builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1464177693.27 results: success (0) buildid: 20160525042639 builduid: 4e1342f98acb4d50963aad46a9cf2f5b revision: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.274330) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.274899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.275211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.312894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.313386) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 05:01:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-05-25 05:01:33 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.428854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.429184) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018953 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.481888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:33.482225) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 --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 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 --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=7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 05:01:33,638 truncating revision to first 12 chars 2016-05-25 05:01:33,638 Setting DEBUG logging. 2016-05-25 05:01:33,638 attempt 1/10 2016-05-25 05:01:33,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2a2ce43bcafb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 05:01:33,939 unpacking tar archive at: fx-team-2a2ce43bcafb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:34.070586) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:34.070916) ========= script_repo_revision: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:34.071320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:34.071609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 05:01:34.085995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-25 05:01:34.086350) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:34 INFO - MultiFileLogger online at 20160525 05:01:34 in /builds/slave/test 05:01:34 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 05:01:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:34 INFO - {'append_to_log': False, 05:01:34 INFO - 'base_work_dir': '/builds/slave/test', 05:01:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:01:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:34 INFO - 'branch': 'Fx-Team-Non-PGO', 05:01:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:34 INFO - 'config_files': ('talos/linux_config.py',), 05:01:34 INFO - 'default_actions': ('clobber', 05:01:34 INFO - 'read-buildbot-config', 05:01:34 INFO - 'download-and-extract', 05:01:34 INFO - 'populate-webroot', 05:01:34 INFO - 'create-virtualenv', 05:01:34 INFO - 'install', 05:01:34 INFO - 'run-tests'), 05:01:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:34 INFO - 'download_minidump_stackwalk': True, 05:01:34 INFO - 'download_symbols': 'ondemand', 05:01:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:34 INFO - 'installer_path': 'installer.exe', 05:01:34 INFO - 'log_level': 'info', 05:01:34 INFO - 'log_name': 'talos', 05:01:34 INFO - 'log_to_console': True, 05:01:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:34 INFO - 'opt_config_files': (), 05:01:34 INFO - 'pip_index': False, 05:01:34 INFO - 'sps_profile': False, 05:01:34 INFO - 'sps_profile_interval': 0, 05:01:34 INFO - 'suite': 'dromaeojs', 05:01:34 INFO - 'system_bits': '32', 05:01:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:34 INFO - 'title': 'talos-linux64-ix-005', 05:01:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:34 INFO - 'use_talos_json': True, 05:01:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:34 INFO - 'work_dir': 'build'} 05:01:34 INFO - ##### 05:01:34 INFO - ##### Running clobber step. 05:01:34 INFO - ##### 05:01:34 INFO - Running pre-action listener: _resource_record_pre_action 05:01:34 INFO - Running main action method: clobber 05:01:34 INFO - rmtree: /builds/slave/test/build 05:01:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:34 INFO - Running post-action listener: _resource_record_post_action 05:01:34 INFO - ##### 05:01:34 INFO - ##### Finished clobber step (success) 05:01:34 INFO - ##### 05:01:34 INFO - ##### 05:01:34 INFO - ##### Running read-buildbot-config step. 05:01:34 INFO - ##### 05:01:34 INFO - Running pre-action listener: _resource_record_pre_action 05:01:34 INFO - Running main action method: read_buildbot_config 05:01:34 INFO - Using buildbot properties: 05:01:34 INFO - { 05:01:34 INFO - "project": "", 05:01:34 INFO - "product": "firefox", 05:01:34 INFO - "script_repo_revision": "production", 05:01:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:01:34 INFO - "repository": "", 05:01:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:01:34 INFO - "buildid": "20160525042639", 05:01:34 INFO - "pgo_build": "False", 05:01:34 INFO - "basedir": "/builds/slave/test", 05:01:34 INFO - "buildnumber": 1713, 05:01:34 INFO - "slavename": "talos-linux64-ix-005", 05:01:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:01:34 INFO - "platform": "ubuntu64_hw", 05:01:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:01:34 INFO - "branch": "fx-team", 05:01:34 INFO - "repo_path": "integration/fx-team", 05:01:34 INFO - "revision": "2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7", 05:01:34 INFO - "stage_platform": "linux64", 05:01:34 INFO - "builduid": "4e1342f98acb4d50963aad46a9cf2f5b", 05:01:34 INFO - "slavebuilddir": "test" 05:01:34 INFO - } 05:01:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:01:34 INFO - Running post-action listener: _resource_record_post_action 05:01:34 INFO - ##### 05:01:34 INFO - ##### Finished read-buildbot-config step (success) 05:01:34 INFO - ##### 05:01:34 INFO - ##### 05:01:34 INFO - ##### Running download-and-extract step. 05:01:34 INFO - ##### 05:01:34 INFO - Running pre-action listener: _resource_record_pre_action 05:01:34 INFO - Running main action method: download_and_extract 05:01:34 INFO - mkdir: /builds/slave/test/build/tests 05:01:34 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')]} 05:01:34 INFO - https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:01:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:39 INFO - Downloaded 1361 bytes. 05:01:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:39 INFO - Using the following test package requirements: 05:01:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:01:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:01:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'jsshell-linux-x86_64.zip'], 05:01:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:01:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:01:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:01:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:01:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:01:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:01:39 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')]} 05:01:39 INFO - https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:49 INFO - Downloaded 22844408 bytes. 05:01:49 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'] 05:01:49 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 05:01:51 INFO - Return code: 0 05:01:51 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 05:01:51 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')]} 05:01:51 INFO - https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:53 INFO - Downloaded 22844408 bytes. 05:01:53 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'] 05:01:53 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 05:01:55 INFO - Return code: 0 05:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:55 INFO - https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:55 INFO - Downloaded 10840359 bytes. 05:01:55 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'] 05:01:55 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 05:01:56 INFO - Return code: 0 05:01:56 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')]} 05:01:56 INFO - https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:01:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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 05:01:57 INFO - Downloaded 54817148 bytes. 05:01:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:57 INFO - mkdir: /builds/slave/test/properties 05:01:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:01:57 INFO - Writing to file /builds/slave/test/properties/build_url 05:01:57 INFO - Contents: 05:01:57 INFO - build_url:https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:58 INFO - Running post-action listener: _resource_record_post_action 05:01:58 INFO - Running post-action listener: set_extra_try_arguments 05:01:58 INFO - ##### 05:01:58 INFO - ##### Finished download-and-extract step (success) 05:01:58 INFO - ##### 05:01:58 INFO - ##### 05:01:58 INFO - ##### Running populate-webroot step. 05:01:58 INFO - ##### 05:01:58 INFO - Running pre-action listener: _resource_record_pre_action 05:01:58 INFO - Running main action method: populate_webroot 05:01:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:58 INFO - '--tppagecycles', 05:01:58 INFO - '7'], 05:01:58 INFO - 'tests': ['tsvgm']}}, 05:01:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:01:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:01:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:01:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['damp', 'tps']}, 05:01:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'tests': ['damp', 'tps']}, 05:01:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['dromaeo_dom']}, 05:01:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['a11yr', 05:01:58 INFO - 'ts_paint', 05:01:58 INFO - 'tpaint', 05:01:58 INFO - 'sessionrestore', 05:01:58 INFO - 'sessionrestore_no_auto_restore', 05:01:58 INFO - 'tabpaint']}, 05:01:58 INFO - 'other-e10s': {'tests': ['a11yr', 05:01:58 INFO - 'ts_paint', 05:01:58 INFO - 'tpaint', 05:01:58 INFO - 'sessionrestore', 05:01:58 INFO - 'sessionrestore_no_auto_restore', 05:01:58 INFO - 'tabpaint']}, 05:01:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:01:58 INFO - 'ts_paint', 05:01:58 INFO - 'tpaint', 05:01:58 INFO - 'sessionrestore', 05:01:58 INFO - 'sessionrestore_no_auto_restore', 05:01:58 INFO - 'tabpaint']}, 05:01:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:01:58 INFO - 'ts_paint', 05:01:58 INFO - 'tpaint', 05:01:58 INFO - 'sessionrestore', 05:01:58 INFO - 'sessionrestore_no_auto_restore', 05:01:58 INFO - 'tabpaint']}, 05:01:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['a11yr', 05:01:58 INFO - 'ts_paint', 05:01:58 INFO - 'tpaint', 05:01:58 INFO - 'sessionrestore', 05:01:58 INFO - 'sessionrestore_no_auto_restore', 05:01:58 INFO - 'tabpaint']}, 05:01:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['a11yr', 05:01:58 INFO - 'ts_paint', 05:01:58 INFO - 'tpaint', 05:01:58 INFO - 'sessionrestore', 05:01:58 INFO - 'sessionrestore_no_auto_restore', 05:01:58 INFO - 'tabpaint']}, 05:01:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['tsvgx', 05:01:58 INFO - 'tsvgr_opacity', 05:01:58 INFO - 'tart', 05:01:58 INFO - 'tscrollx', 05:01:58 INFO - 'cart']}, 05:01:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:01:58 INFO - 'tsvgr_opacity', 05:01:58 INFO - 'tart', 05:01:58 INFO - 'tscrollx', 05:01:58 INFO - 'cart']}, 05:01:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'talos_options': ['--disable-e10s'], 05:01:58 INFO - 'tests': ['tp5o']}, 05:01:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'tests': ['tp5o']}, 05:01:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'talos_options': ['--disable-e10s', 05:01:58 INFO - '--xperf_path', 05:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:58 INFO - 'tests': ['tp5n']}, 05:01:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:58 INFO - 'talos_options': ['--xperf_path', 05:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:58 INFO - 'tests': ['tp5n']}}, 05:01:58 INFO - 'talos.zip': {'path': '', 05:01:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:58 INFO - Running post-action listener: _resource_record_post_action 05:01:58 INFO - ##### 05:01:58 INFO - ##### Finished populate-webroot step (success) 05:01:58 INFO - ##### 05:01:58 INFO - ##### 05:01:58 INFO - ##### Running create-virtualenv step. 05:01:58 INFO - ##### 05:01:58 INFO - Running pre-action listener: _resource_record_pre_action 05:01:58 INFO - Running main action method: create_virtualenv 05:01:58 INFO - Creating virtualenv /builds/slave/test/build/venv 05:01:58 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 05:01:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:01:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:58 INFO - Using real prefix '/usr' 05:01:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:01:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:01 INFO - Installing pip.................done. 05:02:01 INFO - Return code: 0 05:02:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:01 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')]} 05:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 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')]} 05:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 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 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:01 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 05:02:01 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 05:02:01 INFO - Using env: {'DISPLAY': ':0', 05:02:01 INFO - 'HOME': '/home/cltbld', 05:02:01 INFO - 'LANG': 'en_US.UTF-8', 05:02:01 INFO - 'LANGUAGE': 'en_US:en', 05:02:01 INFO - 'LOGNAME': 'cltbld', 05:02:01 INFO - 'MAIL': '/var/mail/cltbld', 05:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:01 INFO - 'MOZ_NO_REMOTE': '1', 05:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:01 INFO - 'NO_EM_RESTART': '1', 05:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:01 INFO - 'PWD': '/builds/slave/test', 05:02:01 INFO - 'SHELL': '/bin/bash', 05:02:01 INFO - 'SHLVL': '1', 05:02:01 INFO - 'TERM': 'linux', 05:02:01 INFO - 'TMOUT': '86400', 05:02:01 INFO - 'USER': 'cltbld', 05:02:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:01 INFO - '_': '/tools/buildbot/bin/python'} 05:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:01 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 05:02:01 INFO - Cleaning up... 05:02:01 INFO - Return code: 0 05:02:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02:01 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')]} 05:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 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')]} 05:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 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 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:01 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 05:02:01 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 05:02:01 INFO - Using env: {'DISPLAY': ':0', 05:02:01 INFO - 'HOME': '/home/cltbld', 05:02:01 INFO - 'LANG': 'en_US.UTF-8', 05:02:01 INFO - 'LANGUAGE': 'en_US:en', 05:02:01 INFO - 'LOGNAME': 'cltbld', 05:02:01 INFO - 'MAIL': '/var/mail/cltbld', 05:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:01 INFO - 'MOZ_NO_REMOTE': '1', 05:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:01 INFO - 'NO_EM_RESTART': '1', 05:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:01 INFO - 'PWD': '/builds/slave/test', 05:02:01 INFO - 'SHELL': '/bin/bash', 05:02:01 INFO - 'SHLVL': '1', 05:02:01 INFO - 'TERM': 'linux', 05:02:01 INFO - 'TMOUT': '86400', 05:02:01 INFO - 'USER': 'cltbld', 05:02:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:01 INFO - '_': '/tools/buildbot/bin/python'} 05:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:01 INFO - Downloading/unpacking psutil>=3.1.1 05:02:01 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 05:02:01 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 05:02:01 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 05:02:01 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 05:02:01 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 05:02:01 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 05:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:03 INFO - Installing collected packages: psutil 05:02:03 INFO - Running setup.py install for psutil 05:02:03 INFO - building 'psutil._psutil_linux' extension 05:02:03 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 05:02:03 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 05:02:04 INFO - building 'psutil._psutil_posix' extension 05:02:04 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 05:02:04 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 05:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:04 INFO - Successfully installed psutil 05:02:04 INFO - Cleaning up... 05:02:04 INFO - Return code: 0 05:02:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:02:04 INFO - Using env: {'DISPLAY': ':0', 05:02:04 INFO - 'HOME': '/home/cltbld', 05:02:04 INFO - 'LANG': 'en_US.UTF-8', 05:02:04 INFO - 'LANGUAGE': 'en_US:en', 05:02:04 INFO - 'LOGNAME': 'cltbld', 05:02:04 INFO - 'MAIL': '/var/mail/cltbld', 05:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:04 INFO - 'MOZ_NO_REMOTE': '1', 05:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:04 INFO - 'NO_EM_RESTART': '1', 05:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:04 INFO - 'PWD': '/builds/slave/test', 05:02:04 INFO - 'SHELL': '/bin/bash', 05:02:04 INFO - 'SHLVL': '1', 05:02:04 INFO - 'TERM': 'linux', 05:02:04 INFO - 'TMOUT': '86400', 05:02:04 INFO - 'USER': 'cltbld', 05:02:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:04 INFO - '_': '/tools/buildbot/bin/python'} 05:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:04 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 05:02:04 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 05:02:04 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 05:02:04 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 05:02:04 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 05:02:04 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 05:02:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:06 INFO - Installing collected packages: mozsystemmonitor 05:02:06 INFO - Running setup.py install for mozsystemmonitor 05:02:06 INFO - Successfully installed mozsystemmonitor 05:02:06 INFO - Cleaning up... 05:02:06 INFO - Return code: 0 05:02:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:06 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')]} 05:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:06 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')]} 05:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:06 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 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:06 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 05:02:06 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 05:02:06 INFO - Using env: {'DISPLAY': ':0', 05:02:06 INFO - 'HOME': '/home/cltbld', 05:02:06 INFO - 'LANG': 'en_US.UTF-8', 05:02:06 INFO - 'LANGUAGE': 'en_US:en', 05:02:06 INFO - 'LOGNAME': 'cltbld', 05:02:06 INFO - 'MAIL': '/var/mail/cltbld', 05:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:06 INFO - 'MOZ_NO_REMOTE': '1', 05:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:06 INFO - 'NO_EM_RESTART': '1', 05:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:06 INFO - 'PWD': '/builds/slave/test', 05:02:06 INFO - 'SHELL': '/bin/bash', 05:02:06 INFO - 'SHLVL': '1', 05:02:06 INFO - 'TERM': 'linux', 05:02:06 INFO - 'TMOUT': '86400', 05:02:06 INFO - 'USER': 'cltbld', 05:02:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:06 INFO - '_': '/tools/buildbot/bin/python'} 05:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:06 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 05:02:06 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 05:02:06 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 05:02:06 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 05:02:06 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 05:02:06 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 05:02:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:08 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 05:02:08 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 05:02:08 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 05:02:08 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 05:02:08 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 05:02:08 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 05:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:09 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 05:02:09 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 05:02:09 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 05:02:09 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 05:02:09 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 05:02:09 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 05:02:09 INFO - Downloading docopt-0.6.1.tar.gz 05:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:09 INFO - Running setup.py install for blobuploader 05:02:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:09 INFO - Running setup.py install for requests 05:02:09 INFO - Running setup.py install for docopt 05:02:10 INFO - Successfully installed blobuploader requests docopt 05:02:10 INFO - Cleaning up... 05:02:10 INFO - Return code: 0 05:02:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:10 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 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:10 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 05:02:10 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 05:02:10 INFO - Using env: {'DISPLAY': ':0', 05:02:10 INFO - 'HOME': '/home/cltbld', 05:02:10 INFO - 'LANG': 'en_US.UTF-8', 05:02:10 INFO - 'LANGUAGE': 'en_US:en', 05:02:10 INFO - 'LOGNAME': 'cltbld', 05:02:10 INFO - 'MAIL': '/var/mail/cltbld', 05:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:10 INFO - 'MOZ_NO_REMOTE': '1', 05:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:10 INFO - 'NO_EM_RESTART': '1', 05:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:10 INFO - 'PWD': '/builds/slave/test', 05:02:10 INFO - 'SHELL': '/bin/bash', 05:02:10 INFO - 'SHLVL': '1', 05:02:10 INFO - 'TERM': 'linux', 05:02:10 INFO - 'TMOUT': '86400', 05:02:10 INFO - 'USER': 'cltbld', 05:02:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:10 INFO - '_': '/tools/buildbot/bin/python'} 05:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:10 INFO - Running setup.py (path:/tmp/pip-egjl2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:10 INFO - Running setup.py (path:/tmp/pip-O9GstO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:10 INFO - Running setup.py (path:/tmp/pip-bHbKwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:10 INFO - Running setup.py (path:/tmp/pip-ugnGhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:10 INFO - Running setup.py (path:/tmp/pip-PfAp3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:10 INFO - Running setup.py (path:/tmp/pip-va6KoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:10 INFO - Running setup.py (path:/tmp/pip-gZNcpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:10 INFO - Running setup.py (path:/tmp/pip-NMT8Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:10 INFO - Running setup.py (path:/tmp/pip-LoOQ6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:11 INFO - Running setup.py (path:/tmp/pip-jNXo0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:11 INFO - Running setup.py (path:/tmp/pip-cY5LbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:11 INFO - Running setup.py (path:/tmp/pip-NA3Ne1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:11 INFO - Running setup.py (path:/tmp/pip-p7M7u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:11 INFO - Running setup.py (path:/tmp/pip-QO15de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:11 INFO - Running setup.py (path:/tmp/pip-DQGfRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:11 INFO - Running setup.py (path:/tmp/pip-Tb1Y_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:11 INFO - Running setup.py (path:/tmp/pip-JrGat9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:11 INFO - Running setup.py install for manifestparser 05:02:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:11 INFO - Running setup.py install for mozcrash 05:02:11 INFO - Running setup.py install for mozdebug 05:02:11 INFO - Running setup.py install for mozdevice 05:02:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Running setup.py install for mozfile 05:02:12 INFO - Running setup.py install for mozhttpd 05:02:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Running setup.py install for mozinfo 05:02:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Running setup.py install for mozInstall 05:02:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Running setup.py install for mozleak 05:02:12 INFO - Running setup.py install for mozlog 05:02:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Running setup.py install for moznetwork 05:02:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Running setup.py install for mozprocess 05:02:12 INFO - Running setup.py install for mozprofile 05:02:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:12 INFO - Running setup.py install for mozrunner 05:02:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:13 INFO - Running setup.py install for mozscreenshot 05:02:13 INFO - Running setup.py install for moztest 05:02:13 INFO - Running setup.py install for mozversion 05:02:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:13 INFO - Cleaning up... 05:02:13 INFO - Return code: 0 05:02:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 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 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:13 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 05:02:13 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 05:02:13 INFO - Using env: {'DISPLAY': ':0', 05:02:13 INFO - 'HOME': '/home/cltbld', 05:02:13 INFO - 'LANG': 'en_US.UTF-8', 05:02:13 INFO - 'LANGUAGE': 'en_US:en', 05:02:13 INFO - 'LOGNAME': 'cltbld', 05:02:13 INFO - 'MAIL': '/var/mail/cltbld', 05:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:13 INFO - 'MOZ_NO_REMOTE': '1', 05:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:13 INFO - 'NO_EM_RESTART': '1', 05:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:13 INFO - 'PWD': '/builds/slave/test', 05:02:13 INFO - 'SHELL': '/bin/bash', 05:02:13 INFO - 'SHLVL': '1', 05:02:13 INFO - 'TERM': 'linux', 05:02:13 INFO - 'TMOUT': '86400', 05:02:13 INFO - 'USER': 'cltbld', 05:02:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:13 INFO - '_': '/tools/buildbot/bin/python'} 05:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:13 INFO - Running setup.py (path:/tmp/pip-5EV2G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:13 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)) 05:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:13 INFO - Running setup.py (path:/tmp/pip-94Ijj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:13 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)) 05:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:13 INFO - Running setup.py (path:/tmp/pip-wly9UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:13 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)) 05:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:13 INFO - Running setup.py (path:/tmp/pip-MGjiYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:13 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)) 05:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:13 INFO - Running setup.py (path:/tmp/pip-eqsBcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:13 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)) 05:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:13 INFO - Running setup.py (path:/tmp/pip-UT8mey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:14 INFO - Running setup.py (path:/tmp/pip-e7wfHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:14 INFO - Running setup.py (path:/tmp/pip-27Cgnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:14 INFO - Running setup.py (path:/tmp/pip-9k1IqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:14 INFO - Running setup.py (path:/tmp/pip-Fm2Sy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:14 INFO - Running setup.py (path:/tmp/pip-9XJ8Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:14 INFO - Running setup.py (path:/tmp/pip-RtVNi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:14 INFO - Running setup.py (path:/tmp/pip-_6Milm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:14 INFO - Running setup.py (path:/tmp/pip-G3xZRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:14 INFO - Running setup.py (path:/tmp/pip-Ta9Vc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:14 INFO - Running setup.py (path:/tmp/pip-rMWj0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:14 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)) 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:14 INFO - Running setup.py (path:/tmp/pip-DF9gG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:14 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)) 05:02:14 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)) 05:02:14 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)) 05:02:14 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)) 05:02:14 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)) 05:02:14 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)) 05:02:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:14 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 05:02:14 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 05:02:14 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 05:02:14 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 05:02:14 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 05:02:14 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 05:02:16 INFO - Downloading blessings-1.6.tar.gz 05:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:16 INFO - Installing collected packages: blessings 05:02:16 INFO - Running setup.py install for blessings 05:02:16 INFO - Successfully installed blessings 05:02:16 INFO - Cleaning up... 05:02:16 INFO - Return code: 0 05:02:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:17 INFO - Reading from file tmpfile_stdout 05:02:17 INFO - Current package versions: 05:02:17 INFO - argparse == 1.2.1 05:02:17 INFO - blessings == 1.6 05:02:17 INFO - blobuploader == 1.2.4 05:02:17 INFO - docopt == 0.6.1 05:02:17 INFO - manifestparser == 1.1 05:02:17 INFO - mozInstall == 1.12 05:02:17 INFO - mozcrash == 0.17 05:02:17 INFO - mozdebug == 0.1 05:02:17 INFO - mozdevice == 0.48 05:02:17 INFO - mozfile == 1.2 05:02:17 INFO - mozhttpd == 0.7 05:02:17 INFO - mozinfo == 0.9 05:02:17 INFO - mozleak == 0.1 05:02:17 INFO - mozlog == 3.2 05:02:17 INFO - moznetwork == 0.27 05:02:17 INFO - mozprocess == 0.22 05:02:17 INFO - mozprofile == 0.28 05:02:17 INFO - mozrunner == 6.11 05:02:17 INFO - mozscreenshot == 0.1 05:02:17 INFO - mozsystemmonitor == 0.3 05:02:17 INFO - moztest == 0.7 05:02:17 INFO - mozversion == 1.4 05:02:17 INFO - psutil == 3.1.1 05:02:17 INFO - requests == 1.2.3 05:02:17 INFO - wsgiref == 0.1.2 05:02:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:17 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 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:17 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 05:02:17 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 05:02:17 INFO - Using env: {'DISPLAY': ':0', 05:02:17 INFO - 'HOME': '/home/cltbld', 05:02:17 INFO - 'LANG': 'en_US.UTF-8', 05:02:17 INFO - 'LANGUAGE': 'en_US:en', 05:02:17 INFO - 'LOGNAME': 'cltbld', 05:02:17 INFO - 'MAIL': '/var/mail/cltbld', 05:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:17 INFO - 'MOZ_NO_REMOTE': '1', 05:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:17 INFO - 'NO_EM_RESTART': '1', 05:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:17 INFO - 'PWD': '/builds/slave/test', 05:02:17 INFO - 'SHELL': '/bin/bash', 05:02:17 INFO - 'SHLVL': '1', 05:02:17 INFO - 'TERM': 'linux', 05:02:17 INFO - 'TMOUT': '86400', 05:02:17 INFO - 'USER': 'cltbld', 05:02:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:17 INFO - '_': '/tools/buildbot/bin/python'} 05:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 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)) 05:02:17 INFO - Cleaning up... 05:02:17 INFO - Return code: 0 05:02:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:17 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 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:17 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 05:02:17 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 05:02:17 INFO - Using env: {'DISPLAY': ':0', 05:02:17 INFO - 'HOME': '/home/cltbld', 05:02:17 INFO - 'LANG': 'en_US.UTF-8', 05:02:17 INFO - 'LANGUAGE': 'en_US:en', 05:02:17 INFO - 'LOGNAME': 'cltbld', 05:02:17 INFO - 'MAIL': '/var/mail/cltbld', 05:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:17 INFO - 'MOZ_NO_REMOTE': '1', 05:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:17 INFO - 'NO_EM_RESTART': '1', 05:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:17 INFO - 'PWD': '/builds/slave/test', 05:02:17 INFO - 'SHELL': '/bin/bash', 05:02:17 INFO - 'SHLVL': '1', 05:02:17 INFO - 'TERM': 'linux', 05:02:17 INFO - 'TMOUT': '86400', 05:02:17 INFO - 'USER': 'cltbld', 05:02:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:17 INFO - '_': '/tools/buildbot/bin/python'} 05:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:17 INFO - Downloading/unpacking jsonschema 05:02:17 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 05:02:17 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 05:02:17 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 05:02:17 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 05:02:17 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 05:02:17 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 05:02:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:19 INFO - Downloading/unpacking functools32 (from jsonschema) 05:02:19 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 05:02:19 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 05:02:19 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 05:02:19 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 05:02:19 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 05:02:19 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 05:02:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:19 INFO - warning: no files found matching '*.txt' 05:02:19 INFO - no previously-included directories found matching 'build' 05:02:19 INFO - no previously-included directories found matching 'dist' 05:02:19 INFO - no previously-included directories found matching '.git*' 05:02:19 INFO - Installing collected packages: jsonschema, functools32 05:02:19 INFO - Running setup.py install for functools32 05:02:19 INFO - warning: no files found matching '*.txt' 05:02:19 INFO - no previously-included directories found matching 'build' 05:02:19 INFO - no previously-included directories found matching 'dist' 05:02:19 INFO - no previously-included directories found matching '.git*' 05:02:19 INFO - Successfully installed jsonschema functools32 05:02:19 INFO - Cleaning up... 05:02:20 INFO - Return code: 0 05:02:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0f4b07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1285770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', '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 05:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:02:20 INFO - Using env: {'DISPLAY': ':0', 05:02:20 INFO - 'HOME': '/home/cltbld', 05:02:20 INFO - 'LANG': 'en_US.UTF-8', 05:02:20 INFO - 'LANGUAGE': 'en_US:en', 05:02:20 INFO - 'LOGNAME': 'cltbld', 05:02:20 INFO - 'MAIL': '/var/mail/cltbld', 05:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:20 INFO - 'MOZ_NO_REMOTE': '1', 05:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:20 INFO - 'NO_EM_RESTART': '1', 05:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:20 INFO - 'PWD': '/builds/slave/test', 05:02:20 INFO - 'SHELL': '/bin/bash', 05:02:20 INFO - 'SHLVL': '1', 05:02:20 INFO - 'TERM': 'linux', 05:02:20 INFO - 'TMOUT': '86400', 05:02:20 INFO - 'USER': 'cltbld', 05:02:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:20 INFO - '_': '/tools/buildbot/bin/python'} 05:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:20 INFO - Downloading/unpacking flake8 05:02:20 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 05:02:20 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 05:02:20 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 05:02:20 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 05:02:20 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 05:02:20 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 05:02:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:02:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:02:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:02:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:22 INFO - no previously-included directories found matching 'docs/_build' 05:02:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:02:23 INFO - Running setup.py install for pep8 05:02:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:23 INFO - no previously-included directories found matching 'docs/_build' 05:02:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:02:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:02:23 INFO - Cleaning up... 05:02:23 INFO - Return code: 0 05:02:23 INFO - Running post-action listener: _resource_record_post_action 05:02:23 INFO - Running post-action listener: _start_resource_monitoring 05:02:23 INFO - Starting resource monitoring. 05:02:23 INFO - ##### 05:02:23 INFO - ##### Finished create-virtualenv step (success) 05:02:23 INFO - ##### 05:02:23 INFO - ##### 05:02:23 INFO - ##### Running install step. 05:02:23 INFO - ##### 05:02:23 INFO - Running pre-action listener: _resource_record_pre_action 05:02:23 INFO - Running main action method: install 05:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:23 INFO - Reading from file tmpfile_stdout 05:02:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:23 INFO - Reading from file tmpfile_stdout 05:02:23 INFO - Output received: 05:02:23 INFO - Usage: mozinstall [options] installer 05:02:23 INFO - Options: 05:02:23 INFO - -h, --help show this help message and exit 05:02:23 INFO - -d DEST, --destination=DEST 05:02:23 INFO - Directory to install application into. [default: 05:02:23 INFO - "/builds/slave/test"] 05:02:23 INFO - --app=APP Application being installed. [default: firefox] 05:02:23 INFO - mkdir: /builds/slave/test/build/application 05:02:23 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'] 05:02:23 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 05:02:39 INFO - Reading from file tmpfile_stdout 05:02:39 INFO - Output received: 05:02:39 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:39 INFO - Running post-action listener: _resource_record_post_action 05:02:39 INFO - ##### 05:02:39 INFO - ##### Finished install step (success) 05:02:39 INFO - ##### 05:02:39 INFO - ##### 05:02:39 INFO - ##### Running run-tests step. 05:02:39 INFO - ##### 05:02:39 INFO - Running pre-action listener: _resource_record_pre_action 05:02:39 INFO - Running main action method: run_tests 05:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:39 INFO - Python 2.7.3 05:02:39 INFO - Return code: 0 05:02:39 INFO - grabbing minidump binary from tooltool 05:02:39 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')]} 05:02:39 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 0x13149c0>, '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 0x13158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:39 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 05:02:39 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 05:02:39 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 05:02:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:39 INFO - Return code: 0 05:02:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:02:40 INFO - Return code: 0 05:02:40 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/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 05:02:40 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/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 05:02:40 INFO - Using env: {'DISPLAY': ':0', 05:02:40 INFO - 'HOME': '/home/cltbld', 05:02:40 INFO - 'LANG': 'en_US.UTF-8', 05:02:40 INFO - 'LANGUAGE': 'en_US:en', 05:02:40 INFO - 'LOGNAME': 'cltbld', 05:02:40 INFO - 'MAIL': '/var/mail/cltbld', 05:02:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:40 INFO - 'MOZ_NO_REMOTE': '1', 05:02:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:40 INFO - 'NO_EM_RESTART': '1', 05:02:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:40 INFO - 'PWD': '/builds/slave/test', 05:02:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:40 INFO - 'SHELL': '/bin/bash', 05:02:40 INFO - 'SHLVL': '1', 05:02:40 INFO - 'TERM': 'linux', 05:02:40 INFO - 'TMOUT': '86400', 05:02:40 INFO - 'USER': 'cltbld', 05:02:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760', 05:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:40 INFO - '_': '/tools/buildbot/bin/python'} 05:02:40 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/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 05:02:40 INFO - mozversion application_buildid: 20160525042639 05:02:40 INFO - mozversion application_changeset: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 05:02:40 INFO - mozversion application_display_name: Nightly 05:02:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:40 INFO - mozversion application_name: Firefox 05:02:40 INFO - mozversion application_remotingname: firefox 05:02:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:02:40 INFO - mozversion application_vendor: Mozilla 05:02:40 INFO - mozversion application_version: 49.0a1 05:02:40 INFO - mozversion platform_buildid: 20160525042639 05:02:40 INFO - mozversion platform_changeset: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 05:02:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:02:40 INFO - mozversion platform_version: 49.0a1 05:02:40 INFO - using testdate: 1464177760 05:02:40 INFO - actual date: 1464177760 05:02:40 INFO - starting webserver on 'localhost:38694' 05:02:40 INFO - SUITE-START | Running 2 tests 05:02:40 INFO - TEST-START | dromaeo_css 05:02:40 INFO - operating with platform_type : linux_ 05:02:40 INFO - Initialising browser for dromaeo_css test... 05:02:40 INFO - TEST-INFO | started process 22244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKoiIFK/profile http://localhost:38694/getInfo.html) 05:02:44 INFO - PROCESS | 22244 | __metrics Screen width/height:1600/1200 05:02:44 INFO - PROCESS | 22244 | colorDepth:24 05:02:44 INFO - PROCESS | 22244 | Browser inner width/height: 1024/697 05:02:44 INFO - PROCESS | 22244 | __metrics 05:02:45 ERROR - PROCESS | 22244 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:02:46 INFO - TEST-INFO | 22244: exit 0 05:02:46 INFO - Browser initialized. 05:02:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:46 INFO - TEST-INFO | started process 22324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKoiIFK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:58 INFO - PROCESS | 22324 | RSS: Main: 155107328 05:02:58 INFO - PROCESS | 22324 | 05:03:50 INFO - PROCESS | 22324 | 1464177830033 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] 05:06:01 INFO - PROCESS | 22324 | Cycle 1(1): loaded http://localhost:38694/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38694/tests/dromaeo/cssquery-ext.html) 05:06:02 INFO - PROCESS | 22324 | RSS: Main: 233689088 05:06:02 INFO - PROCESS | 22324 | 05:09:05 INFO - PROCESS | 22324 | Cycle 1(1): loaded http://localhost:38694/tests/dromaeo/cssquery-ext.html (next: http://localhost:38694/tests/dromaeo/cssquery-jquery.html) 05:09:05 INFO - PROCESS | 22324 | RSS: Main: 237400064 05:09:05 INFO - PROCESS | 22324 | 05:12:07 INFO - PROCESS | 22324 | Cycle 1(1): loaded http://localhost:38694/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38694/tests/dromaeo/cssquery-mootools.html) 05:12:08 INFO - PROCESS | 22324 | RSS: Main: 235638784 05:12:08 INFO - PROCESS | 22324 | 05:15:10 INFO - PROCESS | 22324 | Cycle 1(1): loaded http://localhost:38694/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38694/tests/dromaeo/cssquery-prototype.html) 05:15:11 INFO - PROCESS | 22324 | RSS: Main: 230256640 05:15:11 INFO - PROCESS | 22324 | 05:18:13 INFO - PROCESS | 22324 | Cycle 1(1): loaded http://localhost:38694/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38694/tests/dromaeo/cssquery-yui.html) 05:18:14 INFO - PROCESS | 22324 | RSS: Main: 227098624 05:18:14 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | Cycle 1(1): loaded http://localhost:38694/tests/dromaeo/cssquery-yui.html (next: http://localhost:38694/tests/dromaeo/cssquery-dojo.html) 05:21:17 INFO - PROCESS | 22324 | RSS: Main: 268722176 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | __start_tp_report 05:21:17 INFO - PROCESS | 22324 | _x_x_mozilla_page_load 05:21:17 INFO - PROCESS | 22324 | _x_x_mozilla_page_load_details 05:21:17 INFO - PROCESS | 22324 | |i|pagename|runs| 05:21:17 INFO - PROCESS | 22324 | |0;dojo.html;2662.6937902141253;2670.225634565976;2710.4172602890385;2714.9728502714975;2729.863506824658;4586.7477288749105;4661.440627124742;4696.788644510997;4774.999999999995;4814.759262036897;4652.837150699726;4670.626349892009;4721.2209985352465;4754.405699287589;4792.688475249106;4290.356446533014;4338.11068730911;4408.97795511022;4439.134368798085;4546.318052292149;4467.084247729208;4494.730316181023;4501.212287849629;4543.250363689987;4553.521880202581;4261.998430368861;4311.676624253194;4387.056782791683;4432.98041450465;4444.799984000711;4366.323219900921;4370.38814565961;4372;4467.195904737178;4469.82120715171;4384.342348647697;4401.427814384142;4404.8458303959205;4408;4451.132029254297;4521.163584736802;4613;4658.998315362213;4659.673822832403;4751;5084.3644544431945;5139.306193663882;5145.742712864342;5149.665271757362;5149.84550463483;5134.127198376248;5169.172932330846;5185.118529849935;5194.324737784102;5204.9219261711105;4598.724076555417;4707.552782485658;4758.357621721023;4758.571728544448;4794.9520504794855;5257.63196576236;5267.104592219332;5279.076161671692;5280.128778751539;5281.709505977131;5011.674241174312;5048.040872234264;5057;5057.165567681292;5063.518965698253;4930.186519224288;5049.722265275445;5118.820841270538;5128.538431541179;5146.25379320004;5066.265391518283;5091.032703786269;5094.541491265803;5095.031943930716;5149.433562308143;4891.119598472238;5091.287219789232;5091.541761241432;5098.082345177903;5102;4295.398644189816;4318.330658747899;4330.718503297276;4334.631556317685;4337.392765012901;3769.6984241260634;3772.641599048086;3775.5846856845724;3791.2227993261317;3813.980930095387;4282.76444795533;4317.11499142675;4424.13729322779;4425.579569940851;4462.687611867138;5072.365954255718;5099.6685215460875;5128.230765385222;5140.485951404829;5147.459516750762;4443.422355093817;4456.064226512404;4459.308807134835;4459.576340247671;4477.70894891831;4468.4414448193975;4548.295014272793;4658.510856360102;4661.696989695659;4693.24908014716;4760.952390476051;4780.784864681028;4798.640101992434;4804.111239420718;4843.39457567804;5088.949110508847;5091.796328146981;5092.694438333712;5092.821751238837;5127.2309153625765;4667.883302917454;4789.137955168103;4795.736234507136;4840.806367745392;4853.975730121327;5042.773075211698;5057.949420505748;5062.569681577107;5074.720890351066;5105.412877519133;5084.8220312288895;5143.099957507496;5143.459936706741;5148.150555158357;5186.066508028591;4835.032993401263;4909.189983652657;4956.702597844141;4967.4535801062575;4995.600351971906;4956.900861982812;4964.081644895706;4986.626003049858;4988.4263309719845;5032.144535429059;4895.314655948099;4912.754362281943;4917.1149193145575;4961;4964.578010868972;4844.878878028077;4929.014197160511;4940.382452193476;4979.0788704089855;4996.375453068366;4858.076965376567;4892.902141957212;4893.828715994923;4894.681845680019;4932.778024988956 05:21:17 INFO - PROCESS | 22324 | |1;ext.html;573.882354117406;586.9148973398858;604.054654465761;606.7724603273772;607.659710562085;40592.59407405925;42177.15645687092;42184;42200.36699449507;44989.77505112478;42471.15057698844;42932.570674293245;43002.7849860751;43034.56965430352;43090.7845460773;7777.611119444019;7933.246341597568;7955.681772729084;7958.124606293303;7961.363090952739;7768.611569421535;7890.80272993174;7896.210378962087;7896.763097107068;7900.881486777703;7836.764897053097;7879.645415956295;7886.329661978739;7887.369010479148;7887.684492620288;7817.491863028885;7848.607569621496;7857.410694197901;7862.882056769153;7867.6852925882895;7855.607219638995;7938.920610793876;7949.523028618301;7954.403419743542;7960.164182760785;38823;39002.60997390018;39184.41223381652;39205.21589568221;39281.21437571261;3303.223742420553;3551.5027896094566;3619.366610843092;3677.117491801975;3722.4230244312175;29032.274193145127;29224.538773061475;29261;30202.84898575515;30986.845065774753;3518.753687241894;3523.453864650983;3535.2399234164777;3597.1366871950804;3660.762050466711;261082;263247;263500.6824965882;263605;263986;46359.30461043087;47959;52871.20693189605;53703.46296536984;53861.192082118796;55199.44800552024;56853.431465685644;57096.14355784666;61791.6910415445;61831;14618.488352907598;14920.552383428514;14921.104733716013;14985.850141498446;14987.550373488813;9585.664501742545;10331.94834025825;10664.360138391567;10786.406747628798;10791.136709063256;15657.29542170605;16125.596860078593;16247.512574622544;16258;16294.918525407296;6225.750969961151;6349.682515874188;6370.331115232926;6410.775622853178;6435.742570297136;812.8861959325699;887.7869311365226;920.852663573825;928.2759447630858;987.896270891546;27292.727072729416;28330.43339133206;28735.856320718263;28761.280967975967;28869.422611547652;934.6027938126269;943.3726571829657;944.4239014201331;975.926805489577;1035.7514196592763;14655.193964331851;15497.225138743017;15965.44120955761;16705.164741762863;16719.582010449834;399304;403721;405254;405543;405724;49154.50845491499;50066;50170;50191.24713129306;50210.49789502131;1100.884407137255;1192.9403529823473;1224.614246512328;1225.4301749686438;1243.4777393494753;27582;28586.85706571454;29099.56130567362;29163.541822909196;29190.56214156832;41781.79109104435;41799;41973.580264196964;42228;42265.78867105645;306322;308021;308580.22777950094;308816;309871;21599.46001349979;24125.914333854667;24769.752302476743;24807.50384992326;26148.300360476507;42112.1049552777;42229.57770422257;42561.36157957695;42964.35553466638;43360.13279734451;36261.274774503836;36388.45417318795;36747.26505469929;37035.85195258433;37102.44346334861;36090;36218;36224.456633149995;36485.08787280339;36510.8174459126;35122.297554049284;35273.47089793706;35373.64626353703;35538.289234215685;36055;31209.8439507801;32405;32570.51144232791;32610.184745381554;32637.347253055283;24565;24867.87566062158;25132.371690707878;25368.873155634104;25552.616710748982 05:21:17 INFO - PROCESS | 22324 | |2;jquery.html;360.87008676876326;362.46174430970007;374.923140756145;382.661935573645;395.07749405139;15919.522414327574;16941.491755247363;17291.048992305434;17306.355896189874;17658.117094145306;15977.84022159778;16814.83185168148;16923.91538042308;17030.063346515937;17084.402045928364;4933.777979990909;5106.514881086309;5165.251038599401;5166.715830629314;5168.147255702805;3721.6464435878547;3891.805409729516;5092.439831618519;5586.162075688639;5911.940880591182;5923.05231163014;5937.079752638348;5950.880982380349;5959.493443057346;5966.254218222723;5672.773089076432;5906.084556893688;5907.7046147692445;5908.67502287374;5916.053431450947;3349.4975753636904;4888.70667759932;5106.08090543702;5162.92255616166;5178.637495375326;17684;17745.201465934064;17778.28886844525;20490.897545512325;20500.487487812774;1994.5312851479891;1999.660057790179;2057.372501387076;2082.802133797302;2177.5862586108747;12313.322767247797;13002.284874331908;13054.086213965027;13097.672558186121;13533.796993045113;1795.3626462605716;1875.5123667846458;2021;2057.2902348689677;2100.4433825036376;63503;66277.3372266276;66638;67403.32596674068;67751.32248677549;10047.447390393598;10059.5473203706;10080.899191008142;10203.38779673222;10746.408947507805;14079.788803167961;14091.71816563663;14186.574402767934;14197;14210.147391156564;7170.820729481805;7278.381337586365;7319.670614822346;7408.444366672521;7414.740484083031;6771.153605799275;6852.6916288767125;6870.072540207008;6895.896561551581;7011.509194356346;4331.112122014979;4437;4493.955060449419;4528.977355113203;4530.4110465639915;1723.5001849463765;1786.7498550202981;1802.0719329545295;1810.6913685051666;1820.6631773122015;784.2275358771606;864.2351518905688;909.8726178335038;920.7375897869075;956.4548207521785;16112.115284621475;16637.251323690463;16901.91549042247;16923.661526769396;17118.229679664444;861.7414775567305;869.4696235296464;870.6560908441257;875.5972252763672;883.6391956387221;9366.484843333546;9413.19987801031;9590.808183836285;9592.232621390272;9735.123838854537;360345;371567;375035;375359;375633;69189.30810691828;72886.6355668229;73139;73209.26790732131;73267;837.4138103327573;932.1191474056951;943.4527973775193;963.7783309838636;973.9464329461806;12824.743505130033;14922.328495217524;14937.551873443814;15655.921720391325;16027.118508481679;24461.38846528851;25362.74637253604;32464;32840.50739238865;32843;47259.291110634054;49975.25037124519;50056.499435005186;50407.747961259956;50879.49120508748;7567.243275672609;7755.844883102419;7785.92214077852;7788.727394541163;7802.804929876798;10512.947435262775;11206.775864482828;11305.15211359135;11317.547298107984;11530.711732206762;6800.029969281329;8282.840402343798;9681.854772178564;9737.80524389494;9940.204783617437;9740.853887191839;9822.410655360702;9822.803543928938;9846.409215447096;9959.352642078242;6055.485283750931;6057.061155520902;9471.242300616072;10055.39667619945;10150.340227885164;7556.622168891643;7602.619869006417;7717.2668596483245;7809.453338266267;7930.246626570467;9101.180893719596;9280.95359523198;9347.205487533636;10108.84836727435;10415.062644362044 05:21:17 INFO - PROCESS | 22324 | |3;mootools.html;1187.4062968515743;1401.3483730065518;1454.1783892100962;1569.8430156984302;1762.383165891938;6943.930560694398;7739.110002349731;8029.759107226792;8032.598370081494;8198.713045043425;7927;8097.797555061126;8113.188681131884;8116.228958248972;8119.147489513604;2229.1752051740837;2249.246502421691;2255.5037891663806;2260.062074239189;2260.525289689159;2171.8045375916163;2174.2064146586463;2177.346795961213;2179.7929196726286;2240.6863039174527;2186.9453263668374;2205.2722601541454;2212.070930209308;2215.5458131083087;2237.0827960536185;2138.134055707441;2160.243914629875;2160.3842904772064;2169.0889826272924;2170.6418440957223;2150.7741687122784;2160.0603737374295;2161.3407910587266;2162.502624396382;2164.177612507237;7880.724174653859;8041.115477297492;8061.2744852963515;8102.311303539206;8104.635291411901;4639.443266807971;4826.251930950708;4829;4829.058333624945;4830.082284365959;2936.9559456608167;2960.2007457986438;2973.4647763402577;3013.4123845850067;3016.3364059906785;915.7069737683944;917.7292698653913;919.595378033663;921.4931787516839;931.3434029009532;10694.946525267402;10771.138308935344;10817.296875703132;10818.837717434244;10842.512086956105;4014.337634290368;4082.1631565528996;4174.791260436966;4175.415441838145;4184.4141820145205;8557.614907329185;8645.783855403539;8645.827083458296;8659.653613855502;8675.739727808175;4596.7012144211185;4635.860924172281;4663.626909847272;4676.392069031004;4677.251639737626;3618.8914332570066;4162.105147393325;4312.956870431318;4321.2653848845775;4328.523862375137;3471.6181220065773;3484.738644601665;3553.5202747629255;3581.83881725323;3686.3548878946613;1017.8778546574458;1018.134585602247;1020.0258752890971;1026.645807196516;1050.6795427394566;867.2758246863939;893.5800173918248;895.1451363947415;896.3098414221014;907.4872696926348;5298.761555730001;5423.593230507728;5493.890122197534;5666.858328541819;5686.402927692533;926.5089502563652;937.1565590968047;970.6942313171328;975.1223898491272;987.5630956957609;3604.1530240393486;3736.514253147128;3776.15036616759;3798.3542797724454;3828.5405751310022;9572.90427095734;9686.07982241686;9735.464549449707;9851.211903047739;9858.95070524657;9470.668526601536;9694.418334899787;9708;9708.514574271258;9827.066428689262;7344.339009489065;7527.8118047048165;7543.962280188564;7575.393968482508;7586.848263034708;5451.809186678447;5626.915596266142;5670.206171135962;5724;5736.627119237236;9373.250139988648;9490.430574165572;9516.85724714116;9520.952395237979;9537.809243815223;9154.633814647606;9522.381045232038;9531.57107930131;9665.081817227352;9681.757956051155;7009.754658586925;7010.929890701028;7106.964465177641;7114.893276600752;7129.500934934505;7608.391328693802;7647.847043058996;7681.193474685301;7681.69273229087;7699.191584883507;6874.931250687429;6927.064846245894;6996.510244283055;7040.401565866959;7204.639768011683;6821.556598821061;6918.757843475454;6988.266232045562;6995.930040699732;7180.3896668781645;6245.96877015612;6271.937280627318;6374.203224596926;6388.073729309317;6389.808305750835;4670.416197975253;4748.358971538798;4763.404574428197;4769.3980173839955;4832.395950506187;4904.435989861069;4942.8517144484285;4946.727929963887;4974.925376119289;5003.3495645565845 05:21:17 INFO - PROCESS | 22324 | |4;prototype.html;292.4399774431963;294.5713986150151;297.75881535955875;302.36503342979745;304.22574547775935;4755.45447729488;4780.2590598457255;4815.27770834375;4836.733979631119;4855.465898751135;4744.5492678195515;4749.620030397568;4760.262159365296;4765.356676848624;4770.809167633291;3806.60030696777;3809.3714537101346;3809.9809500952456;3821.273957947995;3834.3098242316373;3535.2575959048504;3589.210373717791;3796.9620303797024;3806.5622453417795;3816.618338166189;3234.4016356974034;3616.9276614467826;3653.9269214615824;3683.705303575721;3719.5865571083086;3696.9260614787686;3786.7503723771088;3788.8295026723727;3803.8478460861534;3804.7907365094907;3366.0911553880314;3371.089805752458;3399.133221028622;3419.811320754719;3419.81191034493;4460.420145381079;4473.888152796174;4633.212353899845;4640.814367425299;4666.719996800203;4266.2320782259185;4276.572342765729;4289.957100428987;4305.74165550068;4321.82712691492;5021.9748901255625;5028.245763135523;5028.969061342416;5032.874178145539;5095.2676090129535;3520.9119772005647;3628.092976755811;3634.7637403568947;3713.257348530278;3715.8327875245677;5232.8283762238625;5237.711925844077;5242.397124330712;5243.475652434764;5275.683458992435;3776.150366167645;3794.924101517954;3801.163743976321;3811.6569508744346;3837.4627552142724;3739.6260373962386;3853.9807300963316;3880.564191249256;3887.1147493465646;3891.1828516011387;4304.720193187432;4319.272291083529;4319.935200971988;4324.416203812445;4359.367891655692;5002.849914502571;5010.1733214020005;5017.874553136201;5095.515925987025;5109.8722531937;1307.620460414253;1326.7346530693899;1329.2356894785537;1334.2261488336742;1335.152178366744;870.9956450217835;882.8543290357147;890.3767362846033;898.1377877237925;899.820035992791;4059.5534491205945;4068.3694027425204;4084.7957602119777;4115.835366585363;4136.689748268832;4660.464046634613;4669.369635099218;4673.299005149187;4691.7184968901975;4697.365855609517;3986.362182050858;4025.91948161041;4033.878983630496;4050.6151915567975;4079.673626109904;2327.7439481657;2487.7014758228765;2499.2002559180887;2507.6865391826022;2513.4219129600297;4407.206702793528;4431.379606855043;4451.977740111279;4718.197906355927;4778.546038126373;5314.92027619586;5323.600729945269;5332.400279916087;5341.359036915517;5349.759260833272;4901.6323775716255;4904.626704522668;4921.8523444296015;4922.237053256751;4945.554900059012;4885.316055752269;5136.5377116059735;5165.845024649267;5171.50870667286;5183.352080989876;4999.15014447552;5040.319556859924;5056.089903817348;5057.721825299644;5093.643444958965;4902.14212512816;4905.411350637946;4916.746229711401;4930.975345123252;4934.259861020875;3653.178034942117;3807.1243613969496;3814.256220037066;3817.522809648794;3823.1780167264174;5156.535911767959;5159.890623515962;5160.561352285098;5164.431912489698;5206.672298563842;4998.825041123689;5011.148104822116;5011.4487406386;5026.723530205873;5035.672681275705;4829.782659780248;5001.42483614389;5010.899782004267;5028.547430731105;5037.974810125926;4943.406791185081;4953.603711703127;4980.750962451791;4986.376702912136;4998.475160108136;5065.848024559269;5075.492450755042;5076.746162691777;5091.490850914879;5113;4784.521547845187;4825.5898248649255;4908.239222920453;4956.727379994135;4957.429895562056 05:21:17 INFO - PROCESS | 22324 | |5;yui.html;742.3022358982556;775.9612019399036;785.3403141361256;785.9960700196498;786.6145588661558;11693.532258709653;12446.066545009138;12474.625761227155;12485.625431237066;12494.625161245154;12113.939430302837;12186.293918851368;12192.146549741521;12246.938765306184;12261;631.6052467208007;777.6189667063155;801.6072124658933;803.8874557561946;803.9909913059132;796.4703472190986;803.4536515169682;803.9316658084069;805.8670319397322;806.399232571732;665.9400653941144;854.179987212277;854.6453221912899;855.8031652719878;856.9571521423935;827.1025936858485;854.7734850264685;854.7777577829747;855.4097672605944;855.683397143061;626.8119564130742;626.8777588370269;627.0093252660785;627.1658693937053;627.5199472403615;12065.457054432483;12101.93949030258;12143.271403715806;12206.816897746541;12214.877851221463;11749.177557570973;11957.94021029898;12163.270203787713;12241.755164896742;12561.309127998047;10874.565017399294;10915.235933484659;11012.50443730034;11041.061509771678;11106.333619982746;4029.6977726670325;4122.814473348676;4139.855105071339;4225.260579398624;4230.323148296288;44424;44574.10851782946;44575.77712111419;44942.55057449416;44945.550544494465;9277;9715.9028409715;9816.852747208797;9892.208623310118;10321.896781032243;16778.83221167797;16977.320907163823;16997.660046798996;17026.65946681084;17063.48809535716;6627.469802415795;6648.634325112069;6677;6750.3249675033085;6965.05971693825;3688.5942546319884;3747.7001839852746;3821.2357528494413;3845.288621605012;3865.1883104547796;2752.628395166667;2828;2830.6178665880257;2830.8584570771377;2831.5327970884987;493.990120197594;509.9082165210298;514.0618371472078;517.76700484782;540.4838379347714;593.6764463367475;611.1077826373545;611.8806832667676;612.908063790435;614.708013693492;7814.140444551095;7845.9215407845195;7908.3277921376175;8160.224778646019;8232.876506852403;576.9826905192851;582.1645938078871;588.3459949881634;620.0053740433694;631.4664108828033;3768.962310376916;3773.754705944105;3825.713071519647;3906.0820707133803;4084.959150408458;49218.75390623024;50480.49519504758;50492.24261636078;55339;58426.7078664604;47517.76241118772;48311.516884831406;48654.75672621685;48980.26529602059;49800.25299620508;45919.24484530872;46009.30986035212;46721.53278467172;46815.29777053347;46886.76556617263;8369.121242269473;8453.070162282267;8459.365547583833;8478.872816907875;8544.102869198645;30552.694473054984;31131.53302700416;31762.52356214705;31823.36353272968;32497;35819.462708058876;35995.46006809952;39081.80459097686;40051.399229011;41100;10817.459127043774;11071.612493562687;11209.383483908137;11282.097432205239;11544.769104618028;11715.472803724024;11800.350980696145;11911.285322880654;12103;12610.117291789853;11427.771444571228;11452.427378631202;11498.425078745862;11541.192116551762;11550.711232219262;11105.500252488819;11336.319820810777;11778.646640600795;11871.347075910908;11924.523019079139;11255.66233013011;11371;11891.167618266638;11913.52345906154;12028.15802893789;9364.391314564531;9407.905920940977;9461.38500997433;9595;9728.270379721691;9266.953665231631;9280.58237379333;9288;9324.300677449082;9338.95330523343 05:21:17 INFO - PROCESS | 22324 | __end_tp_report 05:21:17 INFO - PROCESS | 22324 | __start_cc_report 05:21:17 INFO - PROCESS | 22324 | _x_x_mozilla_cycle_collect,1037 05:21:17 INFO - PROCESS | 22324 | __end_cc_report 05:21:17 INFO - PROCESS | 22324 | __startTimestamp1464178877819__endTimestamp 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | ------- Summary: start ------- 05:21:17 INFO - PROCESS | 22324 | Number of tests: 6 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | [#0] dojo.html Cycles:165 Average:4718.22 Median:4835.03 stddev:490.40 (10.1%) stddev-sans-first:464.64 05:21:17 INFO - PROCESS | 22324 | Values: 2662.7 2670.2 2710.4 2715.0 2729.9 4586.7 4661.4 4696.8 4775.0 4814.8 4652.8 4670.6 4721.2 4754.4 4792.7 4290.4 4338.1 4409.0 4439.1 4546.3 4467.1 4494.7 4501.2 4543.3 4553.5 4262.0 4311.7 4387.1 4433.0 4444.8 4366.3 4370.4 4372.0 4467.2 4469.8 4384.3 4401.4 4404.8 4408.0 4451.1 4521.2 4613.0 4659.0 4659.7 4751.0 5084.4 5139.3 5145.7 5149.7 5149.8 5134.1 5169.2 5185.1 5194.3 5204.9 4598.7 4707.6 4758.4 4758.6 4795.0 5257.6 5267.1 5279.1 5280.1 5281.7 5011.7 5048.0 5057.0 5057.2 5063.5 4930.2 5049.7 5118.8 5128.5 5146.3 5066.3 5091.0 5094.5 5095.0 5149.4 4891.1 5091.3 5091.5 5098.1 5102.0 4295.4 4318.3 4330.7 4334.6 4337.4 3769.7 3772.6 3775.6 3791.2 3814.0 4282.8 4317.1 4424.1 4425.6 4462.7 5072.4 5099.7 5128.2 5140.5 5147.5 4443.4 4456.1 4459.3 4459.6 4477.7 4468.4 4548.3 4658.5 4661.7 4693.2 4761.0 4780.8 4798.6 4804.1 4843.4 5088.9 5091.8 5092.7 5092.8 5127.2 4667.9 4789.1 4795.7 4840.8 4854.0 5042.8 5057.9 5062.6 5074.7 5105.4 5084.8 5143.1 5143.5 5148.2 5186.1 4835.0 4909.2 4956.7 4967.5 4995.6 4956.9 4964.1 4986.6 4988.4 5032.1 4895.3 4912.8 4917.1 4961.0 4964.6 4844.9 4929.0 4940.4 4979.1 4996.4 4858.1 4892.9 4893.8 4894.7 4932.8 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | [#1] ext.html Cycles:180 Average:48190.27 Median:38912.80 stddev:87012.62 (223.6%) stddev-sans-first:87183.26 05:21:17 INFO - PROCESS | 22324 | Values: 573.9 586.9 604.1 606.8 607.7 40592.6 42177.2 42184.0 42200.4 44989.8 42471.2 42932.6 43002.8 43034.6 43090.8 7777.6 7933.2 7955.7 7958.1 7961.4 7768.6 7890.8 7896.2 7896.8 7900.9 7836.8 7879.6 7886.3 7887.4 7887.7 7817.5 7848.6 7857.4 7862.9 7867.7 7855.6 7938.9 7949.5 7954.4 7960.2 38823.0 39002.6 39184.4 39205.2 39281.2 3303.2 3551.5 3619.4 3677.1 3722.4 29032.3 29224.5 29261.0 30202.8 30986.8 3518.8 3523.5 3535.2 3597.1 3660.8 261082.0 263247.0 263500.7 263605.0 263986.0 46359.3 47959.0 52871.2 53703.5 53861.2 55199.4 56853.4 57096.1 61791.7 61831.0 14618.5 14920.6 14921.1 14985.9 14987.6 9585.7 10331.9 10664.4 10786.4 10791.1 15657.3 16125.6 16247.5 16258.0 16294.9 6225.8 6349.7 6370.3 6410.8 6435.7 812.9 887.8 920.9 928.3 987.9 27292.7 28330.4 28735.9 28761.3 28869.4 934.6 943.4 944.4 975.9 1035.8 14655.2 15497.2 15965.4 16705.2 16719.6 399304.0 403721.0 405254.0 405543.0 405724.0 49154.5 50066.0 50170.0 50191.2 50210.5 1100.9 1192.9 1224.6 1225.4 1243.5 27582.0 28586.9 29099.6 29163.5 29190.6 41781.8 41799.0 41973.6 42228.0 42265.8 306322.0 308021.0 308580.2 308816.0 309871.0 21599.5 24125.9 24769.8 24807.5 26148.3 42112.1 42229.6 42561.4 42964.4 43360.1 36261.3 36388.5 36747.3 37035.9 37102.4 36090.0 36218.0 36224.5 36485.1 36510.8 35122.3 35273.5 35373.6 35538.3 36055.0 31209.8 32405.0 32570.5 32610.2 32637.3 24565.0 24867.9 25132.4 25368.9 25552.6 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | [#2] jquery.html Cycles:180 Average:23281.40 Median:50015.87 stddev:61285.11 (122.5%) stddev-sans-first:61432.86 05:21:17 INFO - PROCESS | 22324 | Values: 360.9 362.5 374.9 382.7 395.1 15919.5 16941.5 17291.0 17306.4 17658.1 15977.8 16814.8 16923.9 17030.1 17084.4 4933.8 5106.5 5165.3 5166.7 5168.1 3721.6 3891.8 5092.4 5586.2 5911.9 5923.1 5937.1 5950.9 5959.5 5966.3 5672.8 5906.1 5907.7 5908.7 5916.1 3349.5 4888.7 5106.1 5162.9 5178.6 17684.0 17745.2 17778.3 20490.9 20500.5 1994.5 1999.7 2057.4 2082.8 2177.6 12313.3 13002.3 13054.1 13097.7 13533.8 1795.4 1875.5 2021.0 2057.3 2100.4 63503.0 66277.3 66638.0 67403.3 67751.3 10047.4 10059.5 10080.9 10203.4 10746.4 14079.8 14091.7 14186.6 14197.0 14210.1 7170.8 7278.4 7319.7 7408.4 7414.7 6771.2 6852.7 6870.1 6895.9 7011.5 4331.1 4437.0 4494.0 4529.0 4530.4 1723.5 1786.7 1802.1 1810.7 1820.7 784.2 864.2 909.9 920.7 956.5 16112.1 16637.3 16901.9 16923.7 17118.2 861.7 869.5 870.7 875.6 883.6 9366.5 9413.2 9590.8 9592.2 9735.1 360345.0 371567.0 375035.0 375359.0 375633.0 69189.3 72886.6 73139.0 73209.3 73267.0 837.4 932.1 943.5 963.8 973.9 12824.7 14922.3 14937.6 15655.9 16027.1 24461.4 25362.7 32464.0 32840.5 32843.0 47259.3 49975.3 50056.5 50407.7 50879.5 7567.2 7755.8 7785.9 7788.7 7802.8 10512.9 11206.8 11305.2 11317.5 11530.7 6800.0 8282.8 9681.9 9737.8 9940.2 9740.9 9822.4 9822.8 9846.4 9959.4 6055.5 6057.1 9471.2 10055.4 10150.3 7556.6 7602.6 7717.3 7809.5 7930.2 9101.2 9281.0 9347.2 10108.8 10415.1 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | [#3] mootools.html Cycles:180 Average:5262.18 Median:5668.53 stddev:2947.96 (52.0%) stddev-sans-first:2940.33 05:21:17 INFO - PROCESS | 22324 | Values: 1187.4 1401.3 1454.2 1569.8 1762.4 6943.9 7739.1 8029.8 8032.6 8198.7 7927.0 8097.8 8113.2 8116.2 8119.1 2229.2 2249.2 2255.5 2260.1 2260.5 2171.8 2174.2 2177.3 2179.8 2240.7 2186.9 2205.3 2212.1 2215.5 2237.1 2138.1 2160.2 2160.4 2169.1 2170.6 2150.8 2160.1 2161.3 2162.5 2164.2 7880.7 8041.1 8061.3 8102.3 8104.6 4639.4 4826.3 4829.0 4829.1 4830.1 2937.0 2960.2 2973.5 3013.4 3016.3 915.7 917.7 919.6 921.5 931.3 10694.9 10771.1 10817.3 10818.8 10842.5 4014.3 4082.2 4174.8 4175.4 4184.4 8557.6 8645.8 8645.8 8659.7 8675.7 4596.7 4635.9 4663.6 4676.4 4677.3 3618.9 4162.1 4313.0 4321.3 4328.5 3471.6 3484.7 3553.5 3581.8 3686.4 1017.9 1018.1 1020.0 1026.6 1050.7 867.3 893.6 895.1 896.3 907.5 5298.8 5423.6 5493.9 5666.9 5686.4 926.5 937.2 970.7 975.1 987.6 3604.2 3736.5 3776.2 3798.4 3828.5 9572.9 9686.1 9735.5 9851.2 9859.0 9470.7 9694.4 9708.0 9708.5 9827.1 7344.3 7527.8 7544.0 7575.4 7586.8 5451.8 5626.9 5670.2 5724.0 5736.6 9373.3 9490.4 9516.9 9521.0 9537.8 9154.6 9522.4 9531.6 9665.1 9681.8 7009.8 7010.9 7107.0 7114.9 7129.5 7608.4 7647.8 7681.2 7681.7 7699.2 6874.9 6927.1 6996.5 7040.4 7204.6 6821.6 6918.8 6988.3 6995.9 7180.4 6246.0 6271.9 6374.2 6388.1 6389.8 4670.4 4748.4 4763.4 4769.4 4832.4 4904.4 4942.9 4946.7 4974.9 5003.3 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | [#4] prototype.html Cycles:180 Average:4145.47 Median:4682.51 stddev:1199.74 (25.6%) stddev-sans-first:1167.73 05:21:17 INFO - PROCESS | 22324 | Values: 292.4 294.6 297.8 302.4 304.2 4755.5 4780.3 4815.3 4836.7 4855.5 4744.5 4749.6 4760.3 4765.4 4770.8 3806.6 3809.4 3810.0 3821.3 3834.3 3535.3 3589.2 3797.0 3806.6 3816.6 3234.4 3616.9 3653.9 3683.7 3719.6 3696.9 3786.8 3788.8 3803.8 3804.8 3366.1 3371.1 3399.1 3419.8 3419.8 4460.4 4473.9 4633.2 4640.8 4666.7 4266.2 4276.6 4290.0 4305.7 4321.8 5022.0 5028.2 5029.0 5032.9 5095.3 3520.9 3628.1 3634.8 3713.3 3715.8 5232.8 5237.7 5242.4 5243.5 5275.7 3776.2 3794.9 3801.2 3811.7 3837.5 3739.6 3854.0 3880.6 3887.1 3891.2 4304.7 4319.3 4319.9 4324.4 4359.4 5002.8 5010.2 5017.9 5095.5 5109.9 1307.6 1326.7 1329.2 1334.2 1335.2 871.0 882.9 890.4 898.1 899.8 4059.6 4068.4 4084.8 4115.8 4136.7 4660.5 4669.4 4673.3 4691.7 4697.4 3986.4 4025.9 4033.9 4050.6 4079.7 2327.7 2487.7 2499.2 2507.7 2513.4 4407.2 4431.4 4452.0 4718.2 4778.5 5314.9 5323.6 5332.4 5341.4 5349.8 4901.6 4904.6 4921.9 4922.2 4945.6 4885.3 5136.5 5165.8 5171.5 5183.4 4999.2 5040.3 5056.1 5057.7 5093.6 4902.1 4905.4 4916.7 4931.0 4934.3 3653.2 3807.1 3814.3 3817.5 3823.2 5156.5 5159.9 5160.6 5164.4 5206.7 4998.8 5011.1 5011.4 5026.7 5035.7 4829.8 5001.4 5010.9 5028.5 5038.0 4943.4 4953.6 4980.8 4986.4 4998.5 5065.8 5075.5 5076.7 5091.5 5113.0 4784.5 4825.6 4908.2 4956.7 4957.4 05:21:17 INFO - PROCESS | 22324 | 05:21:17 INFO - PROCESS | 22324 | [#5] yui.html Cycles:180 Average:13059.01 Median:45432.40 stddev:14809.58 (32.6%) stddev-sans-first:14822.24 05:21:17 INFO - PROCESS | 22324 | Values: 742.3 776.0 785.3 786.0 786.6 11693.5 12446.1 12474.6 12485.6 12494.6 12113.9 12186.3 12192.1 12246.9 12261.0 631.6 777.6 801.6 803.9 804.0 796.5 803.5 803.9 805.9 806.4 665.9 854.2 854.6 855.8 857.0 827.1 854.8 854.8 855.4 855.7 626.8 626.9 627.0 627.2 627.5 12065.5 12101.9 12143.3 12206.8 12214.9 11749.2 11957.9 12163.3 12241.8 12561.3 10874.6 10915.2 11012.5 11041.1 11106.3 4029.7 4122.8 4139.9 4225.3 4230.3 44424.0 44574.1 44575.8 44942.6 44945.6 9277.0 9715.9 9816.9 9892.2 10321.9 16778.8 16977.3 16997.7 17026.7 17063.5 6627.5 6648.6 6677.0 6750.3 6965.1 3688.6 3747.7 3821.2 3845.3 3865.2 2752.6 2828.0 2830.6 2830.9 2831.5 494.0 509.9 514.1 517.8 540.5 593.7 611.1 611.9 612.9 614.7 7814.1 7845.9 7908.3 8160.2 8232.9 577.0 582.2 588.3 620.0 631.5 3769.0 3773.8 3825.7 3906.1 4085.0 49218.8 50480.5 50492.2 55339.0 58426.7 47517.8 48311.5 48654.8 48980.3 49800.3 45919.2 46009.3 46721.5 46815.3 46886.8 8369.1 8453.1 8459.4 8478.9 8544.1 30552.7 31131.5 31762.5 31823.4 32497.0 35819.5 35995.5 39081.8 40051.4 41100.0 10817.5 11071.6 11209.4 11282.1 11544.8 11715.5 11800.4 11911.3 12103.0 12610.1 11427.8 11452.4 11498.4 11541.2 11550.7 11105.5 11336.3 11778.6 11871.3 11924.5 11255.7 11371.0 11891.2 11913.5 12028.2 9364.4 9407.9 9461.4 9595.0 9728.3 9267.0 9280.6 9288.0 9324.3 9339.0 05:21:17 INFO - PROCESS | 22324 | -------- Summary: end -------- 05:21:17 INFO - PROCESS | 22324 | 05:21:18 INFO - TEST-INFO | 22324: exit 0 05:21:18 INFO - TEST-OK | dromaeo_css | took 1118073ms 05:21:18 INFO - TEST-START | kraken 05:21:18 INFO - operating with platform_type : linux_ 05:21:18 INFO - Initialising browser for kraken test... 05:21:18 INFO - TEST-INFO | started process 22504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptdJaAZ/profile http://localhost:38694/getInfo.html) 05:21:22 INFO - PROCESS | 22504 | __metrics Screen width/height:1600/1200 05:21:22 INFO - PROCESS | 22504 | colorDepth:24 05:21:22 INFO - PROCESS | 22504 | Browser inner width/height: 1024/697 05:21:22 INFO - PROCESS | 22504 | __metrics 05:21:23 ERROR - PROCESS | 22504 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:21:24 INFO - TEST-INFO | 22504: exit 0 05:21:24 INFO - Browser initialized. 05:21:24 INFO - Running cycle 1/1 for kraken test... 05:21:24 INFO - TEST-INFO | started process 22582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptdJaAZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:36 INFO - PROCESS | 22582 | RSS: Main: 154939392 05:21:36 INFO - PROCESS | 22582 | 05:21:39 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38694/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:40 INFO - PROCESS | 22582 | RSS: Main: 211152896 05:21:40 INFO - PROCESS | 22582 | 05:21:42 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38694/tests/kraken/driver.html?testName=audio-dft) 05:21:43 INFO - PROCESS | 22582 | RSS: Main: 199098368 05:21:43 INFO - PROCESS | 22582 | 05:21:46 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38694/tests/kraken/driver.html?testName=audio-fft) 05:21:47 INFO - PROCESS | 22582 | RSS: Main: 268070912 05:21:47 INFO - PROCESS | 22582 | 05:21:49 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38694/tests/kraken/driver.html?testName=audio-oscillator) 05:21:50 INFO - PROCESS | 22582 | RSS: Main: 176467968 05:21:50 INFO - PROCESS | 22582 | 05:21:52 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38694/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:52 INFO - PROCESS | 22582 | RSS: Main: 180854784 05:21:52 INFO - PROCESS | 22582 | 05:21:56 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38694/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:56 INFO - PROCESS | 22582 | RSS: Main: 216526848 05:21:56 INFO - PROCESS | 22582 | 05:22:00 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38694/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:00 INFO - PROCESS | 22582 | RSS: Main: 217088000 05:22:00 INFO - PROCESS | 22582 | 05:22:03 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38694/tests/kraken/driver.html?testName=json-parse-financial) 05:22:04 INFO - PROCESS | 22582 | RSS: Main: 217489408 05:22:04 INFO - PROCESS | 22582 | 05:22:06 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38694/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:06 INFO - PROCESS | 22582 | RSS: Main: 204787712 05:22:06 INFO - PROCESS | 22582 | 05:22:08 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:09 INFO - PROCESS | 22582 | RSS: Main: 208142336 05:22:09 INFO - PROCESS | 22582 | 05:22:11 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:12 INFO - PROCESS | 22582 | RSS: Main: 220434432 05:22:12 INFO - PROCESS | 22582 | 05:22:14 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:15 INFO - PROCESS | 22582 | RSS: Main: 226611200 05:22:15 INFO - PROCESS | 22582 | 05:22:18 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:18 INFO - PROCESS | 22582 | RSS: Main: 222117888 05:22:18 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:38694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38694/tests/kraken/driver.html?testName=ai-astar) 05:22:20 INFO - PROCESS | 22582 | RSS: Main: 267468800 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | __start_tp_report 05:22:20 INFO - PROCESS | 22582 | _x_x_mozilla_page_load 05:22:20 INFO - PROCESS | 22582 | _x_x_mozilla_page_load_details 05:22:20 INFO - PROCESS | 22582 | |i|pagename|runs| 05:22:20 INFO - PROCESS | 22582 | |0;ai-astar;112;107;115;111;112;113;111;111;112;111 05:22:20 INFO - PROCESS | 22582 | |1;audio-beat-detection;159;130;133;193;131;140;160;130;165;133 05:22:20 INFO - PROCESS | 22582 | |2;audio-dft;161;162;161;162;160;161;162;161;162;162 05:22:20 INFO - PROCESS | 22582 | |3;audio-fft;74;75;75;106;75;76;74;75;97;75 05:22:20 INFO - PROCESS | 22582 | |4;audio-oscillator;85;85;125;86;86;85;112;84;83;123 05:22:20 INFO - PROCESS | 22582 | |5;imaging-gaussian-blur;116;116;116;117;116;116;117;117;117;117 05:22:20 INFO - PROCESS | 22582 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;146;146 05:22:20 INFO - PROCESS | 22582 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 05:22:20 INFO - PROCESS | 22582 | |8;json-parse-financial;63;63;64;63;63;65;64;80;62;62 05:22:20 INFO - PROCESS | 22582 | |9;json-stringify-tinderbox;64;66;65;65;65;64;65;65;65;65 05:22:20 INFO - PROCESS | 22582 | |10;stanford-crypto-aes;88;82;82;82;88;87;84;87;84;82 05:22:20 INFO - PROCESS | 22582 | |11;stanford-crypto-ccm;133;133;132;144;140;131;126;129;182;128 05:22:20 INFO - PROCESS | 22582 | |12;stanford-crypto-pbkdf2;169;166;169;173;172;173;168;170;166;165 05:22:20 INFO - PROCESS | 22582 | |13;stanford-crypto-sha256-iterative;65;65;67;67;66;67;68;64;69;66 05:22:20 INFO - PROCESS | 22582 | __end_tp_report 05:22:20 INFO - PROCESS | 22582 | __start_cc_report 05:22:20 INFO - PROCESS | 22582 | _x_x_mozilla_cycle_collect,1915 05:22:20 INFO - PROCESS | 22582 | __end_cc_report 05:22:20 INFO - PROCESS | 22582 | __startTimestamp1464178940871__endTimestamp 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | ------- Summary: start ------- 05:22:20 INFO - PROCESS | 22582 | Number of tests: 14 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.01 (1.8%) stddev-sans-first:2.13 05:22:20 INFO - PROCESS | 22582 | Values: 112.0 107.0 115.0 111.0 112.0 113.0 111.0 111.0 112.0 111.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:149.50 stddev:21.15 (14.1%) stddev-sans-first:22.01 05:22:20 INFO - PROCESS | 22582 | Values: 159.0 130.0 133.0 193.0 131.0 140.0 160.0 130.0 165.0 133.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 05:22:20 INFO - PROCESS | 22582 | Values: 161.0 162.0 161.0 162.0 160.0 161.0 162.0 161.0 162.0 162.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.44 (15.3%) stddev-sans-first:11.91 05:22:20 INFO - PROCESS | 22582 | Values: 74.0 75.0 75.0 106.0 75.0 76.0 74.0 75.0 97.0 75.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:17.32 (20.4%) stddev-sans-first:17.95 05:22:20 INFO - PROCESS | 22582 | Values: 85.0 85.0 125.0 86.0 86.0 85.0 112.0 84.0 83.0 123.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:22:20 INFO - PROCESS | 22582 | Values: 116.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:22:20 INFO - PROCESS | 22582 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:22:20 INFO - PROCESS | 22582 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:63.50 stddev:5.38 (8.5%) stddev-sans-first:5.67 05:22:20 INFO - PROCESS | 22582 | Values: 63.0 63.0 64.0 63.0 63.0 65.0 64.0 80.0 62.0 62.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 05:22:20 INFO - PROCESS | 22582 | Values: 64.0 66.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.50 stddev:2.63 (3.1%) stddev-sans-first:2.49 05:22:20 INFO - PROCESS | 22582 | Values: 88.0 82.0 82.0 82.0 88.0 87.0 84.0 87.0 84.0 82.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:133.00 stddev:16.45 (12.4%) stddev-sans-first:17.36 05:22:20 INFO - PROCESS | 22582 | Values: 133.0 133.0 132.0 144.0 140.0 131.0 126.0 129.0 182.0 128.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.50 stddev:2.92 (1.7%) stddev-sans-first:3.10 05:22:20 INFO - PROCESS | 22582 | Values: 169.0 166.0 169.0 173.0 172.0 173.0 168.0 170.0 166.0 165.0 05:22:20 INFO - PROCESS | 22582 | 05:22:20 INFO - PROCESS | 22582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.51 (2.2%) stddev-sans-first:1.51 05:22:20 INFO - PROCESS | 22582 | Values: 65.0 65.0 67.0 67.0 66.0 67.0 68.0 64.0 69.0 66.0 05:22:20 INFO - PROCESS | 22582 | -------- Summary: end -------- 05:22:20 INFO - PROCESS | 22582 | 05:22:21 INFO - TEST-INFO | 22582: exit 0 05:22:21 INFO - TEST-OK | kraken | took 63297ms 05:22:21 INFO - SUITE-END | took 1181s 05:22:22 INFO - Completed test suite (00:19:41) 05:22:22 INFO - javascript benchmark 05:22:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.6937902141253, 2670.225634565976, 2710.4172602890385, 2714.9728502714975, 2729.863506824658, 4586.7477288749105, 4661.440627124742, 4696.788644510997, 4774.999999999995, 4814.759262036897, 4652.837150699726, 4670.626349892009, 4721.2209985352465, 4754.405699287589, 4792.688475249106, 4290.356446533014, 4338.11068730911, 4408.97795511022, 4439.134368798085, 4546.318052292149, 4467.084247729208, 4494.730316181023, 4501.212287849629, 4543.250363689987, 4553.521880202581, 4261.998430368861, 4311.676624253194, 4387.056782791683, 4432.98041450465, 4444.799984000711, 4366.323219900921, 4370.38814565961, 4372.0, 4467.195904737178, 4469.82120715171, 4384.342348647697, 4401.427814384142, 4404.8458303959205, 4408.0, 4451.132029254297, 4521.163584736802, 4613.0, 4658.998315362213, 4659.673822832403, 4751.0, 5084.3644544431945, 5139.306193663882, 5145.742712864342, 5149.665271757362, 5149.84550463483, 5134.127198376248, 5169.172932330846, 5185.118529849935, 5194.324737784102, 5204.9219261711105, 4598.724076555417, 4707.552782485658, 4758.357621721023, 4758.571728544448, 4794.9520504794855, 5257.63196576236, 5267.104592219332, 5279.076161671692, 5280.128778751539, 5281.709505977131, 5011.674241174312, 5048.040872234264, 5057.0, 5057.165567681292, 5063.518965698253, 4930.186519224288, 5049.722265275445, 5118.820841270538, 5128.538431541179, 5146.25379320004, 5066.265391518283, 5091.032703786269, 5094.541491265803, 5095.031943930716, 5149.433562308143, 4891.119598472238, 5091.287219789232, 5091.541761241432, 5098.082345177903, 5102.0, 4295.398644189816, 4318.330658747899, 4330.718503297276, 4334.631556317685, 4337.392765012901, 3769.6984241260634, 3772.641599048086, 3775.5846856845724, 3791.2227993261317, 3813.980930095387, 4282.76444795533, 4317.11499142675, 4424.13729322779, 4425.579569940851, 4462.687611867138, 5072.365954255718, 5099.6685215460875, 5128.230765385222, 5140.485951404829, 5147.459516750762, 4443.422355093817, 4456.064226512404, 4459.308807134835, 4459.576340247671, 4477.70894891831, 4468.4414448193975, 4548.295014272793, 4658.510856360102, 4661.696989695659, 4693.24908014716, 4760.952390476051, 4780.784864681028, 4798.640101992434, 4804.111239420718, 4843.39457567804, 5088.949110508847, 5091.796328146981, 5092.694438333712, 5092.821751238837, 5127.2309153625765, 4667.883302917454, 4789.137955168103, 4795.736234507136, 4840.806367745392, 4853.975730121327, 5042.773075211698, 5057.949420505748, 5062.569681577107, 5074.720890351066, 5105.412877519133, 5084.8220312288895, 5143.099957507496, 5143.459936706741, 5148.150555158357, 5186.066508028591, 4835.032993401263, 4909.189983652657, 4956.702597844141, 4967.4535801062575, 4995.600351971906, 4956.900861982812, 4964.081644895706, 4986.626003049858, 4988.4263309719845, 5032.144535429059, 4895.314655948099, 4912.754362281943, 4917.1149193145575, 4961.0, 4964.578010868972, 4844.878878028077, 4929.014197160511, 4940.382452193476, 4979.0788704089855, 4996.375453068366, 4858.076965376567, 4892.902141957212, 4893.828715994923, 4894.681845680019, 4932.778024988956], "value": 4687.447752474872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.882354117406, 586.9148973398858, 604.054654465761, 606.7724603273772, 607.659710562085, 40592.59407405925, 42177.15645687092, 42184.0, 42200.36699449507, 44989.77505112478, 42471.15057698844, 42932.570674293245, 43002.7849860751, 43034.56965430352, 43090.7845460773, 7777.611119444019, 7933.246341597568, 7955.681772729084, 7958.124606293303, 7961.363090952739, 7768.611569421535, 7890.80272993174, 7896.210378962087, 7896.763097107068, 7900.881486777703, 7836.764897053097, 7879.645415956295, 7886.329661978739, 7887.369010479148, 7887.684492620288, 7817.491863028885, 7848.607569621496, 7857.410694197901, 7862.882056769153, 7867.6852925882895, 7855.607219638995, 7938.920610793876, 7949.523028618301, 7954.403419743542, 7960.164182760785, 38823.0, 39002.60997390018, 39184.41223381652, 39205.21589568221, 39281.21437571261, 3303.223742420553, 3551.5027896094566, 3619.366610843092, 3677.117491801975, 3722.4230244312175, 29032.274193145127, 29224.538773061475, 29261.0, 30202.84898575515, 30986.845065774753, 3518.753687241894, 3523.453864650983, 3535.2399234164777, 3597.1366871950804, 3660.762050466711, 261082.0, 263247.0, 263500.6824965882, 263605.0, 263986.0, 46359.30461043087, 47959.0, 52871.20693189605, 53703.46296536984, 53861.192082118796, 55199.44800552024, 56853.431465685644, 57096.14355784666, 61791.6910415445, 61831.0, 14618.488352907598, 14920.552383428514, 14921.104733716013, 14985.850141498446, 14987.550373488813, 9585.664501742545, 10331.94834025825, 10664.360138391567, 10786.406747628798, 10791.136709063256, 15657.29542170605, 16125.596860078593, 16247.512574622544, 16258.0, 16294.918525407296, 6225.750969961151, 6349.682515874188, 6370.331115232926, 6410.775622853178, 6435.742570297136, 812.8861959325699, 887.7869311365226, 920.852663573825, 928.2759447630858, 987.896270891546, 27292.727072729416, 28330.43339133206, 28735.856320718263, 28761.280967975967, 28869.422611547652, 934.6027938126269, 943.3726571829657, 944.4239014201331, 975.926805489577, 1035.7514196592763, 14655.193964331851, 15497.225138743017, 15965.44120955761, 16705.164741762863, 16719.582010449834, 399304.0, 403721.0, 405254.0, 405543.0, 405724.0, 49154.50845491499, 50066.0, 50170.0, 50191.24713129306, 50210.49789502131, 1100.884407137255, 1192.9403529823473, 1224.614246512328, 1225.4301749686438, 1243.4777393494753, 27582.0, 28586.85706571454, 29099.56130567362, 29163.541822909196, 29190.56214156832, 41781.79109104435, 41799.0, 41973.580264196964, 42228.0, 42265.78867105645, 306322.0, 308021.0, 308580.22777950094, 308816.0, 309871.0, 21599.46001349979, 24125.914333854667, 24769.752302476743, 24807.50384992326, 26148.300360476507, 42112.1049552777, 42229.57770422257, 42561.36157957695, 42964.35553466638, 43360.13279734451, 36261.274774503836, 36388.45417318795, 36747.26505469929, 37035.85195258433, 37102.44346334861, 36090.0, 36218.0, 36224.456633149995, 36485.08787280339, 36510.8174459126, 35122.297554049284, 35273.47089793706, 35373.64626353703, 35538.289234215685, 36055.0, 31209.8439507801, 32405.0, 32570.51144232791, 32610.184745381554, 32637.347253055283, 24565.0, 24867.87566062158, 25132.371690707878, 25368.873155634104, 25552.616710748982], "value": 17715.437897111788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.87008676876326, 362.46174430970007, 374.923140756145, 382.661935573645, 395.07749405139, 15919.522414327574, 16941.491755247363, 17291.048992305434, 17306.355896189874, 17658.117094145306, 15977.84022159778, 16814.83185168148, 16923.91538042308, 17030.063346515937, 17084.402045928364, 4933.777979990909, 5106.514881086309, 5165.251038599401, 5166.715830629314, 5168.147255702805, 3721.6464435878547, 3891.805409729516, 5092.439831618519, 5586.162075688639, 5911.940880591182, 5923.05231163014, 5937.079752638348, 5950.880982380349, 5959.493443057346, 5966.254218222723, 5672.773089076432, 5906.084556893688, 5907.7046147692445, 5908.67502287374, 5916.053431450947, 3349.4975753636904, 4888.70667759932, 5106.08090543702, 5162.92255616166, 5178.637495375326, 17684.0, 17745.201465934064, 17778.28886844525, 20490.897545512325, 20500.487487812774, 1994.5312851479891, 1999.660057790179, 2057.372501387076, 2082.802133797302, 2177.5862586108747, 12313.322767247797, 13002.284874331908, 13054.086213965027, 13097.672558186121, 13533.796993045113, 1795.3626462605716, 1875.5123667846458, 2021.0, 2057.2902348689677, 2100.4433825036376, 63503.0, 66277.3372266276, 66638.0, 67403.32596674068, 67751.32248677549, 10047.447390393598, 10059.5473203706, 10080.899191008142, 10203.38779673222, 10746.408947507805, 14079.788803167961, 14091.71816563663, 14186.574402767934, 14197.0, 14210.147391156564, 7170.820729481805, 7278.381337586365, 7319.670614822346, 7408.444366672521, 7414.740484083031, 6771.153605799275, 6852.6916288767125, 6870.072540207008, 6895.896561551581, 7011.509194356346, 4331.112122014979, 4437.0, 4493.955060449419, 4528.977355113203, 4530.4110465639915, 1723.5001849463765, 1786.7498550202981, 1802.0719329545295, 1810.6913685051666, 1820.6631773122015, 784.2275358771606, 864.2351518905688, 909.8726178335038, 920.7375897869075, 956.4548207521785, 16112.115284621475, 16637.251323690463, 16901.91549042247, 16923.661526769396, 17118.229679664444, 861.7414775567305, 869.4696235296464, 870.6560908441257, 875.5972252763672, 883.6391956387221, 9366.484843333546, 9413.19987801031, 9590.808183836285, 9592.232621390272, 9735.123838854537, 360345.0, 371567.0, 375035.0, 375359.0, 375633.0, 69189.30810691828, 72886.6355668229, 73139.0, 73209.26790732131, 73267.0, 837.4138103327573, 932.1191474056951, 943.4527973775193, 963.7783309838636, 973.9464329461806, 12824.743505130033, 14922.328495217524, 14937.551873443814, 15655.921720391325, 16027.118508481679, 24461.38846528851, 25362.74637253604, 32464.0, 32840.50739238865, 32843.0, 47259.291110634054, 49975.25037124519, 50056.499435005186, 50407.747961259956, 50879.49120508748, 7567.243275672609, 7755.844883102419, 7785.92214077852, 7788.727394541163, 7802.804929876798, 10512.947435262775, 11206.775864482828, 11305.15211359135, 11317.547298107984, 11530.711732206762, 6800.029969281329, 8282.840402343798, 9681.854772178564, 9737.80524389494, 9940.204783617437, 9740.853887191839, 9822.410655360702, 9822.803543928938, 9846.409215447096, 9959.352642078242, 6055.485283750931, 6057.061155520902, 9471.242300616072, 10055.39667619945, 10150.340227885164, 7556.622168891643, 7602.619869006417, 7717.2668596483245, 7809.453338266267, 7930.246626570467, 9101.180893719596, 9280.95359523198, 9347.205487533636, 10108.84836727435, 10415.062644362044], "value": 8113.243340200166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.4062968515743, 1401.3483730065518, 1454.1783892100962, 1569.8430156984302, 1762.383165891938, 6943.930560694398, 7739.110002349731, 8029.759107226792, 8032.598370081494, 8198.713045043425, 7927.0, 8097.797555061126, 8113.188681131884, 8116.228958248972, 8119.147489513604, 2229.1752051740837, 2249.246502421691, 2255.5037891663806, 2260.062074239189, 2260.525289689159, 2171.8045375916163, 2174.2064146586463, 2177.346795961213, 2179.7929196726286, 2240.6863039174527, 2186.9453263668374, 2205.2722601541454, 2212.070930209308, 2215.5458131083087, 2237.0827960536185, 2138.134055707441, 2160.243914629875, 2160.3842904772064, 2169.0889826272924, 2170.6418440957223, 2150.7741687122784, 2160.0603737374295, 2161.3407910587266, 2162.502624396382, 2164.177612507237, 7880.724174653859, 8041.115477297492, 8061.2744852963515, 8102.311303539206, 8104.635291411901, 4639.443266807971, 4826.251930950708, 4829.0, 4829.058333624945, 4830.082284365959, 2936.9559456608167, 2960.2007457986438, 2973.4647763402577, 3013.4123845850067, 3016.3364059906785, 915.7069737683944, 917.7292698653913, 919.595378033663, 921.4931787516839, 931.3434029009532, 10694.946525267402, 10771.138308935344, 10817.296875703132, 10818.837717434244, 10842.512086956105, 4014.337634290368, 4082.1631565528996, 4174.791260436966, 4175.415441838145, 4184.4141820145205, 8557.614907329185, 8645.783855403539, 8645.827083458296, 8659.653613855502, 8675.739727808175, 4596.7012144211185, 4635.860924172281, 4663.626909847272, 4676.392069031004, 4677.251639737626, 3618.8914332570066, 4162.105147393325, 4312.956870431318, 4321.2653848845775, 4328.523862375137, 3471.6181220065773, 3484.738644601665, 3553.5202747629255, 3581.83881725323, 3686.3548878946613, 1017.8778546574458, 1018.134585602247, 1020.0258752890971, 1026.645807196516, 1050.6795427394566, 867.2758246863939, 893.5800173918248, 895.1451363947415, 896.3098414221014, 907.4872696926348, 5298.761555730001, 5423.593230507728, 5493.890122197534, 5666.858328541819, 5686.402927692533, 926.5089502563652, 937.1565590968047, 970.6942313171328, 975.1223898491272, 987.5630956957609, 3604.1530240393486, 3736.514253147128, 3776.15036616759, 3798.3542797724454, 3828.5405751310022, 9572.90427095734, 9686.07982241686, 9735.464549449707, 9851.211903047739, 9858.95070524657, 9470.668526601536, 9694.418334899787, 9708.0, 9708.514574271258, 9827.066428689262, 7344.339009489065, 7527.8118047048165, 7543.962280188564, 7575.393968482508, 7586.848263034708, 5451.809186678447, 5626.915596266142, 5670.206171135962, 5724.0, 5736.627119237236, 9373.250139988648, 9490.430574165572, 9516.85724714116, 9520.952395237979, 9537.809243815223, 9154.633814647606, 9522.381045232038, 9531.57107930131, 9665.081817227352, 9681.757956051155, 7009.754658586925, 7010.929890701028, 7106.964465177641, 7114.893276600752, 7129.500934934505, 7608.391328693802, 7647.847043058996, 7681.193474685301, 7681.69273229087, 7699.191584883507, 6874.931250687429, 6927.064846245894, 6996.510244283055, 7040.401565866959, 7204.639768011683, 6821.556598821061, 6918.757843475454, 6988.266232045562, 6995.930040699732, 7180.3896668781645, 6245.96877015612, 6271.937280627318, 6374.203224596926, 6388.073729309317, 6389.808305750835, 4670.416197975253, 4748.358971538798, 4763.404574428197, 4769.3980173839955, 4832.395950506187, 4904.435989861069, 4942.8517144484285, 4946.727929963887, 4974.925376119289, 5003.3495645565845], "value": 4226.1965176148415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.4399774431963, 294.5713986150151, 297.75881535955875, 302.36503342979745, 304.22574547775935, 4755.45447729488, 4780.2590598457255, 4815.27770834375, 4836.733979631119, 4855.465898751135, 4744.5492678195515, 4749.620030397568, 4760.262159365296, 4765.356676848624, 4770.809167633291, 3806.60030696777, 3809.3714537101346, 3809.9809500952456, 3821.273957947995, 3834.3098242316373, 3535.2575959048504, 3589.210373717791, 3796.9620303797024, 3806.5622453417795, 3816.618338166189, 3234.4016356974034, 3616.9276614467826, 3653.9269214615824, 3683.705303575721, 3719.5865571083086, 3696.9260614787686, 3786.7503723771088, 3788.8295026723727, 3803.8478460861534, 3804.7907365094907, 3366.0911553880314, 3371.089805752458, 3399.133221028622, 3419.811320754719, 3419.81191034493, 4460.420145381079, 4473.888152796174, 4633.212353899845, 4640.814367425299, 4666.719996800203, 4266.2320782259185, 4276.572342765729, 4289.957100428987, 4305.74165550068, 4321.82712691492, 5021.9748901255625, 5028.245763135523, 5028.969061342416, 5032.874178145539, 5095.2676090129535, 3520.9119772005647, 3628.092976755811, 3634.7637403568947, 3713.257348530278, 3715.8327875245677, 5232.8283762238625, 5237.711925844077, 5242.397124330712, 5243.475652434764, 5275.683458992435, 3776.150366167645, 3794.924101517954, 3801.163743976321, 3811.6569508744346, 3837.4627552142724, 3739.6260373962386, 3853.9807300963316, 3880.564191249256, 3887.1147493465646, 3891.1828516011387, 4304.720193187432, 4319.272291083529, 4319.935200971988, 4324.416203812445, 4359.367891655692, 5002.849914502571, 5010.1733214020005, 5017.874553136201, 5095.515925987025, 5109.8722531937, 1307.620460414253, 1326.7346530693899, 1329.2356894785537, 1334.2261488336742, 1335.152178366744, 870.9956450217835, 882.8543290357147, 890.3767362846033, 898.1377877237925, 899.820035992791, 4059.5534491205945, 4068.3694027425204, 4084.7957602119777, 4115.835366585363, 4136.689748268832, 4660.464046634613, 4669.369635099218, 4673.299005149187, 4691.7184968901975, 4697.365855609517, 3986.362182050858, 4025.91948161041, 4033.878983630496, 4050.6151915567975, 4079.673626109904, 2327.7439481657, 2487.7014758228765, 2499.2002559180887, 2507.6865391826022, 2513.4219129600297, 4407.206702793528, 4431.379606855043, 4451.977740111279, 4718.197906355927, 4778.546038126373, 5314.92027619586, 5323.600729945269, 5332.400279916087, 5341.359036915517, 5349.759260833272, 4901.6323775716255, 4904.626704522668, 4921.8523444296015, 4922.237053256751, 4945.554900059012, 4885.316055752269, 5136.5377116059735, 5165.845024649267, 5171.50870667286, 5183.352080989876, 4999.15014447552, 5040.319556859924, 5056.089903817348, 5057.721825299644, 5093.643444958965, 4902.14212512816, 4905.411350637946, 4916.746229711401, 4930.975345123252, 4934.259861020875, 3653.178034942117, 3807.1243613969496, 3814.256220037066, 3817.522809648794, 3823.1780167264174, 5156.535911767959, 5159.890623515962, 5160.561352285098, 5164.431912489698, 5206.672298563842, 4998.825041123689, 5011.148104822116, 5011.4487406386, 5026.723530205873, 5035.672681275705, 4829.782659780248, 5001.42483614389, 5010.899782004267, 5028.547430731105, 5037.974810125926, 4943.406791185081, 4953.603711703127, 4980.750962451791, 4986.376702912136, 4998.475160108136, 5065.848024559269, 5075.492450755042, 5076.746162691777, 5091.490850914879, 5113.0, 4784.521547845187, 4825.5898248649255, 4908.239222920453, 4956.727379994135, 4957.429895562056], "value": 3768.8563676395943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.3022358982556, 775.9612019399036, 785.3403141361256, 785.9960700196498, 786.6145588661558, 11693.532258709653, 12446.066545009138, 12474.625761227155, 12485.625431237066, 12494.625161245154, 12113.939430302837, 12186.293918851368, 12192.146549741521, 12246.938765306184, 12261.0, 631.6052467208007, 777.6189667063155, 801.6072124658933, 803.8874557561946, 803.9909913059132, 796.4703472190986, 803.4536515169682, 803.9316658084069, 805.8670319397322, 806.399232571732, 665.9400653941144, 854.179987212277, 854.6453221912899, 855.8031652719878, 856.9571521423935, 827.1025936858485, 854.7734850264685, 854.7777577829747, 855.4097672605944, 855.683397143061, 626.8119564130742, 626.8777588370269, 627.0093252660785, 627.1658693937053, 627.5199472403615, 12065.457054432483, 12101.93949030258, 12143.271403715806, 12206.816897746541, 12214.877851221463, 11749.177557570973, 11957.94021029898, 12163.270203787713, 12241.755164896742, 12561.309127998047, 10874.565017399294, 10915.235933484659, 11012.50443730034, 11041.061509771678, 11106.333619982746, 4029.6977726670325, 4122.814473348676, 4139.855105071339, 4225.260579398624, 4230.323148296288, 44424.0, 44574.10851782946, 44575.77712111419, 44942.55057449416, 44945.550544494465, 9277.0, 9715.9028409715, 9816.852747208797, 9892.208623310118, 10321.896781032243, 16778.83221167797, 16977.320907163823, 16997.660046798996, 17026.65946681084, 17063.48809535716, 6627.469802415795, 6648.634325112069, 6677.0, 6750.3249675033085, 6965.05971693825, 3688.5942546319884, 3747.7001839852746, 3821.2357528494413, 3845.288621605012, 3865.1883104547796, 2752.628395166667, 2828.0, 2830.6178665880257, 2830.8584570771377, 2831.5327970884987, 493.990120197594, 509.9082165210298, 514.0618371472078, 517.76700484782, 540.4838379347714, 593.6764463367475, 611.1077826373545, 611.8806832667676, 612.908063790435, 614.708013693492, 7814.140444551095, 7845.9215407845195, 7908.3277921376175, 8160.224778646019, 8232.876506852403, 576.9826905192851, 582.1645938078871, 588.3459949881634, 620.0053740433694, 631.4664108828033, 3768.962310376916, 3773.754705944105, 3825.713071519647, 3906.0820707133803, 4084.959150408458, 49218.75390623024, 50480.49519504758, 50492.24261636078, 55339.0, 58426.7078664604, 47517.76241118772, 48311.516884831406, 48654.75672621685, 48980.26529602059, 49800.25299620508, 45919.24484530872, 46009.30986035212, 46721.53278467172, 46815.29777053347, 46886.76556617263, 8369.121242269473, 8453.070162282267, 8459.365547583833, 8478.872816907875, 8544.102869198645, 30552.694473054984, 31131.53302700416, 31762.52356214705, 31823.36353272968, 32497.0, 35819.462708058876, 35995.46006809952, 39081.80459097686, 40051.399229011, 41100.0, 10817.459127043774, 11071.612493562687, 11209.383483908137, 11282.097432205239, 11544.769104618028, 11715.472803724024, 11800.350980696145, 11911.285322880654, 12103.0, 12610.117291789853, 11427.771444571228, 11452.427378631202, 11498.425078745862, 11541.192116551762, 11550.711232219262, 11105.500252488819, 11336.319820810777, 11778.646640600795, 11871.347075910908, 11924.523019079139, 11255.66233013011, 11371.0, 11891.167618266638, 11913.52345906154, 12028.15802893789, 9364.391314564531, 9407.905920940977, 9461.38500997433, 9595.0, 9728.270379721691, 9266.953665231631, 9280.58237379333, 9288.0, 9324.300677449082, 9338.95330523343], "value": 6062.093036677827, "unit": "score"}], "name": "dromaeo_css", "value": 6341.894649431302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 115.0, 111.0, 112.0, 113.0, 111.0, 111.0, 112.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 133.0, 193.0, 131.0, 140.0, 160.0, 130.0, 165.0, 133.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 162.0, 161.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 106.0, 75.0, 76.0, 74.0, 75.0, 97.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 125.0, 86.0, 86.0, 85.0, 112.0, 84.0, 83.0, 123.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 65.0, 64.0, 80.0, 62.0, 62.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 82.0, 82.0, 88.0, 87.0, 84.0, 87.0, 84.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 132.0, 144.0, 140.0, 131.0, 126.0, 129.0, 182.0, 128.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 169.0, 173.0, 172.0, 173.0, 168.0, 170.0, 166.0, 165.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 67.0, 66.0, 67.0, 68.0, 64.0, 69.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1540.8999999999999, "alertThreshold": 2.0}]} 05:22:22 INFO - Return code: 0 05:22:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:22:22 ERROR - # TBPL SUCCESS # 05:22:22 INFO - Running post-action listener: _resource_record_post_action 05:22:22 INFO - ##### 05:22:22 INFO - ##### Finished run-tests step (success) 05:22:22 INFO - ##### 05:22:22 INFO - Running post-run listener: _resource_record_post_run 05:22:22 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 520974336; Read time: 0; Write time: 399864 05:22:22 INFO - TinderboxPrint: CPU usage
13.1% 05:22:22 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:22:22 INFO - TinderboxPrint: I/O write bytes / time
520,974,336 / 399,864 05:22:22 INFO - TinderboxPrint: CPU idle
8,306.0 (86.9%) 05:22:22 INFO - TinderboxPrint: CPU user
1,214.7 (12.7%) 05:22:22 INFO - TinderboxPrint: Swap in / out
0 / 0 05:22:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 215179264; Read time: 0; Write time: 198544 05:22:22 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 281661440; Read time: 0; Write time: 196620 05:22:22 INFO - Running post-run listener: _upload_blobber_files 05:22:22 INFO - Blob upload gear active. 05:22:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:22 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 05:22:22 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'] 05:22:22 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 05:22:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:24 INFO - (blobuploader) - INFO - Done attempting. 05:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:24 INFO - (blobuploader) - INFO - Done attempting. 05:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:29 INFO - (blobuploader) - INFO - Done attempting. 05:22:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:29 INFO - Return code: 0 05:22:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9856f07dd860d926a6b127226b308b40601ea23b99a5e3e76b46ba5cee1fba0f3330842afa144a51c528b9bc99ba90231171fb5e7b1ccd97ce5a670350c81c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a78003de4b8e39967d579a7b61a758377405a681505c51618b0f09a6b7e4a43b3418541f96f59fae020dedda2e91113711b008f5fb6f19c6a52d016e1068dad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54782335bd09abd0b73613d5f1fc7c7a7d1c37beb0e11547e3491922fdd5e5092a99936e8dd04cdcb6674e16eb9b1f35e8fad9961d4f70dd44d668c86e16fc7"} 05:22:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:29 INFO - Contents: 05:22:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9856f07dd860d926a6b127226b308b40601ea23b99a5e3e76b46ba5cee1fba0f3330842afa144a51c528b9bc99ba90231171fb5e7b1ccd97ce5a670350c81c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a78003de4b8e39967d579a7b61a758377405a681505c51618b0f09a6b7e4a43b3418541f96f59fae020dedda2e91113711b008f5fb6f19c6a52d016e1068dad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54782335bd09abd0b73613d5f1fc7c7a7d1c37beb0e11547e3491922fdd5e5092a99936e8dd04cdcb6674e16eb9b1f35e8fad9961d4f70dd44d668c86e16fc7"} 05:22:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:29 INFO - Copying logs to upload dir... 05:22:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.290763 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-25 05:22:29.393037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:22:29.397042) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760 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/9856f07dd860d926a6b127226b308b40601ea23b99a5e3e76b46ba5cee1fba0f3330842afa144a51c528b9bc99ba90231171fb5e7b1ccd97ce5a670350c81c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a78003de4b8e39967d579a7b61a758377405a681505c51618b0f09a6b7e4a43b3418541f96f59fae020dedda2e91113711b008f5fb6f19c6a52d016e1068dad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54782335bd09abd0b73613d5f1fc7c7a7d1c37beb0e11547e3491922fdd5e5092a99936e8dd04cdcb6674e16eb9b1f35e8fad9961d4f70dd44d668c86e16fc7"} build_url:https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011515 build_url: 'https://queue.taskcluster.net/v1/task/F-ZheurtQpGdj6yLN_z2nQ/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/9856f07dd860d926a6b127226b308b40601ea23b99a5e3e76b46ba5cee1fba0f3330842afa144a51c528b9bc99ba90231171fb5e7b1ccd97ce5a670350c81c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a78003de4b8e39967d579a7b61a758377405a681505c51618b0f09a6b7e4a43b3418541f96f59fae020dedda2e91113711b008f5fb6f19c6a52d016e1068dad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54782335bd09abd0b73613d5f1fc7c7a7d1c37beb0e11547e3491922fdd5e5092a99936e8dd04cdcb6674e16eb9b1f35e8fad9961d4f70dd44d668c86e16fc7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:22:29.422814) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:22:29.423154) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464177624.855175-566593760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:22:29.506560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:22:29.506896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:22:29.507234) ========= ========= Total master_lag: 0.18 =========