builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1463420535.42 results: success (0) buildid: 20160516095902 builduid: 119e0603021d484e8dc9eed77b91182d revision: de80d1838a8db73172f7c09f57a3ecc0267f47e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.422196) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.422729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.423048) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.456160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.456483) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 10:42:15-- 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% 224M=0s 2016-05-16 10:42:15 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.564887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.565214) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016269 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.619127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:15.619474) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev de80d1838a8db73172f7c09f57a3ecc0267f47e5 --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 de80d1838a8db73172f7c09f57a3ecc0267f47e5 --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=652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 10:42:16,034 truncating revision to first 12 chars 2016-05-16 10:42:16,034 Setting DEBUG logging. 2016-05-16 10:42:16,034 attempt 1/10 2016-05-16 10:42:16,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/de80d1838a8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 10:42:16,307 unpacking tar archive at: fx-team-de80d1838a8d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:16.195606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:16.199174) ========= script_repo_revision: de80d1838a8db73172f7c09f57a3ecc0267f47e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:16.199754) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:16.200032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 10:42:16.210149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-16 10:42:16.210536) ========= /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=652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:42:16 INFO - MultiFileLogger online at 20160516 10:42:16 in /builds/slave/test 10:42:16 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 10:42:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:42:16 INFO - {'append_to_log': False, 10:42:16 INFO - 'base_work_dir': '/builds/slave/test', 10:42:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:42:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:42:16 INFO - 'branch': 'Fx-Team-Non-PGO', 10:42:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:42:16 INFO - 'config_files': ('talos/linux_config.py',), 10:42:16 INFO - 'default_actions': ('clobber', 10:42:16 INFO - 'read-buildbot-config', 10:42:16 INFO - 'download-and-extract', 10:42:16 INFO - 'populate-webroot', 10:42:16 INFO - 'create-virtualenv', 10:42:16 INFO - 'install', 10:42:16 INFO - 'run-tests'), 10:42:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:42:16 INFO - 'download_minidump_stackwalk': True, 10:42:16 INFO - 'download_symbols': 'ondemand', 10:42:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:42:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:42:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:42:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:42:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:42:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:42:16 INFO - 'installer_path': 'installer.exe', 10:42:16 INFO - 'log_level': 'info', 10:42:16 INFO - 'log_name': 'talos', 10:42:16 INFO - 'log_to_console': True, 10:42:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:42:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:42:16 INFO - 'opt_config_files': (), 10:42:16 INFO - 'pip_index': False, 10:42:16 INFO - 'sps_profile': False, 10:42:16 INFO - 'sps_profile_interval': 0, 10:42:16 INFO - 'suite': 'dromaeojs', 10:42:16 INFO - 'system_bits': '32', 10:42:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:42:16 INFO - 'title': 'talos-linux64-ix-046', 10:42:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:42:16 INFO - 'use_talos_json': True, 10:42:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:42:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:42:16 INFO - 'work_dir': 'build'} 10:42:16 INFO - ##### 10:42:16 INFO - ##### Running clobber step. 10:42:16 INFO - ##### 10:42:16 INFO - Running pre-action listener: _resource_record_pre_action 10:42:16 INFO - Running main action method: clobber 10:42:16 INFO - rmtree: /builds/slave/test/build 10:42:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:42:17 INFO - Running post-action listener: _resource_record_post_action 10:42:17 INFO - ##### 10:42:17 INFO - ##### Finished clobber step (success) 10:42:17 INFO - ##### 10:42:17 INFO - ##### 10:42:17 INFO - ##### Running read-buildbot-config step. 10:42:17 INFO - ##### 10:42:17 INFO - Running pre-action listener: _resource_record_pre_action 10:42:17 INFO - Running main action method: read_buildbot_config 10:42:17 INFO - Using buildbot properties: 10:42:17 INFO - { 10:42:17 INFO - "project": "", 10:42:17 INFO - "product": "firefox", 10:42:17 INFO - "script_repo_revision": "production", 10:42:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:42:17 INFO - "repository": "", 10:42:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:42:17 INFO - "buildid": "20160516095902", 10:42:17 INFO - "pgo_build": "False", 10:42:17 INFO - "basedir": "/builds/slave/test", 10:42:17 INFO - "buildnumber": 2975, 10:42:17 INFO - "slavename": "talos-linux64-ix-046", 10:42:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:42:17 INFO - "platform": "ubuntu64_hw", 10:42:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:42:17 INFO - "branch": "fx-team", 10:42:17 INFO - "repo_path": "integration/fx-team", 10:42:17 INFO - "revision": "de80d1838a8db73172f7c09f57a3ecc0267f47e5", 10:42:17 INFO - "stage_platform": "linux64", 10:42:17 INFO - "builduid": "119e0603021d484e8dc9eed77b91182d", 10:42:17 INFO - "slavebuilddir": "test" 10:42:17 INFO - } 10:42:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:42:17 INFO - Running post-action listener: _resource_record_post_action 10:42:17 INFO - ##### 10:42:17 INFO - ##### Finished read-buildbot-config step (success) 10:42:17 INFO - ##### 10:42:17 INFO - ##### 10:42:17 INFO - ##### Running download-and-extract step. 10:42:17 INFO - ##### 10:42:17 INFO - Running pre-action listener: _resource_record_pre_action 10:42:17 INFO - Running main action method: download_and_extract 10:42:17 INFO - mkdir: /builds/slave/test/build/tests 10:42:17 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')]} 10:42:17 INFO - https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:42:17 INFO - Downloaded 1361 bytes. 10:42:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:42:17 INFO - Using the following test package requirements: 10:42:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:42:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:42:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:42:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'jsshell-linux-x86_64.zip'], 10:42:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:42:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:42:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:42:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:42:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:42:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:42:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:42:17 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')]} 10:42:17 INFO - https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:42:19 INFO - Downloaded 22448136 bytes. 10:42:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:42:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:42:20 INFO - Return code: 0 10:42:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:42: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')]} 10:42:20 INFO - https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:42:21 INFO - Downloaded 22448136 bytes. 10:42:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:42:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:42:23 INFO - Return code: 0 10:42: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')]} 10:42:23 INFO - https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:42:24 INFO - Downloaded 10840194 bytes. 10:42:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:42:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:42:25 INFO - Return code: 0 10:42:25 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')]} 10:42:25 INFO - https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:42:26 INFO - Downloaded 54748874 bytes. 10:42:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:42:26 INFO - mkdir: /builds/slave/test/properties 10:42:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:42:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:42:26 INFO - Contents: 10:42:26 INFO - build_url:https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:42:27 INFO - Running post-action listener: _resource_record_post_action 10:42:27 INFO - Running post-action listener: set_extra_try_arguments 10:42:27 INFO - ##### 10:42:27 INFO - ##### Finished download-and-extract step (success) 10:42:27 INFO - ##### 10:42:27 INFO - ##### 10:42:27 INFO - ##### Running populate-webroot step. 10:42:27 INFO - ##### 10:42:27 INFO - Running pre-action listener: _resource_record_pre_action 10:42:27 INFO - Running main action method: populate_webroot 10:42:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:42:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:42:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:42:27 INFO - '--tppagecycles', 10:42:27 INFO - '7'], 10:42:27 INFO - 'tests': ['tsvgm']}}, 10:42:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:42:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:42:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:42:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:42:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['damp', 'tps']}, 10:42:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'tests': ['damp', 'tps']}, 10:42:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['dromaeo_dom']}, 10:42:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:42:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['a11yr', 10:42:27 INFO - 'ts_paint', 10:42:27 INFO - 'tpaint', 10:42:27 INFO - 'sessionrestore', 10:42:27 INFO - 'sessionrestore_no_auto_restore', 10:42:27 INFO - 'tabpaint']}, 10:42:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:42:27 INFO - 'ts_paint', 10:42:27 INFO - 'tpaint', 10:42:27 INFO - 'sessionrestore', 10:42:27 INFO - 'sessionrestore_no_auto_restore', 10:42:27 INFO - 'tabpaint']}, 10:42:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:42:27 INFO - 'ts_paint', 10:42:27 INFO - 'tpaint', 10:42:27 INFO - 'sessionrestore', 10:42:27 INFO - 'sessionrestore_no_auto_restore', 10:42:27 INFO - 'tabpaint']}, 10:42:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:42:27 INFO - 'ts_paint', 10:42:27 INFO - 'tpaint', 10:42:27 INFO - 'sessionrestore', 10:42:27 INFO - 'sessionrestore_no_auto_restore', 10:42:27 INFO - 'tabpaint']}, 10:42:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['a11yr', 10:42:27 INFO - 'ts_paint', 10:42:27 INFO - 'tpaint', 10:42:27 INFO - 'sessionrestore', 10:42:27 INFO - 'sessionrestore_no_auto_restore', 10:42:27 INFO - 'tabpaint']}, 10:42:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['a11yr', 10:42:27 INFO - 'ts_paint', 10:42:27 INFO - 'tpaint', 10:42:27 INFO - 'sessionrestore', 10:42:27 INFO - 'sessionrestore_no_auto_restore', 10:42:27 INFO - 'tabpaint']}, 10:42:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['tsvgx', 10:42:27 INFO - 'tsvgr_opacity', 10:42:27 INFO - 'tart', 10:42:27 INFO - 'tscrollx', 10:42:27 INFO - 'cart']}, 10:42:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:42:27 INFO - 'tsvgr_opacity', 10:42:27 INFO - 'tart', 10:42:27 INFO - 'tscrollx', 10:42:27 INFO - 'cart']}, 10:42:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'talos_options': ['--disable-e10s'], 10:42:27 INFO - 'tests': ['tp5o']}, 10:42:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'tests': ['tp5o']}, 10:42:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'talos_options': ['--disable-e10s', 10:42:27 INFO - '--xperf_path', 10:42:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:27 INFO - 'tests': ['tp5n']}, 10:42:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:27 INFO - 'talos_options': ['--xperf_path', 10:42:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:27 INFO - 'tests': ['tp5n']}}, 10:42:27 INFO - 'talos.zip': {'path': '', 10:42:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:42:27 INFO - Running post-action listener: _resource_record_post_action 10:42:27 INFO - ##### 10:42:27 INFO - ##### Finished populate-webroot step (success) 10:42:27 INFO - ##### 10:42:27 INFO - ##### 10:42:27 INFO - ##### Running create-virtualenv step. 10:42:27 INFO - ##### 10:42:27 INFO - Running pre-action listener: _resource_record_pre_action 10:42:27 INFO - Running main action method: create_virtualenv 10:42:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:42:27 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 10:42:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:42:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:42:27 INFO - Using real prefix '/usr' 10:42:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:42:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:42:29 INFO - Installing pip.................done. 10:42:29 INFO - Return code: 0 10:42:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:42:29 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')]} 10:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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')]} 10:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:29 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 10:42:29 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 10:42:29 INFO - Using env: {'DISPLAY': ':0', 10:42:29 INFO - 'HOME': '/home/cltbld', 10:42:29 INFO - 'LANG': 'en_US.UTF-8', 10:42:29 INFO - 'LANGUAGE': 'en_US:en', 10:42:29 INFO - 'LOGNAME': 'cltbld', 10:42:29 INFO - 'MAIL': '/var/mail/cltbld', 10:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:29 INFO - 'MOZ_NO_REMOTE': '1', 10:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:29 INFO - 'NO_EM_RESTART': '1', 10:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:29 INFO - 'PWD': '/builds/slave/test', 10:42:29 INFO - 'SHELL': '/bin/bash', 10:42:29 INFO - 'SHLVL': '1', 10:42:29 INFO - 'TERM': 'linux', 10:42:29 INFO - 'TMOUT': '86400', 10:42:29 INFO - 'USER': 'cltbld', 10:42:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:29 INFO - '_': '/tools/buildbot/bin/python'} 10:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:30 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 10:42:30 INFO - Cleaning up... 10:42:30 INFO - Return code: 0 10:42:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:42:30 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')]} 10:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:30 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')]} 10:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:30 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:30 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>=3.1.1'] in /builds/slave/test/build 10:42:30 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>=3.1.1 10:42:30 INFO - Using env: {'DISPLAY': ':0', 10:42:30 INFO - 'HOME': '/home/cltbld', 10:42:30 INFO - 'LANG': 'en_US.UTF-8', 10:42:30 INFO - 'LANGUAGE': 'en_US:en', 10:42:30 INFO - 'LOGNAME': 'cltbld', 10:42:30 INFO - 'MAIL': '/var/mail/cltbld', 10:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:30 INFO - 'MOZ_NO_REMOTE': '1', 10:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:30 INFO - 'NO_EM_RESTART': '1', 10:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:30 INFO - 'PWD': '/builds/slave/test', 10:42:30 INFO - 'SHELL': '/bin/bash', 10:42:30 INFO - 'SHLVL': '1', 10:42:30 INFO - 'TERM': 'linux', 10:42:30 INFO - 'TMOUT': '86400', 10:42:30 INFO - 'USER': 'cltbld', 10:42:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:30 INFO - '_': '/tools/buildbot/bin/python'} 10:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:30 INFO - Downloading/unpacking psutil>=3.1.1 10:42:30 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 10:42:30 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 10:42:30 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 10:42:30 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 10:42:30 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 10:42:30 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 10:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:32 INFO - Installing collected packages: psutil 10:42:32 INFO - Running setup.py install for psutil 10:42:32 INFO - building 'psutil._psutil_linux' extension 10:42:32 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 10:42:32 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 10:42:32 INFO - building 'psutil._psutil_posix' extension 10:42:32 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 10:42:32 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 10:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:32 INFO - Successfully installed psutil 10:42:32 INFO - Cleaning up... 10:42:32 INFO - Return code: 0 10:42:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:42:32 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')]} 10:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:32 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')]} 10:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:32 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:32 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.3'] in /builds/slave/test/build 10:42:32 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.3 10:42:32 INFO - Using env: {'DISPLAY': ':0', 10:42:32 INFO - 'HOME': '/home/cltbld', 10:42:32 INFO - 'LANG': 'en_US.UTF-8', 10:42:32 INFO - 'LANGUAGE': 'en_US:en', 10:42:32 INFO - 'LOGNAME': 'cltbld', 10:42:32 INFO - 'MAIL': '/var/mail/cltbld', 10:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:32 INFO - 'MOZ_NO_REMOTE': '1', 10:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:32 INFO - 'NO_EM_RESTART': '1', 10:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:32 INFO - 'PWD': '/builds/slave/test', 10:42:32 INFO - 'SHELL': '/bin/bash', 10:42:32 INFO - 'SHLVL': '1', 10:42:32 INFO - 'TERM': 'linux', 10:42:32 INFO - 'TMOUT': '86400', 10:42:32 INFO - 'USER': 'cltbld', 10:42:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:32 INFO - '_': '/tools/buildbot/bin/python'} 10:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:42:33 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 10:42:33 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 10:42:33 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 10:42:33 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 10:42:33 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 10:42:33 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 10:42:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:42:35 INFO - Installing collected packages: mozsystemmonitor 10:42:35 INFO - Running setup.py install for mozsystemmonitor 10:42:35 INFO - Successfully installed mozsystemmonitor 10:42:35 INFO - Cleaning up... 10:42:35 INFO - Return code: 0 10:42:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:42:35 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')]} 10:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:35 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')]} 10:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:35 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 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:35 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 10:42:35 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 10:42:35 INFO - Using env: {'DISPLAY': ':0', 10:42:35 INFO - 'HOME': '/home/cltbld', 10:42:35 INFO - 'LANG': 'en_US.UTF-8', 10:42:35 INFO - 'LANGUAGE': 'en_US:en', 10:42:35 INFO - 'LOGNAME': 'cltbld', 10:42:35 INFO - 'MAIL': '/var/mail/cltbld', 10:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:35 INFO - 'MOZ_NO_REMOTE': '1', 10:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:35 INFO - 'NO_EM_RESTART': '1', 10:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:35 INFO - 'PWD': '/builds/slave/test', 10:42:35 INFO - 'SHELL': '/bin/bash', 10:42:35 INFO - 'SHLVL': '1', 10:42:35 INFO - 'TERM': 'linux', 10:42:35 INFO - 'TMOUT': '86400', 10:42:35 INFO - 'USER': 'cltbld', 10:42:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:35 INFO - '_': '/tools/buildbot/bin/python'} 10:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:35 INFO - Downloading/unpacking blobuploader==1.2.4 10:42:35 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 10:42:35 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 10:42:35 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 10:42:35 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 10:42:35 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 10:42:35 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 10:42:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:42:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:42:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 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 10:42:37 INFO - Downloading docopt-0.6.1.tar.gz 10:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:42:38 INFO - Installing collected packages: blobuploader, requests, docopt 10:42:38 INFO - Running setup.py install for blobuploader 10:42:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:42:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:42:38 INFO - Running setup.py install for requests 10:42:38 INFO - Running setup.py install for docopt 10:42:38 INFO - Successfully installed blobuploader requests docopt 10:42:38 INFO - Cleaning up... 10:42:38 INFO - Return code: 0 10:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:38 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')]} 10:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:38 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')]} 10:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:38 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 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:38 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 10:42:38 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 10:42:38 INFO - Using env: {'DISPLAY': ':0', 10:42:38 INFO - 'HOME': '/home/cltbld', 10:42:38 INFO - 'LANG': 'en_US.UTF-8', 10:42:38 INFO - 'LANGUAGE': 'en_US:en', 10:42:38 INFO - 'LOGNAME': 'cltbld', 10:42:38 INFO - 'MAIL': '/var/mail/cltbld', 10:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:38 INFO - 'MOZ_NO_REMOTE': '1', 10:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:38 INFO - 'NO_EM_RESTART': '1', 10:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:38 INFO - 'PWD': '/builds/slave/test', 10:42:38 INFO - 'SHELL': '/bin/bash', 10:42:38 INFO - 'SHLVL': '1', 10:42:38 INFO - 'TERM': 'linux', 10:42:38 INFO - 'TMOUT': '86400', 10:42:38 INFO - 'USER': 'cltbld', 10:42:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:38 INFO - '_': '/tools/buildbot/bin/python'} 10:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:38 INFO - Running setup.py (path:/tmp/pip-_iThMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:38 INFO - Running setup.py (path:/tmp/pip-TFFtv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:39 INFO - Running setup.py (path:/tmp/pip-rDBrEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:39 INFO - Running setup.py (path:/tmp/pip-BVMEXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:39 INFO - Running setup.py (path:/tmp/pip-wprJvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:39 INFO - Running setup.py (path:/tmp/pip-zEJ1EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:39 INFO - Running setup.py (path:/tmp/pip-OlWtcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:39 INFO - Running setup.py (path:/tmp/pip-eqD00H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:39 INFO - Running setup.py (path:/tmp/pip-8OZmfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:39 INFO - Running setup.py (path:/tmp/pip-KkLVPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:39 INFO - Running setup.py (path:/tmp/pip-RXuAEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:39 INFO - Running setup.py (path:/tmp/pip-dHt2aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:39 INFO - Running setup.py (path:/tmp/pip-CUPYdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:39 INFO - Running setup.py (path:/tmp/pip-PJX6uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:39 INFO - Running setup.py (path:/tmp/pip-4UfsPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:39 INFO - Running setup.py (path:/tmp/pip-HrRqea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:40 INFO - Running setup.py (path:/tmp/pip-KrN2X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:42:40 INFO - Running setup.py install for manifestparser 10:42:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Running setup.py install for mozcrash 10:42:40 INFO - Running setup.py install for mozdebug 10:42:40 INFO - Running setup.py install for mozdevice 10:42:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Running setup.py install for mozfile 10:42:40 INFO - Running setup.py install for mozhttpd 10:42:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Running setup.py install for mozinfo 10:42:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Running setup.py install for mozInstall 10:42:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:42:40 INFO - Running setup.py install for mozleak 10:42:40 INFO - Running setup.py install for mozlog 10:42:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Running setup.py install for moznetwork 10:42:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Running setup.py install for mozprocess 10:42:41 INFO - Running setup.py install for mozprofile 10:42:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Running setup.py install for mozrunner 10:42:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Running setup.py install for mozscreenshot 10:42:41 INFO - Running setup.py install for moztest 10:42:41 INFO - Running setup.py install for mozversion 10:42:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:42:41 INFO - Cleaning up... 10:42:41 INFO - Return code: 0 10:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:41 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')]} 10:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:41 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')]} 10:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:41 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 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:41 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 10:42:41 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 10:42:41 INFO - Using env: {'DISPLAY': ':0', 10:42:41 INFO - 'HOME': '/home/cltbld', 10:42:41 INFO - 'LANG': 'en_US.UTF-8', 10:42:41 INFO - 'LANGUAGE': 'en_US:en', 10:42:41 INFO - 'LOGNAME': 'cltbld', 10:42:41 INFO - 'MAIL': '/var/mail/cltbld', 10:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:41 INFO - 'MOZ_NO_REMOTE': '1', 10:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:41 INFO - 'NO_EM_RESTART': '1', 10:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:41 INFO - 'PWD': '/builds/slave/test', 10:42:41 INFO - 'SHELL': '/bin/bash', 10:42:41 INFO - 'SHLVL': '1', 10:42:41 INFO - 'TERM': 'linux', 10:42:41 INFO - 'TMOUT': '86400', 10:42:41 INFO - 'USER': 'cltbld', 10:42:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:41 INFO - '_': '/tools/buildbot/bin/python'} 10:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:42 INFO - Running setup.py (path:/tmp/pip-CFc4Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:42 INFO - Running setup.py (path:/tmp/pip-b_EDxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:42 INFO - Running setup.py (path:/tmp/pip-zX2Czw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:42 INFO - Running setup.py (path:/tmp/pip-cuyT4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:42 INFO - Running setup.py (path:/tmp/pip-uezBGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:42 INFO - Running setup.py (path:/tmp/pip-GVaqOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:42 INFO - Running setup.py (path:/tmp/pip-4k0bzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:42 INFO - Running setup.py (path:/tmp/pip-2kYbtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:42 INFO - Running setup.py (path:/tmp/pip-e42w9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:42 INFO - Running setup.py (path:/tmp/pip-LtTGBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:42 INFO - Running setup.py (path:/tmp/pip-INo77V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:42 INFO - Running setup.py (path:/tmp/pip-uidcwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:42 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)) 10:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:42 INFO - Running setup.py (path:/tmp/pip-zaYP20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:43 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)) 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:43 INFO - Running setup.py (path:/tmp/pip-2NrApd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:43 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)) 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:43 INFO - Running setup.py (path:/tmp/pip-d5KYOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:43 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)) 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:43 INFO - Running setup.py (path:/tmp/pip-PiHLb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:43 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)) 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:43 INFO - Running setup.py (path:/tmp/pip-EIGEOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:43 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)) 10:42:43 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)) 10:42:43 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)) 10:42:43 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)) 10:42:43 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)) 10:42:43 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)) 10:42:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:42:43 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 10:42:43 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 10:42:43 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 10:42:43 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 10:42:43 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 10:42:43 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 10:42:45 INFO - Downloading blessings-1.6.tar.gz 10:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:42:45 INFO - Installing collected packages: blessings 10:42:45 INFO - Running setup.py install for blessings 10:42:45 INFO - Successfully installed blessings 10:42:45 INFO - Cleaning up... 10:42:45 INFO - Return code: 0 10:42:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:42:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:45 INFO - Reading from file tmpfile_stdout 10:42:45 INFO - Current package versions: 10:42:45 INFO - argparse == 1.2.1 10:42:45 INFO - blessings == 1.6 10:42:45 INFO - blobuploader == 1.2.4 10:42:45 INFO - docopt == 0.6.1 10:42:45 INFO - manifestparser == 1.1 10:42:45 INFO - mozInstall == 1.12 10:42:45 INFO - mozcrash == 0.17 10:42:45 INFO - mozdebug == 0.1 10:42:45 INFO - mozdevice == 0.48 10:42:45 INFO - mozfile == 1.2 10:42:45 INFO - mozhttpd == 0.7 10:42:45 INFO - mozinfo == 0.9 10:42:45 INFO - mozleak == 0.1 10:42:45 INFO - mozlog == 3.2 10:42:45 INFO - moznetwork == 0.27 10:42:45 INFO - mozprocess == 0.22 10:42:45 INFO - mozprofile == 0.28 10:42:45 INFO - mozrunner == 6.11 10:42:45 INFO - mozscreenshot == 0.1 10:42:45 INFO - mozsystemmonitor == 0.3 10:42:45 INFO - moztest == 0.7 10:42:45 INFO - mozversion == 1.4 10:42:45 INFO - psutil == 3.1.1 10:42:45 INFO - requests == 1.2.3 10:42:45 INFO - wsgiref == 0.1.2 10:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:45 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')]} 10:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:45 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')]} 10:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:45 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 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:45 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 10:42:45 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 10:42:45 INFO - Using env: {'DISPLAY': ':0', 10:42:45 INFO - 'HOME': '/home/cltbld', 10:42:45 INFO - 'LANG': 'en_US.UTF-8', 10:42:45 INFO - 'LANGUAGE': 'en_US:en', 10:42:45 INFO - 'LOGNAME': 'cltbld', 10:42:45 INFO - 'MAIL': '/var/mail/cltbld', 10:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:45 INFO - 'MOZ_NO_REMOTE': '1', 10:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:45 INFO - 'NO_EM_RESTART': '1', 10:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:45 INFO - 'PWD': '/builds/slave/test', 10:42:45 INFO - 'SHELL': '/bin/bash', 10:42:45 INFO - 'SHLVL': '1', 10:42:45 INFO - 'TERM': 'linux', 10:42:45 INFO - 'TMOUT': '86400', 10:42:45 INFO - 'USER': 'cltbld', 10:42:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:45 INFO - '_': '/tools/buildbot/bin/python'} 10:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 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)) 10:42:45 INFO - Cleaning up... 10:42:45 INFO - Return code: 0 10:42:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:42:45 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')]} 10:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:45 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')]} 10:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:45 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 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:45 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 10:42:45 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 10:42:45 INFO - Using env: {'DISPLAY': ':0', 10:42:45 INFO - 'HOME': '/home/cltbld', 10:42:45 INFO - 'LANG': 'en_US.UTF-8', 10:42:45 INFO - 'LANGUAGE': 'en_US:en', 10:42:45 INFO - 'LOGNAME': 'cltbld', 10:42:45 INFO - 'MAIL': '/var/mail/cltbld', 10:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:45 INFO - 'MOZ_NO_REMOTE': '1', 10:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:45 INFO - 'NO_EM_RESTART': '1', 10:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:45 INFO - 'PWD': '/builds/slave/test', 10:42:45 INFO - 'SHELL': '/bin/bash', 10:42:45 INFO - 'SHLVL': '1', 10:42:45 INFO - 'TERM': 'linux', 10:42:45 INFO - 'TMOUT': '86400', 10:42:45 INFO - 'USER': 'cltbld', 10:42:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:45 INFO - '_': '/tools/buildbot/bin/python'} 10:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:46 INFO - Downloading/unpacking jsonschema 10:42:46 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 10:42:46 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 10:42:46 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 10:42:46 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 10:42:46 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 10:42:46 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 10:42:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:42:47 INFO - Downloading/unpacking functools32 (from jsonschema) 10:42:47 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 10:42:47 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 10:42:47 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 10:42:47 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 10:42:47 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 10:42:47 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 10:42:48 INFO - Downloading functools32-3.2.3-2.tar.gz 10:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:42:48 INFO - warning: no files found matching '*.txt' 10:42:48 INFO - no previously-included directories found matching 'build' 10:42:48 INFO - no previously-included directories found matching 'dist' 10:42:48 INFO - no previously-included directories found matching '.git*' 10:42:48 INFO - Installing collected packages: jsonschema, functools32 10:42:48 INFO - Running setup.py install for functools32 10:42:48 INFO - warning: no files found matching '*.txt' 10:42:48 INFO - no previously-included directories found matching 'build' 10:42:48 INFO - no previously-included directories found matching 'dist' 10:42:48 INFO - no previously-included directories found matching '.git*' 10:42:48 INFO - Successfully installed jsonschema functools32 10:42:48 INFO - Cleaning up... 10:42:48 INFO - Return code: 0 10:42:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:42: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')]} 10:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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')]} 10:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:48 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 0x7f819bc42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1836770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', '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 10:42:48 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 10:42:48 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 10:42:48 INFO - Using env: {'DISPLAY': ':0', 10:42:48 INFO - 'HOME': '/home/cltbld', 10:42:48 INFO - 'LANG': 'en_US.UTF-8', 10:42:48 INFO - 'LANGUAGE': 'en_US:en', 10:42:48 INFO - 'LOGNAME': 'cltbld', 10:42:48 INFO - 'MAIL': '/var/mail/cltbld', 10:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:48 INFO - 'MOZ_NO_REMOTE': '1', 10:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:48 INFO - 'NO_EM_RESTART': '1', 10:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:48 INFO - 'PWD': '/builds/slave/test', 10:42:48 INFO - 'SHELL': '/bin/bash', 10:42:48 INFO - 'SHLVL': '1', 10:42:48 INFO - 'TERM': 'linux', 10:42:48 INFO - 'TMOUT': '86400', 10:42:48 INFO - 'USER': 'cltbld', 10:42:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:48 INFO - '_': '/tools/buildbot/bin/python'} 10:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:48 INFO - Downloading/unpacking flake8 10:42:48 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 10:42:48 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 10:42:48 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 10:42:48 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 10:42:48 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 10:42:48 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 10:42:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:42:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:42:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:50 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 10:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:51 INFO - no previously-included directories found matching 'docs/_build' 10:42:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:42:51 INFO - Running setup.py install for pep8 10:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:51 INFO - no previously-included directories found matching 'docs/_build' 10:42:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:42:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:42:51 INFO - Cleaning up... 10:42:51 INFO - Return code: 0 10:42:51 INFO - Running post-action listener: _resource_record_post_action 10:42:51 INFO - Running post-action listener: _start_resource_monitoring 10:42:51 INFO - Starting resource monitoring. 10:42:51 INFO - ##### 10:42:51 INFO - ##### Finished create-virtualenv step (success) 10:42:51 INFO - ##### 10:42:51 INFO - ##### 10:42:51 INFO - ##### Running install step. 10:42:51 INFO - ##### 10:42:51 INFO - Running pre-action listener: _resource_record_pre_action 10:42:51 INFO - Running main action method: install 10:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:51 INFO - Reading from file tmpfile_stdout 10:42:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:42:51 INFO - Reading from file tmpfile_stdout 10:42:51 INFO - Output received: 10:42:51 INFO - Usage: mozinstall [options] installer 10:42:51 INFO - Options: 10:42:51 INFO - -h, --help show this help message and exit 10:42:51 INFO - -d DEST, --destination=DEST 10:42:51 INFO - Directory to install application into. [default: 10:42:51 INFO - "/builds/slave/test"] 10:42:51 INFO - --app=APP Application being installed. [default: firefox] 10:42:51 INFO - mkdir: /builds/slave/test/build/application 10:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:43:07 INFO - Reading from file tmpfile_stdout 10:43:07 INFO - Output received: 10:43:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:43:07 INFO - Running post-action listener: _resource_record_post_action 10:43:07 INFO - ##### 10:43:07 INFO - ##### Finished install step (success) 10:43:07 INFO - ##### 10:43:07 INFO - ##### 10:43:07 INFO - ##### Running run-tests step. 10:43:07 INFO - ##### 10:43:07 INFO - Running pre-action listener: _resource_record_pre_action 10:43:07 INFO - Running main action method: run_tests 10:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:43:07 INFO - Python 2.7.3 10:43:07 INFO - Return code: 0 10:43:07 INFO - grabbing minidump binary from tooltool 10:43: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')]} 10:43:07 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c59c0>, '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 0x18c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:43:07 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 10:43:07 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 10:43:07 INFO - Calling ['/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'] with output_timeout 600 10:43:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:43:07 INFO - Return code: 0 10:43:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:43:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:43:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:43:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:43:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:43:08 INFO - Return code: 0 10:43:08 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/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:43:08 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/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 10:43:08 INFO - Using env: {'DISPLAY': ':0', 10:43:08 INFO - 'HOME': '/home/cltbld', 10:43:08 INFO - 'LANG': 'en_US.UTF-8', 10:43:08 INFO - 'LANGUAGE': 'en_US:en', 10:43:08 INFO - 'LOGNAME': 'cltbld', 10:43:08 INFO - 'MAIL': '/var/mail/cltbld', 10:43:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:43:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:08 INFO - 'MOZ_NO_REMOTE': '1', 10:43:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:08 INFO - 'NO_EM_RESTART': '1', 10:43:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:08 INFO - 'PWD': '/builds/slave/test', 10:43:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:43:08 INFO - 'SHELL': '/bin/bash', 10:43:08 INFO - 'SHLVL': '1', 10:43:08 INFO - 'TERM': 'linux', 10:43:08 INFO - 'TMOUT': '86400', 10:43:08 INFO - 'USER': 'cltbld', 10:43:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032', 10:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:08 INFO - '_': '/tools/buildbot/bin/python'} 10:43:08 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/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:43:08 INFO - mozversion application_buildid: 20160516095902 10:43:08 INFO - mozversion application_changeset: de80d1838a8db73172f7c09f57a3ecc0267f47e5 10:43:08 INFO - mozversion application_display_name: Nightly 10:43:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:43:08 INFO - mozversion application_name: Firefox 10:43:08 INFO - mozversion application_remotingname: firefox 10:43:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:43:08 INFO - mozversion application_vendor: Mozilla 10:43:08 INFO - mozversion application_version: 49.0a1 10:43:08 INFO - mozversion platform_buildid: 20160516095902 10:43:08 INFO - mozversion platform_changeset: de80d1838a8db73172f7c09f57a3ecc0267f47e5 10:43:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:43:08 INFO - mozversion platform_version: 49.0a1 10:43:08 INFO - using testdate: 1463420588 10:43:08 INFO - actual date: 1463420588 10:43:08 INFO - starting webserver on 'localhost:59067' 10:43:08 INFO - SUITE-START | Running 2 tests 10:43:08 INFO - TEST-START | dromaeo_css 10:43:08 INFO - operating with platform_type : linux_ 10:43:08 INFO - Initialising browser for dromaeo_css test... 10:43:08 INFO - TEST-INFO | started process 31359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRKlG3f/profile http://localhost:59067/getInfo.html) 10:43:13 INFO - PROCESS | 31359 | __metrics Screen width/height:1600/1200 10:43:13 INFO - PROCESS | 31359 | colorDepth:24 10:43:13 INFO - PROCESS | 31359 | Browser inner width/height: 1024/697 10:43:13 INFO - PROCESS | 31359 | __metrics 10:43:14 ERROR - PROCESS | 31359 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:43:15 INFO - TEST-INFO | 31359: exit 0 10:43:15 INFO - Browser initialized. 10:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:43:15 INFO - TEST-INFO | started process 31439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRKlG3f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:27 INFO - PROCESS | 31439 | RSS: Main: 154976256 10:43:27 INFO - PROCESS | 31439 | 10:44:18 INFO - PROCESS | 31439 | 1463420658707 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] 10:46:30 INFO - PROCESS | 31439 | Cycle 1(1): loaded http://localhost:59067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59067/tests/dromaeo/cssquery-ext.html) 10:46:31 INFO - PROCESS | 31439 | RSS: Main: 275202048 10:46:31 INFO - PROCESS | 31439 | 10:49:34 INFO - PROCESS | 31439 | Cycle 1(1): loaded http://localhost:59067/tests/dromaeo/cssquery-ext.html (next: http://localhost:59067/tests/dromaeo/cssquery-jquery.html) 10:49:35 INFO - PROCESS | 31439 | RSS: Main: 237314048 10:49:35 INFO - PROCESS | 31439 | 10:52:37 INFO - PROCESS | 31439 | Cycle 1(1): loaded http://localhost:59067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59067/tests/dromaeo/cssquery-mootools.html) 10:52:37 INFO - PROCESS | 31439 | RSS: Main: 235393024 10:52:37 INFO - PROCESS | 31439 | 10:55:39 INFO - PROCESS | 31439 | Cycle 1(1): loaded http://localhost:59067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59067/tests/dromaeo/cssquery-prototype.html) 10:55:40 INFO - PROCESS | 31439 | RSS: Main: 235368448 10:55:40 INFO - PROCESS | 31439 | 10:58:43 INFO - PROCESS | 31439 | Cycle 1(1): loaded http://localhost:59067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59067/tests/dromaeo/cssquery-yui.html) 10:58:43 INFO - PROCESS | 31439 | RSS: Main: 219828224 10:58:43 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | Cycle 1(1): loaded http://localhost:59067/tests/dromaeo/cssquery-yui.html (next: http://localhost:59067/tests/dromaeo/cssquery-dojo.html) 11:01:46 INFO - PROCESS | 31439 | RSS: Main: 267964416 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | __start_tp_report 11:01:46 INFO - PROCESS | 31439 | _x_x_mozilla_page_load 11:01:46 INFO - PROCESS | 31439 | _x_x_mozilla_page_load_details 11:01:46 INFO - PROCESS | 31439 | |i|pagename|runs| 11:01:46 INFO - PROCESS | 31439 | |0;dojo.html;2612.4775044991;2682.2221555748833;2719.0755143251295;2726.236653736953;2728.154272175626;4619.2609182530805;4628.190066738316;4677.625789936806;4748.596369308609;4791.448983366914;4651.627869770418;4677.74272415017;4692.906141877161;4757.310190022454;4765.737884416356;4268.402423660682;4279.336702811053;4335.783210839461;4372.475302963633;4436.778161091948;4363.629091527224;4390.714603550775;4391.253486907233;4422.933655995163;4438.689291749579;4232;4244.896326954983;4276.123394704078;4276.743395396286;4352.738835669854;4311.030018245901;4314.374415709736;4320.848770293056;4323.632491238249;4368.759718215497;4353.847615333448;4353.998580326511;4359.38968544404;4363.585459381354;4410.580994805488;4478.977605111986;4530.365748795171;4566.337881007235;4630.536946305376;4671.696339737906;5026.698398096126;5090.643654944155;5094;5094.821681241176;5110.514501122388;5058.0895438821;5065.822696205652;5097.13348730713;5130.897382052375;5131.281620573122;4575.702579332333;4663.393758811333;4681.789319480631;4692.601128904013;4714.245720684674;5144.948550514447;5187.507186817246;5196.1166601677805;5204.297419848272;5206.8437946860895;4949.084419382354;4978.5768209701855;4983.6013118950395;4998.90002199954;5001.899962000813;4935.235038569028;4994.875128121826;5046.873828154252;5051.924221136613;5074.720890350993;4988.127077761377;5008.57427118699;5017.172166592544;5023.472535383805;5065.366829146356;4869.805207791719;4995.900081998339;5003.399592048904;5006.0989021975665;5019.974900125476;4150.896227594274;4151.46031015966;4156.854510092132;4186.895327616773;4200.957990420056;3711.387621042552;3713.164537978933;3717.312297225022;3738.869139580156;3748.0629842539365;4230.069384735353;4379.781010949503;4382.868513944587;4420.58004489573;4429;4952.62855285855;4983.152864013126;4983.377077865267;5003.624728145403;5006.874828129326;4330.696851220384;4331.480222373272;4332.1985432695055;4358.302671572533;4379.364992076131;4393.7363758174615;4486.439195100613;4492.034212644297;4493.955060449353;4503.482099558592;4768.237082066853;4804.399450068741;4808.35087263215;4814.6870453420415;4858.222684370484;5060.544550990428;5068.873278168076;5073.644844860824;5075.77159027852;5089.13484707608;4663.790129444251;4737.478877323423;4771.06964141989;4782.808687652455;4842.7820748065715;4935.309056732132;4959.776810043484;4960.255961605788;4965.851024469272;5004.749762511787;4993.575546078624;5016.874578135576;5026.824061157989;5034.647574669738;5063.3417655704525;4745.644076694192;4872.756362181806;4877.6585639004925;4910.116179087656;4940.827071052496;4880.536349046835;4889.755512224446;4893.119238537098;4903.901921961612;4951.133551628523;4815.590674792542;4828.613710903049;4832.51674832528;4874.488178741323;4875.731834749123;4770.928436073392;4772.76136193182;4812.542808433333;4854.17479028559;4875.561199492063;4763.118823017753;4773;4774.379330686988;4781.163296423042;4786.7845946931775 11:01:46 INFO - PROCESS | 31439 | |1;ext.html;552.9198266251394;601.9518438524918;602.2321540036453;603.3544107804651;614.649649699671;28731.56902646462;29044.854775726144;42695.57304426955;42710.35934460982;43729.78135109328;40723.796381018125;41208.793956030255;44594;44607;44694.32958505617;7496.13794413644;8063.919360806405;8203.58982050898;8212;8223.54770487623;10109.494525273743;10325.896741032606;10332.225083118796;10335.741606459824;10704.090152337061;10163;10265.076143147115;10605.575776968912;10614.257002009863;10615.150787936947;10339.638112666058;10446;10449.425281609509;10449.529771160316;10451;10332.896671033268;10411.791764164675;10418.166546676248;10418.531166097544;10423.374597524173;40962.795186024174;41297;41415.79292103551;41430.585694142974;41513.1697366054;3400.081977865987;3415.112070861569;3484.303139372136;3864.265789499986;4042.8787136385663;30850;31279.68720312813;31860;33221.667783322344;33341.499877501854;3480.564929383827;3585.025380710662;3606.8917932461804;3666.0651533858695;3676.944845827288;297380.5130974353;298079;298253;301261;302609;64617.35382646207;65589.34410655928;65814.34185658178;65828;65840.6707966457;67912.66043669848;68881.31118688748;68911.65544172247;68958;68965.65517172382;15353.692926141637;15522.844771552365;15524.767128493082;15560.377584896478;15628.062316261061;10160.745981350525;10467.633632822966;10470.581176752845;10666.093382062612;11731.530738770523;18409.47546531298;21389.46526336823;21836.672449913265;21847.344579662637;21847.344579662637;7610.292280789408;7741.8838717419285;7835.804104897309;7951.602419878983;8088.555129467818;863.4344504349662;948.6632245552729;995.9850602240972;1012.0646415480655;1044.4046893270763;29149.417011660073;29549.113526594236;29568.852155739085;29800.254993625334;30133.69866301309;1010.4796030044533;1033.328336581213;1037.9792404151874;1054.1303424674675;1159.310210424796;15346.539603811903;15792.289346979414;15818.841811581737;15898.284577194054;16128.919355403148;406019;409116;410294;411023;411782;54033.45966540363;55477;55550.72224638932;55568.72215638896;55741.72129139328;1160.3849959521467;1268.1249937543066;1280.6862318731971;1283.794592865137;1314.283715375123;28909.421811564072;30207.69792302049;30259.243518911324;30399.696003039688;30930.69069309278;44832;52213;53423.732881335345;53480.73259633677;57808;378796;379826;382083;382316;382460;34622;40212.37557680904;40416.39375409312;41845.58154418417;42371.15257694767;45194;45383;45847.541524584325;46205.76897115493;46484;38468.23063538658;39090.80454597709;39153.41269880897;39531;39536.40695389514;36926;37756.811215943744;39018.6098139015;39080.804595976835;39524.2095158101;37547.249055019296;37871.621283787914;38373;38420.42369364518;38786;32799.50800737943;34943.65056349404;34950.82524587361;34960.650393495736;35054.29891402209;26536;28229.576556352084;28476;28545.571816423184;28647.713522864506 11:01:46 INFO - PROCESS | 31439 | |2;jquery.html;389.6434762192594;390.63670786168854;395.5056179775281;395.52734482293664;414.1282600126733;13060.934695326534;13415.396307166176;16876.324947002122;17911.641767164667;18105.456836294914;15943.92028039858;16892.15539223037;17572.121393930316;17629.03040332781;18568.44294671162;5232.345956755396;5309.946900530984;5354.839354819343;5365.892682146355;5394.433584473632;3690.2250527389147;5173.715445650488;5211.895762084756;5325.254464374991;5869.911951320733;6125.5712100153005;6227.626342419469;6239.750409983595;6246.063090536433;6252.781152659658;6129.32577416486;6180.6291622502795;6203.069539569078;6206.472449841769;6253.593516421418;5339.092354299778;5456.0997435423105;5460.235567020621;5464.9453505464835;5480.862978425532;20383.08276127578;21306.14775408982;21531.569368612698;21548.569028619495;21570.1371945122;2090.9790902090936;2129.4676330917273;2179.858309209896;2191.802737753594;2516.4589613233243;13070.542531011464;13359.53241636538;13615;13696.65758356039;14224.644383890382;1797.694391953371;1837.0814592703648;1871.1486273745413;1881.8306352428347;1924.4130540185238;69678;74244.25755742428;74446;74562.25437745608;75655.24344756537;9722.659706910224;9853.75365615851;9997.250206234561;10200.540975656113;10372.325798823053;14122.85877141236;14206.147631141957;14215.43138274478;14218.644533886736;14236.074655147382;7294.343509084208;7338.889916651255;7493.288137626917;7513.887291690629;7530.171681115073;6767.830804229934;6817.965910170417;6878.38094571491;7002.894956575656;7023.824404389931;6429.6463694496315;6443;6479.514036447285;6488.416042556099;6637.535372523877;1667.6998140334856;1719.312275089949;1806.765120534322;1809.3305476973603;1869.925202991865;854.5214679779343;925.9722208333761;971.582219645545;990.1979396688562;1004.0662184168647;16907;17893.642127157385;18022.459326220236;18161.273549058154;18399.264029438673;926.9849514781304;928.1692884868005;949.9810003799886;967.5597603090577;980.9705708828747;10291.022352876465;10472.16222702182;10476.580936762597;10605.41670208146;10638.574457021787;429271;430734;438569;439098;440119;71948;72172.63913680398;72430;73104;73354.63322683352;862.642003568512;950.5342382232794;952.7903861150536;980.0444566547559;982.5480279071708;14075.648108797363;16191.980486049362;16617.252223650208;16777.580560486087;16912.069836158636;34111;34117;34439;34628.30743385068;35627.28745425129;42392.57607423886;42590.57409425866;44411.55588444074;45036.77481612571;45297;6812.693428795617;7176.641167941686;7340.559566426032;7784.494007889469;8169.795755105933;12093.15347925672;12287.1399002069;12355.320457374572;12481.56314528987;12498.625041248777;10302.278840481094;10428;10692.305000174963;10835.832833433187;11283.830742539032;10916.727081823017;11067.169962252703;11101.278416903198;11108.173232824793;11216.83174752363;10878.836817447904;10920.781584368428;11148.832767508657;11324.433778311217;11341.546338146381;6971.8605627886145;7082.972968919581;7198.992141100145;7277.235890231449;7335.853282934205;10373.533191006272;10657.840132397865;10853.891461085605;10937.179711521509;11308.943455282671 11:01:46 INFO - PROCESS | 31439 | |3;mootools.html;1316.0655934286656;1383.3498255819761;1450.3980847948103;1606.6545692676073;1870.672632289349;7553.244675532444;7952.960235198831;7957.20427957204;8125.268725814675;8142.91857081429;7966.641501132449;8137.226963438478;8151;8162.95918520408;8181;2266.931992040237;2293.243229734184;2294.380517260339;2297.3911913342977;2298.689676893623;2212.5353675728115;2221.2336743823357;2227.8217742580637;2234.2850287907877;2273.1134857405623;2273.283915566591;2274.3631783100677;2296.7932886040253;2298.528801595677;2298.9540209195807;2259.4690247791837;2259.5029093599383;2282.965755513677;2286.4626812699003;2286.6684330772027;2211.9336419907427;2214.811741002017;2217.645176771709;2218.4675677837363;2218.7448443429053;7919.920800791976;8039.437239393244;8083.47457415272;8094;8153.470024448392;4713;4822.204336284509;4823.035392921394;4826.879328016793;4828.73441960692;2986.7461265792435;2998.055612482061;3055.2972816252163;3077.81533108012;3088.984555077233;906.7506435730227;917.7063339731288;931.4504442378961;942.3544871762864;951.372094417681;10731.034206921415;10733;10759.3544387337;10760.892391076146;10788.892111078867;3944.2111577684577;4073.165001174752;4110.445089912883;4135.6898232632675;4145.834166633361;8408.327333813402;8472.279856212292;8478.57607119654;8479.576021198915;8484.787880302918;4511;4514.119746649372;4517.2094883395275;4518.525554816697;4524.547545245515;3652.0504668786307;4221.197972385298;4275.893102672458;4408.867733967986;4422;3525.330187264463;3552.8223588820456;3615.060084378028;3629.473726309723;3640.526731524885;1094.141099237095;1102.73534351755;1107.8892110788856;1116.3357802107732;1121.3384103379046;717.6375930155239;767.4282659418657;855.6064210463132;878.2139984713773;882.4793371910475;5266.1574148136115;5432.994895944263;5467.9453205467435;5488.094464413407;5639.351474580394;926.4070994563485;938.9154976052188;946.654471118037;957.4398976598628;962.499500259861;3639.6906262967414;3641;3645.945310820287;3685.539307586552;3796.1648437343742;9430.962594114642;9705.757356066155;9767;9767.316287859781;9786.168175705145;9592.76018099553;9607.663731769355;9660.855087173699;9663.13031827139;9676.419414834992;7063.2583578724525;7326.597037162901;7432.85134297311;7595.202503737028;7617.27635874591;5462.20797984298;5478.753456094565;5501.917471237854;5513.145462453326;5605.915911261252;9013.369064165445;9056.592453339746;9088.500132492776;9182.403143795633;9192.080791920755;9064.184223419923;9401.81196376055;9468.573914174016;9505.572249248662;9548;7010.228874823867;7114.253003434565;7137.678804453708;7141.9642901785155;7146.249643787535;7526.473146879885;7599.088109426904;7720.189380115232;7726.111497177896;7733.38132949374;6989.161300643752;7001.544899581511;7027.121609798775;7124.358807707331;7165.964170179116;6891.724331026903;6935.965320173367;6954.687039083355;7008.579485230903;7140.821479463055;6499.0901273820755;6509.1863517060365;6567.737290508326;6569.37590928861;6571.5399922005;4682.274247491644;4722.716637001791;4757.738324392191;4761.500042495488;4801.18379875415;4805.471398146131;4865.002674451658;4902.411710594752;4973.5523802857915;4997.350344455343 11:01:46 INFO - PROCESS | 31439 | |4;prototype.html;315.894175451224;321.7313543191435;331.79262960649595;332.5012481278083;332.5527165961781;4821.204501257293;4842.97578512107;4855.567607555767;4871.683340582864;4890.755462226893;4563.338315944195;4706.788194531246;4734.372423305064;4741.9414477661885;4775.14047471455;3757.6054514276016;3793.089658481965;3807.809609519527;3865.6083809828438;3876;3846.9807650961707;3850.711196660248;3863.884083477486;3883.184531248441;3886.04791826003;3584.2652256287397;3772.811359432031;3847.7498962567483;3847.8460861565504;3861.706328379996;3748;3757.248550289953;3764.698824094066;3776.30138424391;3787.9242415151816;3308.768386212966;3321.485169798685;3325.7029758394247;3334.4498157803932;3341.081202669261;4623.1678297906365;4637.721736695809;4657.5575320344515;4660.37084993525;4662.50799744082;4155.168966206771;4319.920019995001;4336.392904993303;4337.330127900749;4366.170427618774;5096.413912400048;5099.23511473282;5099.745012749385;5115.718635475085;5123.487651234884;3626.746127771057;3630.16506203572;3630.5643322801434;3672;3675.9448608270895;5126.974365128188;5242.606804489678;5274.340707411574;5299.761510732026;5313.149896016619;3727.30407664512;3754.9436758448646;3756.9248615027545;3760.9623903761158;3766.3804564037177;3785.9777859977653;3789.7536660117003;3807.181455986921;3807.790571518593;3830.3105441020325;4319.784010799511;4343.805453500313;4345.239583072949;4354.673399494987;4361.323994780814;4960.23116416956;5060.746962651852;5088.363954505687;5089.134847075932;5096.159133742891;1245.9626211213679;1307.5162189989574;1315.53298579005;1317.1043690290694;1320.1287150480637;875.8073223890734;916.0945233913444;916.7577931902176;920.5075284722641;925.0703043441433;4504.09918016398;4505.008898042425;4509.255972764523;4533.189422558035;4542.432195975503;5194;5194.714290713971;5198.194279886624;5231.8168864089575;5269.314989051399;4245.766482843412;4468.240399132155;4479.395281637003;4492.797824097924;4494.752788596593;2766.6265054217824;2773.126465163467;2780.7497325240824;2789.3166174287026;2791.553351463756;4922.975385123052;4927.679700819507;4934.753262336869;4952.777125029383;4961.50384961501;5048.722320272347;5270.7628156733035;5290.867728306746;5291.894162116813;5329.9467005330225;4762.571368576775;4777.95222047782;4835.564799168092;4872.317875497433;4916.680415772963;5125.231215317583;5133.281340612242;5165.173572228426;5175.948240517547;5177.534021938043;4909.533594308535;5165.845024649267;5174.844754657366;5177.456367081402;5190.55880250183;4959.851204463872;4979.601631869369;5011.799528018984;5012.649114561946;5012.924806127984;3778.677462887967;3810.714196435223;3812.6949844011856;3814.8474061037246;3824.8661296854475;5149.459306772885;5261.605379596622;5285.260063591023;5288.286081378965;5304.204369344629;5107.719075450886;5131.025105229995;5135.329628593186;5142.820001299937;5151.2273159026445;4996.875078123076;5133;5145.588352931832;5157.406898206604;5160.716160611052;4824.228123500223;4943.2585112233455;5056.57019153376;5061;5066.695998240118;5165.225216217597;5180.766865490987;5181.5077567631015;5184.392838220013;5194.974025130002;5031.572316353151;5063.316452278895;5068.315777370008;5082.567981721595;5083.923741143812 11:01:46 INFO - PROCESS | 31439 | |5;yui.html;712.4407340237914;790.2966359939654;794.1105961323319;811.4076723991486;817.8119032622496;14137.29313534323;14694.118352898833;14803.185824779634;14812.77780833287;14818.55544333669;13546.39041243144;13638.249896255702;13677.931610341935;13693.65765855854;13700.657483562916;670.1857243449208;845.7082306604211;880.3089574683875;888.2449917570078;888.6711916590871;873.9038705742363;881.1320848963766;881.6825942660637;881.9559022048904;881.973540793774;932.1517419148543;939.642935684439;939.6570251858057;939.994206199367;940.539135823445;706.3607435271088;894.7449976756658;923.3536524432924;930.3255140023497;930.585889279271;677.0284641539407;682.0383259603934;682.0825989044727;682.9931700682979;684.096991970599;12313.69215769604;12354.691132721664;12356.62930112089;12363.320017399039;12503.124781265315;11315.15136364776;11528.884711152865;11743.882561174365;11753.529858805638;11878.524859005629;11210.551577936872;11213.327200368005;11513;11532.769344613145;11589.304641721523;4114.650254728352;4115.73247738899;4137.77242251676;4170.207660544487;4240.512341080754;46701.29948050782;47745.76127119342;47869;47953.28070078952;48022.75988620034;9533.094356036165;9542.761430964143;9639.132478076866;9776.022397760167;9813.313068085166;17036.2333694984;17525.38661146879;17539.73690394645;17576.736348954775;18196.90901545484;6644.169478815148;6754.696038678271;6760.08738820253;6779.254282028973;6895.586264824126;3732.757370770891;3778.3954567269107;3832.5209348831395;3915.7650540967634;3936.7834769087403;2898.9565156522667;2986.2982199183175;2991.745701615387;2997.2956355256497;3001.9549706754415;525.976331065103;532.2707890190463;535.8285348688382;541.3747122074011;547.9506844383944;524.4100387064552;593.3769541980903;600.1777564736252;633.3128555517224;637.2830565613684;7944;8052.315553177928;8167.959160204161;8214.917850821535;8258;647.3009150117862;663.6781161136845;665.6472069803012;665.7436886798617;667.7729571945562;3783.981080094582;3820.9808950955066;3920.9803950980063;3955.5434540458696;4048.6356227939627;53691.731541342044;54179;54593;55176.17235741387;55329;47971.280430793566;48556.75721621369;49333.753331233835;50038;50804.74597627062;44584.3312350315;44948;45092.549074509494;45943.540564593925;46416.535834641225;7748.92251077482;7769.378449723896;7840.568768717775;7950.125486196398;8009.879851802111;31182.532262016543;31473;31626.525602115526;32007.67992320047;32261.677383225866;36770.816145919096;38549;40961.795191023855;41099.1780164401;41399.1720165589;10076.798464030531;10214.846777298495;10337.17302615774;10367.481625918825;10493.265471416928;11077.556897724;11199.440027998404;11343.319400835977;11565.595204167814;11577.363245021605;10740;10849.728756781144;10860.239783215098;11179.776404472028;11339.376334301363;9968.352057116264;10020.498975051363;10216.795664086825;10324.277300589187;10486.056254937092;10461.581536738446;10475.214358923264;10545;10545.630902918669;10915.508802104083;9062.909370906207;9083.318751093826;9173.678921237724;9339.906600934175;9550.90449095528;8750.99840255586;8804.251638610789;8932.50871202064;9003.594838232164;9157.267418606361 11:01:46 INFO - PROCESS | 31439 | __end_tp_report 11:01:46 INFO - PROCESS | 31439 | __start_cc_report 11:01:46 INFO - PROCESS | 31439 | _x_x_mozilla_cycle_collect,1263 11:01:46 INFO - PROCESS | 31439 | __end_cc_report 11:01:46 INFO - PROCESS | 31439 | __startTimestamp1463421706947__endTimestamp 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | ------- Summary: start ------- 11:01:46 INFO - PROCESS | 31439 | Number of tests: 6 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | [#0] dojo.html Cycles:165 Average:4646.59 Median:4773.00 stddev:481.24 (10.1%) stddev-sans-first:455.49 11:01:46 INFO - PROCESS | 31439 | Values: 2612.5 2682.2 2719.1 2726.2 2728.2 4619.3 4628.2 4677.6 4748.6 4791.4 4651.6 4677.7 4692.9 4757.3 4765.7 4268.4 4279.3 4335.8 4372.5 4436.8 4363.6 4390.7 4391.3 4422.9 4438.7 4232.0 4244.9 4276.1 4276.7 4352.7 4311.0 4314.4 4320.8 4323.6 4368.8 4353.8 4354.0 4359.4 4363.6 4410.6 4479.0 4530.4 4566.3 4630.5 4671.7 5026.7 5090.6 5094.0 5094.8 5110.5 5058.1 5065.8 5097.1 5130.9 5131.3 4575.7 4663.4 4681.8 4692.6 4714.2 5144.9 5187.5 5196.1 5204.3 5206.8 4949.1 4978.6 4983.6 4998.9 5001.9 4935.2 4994.9 5046.9 5051.9 5074.7 4988.1 5008.6 5017.2 5023.5 5065.4 4869.8 4995.9 5003.4 5006.1 5020.0 4150.9 4151.5 4156.9 4186.9 4201.0 3711.4 3713.2 3717.3 3738.9 3748.1 4230.1 4379.8 4382.9 4420.6 4429.0 4952.6 4983.2 4983.4 5003.6 5006.9 4330.7 4331.5 4332.2 4358.3 4379.4 4393.7 4486.4 4492.0 4494.0 4503.5 4768.2 4804.4 4808.4 4814.7 4858.2 5060.5 5068.9 5073.6 5075.8 5089.1 4663.8 4737.5 4771.1 4782.8 4842.8 4935.3 4959.8 4960.3 4965.9 5004.7 4993.6 5016.9 5026.8 5034.6 5063.3 4745.6 4872.8 4877.7 4910.1 4940.8 4880.5 4889.8 4893.1 4903.9 4951.1 4815.6 4828.6 4832.5 4874.5 4875.7 4770.9 4772.8 4812.5 4854.2 4875.6 4763.1 4773.0 4774.4 4781.2 4786.8 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | [#1] ext.html Cycles:180 Average:53939.33 Median:3636.48 stddev:96371.91 (2650.1%) stddev-sans-first:96558.90 11:01:46 INFO - PROCESS | 31439 | Values: 552.9 602.0 602.2 603.4 614.6 28731.6 29044.9 42695.6 42710.4 43729.8 40723.8 41208.8 44594.0 44607.0 44694.3 7496.1 8063.9 8203.6 8212.0 8223.5 10109.5 10325.9 10332.2 10335.7 10704.1 10163.0 10265.1 10605.6 10614.3 10615.2 10339.6 10446.0 10449.4 10449.5 10451.0 10332.9 10411.8 10418.2 10418.5 10423.4 40962.8 41297.0 41415.8 41430.6 41513.2 3400.1 3415.1 3484.3 3864.3 4042.9 30850.0 31279.7 31860.0 33221.7 33341.5 3480.6 3585.0 3606.9 3666.1 3676.9 297380.5 298079.0 298253.0 301261.0 302609.0 64617.4 65589.3 65814.3 65828.0 65840.7 67912.7 68881.3 68911.7 68958.0 68965.7 15353.7 15522.8 15524.8 15560.4 15628.1 10160.7 10467.6 10470.6 10666.1 11731.5 18409.5 21389.5 21836.7 21847.3 21847.3 7610.3 7741.9 7835.8 7951.6 8088.6 863.4 948.7 996.0 1012.1 1044.4 29149.4 29549.1 29568.9 29800.3 30133.7 1010.5 1033.3 1038.0 1054.1 1159.3 15346.5 15792.3 15818.8 15898.3 16128.9 406019.0 409116.0 410294.0 411023.0 411782.0 54033.5 55477.0 55550.7 55568.7 55741.7 1160.4 1268.1 1280.7 1283.8 1314.3 28909.4 30207.7 30259.2 30399.7 30930.7 44832.0 52213.0 53423.7 53480.7 57808.0 378796.0 379826.0 382083.0 382316.0 382460.0 34622.0 40212.4 40416.4 41845.6 42371.2 45194.0 45383.0 45847.5 46205.8 46484.0 38468.2 39090.8 39153.4 39531.0 39536.4 36926.0 37756.8 39018.6 39080.8 39524.2 37547.2 37871.6 38373.0 38420.4 38786.0 32799.5 34943.7 34950.8 34960.7 35054.3 26536.0 28229.6 28476.0 28545.6 28647.7 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | [#2] jquery.html Cycles:180 Average:25723.96 Median:393.07 stddev:71495.62 (18189.0%) stddev-sans-first:71670.88 11:01:46 INFO - PROCESS | 31439 | Values: 389.6 390.6 395.5 395.5 414.1 13060.9 13415.4 16876.3 17911.6 18105.5 15943.9 16892.2 17572.1 17629.0 18568.4 5232.3 5309.9 5354.8 5365.9 5394.4 3690.2 5173.7 5211.9 5325.3 5869.9 6125.6 6227.6 6239.8 6246.1 6252.8 6129.3 6180.6 6203.1 6206.5 6253.6 5339.1 5456.1 5460.2 5464.9 5480.9 20383.1 21306.1 21531.6 21548.6 21570.1 2091.0 2129.5 2179.9 2191.8 2516.5 13070.5 13359.5 13615.0 13696.7 14224.6 1797.7 1837.1 1871.1 1881.8 1924.4 69678.0 74244.3 74446.0 74562.3 75655.2 9722.7 9853.8 9997.3 10200.5 10372.3 14122.9 14206.1 14215.4 14218.6 14236.1 7294.3 7338.9 7493.3 7513.9 7530.2 6767.8 6818.0 6878.4 7002.9 7023.8 6429.6 6443.0 6479.5 6488.4 6637.5 1667.7 1719.3 1806.8 1809.3 1869.9 854.5 926.0 971.6 990.2 1004.1 16907.0 17893.6 18022.5 18161.3 18399.3 927.0 928.2 950.0 967.6 981.0 10291.0 10472.2 10476.6 10605.4 10638.6 429271.0 430734.0 438569.0 439098.0 440119.0 71948.0 72172.6 72430.0 73104.0 73354.6 862.6 950.5 952.8 980.0 982.5 14075.6 16192.0 16617.3 16777.6 16912.1 34111.0 34117.0 34439.0 34628.3 35627.3 42392.6 42590.6 44411.6 45036.8 45297.0 6812.7 7176.6 7340.6 7784.5 8169.8 12093.2 12287.1 12355.3 12481.6 12498.6 10302.3 10428.0 10692.3 10835.8 11283.8 10916.7 11067.2 11101.3 11108.2 11216.8 10878.8 10920.8 11148.8 11324.4 11341.5 6971.9 7083.0 7199.0 7277.2 7335.9 10373.5 10657.8 10853.9 10937.2 11308.9 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | [#3] mootools.html Cycles:180 Average:5253.38 Median:5495.01 stddev:2912.27 (53.0%) stddev-sans-first:2905.41 11:01:46 INFO - PROCESS | 31439 | Values: 1316.1 1383.3 1450.4 1606.7 1870.7 7553.2 7953.0 7957.2 8125.3 8142.9 7966.6 8137.2 8151.0 8163.0 8181.0 2266.9 2293.2 2294.4 2297.4 2298.7 2212.5 2221.2 2227.8 2234.3 2273.1 2273.3 2274.4 2296.8 2298.5 2299.0 2259.5 2259.5 2283.0 2286.5 2286.7 2211.9 2214.8 2217.6 2218.5 2218.7 7919.9 8039.4 8083.5 8094.0 8153.5 4713.0 4822.2 4823.0 4826.9 4828.7 2986.7 2998.1 3055.3 3077.8 3089.0 906.8 917.7 931.5 942.4 951.4 10731.0 10733.0 10759.4 10760.9 10788.9 3944.2 4073.2 4110.4 4135.7 4145.8 8408.3 8472.3 8478.6 8479.6 8484.8 4511.0 4514.1 4517.2 4518.5 4524.5 3652.1 4221.2 4275.9 4408.9 4422.0 3525.3 3552.8 3615.1 3629.5 3640.5 1094.1 1102.7 1107.9 1116.3 1121.3 717.6 767.4 855.6 878.2 882.5 5266.2 5433.0 5467.9 5488.1 5639.4 926.4 938.9 946.7 957.4 962.5 3639.7 3641.0 3645.9 3685.5 3796.2 9431.0 9705.8 9767.0 9767.3 9786.2 9592.8 9607.7 9660.9 9663.1 9676.4 7063.3 7326.6 7432.9 7595.2 7617.3 5462.2 5478.8 5501.9 5513.1 5605.9 9013.4 9056.6 9088.5 9182.4 9192.1 9064.2 9401.8 9468.6 9505.6 9548.0 7010.2 7114.3 7137.7 7142.0 7146.2 7526.5 7599.1 7720.2 7726.1 7733.4 6989.2 7001.5 7027.1 7124.4 7166.0 6891.7 6936.0 6954.7 7008.6 7140.8 6499.1 6509.2 6567.7 6569.4 6571.5 4682.3 4722.7 4757.7 4761.5 4801.2 4805.5 4865.0 4902.4 4973.6 4997.4 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | [#4] prototype.html Cycles:180 Average:4232.86 Median:4776.55 stddev:1215.28 (25.4%) stddev-sans-first:1182.60 11:01:46 INFO - PROCESS | 31439 | Values: 315.9 321.7 331.8 332.5 332.6 4821.2 4843.0 4855.6 4871.7 4890.8 4563.3 4706.8 4734.4 4741.9 4775.1 3757.6 3793.1 3807.8 3865.6 3876.0 3847.0 3850.7 3863.9 3883.2 3886.0 3584.3 3772.8 3847.7 3847.8 3861.7 3748.0 3757.2 3764.7 3776.3 3787.9 3308.8 3321.5 3325.7 3334.4 3341.1 4623.2 4637.7 4657.6 4660.4 4662.5 4155.2 4319.9 4336.4 4337.3 4366.2 5096.4 5099.2 5099.7 5115.7 5123.5 3626.7 3630.2 3630.6 3672.0 3675.9 5127.0 5242.6 5274.3 5299.8 5313.1 3727.3 3754.9 3756.9 3761.0 3766.4 3786.0 3789.8 3807.2 3807.8 3830.3 4319.8 4343.8 4345.2 4354.7 4361.3 4960.2 5060.7 5088.4 5089.1 5096.2 1246.0 1307.5 1315.5 1317.1 1320.1 875.8 916.1 916.8 920.5 925.1 4504.1 4505.0 4509.3 4533.2 4542.4 5194.0 5194.7 5198.2 5231.8 5269.3 4245.8 4468.2 4479.4 4492.8 4494.8 2766.6 2773.1 2780.7 2789.3 2791.6 4923.0 4927.7 4934.8 4952.8 4961.5 5048.7 5270.8 5290.9 5291.9 5329.9 4762.6 4778.0 4835.6 4872.3 4916.7 5125.2 5133.3 5165.2 5175.9 5177.5 4909.5 5165.8 5174.8 5177.5 5190.6 4959.9 4979.6 5011.8 5012.6 5012.9 3778.7 3810.7 3812.7 3814.8 3824.9 5149.5 5261.6 5285.3 5288.3 5304.2 5107.7 5131.0 5135.3 5142.8 5151.2 4996.9 5133.0 5145.6 5157.4 5160.7 4824.2 4943.3 5056.6 5061.0 5066.7 5165.2 5180.8 5181.5 5184.4 5195.0 5031.6 5063.3 5068.3 5082.6 5083.9 11:01:46 INFO - PROCESS | 31439 | 11:01:46 INFO - PROCESS | 31439 | [#5] yui.html Cycles:180 Average:13207.41 Median:47807.38 stddev:15184.43 (31.8%) stddev-sans-first:15198.03 11:01:46 INFO - PROCESS | 31439 | Values: 712.4 790.3 794.1 811.4 817.8 14137.3 14694.1 14803.2 14812.8 14818.6 13546.4 13638.2 13677.9 13693.7 13700.7 670.2 845.7 880.3 888.2 888.7 873.9 881.1 881.7 882.0 882.0 932.2 939.6 939.7 940.0 940.5 706.4 894.7 923.4 930.3 930.6 677.0 682.0 682.1 683.0 684.1 12313.7 12354.7 12356.6 12363.3 12503.1 11315.2 11528.9 11743.9 11753.5 11878.5 11210.6 11213.3 11513.0 11532.8 11589.3 4114.7 4115.7 4137.8 4170.2 4240.5 46701.3 47745.8 47869.0 47953.3 48022.8 9533.1 9542.8 9639.1 9776.0 9813.3 17036.2 17525.4 17539.7 17576.7 18196.9 6644.2 6754.7 6760.1 6779.3 6895.6 3732.8 3778.4 3832.5 3915.8 3936.8 2899.0 2986.3 2991.7 2997.3 3002.0 526.0 532.3 535.8 541.4 548.0 524.4 593.4 600.2 633.3 637.3 7944.0 8052.3 8168.0 8214.9 8258.0 647.3 663.7 665.6 665.7 667.8 3784.0 3821.0 3921.0 3955.5 4048.6 53691.7 54179.0 54593.0 55176.2 55329.0 47971.3 48556.8 49333.8 50038.0 50804.7 44584.3 44948.0 45092.5 45943.5 46416.5 7748.9 7769.4 7840.6 7950.1 8009.9 31182.5 31473.0 31626.5 32007.7 32261.7 36770.8 38549.0 40961.8 41099.2 41399.2 10076.8 10214.8 10337.2 10367.5 10493.3 11077.6 11199.4 11343.3 11565.6 11577.4 10740.0 10849.7 10860.2 11179.8 11339.4 9968.4 10020.5 10216.8 10324.3 10486.1 10461.6 10475.2 10545.0 10545.6 10915.5 9062.9 9083.3 9173.7 9339.9 9550.9 8751.0 8804.3 8932.5 9003.6 9157.3 11:01:46 INFO - PROCESS | 31439 | -------- Summary: end -------- 11:01:46 INFO - PROCESS | 31439 | 11:01:47 INFO - TEST-INFO | 31439: exit 0 11:01:47 INFO - TEST-OK | dromaeo_css | took 1118900ms 11:01:47 INFO - TEST-START | kraken 11:01:47 INFO - operating with platform_type : linux_ 11:01:47 INFO - Initialising browser for kraken test... 11:01:47 INFO - TEST-INFO | started process 31619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp882LxQ/profile http://localhost:59067/getInfo.html) 11:01:51 INFO - PROCESS | 31619 | __metrics Screen width/height:1600/1200 11:01:51 INFO - PROCESS | 31619 | colorDepth:24 11:01:51 INFO - PROCESS | 31619 | Browser inner width/height: 1024/697 11:01:51 INFO - PROCESS | 31619 | __metrics 11:01:52 ERROR - PROCESS | 31619 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:01:53 INFO - TEST-INFO | 31619: exit 0 11:01:53 INFO - Browser initialized. 11:01:53 INFO - Running cycle 1/1 for kraken test... 11:01:53 INFO - TEST-INFO | started process 31703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp882LxQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:05 INFO - PROCESS | 31703 | RSS: Main: 154689536 11:02:05 INFO - PROCESS | 31703 | 11:02:08 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59067/tests/kraken/driver.html?testName=audio-beat-detection) 11:02:09 INFO - PROCESS | 31703 | RSS: Main: 210829312 11:02:09 INFO - PROCESS | 31703 | 11:02:12 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59067/tests/kraken/driver.html?testName=audio-dft) 11:02:12 INFO - PROCESS | 31703 | RSS: Main: 198909952 11:02:12 INFO - PROCESS | 31703 | 11:02:16 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59067/tests/kraken/driver.html?testName=audio-fft) 11:02:16 INFO - PROCESS | 31703 | RSS: Main: 266973184 11:02:16 INFO - PROCESS | 31703 | 11:02:19 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59067/tests/kraken/driver.html?testName=audio-oscillator) 11:02:19 INFO - PROCESS | 31703 | RSS: Main: 175828992 11:02:19 INFO - PROCESS | 31703 | 11:02:22 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:02:22 INFO - PROCESS | 31703 | RSS: Main: 180232192 11:02:22 INFO - PROCESS | 31703 | 11:02:25 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59067/tests/kraken/driver.html?testName=imaging-darkroom) 11:02:26 INFO - PROCESS | 31703 | RSS: Main: 216276992 11:02:26 INFO - PROCESS | 31703 | 11:02:30 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59067/tests/kraken/driver.html?testName=imaging-desaturate) 11:02:30 INFO - PROCESS | 31703 | RSS: Main: 214839296 11:02:30 INFO - PROCESS | 31703 | 11:02:33 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59067/tests/kraken/driver.html?testName=json-parse-financial) 11:02:34 INFO - PROCESS | 31703 | RSS: Main: 215613440 11:02:34 INFO - PROCESS | 31703 | 11:02:36 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:02:36 INFO - PROCESS | 31703 | RSS: Main: 208834560 11:02:36 INFO - PROCESS | 31703 | 11:02:38 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:02:39 INFO - PROCESS | 31703 | RSS: Main: 212766720 11:02:39 INFO - PROCESS | 31703 | 11:02:41 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:02:42 INFO - PROCESS | 31703 | RSS: Main: 215777280 11:02:42 INFO - PROCESS | 31703 | 11:02:45 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:02:45 INFO - PROCESS | 31703 | RSS: Main: 219590656 11:02:45 INFO - PROCESS | 31703 | 11:02:48 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:02:49 INFO - PROCESS | 31703 | RSS: Main: 218939392 11:02:49 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | Cycle 1(1): loaded http://localhost:59067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59067/tests/kraken/driver.html?testName=ai-astar) 11:02:51 INFO - PROCESS | 31703 | RSS: Main: 264691712 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | __start_tp_report 11:02:51 INFO - PROCESS | 31703 | _x_x_mozilla_page_load 11:02:51 INFO - PROCESS | 31703 | _x_x_mozilla_page_load_details 11:02:51 INFO - PROCESS | 31703 | |i|pagename|runs| 11:02:51 INFO - PROCESS | 31703 | |0;ai-astar;113;107;112;112;114;113;114;114;111;112 11:02:51 INFO - PROCESS | 31703 | |1;audio-beat-detection;162;131;156;218;132;158;151;135;206;130 11:02:51 INFO - PROCESS | 31703 | |2;audio-dft;162;160;161;162;162;161;161;161;161;161 11:02:51 INFO - PROCESS | 31703 | |3;audio-fft;98;74;75;143;77;76;76;75;137;75 11:02:51 INFO - PROCESS | 31703 | |4;audio-oscillator;93;94;155;91;91;91;123;92;92;127 11:02:51 INFO - PROCESS | 31703 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;117;117 11:02:51 INFO - PROCESS | 31703 | |6;imaging-darkroom;145;146;146;146;145;146;146;145;145;146 11:02:51 INFO - PROCESS | 31703 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;94 11:02:51 INFO - PROCESS | 31703 | |8;json-parse-financial;63;64;64;63;65;64;64;63;63;70 11:02:51 INFO - PROCESS | 31703 | |9;json-stringify-tinderbox;63;64;63;63;63;63;63;64;64;63 11:02:51 INFO - PROCESS | 31703 | |10;stanford-crypto-aes;83;82;88;85;84;83;90;82;142;84 11:02:51 INFO - PROCESS | 31703 | |11;stanford-crypto-ccm;140;139;130;130;136;132;128;131;156;142 11:02:51 INFO - PROCESS | 31703 | |12;stanford-crypto-pbkdf2;175;172;182;174;174;168;172;170;167;169 11:02:51 INFO - PROCESS | 31703 | |13;stanford-crypto-sha256-iterative;67;71;68;71;67;66;67;65;68;64 11:02:51 INFO - PROCESS | 31703 | __end_tp_report 11:02:51 INFO - PROCESS | 31703 | __start_cc_report 11:02:51 INFO - PROCESS | 31703 | _x_x_mozilla_cycle_collect,2087 11:02:51 INFO - PROCESS | 31703 | __end_cc_report 11:02:51 INFO - PROCESS | 31703 | __startTimestamp1463421771622__endTimestamp 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | ------- Summary: start ------- 11:02:51 INFO - PROCESS | 31703 | Number of tests: 14 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.10 (1.9%) stddev-sans-first:2.20 11:02:51 INFO - PROCESS | 31703 | Values: 113.0 107.0 112.0 112.0 114.0 113.0 114.0 114.0 111.0 112.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:157.00 stddev:31.07 (19.8%) stddev-sans-first:32.92 11:02:51 INFO - PROCESS | 31703 | Values: 162.0 131.0 156.0 218.0 132.0 158.0 151.0 135.0 206.0 130.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 11:02:51 INFO - PROCESS | 31703 | Values: 162.0 160.0 161.0 162.0 162.0 161.0 161.0 161.0 161.0 161.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#3] audio-fft Cycles:10 Average:90.60 Median:75.50 stddev:27.02 (35.8%) stddev-sans-first:28.53 11:02:51 INFO - PROCESS | 31703 | Values: 98.0 74.0 75.0 143.0 77.0 76.0 76.0 75.0 137.0 75.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:91.50 stddev:22.36 (24.4%) stddev-sans-first:23.30 11:02:51 INFO - PROCESS | 31703 | Values: 93.0 94.0 155.0 91.0 91.0 91.0 123.0 92.0 92.0 127.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:02:51 INFO - PROCESS | 31703 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:02:51 INFO - PROCESS | 31703 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:02:51 INFO - PROCESS | 31703 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:2.11 (3.3%) stddev-sans-first:2.19 11:02:51 INFO - PROCESS | 31703 | Values: 63.0 64.0 64.0 63.0 65.0 64.0 64.0 63.0 63.0 70.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 11:02:51 INFO - PROCESS | 31703 | Values: 63.0 64.0 63.0 63.0 63.0 63.0 63.0 64.0 64.0 63.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:84.00 stddev:18.35 (21.8%) stddev-sans-first:19.27 11:02:51 INFO - PROCESS | 31703 | Values: 83.0 82.0 88.0 85.0 84.0 83.0 90.0 82.0 142.0 84.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:137.50 stddev:8.41 (6.1%) stddev-sans-first:8.82 11:02:51 INFO - PROCESS | 31703 | Values: 140.0 139.0 130.0 130.0 136.0 132.0 128.0 131.0 156.0 142.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:4.35 (2.5%) stddev-sans-first:4.50 11:02:51 INFO - PROCESS | 31703 | Values: 175.0 172.0 182.0 174.0 174.0 168.0 172.0 170.0 167.0 169.0 11:02:51 INFO - PROCESS | 31703 | 11:02:51 INFO - PROCESS | 31703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.27 (3.4%) stddev-sans-first:2.40 11:02:51 INFO - PROCESS | 31703 | Values: 67.0 71.0 68.0 71.0 67.0 66.0 67.0 65.0 68.0 64.0 11:02:51 INFO - PROCESS | 31703 | -------- Summary: end -------- 11:02:51 INFO - PROCESS | 31703 | 11:02:52 INFO - TEST-INFO | 31703: exit 0 11:02:52 INFO - TEST-OK | kraken | took 64998ms 11:02:52 INFO - SUITE-END | took 1183s 11:02:52 INFO - Completed test suite (00:19:43) 11:02:52 INFO - javascript benchmark 11:02:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.4775044991, 2682.2221555748833, 2719.0755143251295, 2726.236653736953, 2728.154272175626, 4619.2609182530805, 4628.190066738316, 4677.625789936806, 4748.596369308609, 4791.448983366914, 4651.627869770418, 4677.74272415017, 4692.906141877161, 4757.310190022454, 4765.737884416356, 4268.402423660682, 4279.336702811053, 4335.783210839461, 4372.475302963633, 4436.778161091948, 4363.629091527224, 4390.714603550775, 4391.253486907233, 4422.933655995163, 4438.689291749579, 4232.0, 4244.896326954983, 4276.123394704078, 4276.743395396286, 4352.738835669854, 4311.030018245901, 4314.374415709736, 4320.848770293056, 4323.632491238249, 4368.759718215497, 4353.847615333448, 4353.998580326511, 4359.38968544404, 4363.585459381354, 4410.580994805488, 4478.977605111986, 4530.365748795171, 4566.337881007235, 4630.536946305376, 4671.696339737906, 5026.698398096126, 5090.643654944155, 5094.0, 5094.821681241176, 5110.514501122388, 5058.0895438821, 5065.822696205652, 5097.13348730713, 5130.897382052375, 5131.281620573122, 4575.702579332333, 4663.393758811333, 4681.789319480631, 4692.601128904013, 4714.245720684674, 5144.948550514447, 5187.507186817246, 5196.1166601677805, 5204.297419848272, 5206.8437946860895, 4949.084419382354, 4978.5768209701855, 4983.6013118950395, 4998.90002199954, 5001.899962000813, 4935.235038569028, 4994.875128121826, 5046.873828154252, 5051.924221136613, 5074.720890350993, 4988.127077761377, 5008.57427118699, 5017.172166592544, 5023.472535383805, 5065.366829146356, 4869.805207791719, 4995.900081998339, 5003.399592048904, 5006.0989021975665, 5019.974900125476, 4150.896227594274, 4151.46031015966, 4156.854510092132, 4186.895327616773, 4200.957990420056, 3711.387621042552, 3713.164537978933, 3717.312297225022, 3738.869139580156, 3748.0629842539365, 4230.069384735353, 4379.781010949503, 4382.868513944587, 4420.58004489573, 4429.0, 4952.62855285855, 4983.152864013126, 4983.377077865267, 5003.624728145403, 5006.874828129326, 4330.696851220384, 4331.480222373272, 4332.1985432695055, 4358.302671572533, 4379.364992076131, 4393.7363758174615, 4486.439195100613, 4492.034212644297, 4493.955060449353, 4503.482099558592, 4768.237082066853, 4804.399450068741, 4808.35087263215, 4814.6870453420415, 4858.222684370484, 5060.544550990428, 5068.873278168076, 5073.644844860824, 5075.77159027852, 5089.13484707608, 4663.790129444251, 4737.478877323423, 4771.06964141989, 4782.808687652455, 4842.7820748065715, 4935.309056732132, 4959.776810043484, 4960.255961605788, 4965.851024469272, 5004.749762511787, 4993.575546078624, 5016.874578135576, 5026.824061157989, 5034.647574669738, 5063.3417655704525, 4745.644076694192, 4872.756362181806, 4877.6585639004925, 4910.116179087656, 4940.827071052496, 4880.536349046835, 4889.755512224446, 4893.119238537098, 4903.901921961612, 4951.133551628523, 4815.590674792542, 4828.613710903049, 4832.51674832528, 4874.488178741323, 4875.731834749123, 4770.928436073392, 4772.76136193182, 4812.542808433333, 4854.17479028559, 4875.561199492063, 4763.118823017753, 4773.0, 4774.379330686988, 4781.163296423042, 4786.7845946931775], "value": 4616.692288811875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9198266251394, 601.9518438524918, 602.2321540036453, 603.3544107804651, 614.649649699671, 28731.56902646462, 29044.854775726144, 42695.57304426955, 42710.35934460982, 43729.78135109328, 40723.796381018125, 41208.793956030255, 44594.0, 44607.0, 44694.32958505617, 7496.13794413644, 8063.919360806405, 8203.58982050898, 8212.0, 8223.54770487623, 10109.494525273743, 10325.896741032606, 10332.225083118796, 10335.741606459824, 10704.090152337061, 10163.0, 10265.076143147115, 10605.575776968912, 10614.257002009863, 10615.150787936947, 10339.638112666058, 10446.0, 10449.425281609509, 10449.529771160316, 10451.0, 10332.896671033268, 10411.791764164675, 10418.166546676248, 10418.531166097544, 10423.374597524173, 40962.795186024174, 41297.0, 41415.79292103551, 41430.585694142974, 41513.1697366054, 3400.081977865987, 3415.112070861569, 3484.303139372136, 3864.265789499986, 4042.8787136385663, 30850.0, 31279.68720312813, 31860.0, 33221.667783322344, 33341.499877501854, 3480.564929383827, 3585.025380710662, 3606.8917932461804, 3666.0651533858695, 3676.944845827288, 297380.5130974353, 298079.0, 298253.0, 301261.0, 302609.0, 64617.35382646207, 65589.34410655928, 65814.34185658178, 65828.0, 65840.6707966457, 67912.66043669848, 68881.31118688748, 68911.65544172247, 68958.0, 68965.65517172382, 15353.692926141637, 15522.844771552365, 15524.767128493082, 15560.377584896478, 15628.062316261061, 10160.745981350525, 10467.633632822966, 10470.581176752845, 10666.093382062612, 11731.530738770523, 18409.47546531298, 21389.46526336823, 21836.672449913265, 21847.344579662637, 21847.344579662637, 7610.292280789408, 7741.8838717419285, 7835.804104897309, 7951.602419878983, 8088.555129467818, 863.4344504349662, 948.6632245552729, 995.9850602240972, 1012.0646415480655, 1044.4046893270763, 29149.417011660073, 29549.113526594236, 29568.852155739085, 29800.254993625334, 30133.69866301309, 1010.4796030044533, 1033.328336581213, 1037.9792404151874, 1054.1303424674675, 1159.310210424796, 15346.539603811903, 15792.289346979414, 15818.841811581737, 15898.284577194054, 16128.919355403148, 406019.0, 409116.0, 410294.0, 411023.0, 411782.0, 54033.45966540363, 55477.0, 55550.72224638932, 55568.72215638896, 55741.72129139328, 1160.3849959521467, 1268.1249937543066, 1280.6862318731971, 1283.794592865137, 1314.283715375123, 28909.421811564072, 30207.69792302049, 30259.243518911324, 30399.696003039688, 30930.69069309278, 44832.0, 52213.0, 53423.732881335345, 53480.73259633677, 57808.0, 378796.0, 379826.0, 382083.0, 382316.0, 382460.0, 34622.0, 40212.37557680904, 40416.39375409312, 41845.58154418417, 42371.15257694767, 45194.0, 45383.0, 45847.541524584325, 46205.76897115493, 46484.0, 38468.23063538658, 39090.80454597709, 39153.41269880897, 39531.0, 39536.40695389514, 36926.0, 37756.811215943744, 39018.6098139015, 39080.804595976835, 39524.2095158101, 37547.249055019296, 37871.621283787914, 38373.0, 38420.42369364518, 38786.0, 32799.50800737943, 34943.65056349404, 34950.82524587361, 34960.650393495736, 35054.29891402209, 26536.0, 28229.576556352084, 28476.0, 28545.571816423184, 28647.713522864506], "value": 19820.014367866548, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.6434762192594, 390.63670786168854, 395.5056179775281, 395.52734482293664, 414.1282600126733, 13060.934695326534, 13415.396307166176, 16876.324947002122, 17911.641767164667, 18105.456836294914, 15943.92028039858, 16892.15539223037, 17572.121393930316, 17629.03040332781, 18568.44294671162, 5232.345956755396, 5309.946900530984, 5354.839354819343, 5365.892682146355, 5394.433584473632, 3690.2250527389147, 5173.715445650488, 5211.895762084756, 5325.254464374991, 5869.911951320733, 6125.5712100153005, 6227.626342419469, 6239.750409983595, 6246.063090536433, 6252.781152659658, 6129.32577416486, 6180.6291622502795, 6203.069539569078, 6206.472449841769, 6253.593516421418, 5339.092354299778, 5456.0997435423105, 5460.235567020621, 5464.9453505464835, 5480.862978425532, 20383.08276127578, 21306.14775408982, 21531.569368612698, 21548.569028619495, 21570.1371945122, 2090.9790902090936, 2129.4676330917273, 2179.858309209896, 2191.802737753594, 2516.4589613233243, 13070.542531011464, 13359.53241636538, 13615.0, 13696.65758356039, 14224.644383890382, 1797.694391953371, 1837.0814592703648, 1871.1486273745413, 1881.8306352428347, 1924.4130540185238, 69678.0, 74244.25755742428, 74446.0, 74562.25437745608, 75655.24344756537, 9722.659706910224, 9853.75365615851, 9997.250206234561, 10200.540975656113, 10372.325798823053, 14122.85877141236, 14206.147631141957, 14215.43138274478, 14218.644533886736, 14236.074655147382, 7294.343509084208, 7338.889916651255, 7493.288137626917, 7513.887291690629, 7530.171681115073, 6767.830804229934, 6817.965910170417, 6878.38094571491, 7002.894956575656, 7023.824404389931, 6429.6463694496315, 6443.0, 6479.514036447285, 6488.416042556099, 6637.535372523877, 1667.6998140334856, 1719.312275089949, 1806.765120534322, 1809.3305476973603, 1869.925202991865, 854.5214679779343, 925.9722208333761, 971.582219645545, 990.1979396688562, 1004.0662184168647, 16907.0, 17893.642127157385, 18022.459326220236, 18161.273549058154, 18399.264029438673, 926.9849514781304, 928.1692884868005, 949.9810003799886, 967.5597603090577, 980.9705708828747, 10291.022352876465, 10472.16222702182, 10476.580936762597, 10605.41670208146, 10638.574457021787, 429271.0, 430734.0, 438569.0, 439098.0, 440119.0, 71948.0, 72172.63913680398, 72430.0, 73104.0, 73354.63322683352, 862.642003568512, 950.5342382232794, 952.7903861150536, 980.0444566547559, 982.5480279071708, 14075.648108797363, 16191.980486049362, 16617.252223650208, 16777.580560486087, 16912.069836158636, 34111.0, 34117.0, 34439.0, 34628.30743385068, 35627.28745425129, 42392.57607423886, 42590.57409425866, 44411.55588444074, 45036.77481612571, 45297.0, 6812.693428795617, 7176.641167941686, 7340.559566426032, 7784.494007889469, 8169.795755105933, 12093.15347925672, 12287.1399002069, 12355.320457374572, 12481.56314528987, 12498.625041248777, 10302.278840481094, 10428.0, 10692.305000174963, 10835.832833433187, 11283.830742539032, 10916.727081823017, 11067.169962252703, 11101.278416903198, 11108.173232824793, 11216.83174752363, 10878.836817447904, 10920.781584368428, 11148.832767508657, 11324.433778311217, 11341.546338146381, 6971.8605627886145, 7082.972968919581, 7198.992141100145, 7277.235890231449, 7335.853282934205, 10373.533191006272, 10657.840132397865, 10853.891461085605, 10937.179711521509, 11308.943455282671], "value": 8649.362704832405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.0655934286656, 1383.3498255819761, 1450.3980847948103, 1606.6545692676073, 1870.672632289349, 7553.244675532444, 7952.960235198831, 7957.20427957204, 8125.268725814675, 8142.91857081429, 7966.641501132449, 8137.226963438478, 8151.0, 8162.95918520408, 8181.0, 2266.931992040237, 2293.243229734184, 2294.380517260339, 2297.3911913342977, 2298.689676893623, 2212.5353675728115, 2221.2336743823357, 2227.8217742580637, 2234.2850287907877, 2273.1134857405623, 2273.283915566591, 2274.3631783100677, 2296.7932886040253, 2298.528801595677, 2298.9540209195807, 2259.4690247791837, 2259.5029093599383, 2282.965755513677, 2286.4626812699003, 2286.6684330772027, 2211.9336419907427, 2214.811741002017, 2217.645176771709, 2218.4675677837363, 2218.7448443429053, 7919.920800791976, 8039.437239393244, 8083.47457415272, 8094.0, 8153.470024448392, 4713.0, 4822.204336284509, 4823.035392921394, 4826.879328016793, 4828.73441960692, 2986.7461265792435, 2998.055612482061, 3055.2972816252163, 3077.81533108012, 3088.984555077233, 906.7506435730227, 917.7063339731288, 931.4504442378961, 942.3544871762864, 951.372094417681, 10731.034206921415, 10733.0, 10759.3544387337, 10760.892391076146, 10788.892111078867, 3944.2111577684577, 4073.165001174752, 4110.445089912883, 4135.6898232632675, 4145.834166633361, 8408.327333813402, 8472.279856212292, 8478.57607119654, 8479.576021198915, 8484.787880302918, 4511.0, 4514.119746649372, 4517.2094883395275, 4518.525554816697, 4524.547545245515, 3652.0504668786307, 4221.197972385298, 4275.893102672458, 4408.867733967986, 4422.0, 3525.330187264463, 3552.8223588820456, 3615.060084378028, 3629.473726309723, 3640.526731524885, 1094.141099237095, 1102.73534351755, 1107.8892110788856, 1116.3357802107732, 1121.3384103379046, 717.6375930155239, 767.4282659418657, 855.6064210463132, 878.2139984713773, 882.4793371910475, 5266.1574148136115, 5432.994895944263, 5467.9453205467435, 5488.094464413407, 5639.351474580394, 926.4070994563485, 938.9154976052188, 946.654471118037, 957.4398976598628, 962.499500259861, 3639.6906262967414, 3641.0, 3645.945310820287, 3685.539307586552, 3796.1648437343742, 9430.962594114642, 9705.757356066155, 9767.0, 9767.316287859781, 9786.168175705145, 9592.76018099553, 9607.663731769355, 9660.855087173699, 9663.13031827139, 9676.419414834992, 7063.2583578724525, 7326.597037162901, 7432.85134297311, 7595.202503737028, 7617.27635874591, 5462.20797984298, 5478.753456094565, 5501.917471237854, 5513.145462453326, 5605.915911261252, 9013.369064165445, 9056.592453339746, 9088.500132492776, 9182.403143795633, 9192.080791920755, 9064.184223419923, 9401.81196376055, 9468.573914174016, 9505.572249248662, 9548.0, 7010.228874823867, 7114.253003434565, 7137.678804453708, 7141.9642901785155, 7146.249643787535, 7526.473146879885, 7599.088109426904, 7720.189380115232, 7726.111497177896, 7733.38132949374, 6989.161300643752, 7001.544899581511, 7027.121609798775, 7124.358807707331, 7165.964170179116, 6891.724331026903, 6935.965320173367, 6954.687039083355, 7008.579485230903, 7140.821479463055, 6499.0901273820755, 6509.1863517060365, 6567.737290508326, 6569.37590928861, 6571.5399922005, 4682.274247491644, 4722.716637001791, 4757.738324392191, 4761.500042495488, 4801.18379875415, 4805.471398146131, 4865.002674451658, 4902.411710594752, 4973.5523802857915, 4997.350344455343], "value": 4236.419353657027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.894175451224, 321.7313543191435, 331.79262960649595, 332.5012481278083, 332.5527165961781, 4821.204501257293, 4842.97578512107, 4855.567607555767, 4871.683340582864, 4890.755462226893, 4563.338315944195, 4706.788194531246, 4734.372423305064, 4741.9414477661885, 4775.14047471455, 3757.6054514276016, 3793.089658481965, 3807.809609519527, 3865.6083809828438, 3876.0, 3846.9807650961707, 3850.711196660248, 3863.884083477486, 3883.184531248441, 3886.04791826003, 3584.2652256287397, 3772.811359432031, 3847.7498962567483, 3847.8460861565504, 3861.706328379996, 3748.0, 3757.248550289953, 3764.698824094066, 3776.30138424391, 3787.9242415151816, 3308.768386212966, 3321.485169798685, 3325.7029758394247, 3334.4498157803932, 3341.081202669261, 4623.1678297906365, 4637.721736695809, 4657.5575320344515, 4660.37084993525, 4662.50799744082, 4155.168966206771, 4319.920019995001, 4336.392904993303, 4337.330127900749, 4366.170427618774, 5096.413912400048, 5099.23511473282, 5099.745012749385, 5115.718635475085, 5123.487651234884, 3626.746127771057, 3630.16506203572, 3630.5643322801434, 3672.0, 3675.9448608270895, 5126.974365128188, 5242.606804489678, 5274.340707411574, 5299.761510732026, 5313.149896016619, 3727.30407664512, 3754.9436758448646, 3756.9248615027545, 3760.9623903761158, 3766.3804564037177, 3785.9777859977653, 3789.7536660117003, 3807.181455986921, 3807.790571518593, 3830.3105441020325, 4319.784010799511, 4343.805453500313, 4345.239583072949, 4354.673399494987, 4361.323994780814, 4960.23116416956, 5060.746962651852, 5088.363954505687, 5089.134847075932, 5096.159133742891, 1245.9626211213679, 1307.5162189989574, 1315.53298579005, 1317.1043690290694, 1320.1287150480637, 875.8073223890734, 916.0945233913444, 916.7577931902176, 920.5075284722641, 925.0703043441433, 4504.09918016398, 4505.008898042425, 4509.255972764523, 4533.189422558035, 4542.432195975503, 5194.0, 5194.714290713971, 5198.194279886624, 5231.8168864089575, 5269.314989051399, 4245.766482843412, 4468.240399132155, 4479.395281637003, 4492.797824097924, 4494.752788596593, 2766.6265054217824, 2773.126465163467, 2780.7497325240824, 2789.3166174287026, 2791.553351463756, 4922.975385123052, 4927.679700819507, 4934.753262336869, 4952.777125029383, 4961.50384961501, 5048.722320272347, 5270.7628156733035, 5290.867728306746, 5291.894162116813, 5329.9467005330225, 4762.571368576775, 4777.95222047782, 4835.564799168092, 4872.317875497433, 4916.680415772963, 5125.231215317583, 5133.281340612242, 5165.173572228426, 5175.948240517547, 5177.534021938043, 4909.533594308535, 5165.845024649267, 5174.844754657366, 5177.456367081402, 5190.55880250183, 4959.851204463872, 4979.601631869369, 5011.799528018984, 5012.649114561946, 5012.924806127984, 3778.677462887967, 3810.714196435223, 3812.6949844011856, 3814.8474061037246, 3824.8661296854475, 5149.459306772885, 5261.605379596622, 5285.260063591023, 5288.286081378965, 5304.204369344629, 5107.719075450886, 5131.025105229995, 5135.329628593186, 5142.820001299937, 5151.2273159026445, 4996.875078123076, 5133.0, 5145.588352931832, 5157.406898206604, 5160.716160611052, 4824.228123500223, 4943.2585112233455, 5056.57019153376, 5061.0, 5066.695998240118, 5165.225216217597, 5180.766865490987, 5181.5077567631015, 5184.392838220013, 5194.974025130002, 5031.572316353151, 5063.316452278895, 5068.315777370008, 5082.567981721595, 5083.923741143812], "value": 3856.2097779192986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.4407340237914, 790.2966359939654, 794.1105961323319, 811.4076723991486, 817.8119032622496, 14137.29313534323, 14694.118352898833, 14803.185824779634, 14812.77780833287, 14818.55544333669, 13546.39041243144, 13638.249896255702, 13677.931610341935, 13693.65765855854, 13700.657483562916, 670.1857243449208, 845.7082306604211, 880.3089574683875, 888.2449917570078, 888.6711916590871, 873.9038705742363, 881.1320848963766, 881.6825942660637, 881.9559022048904, 881.973540793774, 932.1517419148543, 939.642935684439, 939.6570251858057, 939.994206199367, 940.539135823445, 706.3607435271088, 894.7449976756658, 923.3536524432924, 930.3255140023497, 930.585889279271, 677.0284641539407, 682.0383259603934, 682.0825989044727, 682.9931700682979, 684.096991970599, 12313.69215769604, 12354.691132721664, 12356.62930112089, 12363.320017399039, 12503.124781265315, 11315.15136364776, 11528.884711152865, 11743.882561174365, 11753.529858805638, 11878.524859005629, 11210.551577936872, 11213.327200368005, 11513.0, 11532.769344613145, 11589.304641721523, 4114.650254728352, 4115.73247738899, 4137.77242251676, 4170.207660544487, 4240.512341080754, 46701.29948050782, 47745.76127119342, 47869.0, 47953.28070078952, 48022.75988620034, 9533.094356036165, 9542.761430964143, 9639.132478076866, 9776.022397760167, 9813.313068085166, 17036.2333694984, 17525.38661146879, 17539.73690394645, 17576.736348954775, 18196.90901545484, 6644.169478815148, 6754.696038678271, 6760.08738820253, 6779.254282028973, 6895.586264824126, 3732.757370770891, 3778.3954567269107, 3832.5209348831395, 3915.7650540967634, 3936.7834769087403, 2898.9565156522667, 2986.2982199183175, 2991.745701615387, 2997.2956355256497, 3001.9549706754415, 525.976331065103, 532.2707890190463, 535.8285348688382, 541.3747122074011, 547.9506844383944, 524.4100387064552, 593.3769541980903, 600.1777564736252, 633.3128555517224, 637.2830565613684, 7944.0, 8052.315553177928, 8167.959160204161, 8214.917850821535, 8258.0, 647.3009150117862, 663.6781161136845, 665.6472069803012, 665.7436886798617, 667.7729571945562, 3783.981080094582, 3820.9808950955066, 3920.9803950980063, 3955.5434540458696, 4048.6356227939627, 53691.731541342044, 54179.0, 54593.0, 55176.17235741387, 55329.0, 47971.280430793566, 48556.75721621369, 49333.753331233835, 50038.0, 50804.74597627062, 44584.3312350315, 44948.0, 45092.549074509494, 45943.540564593925, 46416.535834641225, 7748.92251077482, 7769.378449723896, 7840.568768717775, 7950.125486196398, 8009.879851802111, 31182.532262016543, 31473.0, 31626.525602115526, 32007.67992320047, 32261.677383225866, 36770.816145919096, 38549.0, 40961.795191023855, 41099.1780164401, 41399.1720165589, 10076.798464030531, 10214.846777298495, 10337.17302615774, 10367.481625918825, 10493.265471416928, 11077.556897724, 11199.440027998404, 11343.319400835977, 11565.595204167814, 11577.363245021605, 10740.0, 10849.728756781144, 10860.239783215098, 11179.776404472028, 11339.376334301363, 9968.352057116264, 10020.498975051363, 10216.795664086825, 10324.277300589187, 10486.056254937092, 10461.581536738446, 10475.214358923264, 10545.0, 10545.630902918669, 10915.508802104083, 9062.909370906207, 9083.318751093826, 9173.678921237724, 9339.906600934175, 9550.90449095528, 8750.99840255586, 8804.251638610789, 8932.50871202064, 9003.594838232164, 9157.267418606361], "value": 6157.165616201511, "unit": "score"}], "name": "dromaeo_css", "value": 6558.970334678339, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 112.0, 114.0, 113.0, 114.0, 114.0, 111.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 156.0, 218.0, 132.0, 158.0, 151.0, 135.0, 206.0, 130.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 74.0, 75.0, 143.0, 77.0, 76.0, 76.0, 75.0, 137.0, 75.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 155.0, 91.0, 91.0, 91.0, 123.0, 92.0, 92.0, 127.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 65.0, 64.0, 64.0, 63.0, 63.0, 70.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 88.0, 85.0, 84.0, 83.0, 90.0, 82.0, 142.0, 84.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 130.0, 130.0, 136.0, 132.0, 128.0, 131.0, 156.0, 142.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 182.0, 174.0, 174.0, 168.0, 172.0, 170.0, 167.0, 169.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 71.0, 67.0, 66.0, 67.0, 65.0, 68.0, 64.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1578.2, "alertThreshold": 2.0}]} 11:02:52 INFO - Return code: 0 11:02:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:02:52 ERROR - # TBPL SUCCESS # 11:02:52 INFO - Running post-action listener: _resource_record_post_action 11:02:52 INFO - ##### 11:02:52 INFO - ##### Finished run-tests step (success) 11:02:52 INFO - ##### 11:02:52 INFO - Running post-run listener: _resource_record_post_run 11:02:52 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 540643328; Read time: 0; Write time: 531996 11:02:52 INFO - TinderboxPrint: CPU usage
13.1% 11:02:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:02:52 INFO - TinderboxPrint: I/O write bytes / time
540,643,328 / 531,996 11:02:52 INFO - TinderboxPrint: CPU idle
8,329.3 (86.9%) 11:02:52 INFO - TinderboxPrint: CPU user
1,212.6 (12.6%) 11:02:52 INFO - TinderboxPrint: Swap in / out
0 / 0 11:02:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246378496; Read time: 0; Write time: 282020 11:02:52 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 294264832; Read time: 0; Write time: 249976 11:02:53 INFO - Running post-run listener: _upload_blobber_files 11:02:53 INFO - Blob upload gear active. 11:02:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:02:53 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 11:02:53 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'] 11:02:53 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 11:02:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:54 INFO - (blobuploader) - INFO - Done attempting. 11:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:55 INFO - (blobuploader) - INFO - Done attempting. 11:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:59 INFO - (blobuploader) - INFO - Done attempting. 11:02:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:02:59 INFO - Return code: 0 11:02:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:02:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:02:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33034b01590fbd3293eafd457213dbcc8256f0c056ba5f9dc5a787e236665f138728876f223a0965bbd27eac501aff18a7f14ee79b60ea45c97ab9a0c41d1675", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b6bc5f85c0345fa6f2c3a4014d73856e0926eb5919c4e26cdf1fa7ddc00c60bf3c39f480f31bf87440db554532abf43e01deb441176b91a26ec12ddc769a6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e261c19f4865267faa46c9b1e89732574878f6abfa914bb189793347a8eedcf8eb81be2056066eb3f89644cf6022507569c539a7c8da2d9f68492dcdf683e75"} 11:02:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:02:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:02:59 INFO - Contents: 11:02:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33034b01590fbd3293eafd457213dbcc8256f0c056ba5f9dc5a787e236665f138728876f223a0965bbd27eac501aff18a7f14ee79b60ea45c97ab9a0c41d1675", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b6bc5f85c0345fa6f2c3a4014d73856e0926eb5919c4e26cdf1fa7ddc00c60bf3c39f480f31bf87440db554532abf43e01deb441176b91a26ec12ddc769a6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e261c19f4865267faa46c9b1e89732574878f6abfa914bb189793347a8eedcf8eb81be2056066eb3f89644cf6022507569c539a7c8da2d9f68492dcdf683e75"} 11:02:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:02:59 INFO - Copying logs to upload dir... 11:02:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:02:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.514427 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-16 11:02:58.742164) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 11:02:58.746135) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032 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/33034b01590fbd3293eafd457213dbcc8256f0c056ba5f9dc5a787e236665f138728876f223a0965bbd27eac501aff18a7f14ee79b60ea45c97ab9a0c41d1675", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b6bc5f85c0345fa6f2c3a4014d73856e0926eb5919c4e26cdf1fa7ddc00c60bf3c39f480f31bf87440db554532abf43e01deb441176b91a26ec12ddc769a6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e261c19f4865267faa46c9b1e89732574878f6abfa914bb189793347a8eedcf8eb81be2056066eb3f89644cf6022507569c539a7c8da2d9f68492dcdf683e75"} build_url:https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/OhitR5fEQtuj1MHBGS0zwA/artifacts/public/build/firefox-49.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/33034b01590fbd3293eafd457213dbcc8256f0c056ba5f9dc5a787e236665f138728876f223a0965bbd27eac501aff18a7f14ee79b60ea45c97ab9a0c41d1675", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b6bc5f85c0345fa6f2c3a4014d73856e0926eb5919c4e26cdf1fa7ddc00c60bf3c39f480f31bf87440db554532abf43e01deb441176b91a26ec12ddc769a6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e261c19f4865267faa46c9b1e89732574878f6abfa914bb189793347a8eedcf8eb81be2056066eb3f89644cf6022507569c539a7c8da2d9f68492dcdf683e75"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 11:02:58.770421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:02:58.770755) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463420272.171983-1008339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:02:58.856638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 11:02:58.856969) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 11:02:58.857264) ========= ========= Total master_lag: 0.18 =========