builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1458280605.91 results: success (0) buildid: 20160317222820 builduid: 27d89540187e4a778c767490ec3dddf3 revision: cdcccf027c37873120a30baff31e501df33f61f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:45.909459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:45.910181) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:45.910654) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006376 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:45.941196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:45.941520) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:45.964144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:45.964424) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:46.013600) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:46.013880) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:46.014234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:46.014529) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 22:56:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-03-17 22:56:46 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091958 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:46.119574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:46.119874) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019352 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:46.170263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 22:56:46.170656) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cdcccf027c37873120a30baff31e501df33f61f0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cdcccf027c37873120a30baff31e501df33f61f0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 22:56:46,393 truncating revision to first 12 chars 2016-03-17 22:56:46,393 Setting DEBUG logging. 2016-03-17 22:56:46,393 attempt 1/10 2016-03-17 22:56:46,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cdcccf027c37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 22:56:47,416 unpacking tar archive at: fx-team-cdcccf027c37/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 22:56:47.489244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:47.489563) ========= echo cdcccf027c37873120a30baff31e501df33f61f0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cdcccf027c37873120a30baff31e501df33f61f0'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False cdcccf027c37873120a30baff31e501df33f61f0 program finished with exit code 0 elapsedTime=0.004644 script_repo_revision: 'cdcccf027c37873120a30baff31e501df33f61f0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:47.540124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:47.540444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 22:56:47.550579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-17 22:56:47.550866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:56:47 INFO - MultiFileLogger online at 20160317 22:56:47 in /builds/slave/test 22:56:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:56:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:56:47 INFO - {'append_to_log': False, 22:56:47 INFO - 'base_work_dir': '/builds/slave/test', 22:56:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:56:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:56:47 INFO - 'branch': 'Fx-Team-Non-PGO', 22:56:47 INFO - 'buildbot_json_path': 'buildprops.json', 22:56:47 INFO - 'config_files': ('talos/linux_config.py',), 22:56:47 INFO - 'default_actions': ('clobber', 22:56:47 INFO - 'read-buildbot-config', 22:56:47 INFO - 'download-and-extract', 22:56:47 INFO - 'populate-webroot', 22:56:47 INFO - 'create-virtualenv', 22:56:47 INFO - 'install', 22:56:47 INFO - 'run-tests'), 22:56:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:56:47 INFO - 'download_minidump_stackwalk': True, 22:56:47 INFO - 'download_symbols': 'ondemand', 22:56:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:56:47 INFO - 'tooltool.py': '/tools/tooltool.py', 22:56:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:56:47 INFO - '/tools/misc-python/virtualenv.py')}, 22:56:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:56:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:56:47 INFO - 'installer_path': 'installer.exe', 22:56:47 INFO - 'log_level': 'info', 22:56:47 INFO - 'log_name': 'talos', 22:56:47 INFO - 'log_to_console': True, 22:56:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:56:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:56:47 INFO - 'opt_config_files': (), 22:56:47 INFO - 'pip_index': False, 22:56:47 INFO - 'sps_profile': False, 22:56:47 INFO - 'sps_profile_interval': 0, 22:56:47 INFO - 'suite': 'dromaeojs', 22:56:47 INFO - 'system_bits': '32', 22:56:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:56:47 INFO - 'title': 'talos-linux64-ix-045', 22:56:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:56:47 INFO - 'use_talos_json': True, 22:56:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:56:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:56:47 INFO - 'work_dir': 'build'} 22:56:47 INFO - ##### 22:56:47 INFO - ##### Running clobber step. 22:56:47 INFO - ##### 22:56:47 INFO - Running pre-action listener: _resource_record_pre_action 22:56:47 INFO - Running main action method: clobber 22:56:47 INFO - rmtree: /builds/slave/test/build 22:56:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:56:48 INFO - Running post-action listener: _resource_record_post_action 22:56:48 INFO - ##### 22:56:48 INFO - ##### Running read-buildbot-config step. 22:56:48 INFO - ##### 22:56:48 INFO - Running pre-action listener: _resource_record_pre_action 22:56:48 INFO - Running main action method: read_buildbot_config 22:56:48 INFO - Using buildbot properties: 22:56:48 INFO - { 22:56:48 INFO - "project": "", 22:56:48 INFO - "product": "firefox", 22:56:48 INFO - "script_repo_revision": "production", 22:56:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:56:48 INFO - "repository": "", 22:56:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:56:48 INFO - "buildid": "20160317222820", 22:56:48 INFO - "pgo_build": "False", 22:56:48 INFO - "basedir": "/builds/slave/test", 22:56:48 INFO - "buildnumber": 1469, 22:56:48 INFO - "slavename": "talos-linux64-ix-045", 22:56:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:56:48 INFO - "platform": "ubuntu64_hw", 22:56:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:56:48 INFO - "branch": "fx-team", 22:56:48 INFO - "repo_path": "integration/fx-team", 22:56:48 INFO - "revision": "cdcccf027c37873120a30baff31e501df33f61f0", 22:56:48 INFO - "stage_platform": "linux64", 22:56:48 INFO - "builduid": "27d89540187e4a778c767490ec3dddf3", 22:56:48 INFO - "slavebuilddir": "test" 22:56:48 INFO - } 22:56:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:56:48 INFO - Running post-action listener: _resource_record_post_action 22:56:48 INFO - ##### 22:56:48 INFO - ##### Running download-and-extract step. 22:56:48 INFO - ##### 22:56:48 INFO - Running pre-action listener: _resource_record_pre_action 22:56:48 INFO - Running main action method: download_and_extract 22:56:48 INFO - mkdir: /builds/slave/test/build/tests 22:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:48 INFO - https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:56:50 INFO - Downloaded 1361 bytes. 22:56:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:56:50 INFO - Using the following test package requirements: 22:56:50 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:56:50 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:56:50 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:56:50 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'jsshell-linux-x86_64.zip'], 22:56:50 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:56:50 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:56:50 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:56:50 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:56:50 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:56:50 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:56:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:50 INFO - https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:56:54 INFO - Downloaded 22008976 bytes. 22:56:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:56:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:56:55 INFO - Return code: 0 22:56:55 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:55 INFO - https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:56:56 INFO - Downloaded 22008976 bytes. 22:56:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:56:58 INFO - Return code: 0 22:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:58 INFO - https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:56:59 INFO - Downloaded 10846565 bytes. 22:56:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:56:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:57:00 INFO - Return code: 0 22:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:00 INFO - https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:57:01 INFO - Downloaded 54146974 bytes. 22:57:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:01 INFO - mkdir: /builds/slave/test/properties 22:57:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:57:01 INFO - Writing to file /builds/slave/test/properties/build_url 22:57:01 INFO - Contents: 22:57:01 INFO - build_url:https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:02 INFO - Running post-action listener: _resource_record_post_action 22:57:02 INFO - Running post-action listener: set_extra_try_arguments 22:57:02 INFO - ##### 22:57:02 INFO - ##### Running populate-webroot step. 22:57:02 INFO - ##### 22:57:02 INFO - Running pre-action listener: _resource_record_pre_action 22:57:02 INFO - Running main action method: populate_webroot 22:57:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:57:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:57:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:57:02 INFO - '--tppagecycles', 22:57:02 INFO - '7'], 22:57:02 INFO - 'tests': ['tsvgm']}}, 22:57:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:57:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:57:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:57:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:57:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'tests': ['damp', 'tps']}, 22:57:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['damp', 'tps']}, 22:57:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:57:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:57:02 INFO - 'other': {'tests': ['a11yr', 22:57:02 INFO - 'ts_paint', 22:57:02 INFO - 'tpaint', 22:57:02 INFO - 'sessionrestore', 22:57:02 INFO - 'sessionrestore_no_auto_restore', 22:57:02 INFO - 'tabpaint']}, 22:57:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['a11yr', 22:57:02 INFO - 'ts_paint', 22:57:02 INFO - 'tpaint', 22:57:02 INFO - 'sessionrestore', 22:57:02 INFO - 'sessionrestore_no_auto_restore', 22:57:02 INFO - 'tabpaint']}, 22:57:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['a11yr', 22:57:02 INFO - 'ts_paint', 22:57:02 INFO - 'tpaint', 22:57:02 INFO - 'sessionrestore', 22:57:02 INFO - 'sessionrestore_no_auto_restore', 22:57:02 INFO - 'tabpaint']}, 22:57:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['a11yr', 22:57:02 INFO - 'ts_paint', 22:57:02 INFO - 'tpaint', 22:57:02 INFO - 'sessionrestore', 22:57:02 INFO - 'sessionrestore_no_auto_restore', 22:57:02 INFO - 'tabpaint']}, 22:57:02 INFO - 'other_l64': {'tests': ['a11yr', 22:57:02 INFO - 'ts_paint', 22:57:02 INFO - 'tpaint', 22:57:02 INFO - 'sessionrestore', 22:57:02 INFO - 'sessionrestore_no_auto_restore', 22:57:02 INFO - 'tabpaint']}, 22:57:02 INFO - 'other_nol64': {'tests': ['a11yr', 22:57:02 INFO - 'ts_paint', 22:57:02 INFO - 'tpaint', 22:57:02 INFO - 'sessionrestore', 22:57:02 INFO - 'sessionrestore_no_auto_restore', 22:57:02 INFO - 'tabpaint']}, 22:57:02 INFO - 'svgr': {'tests': ['tsvgx', 22:57:02 INFO - 'tsvgr_opacity', 22:57:02 INFO - 'tart', 22:57:02 INFO - 'tscrollx', 22:57:02 INFO - 'cart']}, 22:57:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['tsvgx', 22:57:02 INFO - 'tsvgr_opacity', 22:57:02 INFO - 'tart', 22:57:02 INFO - 'tscrollx', 22:57:02 INFO - 'cart']}, 22:57:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'tests': ['tp5o']}, 22:57:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'talos_options': ['--e10s'], 22:57:02 INFO - 'tests': ['tp5o']}, 22:57:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'talos_options': ['--xperf_path', 22:57:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:02 INFO - 'tests': ['tp5n']}, 22:57:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:02 INFO - 'talos_options': ['--e10s', 22:57:02 INFO - '--xperf_path', 22:57:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:02 INFO - 'tests': ['tp5n']}}, 22:57:02 INFO - 'talos.zip': {'path': '', 22:57:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:57:02 INFO - Running post-action listener: _resource_record_post_action 22:57:02 INFO - ##### 22:57:02 INFO - ##### Running create-virtualenv step. 22:57:02 INFO - ##### 22:57:02 INFO - Running pre-action listener: _resource_record_pre_action 22:57:02 INFO - Running main action method: create_virtualenv 22:57:02 INFO - Creating virtualenv /builds/slave/test/build/venv 22:57:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:57:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:57:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:57:02 INFO - Using real prefix '/usr' 22:57:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:57:02 INFO - Installing distribute.............................................................................................................................................................................................done. 22:57:04 INFO - Installing pip.................done. 22:57:04 INFO - Return code: 0 22:57:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:57:04 INFO - Using env: {'DISPLAY': ':0', 22:57:04 INFO - 'HOME': '/home/cltbld', 22:57:04 INFO - 'LANG': 'en_US.UTF-8', 22:57:04 INFO - 'LANGUAGE': 'en_US:en', 22:57:04 INFO - 'LOGNAME': 'cltbld', 22:57:04 INFO - 'MAIL': '/var/mail/cltbld', 22:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:04 INFO - 'MOZ_NO_REMOTE': '1', 22:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:04 INFO - 'NO_EM_RESTART': '1', 22:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:04 INFO - 'PWD': '/builds/slave/test', 22:57:04 INFO - 'SHELL': '/bin/bash', 22:57:04 INFO - 'SHLVL': '1', 22:57:04 INFO - 'TERM': 'linux', 22:57:04 INFO - 'TMOUT': '86400', 22:57:04 INFO - 'USER': 'cltbld', 22:57:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:04 INFO - '_': '/tools/buildbot/bin/python'} 22:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:57:05 INFO - Cleaning up... 22:57:05 INFO - Return code: 0 22:57:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:57:05 INFO - Using env: {'DISPLAY': ':0', 22:57:05 INFO - 'HOME': '/home/cltbld', 22:57:05 INFO - 'LANG': 'en_US.UTF-8', 22:57:05 INFO - 'LANGUAGE': 'en_US:en', 22:57:05 INFO - 'LOGNAME': 'cltbld', 22:57:05 INFO - 'MAIL': '/var/mail/cltbld', 22:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:05 INFO - 'MOZ_NO_REMOTE': '1', 22:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:05 INFO - 'NO_EM_RESTART': '1', 22:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:05 INFO - 'PWD': '/builds/slave/test', 22:57:05 INFO - 'SHELL': '/bin/bash', 22:57:05 INFO - 'SHLVL': '1', 22:57:05 INFO - 'TERM': 'linux', 22:57:05 INFO - 'TMOUT': '86400', 22:57:05 INFO - 'USER': 'cltbld', 22:57:05 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:05 INFO - '_': '/tools/buildbot/bin/python'} 22:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:05 INFO - Downloading/unpacking psutil>=0.7.1 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:57:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:07 INFO - Installing collected packages: psutil 22:57:07 INFO - Running setup.py install for psutil 22:57:07 INFO - building 'psutil._psutil_linux' extension 22:57:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:57:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:57:07 INFO - building 'psutil._psutil_posix' extension 22:57:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:57:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:57:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:07 INFO - Successfully installed psutil 22:57:07 INFO - Cleaning up... 22:57:07 INFO - Return code: 0 22:57:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:57:07 INFO - Using env: {'DISPLAY': ':0', 22:57:07 INFO - 'HOME': '/home/cltbld', 22:57:07 INFO - 'LANG': 'en_US.UTF-8', 22:57:07 INFO - 'LANGUAGE': 'en_US:en', 22:57:07 INFO - 'LOGNAME': 'cltbld', 22:57:07 INFO - 'MAIL': '/var/mail/cltbld', 22:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:07 INFO - 'MOZ_NO_REMOTE': '1', 22:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:07 INFO - 'NO_EM_RESTART': '1', 22:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:07 INFO - 'PWD': '/builds/slave/test', 22:57:07 INFO - 'SHELL': '/bin/bash', 22:57:07 INFO - 'SHLVL': '1', 22:57:07 INFO - 'TERM': 'linux', 22:57:07 INFO - 'TMOUT': '86400', 22:57:07 INFO - 'USER': 'cltbld', 22:57:07 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:07 INFO - '_': '/tools/buildbot/bin/python'} 22:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:57:09 INFO - Installing collected packages: mozsystemmonitor 22:57:09 INFO - Running setup.py install for mozsystemmonitor 22:57:09 INFO - Successfully installed mozsystemmonitor 22:57:09 INFO - Cleaning up... 22:57:10 INFO - Return code: 0 22:57:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:57:10 INFO - Using env: {'DISPLAY': ':0', 22:57:10 INFO - 'HOME': '/home/cltbld', 22:57:10 INFO - 'LANG': 'en_US.UTF-8', 22:57:10 INFO - 'LANGUAGE': 'en_US:en', 22:57:10 INFO - 'LOGNAME': 'cltbld', 22:57:10 INFO - 'MAIL': '/var/mail/cltbld', 22:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:10 INFO - 'MOZ_NO_REMOTE': '1', 22:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:10 INFO - 'NO_EM_RESTART': '1', 22:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:10 INFO - 'PWD': '/builds/slave/test', 22:57:10 INFO - 'SHELL': '/bin/bash', 22:57:10 INFO - 'SHLVL': '1', 22:57:10 INFO - 'TERM': 'linux', 22:57:10 INFO - 'TMOUT': '86400', 22:57:10 INFO - 'USER': 'cltbld', 22:57:10 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:10 INFO - '_': '/tools/buildbot/bin/python'} 22:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:10 INFO - Downloading/unpacking blobuploader==1.2.4 22:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:12 INFO - Downloading blobuploader-1.2.4.tar.gz 22:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:57:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:57:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:12 INFO - Downloading docopt-0.6.1.tar.gz 22:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:57:13 INFO - Installing collected packages: blobuploader, requests, docopt 22:57:13 INFO - Running setup.py install for blobuploader 22:57:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:57:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:57:13 INFO - Running setup.py install for requests 22:57:13 INFO - Running setup.py install for docopt 22:57:13 INFO - Successfully installed blobuploader requests docopt 22:57:13 INFO - Cleaning up... 22:57:13 INFO - Return code: 0 22:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:13 INFO - Using env: {'DISPLAY': ':0', 22:57:13 INFO - 'HOME': '/home/cltbld', 22:57:13 INFO - 'LANG': 'en_US.UTF-8', 22:57:13 INFO - 'LANGUAGE': 'en_US:en', 22:57:13 INFO - 'LOGNAME': 'cltbld', 22:57:13 INFO - 'MAIL': '/var/mail/cltbld', 22:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:13 INFO - 'MOZ_NO_REMOTE': '1', 22:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:13 INFO - 'NO_EM_RESTART': '1', 22:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:13 INFO - 'PWD': '/builds/slave/test', 22:57:13 INFO - 'SHELL': '/bin/bash', 22:57:13 INFO - 'SHLVL': '1', 22:57:13 INFO - 'TERM': 'linux', 22:57:13 INFO - 'TMOUT': '86400', 22:57:13 INFO - 'USER': 'cltbld', 22:57:13 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:13 INFO - '_': '/tools/buildbot/bin/python'} 22:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:13 INFO - Running setup.py (path:/tmp/pip-E0Yxqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:13 INFO - Running setup.py (path:/tmp/pip-qHvCp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:14 INFO - Running setup.py (path:/tmp/pip-OMbbJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:14 INFO - Running setup.py (path:/tmp/pip-GZ6wsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:14 INFO - Running setup.py (path:/tmp/pip-N_8doJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:14 INFO - Running setup.py (path:/tmp/pip-DudxKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:14 INFO - Running setup.py (path:/tmp/pip-8weHu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:14 INFO - Running setup.py (path:/tmp/pip-Gj_Hvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:14 INFO - Running setup.py (path:/tmp/pip-hUPK9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:14 INFO - Running setup.py (path:/tmp/pip-RJdid8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:14 INFO - Running setup.py (path:/tmp/pip-P9McUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:14 INFO - Running setup.py (path:/tmp/pip-qCIkXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:14 INFO - Running setup.py (path:/tmp/pip-ThiJYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:14 INFO - Running setup.py (path:/tmp/pip-SZ5lMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:14 INFO - Running setup.py (path:/tmp/pip-ltkvhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:14 INFO - Running setup.py (path:/tmp/pip-uRbmUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:15 INFO - Running setup.py (path:/tmp/pip-RWjk3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:57:15 INFO - Running setup.py install for manifestparser 22:57:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Running setup.py install for mozcrash 22:57:15 INFO - Running setup.py install for mozdebug 22:57:15 INFO - Running setup.py install for mozdevice 22:57:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Running setup.py install for mozfile 22:57:15 INFO - Running setup.py install for mozhttpd 22:57:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Running setup.py install for mozinfo 22:57:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Running setup.py install for mozInstall 22:57:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:57:15 INFO - Running setup.py install for mozleak 22:57:15 INFO - Running setup.py install for mozlog 22:57:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Running setup.py install for moznetwork 22:57:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Running setup.py install for mozprocess 22:57:16 INFO - Running setup.py install for mozprofile 22:57:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Running setup.py install for mozrunner 22:57:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Running setup.py install for mozscreenshot 22:57:16 INFO - Running setup.py install for moztest 22:57:16 INFO - Running setup.py install for mozversion 22:57:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:57:16 INFO - Cleaning up... 22:57:16 INFO - Return code: 0 22:57:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:16 INFO - Using env: {'DISPLAY': ':0', 22:57:16 INFO - 'HOME': '/home/cltbld', 22:57:16 INFO - 'LANG': 'en_US.UTF-8', 22:57:16 INFO - 'LANGUAGE': 'en_US:en', 22:57:16 INFO - 'LOGNAME': 'cltbld', 22:57:16 INFO - 'MAIL': '/var/mail/cltbld', 22:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:16 INFO - 'MOZ_NO_REMOTE': '1', 22:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:16 INFO - 'NO_EM_RESTART': '1', 22:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:16 INFO - 'PWD': '/builds/slave/test', 22:57:16 INFO - 'SHELL': '/bin/bash', 22:57:16 INFO - 'SHLVL': '1', 22:57:16 INFO - 'TERM': 'linux', 22:57:16 INFO - 'TMOUT': '86400', 22:57:16 INFO - 'USER': 'cltbld', 22:57:16 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:16 INFO - '_': '/tools/buildbot/bin/python'} 22:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:17 INFO - Running setup.py (path:/tmp/pip-wQ_OZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:17 INFO - Running setup.py (path:/tmp/pip-brNSTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:17 INFO - Running setup.py (path:/tmp/pip-kFjul3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:17 INFO - Running setup.py (path:/tmp/pip-8abPOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:17 INFO - Running setup.py (path:/tmp/pip-MP2hbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:17 INFO - Running setup.py (path:/tmp/pip-x59VP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:17 INFO - Running setup.py (path:/tmp/pip-qtkJYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:17 INFO - Running setup.py (path:/tmp/pip-04lewb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:17 INFO - Running setup.py (path:/tmp/pip-vfP6AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:17 INFO - Running setup.py (path:/tmp/pip-5MwZOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:17 INFO - Running setup.py (path:/tmp/pip-3hPLNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:17 INFO - Running setup.py (path:/tmp/pip-xWM0rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:17 INFO - Running setup.py (path:/tmp/pip-6LzCYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:18 INFO - Running setup.py (path:/tmp/pip-q_fvn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:18 INFO - Running setup.py (path:/tmp/pip-Y9Unjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:18 INFO - Running setup.py (path:/tmp/pip-0JyG38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:18 INFO - Running setup.py (path:/tmp/pip-7E6N5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:57:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:20 INFO - Downloading blessings-1.6.tar.gz 22:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:57:20 INFO - Installing collected packages: blessings 22:57:20 INFO - Running setup.py install for blessings 22:57:20 INFO - Successfully installed blessings 22:57:20 INFO - Cleaning up... 22:57:20 INFO - Return code: 0 22:57:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:20 INFO - Reading from file tmpfile_stdout 22:57:20 INFO - Current package versions: 22:57:20 INFO - argparse == 1.2.1 22:57:20 INFO - blessings == 1.6 22:57:20 INFO - blobuploader == 1.2.4 22:57:20 INFO - docopt == 0.6.1 22:57:20 INFO - manifestparser == 1.1 22:57:20 INFO - mozInstall == 1.12 22:57:20 INFO - mozcrash == 0.17 22:57:20 INFO - mozdebug == 0.1 22:57:20 INFO - mozdevice == 0.48 22:57:20 INFO - mozfile == 1.2 22:57:20 INFO - mozhttpd == 0.7 22:57:20 INFO - mozinfo == 0.9 22:57:20 INFO - mozleak == 0.1 22:57:20 INFO - mozlog == 3.1 22:57:20 INFO - moznetwork == 0.27 22:57:20 INFO - mozprocess == 0.22 22:57:20 INFO - mozprofile == 0.28 22:57:20 INFO - mozrunner == 6.11 22:57:20 INFO - mozscreenshot == 0.1 22:57:20 INFO - mozsystemmonitor == 0.0 22:57:20 INFO - moztest == 0.7 22:57:20 INFO - mozversion == 1.4 22:57:20 INFO - psutil == 3.1.1 22:57:20 INFO - requests == 1.2.3 22:57:20 INFO - wsgiref == 0.1.2 22:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:20 INFO - Using env: {'DISPLAY': ':0', 22:57:20 INFO - 'HOME': '/home/cltbld', 22:57:20 INFO - 'LANG': 'en_US.UTF-8', 22:57:20 INFO - 'LANGUAGE': 'en_US:en', 22:57:20 INFO - 'LOGNAME': 'cltbld', 22:57:20 INFO - 'MAIL': '/var/mail/cltbld', 22:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:20 INFO - 'MOZ_NO_REMOTE': '1', 22:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:20 INFO - 'NO_EM_RESTART': '1', 22:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:20 INFO - 'PWD': '/builds/slave/test', 22:57:20 INFO - 'SHELL': '/bin/bash', 22:57:20 INFO - 'SHLVL': '1', 22:57:20 INFO - 'TERM': 'linux', 22:57:20 INFO - 'TMOUT': '86400', 22:57:20 INFO - 'USER': 'cltbld', 22:57:20 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:20 INFO - '_': '/tools/buildbot/bin/python'} 22:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:57:20 INFO - Cleaning up... 22:57:20 INFO - Return code: 0 22:57:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:57:20 INFO - Using env: {'DISPLAY': ':0', 22:57:20 INFO - 'HOME': '/home/cltbld', 22:57:20 INFO - 'LANG': 'en_US.UTF-8', 22:57:20 INFO - 'LANGUAGE': 'en_US:en', 22:57:20 INFO - 'LOGNAME': 'cltbld', 22:57:20 INFO - 'MAIL': '/var/mail/cltbld', 22:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:20 INFO - 'MOZ_NO_REMOTE': '1', 22:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:20 INFO - 'NO_EM_RESTART': '1', 22:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:20 INFO - 'PWD': '/builds/slave/test', 22:57:20 INFO - 'SHELL': '/bin/bash', 22:57:20 INFO - 'SHLVL': '1', 22:57:20 INFO - 'TERM': 'linux', 22:57:20 INFO - 'TMOUT': '86400', 22:57:20 INFO - 'USER': 'cltbld', 22:57:20 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:20 INFO - '_': '/tools/buildbot/bin/python'} 22:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:21 INFO - Downloading/unpacking jsonschema 22:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:57:22 INFO - Downloading/unpacking functools32 (from jsonschema) 22:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:23 INFO - Downloading functools32-3.2.3-2.tar.gz 22:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:57:23 INFO - warning: no files found matching '*.txt' 22:57:23 INFO - no previously-included directories found matching 'build' 22:57:23 INFO - no previously-included directories found matching 'dist' 22:57:23 INFO - no previously-included directories found matching '.git*' 22:57:23 INFO - Installing collected packages: jsonschema, functools32 22:57:23 INFO - Running setup.py install for functools32 22:57:23 INFO - warning: no files found matching '*.txt' 22:57:23 INFO - no previously-included directories found matching 'build' 22:57:23 INFO - no previously-included directories found matching 'dist' 22:57:23 INFO - no previously-included directories found matching '.git*' 22:57:23 INFO - Successfully installed jsonschema functools32 22:57:23 INFO - Cleaning up... 22:57:23 INFO - Return code: 0 22:57:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9b2dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:57:23 INFO - Using env: {'DISPLAY': ':0', 22:57:23 INFO - 'HOME': '/home/cltbld', 22:57:23 INFO - 'LANG': 'en_US.UTF-8', 22:57:23 INFO - 'LANGUAGE': 'en_US:en', 22:57:23 INFO - 'LOGNAME': 'cltbld', 22:57:23 INFO - 'MAIL': '/var/mail/cltbld', 22:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:23 INFO - 'MOZ_NO_REMOTE': '1', 22:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:23 INFO - 'NO_EM_RESTART': '1', 22:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:23 INFO - 'PWD': '/builds/slave/test', 22:57:23 INFO - 'SHELL': '/bin/bash', 22:57:23 INFO - 'SHLVL': '1', 22:57:23 INFO - 'TERM': 'linux', 22:57:23 INFO - 'TMOUT': '86400', 22:57:23 INFO - 'USER': 'cltbld', 22:57:23 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:23 INFO - '_': '/tools/buildbot/bin/python'} 22:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:23 INFO - Downloading/unpacking flake8 22:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:57:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:57:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:57:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:57:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:57:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:57:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:57:26 INFO - no previously-included directories found matching 'docs/_build' 22:57:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:57:26 INFO - Running setup.py install for pep8 22:57:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:57:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:57:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:57:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:57:26 INFO - no previously-included directories found matching 'docs/_build' 22:57:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:57:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:57:26 INFO - Cleaning up... 22:57:26 INFO - Return code: 0 22:57:26 INFO - Running post-action listener: _resource_record_post_action 22:57:26 INFO - Running post-action listener: _start_resource_monitoring 22:57:26 INFO - Starting resource monitoring. 22:57:26 INFO - ##### 22:57:26 INFO - ##### Running install step. 22:57:26 INFO - ##### 22:57:26 INFO - Running pre-action listener: _resource_record_pre_action 22:57:26 INFO - Running main action method: install 22:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:26 INFO - Reading from file tmpfile_stdout 22:57:26 INFO - Detecting whether we're running mozinstall >=1.0... 22:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:57:26 INFO - Reading from file tmpfile_stdout 22:57:26 INFO - Output received: 22:57:26 INFO - Usage: mozinstall [options] installer 22:57:26 INFO - Options: 22:57:26 INFO - -h, --help show this help message and exit 22:57:26 INFO - -d DEST, --destination=DEST 22:57:26 INFO - Directory to install application into. [default: 22:57:26 INFO - "/builds/slave/test"] 22:57:26 INFO - --app=APP Application being installed. [default: firefox] 22:57:26 INFO - mkdir: /builds/slave/test/build/application 22:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:57:42 INFO - Reading from file tmpfile_stdout 22:57:42 INFO - Output received: 22:57:42 INFO - /builds/slave/test/build/application/firefox/firefox 22:57:42 INFO - Running post-action listener: _resource_record_post_action 22:57:42 INFO - ##### 22:57:42 INFO - ##### Running run-tests step. 22:57:42 INFO - ##### 22:57:42 INFO - Running pre-action listener: _resource_record_pre_action 22:57:42 INFO - Running main action method: run_tests 22:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:57:42 INFO - Python 2.7.3 22:57:42 INFO - Return code: 0 22:57:42 INFO - grabbing minidump binary from tooltool 22:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:57:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:57:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:57:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:57:42 INFO - Return code: 0 22:57:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:57:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:57:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:57:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:57:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:57:43 INFO - Return code: 0 22:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:57:43 INFO - Using env: {'DISPLAY': ':0', 22:57:43 INFO - 'HOME': '/home/cltbld', 22:57:43 INFO - 'LANG': 'en_US.UTF-8', 22:57:43 INFO - 'LANGUAGE': 'en_US:en', 22:57:43 INFO - 'LOGNAME': 'cltbld', 22:57:43 INFO - 'MAIL': '/var/mail/cltbld', 22:57:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:57:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:43 INFO - 'MOZ_NO_REMOTE': '1', 22:57:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:43 INFO - 'NO_EM_RESTART': '1', 22:57:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:43 INFO - 'PWD': '/builds/slave/test', 22:57:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:57:43 INFO - 'SHELL': '/bin/bash', 22:57:43 INFO - 'SHLVL': '1', 22:57:43 INFO - 'TERM': 'linux', 22:57:43 INFO - 'TMOUT': '86400', 22:57:43 INFO - 'USER': 'cltbld', 22:57:43 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689', 22:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:43 INFO - '_': '/tools/buildbot/bin/python'} 22:57:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:57:43 INFO - mozversion application_buildid: 20160317222820 22:57:43 INFO - mozversion application_changeset: cdcccf027c37873120a30baff31e501df33f61f0 22:57:43 INFO - mozversion application_display_name: Nightly 22:57:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:57:43 INFO - mozversion application_name: Firefox 22:57:43 INFO - mozversion application_remotingname: firefox 22:57:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:57:43 INFO - mozversion application_vendor: Mozilla 22:57:43 INFO - mozversion application_version: 48.0a1 22:57:43 INFO - mozversion platform_buildid: 20160317222820 22:57:43 INFO - mozversion platform_changeset: cdcccf027c37873120a30baff31e501df33f61f0 22:57:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:57:43 INFO - mozversion platform_version: 48.0a1 22:57:43 INFO - using testdate: 1458280663 22:57:43 INFO - actual date: 1458280663 22:57:43 INFO - starting webserver on 'localhost:37792' 22:57:43 INFO - SUITE-START | Running 2 tests 22:57:43 INFO - TEST-START | dromaeo_css 22:57:43 INFO - operating with platform_type : linux_ 22:57:43 INFO - Initialising browser for dromaeo_css test... 22:57:43 INFO - TEST-INFO | started process 4699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hynxy/profile http://localhost:37792/getInfo.html) 22:57:47 INFO - PROCESS | 4699 | __metrics Screen width/height:1600/1200 22:57:47 INFO - PROCESS | 4699 | colorDepth:24 22:57:47 INFO - PROCESS | 4699 | Browser inner width/height: 1024/697 22:57:47 INFO - PROCESS | 4699 | __metrics 22:57:48 ERROR - PROCESS | 4699 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:57:48 INFO - PROCESS | 4699 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:57:49 INFO - TEST-INFO | 4699: exit 0 22:57:49 INFO - Browser initialized. 22:57:49 INFO - Running cycle 1/1 for dromaeo_css test... 22:57:49 INFO - TEST-INFO | started process 4792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hynxy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:01 INFO - PROCESS | 4792 | RSS: Main: 154771456 22:58:01 INFO - PROCESS | 4792 | 22:58:52 INFO - PROCESS | 4792 | 1458280732050 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:01:03 INFO - PROCESS | 4792 | Cycle 1(1): loaded http://localhost:37792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37792/tests/dromaeo/cssquery-ext.html) 23:01:04 INFO - PROCESS | 4792 | RSS: Main: 228737024 23:01:04 INFO - PROCESS | 4792 | 23:04:06 INFO - PROCESS | 4792 | Cycle 1(1): loaded http://localhost:37792/tests/dromaeo/cssquery-ext.html (next: http://localhost:37792/tests/dromaeo/cssquery-jquery.html) 23:04:07 INFO - PROCESS | 4792 | RSS: Main: 247599104 23:04:07 INFO - PROCESS | 4792 | 23:07:09 INFO - PROCESS | 4792 | Cycle 1(1): loaded http://localhost:37792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37792/tests/dromaeo/cssquery-mootools.html) 23:07:09 INFO - PROCESS | 4792 | RSS: Main: 242114560 23:07:09 INFO - PROCESS | 4792 | 23:10:11 INFO - PROCESS | 4792 | Cycle 1(1): loaded http://localhost:37792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37792/tests/dromaeo/cssquery-prototype.html) 23:10:12 INFO - PROCESS | 4792 | RSS: Main: 208371712 23:10:12 INFO - PROCESS | 4792 | 23:13:14 INFO - PROCESS | 4792 | Cycle 1(1): loaded http://localhost:37792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37792/tests/dromaeo/cssquery-yui.html) 23:13:15 INFO - PROCESS | 4792 | RSS: Main: 201244672 23:13:15 INFO - PROCESS | 4792 | 23:16:17 INFO - PROCESS | 4792 | Cycle 1(1): loaded http://localhost:37792/tests/dromaeo/cssquery-yui.html (next: http://localhost:37792/tests/dromaeo/cssquery-dojo.html) 23:16:18 INFO - PROCESS | 4792 | RSS: Main: 271212544 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | __start_tp_report 23:16:18 INFO - PROCESS | 4792 | _x_x_mozilla_page_load 23:16:18 INFO - PROCESS | 4792 | _x_x_mozilla_page_load_details 23:16:18 INFO - PROCESS | 4792 | |i|pagename|runs| 23:16:18 INFO - PROCESS | 4792 | |0;dojo.html;2623.5933430318296;2678.933026674334;2682.2221555748833;2695.4339588686375;2717.592361145828;4565.269556870901;4647.093816705744;4666.696664716791;4671.15919134556;4684.344191813145;4713.222318317474;4735.73953432561;4740.525947405258;4754.548317909793;4758.738269395182;4279.529251782302;4368.847090351838;4369.715968462056;4420.845270415536;4444.155610434023;4250.787460626972;4309.052008558112;4379.211741886459;4388.056567837914;4389.429374181368;4301.139772045588;4344.413504176927;4347.739135651871;4390.143921935224;4398.296272596369;4360.738355698668;4361.738295702236;4381.978090109561;4384.342348647729;4400.713953593006;4217.873463796091;4294.806733696991;4343.717658352197;4346.695731298779;4402.119576084764;4629.213033784231;4671.346011558385;4724.196886529298;4726.976365118187;4730.952690473086;5061.873453163664;5061.898762024775;5065.265536497187;5073.797048118071;5122.410922743895;5094.566961808251;5097.184450487941;5097.668651537638;5102.081625307444;5109.6167787415725;4679.578837904571;4680.789364478641;4716.528347165325;4753.714777113384;4758.048390321949;5195.792168313301;5196.4803519648485;5200.7919683213;5201.45384734605;5201.479852014768;4877.6829506081995;4999.375078115236;5001.699898006132;5018.698878067327;5049;4998.475160108209;5043.142665746758;5060.645754797202;5096.980603879239;5109.233614957711;5050.671706339076;5069.746512674352;5069.847904562869;5076.086304465158;5124.641275110706;4921.729304888194;5020.924686129711;5056.974715126401;5061.468545802638;5065.164247899129;4209.473815773028;4245.936310955338;4262.190183865056;4291.678124140702;4303.763293018914;3745.6441638044344;3748.8125593720206;3754.755940863835;3775.962240377616;3786.583475817658;4281.700280980302;4357.934630980538;4387.363832244307;4393.29707246839;4428.535003824616;5073.492650734971;5073.847784566469;5083.644144909895;5105.7191854448365;5127.512886275797;4346.9347959780625;4367.890802729958;4370.2570563004365;4417.0724147929295;4422.159789639958;4400.471943366816;4516.774161291923;4529.728216306966;4535.183666939983;4633.606143477775;4830.9275360870315;4845.927311090407;4856.004519073582;4881.658283920163;4897.730624815526;5100.081985242544;5104.387473503203;5106;5107.412647545431;5108.948910510847;4665.930011049905;4767;4843.24929635907;4862;4891.90216195667;4978.900421991612;4979.751012449436;4995.850124496271;5001.049800537886;5046.444891061907;5073.8731531712;5078.263651770399;5082.872928176826;5083.237514372874;5124.871878203075;4816.710997340171;4895.314655948241;4942.061008408391;4971.428285747041;4987.700737955734;4870.512948705101;4905.583025442877;4910.705357678551;4913.361263035782;4965.553100220997;4771.73755443454;4839.95160048395;4850.369451971221;4852.587530059985;4897.755112244445;4790.401199850019;4913;4915.926261106015;4949.133901567139;4999.0501804657;4845.41854977405;4854.1747902857305;4856.368672072608;4869.196582563837;4870.853874383774 23:16:18 INFO - PROCESS | 4792 | |1;ext.html;537.1164434505237;538.4911258860376;558.1070287539936;561.3880869851861;566.2271000084884;26749.331266718316;34090.318193636114;34286.99999999997;34311;34399.484007739906;37198.81400592993;37539.81230093852;37547;37714.24571508575;37782.81108594453;7675.6545955432;7779.988601481799;7840.921590784076;7852.293293603575;7873.055233371975;7648.73229436967;7775.455718099735;7778.377729781604;7780.14418413974;7994.2005799419885;7967.60161991901;8006.879896801553;8027.438079334449;8034.558099304565;8034.758957231293;7903.3282171015535;7971.561564113971;7976.042874855026;7980.321672657831;8000.119986801447;7829.8825517616715;7975.122736498981;7975.920240797575;7975.96012019942;7976.122626511079;37177;37491.62508374936;37514.43728344077;37559.436608450895;37590.24819503622;2890.4652639261594;2986.970130298713;2999.475091858916;3049.8883097542816;3108.9378212435627;28258.434831303464;29059.273518162005;29100.563491547644;29370;29925.700742992725;3421.9657803421896;3469.3061387722555;3515.244222492151;3608.8736894208578;3626.9818650906577;257572;260400;260695;261632.6918365415;262108;41731.7913410431;52753;54171.729141354044;54201;54260;41765.79117104395;41894.16211675749;41909.161816763495;42044;42049.78975105105;12489.687757806127;12736.981041516656;12740.617781466572;12745.872541274468;12750;9533.285003624756;9534.046595340411;9538.61845526185;9548.045195480396;9574.329796914288;14284.642883927985;14301.213433261062;14781.704365912836;14835.851641483663;14926.925365373103;5776.595638305363;5842.123681447817;5903.852403689856;5909.113632955005;5949.553783466257;860.4106187261746;879.3580686099183;951.9095685909828;984.4290311619244;991.3853410885154;27806.3048423791;29566.852165739463;29790.25524361908;31088.378232435225;31156.688433115833;948.6489998700525;974.70758772368;980.1815484070738;1028.3315844701003;1073.5705717712822;13915.512957046454;14328.211948342941;14376.856231437761;14457.277136143151;14536;373788;377164;379302;379569;380225;47668.7616561915;48719.5128048722;48880.26679599809;48992.265116023285;49046;1158.2182027131653;1177.717347836513;1239.504198320679;1247.9500819967282;1263.3241215949422;24518.75481245236;26023;26129.608055878798;26142.34644133912;26193.345166370993;35038.47442288419;35459.82270088633;35630.28739425249;35680.82159589185;35735.10662233465;184231;184373;184485;185169;186440;26366;30259.243518912204;30807;30834.845825770728;31402.842985784926;34275.485867711504;34454.31091378209;34958.03019029967;35312.47031294584;37517.62482375251;32800.50799237966;32850.50724239091;33013.83493082519;33464.1633959153;33558.49662255117;32964.34071318608;33082.33835323232;33462.83268583739;33528.1617959553;33810.32379352448;32359.676403236608;32814.5077823828;33214.5017824728;33255.334893301515;33324;28330.575041374806;28707.85646071756;29103.85448072746;29350.853245733633;29360.26599335034;23337;23426.18008369699;23690.763092369547;23691.52616947686;23692.170774022827 23:16:18 INFO - PROCESS | 4792 | |2;jquery.html;358.1976372924648;359.35316430425246;365.6909911125099;371.9349113905068;373.50324068988215;15140.091594504338;15410.61473463164;17282.395116170937;17308.826911730896;17332.133393330314;16517.33930642773;16685.416010439636;16878.57803554912;16895;16905.49283521496;4649.070185962821;4965.230389289657;5155.046316431453;5226.686398816083;5233.345831771028;5114.56526195272;5162.664426812264;5174.275601415805;5190.974045129769;5221.373435187783;4928.088303663816;5168;5170.689758614495;5174.223866420049;5180.3006594109875;5112.769925353368;5145.845624631267;5147.613928955325;5152.793888244466;5171.250168725533;4578.679492435531;4622.699524530928;4624.722516649012;4625.468071171825;4653.767311634439;19475.707864381904;19755.604887902304;20072.899635501875;20074.799252007586;20119;1921.2795201799324;2098.1187901081585;2098.5697931924074;2196.879171645559;2402.9279121626378;13125.34373281332;13150.145240559428;13203.339833008407;13390.062695611312;13466.663333416744;1762.7355896615481;1794.5872449336596;1826.9360572380035;1827.9086045697795;1828.305244007282;56959;60372.39627603668;60515;60927.39072609306;62203.68898155526;10190.133838623651;10362.637307694195;10389.740256493496;10446.112080473245;10534.473276336152;13281.667958300926;13338.799918001238;13358.064935454426;13364.064515483822;13382.531611393555;6883.242843287235;7122.002919591261;7203.02759127511;7211.990321355014;7227.855442891113;6671.766488172891;6679.599224046573;6716.731330746813;6801.591904485746;6850.794476165723;4439.911201775946;4441.755703436342;4451.977740111279;4466.9106617867465;4520.841770538015;1837.5589858434148;1849.9907500462411;1874.7000479923147;1881.89649569275;1889.159324100762;803.365341380303;838.1409055717816;886.1714297132202;909.9353756105372;939.5490164720973;15421.768673469907;15817.841821581636;15903.045817251003;16272.944971895866;16621.335146594243;865.5715420866711;883.4831623500324;903.5888670654837;941.9497260554432;956.0487315121499;9215.216706580015;9546.140847323773;9606.097342846388;9607.375520591138;9756;394982;397691;406704;408816;409743;52305.7384713074;62398.68800655968;63300.683496583144;66509.66745166243;70028.64985675039;886.5257087458178;893.4058850864103;907.4963395315531;918.9908100919039;921.502388710089;14633.853661463248;14724.19016954035;14743.705125897637;15024.24878756036;15349.155796430858;32710.34579308448;33550.32899342048;33744;33847.3230535383;33908.66091339055;45979.54020459753;46208.76895615501;46272.7531783205;46302.76848615735;46683.29975050309;7334.3032411920785;7393.74306367908;7414.443916706161;7429.07136607924;7488.288612581796;9610.471424071744;10789;11034.834477483004;11273.436328183721;11341.659750207507;9543.665971690958;9639.807203855744;9689.273304502332;9800.264980126376;9837.95081024619;5917.763289468373;8974.282057435259;9158.679446219618;9296.767580810263;9484.715458536255;9629;9651.420914745138;9987.450690211817;10078.596856125672;10207.234457415576;7248.383887369632;7300.415966722543;7347.889781653386;7451.031365922396;7557.470977031775;8057;9901.950490247502;9981.151602113901;10005.799884002425;10094.646687365906 23:16:18 INFO - PROCESS | 4792 | |3;mootools.html;1312.3766211049758;1430.3420426603761;1440.6398400399896;1608.5496061102888;1823.5714607067337;6643.568168069072;7183.784486465402;7324.230955749649;7325.743598974037;7334.1565719942155;7414.406847452205;7590.58251796151;7602.087749470057;7604.77185684429;7618.84762304755;1980.8217260446556;2267.9319620411416;2290.977090229097;2319.93040208794;2328.208409140892;2326.0695721711368;2344.343583796531;2344.9648255276184;2345.6833327500826;2347.565700345433;2255.8082562982167;2327.0575416956076;2327.3716096653893;2328.0687724910003;2332.6617640442128;2257.3566533537946;2264.9886750566143;2266.660000999847;2272.125231785758;2294.678744975705;2255.751867294596;2261;2266.0256089881345;2280.703508543895;2327.418145463634;7735.303822655932;7817.1791961843755;7819.061712594468;7819.335356494705;7826.491278066907;4676.672632915697;4783.091212669582;4807.759612019385;4812.085703716282;4813.181759100961;2934.1637633274627;3068;3106.409782141386;3247;3259.722923551501;1028.4960369419005;1033.3076838518211;1053.367979212474;1069.4492336446735;1085.3867564825848;10582.629607963685;10601.84097238542;10607.469626518643;10629.9468502657;10649.201309901788;4460.397846290774;4501.932471012938;4548.090381923628;4605.355250264965;4609.147307748078;8102;8115.513069215866;8158.184181581794;8171.264586187272;8173.468724532886;4080.163566468867;4627.490975992638;4671.392718946515;4680.602148817321;4699.271612900006;3772.849086036583;3781.7352785305316;3812.1232116613332;4201.789910504463;4354.346847972766;3554.928901422009;3617.1680513482047;3627.383344831385;3661.3409586274192;3676.3015027144756;1107.7175320293275;1112.6828853776635;1116.832475128721;1122.1135303110452;1125.7635896461834;903.6159632156307;921.2998121427763;921.9354645174774;950.6054987180381;1264.9747005059846;7418.962905185547;7436;7445.25547445262;7495.287947644965;7507;480.92305231162845;488.5456525431383;497.8133200049981;498.40191769876293;500.1846989407243;5654.97172514143;5679.829605111853;5693.829185124453;5696.914546281809;5721.656700597894;9353;9564.426134431957;9691.51542422876;9692.612295508101;9705.563249653782;9182.311326650528;9331.393459425115;9467.715968520955;9530.475823829756;9537.666181683746;7333.230010848891;7425.368843648243;7490.887636685454;7490.925090749131;7491.587962661997;7023.964880175567;7044.119485064367;7051.964740176266;7083.114610673666;7090.716371345088;8475.279601233717;8508.064112947446;8534.061253262013;8540.572971351283;8545.957270213608;8636.222739953435;8673.653053878026;8821.338399619926;8837.646494140163;8896.154865287788;5477.287952566141;5637.605367624227;5644.576656750843;5959.582829201914;6004.609700369462;6979.930200697928;7106.502544821813;7112.715491380287;7125.572465652078;7128.928710713034;6420.871582568416;6536.607803531803;6564.015397690385;6565.277819439762;6652.4345430637;6252.3122456530655;6356.237251529846;6468.967655161694;6470.579412338183;6470.6441145737435;6625.569337993015;6665.633390163587;6677.065210870385;6750.122484077038;6806.081179040766;5975.462208401264;6113.480354169946;6183.103449999815;6192.256929168529;6201.131841542097;6477.838054048687;6507.544471887112;6516.152900123143;6561.507886908596;6563.3764792344655 23:16:18 INFO - PROCESS | 4792 | |4;prototype.html;323.9886603968861;327.33714228686904;327.6559612406972;328.7173031193175;335.7163197098451;5327.547158491528;5328.280682107919;5329.573634109272;5339.492748188925;5344.4922732340465;5165.27686123942;5264.1051021326375;5290.074237008518;5308.124159513675;5312;3964.3657014877626;4042.3734321180264;4123.9793801030955;4164.583541645841;4188.036751547138;4156.210320039183;4169.958300416987;4186.079062606222;4202.285611446062;4202.516710578277;4158.334666453368;4165.916681666365;4169.958300417003;4171.791410429481;4172.937405938914;3970.9205815883665;4055.35114381699;4129.772862492562;4133.483314585676;4139.2135494256;3676.926461470782;3701.61133081028;3706.703463722896;3714.3685573452576;3718.1819999600043;5093.414257360414;5111.514406131411;5111.718855462948;5111.948880511184;5113.744312784346;4850.4236123259725;4850.902981940377;4852.223644216943;4858.562729354339;4862.781174847105;5647.43525647436;5650.7174641267775;5650.85872853182;5656.604037717361;5657.688827114507;4086.427900093989;4098.098418347959;4098.938515922264;4099.795010249505;4102.056526998807;5656.547476201894;5920.348761636216;5921.111833225008;5930.258717660293;5937.079752638305;3974.2647610192207;4054.5945405459806;4055.513338399352;4057.8376864925663;4057.94493431704;4102.692298077596;4115.1975364804175;4118.6499147572795;4119.0937993641355;4127.195196936568;4715.198416269242;4725.314829349725;4725.740084295328;4726.220173671374;4726.480087190406;5640.407757185519;5651.9152212716845;5654.06707893193;5655.095184770417;5660.915086273709;1477.8841974309328;1504.7216264991011;1504.8720858726913;1505.6386467247783;1506.0361368724025;965.7295957132014;1009.8283291840405;1011.9949400252951;1033.405791669778;1035.9015893490107;4891.388576427947;4896.853094407174;4909.214525675875;4914.20631469511;4917.877053073702;5707.74315155819;5713.285839270091;5713.6857472838565;5718.7426565804635;5722.62802917809;4885.071836351153;4888;4888.364512613338;4895.559399654048;4904.190808516555;3056.144279601715;3088.258817883692;3093.6906309368883;3120.188750924776;3122.3443076954095;5496.477834605706;5499.835004949858;5509.146082357241;5512.39363669996;5513.558915286768;5762.538996880324;5941.168236446901;5944.7324870380935;5951.791687290924;5955.910661340084;5468.4531546845;5487.64330318528;5496.615236933376;5501.697406642673;5509.47659972302;5766.221560089334;5783.363829978614;5785.074388097884;5792.160136780059;5792.82621521355;5662.094064949588;5671;5675.489205971482;5676.801311954062;5679.914801278067;5482;5482.342118945592;5493.395726470165;5494.066008778597;5507.421720719267;4067.1458993611673;4212.620864122244;4218.789060546899;4220.5146408163455;4222.303319952173;5746.741396637078;5774.971125144348;5779.450952159538;5779.942200577941;5781.566382521243;5569.192467092168;5579.916301255404;5580.218769372373;5580.441955804387;5581.9162712560155;5544.168374743821;5572.972135139298;5573.832785016456;5577.52591029767;5577.832665020056;5450.781968721207;5463;5468.56251499887;5470.097433923358;5472.5621950243085;5475.863103422446;5729.455701708331;5729.627574207663;5733.569982251432;5739.684317362585;5490.450954904478;5550.500454959073;5566.248556444828;5577.77688892456;5586.245856809279 23:16:18 INFO - PROCESS | 4792 | |5;yui.html;641.9133416988706;769.5459678789513;785.4423359414811;786.3198333441572;787.8936343593613;12503.812442813354;12651.177673451242;12700.745985080293;12734.299613521252;12735.172213806107;11984.820227696591;12031.458584363703;12066.155369124164;12073.21524100935;12095.75808483832;636.8789929913324;803.7910143362709;819.7417813388763;821.0229826506438;822.2640736540792;816.3510009542427;819.9139090395512;821.6179476543406;822.9588520573977;824.1881746479713;862.6161358195574;865.8571335729597;868.4572142410993;868.891388576428;869.026690107081;857.4555157475048;858.0347109501811;858.2275951643509;858.6522458404326;868.3183700794909;637.4517914593446;637.5632691606219;637.7480895046431;637.8532937424372;638.1735652330243;12748.745025099539;12774.425150868234;12777.808332875014;12799.296038717866;12820.743585128244;12243;12618.305993170372;13010.154339967872;13134.211947283098;13140.211587304791;10082.092611664912;10224.64213752515;10244.94877525615;10386.428746418944;10413.271071025032;3313.2545177335146;3315.088350703552;3364.226227967581;3450.8447119879665;3453.620101788801;38159.61840381588;42282.15435691299;43804.342934856;43922.90192745175;44265.3360199594;10110.797784044425;10267.435291059064;10302.278840481244;10311.535980880879;10331.276810623183;17016.74474882853;17025.914870425568;17031.31874724997;17059.573510662085;17068.658626827393;6518.087467754518;6720.428763555153;6792.830179245559;6793.66031698423;6866.622335771481;3643.2531331077066;3682.3739964206147;3705.4997575327525;3742.176721121349;3747.981260093682;2732.5081485332435;2762.8204166729097;2770.473610014091;2793.7485626293733;2795.3570678744004;494.68834634180234;514.580616797309;517.2758138605982;568.5934556791914;590.822753174046;491.3587767962843;497.64169797745564;497.7536119620739;580.9854753631108;593.8366949088949;7582.848343033108;7852.332551733052;7864;7940;7982.241687039722;560.8934302482515;564.9180868774005;568.2016766443154;588.7409539802474;588.9028310328833;3697.6856967157555;3727.906802329909;3764.3036038333;3816.4275358695863;3880.3791393376923;55127.44872551223;55432;55602.44397555973;55612.721936390866;55685;45766.542334576894;46032.07935841331;47912;48478.75760621245;49090.754546227756;41698.58301416947;43442;44262.778686107005;44691.55308446874;45038.54961450409;7836.177201393772;7926.167752386147;7985.901359440569;7990.680372785024;8145.551994640352;31622.525662115546;32617.673823261463;33832.83083584566;33990.66009339875;34231;38839.22321553496;41377.1724565513;41414.792926035174;41908.58091419047;44441.55558444374;9994.20046396301;9999.999999999884;10058.798824023332;10148.188144948534;10223.795524089328;11076.5569377224;11441.313521188755;11485.425728713699;11541.653750387502;11638.418079095842;10681.46592670379;10751.13990880712;10848.294860834021;10876.18428617841;11082.168837337393;9893.159081478156;10075.647352342632;10091.79816403653;10123.392596444237;10272.33229840058;10358.274920755475;10579.788404231718;10615.840762388416;10676.412797295912;11031.613893513688;9243.39917905361;9244.399114057565;9348.392354497208;9483.66807161746;9499.43003419797;9000.36997410175;9049.59276832531;9054.185123338932;9180.219681327162;9250.074992500697 23:16:18 INFO - PROCESS | 4792 | __end_tp_report 23:16:18 INFO - PROCESS | 4792 | __start_cc_report 23:16:18 INFO - PROCESS | 4792 | _x_x_mozilla_cycle_collect,1057 23:16:18 INFO - PROCESS | 4792 | __end_cc_report 23:16:18 INFO - PROCESS | 4792 | __startTimestamp1458281778217__endTimestamp 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | ------- Summary: start ------- 23:16:18 INFO - PROCESS | 4792 | Number of tests: 6 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | [#0] dojo.html Cycles:165 Average:4681.72 Median:4843.25 stddev:488.85 (10.1%) stddev-sans-first:462.92 23:16:18 INFO - PROCESS | 4792 | Values: 2623.6 2678.9 2682.2 2695.4 2717.6 4565.3 4647.1 4666.7 4671.2 4684.3 4713.2 4735.7 4740.5 4754.5 4758.7 4279.5 4368.8 4369.7 4420.8 4444.2 4250.8 4309.1 4379.2 4388.1 4389.4 4301.1 4344.4 4347.7 4390.1 4398.3 4360.7 4361.7 4382.0 4384.3 4400.7 4217.9 4294.8 4343.7 4346.7 4402.1 4629.2 4671.3 4724.2 4727.0 4731.0 5061.9 5061.9 5065.3 5073.8 5122.4 5094.6 5097.2 5097.7 5102.1 5109.6 4679.6 4680.8 4716.5 4753.7 4758.0 5195.8 5196.5 5200.8 5201.5 5201.5 4877.7 4999.4 5001.7 5018.7 5049.0 4998.5 5043.1 5060.6 5097.0 5109.2 5050.7 5069.7 5069.8 5076.1 5124.6 4921.7 5020.9 5057.0 5061.5 5065.2 4209.5 4245.9 4262.2 4291.7 4303.8 3745.6 3748.8 3754.8 3776.0 3786.6 4281.7 4357.9 4387.4 4393.3 4428.5 5073.5 5073.8 5083.6 5105.7 5127.5 4346.9 4367.9 4370.3 4417.1 4422.2 4400.5 4516.8 4529.7 4535.2 4633.6 4830.9 4845.9 4856.0 4881.7 4897.7 5100.1 5104.4 5106.0 5107.4 5108.9 4665.9 4767.0 4843.2 4862.0 4891.9 4978.9 4979.8 4995.9 5001.0 5046.4 5073.9 5078.3 5082.9 5083.2 5124.9 4816.7 4895.3 4942.1 4971.4 4987.7 4870.5 4905.6 4910.7 4913.4 4965.6 4771.7 4840.0 4850.4 4852.6 4897.8 4790.4 4913.0 4915.9 4949.1 4999.1 4845.4 4854.2 4856.4 4869.2 4870.9 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | [#1] ext.html Cycles:180 Average:42157.78 Median:19213.67 stddev:75342.83 (392.1%) stddev-sans-first:75489.38 23:16:18 INFO - PROCESS | 4792 | Values: 537.1 538.5 558.1 561.4 566.2 26749.3 34090.3 34287.0 34311.0 34399.5 37198.8 37539.8 37547.0 37714.2 37782.8 7675.7 7780.0 7840.9 7852.3 7873.1 7648.7 7775.5 7778.4 7780.1 7994.2 7967.6 8006.9 8027.4 8034.6 8034.8 7903.3 7971.6 7976.0 7980.3 8000.1 7829.9 7975.1 7975.9 7976.0 7976.1 37177.0 37491.6 37514.4 37559.4 37590.2 2890.5 2987.0 2999.5 3049.9 3108.9 28258.4 29059.3 29100.6 29370.0 29925.7 3422.0 3469.3 3515.2 3608.9 3627.0 257572.0 260400.0 260695.0 261632.7 262108.0 41731.8 52753.0 54171.7 54201.0 54260.0 41765.8 41894.2 41909.2 42044.0 42049.8 12489.7 12737.0 12740.6 12745.9 12750.0 9533.3 9534.0 9538.6 9548.0 9574.3 14284.6 14301.2 14781.7 14835.9 14926.9 5776.6 5842.1 5903.9 5909.1 5949.6 860.4 879.4 951.9 984.4 991.4 27806.3 29566.9 29790.3 31088.4 31156.7 948.6 974.7 980.2 1028.3 1073.6 13915.5 14328.2 14376.9 14457.3 14536.0 373788.0 377164.0 379302.0 379569.0 380225.0 47668.8 48719.5 48880.3 48992.3 49046.0 1158.2 1177.7 1239.5 1248.0 1263.3 24518.8 26023.0 26129.6 26142.3 26193.3 35038.5 35459.8 35630.3 35680.8 35735.1 184231.0 184373.0 184485.0 185169.0 186440.0 26366.0 30259.2 30807.0 30834.8 31402.8 34275.5 34454.3 34958.0 35312.5 37517.6 32800.5 32850.5 33013.8 33464.2 33558.5 32964.3 33082.3 33462.8 33528.2 33810.3 32359.7 32814.5 33214.5 33255.3 33324.0 28330.6 28707.9 29103.9 29350.9 29360.3 23337.0 23426.2 23690.8 23691.5 23692.2 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | [#2] jquery.html Cycles:180 Average:23690.63 Median:25475.92 stddev:66102.26 (259.5%) stddev-sans-first:66264.47 23:16:18 INFO - PROCESS | 4792 | Values: 358.2 359.4 365.7 371.9 373.5 15140.1 15410.6 17282.4 17308.8 17332.1 16517.3 16685.4 16878.6 16895.0 16905.5 4649.1 4965.2 5155.0 5226.7 5233.3 5114.6 5162.7 5174.3 5191.0 5221.4 4928.1 5168.0 5170.7 5174.2 5180.3 5112.8 5145.8 5147.6 5152.8 5171.3 4578.7 4622.7 4624.7 4625.5 4653.8 19475.7 19755.6 20072.9 20074.8 20119.0 1921.3 2098.1 2098.6 2196.9 2402.9 13125.3 13150.1 13203.3 13390.1 13466.7 1762.7 1794.6 1826.9 1827.9 1828.3 56959.0 60372.4 60515.0 60927.4 62203.7 10190.1 10362.6 10389.7 10446.1 10534.5 13281.7 13338.8 13358.1 13364.1 13382.5 6883.2 7122.0 7203.0 7212.0 7227.9 6671.8 6679.6 6716.7 6801.6 6850.8 4439.9 4441.8 4452.0 4466.9 4520.8 1837.6 1850.0 1874.7 1881.9 1889.2 803.4 838.1 886.2 909.9 939.5 15421.8 15817.8 15903.0 16272.9 16621.3 865.6 883.5 903.6 941.9 956.0 9215.2 9546.1 9606.1 9607.4 9756.0 394982.0 397691.0 406704.0 408816.0 409743.0 52305.7 62398.7 63300.7 66509.7 70028.6 886.5 893.4 907.5 919.0 921.5 14633.9 14724.2 14743.7 15024.2 15349.2 32710.3 33550.3 33744.0 33847.3 33908.7 45979.5 46208.8 46272.8 46302.8 46683.3 7334.3 7393.7 7414.4 7429.1 7488.3 9610.5 10789.0 11034.8 11273.4 11341.7 9543.7 9639.8 9689.3 9800.3 9838.0 5917.8 8974.3 9158.7 9296.8 9484.7 9629.0 9651.4 9987.5 10078.6 10207.2 7248.4 7300.4 7347.9 7451.0 7557.5 8057.0 9902.0 9981.2 10005.8 10094.6 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | [#3] mootools.html Cycles:180 Average:5323.16 Median:5990.04 stddev:2795.44 (46.7%) stddev-sans-first:2787.03 23:16:18 INFO - PROCESS | 4792 | Values: 1312.4 1430.3 1440.6 1608.5 1823.6 6643.6 7183.8 7324.2 7325.7 7334.2 7414.4 7590.6 7602.1 7604.8 7618.8 1980.8 2267.9 2291.0 2319.9 2328.2 2326.1 2344.3 2345.0 2345.7 2347.6 2255.8 2327.1 2327.4 2328.1 2332.7 2257.4 2265.0 2266.7 2272.1 2294.7 2255.8 2261.0 2266.0 2280.7 2327.4 7735.3 7817.2 7819.1 7819.3 7826.5 4676.7 4783.1 4807.8 4812.1 4813.2 2934.2 3068.0 3106.4 3247.0 3259.7 1028.5 1033.3 1053.4 1069.4 1085.4 10582.6 10601.8 10607.5 10629.9 10649.2 4460.4 4501.9 4548.1 4605.4 4609.1 8102.0 8115.5 8158.2 8171.3 8173.5 4080.2 4627.5 4671.4 4680.6 4699.3 3772.8 3781.7 3812.1 4201.8 4354.3 3554.9 3617.2 3627.4 3661.3 3676.3 1107.7 1112.7 1116.8 1122.1 1125.8 903.6 921.3 921.9 950.6 1265.0 7419.0 7436.0 7445.3 7495.3 7507.0 480.9 488.5 497.8 498.4 500.2 5655.0 5679.8 5693.8 5696.9 5721.7 9353.0 9564.4 9691.5 9692.6 9705.6 9182.3 9331.4 9467.7 9530.5 9537.7 7333.2 7425.4 7490.9 7490.9 7491.6 7024.0 7044.1 7052.0 7083.1 7090.7 8475.3 8508.1 8534.1 8540.6 8546.0 8636.2 8673.7 8821.3 8837.6 8896.2 5477.3 5637.6 5644.6 5959.6 6004.6 6979.9 7106.5 7112.7 7125.6 7128.9 6420.9 6536.6 6564.0 6565.3 6652.4 6252.3 6356.2 6469.0 6470.6 6470.6 6625.6 6665.6 6677.1 6750.1 6806.1 5975.5 6113.5 6183.1 6192.3 6201.1 6477.8 6507.5 6516.2 6561.5 6563.4 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | [#4] prototype.html Cycles:180 Average:4668.77 Median:5277.09 stddev:1346.39 (25.5%) stddev-sans-first:1310.07 23:16:18 INFO - PROCESS | 4792 | Values: 324.0 327.3 327.7 328.7 335.7 5327.5 5328.3 5329.6 5339.5 5344.5 5165.3 5264.1 5290.1 5308.1 5312.0 3964.4 4042.4 4124.0 4164.6 4188.0 4156.2 4170.0 4186.1 4202.3 4202.5 4158.3 4165.9 4170.0 4171.8 4172.9 3970.9 4055.4 4129.8 4133.5 4139.2 3676.9 3701.6 3706.7 3714.4 3718.2 5093.4 5111.5 5111.7 5111.9 5113.7 4850.4 4850.9 4852.2 4858.6 4862.8 5647.4 5650.7 5650.9 5656.6 5657.7 4086.4 4098.1 4098.9 4099.8 4102.1 5656.5 5920.3 5921.1 5930.3 5937.1 3974.3 4054.6 4055.5 4057.8 4057.9 4102.7 4115.2 4118.6 4119.1 4127.2 4715.2 4725.3 4725.7 4726.2 4726.5 5640.4 5651.9 5654.1 5655.1 5660.9 1477.9 1504.7 1504.9 1505.6 1506.0 965.7 1009.8 1012.0 1033.4 1035.9 4891.4 4896.9 4909.2 4914.2 4917.9 5707.7 5713.3 5713.7 5718.7 5722.6 4885.1 4888.0 4888.4 4895.6 4904.2 3056.1 3088.3 3093.7 3120.2 3122.3 5496.5 5499.8 5509.1 5512.4 5513.6 5762.5 5941.2 5944.7 5951.8 5955.9 5468.5 5487.6 5496.6 5501.7 5509.5 5766.2 5783.4 5785.1 5792.2 5792.8 5662.1 5671.0 5675.5 5676.8 5679.9 5482.0 5482.3 5493.4 5494.1 5507.4 4067.1 4212.6 4218.8 4220.5 4222.3 5746.7 5775.0 5779.5 5779.9 5781.6 5569.2 5579.9 5580.2 5580.4 5581.9 5544.2 5573.0 5573.8 5577.5 5577.8 5450.8 5463.0 5468.6 5470.1 5472.6 5475.9 5729.5 5729.6 5733.6 5739.7 5490.5 5550.5 5566.2 5577.8 5586.2 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - PROCESS | 4792 | [#5] yui.html Cycles:180 Average:12948.91 Median:43863.62 stddev:14914.68 (34.0%) stddev-sans-first:14927.88 23:16:18 INFO - PROCESS | 4792 | Values: 641.9 769.5 785.4 786.3 787.9 12503.8 12651.2 12700.7 12734.3 12735.2 11984.8 12031.5 12066.2 12073.2 12095.8 636.9 803.8 819.7 821.0 822.3 816.4 819.9 821.6 823.0 824.2 862.6 865.9 868.5 868.9 869.0 857.5 858.0 858.2 858.7 868.3 637.5 637.6 637.7 637.9 638.2 12748.7 12774.4 12777.8 12799.3 12820.7 12243.0 12618.3 13010.2 13134.2 13140.2 10082.1 10224.6 10244.9 10386.4 10413.3 3313.3 3315.1 3364.2 3450.8 3453.6 38159.6 42282.2 43804.3 43922.9 44265.3 10110.8 10267.4 10302.3 10311.5 10331.3 17016.7 17025.9 17031.3 17059.6 17068.7 6518.1 6720.4 6792.8 6793.7 6866.6 3643.3 3682.4 3705.5 3742.2 3748.0 2732.5 2762.8 2770.5 2793.7 2795.4 494.7 514.6 517.3 568.6 590.8 491.4 497.6 497.8 581.0 593.8 7582.8 7852.3 7864.0 7940.0 7982.2 560.9 564.9 568.2 588.7 588.9 3697.7 3727.9 3764.3 3816.4 3880.4 55127.4 55432.0 55602.4 55612.7 55685.0 45766.5 46032.1 47912.0 48478.8 49090.8 41698.6 43442.0 44262.8 44691.6 45038.5 7836.2 7926.2 7985.9 7990.7 8145.6 31622.5 32617.7 33832.8 33990.7 34231.0 38839.2 41377.2 41414.8 41908.6 44441.6 9994.2 10000.0 10058.8 10148.2 10223.8 11076.6 11441.3 11485.4 11541.7 11638.4 10681.5 10751.1 10848.3 10876.2 11082.2 9893.2 10075.6 10091.8 10123.4 10272.3 10358.3 10579.8 10615.8 10676.4 11031.6 9243.4 9244.4 9348.4 9483.7 9499.4 9000.4 9049.6 9054.2 9180.2 9250.1 23:16:18 INFO - PROCESS | 4792 | -------- Summary: end -------- 23:16:18 INFO - PROCESS | 4792 | 23:16:18 INFO - TEST-INFO | 4792: exit 0 23:16:18 INFO - TEST-OK | dromaeo_css | took 1115338ms 23:16:18 INFO - TEST-START | kraken 23:16:18 INFO - operating with platform_type : linux_ 23:16:18 INFO - Initialising browser for kraken test... 23:16:18 INFO - TEST-INFO | started process 4973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXEs3C/profile http://localhost:37792/getInfo.html) 23:16:22 INFO - PROCESS | 4973 | __metrics Screen width/height:1600/1200 23:16:22 INFO - PROCESS | 4973 | colorDepth:24 23:16:22 INFO - PROCESS | 4973 | Browser inner width/height: 1024/697 23:16:22 INFO - PROCESS | 4973 | __metrics 23:16:23 ERROR - PROCESS | 4973 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:16:24 INFO - TEST-INFO | 4973: exit 0 23:16:24 INFO - Browser initialized. 23:16:24 INFO - Running cycle 1/1 for kraken test... 23:16:24 INFO - TEST-INFO | started process 5058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXEs3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:36 INFO - PROCESS | 5058 | RSS: Main: 153948160 23:16:36 INFO - PROCESS | 5058 | 23:16:38 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37792/tests/kraken/driver.html?testName=audio-beat-detection) 23:16:39 INFO - PROCESS | 5058 | RSS: Main: 197541888 23:16:39 INFO - PROCESS | 5058 | 23:16:42 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37792/tests/kraken/driver.html?testName=audio-dft) 23:16:42 INFO - PROCESS | 5058 | RSS: Main: 187764736 23:16:42 INFO - PROCESS | 5058 | 23:16:45 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37792/tests/kraken/driver.html?testName=audio-fft) 23:16:46 INFO - PROCESS | 5058 | RSS: Main: 173514752 23:16:46 INFO - PROCESS | 5058 | 23:16:48 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37792/tests/kraken/driver.html?testName=audio-oscillator) 23:16:49 INFO - PROCESS | 5058 | RSS: Main: 173871104 23:16:49 INFO - PROCESS | 5058 | 23:16:51 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:16:51 INFO - PROCESS | 5058 | RSS: Main: 175308800 23:16:51 INFO - PROCESS | 5058 | 23:16:55 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37792/tests/kraken/driver.html?testName=imaging-darkroom) 23:16:55 INFO - PROCESS | 5058 | RSS: Main: 174141440 23:16:55 INFO - PROCESS | 5058 | 23:16:59 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37792/tests/kraken/driver.html?testName=imaging-desaturate) 23:16:59 INFO - PROCESS | 5058 | RSS: Main: 173969408 23:16:59 INFO - PROCESS | 5058 | 23:17:02 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37792/tests/kraken/driver.html?testName=json-parse-financial) 23:17:03 INFO - PROCESS | 5058 | RSS: Main: 174104576 23:17:03 INFO - PROCESS | 5058 | 23:17:04 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:17:05 INFO - PROCESS | 5058 | RSS: Main: 186916864 23:17:05 INFO - PROCESS | 5058 | 23:17:07 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:17:07 INFO - PROCESS | 5058 | RSS: Main: 187121664 23:17:07 INFO - PROCESS | 5058 | 23:17:10 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:17:10 INFO - PROCESS | 5058 | RSS: Main: 192925696 23:17:10 INFO - PROCESS | 5058 | 23:17:13 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:17:13 INFO - PROCESS | 5058 | RSS: Main: 200388608 23:17:13 INFO - PROCESS | 5058 | 23:17:16 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:17:16 INFO - PROCESS | 5058 | RSS: Main: 199290880 23:17:16 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:37792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37792/tests/kraken/driver.html?testName=ai-astar) 23:17:18 INFO - PROCESS | 5058 | RSS: Main: 258207744 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | __start_tp_report 23:17:18 INFO - PROCESS | 5058 | _x_x_mozilla_page_load 23:17:18 INFO - PROCESS | 5058 | _x_x_mozilla_page_load_details 23:17:18 INFO - PROCESS | 5058 | |i|pagename|runs| 23:17:18 INFO - PROCESS | 5058 | |0;ai-astar;113;114;108;113;114;113;102;113;113;111 23:17:18 INFO - PROCESS | 5058 | |1;audio-beat-detection;151;130;155;176;129;155;151;131;168;135 23:17:18 INFO - PROCESS | 5058 | |2;audio-dft;164;161;162;161;161;160;161;161;162;162 23:17:18 INFO - PROCESS | 5058 | |3;audio-fft;73;74;94;95;76;73;72;99;92;72 23:17:18 INFO - PROCESS | 5058 | |4;audio-oscillator;93;94;132;93;95;94;136;94;94;127 23:17:18 INFO - PROCESS | 5058 | |5;imaging-gaussian-blur;116;116;116;117;117;118;117;117;117;128 23:17:18 INFO - PROCESS | 5058 | |6;imaging-darkroom;145;146;145;148;147;146;147;145;146;146 23:17:18 INFO - PROCESS | 5058 | |7;imaging-desaturate;95;95;95;95;97;96;95;96;96;95 23:17:18 INFO - PROCESS | 5058 | |8;json-parse-financial;63;64;63;65;63;64;63;72;63;61 23:17:18 INFO - PROCESS | 5058 | |9;json-stringify-tinderbox;63;64;65;64;64;65;65;64;64;64 23:17:18 INFO - PROCESS | 5058 | |10;stanford-crypto-aes;80;89;91;82;83;81;82;80;82;83 23:17:18 INFO - PROCESS | 5058 | |11;stanford-crypto-ccm;121;118;122;118;113;115;121;117;115;115 23:17:18 INFO - PROCESS | 5058 | |12;stanford-crypto-pbkdf2;148;137;146;150;144;132;152;141;141;141 23:17:18 INFO - PROCESS | 5058 | |13;stanford-crypto-sha256-iterative;66;66;68;69;68;67;66;72;68;68 23:17:18 INFO - PROCESS | 5058 | __end_tp_report 23:17:18 INFO - PROCESS | 5058 | __start_cc_report 23:17:18 INFO - PROCESS | 5058 | _x_x_mozilla_cycle_collect,1129 23:17:18 INFO - PROCESS | 5058 | __end_cc_report 23:17:18 INFO - PROCESS | 5058 | __startTimestamp1458281838837__endTimestamp 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | ------- Summary: start ------- 23:17:18 INFO - PROCESS | 5058 | Number of tests: 14 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:3.93 23:17:18 INFO - PROCESS | 5058 | Values: 113.0 114.0 108.0 113.0 114.0 113.0 102.0 113.0 113.0 111.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:153.00 stddev:16.48 (10.8%) stddev-sans-first:17.44 23:17:18 INFO - PROCESS | 5058 | Values: 151.0 130.0 155.0 176.0 129.0 155.0 151.0 131.0 168.0 135.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.08 (0.7%) stddev-sans-first:0.67 23:17:18 INFO - PROCESS | 5058 | Values: 164.0 161.0 162.0 161.0 161.0 160.0 161.0 161.0 162.0 162.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#3] audio-fft Cycles:10 Average:82.00 Median:84.00 stddev:11.37 (13.5%) stddev-sans-first:11.59 23:17:18 INFO - PROCESS | 5058 | Values: 73.0 74.0 94.0 95.0 76.0 73.0 72.0 99.0 92.0 72.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:94.00 stddev:18.40 (19.6%) stddev-sans-first:18.97 23:17:18 INFO - PROCESS | 5058 | Values: 93.0 94.0 132.0 93.0 95.0 94.0 136.0 94.0 94.0 127.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.00 stddev:3.60 (3.1%) stddev-sans-first:3.76 23:17:18 INFO - PROCESS | 5058 | Values: 116.0 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 128.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 23:17:18 INFO - PROCESS | 5058 | Values: 145.0 146.0 145.0 148.0 147.0 146.0 147.0 145.0 146.0 146.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 23:17:18 INFO - PROCESS | 5058 | Values: 95.0 95.0 95.0 95.0 97.0 96.0 95.0 96.0 96.0 95.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:63.50 stddev:2.96 (4.7%) stddev-sans-first:3.11 23:17:18 INFO - PROCESS | 5058 | Values: 63.0 64.0 63.0 65.0 63.0 64.0 63.0 72.0 63.0 61.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 23:17:18 INFO - PROCESS | 5058 | Values: 63.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 64.0 64.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.71 (4.5%) stddev-sans-first:3.74 23:17:18 INFO - PROCESS | 5058 | Values: 80.0 89.0 91.0 82.0 83.0 81.0 82.0 80.0 82.0 83.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:118.00 stddev:3.06 (2.6%) stddev-sans-first:2.98 23:17:18 INFO - PROCESS | 5058 | Values: 121.0 118.0 122.0 118.0 113.0 115.0 121.0 117.0 115.0 115.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:145.00 stddev:6.09 (4.2%) stddev-sans-first:6.20 23:17:18 INFO - PROCESS | 5058 | Values: 148.0 137.0 146.0 150.0 144.0 132.0 152.0 141.0 141.0 141.0 23:17:18 INFO - PROCESS | 5058 | 23:17:18 INFO - PROCESS | 5058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.81 (2.7%) stddev-sans-first:1.80 23:17:18 INFO - PROCESS | 5058 | Values: 66.0 66.0 68.0 69.0 68.0 67.0 66.0 72.0 68.0 68.0 23:17:18 INFO - PROCESS | 5058 | -------- Summary: end -------- 23:17:18 INFO - PROCESS | 5058 | 23:17:19 INFO - TEST-INFO | 5058: exit 0 23:17:19 INFO - TEST-OK | kraken | took 60884ms 23:17:19 INFO - SUITE-END | took 1176s 23:17:19 INFO - Completed test suite (00:19:36) 23:17:19 INFO - javascript benchmark 23:17:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2623.5933430318296, 2678.933026674334, 2682.2221555748833, 2695.4339588686375, 2717.592361145828, 4565.269556870901, 4647.093816705744, 4666.696664716791, 4671.15919134556, 4684.344191813145, 4713.222318317474, 4735.73953432561, 4740.525947405258, 4754.548317909793, 4758.738269395182, 4279.529251782302, 4368.847090351838, 4369.715968462056, 4420.845270415536, 4444.155610434023, 4250.787460626972, 4309.052008558112, 4379.211741886459, 4388.056567837914, 4389.429374181368, 4301.139772045588, 4344.413504176927, 4347.739135651871, 4390.143921935224, 4398.296272596369, 4360.738355698668, 4361.738295702236, 4381.978090109561, 4384.342348647729, 4400.713953593006, 4217.873463796091, 4294.806733696991, 4343.717658352197, 4346.695731298779, 4402.119576084764, 4629.213033784231, 4671.346011558385, 4724.196886529298, 4726.976365118187, 4730.952690473086, 5061.873453163664, 5061.898762024775, 5065.265536497187, 5073.797048118071, 5122.410922743895, 5094.566961808251, 5097.184450487941, 5097.668651537638, 5102.081625307444, 5109.6167787415725, 4679.578837904571, 4680.789364478641, 4716.528347165325, 4753.714777113384, 4758.048390321949, 5195.792168313301, 5196.4803519648485, 5200.7919683213, 5201.45384734605, 5201.479852014768, 4877.6829506081995, 4999.375078115236, 5001.699898006132, 5018.698878067327, 5049.0, 4998.475160108209, 5043.142665746758, 5060.645754797202, 5096.980603879239, 5109.233614957711, 5050.671706339076, 5069.746512674352, 5069.847904562869, 5076.086304465158, 5124.641275110706, 4921.729304888194, 5020.924686129711, 5056.974715126401, 5061.468545802638, 5065.164247899129, 4209.473815773028, 4245.936310955338, 4262.190183865056, 4291.678124140702, 4303.763293018914, 3745.6441638044344, 3748.8125593720206, 3754.755940863835, 3775.962240377616, 3786.583475817658, 4281.700280980302, 4357.934630980538, 4387.363832244307, 4393.29707246839, 4428.535003824616, 5073.492650734971, 5073.847784566469, 5083.644144909895, 5105.7191854448365, 5127.512886275797, 4346.9347959780625, 4367.890802729958, 4370.2570563004365, 4417.0724147929295, 4422.159789639958, 4400.471943366816, 4516.774161291923, 4529.728216306966, 4535.183666939983, 4633.606143477775, 4830.9275360870315, 4845.927311090407, 4856.004519073582, 4881.658283920163, 4897.730624815526, 5100.081985242544, 5104.387473503203, 5106.0, 5107.412647545431, 5108.948910510847, 4665.930011049905, 4767.0, 4843.24929635907, 4862.0, 4891.90216195667, 4978.900421991612, 4979.751012449436, 4995.850124496271, 5001.049800537886, 5046.444891061907, 5073.8731531712, 5078.263651770399, 5082.872928176826, 5083.237514372874, 5124.871878203075, 4816.710997340171, 4895.314655948241, 4942.061008408391, 4971.428285747041, 4987.700737955734, 4870.512948705101, 4905.583025442877, 4910.705357678551, 4913.361263035782, 4965.553100220997, 4771.73755443454, 4839.95160048395, 4850.369451971221, 4852.587530059985, 4897.755112244445, 4790.401199850019, 4913.0, 4915.926261106015, 4949.133901567139, 4999.0501804657, 4845.41854977405, 4854.1747902857305, 4856.368672072608, 4869.196582563837, 4870.853874383774], "unit": "score", "name": "dojo.html", "value": 4650.88464699077}, {"lowerIsBetter": false, "replicates": [537.1164434505237, 538.4911258860376, 558.1070287539936, 561.3880869851861, 566.2271000084884, 26749.331266718316, 34090.318193636114, 34286.99999999997, 34311.0, 34399.484007739906, 37198.81400592993, 37539.81230093852, 37547.0, 37714.24571508575, 37782.81108594453, 7675.6545955432, 7779.988601481799, 7840.921590784076, 7852.293293603575, 7873.055233371975, 7648.73229436967, 7775.455718099735, 7778.377729781604, 7780.14418413974, 7994.2005799419885, 7967.60161991901, 8006.879896801553, 8027.438079334449, 8034.558099304565, 8034.758957231293, 7903.3282171015535, 7971.561564113971, 7976.042874855026, 7980.321672657831, 8000.119986801447, 7829.8825517616715, 7975.122736498981, 7975.920240797575, 7975.96012019942, 7976.122626511079, 37177.0, 37491.62508374936, 37514.43728344077, 37559.436608450895, 37590.24819503622, 2890.4652639261594, 2986.970130298713, 2999.475091858916, 3049.8883097542816, 3108.9378212435627, 28258.434831303464, 29059.273518162005, 29100.563491547644, 29370.0, 29925.700742992725, 3421.9657803421896, 3469.3061387722555, 3515.244222492151, 3608.8736894208578, 3626.9818650906577, 257572.0, 260400.0, 260695.0, 261632.6918365415, 262108.0, 41731.7913410431, 52753.0, 54171.729141354044, 54201.0, 54260.0, 41765.79117104395, 41894.16211675749, 41909.161816763495, 42044.0, 42049.78975105105, 12489.687757806127, 12736.981041516656, 12740.617781466572, 12745.872541274468, 12750.0, 9533.285003624756, 9534.046595340411, 9538.61845526185, 9548.045195480396, 9574.329796914288, 14284.642883927985, 14301.213433261062, 14781.704365912836, 14835.851641483663, 14926.925365373103, 5776.595638305363, 5842.123681447817, 5903.852403689856, 5909.113632955005, 5949.553783466257, 860.4106187261746, 879.3580686099183, 951.9095685909828, 984.4290311619244, 991.3853410885154, 27806.3048423791, 29566.852165739463, 29790.25524361908, 31088.378232435225, 31156.688433115833, 948.6489998700525, 974.70758772368, 980.1815484070738, 1028.3315844701003, 1073.5705717712822, 13915.512957046454, 14328.211948342941, 14376.856231437761, 14457.277136143151, 14536.0, 373788.0, 377164.0, 379302.0, 379569.0, 380225.0, 47668.7616561915, 48719.5128048722, 48880.26679599809, 48992.265116023285, 49046.0, 1158.2182027131653, 1177.717347836513, 1239.504198320679, 1247.9500819967282, 1263.3241215949422, 24518.75481245236, 26023.0, 26129.608055878798, 26142.34644133912, 26193.345166370993, 35038.47442288419, 35459.82270088633, 35630.28739425249, 35680.82159589185, 35735.10662233465, 184231.0, 184373.0, 184485.0, 185169.0, 186440.0, 26366.0, 30259.243518912204, 30807.0, 30834.845825770728, 31402.842985784926, 34275.485867711504, 34454.31091378209, 34958.03019029967, 35312.47031294584, 37517.62482375251, 32800.50799237966, 32850.50724239091, 33013.83493082519, 33464.1633959153, 33558.49662255117, 32964.34071318608, 33082.33835323232, 33462.83268583739, 33528.1617959553, 33810.32379352448, 32359.676403236608, 32814.5077823828, 33214.5017824728, 33255.334893301515, 33324.0, 28330.575041374806, 28707.85646071756, 29103.85448072746, 29350.853245733633, 29360.26599335034, 23337.0, 23426.18008369699, 23690.763092369547, 23691.52616947686, 23692.170774022827], "unit": "score", "name": "ext.html", "value": 16423.012178791512}, {"lowerIsBetter": false, "replicates": [358.1976372924648, 359.35316430425246, 365.6909911125099, 371.9349113905068, 373.50324068988215, 15140.091594504338, 15410.61473463164, 17282.395116170937, 17308.826911730896, 17332.133393330314, 16517.33930642773, 16685.416010439636, 16878.57803554912, 16895.0, 16905.49283521496, 4649.070185962821, 4965.230389289657, 5155.046316431453, 5226.686398816083, 5233.345831771028, 5114.56526195272, 5162.664426812264, 5174.275601415805, 5190.974045129769, 5221.373435187783, 4928.088303663816, 5168.0, 5170.689758614495, 5174.223866420049, 5180.3006594109875, 5112.769925353368, 5145.845624631267, 5147.613928955325, 5152.793888244466, 5171.250168725533, 4578.679492435531, 4622.699524530928, 4624.722516649012, 4625.468071171825, 4653.767311634439, 19475.707864381904, 19755.604887902304, 20072.899635501875, 20074.799252007586, 20119.0, 1921.2795201799324, 2098.1187901081585, 2098.5697931924074, 2196.879171645559, 2402.9279121626378, 13125.34373281332, 13150.145240559428, 13203.339833008407, 13390.062695611312, 13466.663333416744, 1762.7355896615481, 1794.5872449336596, 1826.9360572380035, 1827.9086045697795, 1828.305244007282, 56959.0, 60372.39627603668, 60515.0, 60927.39072609306, 62203.68898155526, 10190.133838623651, 10362.637307694195, 10389.740256493496, 10446.112080473245, 10534.473276336152, 13281.667958300926, 13338.799918001238, 13358.064935454426, 13364.064515483822, 13382.531611393555, 6883.242843287235, 7122.002919591261, 7203.02759127511, 7211.990321355014, 7227.855442891113, 6671.766488172891, 6679.599224046573, 6716.731330746813, 6801.591904485746, 6850.794476165723, 4439.911201775946, 4441.755703436342, 4451.977740111279, 4466.9106617867465, 4520.841770538015, 1837.5589858434148, 1849.9907500462411, 1874.7000479923147, 1881.89649569275, 1889.159324100762, 803.365341380303, 838.1409055717816, 886.1714297132202, 909.9353756105372, 939.5490164720973, 15421.768673469907, 15817.841821581636, 15903.045817251003, 16272.944971895866, 16621.335146594243, 865.5715420866711, 883.4831623500324, 903.5888670654837, 941.9497260554432, 956.0487315121499, 9215.216706580015, 9546.140847323773, 9606.097342846388, 9607.375520591138, 9756.0, 394982.0, 397691.0, 406704.0, 408816.0, 409743.0, 52305.7384713074, 62398.68800655968, 63300.683496583144, 66509.66745166243, 70028.64985675039, 886.5257087458178, 893.4058850864103, 907.4963395315531, 918.9908100919039, 921.502388710089, 14633.853661463248, 14724.19016954035, 14743.705125897637, 15024.24878756036, 15349.155796430858, 32710.34579308448, 33550.32899342048, 33744.0, 33847.3230535383, 33908.66091339055, 45979.54020459753, 46208.76895615501, 46272.7531783205, 46302.76848615735, 46683.29975050309, 7334.3032411920785, 7393.74306367908, 7414.443916706161, 7429.07136607924, 7488.288612581796, 9610.471424071744, 10789.0, 11034.834477483004, 11273.436328183721, 11341.659750207507, 9543.665971690958, 9639.807203855744, 9689.273304502332, 9800.264980126376, 9837.95081024619, 5917.763289468373, 8974.282057435259, 9158.679446219618, 9296.767580810263, 9484.715458536255, 9629.0, 9651.420914745138, 9987.450690211817, 10078.596856125672, 10207.234457415576, 7248.383887369632, 7300.415966722543, 7347.889781653386, 7451.031365922396, 7557.470977031775, 8057.0, 9901.950490247502, 9981.151602113901, 10005.799884002425, 10094.646687365906], "unit": "score", "name": "jquery.html", "value": 8007.57610126709}, {"lowerIsBetter": false, "replicates": [1312.3766211049758, 1430.3420426603761, 1440.6398400399896, 1608.5496061102888, 1823.5714607067337, 6643.568168069072, 7183.784486465402, 7324.230955749649, 7325.743598974037, 7334.1565719942155, 7414.406847452205, 7590.58251796151, 7602.087749470057, 7604.77185684429, 7618.84762304755, 1980.8217260446556, 2267.9319620411416, 2290.977090229097, 2319.93040208794, 2328.208409140892, 2326.0695721711368, 2344.343583796531, 2344.9648255276184, 2345.6833327500826, 2347.565700345433, 2255.8082562982167, 2327.0575416956076, 2327.3716096653893, 2328.0687724910003, 2332.6617640442128, 2257.3566533537946, 2264.9886750566143, 2266.660000999847, 2272.125231785758, 2294.678744975705, 2255.751867294596, 2261.0, 2266.0256089881345, 2280.703508543895, 2327.418145463634, 7735.303822655932, 7817.1791961843755, 7819.061712594468, 7819.335356494705, 7826.491278066907, 4676.672632915697, 4783.091212669582, 4807.759612019385, 4812.085703716282, 4813.181759100961, 2934.1637633274627, 3068.0, 3106.409782141386, 3247.0, 3259.722923551501, 1028.4960369419005, 1033.3076838518211, 1053.367979212474, 1069.4492336446735, 1085.3867564825848, 10582.629607963685, 10601.84097238542, 10607.469626518643, 10629.9468502657, 10649.201309901788, 4460.397846290774, 4501.932471012938, 4548.090381923628, 4605.355250264965, 4609.147307748078, 8102.0, 8115.513069215866, 8158.184181581794, 8171.264586187272, 8173.468724532886, 4080.163566468867, 4627.490975992638, 4671.392718946515, 4680.602148817321, 4699.271612900006, 3772.849086036583, 3781.7352785305316, 3812.1232116613332, 4201.789910504463, 4354.346847972766, 3554.928901422009, 3617.1680513482047, 3627.383344831385, 3661.3409586274192, 3676.3015027144756, 1107.7175320293275, 1112.6828853776635, 1116.832475128721, 1122.1135303110452, 1125.7635896461834, 903.6159632156307, 921.2998121427763, 921.9354645174774, 950.6054987180381, 1264.9747005059846, 7418.962905185547, 7436.0, 7445.25547445262, 7495.287947644965, 7507.0, 480.92305231162845, 488.5456525431383, 497.8133200049981, 498.40191769876293, 500.1846989407243, 5654.97172514143, 5679.829605111853, 5693.829185124453, 5696.914546281809, 5721.656700597894, 9353.0, 9564.426134431957, 9691.51542422876, 9692.612295508101, 9705.563249653782, 9182.311326650528, 9331.393459425115, 9467.715968520955, 9530.475823829756, 9537.666181683746, 7333.230010848891, 7425.368843648243, 7490.887636685454, 7490.925090749131, 7491.587962661997, 7023.964880175567, 7044.119485064367, 7051.964740176266, 7083.114610673666, 7090.716371345088, 8475.279601233717, 8508.064112947446, 8534.061253262013, 8540.572971351283, 8545.957270213608, 8636.222739953435, 8673.653053878026, 8821.338399619926, 8837.646494140163, 8896.154865287788, 5477.287952566141, 5637.605367624227, 5644.576656750843, 5959.582829201914, 6004.609700369462, 6979.930200697928, 7106.502544821813, 7112.715491380287, 7125.572465652078, 7128.928710713034, 6420.871582568416, 6536.607803531803, 6564.015397690385, 6565.277819439762, 6652.4345430637, 6252.3122456530655, 6356.237251529846, 6468.967655161694, 6470.579412338183, 6470.6441145737435, 6625.569337993015, 6665.633390163587, 6677.065210870385, 6750.122484077038, 6806.081179040766, 5975.462208401264, 6113.480354169946, 6183.103449999815, 6192.256929168529, 6201.131841542097, 6477.838054048687, 6507.544471887112, 6516.152900123143, 6561.507886908596, 6563.3764792344655], "unit": "score", "name": "mootools.html", "value": 4297.066885398579}, {"lowerIsBetter": false, "replicates": [323.9886603968861, 327.33714228686904, 327.6559612406972, 328.7173031193175, 335.7163197098451, 5327.547158491528, 5328.280682107919, 5329.573634109272, 5339.492748188925, 5344.4922732340465, 5165.27686123942, 5264.1051021326375, 5290.074237008518, 5308.124159513675, 5312.0, 3964.3657014877626, 4042.3734321180264, 4123.9793801030955, 4164.583541645841, 4188.036751547138, 4156.210320039183, 4169.958300416987, 4186.079062606222, 4202.285611446062, 4202.516710578277, 4158.334666453368, 4165.916681666365, 4169.958300417003, 4171.791410429481, 4172.937405938914, 3970.9205815883665, 4055.35114381699, 4129.772862492562, 4133.483314585676, 4139.2135494256, 3676.926461470782, 3701.61133081028, 3706.703463722896, 3714.3685573452576, 3718.1819999600043, 5093.414257360414, 5111.514406131411, 5111.718855462948, 5111.948880511184, 5113.744312784346, 4850.4236123259725, 4850.902981940377, 4852.223644216943, 4858.562729354339, 4862.781174847105, 5647.43525647436, 5650.7174641267775, 5650.85872853182, 5656.604037717361, 5657.688827114507, 4086.427900093989, 4098.098418347959, 4098.938515922264, 4099.795010249505, 4102.056526998807, 5656.547476201894, 5920.348761636216, 5921.111833225008, 5930.258717660293, 5937.079752638305, 3974.2647610192207, 4054.5945405459806, 4055.513338399352, 4057.8376864925663, 4057.94493431704, 4102.692298077596, 4115.1975364804175, 4118.6499147572795, 4119.0937993641355, 4127.195196936568, 4715.198416269242, 4725.314829349725, 4725.740084295328, 4726.220173671374, 4726.480087190406, 5640.407757185519, 5651.9152212716845, 5654.06707893193, 5655.095184770417, 5660.915086273709, 1477.8841974309328, 1504.7216264991011, 1504.8720858726913, 1505.6386467247783, 1506.0361368724025, 965.7295957132014, 1009.8283291840405, 1011.9949400252951, 1033.405791669778, 1035.9015893490107, 4891.388576427947, 4896.853094407174, 4909.214525675875, 4914.20631469511, 4917.877053073702, 5707.74315155819, 5713.285839270091, 5713.6857472838565, 5718.7426565804635, 5722.62802917809, 4885.071836351153, 4888.0, 4888.364512613338, 4895.559399654048, 4904.190808516555, 3056.144279601715, 3088.258817883692, 3093.6906309368883, 3120.188750924776, 3122.3443076954095, 5496.477834605706, 5499.835004949858, 5509.146082357241, 5512.39363669996, 5513.558915286768, 5762.538996880324, 5941.168236446901, 5944.7324870380935, 5951.791687290924, 5955.910661340084, 5468.4531546845, 5487.64330318528, 5496.615236933376, 5501.697406642673, 5509.47659972302, 5766.221560089334, 5783.363829978614, 5785.074388097884, 5792.160136780059, 5792.82621521355, 5662.094064949588, 5671.0, 5675.489205971482, 5676.801311954062, 5679.914801278067, 5482.0, 5482.342118945592, 5493.395726470165, 5494.066008778597, 5507.421720719267, 4067.1458993611673, 4212.620864122244, 4218.789060546899, 4220.5146408163455, 4222.303319952173, 5746.741396637078, 5774.971125144348, 5779.450952159538, 5779.942200577941, 5781.566382521243, 5569.192467092168, 5579.916301255404, 5580.218769372373, 5580.441955804387, 5581.9162712560155, 5544.168374743821, 5572.972135139298, 5573.832785016456, 5577.52591029767, 5577.832665020056, 5450.781968721207, 5463.0, 5468.56251499887, 5470.097433923358, 5472.5621950243085, 5475.863103422446, 5729.455701708331, 5729.627574207663, 5733.569982251432, 5739.684317362585, 5490.450954904478, 5550.500454959073, 5566.248556444828, 5577.77688892456, 5586.245856809279], "unit": "score", "name": "prototype.html", "value": 4245.527854074796}, {"lowerIsBetter": false, "replicates": [641.9133416988706, 769.5459678789513, 785.4423359414811, 786.3198333441572, 787.8936343593613, 12503.812442813354, 12651.177673451242, 12700.745985080293, 12734.299613521252, 12735.172213806107, 11984.820227696591, 12031.458584363703, 12066.155369124164, 12073.21524100935, 12095.75808483832, 636.8789929913324, 803.7910143362709, 819.7417813388763, 821.0229826506438, 822.2640736540792, 816.3510009542427, 819.9139090395512, 821.6179476543406, 822.9588520573977, 824.1881746479713, 862.6161358195574, 865.8571335729597, 868.4572142410993, 868.891388576428, 869.026690107081, 857.4555157475048, 858.0347109501811, 858.2275951643509, 858.6522458404326, 868.3183700794909, 637.4517914593446, 637.5632691606219, 637.7480895046431, 637.8532937424372, 638.1735652330243, 12748.745025099539, 12774.425150868234, 12777.808332875014, 12799.296038717866, 12820.743585128244, 12243.0, 12618.305993170372, 13010.154339967872, 13134.211947283098, 13140.211587304791, 10082.092611664912, 10224.64213752515, 10244.94877525615, 10386.428746418944, 10413.271071025032, 3313.2545177335146, 3315.088350703552, 3364.226227967581, 3450.8447119879665, 3453.620101788801, 38159.61840381588, 42282.15435691299, 43804.342934856, 43922.90192745175, 44265.3360199594, 10110.797784044425, 10267.435291059064, 10302.278840481244, 10311.535980880879, 10331.276810623183, 17016.74474882853, 17025.914870425568, 17031.31874724997, 17059.573510662085, 17068.658626827393, 6518.087467754518, 6720.428763555153, 6792.830179245559, 6793.66031698423, 6866.622335771481, 3643.2531331077066, 3682.3739964206147, 3705.4997575327525, 3742.176721121349, 3747.981260093682, 2732.5081485332435, 2762.8204166729097, 2770.473610014091, 2793.7485626293733, 2795.3570678744004, 494.68834634180234, 514.580616797309, 517.2758138605982, 568.5934556791914, 590.822753174046, 491.3587767962843, 497.64169797745564, 497.7536119620739, 580.9854753631108, 593.8366949088949, 7582.848343033108, 7852.332551733052, 7864.0, 7940.0, 7982.241687039722, 560.8934302482515, 564.9180868774005, 568.2016766443154, 588.7409539802474, 588.9028310328833, 3697.6856967157555, 3727.906802329909, 3764.3036038333, 3816.4275358695863, 3880.3791393376923, 55127.44872551223, 55432.0, 55602.44397555973, 55612.721936390866, 55685.0, 45766.542334576894, 46032.07935841331, 47912.0, 48478.75760621245, 49090.754546227756, 41698.58301416947, 43442.0, 44262.778686107005, 44691.55308446874, 45038.54961450409, 7836.177201393772, 7926.167752386147, 7985.901359440569, 7990.680372785024, 8145.551994640352, 31622.525662115546, 32617.673823261463, 33832.83083584566, 33990.66009339875, 34231.0, 38839.22321553496, 41377.1724565513, 41414.792926035174, 41908.58091419047, 44441.55558444374, 9994.20046396301, 9999.999999999884, 10058.798824023332, 10148.188144948534, 10223.795524089328, 11076.5569377224, 11441.313521188755, 11485.425728713699, 11541.653750387502, 11638.418079095842, 10681.46592670379, 10751.13990880712, 10848.294860834021, 10876.18428617841, 11082.168837337393, 9893.159081478156, 10075.647352342632, 10091.79816403653, 10123.392596444237, 10272.33229840058, 10358.274920755475, 10579.788404231718, 10615.840762388416, 10676.412797295912, 11031.613893513688, 9243.39917905361, 9244.399114057565, 9348.392354497208, 9483.66807161746, 9499.43003419797, 9000.36997410175, 9049.59276832531, 9054.185123338932, 9180.219681327162, 9250.074992500697], "unit": "score", "name": "yui.html", "value": 5944.302841846791}], "name": "dromaeo_css", "value": 6362.42268356317}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 108.0, 113.0, 114.0, 113.0, 102.0, 113.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 155.0, 176.0, 129.0, 155.0, 151.0, 131.0, 168.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 94.0, 95.0, 76.0, 73.0, 72.0, 99.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 132.0, 93.0, 95.0, 94.0, 136.0, 94.0, 94.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 128.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 148.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 63.0, 72.0, 63.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [80.0, 89.0, 91.0, 82.0, 83.0, 81.0, 82.0, 80.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 122.0, 118.0, 113.0, 115.0, 121.0, 117.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.5}, {"lowerIsBetter": true, "replicates": [148.0, 137.0, 146.0, 150.0, 144.0, 132.0, 152.0, 141.0, 141.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 69.0, 68.0, 67.0, 66.0, 72.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1507.8}]} 23:17:20 INFO - Return code: 0 23:17:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:17:20 ERROR - # TBPL SUCCESS # 23:17:20 INFO - Running post-action listener: _resource_record_post_action 23:17:20 INFO - Running post-run listener: _resource_record_post_run 23:17:21 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 77824; Write bytes: 521658368; Read time: 368; Write time: 600004 23:17:21 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 69632; Write bytes: 232562688; Read time: 228; Write time: 347720 23:17:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289095680; Read time: 140; Write time: 252284 23:17:21 INFO - Running post-run listener: _upload_blobber_files 23:17:21 INFO - Blob upload gear active. 23:17:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:17:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:17:21 INFO - (blobuploader) - INFO - Open directory for files ... 23:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:17:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:22 INFO - (blobuploader) - INFO - Done attempting. 23:17:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:17:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:17:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:23 INFO - (blobuploader) - INFO - Done attempting. 23:17:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:17:23 INFO - Return code: 0 23:17:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:17:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:17:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7271643e036d1e9f732851d5528dc137d336dce2c0aca9b81be7d385955842c211de46833800095704844ff50a65b4a28ad04da34d981038a8e02177ba316957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b71f9c3b8a249a9bc12d26b7b2eb25a45642369ef9250959a0501f1e61e5e82bb33ba308593445fe370f45caafcfb4454c2c75bd39959451b50af6ccbf5ba1f"} 23:17:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:17:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:17:23 INFO - Contents: 23:17:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7271643e036d1e9f732851d5528dc137d336dce2c0aca9b81be7d385955842c211de46833800095704844ff50a65b4a28ad04da34d981038a8e02177ba316957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b71f9c3b8a249a9bc12d26b7b2eb25a45642369ef9250959a0501f1e61e5e82bb33ba308593445fe370f45caafcfb4454c2c75bd39959451b50af6ccbf5ba1f"} 23:17:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:17:23 INFO - Copying logs to upload dir... 23:17:23 INFO - mkdir: /builds/slave/test/build/upload/logs 23:17:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.292602 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-17 23:17:23.859994) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 23:17:23.863345) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7271643e036d1e9f732851d5528dc137d336dce2c0aca9b81be7d385955842c211de46833800095704844ff50a65b4a28ad04da34d981038a8e02177ba316957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b71f9c3b8a249a9bc12d26b7b2eb25a45642369ef9250959a0501f1e61e5e82bb33ba308593445fe370f45caafcfb4454c2c75bd39959451b50af6ccbf5ba1f"} build_url:https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/LfahQyehTuGIkTtuHE3myw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7271643e036d1e9f732851d5528dc137d336dce2c0aca9b81be7d385955842c211de46833800095704844ff50a65b4a28ad04da34d981038a8e02177ba316957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b71f9c3b8a249a9bc12d26b7b2eb25a45642369ef9250959a0501f1e61e5e82bb33ba308593445fe370f45caafcfb4454c2c75bd39959451b50af6ccbf5ba1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 23:17:23.887703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 23:17:23.888012) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458278586.44228-1980192689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 23:17:23.971806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 23:17:23.972127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 23:17:23.972408) ========= ========= Total master_lag: 0.28 =========