builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1464772018.04 results: success (0) buildid: 20160601003956 builduid: 317cf23392f64494986208a3893ab652 revision: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.040966) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.041447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.041746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.057605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.058023) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 02:06:58-- 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% 77.5M=0s 2016-06-01 02:06:58 (77.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114470 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.186828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.187150) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.236621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.237009) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a --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 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a --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=6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 02:06:58,902 truncating revision to first 12 chars 2016-06-01 02:06:58,902 Setting DEBUG logging. 2016-06-01 02:06:58,902 attempt 1/10 2016-06-01 02:06:58,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/78e2125dfb6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 02:06:59,248 unpacking tar archive at: fx-team-78e2125dfb6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.923582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.923959) ========= script_repo_revision: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.924360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.924625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 02:06:58.934063) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 02:06:58.934465) ========= /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=6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:06:59 INFO - MultiFileLogger online at 20160601 02:06:59 in /builds/slave/test 02:06:59 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 02:06:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:06:59 INFO - {'append_to_log': False, 02:06:59 INFO - 'base_work_dir': '/builds/slave/test', 02:06:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:06:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:06:59 INFO - 'branch': 'Fx-Team-Non-PGO', 02:06:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:06:59 INFO - 'config_files': ('talos/linux_config.py',), 02:06:59 INFO - 'default_actions': ('clobber', 02:06:59 INFO - 'read-buildbot-config', 02:06:59 INFO - 'download-and-extract', 02:06:59 INFO - 'populate-webroot', 02:06:59 INFO - 'create-virtualenv', 02:06:59 INFO - 'install', 02:06:59 INFO - 'run-tests'), 02:06:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:06:59 INFO - 'download_minidump_stackwalk': True, 02:06:59 INFO - 'download_symbols': 'ondemand', 02:06:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:06:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:06:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:06:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:06:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:06:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:06:59 INFO - 'installer_path': 'installer.exe', 02:06:59 INFO - 'log_level': 'info', 02:06:59 INFO - 'log_name': 'talos', 02:06:59 INFO - 'log_to_console': True, 02:06:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:06:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:06:59 INFO - 'opt_config_files': (), 02:06:59 INFO - 'pip_index': False, 02:06:59 INFO - 'sps_profile': False, 02:06:59 INFO - 'sps_profile_interval': 0, 02:06:59 INFO - 'suite': 'dromaeojs', 02:06:59 INFO - 'system_bits': '32', 02:06:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:06:59 INFO - 'title': 'talos-linux64-ix-023', 02:06:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:06:59 INFO - 'use_talos_json': True, 02:06:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:06:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:06:59 INFO - 'work_dir': 'build'} 02:06:59 INFO - ##### 02:06:59 INFO - ##### Running clobber step. 02:06:59 INFO - ##### 02:06:59 INFO - Running pre-action listener: _resource_record_pre_action 02:06:59 INFO - Running main action method: clobber 02:06:59 INFO - rmtree: /builds/slave/test/build 02:06:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:00 INFO - Running post-action listener: _resource_record_post_action 02:07:00 INFO - ##### 02:07:00 INFO - ##### Finished clobber step (success) 02:07:00 INFO - ##### 02:07:00 INFO - ##### 02:07:00 INFO - ##### Running read-buildbot-config step. 02:07:00 INFO - ##### 02:07:00 INFO - Running pre-action listener: _resource_record_pre_action 02:07:00 INFO - Running main action method: read_buildbot_config 02:07:00 INFO - Using buildbot properties: 02:07:00 INFO - { 02:07:00 INFO - "project": "", 02:07:00 INFO - "product": "firefox", 02:07:00 INFO - "script_repo_revision": "production", 02:07:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:07:00 INFO - "repository": "", 02:07:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:07:00 INFO - "buildid": "20160601003956", 02:07:00 INFO - "pgo_build": "False", 02:07:00 INFO - "basedir": "/builds/slave/test", 02:07:00 INFO - "buildnumber": 3027, 02:07:00 INFO - "slavename": "talos-linux64-ix-023", 02:07:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:07:00 INFO - "platform": "ubuntu64_hw", 02:07:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:07:00 INFO - "branch": "fx-team", 02:07:00 INFO - "repo_path": "integration/fx-team", 02:07:00 INFO - "revision": "78e2125dfb6b02cdbab73a30c54bb4dc19aa310a", 02:07:00 INFO - "stage_platform": "linux64", 02:07:00 INFO - "builduid": "317cf23392f64494986208a3893ab652", 02:07:00 INFO - "slavebuilddir": "test" 02:07:00 INFO - } 02:07:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:07:00 INFO - Running post-action listener: _resource_record_post_action 02:07:00 INFO - ##### 02:07:00 INFO - ##### Finished read-buildbot-config step (success) 02:07:00 INFO - ##### 02:07:00 INFO - ##### 02:07:00 INFO - ##### Running download-and-extract step. 02:07:00 INFO - ##### 02:07:00 INFO - Running pre-action listener: _resource_record_pre_action 02:07:00 INFO - Running main action method: download_and_extract 02:07:00 INFO - mkdir: /builds/slave/test/build/tests 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:00 INFO - https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:00 INFO - Downloaded 1361 bytes. 02:07:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:07:00 INFO - Using the following test package requirements: 02:07:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:07:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:07:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'jsshell-linux-x86_64.zip'], 02:07:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:07:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:07:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:07:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:07:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:07:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:00 INFO - https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:02 INFO - Downloaded 22840449 bytes. 02:07:02 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'] 02:07:02 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 02:07:03 INFO - Return code: 0 02:07:03 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 02:07:03 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')]} 02:07:03 INFO - https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:04 INFO - Downloaded 22840449 bytes. 02:07:04 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'] 02:07:04 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 02:07:05 INFO - Return code: 0 02:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:05 INFO - https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:06 INFO - Downloaded 10834055 bytes. 02:07:06 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'] 02:07:06 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 02:07:06 INFO - Return code: 0 02:07: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')]} 02:07:06 INFO - https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuftPJK7T366hgJJkvh5Qg/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 02:07:08 INFO - Downloaded 55037057 bytes. 02:07:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:07:08 INFO - mkdir: /builds/slave/test/properties 02:07:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:08 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:08 INFO - Contents: 02:07:08 INFO - build_url:https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:07:09 INFO - Running post-action listener: _resource_record_post_action 02:07:09 INFO - Running post-action listener: set_extra_try_arguments 02:07:09 INFO - ##### 02:07:09 INFO - ##### Finished download-and-extract step (success) 02:07:09 INFO - ##### 02:07:09 INFO - ##### 02:07:09 INFO - ##### Running populate-webroot step. 02:07:09 INFO - ##### 02:07:09 INFO - Running pre-action listener: _resource_record_pre_action 02:07:09 INFO - Running main action method: populate_webroot 02:07:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:09 INFO - '--tppagecycles', 02:07:09 INFO - '7'], 02:07:09 INFO - 'tests': ['tsvgm']}}, 02:07:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['damp', 'tps']}, 02:07:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'tests': ['damp', 'tps']}, 02:07:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['dromaeo_dom']}, 02:07:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['a11yr', 02:07:09 INFO - 'ts_paint', 02:07:09 INFO - 'tpaint', 02:07:09 INFO - 'sessionrestore', 02:07:09 INFO - 'sessionrestore_no_auto_restore', 02:07:09 INFO - 'tabpaint']}, 02:07:09 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:09 INFO - 'ts_paint', 02:07:09 INFO - 'tpaint', 02:07:09 INFO - 'sessionrestore', 02:07:09 INFO - 'sessionrestore_no_auto_restore', 02:07:09 INFO - 'tabpaint']}, 02:07:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:09 INFO - 'ts_paint', 02:07:09 INFO - 'tpaint', 02:07:09 INFO - 'sessionrestore', 02:07:09 INFO - 'sessionrestore_no_auto_restore', 02:07:09 INFO - 'tabpaint']}, 02:07:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:09 INFO - 'ts_paint', 02:07:09 INFO - 'tpaint', 02:07:09 INFO - 'sessionrestore', 02:07:09 INFO - 'sessionrestore_no_auto_restore', 02:07:09 INFO - 'tabpaint']}, 02:07:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['a11yr', 02:07:09 INFO - 'ts_paint', 02:07:09 INFO - 'tpaint', 02:07:09 INFO - 'sessionrestore', 02:07:09 INFO - 'sessionrestore_no_auto_restore', 02:07:09 INFO - 'tabpaint']}, 02:07:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['a11yr', 02:07:09 INFO - 'ts_paint', 02:07:09 INFO - 'tpaint', 02:07:09 INFO - 'sessionrestore', 02:07:09 INFO - 'sessionrestore_no_auto_restore', 02:07:09 INFO - 'tabpaint']}, 02:07:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['tsvgx', 02:07:09 INFO - 'tsvgr_opacity', 02:07:09 INFO - 'tart', 02:07:09 INFO - 'tscrollx', 02:07:09 INFO - 'cart']}, 02:07:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:09 INFO - 'tsvgr_opacity', 02:07:09 INFO - 'tart', 02:07:09 INFO - 'tscrollx', 02:07:09 INFO - 'cart']}, 02:07:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'talos_options': ['--disable-e10s'], 02:07:09 INFO - 'tests': ['tp5o']}, 02:07:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'tests': ['tp5o']}, 02:07:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'talos_options': ['--disable-e10s', 02:07:09 INFO - '--xperf_path', 02:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:09 INFO - 'tests': ['tp5n']}, 02:07:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:09 INFO - 'talos_options': ['--xperf_path', 02:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:09 INFO - 'tests': ['tp5n']}}, 02:07:09 INFO - 'talos.zip': {'path': '', 02:07:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:09 INFO - Running post-action listener: _resource_record_post_action 02:07:09 INFO - ##### 02:07:09 INFO - ##### Finished populate-webroot step (success) 02:07:09 INFO - ##### 02:07:09 INFO - ##### 02:07:09 INFO - ##### Running create-virtualenv step. 02:07:09 INFO - ##### 02:07:09 INFO - Running pre-action listener: _resource_record_pre_action 02:07:09 INFO - Running main action method: create_virtualenv 02:07:09 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:09 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 02:07:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:09 INFO - Using real prefix '/usr' 02:07:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:11 INFO - Installing pip.................done. 02:07:11 INFO - Return code: 0 02:07:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:11 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')]} 02:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:11 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')]} 02:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:11 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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:11 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 02:07:11 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 02:07:11 INFO - Using env: {'DISPLAY': ':0', 02:07:11 INFO - 'HOME': '/home/cltbld', 02:07:11 INFO - 'LANG': 'en_US.UTF-8', 02:07:11 INFO - 'LANGUAGE': 'en_US:en', 02:07:11 INFO - 'LOGNAME': 'cltbld', 02:07:11 INFO - 'MAIL': '/var/mail/cltbld', 02:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:11 INFO - 'MOZ_NO_REMOTE': '1', 02:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:11 INFO - 'NO_EM_RESTART': '1', 02:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:11 INFO - 'PWD': '/builds/slave/test', 02:07:11 INFO - 'SHELL': '/bin/bash', 02:07:11 INFO - 'SHLVL': '1', 02:07:11 INFO - 'TERM': 'linux', 02:07:11 INFO - 'TMOUT': '86400', 02:07:11 INFO - 'USER': 'cltbld', 02:07:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:11 INFO - '_': '/tools/buildbot/bin/python'} 02:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:11 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 02:07:11 INFO - Cleaning up... 02:07:11 INFO - Return code: 0 02:07:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:07:11 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')]} 02:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:11 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')]} 02:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:11 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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:11 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 02:07:11 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 02:07:11 INFO - Using env: {'DISPLAY': ':0', 02:07:11 INFO - 'HOME': '/home/cltbld', 02:07:11 INFO - 'LANG': 'en_US.UTF-8', 02:07:11 INFO - 'LANGUAGE': 'en_US:en', 02:07:11 INFO - 'LOGNAME': 'cltbld', 02:07:11 INFO - 'MAIL': '/var/mail/cltbld', 02:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:11 INFO - 'MOZ_NO_REMOTE': '1', 02:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:11 INFO - 'NO_EM_RESTART': '1', 02:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:11 INFO - 'PWD': '/builds/slave/test', 02:07:11 INFO - 'SHELL': '/bin/bash', 02:07:11 INFO - 'SHLVL': '1', 02:07:11 INFO - 'TERM': 'linux', 02:07:11 INFO - 'TMOUT': '86400', 02:07:11 INFO - 'USER': 'cltbld', 02:07:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:11 INFO - '_': '/tools/buildbot/bin/python'} 02:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:12 INFO - Downloading/unpacking psutil>=3.1.1 02:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:14 INFO - Installing collected packages: psutil 02:07:14 INFO - Running setup.py install for psutil 02:07:14 INFO - building 'psutil._psutil_linux' extension 02:07:14 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 02:07:14 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 02:07:14 INFO - building 'psutil._psutil_posix' extension 02:07:14 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 02:07:14 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 02:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:14 INFO - Successfully installed psutil 02:07:14 INFO - Cleaning up... 02:07:14 INFO - Return code: 0 02:07:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:07:14 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')]} 02:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:14 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')]} 02:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:14 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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:14 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 02:07:14 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 02:07:14 INFO - Using env: {'DISPLAY': ':0', 02:07:14 INFO - 'HOME': '/home/cltbld', 02:07:14 INFO - 'LANG': 'en_US.UTF-8', 02:07:14 INFO - 'LANGUAGE': 'en_US:en', 02:07:14 INFO - 'LOGNAME': 'cltbld', 02:07:14 INFO - 'MAIL': '/var/mail/cltbld', 02:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:14 INFO - 'MOZ_NO_REMOTE': '1', 02:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:14 INFO - 'NO_EM_RESTART': '1', 02:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:14 INFO - 'PWD': '/builds/slave/test', 02:07:14 INFO - 'SHELL': '/bin/bash', 02:07:14 INFO - 'SHLVL': '1', 02:07:14 INFO - 'TERM': 'linux', 02:07:14 INFO - 'TMOUT': '86400', 02:07:14 INFO - 'USER': 'cltbld', 02:07:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:14 INFO - '_': '/tools/buildbot/bin/python'} 02:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:07:16 INFO - Installing collected packages: mozsystemmonitor 02:07:16 INFO - Running setup.py install for mozsystemmonitor 02:07:16 INFO - Successfully installed mozsystemmonitor 02:07:16 INFO - Cleaning up... 02:07:17 INFO - Return code: 0 02:07:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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', '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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:07: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 blobuploader==1.2.4 02:07:17 INFO - Using env: {'DISPLAY': ':0', 02:07:17 INFO - 'HOME': '/home/cltbld', 02:07:17 INFO - 'LANG': 'en_US.UTF-8', 02:07:17 INFO - 'LANGUAGE': 'en_US:en', 02:07:17 INFO - 'LOGNAME': 'cltbld', 02:07:17 INFO - 'MAIL': '/var/mail/cltbld', 02:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:17 INFO - 'MOZ_NO_REMOTE': '1', 02:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:17 INFO - 'NO_EM_RESTART': '1', 02:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:17 INFO - 'PWD': '/builds/slave/test', 02:07:17 INFO - 'SHELL': '/bin/bash', 02:07:17 INFO - 'SHLVL': '1', 02:07:17 INFO - 'TERM': 'linux', 02:07:17 INFO - 'TMOUT': '86400', 02:07:17 INFO - 'USER': 'cltbld', 02:07:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:17 INFO - '_': '/tools/buildbot/bin/python'} 02:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:17 INFO - Downloading/unpacking blobuploader==1.2.4 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:19 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:19 INFO - Downloading docopt-0.6.1.tar.gz 02:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:20 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:20 INFO - Running setup.py install for blobuploader 02:07:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:20 INFO - Running setup.py install for requests 02:07:20 INFO - Running setup.py install for docopt 02:07:20 INFO - Successfully installed blobuploader requests docopt 02:07:20 INFO - Cleaning up... 02:07:20 INFO - Return code: 0 02:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:20 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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:20 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 02:07:20 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 02:07:20 INFO - Using env: {'DISPLAY': ':0', 02:07:20 INFO - 'HOME': '/home/cltbld', 02:07:20 INFO - 'LANG': 'en_US.UTF-8', 02:07:20 INFO - 'LANGUAGE': 'en_US:en', 02:07:20 INFO - 'LOGNAME': 'cltbld', 02:07:20 INFO - 'MAIL': '/var/mail/cltbld', 02:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:20 INFO - 'MOZ_NO_REMOTE': '1', 02:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:20 INFO - 'NO_EM_RESTART': '1', 02:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:20 INFO - 'PWD': '/builds/slave/test', 02:07:20 INFO - 'SHELL': '/bin/bash', 02:07:20 INFO - 'SHLVL': '1', 02:07:20 INFO - 'TERM': 'linux', 02:07:20 INFO - 'TMOUT': '86400', 02:07:20 INFO - 'USER': 'cltbld', 02:07:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:20 INFO - '_': '/tools/buildbot/bin/python'} 02:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:20 INFO - Running setup.py (path:/tmp/pip-HZJgaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:20 INFO - Running setup.py (path:/tmp/pip-j3pBus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:20 INFO - Running setup.py (path:/tmp/pip-ZYKJ_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:21 INFO - Running setup.py (path:/tmp/pip-upTQLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:21 INFO - Running setup.py (path:/tmp/pip-qFbQX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:21 INFO - Running setup.py (path:/tmp/pip-xvZnw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:21 INFO - Running setup.py (path:/tmp/pip-HxGnCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:21 INFO - Running setup.py (path:/tmp/pip-MamLbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:21 INFO - Running setup.py (path:/tmp/pip-wePDub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:21 INFO - Running setup.py (path:/tmp/pip-fPy0en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:21 INFO - Running setup.py (path:/tmp/pip-hgOsnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:21 INFO - Running setup.py (path:/tmp/pip-FlA9Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:21 INFO - Running setup.py (path:/tmp/pip-bRL7Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:21 INFO - Running setup.py (path:/tmp/pip-sHPRIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:21 INFO - Running setup.py (path:/tmp/pip-pX5Ny8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:21 INFO - Running setup.py (path:/tmp/pip-p4Xuc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:21 INFO - Running setup.py (path:/tmp/pip-QkghFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:22 INFO - Running setup.py install for manifestparser 02:07:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozcrash 02:07:22 INFO - Running setup.py install for mozdebug 02:07:22 INFO - Running setup.py install for mozdevice 02:07:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozfile 02:07:22 INFO - Running setup.py install for mozhttpd 02:07:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozinfo 02:07:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozInstall 02:07:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozleak 02:07:22 INFO - Running setup.py install for mozlog 02:07:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Running setup.py install for moznetwork 02:07:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Running setup.py install for mozprocess 02:07:23 INFO - Running setup.py install for mozprofile 02:07:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Running setup.py install for mozrunner 02:07:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Running setup.py install for mozscreenshot 02:07:23 INFO - Running setup.py install for moztest 02:07:23 INFO - Running setup.py install for mozversion 02:07:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:23 INFO - Cleaning up... 02:07:23 INFO - Return code: 0 02:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:23 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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:23 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 02:07:23 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 02:07:23 INFO - Using env: {'DISPLAY': ':0', 02:07:23 INFO - 'HOME': '/home/cltbld', 02:07:23 INFO - 'LANG': 'en_US.UTF-8', 02:07:23 INFO - 'LANGUAGE': 'en_US:en', 02:07:23 INFO - 'LOGNAME': 'cltbld', 02:07:23 INFO - 'MAIL': '/var/mail/cltbld', 02:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:23 INFO - 'MOZ_NO_REMOTE': '1', 02:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:23 INFO - 'NO_EM_RESTART': '1', 02:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:23 INFO - 'PWD': '/builds/slave/test', 02:07:23 INFO - 'SHELL': '/bin/bash', 02:07:23 INFO - 'SHLVL': '1', 02:07:23 INFO - 'TERM': 'linux', 02:07:23 INFO - 'TMOUT': '86400', 02:07:23 INFO - 'USER': 'cltbld', 02:07:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:23 INFO - '_': '/tools/buildbot/bin/python'} 02:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:24 INFO - Running setup.py (path:/tmp/pip-sQXn4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:24 INFO - Running setup.py (path:/tmp/pip-3SRp6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:24 INFO - Running setup.py (path:/tmp/pip-vzobZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:24 INFO - Running setup.py (path:/tmp/pip-5ksC_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:24 INFO - Running setup.py (path:/tmp/pip-_cyyzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:24 INFO - Running setup.py (path:/tmp/pip-BQKHz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:24 INFO - Running setup.py (path:/tmp/pip-aPG2xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:24 INFO - Running setup.py (path:/tmp/pip-Ky45RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:24 INFO - Running setup.py (path:/tmp/pip-BnNtSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:24 INFO - Running setup.py (path:/tmp/pip-s7UVbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:24 INFO - Running setup.py (path:/tmp/pip-OWYXnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:24 INFO - Running setup.py (path:/tmp/pip-lv4ei2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:24 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)) 02:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:24 INFO - Running setup.py (path:/tmp/pip-eMja5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:25 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)) 02:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:25 INFO - Running setup.py (path:/tmp/pip-sVbEym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:25 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)) 02:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:25 INFO - Running setup.py (path:/tmp/pip-MO05Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:25 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)) 02:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:25 INFO - Running setup.py (path:/tmp/pip-Ymgcmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:25 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)) 02:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:25 INFO - Running setup.py (path:/tmp/pip-n_ZFOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:25 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)) 02:07:25 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)) 02:07:25 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)) 02:07:25 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)) 02:07:25 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)) 02:07:25 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)) 02:07:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:27 INFO - Downloading blessings-1.6.tar.gz 02:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:27 INFO - Installing collected packages: blessings 02:07:27 INFO - Running setup.py install for blessings 02:07:27 INFO - Successfully installed blessings 02:07:27 INFO - Cleaning up... 02:07:27 INFO - Return code: 0 02:07:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:27 INFO - Reading from file tmpfile_stdout 02:07:27 INFO - Current package versions: 02:07:27 INFO - argparse == 1.2.1 02:07:27 INFO - blessings == 1.6 02:07:27 INFO - blobuploader == 1.2.4 02:07:27 INFO - docopt == 0.6.1 02:07:27 INFO - manifestparser == 1.1 02:07:27 INFO - mozInstall == 1.12 02:07:27 INFO - mozcrash == 0.17 02:07:27 INFO - mozdebug == 0.1 02:07:27 INFO - mozdevice == 0.48 02:07:27 INFO - mozfile == 1.2 02:07:27 INFO - mozhttpd == 0.7 02:07:27 INFO - mozinfo == 0.9 02:07:27 INFO - mozleak == 0.1 02:07:27 INFO - mozlog == 3.2 02:07:27 INFO - moznetwork == 0.27 02:07:27 INFO - mozprocess == 0.22 02:07:27 INFO - mozprofile == 0.28 02:07:27 INFO - mozrunner == 6.11 02:07:27 INFO - mozscreenshot == 0.1 02:07:27 INFO - mozsystemmonitor == 0.3 02:07:27 INFO - moztest == 0.7 02:07:27 INFO - mozversion == 1.4 02:07:27 INFO - psutil == 3.1.1 02:07:27 INFO - requests == 1.2.3 02:07:27 INFO - wsgiref == 0.1.2 02:07:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:27 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')]} 02:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:27 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')]} 02:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:27 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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:27 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 02:07:27 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 02:07:27 INFO - Using env: {'DISPLAY': ':0', 02:07:27 INFO - 'HOME': '/home/cltbld', 02:07:27 INFO - 'LANG': 'en_US.UTF-8', 02:07:27 INFO - 'LANGUAGE': 'en_US:en', 02:07:27 INFO - 'LOGNAME': 'cltbld', 02:07:27 INFO - 'MAIL': '/var/mail/cltbld', 02:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:27 INFO - 'MOZ_NO_REMOTE': '1', 02:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:27 INFO - 'NO_EM_RESTART': '1', 02:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:27 INFO - 'PWD': '/builds/slave/test', 02:07:27 INFO - 'SHELL': '/bin/bash', 02:07:27 INFO - 'SHLVL': '1', 02:07:27 INFO - 'TERM': 'linux', 02:07:27 INFO - 'TMOUT': '86400', 02:07:27 INFO - 'USER': 'cltbld', 02:07:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:27 INFO - '_': '/tools/buildbot/bin/python'} 02:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 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)) 02:07:27 INFO - Cleaning up... 02:07:27 INFO - Return code: 0 02:07:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:27 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')]} 02:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:27 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')]} 02:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:27 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 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:27 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 02:07:27 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 02:07:27 INFO - Using env: {'DISPLAY': ':0', 02:07:27 INFO - 'HOME': '/home/cltbld', 02:07:27 INFO - 'LANG': 'en_US.UTF-8', 02:07:27 INFO - 'LANGUAGE': 'en_US:en', 02:07:27 INFO - 'LOGNAME': 'cltbld', 02:07:27 INFO - 'MAIL': '/var/mail/cltbld', 02:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:27 INFO - 'MOZ_NO_REMOTE': '1', 02:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:27 INFO - 'NO_EM_RESTART': '1', 02:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:27 INFO - 'PWD': '/builds/slave/test', 02:07:27 INFO - 'SHELL': '/bin/bash', 02:07:27 INFO - 'SHLVL': '1', 02:07:27 INFO - 'TERM': 'linux', 02:07:27 INFO - 'TMOUT': '86400', 02:07:27 INFO - 'USER': 'cltbld', 02:07:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:27 INFO - '_': '/tools/buildbot/bin/python'} 02:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:28 INFO - Downloading/unpacking jsonschema 02:07:28 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 02:07:28 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 02:07:28 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 02:07:28 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 02:07:28 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 02:07:28 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 02:07:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:29 INFO - Downloading/unpacking functools32 (from jsonschema) 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:30 INFO - warning: no files found matching '*.txt' 02:07:30 INFO - no previously-included directories found matching 'build' 02:07:30 INFO - no previously-included directories found matching 'dist' 02:07:30 INFO - no previously-included directories found matching '.git*' 02:07:30 INFO - Installing collected packages: jsonschema, functools32 02:07:30 INFO - Running setup.py install for functools32 02:07:30 INFO - warning: no files found matching '*.txt' 02:07:30 INFO - no previously-included directories found matching 'build' 02:07:30 INFO - no previously-included directories found matching 'dist' 02:07:30 INFO - no previously-included directories found matching '.git*' 02:07:30 INFO - Successfully installed jsonschema functools32 02:07:30 INFO - Cleaning up... 02:07:30 INFO - Return code: 0 02:07:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa1aa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', '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 02:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:07:30 INFO - Using env: {'DISPLAY': ':0', 02:07:30 INFO - 'HOME': '/home/cltbld', 02:07:30 INFO - 'LANG': 'en_US.UTF-8', 02:07:30 INFO - 'LANGUAGE': 'en_US:en', 02:07:30 INFO - 'LOGNAME': 'cltbld', 02:07:30 INFO - 'MAIL': '/var/mail/cltbld', 02:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:30 INFO - 'MOZ_NO_REMOTE': '1', 02:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:30 INFO - 'NO_EM_RESTART': '1', 02:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:30 INFO - 'PWD': '/builds/slave/test', 02:07:30 INFO - 'SHELL': '/bin/bash', 02:07:30 INFO - 'SHLVL': '1', 02:07:30 INFO - 'TERM': 'linux', 02:07:30 INFO - 'TMOUT': '86400', 02:07:30 INFO - 'USER': 'cltbld', 02:07:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:30 INFO - '_': '/tools/buildbot/bin/python'} 02:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:30 INFO - Downloading/unpacking flake8 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:07:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:07:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:32 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 02:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:33 INFO - no previously-included directories found matching 'docs/_build' 02:07:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:07:33 INFO - Running setup.py install for pep8 02:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:33 INFO - no previously-included directories found matching 'docs/_build' 02:07:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:07:33 INFO - Cleaning up... 02:07:33 INFO - Return code: 0 02:07:33 INFO - Running post-action listener: _resource_record_post_action 02:07:33 INFO - Running post-action listener: _start_resource_monitoring 02:07:33 INFO - Starting resource monitoring. 02:07:33 INFO - ##### 02:07:33 INFO - ##### Finished create-virtualenv step (success) 02:07:33 INFO - ##### 02:07:33 INFO - ##### 02:07:33 INFO - ##### Running install step. 02:07:33 INFO - ##### 02:07:33 INFO - Running pre-action listener: _resource_record_pre_action 02:07:33 INFO - Running main action method: install 02:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:33 INFO - Reading from file tmpfile_stdout 02:07:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:33 INFO - Reading from file tmpfile_stdout 02:07:33 INFO - Output received: 02:07:33 INFO - Usage: mozinstall [options] installer 02:07:33 INFO - Options: 02:07:33 INFO - -h, --help show this help message and exit 02:07:33 INFO - -d DEST, --destination=DEST 02:07:33 INFO - Directory to install application into. [default: 02:07:33 INFO - "/builds/slave/test"] 02:07:33 INFO - --app=APP Application being installed. [default: firefox] 02:07:33 INFO - mkdir: /builds/slave/test/build/application 02:07:33 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'] 02:07:33 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 02:07:49 INFO - Reading from file tmpfile_stdout 02:07:49 INFO - Output received: 02:07:49 INFO - /builds/slave/test/build/application/firefox/firefox 02:07:49 INFO - Running post-action listener: _resource_record_post_action 02:07:49 INFO - ##### 02:07:49 INFO - ##### Finished install step (success) 02:07:49 INFO - ##### 02:07:49 INFO - ##### 02:07:49 INFO - ##### Running run-tests step. 02:07:49 INFO - ##### 02:07:49 INFO - Running pre-action listener: _resource_record_pre_action 02:07:49 INFO - Running main action method: run_tests 02:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:49 INFO - Python 2.7.3 02:07:49 INFO - Return code: 0 02:07:49 INFO - grabbing minidump binary from tooltool 02:07:49 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')]} 02:07:49 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 0x27fbb20>, '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 0x27fca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fceb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:49 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 02:07:49 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 02:07:49 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 02:07:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:49 INFO - Return code: 0 02:07:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:07:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:07:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:07:50 INFO - Return code: 0 02:07:50 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/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 02:07:50 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/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 02:07:50 INFO - Using env: {'DISPLAY': ':0', 02:07:50 INFO - 'HOME': '/home/cltbld', 02:07:50 INFO - 'LANG': 'en_US.UTF-8', 02:07:50 INFO - 'LANGUAGE': 'en_US:en', 02:07:50 INFO - 'LOGNAME': 'cltbld', 02:07:50 INFO - 'MAIL': '/var/mail/cltbld', 02:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:50 INFO - 'MOZ_NO_REMOTE': '1', 02:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:50 INFO - 'NO_EM_RESTART': '1', 02:07:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:50 INFO - 'PWD': '/builds/slave/test', 02:07:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:50 INFO - 'SHELL': '/bin/bash', 02:07:50 INFO - 'SHLVL': '1', 02:07:50 INFO - 'TERM': 'linux', 02:07:50 INFO - 'TMOUT': '86400', 02:07:50 INFO - 'USER': 'cltbld', 02:07:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436', 02:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:50 INFO - '_': '/tools/buildbot/bin/python'} 02:07:50 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/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 02:07:50 INFO - mozversion application_buildid: 20160601003956 02:07:50 INFO - mozversion application_changeset: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a 02:07:50 INFO - mozversion application_display_name: Nightly 02:07:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:50 INFO - mozversion application_name: Firefox 02:07:50 INFO - mozversion application_remotingname: firefox 02:07:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:07:50 INFO - mozversion application_vendor: Mozilla 02:07:50 INFO - mozversion application_version: 49.0a1 02:07:50 INFO - mozversion platform_buildid: 20160601003956 02:07:50 INFO - mozversion platform_changeset: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a 02:07:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:07:50 INFO - mozversion platform_version: 49.0a1 02:07:50 INFO - using testdate: 1464772070 02:07:50 INFO - actual date: 1464772070 02:07:50 INFO - starting webserver on 'localhost:55466' 02:07:50 INFO - SUITE-START | Running 2 tests 02:07:50 INFO - TEST-START | dromaeo_css 02:07:50 INFO - operating with platform_type : linux_ 02:07:50 INFO - Initialising browser for dromaeo_css test... 02:07:50 INFO - TEST-INFO | started process 22271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNGXaK/profile http://localhost:55466/getInfo.html) 02:07:55 INFO - PROCESS | 22271 | __metrics Screen width/height:1600/1200 02:07:55 INFO - PROCESS | 22271 | colorDepth:24 02:07:55 INFO - PROCESS | 22271 | Browser inner width/height: 1024/697 02:07:55 INFO - PROCESS | 22271 | __metrics 02:07:56 ERROR - PROCESS | 22271 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:07:56 INFO - TEST-INFO | 22271: exit 0 02:07:56 INFO - Browser initialized. 02:07:56 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:56 INFO - TEST-INFO | started process 22351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNGXaK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:08 INFO - PROCESS | 22351 | RSS: Main: 157372416 02:08:08 INFO - PROCESS | 22351 | 02:09:00 INFO - PROCESS | 22351 | 1464772140546 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] 02:11:12 INFO - PROCESS | 22351 | Cycle 1(1): loaded http://localhost:55466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55466/tests/dromaeo/cssquery-ext.html) 02:11:13 INFO - PROCESS | 22351 | RSS: Main: 268759040 02:11:13 INFO - PROCESS | 22351 | 02:14:15 INFO - PROCESS | 22351 | Cycle 1(1): loaded http://localhost:55466/tests/dromaeo/cssquery-ext.html (next: http://localhost:55466/tests/dromaeo/cssquery-jquery.html) 02:14:16 INFO - PROCESS | 22351 | RSS: Main: 241754112 02:14:16 INFO - PROCESS | 22351 | 02:17:18 INFO - PROCESS | 22351 | Cycle 1(1): loaded http://localhost:55466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55466/tests/dromaeo/cssquery-mootools.html) 02:17:19 INFO - PROCESS | 22351 | RSS: Main: 245932032 02:17:19 INFO - PROCESS | 22351 | 02:20:21 INFO - PROCESS | 22351 | Cycle 1(1): loaded http://localhost:55466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55466/tests/dromaeo/cssquery-prototype.html) 02:20:22 INFO - PROCESS | 22351 | RSS: Main: 246181888 02:20:22 INFO - PROCESS | 22351 | 02:23:25 INFO - PROCESS | 22351 | Cycle 1(1): loaded http://localhost:55466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55466/tests/dromaeo/cssquery-yui.html) 02:23:25 INFO - PROCESS | 22351 | RSS: Main: 219680768 02:23:25 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | Cycle 1(1): loaded http://localhost:55466/tests/dromaeo/cssquery-yui.html (next: http://localhost:55466/tests/dromaeo/cssquery-dojo.html) 02:26:28 INFO - PROCESS | 22351 | RSS: Main: 270249984 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | __start_tp_report 02:26:28 INFO - PROCESS | 22351 | _x_x_mozilla_page_load 02:26:28 INFO - PROCESS | 22351 | _x_x_mozilla_page_load_details 02:26:28 INFO - PROCESS | 22351 | |i|pagename|runs| 02:26:28 INFO - PROCESS | 22351 | |0;dojo.html;2661.481011202816;2666.1734862192734;2686.5164270431337;2698.7840972722183;2721.9319517012073;4555.772211389425;4630.791614377353;4647.233206520928;4702.435707715074;4742.170120228963;4659;4675.485696573374;4689.788959496822;4720.433547974248;4733.71597704138;4241.766702831351;4302.698811083225;4344.522102568715;4372.12557488502;4477.955220447802;4384.254676704968;4405.82376704933;4408.030233348658;4436.334549817521;4451.198784218839;4198.895027624303;4245.363195520666;4303.139372125556;4303.505096913864;4345.044090300129;4282.914341713148;4287.8070486828165;4289.120730250323;4420.07178492517;4423.623991960687;4324.416203812508;4334.111507141029;4340.370646256275;4366.476022877275;4380.145871555048;4487.326900964881;4569.862904112882;4623.770565315765;4695.906081878377;4699.812007519695;4977;5034.219695947134;5089.3638295213095;5108.719020453874;5115.974420127875;5111.386633603991;5144.511271429208;5152.484751524855;5153.6392452528335;5156.535911767959;4628.282616194495;4659.720416775004;4701.435827700698;4806.975965120152;4807.158747219222;5137.460566640524;5141.3830340358645;5169.53474187325;5185.429602743695;5197.688138711689;4955.380577427822;4999.02519008797;5007.349044624176;5015.398152221684;5019.196928491424;4864.6594738368685;4943.28322393251;4951.90096198074;4979.800807967713;5087.567556757717;4939.753012349368;4940.7035577865445;4942.9258561121615;4964;4965.255211718271;4884;4891.55975962158;4895.216765317532;4898.485659005824;4946.9010619787405;4044.2315959967514;4085.673146148301;4086.0397806515443;4131.400946862688;4156.792160392029;3683.631636836295;3704.666580007812;3705.055210921198;3705.7776533408082;3706.3513885070543;4231.724937879028;4280.186764514795;4283.2290187765875;4287.656987440997;4288.356746488052;4991.975040124848;5003.024410240041;5012.022655582199;5019.698818070854;5056.165732654071;4325.7620830853975;4331.545187755303;4332.870013899588;4367.58507941745;4376.562343765598;4436.556344365602;4501.257292546758;4508.030773383738;4511.436070491189;4545.568171023748;4657.254839225708;4708.576228139553;4731.361266229015;4759.309900064541;4876.95123048765;4998.750062496933;5001.42483614389;5012.273220383097;5019.64862459639;5059.266406370982;4751.192297309397;4752.952470475251;4762.6189904808225;4768.9523104768505;4800.711957282574;4843.612510999041;4917.409910810726;4966.850994470172;4981;4999.650024498395;5017.924731128963;5024.799008039638;5040.218766091115;5049.166887463674;5099.745012749274;4758.857234282977;4889.339939108175;4908.214685650279;4909.26361045846;4961.454240033521;4805.5915247204375;4856.39295088114;4870.31815545831;4874.805007799649;4891.926621100757;4821.252705830461;4853.369062021915;4898.951010489992;4901.705897646153;4902.1911384621135;4804.279358096313;4825;4984.42679091909;4988.80044798204;4996.650234483696;4755.857324280277;4761.857144285677;4764.380630518011;4783.784729687103;4823.324734537097 02:26:28 INFO - PROCESS | 22351 | |1;ext.html;539.6371739288395;588.7056471764117;590.9438603332682;595.166766526862;598.0192484325706;27791.583126253096;40278;40737.59262407375;41010;41294.17411651773;42661;43051.569484305146;43076.569234307644;43124.35313470301;43133.78433107838;5681.886362272752;5686.175504551838;5686.800961966332;5687.687177205252;5833.095870140124;7517.586532740697;7811.609419529001;7816.726414575491;7820.569868657221;7820.882686759704;7458.291462311072;7849.372050235967;7853.332466740334;7862.410319226081;7870.370370370385;7430.739924102658;7791.532508049479;7836.059672839296;7839.686412543463;7841.05907291123;7722.343600793939;7812;7814.3748500119855;7819.491733037335;7822.335101516378;39859.60842349439;40240.1951960962;40295;40357.59642403568;40384.39423408651;3158.0367987763725;3169.3344397676515;3284.014795561346;3312.519684645713;3776.131489757344;30139.246518836986;30445;30703.53944690809;30967.380652386826;31577.684223157932;3361.193313604742;3363.5291059251726;3382.492626106079;3397.9466365426797;3417.743669224818;205173;269353;271373;272120.63939680374;272946;47776.522234777905;48959.265611015864;55329.723351382985;56342;56357.43642563604;58153.12770308449;59770.816042876584;60006;65219;65400.345996540374;14746.483873064391;14850.108993460426;14917.254137293308;14920.477783277533;14924;9839.262055345735;10069.244806639532;11130.443477826077;11220.719482013015;11226.831597526043;16095.517134485985;18168.364107256184;18770.155343009596;18772.342967996326;19219.423417297505;7014.614196219257;7198.5680859148615;7203.819904502429;7212.459065570103;7269.345758881726;856.2678909532385;916.8441364967971;932.6409332407072;940.8682784410188;973.4110862927968;27516.312092197855;28385;28851.5672264912;29023.709762902523;29081.85459072691;919.4207649180973;991.667791289926;998.2513115163628;1007.7027276953316;1035.4098164046572;15051.548453546411;15233.466828660943;15261.694766104616;15474.767878481833;15495.380184792482;393166.478346513;394896;397671;399998;401282;50100;50557.49442505528;50588.24117638165;50663.24005139926;50723.49276507262;1130.5082289204222;1187.1571184458958;1194.5460724924474;1197.0543270815958;1201.5614300780153;27373.452530949668;28161.57757633596;28388.64929367571;28461;28651.856740716164;42538.361924570534;42920.78539607407;42937.57062429336;42945.570544295406;42985.3552196711;266019;267515;268206;268268;268496;25303.620445692963;25762.8711856447;25862.22413327603;26969.865150674123;33048.173795655304;33362;34353.65646343605;34676.65323346835;44400.77799610981;44463.33305000363;36570.634293657786;37046.25907481781;38109.809450953675;38151.23697525978;38812.223755524166;36454.8177259112;37471.250574987804;37976;38079.238415232096;38395.80802095972;35583;37052.66526012672;37500;37552.183586230596;37899.24201515899;33004.1748956278;33958.83020584881;34001.65998339985;34039.829800850835;34185.487217691254;25839.741602584487;25976.480470390863;26065.73934260633;26244.475110498064;26376.604350935137 02:26:28 INFO - PROCESS | 22351 | |2;jquery.html;352.5152914742231;361.8064335580465;362.86029878496777;373.0859394483516;378.63650895140665;15825.683486330267;17150.485485435427;17195.91402042991;17555.2100155493;17706.46880593581;16213.351465941349;16365.34538618454;17177.91411042943;17178.656426871454;17178.656426871486;5038.4457709652;5127.282180494733;5136.8458946231485;5168.819091331804;5174.80979374744;3714.5542534895717;3895.6299151580556;5075.9746201268945;5608.411116832735;5952.642841429506;5995.280566332046;5996.520278377741;6000.819975400745;6023.186869772569;6027.789027384042;5715.799947001877;5899.616524925909;5962.910556341659;6066.120412540201;6075.787347442841;3367.6632336766374;4867.342908707315;5173.793048278064;5176.327077479904;5186.636935414523;19670.40988770339;20302.289419870234;20321;20354.89822550878;20431.182752689874;1904.581371218773;2017.9607502136412;2180.738311402626;2202.284257616281;2285.4172186092605;12695.301758403284;13045.739085218338;13257.602271931857;13462.646819166532;13505.86494135056;1720.1829131162722;1767.6994910865055;1769.8761086723805;1776.8933863968202;1781.2785821742216;65523.64311455738;68245;68446.315536845;68513;68722.65638671775;9280.535973201313;9342.766430839283;9714.368566043184;9714.708558743248;9976.950115249378;13354.799678004838;13423.932880335537;13441.596752097452;13452.1256118352;13452.663683407993;7321.267873212636;7326.523775954653;7461.626918654046;7540.622968851536;7610.048743907012;7106.360427561544;7147;7155.284471552907;7167.283271672791;7274.527155734861;6127.356627554132;6128.1114238435175;6210.4100110489435;6215.689215539205;6270.7805226816845;1597.4169428158639;1696.8812183147309;1698.5413938236607;1698.5838469575033;1762.3126980477623;810.9472884262505;906.5829718329642;913.3789023463976;968.8207681578931;1019.5666841592442;16541.6691666166;17114.743278850827;17525.912370438065;17633.294668213384;17699.29202831898;911.0752586124956;931.5035704312372;935.9391639543408;939.6335429182624;941.4351389166445;9617.758321714682;10100.848487272697;10109.090181883666;10162.949185254174;10210.744731381776;363252;372575;377443;381438;382497;68512.3148768516;69059;69298.3070169302;69479.3052069483;69734;960.5917485068818;963.6675347005272;963.8939716631165;971.5530855806267;976.2629214942673;15363.155026473205;15445.691086178438;15455.381784728936;15560.688786224438;15973.840261597235;32187.35625287528;32304;32510.67489325171;33452;33896.322073557894;43677.78161109174;44547.777261113486;44648.776756116014;44739.32891006573;44904.77547612241;7262.455315851438;7278.96360518194;7342.412606991321;7397.149327827368;7459.813504662427;10771.299865508718;10934.56261749521;10988.890111099106;11248.043916267208;11254.21220514556;7453.850922981402;7460.626968651654;9437.81124377495;9561.760955976157;9640.084192001748;9225.630974761203;9378.437293762396;9386.718398448058;9552.95223523878;9701.6119355225;9412.95293523528;9482.146606805421;9567.425954442755;9752.609895604097;9946.35348702332;7096.929030709627;7207.9279207207255;7262.201157872735;7267.273272672691;7283.708651654087;9645.9035409645;9659.806803864023;9735.367201131903;9739.9026009739;9744.07431294026 02:26:28 INFO - PROCESS | 22351 | |3;mootools.html;1250.724840535082;1417.971640567189;1468.375940225404;1578.810542734872;1781.8752687311894;6836.726530938763;7738.18749031352;8078.232567906054;8087.838243235139;8272.420930534865;7943.880841787378;8167.795805104875;8179.222973817477;8180.754577362673;8187.590620468967;1905.571246469547;2111.947201319964;2181.182056728727;2205.834562407818;2241.4396400899777;2208.729980261348;2224.8776317302622;2230.643097104464;2237.686723858661;2237.944051398712;2137.3374253981237;2196.615592271346;2227.8551894126913;2231.1967691631;2232.229880691167;1853.4161739052222;2081.969425134568;2151.333086743107;2164.9134034638596;2171.6091103601348;2143.528423746773;2157.1910533549917;2161.6433288507533;2164.6428339323993;2183.759786423492;8045.517268963881;8086.433949623529;8091.474054186518;8091.959540202321;8098.514089154611;4437.889052773674;4588;4589;4592.357070010201;4592.7014744041535;2862.7423531882023;3024.561438591414;3073.846307684629;3090.860911258999;3097.767667424952;887.6360692116266;887.7292425810125;896.6458248991612;908.159952044363;924.570074915161;11110.722231944184;11115.777684446346;11116.277441966246;11137.05335046522;11146.275492092907;4003.179348233605;4157.542670306264;4221.767802770877;4226.682998775104;4227.429297044921;9363.204127649089;9406.1064198901;9417.811643767087;9428.10433008863;9432.528373581294;4573.131105090022;4619.838305659353;4628.907421851612;4638.83764068256;4661.813527458864;3718.3678774608384;4107.691923105779;4270.572942705767;4289.914201715948;4333.674974376934;3535.734819888519;3605.2248766515327;3623.9456408153897;3648.5986541480415;3685.3182161300247;1178.1046404732465;1191.880811918801;1196.7726132034886;1210.2738356985737;1212.9636110916686;865.6148014133651;875.4922145155795;877.4779006491127;887.7469921072593;896.0770406481205;5544.861378465571;5673.149027645886;5690.2033715279895;5778.104393818965;5867.559933004956;398.6671129606811;417.42812347084686;418.949726032878;428.9270823959934;432.71657064622724;3708.3881159608363;3792.7724336539345;3805.06775839921;3874.1476875087437;3932.193900250499;9419.623215071457;9671.419714816993;9791.853122203172;9799;9833.557489912972;9649.179819715402;9738.318317717692;9777.804443911082;9790.265730070274;9795.755106122262;7060.894086588808;7352.558846469229;7421.257874212643;7451.627418629047;7466.514676546007;5649.322081350264;5752.223449834386;5774.595778295479;5842.737076831468;5897.498712609305;9012.459252444874;9218.907810921804;9293.953530232306;9389.859152112587;9411.10594493522;9248.537573121452;9366.157045865904;9366.67216647414;9370.578323975302;9377.296702747457;6278.529110316836;6743.865122697617;6912.377885990285;6927.89608155868;7027.4729395294535;7753.139246580893;7813.570253635878;7864.449488535747;7870.9606451967375;7892.684292628231;6837.076994605664;6839.521233513607;6969.7909062728195;7053.259407762316;7128.501004929605;7018.508704390643;7043;7050.15398152225;7089.0784198053925;7159.140903091662;6537.411632953057;6540.149780528691;6599.736010559716;6616.801495955129;6619.27188009309;4902.534259245366;4904.166291730486;4915.164422048332;4940.135476291563;4971.527704868032;4992.076465853828;5028.1954887219335;5043.4365346742625;5049.722265275445;5093.4651861554 02:26:28 INFO - PROCESS | 22351 | |4;prototype.html;289.3027802994783;297.6814808155274;302.2986670923458;307.76763543524635;310.619491123374;4564.922960053176;4682.41469816273;4706.223473126935;4806.110869489143;4840.515948405162;4550.840720574773;4717.433907931053;4734.881627959294;4743.620510359172;4748.169070412681;3767.566729826071;3771.905702357449;3771.962280377202;3781.506305009533;3783.9404966609395;3593.6047034826147;3613.187032917586;3781.2626537825136;3785.3564893967955;3789.2800367930145;3755.605661405554;3761.755485893408;3768.321702093622;3779.433085037239;3795.5635101963353;3734.9813250933844;3743.943840842403;3752.2307926874923;3773.245350929811;3791.146991926822;3346.4645656695056;3347.2092430549783;3361.9495707564406;3366.394049071166;3378.749862550872;4475.418195634579;4519.706219095781;4553.385292985471;4558.931616025762;4579.610733087691;4281.357796330544;4285.4214681017975;4290.549492303326;4297.4413326267695;4303.31147016479;4918.385201849769;4934.4572097069295;4956.553910148068;4967.801287948478;4970;3495.8252087395526;3635.1093981974323;3668.321360548307;3668.8899333020054;3673.669369756735;5125.513076257786;5174.404943431516;5183.071564566008;5204.479552044765;5209.874075554675;3714.795686237229;3733.831977561016;3741.85032598693;3754.249150169977;3767.453719210699;3830.1765120499226;3832.7317087804145;3840.711946604016;3842.8462861485227;3853.094522787143;4041.3533834586324;4225.239456897788;4233.809478573472;4243.533211346749;4250.362445633118;4872.684375218742;4924.138275801721;4944.728039957765;4958.826441074545;4965.875853103701;1249.2317224906617;1270.8879730236044;1314.1983390132011;1317.2228385252556;1329.6077657091182;845.3321875718236;846.6655671009917;852.8507511185518;864.2135656552633;870.3776799588325;3870.806459677005;3909.9609003910164;3914.9021274468364;3917.764934103963;3930.744501607386;4493.73037617744;4502.932456013163;4523.32150177476;4569.13186494565;4575;3872.780074276594;3917.8451851481573;3961.8613348532663;3964.7819369934355;3974.2448934702315;2313.35226136682;2408.2775167449695;2411.831171817991;2412.3969007748065;2421.2252079334444;4286.61420472159;4306.849260275875;4307.612314891675;4318.50875089903;4334.869953901388;4508.176251410959;4538.478075021415;4547.204239258117;4568.81724731007;4630.527104671496;4273.9358909616385;4309.913801723948;4312.827486900489;4535.886602835021;4929.359183306147;5145.125328694056;5153.922691159561;5165.328507294028;5179.870503237449;5198.491018562379;5062.82280120194;5067.049186063318;5068.771905264198;5073.746312684277;5096.267269128514;4749.459039413897;4950.950490495193;4952.579030782424;4972.359121489827;4983.327250821238;3592.317459682652;3605.7656252343513;3619.3304238715923;3622.6558476944647;3626.9818650906577;4922.556969872729;5165.302684137593;5177.301064356264;5186.611004174627;5191.896162076661;4870.512948705101;4973.676711013773;4981.825636102864;4983.159599028519;4990.930577694764;4959.876003099951;4967.162150004521;4993.201087825931;4994.400671919393;4999.625028122832;4783.7129772213775;4932.679375840559;4946.851594452172;4968.27959945813;4979.5102448775615;5071.1632580625255;5076.771545280398;5090.720010399464;5093.962415034016;5105.489451054865;4868.810928841614;4921.581665558468;4937.185364414831;4939.357883475125;4942.456329803791 02:26:28 INFO - PROCESS | 22351 | |5;yui.html;730.2697302697303;778.2101167315176;781.7732857471335;785.7788847870245;790.7943934577008;12017.459214335355;12537.059720520952;12562.560310389139;12579.371031448436;12634.810477842828;11623.65129046128;11678.708032299197;11703.297802131856;11714.062874970003;11740.647780566596;620.1844574384693;637.9872402551946;774.3650206830388;786.3001928283832;788.2826627768732;779.2674885607539;805.6616221187086;807.1726480357622;807.1887752808419;809.0493669937829;844.3709436469838;850.6214734443175;851.1360968616859;851.2636569367514;852.2244757270885;649.8375406148463;671.7749553899449;845.5011543189516;846.1834329871673;846.5301757524571;493.32907246145214;494.9059678661043;596.9403059694039;611.62996387186;613.1416017575385;12276.75446491074;12285.201461905037;12299.56951506702;12312.507499700001;12345.38273086342;11777.882221177764;12192.51229950801;12195.695107622292;12242.326672033034;12626.68433289166;10942.23404361695;10966.670999870017;11065.889341106566;11156.609518666888;11196.832047519212;4089.3661482469965;4109.938350924738;4114.979425102855;4152.584741525823;4222.9788851055855;45667.77166114148;46151;46480.5351946483;46606.76696616529;46753.766231168964;9667.661631842851;9756.658516952015;9808.509574521388;9825.950870245746;10017.69946901594;17315.480535583953;17362.565935851704;17376;17377.82622173762;17428;6649.434798042221;6671.733130674816;6745.325467453314;6814;6863.519553631298;3547.219611685425;3628.401313783196;3711.628837116321;3717.219383929351;3744.213715119801;2849.957250641242;2892.262473069396;2895.840728759896;2897.565365195195;2939.4855900217804;521.6035812782237;527.1512864288493;528.6167528541853;535.4912832808848;545.8580769000009;456.6529437627427;513.7071869034689;544.3685325022955;547.4716898193262;551.8813455107171;7646.120696119906;7668.80827979305;7726.072871255486;7745.573993430416;7883.290503854566;489.86283840524;534.5269436548605;538.3055857943209;581.2995340614549;581.316952580716;3768.520773585575;3817.10298079951;3837.827297771607;3852.903677408031;3907.7264591478893;53244.201336979975;54346.184807227924;54583;54680;54773.72613136909;48086.51913480891;49133.26300105501;50204.748976255614;51180.48819511757;51387.22919156215;45472;45733.54266457293;45989;46427.28581713455;46643.30035049409;7230.323611665916;7244.565326080452;7351.70593176267;7453.217412171861;7456.627168641655;31222.68777312198;31607.367852643278;31650.208744781565;31896.5215521772;32260.35479290448;38252.80873595725;40544.391834123104;40592.59407406006;40887;41263.793681031406;8963.820723585623;9292.767680808034;9430;9577.377470464677;9673.854892176481;9894.901050989398;10149.137323327599;10159.7460063499;10185.898141018792;10471.476426178508;9106.726798196065;9244.168024877794;9370;9388.152475099447;9400.106989835955;9028.819423611621;9282.62869485213;9616.75958101053;9648.276379271443;10008.64969726056;8626.439281446686;8647.135286471303;8910.509921954355;8953.93545506402;8956.059613740463;8860.468371897707;8967.461952282883;8985.326100542356;9524.095210954949;9573.2820038496;9966.800663986825;10049.397036177852;10128.240381971234;10144.28989970695;10150.593976241164 02:26:28 INFO - PROCESS | 22351 | __end_tp_report 02:26:28 INFO - PROCESS | 22351 | __start_cc_report 02:26:28 INFO - PROCESS | 22351 | _x_x_mozilla_cycle_collect,1077 02:26:28 INFO - PROCESS | 22351 | __end_cc_report 02:26:28 INFO - PROCESS | 22351 | __startTimestamp1464773188761__endTimestamp 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | ------- Summary: start ------- 02:26:28 INFO - PROCESS | 22351 | Number of tests: 6 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | [#0] dojo.html Cycles:165 Average:4638.81 Median:4762.62 stddev:484.14 (10.2%) stddev-sans-first:460.10 02:26:28 INFO - PROCESS | 22351 | Values: 2661.5 2666.2 2686.5 2698.8 2721.9 4555.8 4630.8 4647.2 4702.4 4742.2 4659.0 4675.5 4689.8 4720.4 4733.7 4241.8 4302.7 4344.5 4372.1 4478.0 4384.3 4405.8 4408.0 4436.3 4451.2 4198.9 4245.4 4303.1 4303.5 4345.0 4282.9 4287.8 4289.1 4420.1 4423.6 4324.4 4334.1 4340.4 4366.5 4380.1 4487.3 4569.9 4623.8 4695.9 4699.8 4977.0 5034.2 5089.4 5108.7 5116.0 5111.4 5144.5 5152.5 5153.6 5156.5 4628.3 4659.7 4701.4 4807.0 4807.2 5137.5 5141.4 5169.5 5185.4 5197.7 4955.4 4999.0 5007.3 5015.4 5019.2 4864.7 4943.3 4951.9 4979.8 5087.6 4939.8 4940.7 4942.9 4964.0 4965.3 4884.0 4891.6 4895.2 4898.5 4946.9 4044.2 4085.7 4086.0 4131.4 4156.8 3683.6 3704.7 3705.1 3705.8 3706.4 4231.7 4280.2 4283.2 4287.7 4288.4 4992.0 5003.0 5012.0 5019.7 5056.2 4325.8 4331.5 4332.9 4367.6 4376.6 4436.6 4501.3 4508.0 4511.4 4545.6 4657.3 4708.6 4731.4 4759.3 4877.0 4998.8 5001.4 5012.3 5019.6 5059.3 4751.2 4753.0 4762.6 4769.0 4800.7 4843.6 4917.4 4966.9 4981.0 4999.7 5017.9 5024.8 5040.2 5049.2 5099.7 4758.9 4889.3 4908.2 4909.3 4961.5 4805.6 4856.4 4870.3 4874.8 4891.9 4821.3 4853.4 4899.0 4901.7 4902.2 4804.3 4825.0 4984.4 4988.8 4996.7 4755.9 4761.9 4764.4 4783.8 4823.3 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | [#1] ext.html Cycles:180 Average:46997.90 Median:38094.52 stddev:82818.21 (217.4%) stddev-sans-first:82977.08 02:26:28 INFO - PROCESS | 22351 | Values: 539.6 588.7 590.9 595.2 598.0 27791.6 40278.0 40737.6 41010.0 41294.2 42661.0 43051.6 43076.6 43124.4 43133.8 5681.9 5686.2 5686.8 5687.7 5833.1 7517.6 7811.6 7816.7 7820.6 7820.9 7458.3 7849.4 7853.3 7862.4 7870.4 7430.7 7791.5 7836.1 7839.7 7841.1 7722.3 7812.0 7814.4 7819.5 7822.3 39859.6 40240.2 40295.0 40357.6 40384.4 3158.0 3169.3 3284.0 3312.5 3776.1 30139.2 30445.0 30703.5 30967.4 31577.7 3361.2 3363.5 3382.5 3397.9 3417.7 205173.0 269353.0 271373.0 272120.6 272946.0 47776.5 48959.3 55329.7 56342.0 56357.4 58153.1 59770.8 60006.0 65219.0 65400.3 14746.5 14850.1 14917.3 14920.5 14924.0 9839.3 10069.2 11130.4 11220.7 11226.8 16095.5 18168.4 18770.2 18772.3 19219.4 7014.6 7198.6 7203.8 7212.5 7269.3 856.3 916.8 932.6 940.9 973.4 27516.3 28385.0 28851.6 29023.7 29081.9 919.4 991.7 998.3 1007.7 1035.4 15051.5 15233.5 15261.7 15474.8 15495.4 393166.5 394896.0 397671.0 399998.0 401282.0 50100.0 50557.5 50588.2 50663.2 50723.5 1130.5 1187.2 1194.5 1197.1 1201.6 27373.5 28161.6 28388.6 28461.0 28651.9 42538.4 42920.8 42937.6 42945.6 42985.4 266019.0 267515.0 268206.0 268268.0 268496.0 25303.6 25762.9 25862.2 26969.9 33048.2 33362.0 34353.7 34676.7 44400.8 44463.3 36570.6 37046.3 38109.8 38151.2 38812.2 36454.8 37471.3 37976.0 38079.2 38395.8 35583.0 37052.7 37500.0 37552.2 37899.2 33004.2 33958.8 34001.7 34039.8 34185.5 25839.7 25976.5 26065.7 26244.5 26376.6 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | [#2] jquery.html Cycles:180 Average:23403.94 Median:5175.57 stddev:61795.41 (1194.0%) stddev-sans-first:61944.52 02:26:28 INFO - PROCESS | 22351 | Values: 352.5 361.8 362.9 373.1 378.6 15825.7 17150.5 17195.9 17555.2 17706.5 16213.4 16365.3 17177.9 17178.7 17178.7 5038.4 5127.3 5136.8 5168.8 5174.8 3714.6 3895.6 5076.0 5608.4 5952.6 5995.3 5996.5 6000.8 6023.2 6027.8 5715.8 5899.6 5962.9 6066.1 6075.8 3367.7 4867.3 5173.8 5176.3 5186.6 19670.4 20302.3 20321.0 20354.9 20431.2 1904.6 2018.0 2180.7 2202.3 2285.4 12695.3 13045.7 13257.6 13462.6 13505.9 1720.2 1767.7 1769.9 1776.9 1781.3 65523.6 68245.0 68446.3 68513.0 68722.7 9280.5 9342.8 9714.4 9714.7 9977.0 13354.8 13423.9 13441.6 13452.1 13452.7 7321.3 7326.5 7461.6 7540.6 7610.0 7106.4 7147.0 7155.3 7167.3 7274.5 6127.4 6128.1 6210.4 6215.7 6270.8 1597.4 1696.9 1698.5 1698.6 1762.3 810.9 906.6 913.4 968.8 1019.6 16541.7 17114.7 17525.9 17633.3 17699.3 911.1 931.5 935.9 939.6 941.4 9617.8 10100.8 10109.1 10162.9 10210.7 363252.0 372575.0 377443.0 381438.0 382497.0 68512.3 69059.0 69298.3 69479.3 69734.0 960.6 963.7 963.9 971.6 976.3 15363.2 15445.7 15455.4 15560.7 15973.8 32187.4 32304.0 32510.7 33452.0 33896.3 43677.8 44547.8 44648.8 44739.3 44904.8 7262.5 7279.0 7342.4 7397.1 7459.8 10771.3 10934.6 10988.9 11248.0 11254.2 7453.9 7460.6 9437.8 9561.8 9640.1 9225.6 9378.4 9386.7 9553.0 9701.6 9413.0 9482.1 9567.4 9752.6 9946.4 7096.9 7207.9 7262.2 7267.3 7283.7 9645.9 9659.8 9735.4 9739.9 9744.1 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | [#3] mootools.html Cycles:180 Average:5287.28 Median:5597.09 stddev:3002.51 (53.6%) stddev-sans-first:2995.60 02:26:28 INFO - PROCESS | 22351 | Values: 1250.7 1418.0 1468.4 1578.8 1781.9 6836.7 7738.2 8078.2 8087.8 8272.4 7943.9 8167.8 8179.2 8180.8 8187.6 1905.6 2111.9 2181.2 2205.8 2241.4 2208.7 2224.9 2230.6 2237.7 2237.9 2137.3 2196.6 2227.9 2231.2 2232.2 1853.4 2082.0 2151.3 2164.9 2171.6 2143.5 2157.2 2161.6 2164.6 2183.8 8045.5 8086.4 8091.5 8092.0 8098.5 4437.9 4588.0 4589.0 4592.4 4592.7 2862.7 3024.6 3073.8 3090.9 3097.8 887.6 887.7 896.6 908.2 924.6 11110.7 11115.8 11116.3 11137.1 11146.3 4003.2 4157.5 4221.8 4226.7 4227.4 9363.2 9406.1 9417.8 9428.1 9432.5 4573.1 4619.8 4628.9 4638.8 4661.8 3718.4 4107.7 4270.6 4289.9 4333.7 3535.7 3605.2 3623.9 3648.6 3685.3 1178.1 1191.9 1196.8 1210.3 1213.0 865.6 875.5 877.5 887.7 896.1 5544.9 5673.1 5690.2 5778.1 5867.6 398.7 417.4 418.9 428.9 432.7 3708.4 3792.8 3805.1 3874.1 3932.2 9419.6 9671.4 9791.9 9799.0 9833.6 9649.2 9738.3 9777.8 9790.3 9795.8 7060.9 7352.6 7421.3 7451.6 7466.5 5649.3 5752.2 5774.6 5842.7 5897.5 9012.5 9218.9 9294.0 9389.9 9411.1 9248.5 9366.2 9366.7 9370.6 9377.3 6278.5 6743.9 6912.4 6927.9 7027.5 7753.1 7813.6 7864.4 7871.0 7892.7 6837.1 6839.5 6969.8 7053.3 7128.5 7018.5 7043.0 7050.2 7089.1 7159.1 6537.4 6540.1 6599.7 6616.8 6619.3 4902.5 4904.2 4915.2 4940.1 4971.5 4992.1 5028.2 5043.4 5049.7 5093.5 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | [#4] prototype.html Cycles:180 Average:4068.02 Median:4505.55 stddev:1174.45 (26.1%) stddev-sans-first:1142.99 02:26:28 INFO - PROCESS | 22351 | Values: 289.3 297.7 302.3 307.8 310.6 4564.9 4682.4 4706.2 4806.1 4840.5 4550.8 4717.4 4734.9 4743.6 4748.2 3767.6 3771.9 3772.0 3781.5 3783.9 3593.6 3613.2 3781.3 3785.4 3789.3 3755.6 3761.8 3768.3 3779.4 3795.6 3735.0 3743.9 3752.2 3773.2 3791.1 3346.5 3347.2 3361.9 3366.4 3378.7 4475.4 4519.7 4553.4 4558.9 4579.6 4281.4 4285.4 4290.5 4297.4 4303.3 4918.4 4934.5 4956.6 4967.8 4970.0 3495.8 3635.1 3668.3 3668.9 3673.7 5125.5 5174.4 5183.1 5204.5 5209.9 3714.8 3733.8 3741.9 3754.2 3767.5 3830.2 3832.7 3840.7 3842.8 3853.1 4041.4 4225.2 4233.8 4243.5 4250.4 4872.7 4924.1 4944.7 4958.8 4965.9 1249.2 1270.9 1314.2 1317.2 1329.6 845.3 846.7 852.9 864.2 870.4 3870.8 3910.0 3914.9 3917.8 3930.7 4493.7 4502.9 4523.3 4569.1 4575.0 3872.8 3917.8 3961.9 3964.8 3974.2 2313.4 2408.3 2411.8 2412.4 2421.2 4286.6 4306.8 4307.6 4318.5 4334.9 4508.2 4538.5 4547.2 4568.8 4630.5 4273.9 4309.9 4312.8 4535.9 4929.4 5145.1 5153.9 5165.3 5179.9 5198.5 5062.8 5067.0 5068.8 5073.7 5096.3 4749.5 4951.0 4952.6 4972.4 4983.3 3592.3 3605.8 3619.3 3622.7 3627.0 4922.6 5165.3 5177.3 5186.6 5191.9 4870.5 4973.7 4981.8 4983.2 4990.9 4959.9 4967.2 4993.2 4994.4 4999.6 4783.7 4932.7 4946.9 4968.3 4979.5 5071.2 5076.8 5090.7 5094.0 5105.5 4868.8 4921.6 4937.2 4939.4 4942.5 02:26:28 INFO - PROCESS | 22351 | 02:26:28 INFO - PROCESS | 22351 | [#5] yui.html Cycles:180 Average:12905.10 Median:524.38 stddev:15246.03 (2907.5%) stddev-sans-first:15261.39 02:26:28 INFO - PROCESS | 22351 | Values: 730.3 778.2 781.8 785.8 790.8 12017.5 12537.1 12562.6 12579.4 12634.8 11623.7 11678.7 11703.3 11714.1 11740.6 620.2 638.0 774.4 786.3 788.3 779.3 805.7 807.2 807.2 809.0 844.4 850.6 851.1 851.3 852.2 649.8 671.8 845.5 846.2 846.5 493.3 494.9 596.9 611.6 613.1 12276.8 12285.2 12299.6 12312.5 12345.4 11777.9 12192.5 12195.7 12242.3 12626.7 10942.2 10966.7 11065.9 11156.6 11196.8 4089.4 4109.9 4115.0 4152.6 4223.0 45667.8 46151.0 46480.5 46606.8 46753.8 9667.7 9756.7 9808.5 9826.0 10017.7 17315.5 17362.6 17376.0 17377.8 17428.0 6649.4 6671.7 6745.3 6814.0 6863.5 3547.2 3628.4 3711.6 3717.2 3744.2 2850.0 2892.3 2895.8 2897.6 2939.5 521.6 527.2 528.6 535.5 545.9 456.7 513.7 544.4 547.5 551.9 7646.1 7668.8 7726.1 7745.6 7883.3 489.9 534.5 538.3 581.3 581.3 3768.5 3817.1 3837.8 3852.9 3907.7 53244.2 54346.2 54583.0 54680.0 54773.7 48086.5 49133.3 50204.7 51180.5 51387.2 45472.0 45733.5 45989.0 46427.3 46643.3 7230.3 7244.6 7351.7 7453.2 7456.6 31222.7 31607.4 31650.2 31896.5 32260.4 38252.8 40544.4 40592.6 40887.0 41263.8 8963.8 9292.8 9430.0 9577.4 9673.9 9894.9 10149.1 10159.7 10185.9 10471.5 9106.7 9244.2 9370.0 9388.2 9400.1 9028.8 9282.6 9616.8 9648.3 10008.6 8626.4 8647.1 8910.5 8953.9 8956.1 8860.5 8967.5 8985.3 9524.1 9573.3 9966.8 10049.4 10128.2 10144.3 10150.6 02:26:28 INFO - PROCESS | 22351 | -------- Summary: end -------- 02:26:28 INFO - PROCESS | 22351 | 02:26:29 INFO - TEST-INFO | 22351: exit 0 02:26:29 INFO - TEST-OK | dromaeo_css | took 1118644ms 02:26:29 INFO - TEST-START | kraken 02:26:29 INFO - operating with platform_type : linux_ 02:26:29 INFO - Initialising browser for kraken test... 02:26:29 INFO - TEST-INFO | started process 22530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kcY4o/profile http://localhost:55466/getInfo.html) 02:26:33 INFO - PROCESS | 22530 | __metrics Screen width/height:1600/1200 02:26:33 INFO - PROCESS | 22530 | colorDepth:24 02:26:33 INFO - PROCESS | 22530 | Browser inner width/height: 1024/697 02:26:33 INFO - PROCESS | 22530 | __metrics 02:26:34 ERROR - PROCESS | 22530 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:26:35 INFO - TEST-INFO | 22530: exit 0 02:26:35 INFO - Browser initialized. 02:26:35 INFO - Running cycle 1/1 for kraken test... 02:26:35 INFO - TEST-INFO | started process 22609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kcY4o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:47 INFO - PROCESS | 22609 | RSS: Main: 156954624 02:26:47 INFO - PROCESS | 22609 | 02:26:50 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55466/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:51 INFO - PROCESS | 22609 | RSS: Main: 215502848 02:26:51 INFO - PROCESS | 22609 | 02:26:54 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55466/tests/kraken/driver.html?testName=audio-dft) 02:26:54 INFO - PROCESS | 22609 | RSS: Main: 203657216 02:26:54 INFO - PROCESS | 22609 | 02:26:57 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55466/tests/kraken/driver.html?testName=audio-fft) 02:26:58 INFO - PROCESS | 22609 | RSS: Main: 270520320 02:26:58 INFO - PROCESS | 22609 | 02:27:00 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55466/tests/kraken/driver.html?testName=audio-oscillator) 02:27:01 INFO - PROCESS | 22609 | RSS: Main: 180867072 02:27:01 INFO - PROCESS | 22609 | 02:27:03 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:04 INFO - PROCESS | 22609 | RSS: Main: 184766464 02:27:04 INFO - PROCESS | 22609 | 02:27:07 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55466/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:08 INFO - PROCESS | 22609 | RSS: Main: 220663808 02:27:08 INFO - PROCESS | 22609 | 02:27:11 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55466/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:12 INFO - PROCESS | 22609 | RSS: Main: 216801280 02:27:12 INFO - PROCESS | 22609 | 02:27:15 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55466/tests/kraken/driver.html?testName=json-parse-financial) 02:27:15 INFO - PROCESS | 22609 | RSS: Main: 219099136 02:27:15 INFO - PROCESS | 22609 | 02:27:17 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:17 INFO - PROCESS | 22609 | RSS: Main: 208474112 02:27:17 INFO - PROCESS | 22609 | 02:27:19 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:20 INFO - PROCESS | 22609 | RSS: Main: 210677760 02:27:20 INFO - PROCESS | 22609 | 02:27:22 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:23 INFO - PROCESS | 22609 | RSS: Main: 218857472 02:27:23 INFO - PROCESS | 22609 | 02:27:26 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:26 INFO - PROCESS | 22609 | RSS: Main: 222814208 02:27:26 INFO - PROCESS | 22609 | 02:27:29 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:30 INFO - PROCESS | 22609 | RSS: Main: 222601216 02:27:30 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | Cycle 1(1): loaded http://localhost:55466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55466/tests/kraken/driver.html?testName=ai-astar) 02:27:32 INFO - PROCESS | 22609 | RSS: Main: 264962048 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | __start_tp_report 02:27:32 INFO - PROCESS | 22609 | _x_x_mozilla_page_load 02:27:32 INFO - PROCESS | 22609 | _x_x_mozilla_page_load_details 02:27:32 INFO - PROCESS | 22609 | |i|pagename|runs| 02:27:32 INFO - PROCESS | 22609 | |0;ai-astar;116;109;114;115;113;115;112;113;114;114 02:27:32 INFO - PROCESS | 22609 | |1;audio-beat-detection;160;130;131;182;131;130;163;135;176;129 02:27:32 INFO - PROCESS | 22609 | |2;audio-dft;160;161;161;161;162;160;163;162;161;162 02:27:32 INFO - PROCESS | 22609 | |3;audio-fft;75;77;77;106;84;77;76;74;100;76 02:27:32 INFO - PROCESS | 22609 | |4;audio-oscillator;84;86;114;85;86;84;116;84;84;126 02:27:32 INFO - PROCESS | 22609 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;117 02:27:32 INFO - PROCESS | 22609 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;146 02:27:32 INFO - PROCESS | 22609 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;94;94 02:27:32 INFO - PROCESS | 22609 | |8;json-parse-financial;67;64;65;64;65;65;71;64;64;72 02:27:32 INFO - PROCESS | 22609 | |9;json-stringify-tinderbox;65;66;65;66;66;66;67;66;66;65 02:27:32 INFO - PROCESS | 22609 | |10;stanford-crypto-aes;85;84;91;88;84;84;83;85;112;84 02:27:32 INFO - PROCESS | 22609 | |11;stanford-crypto-ccm;132;143;140;139;130;143;139;133;141;132 02:27:32 INFO - PROCESS | 22609 | |12;stanford-crypto-pbkdf2;169;174;170;169;170;169;167;172;170;167 02:27:32 INFO - PROCESS | 22609 | |13;stanford-crypto-sha256-iterative;67;66;66;67;72;67;67;66;66;66 02:27:32 INFO - PROCESS | 22609 | __end_tp_report 02:27:32 INFO - PROCESS | 22609 | __start_cc_report 02:27:32 INFO - PROCESS | 22609 | _x_x_mozilla_cycle_collect,1881 02:27:32 INFO - PROCESS | 22609 | __end_cc_report 02:27:32 INFO - PROCESS | 22609 | __startTimestamp1464773252375__endTimestamp 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | ------- Summary: start ------- 02:27:32 INFO - PROCESS | 22609 | Number of tests: 14 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:1.86 02:27:32 INFO - PROCESS | 22609 | Values: 116.0 109.0 114.0 115.0 113.0 115.0 112.0 113.0 114.0 114.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:147.50 stddev:21.21 (14.4%) stddev-sans-first:21.94 02:27:32 INFO - PROCESS | 22609 | Values: 160.0 130.0 131.0 182.0 131.0 130.0 163.0 135.0 176.0 129.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 02:27:32 INFO - PROCESS | 22609 | Values: 160.0 161.0 161.0 161.0 162.0 160.0 163.0 162.0 161.0 162.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.50 stddev:11.37 (14.9%) stddev-sans-first:11.76 02:27:32 INFO - PROCESS | 22609 | Values: 75.0 77.0 77.0 106.0 84.0 77.0 76.0 74.0 100.0 76.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:16.70 (19.9%) stddev-sans-first:17.24 02:27:32 INFO - PROCESS | 22609 | Values: 84.0 86.0 114.0 85.0 86.0 84.0 116.0 84.0 84.0 126.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:27:32 INFO - PROCESS | 22609 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:27:32 INFO - PROCESS | 22609 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:27:32 INFO - PROCESS | 22609 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:3.00 (4.6%) stddev-sans-first:3.16 02:27:32 INFO - PROCESS | 22609 | Values: 67.0 64.0 65.0 64.0 65.0 65.0 71.0 64.0 64.0 72.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 02:27:32 INFO - PROCESS | 22609 | Values: 65.0 66.0 65.0 66.0 66.0 66.0 67.0 66.0 66.0 65.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:84.50 stddev:8.77 (10.4%) stddev-sans-first:9.23 02:27:32 INFO - PROCESS | 22609 | Values: 85.0 84.0 91.0 88.0 84.0 84.0 83.0 85.0 112.0 84.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:139.50 stddev:4.94 (3.5%) stddev-sans-first:4.87 02:27:32 INFO - PROCESS | 22609 | Values: 132.0 143.0 140.0 139.0 130.0 143.0 139.0 133.0 141.0 132.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.00 stddev:2.11 (1.2%) stddev-sans-first:2.22 02:27:32 INFO - PROCESS | 22609 | Values: 169.0 174.0 170.0 169.0 170.0 169.0 167.0 172.0 170.0 167.0 02:27:32 INFO - PROCESS | 22609 | 02:27:32 INFO - PROCESS | 22609 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.94 02:27:32 INFO - PROCESS | 22609 | Values: 67.0 66.0 66.0 67.0 72.0 67.0 67.0 66.0 66.0 66.0 02:27:32 INFO - PROCESS | 22609 | -------- Summary: end -------- 02:27:32 INFO - PROCESS | 22609 | 02:27:33 INFO - TEST-INFO | 22609: exit 0 02:27:33 INFO - TEST-OK | kraken | took 63814ms 02:27:33 INFO - SUITE-END | took 1182s 02:27:33 INFO - Completed test suite (00:19:42) 02:27:33 INFO - javascript benchmark 02:27:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2661.481011202816, 2666.1734862192734, 2686.5164270431337, 2698.7840972722183, 2721.9319517012073, 4555.772211389425, 4630.791614377353, 4647.233206520928, 4702.435707715074, 4742.170120228963, 4659.0, 4675.485696573374, 4689.788959496822, 4720.433547974248, 4733.71597704138, 4241.766702831351, 4302.698811083225, 4344.522102568715, 4372.12557488502, 4477.955220447802, 4384.254676704968, 4405.82376704933, 4408.030233348658, 4436.334549817521, 4451.198784218839, 4198.895027624303, 4245.363195520666, 4303.139372125556, 4303.505096913864, 4345.044090300129, 4282.914341713148, 4287.8070486828165, 4289.120730250323, 4420.07178492517, 4423.623991960687, 4324.416203812508, 4334.111507141029, 4340.370646256275, 4366.476022877275, 4380.145871555048, 4487.326900964881, 4569.862904112882, 4623.770565315765, 4695.906081878377, 4699.812007519695, 4977.0, 5034.219695947134, 5089.3638295213095, 5108.719020453874, 5115.974420127875, 5111.386633603991, 5144.511271429208, 5152.484751524855, 5153.6392452528335, 5156.535911767959, 4628.282616194495, 4659.720416775004, 4701.435827700698, 4806.975965120152, 4807.158747219222, 5137.460566640524, 5141.3830340358645, 5169.53474187325, 5185.429602743695, 5197.688138711689, 4955.380577427822, 4999.02519008797, 5007.349044624176, 5015.398152221684, 5019.196928491424, 4864.6594738368685, 4943.28322393251, 4951.90096198074, 4979.800807967713, 5087.567556757717, 4939.753012349368, 4940.7035577865445, 4942.9258561121615, 4964.0, 4965.255211718271, 4884.0, 4891.55975962158, 4895.216765317532, 4898.485659005824, 4946.9010619787405, 4044.2315959967514, 4085.673146148301, 4086.0397806515443, 4131.400946862688, 4156.792160392029, 3683.631636836295, 3704.666580007812, 3705.055210921198, 3705.7776533408082, 3706.3513885070543, 4231.724937879028, 4280.186764514795, 4283.2290187765875, 4287.656987440997, 4288.356746488052, 4991.975040124848, 5003.024410240041, 5012.022655582199, 5019.698818070854, 5056.165732654071, 4325.7620830853975, 4331.545187755303, 4332.870013899588, 4367.58507941745, 4376.562343765598, 4436.556344365602, 4501.257292546758, 4508.030773383738, 4511.436070491189, 4545.568171023748, 4657.254839225708, 4708.576228139553, 4731.361266229015, 4759.309900064541, 4876.95123048765, 4998.750062496933, 5001.42483614389, 5012.273220383097, 5019.64862459639, 5059.266406370982, 4751.192297309397, 4752.952470475251, 4762.6189904808225, 4768.9523104768505, 4800.711957282574, 4843.612510999041, 4917.409910810726, 4966.850994470172, 4981.0, 4999.650024498395, 5017.924731128963, 5024.799008039638, 5040.218766091115, 5049.166887463674, 5099.745012749274, 4758.857234282977, 4889.339939108175, 4908.214685650279, 4909.26361045846, 4961.454240033521, 4805.5915247204375, 4856.39295088114, 4870.31815545831, 4874.805007799649, 4891.926621100757, 4821.252705830461, 4853.369062021915, 4898.951010489992, 4901.705897646153, 4902.1911384621135, 4804.279358096313, 4825.0, 4984.42679091909, 4988.80044798204, 4996.650234483696, 4755.857324280277, 4761.857144285677, 4764.380630518011, 4783.784729687103, 4823.324734537097], "value": 4608.562131722959, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.6371739288395, 588.7056471764117, 590.9438603332682, 595.166766526862, 598.0192484325706, 27791.583126253096, 40278.0, 40737.59262407375, 41010.0, 41294.17411651773, 42661.0, 43051.569484305146, 43076.569234307644, 43124.35313470301, 43133.78433107838, 5681.886362272752, 5686.175504551838, 5686.800961966332, 5687.687177205252, 5833.095870140124, 7517.586532740697, 7811.609419529001, 7816.726414575491, 7820.569868657221, 7820.882686759704, 7458.291462311072, 7849.372050235967, 7853.332466740334, 7862.410319226081, 7870.370370370385, 7430.739924102658, 7791.532508049479, 7836.059672839296, 7839.686412543463, 7841.05907291123, 7722.343600793939, 7812.0, 7814.3748500119855, 7819.491733037335, 7822.335101516378, 39859.60842349439, 40240.1951960962, 40295.0, 40357.59642403568, 40384.39423408651, 3158.0367987763725, 3169.3344397676515, 3284.014795561346, 3312.519684645713, 3776.131489757344, 30139.246518836986, 30445.0, 30703.53944690809, 30967.380652386826, 31577.684223157932, 3361.193313604742, 3363.5291059251726, 3382.492626106079, 3397.9466365426797, 3417.743669224818, 205173.0, 269353.0, 271373.0, 272120.63939680374, 272946.0, 47776.522234777905, 48959.265611015864, 55329.723351382985, 56342.0, 56357.43642563604, 58153.12770308449, 59770.816042876584, 60006.0, 65219.0, 65400.345996540374, 14746.483873064391, 14850.108993460426, 14917.254137293308, 14920.477783277533, 14924.0, 9839.262055345735, 10069.244806639532, 11130.443477826077, 11220.719482013015, 11226.831597526043, 16095.517134485985, 18168.364107256184, 18770.155343009596, 18772.342967996326, 19219.423417297505, 7014.614196219257, 7198.5680859148615, 7203.819904502429, 7212.459065570103, 7269.345758881726, 856.2678909532385, 916.8441364967971, 932.6409332407072, 940.8682784410188, 973.4110862927968, 27516.312092197855, 28385.0, 28851.5672264912, 29023.709762902523, 29081.85459072691, 919.4207649180973, 991.667791289926, 998.2513115163628, 1007.7027276953316, 1035.4098164046572, 15051.548453546411, 15233.466828660943, 15261.694766104616, 15474.767878481833, 15495.380184792482, 393166.478346513, 394896.0, 397671.0, 399998.0, 401282.0, 50100.0, 50557.49442505528, 50588.24117638165, 50663.24005139926, 50723.49276507262, 1130.5082289204222, 1187.1571184458958, 1194.5460724924474, 1197.0543270815958, 1201.5614300780153, 27373.452530949668, 28161.57757633596, 28388.64929367571, 28461.0, 28651.856740716164, 42538.361924570534, 42920.78539607407, 42937.57062429336, 42945.570544295406, 42985.3552196711, 266019.0, 267515.0, 268206.0, 268268.0, 268496.0, 25303.620445692963, 25762.8711856447, 25862.22413327603, 26969.865150674123, 33048.173795655304, 33362.0, 34353.65646343605, 34676.65323346835, 44400.77799610981, 44463.33305000363, 36570.634293657786, 37046.25907481781, 38109.809450953675, 38151.23697525978, 38812.223755524166, 36454.8177259112, 37471.250574987804, 37976.0, 38079.238415232096, 38395.80802095972, 35583.0, 37052.66526012672, 37500.0, 37552.183586230596, 37899.24201515899, 33004.1748956278, 33958.83020584881, 34001.65998339985, 34039.829800850835, 34185.487217691254, 25839.741602584487, 25976.480470390863, 26065.73934260633, 26244.475110498064, 26376.604350935137], "value": 17633.91333541126, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.5152914742231, 361.8064335580465, 362.86029878496777, 373.0859394483516, 378.63650895140665, 15825.683486330267, 17150.485485435427, 17195.91402042991, 17555.2100155493, 17706.46880593581, 16213.351465941349, 16365.34538618454, 17177.91411042943, 17178.656426871454, 17178.656426871486, 5038.4457709652, 5127.282180494733, 5136.8458946231485, 5168.819091331804, 5174.80979374744, 3714.5542534895717, 3895.6299151580556, 5075.9746201268945, 5608.411116832735, 5952.642841429506, 5995.280566332046, 5996.520278377741, 6000.819975400745, 6023.186869772569, 6027.789027384042, 5715.799947001877, 5899.616524925909, 5962.910556341659, 6066.120412540201, 6075.787347442841, 3367.6632336766374, 4867.342908707315, 5173.793048278064, 5176.327077479904, 5186.636935414523, 19670.40988770339, 20302.289419870234, 20321.0, 20354.89822550878, 20431.182752689874, 1904.581371218773, 2017.9607502136412, 2180.738311402626, 2202.284257616281, 2285.4172186092605, 12695.301758403284, 13045.739085218338, 13257.602271931857, 13462.646819166532, 13505.86494135056, 1720.1829131162722, 1767.6994910865055, 1769.8761086723805, 1776.8933863968202, 1781.2785821742216, 65523.64311455738, 68245.0, 68446.315536845, 68513.0, 68722.65638671775, 9280.535973201313, 9342.766430839283, 9714.368566043184, 9714.708558743248, 9976.950115249378, 13354.799678004838, 13423.932880335537, 13441.596752097452, 13452.1256118352, 13452.663683407993, 7321.267873212636, 7326.523775954653, 7461.626918654046, 7540.622968851536, 7610.048743907012, 7106.360427561544, 7147.0, 7155.284471552907, 7167.283271672791, 7274.527155734861, 6127.356627554132, 6128.1114238435175, 6210.4100110489435, 6215.689215539205, 6270.7805226816845, 1597.4169428158639, 1696.8812183147309, 1698.5413938236607, 1698.5838469575033, 1762.3126980477623, 810.9472884262505, 906.5829718329642, 913.3789023463976, 968.8207681578931, 1019.5666841592442, 16541.6691666166, 17114.743278850827, 17525.912370438065, 17633.294668213384, 17699.29202831898, 911.0752586124956, 931.5035704312372, 935.9391639543408, 939.6335429182624, 941.4351389166445, 9617.758321714682, 10100.848487272697, 10109.090181883666, 10162.949185254174, 10210.744731381776, 363252.0, 372575.0, 377443.0, 381438.0, 382497.0, 68512.3148768516, 69059.0, 69298.3070169302, 69479.3052069483, 69734.0, 960.5917485068818, 963.6675347005272, 963.8939716631165, 971.5530855806267, 976.2629214942673, 15363.155026473205, 15445.691086178438, 15455.381784728936, 15560.688786224438, 15973.840261597235, 32187.35625287528, 32304.0, 32510.67489325171, 33452.0, 33896.322073557894, 43677.78161109174, 44547.777261113486, 44648.776756116014, 44739.32891006573, 44904.77547612241, 7262.455315851438, 7278.96360518194, 7342.412606991321, 7397.149327827368, 7459.813504662427, 10771.299865508718, 10934.56261749521, 10988.890111099106, 11248.043916267208, 11254.21220514556, 7453.850922981402, 7460.626968651654, 9437.81124377495, 9561.760955976157, 9640.084192001748, 9225.630974761203, 9378.437293762396, 9386.718398448058, 9552.95223523878, 9701.6119355225, 9412.95293523528, 9482.146606805421, 9567.425954442755, 9752.609895604097, 9946.35348702332, 7096.929030709627, 7207.9279207207255, 7262.201157872735, 7267.273272672691, 7283.708651654087, 9645.9035409645, 9659.806803864023, 9735.367201131903, 9739.9026009739, 9744.07431294026], "value": 8214.361260952372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.724840535082, 1417.971640567189, 1468.375940225404, 1578.810542734872, 1781.8752687311894, 6836.726530938763, 7738.18749031352, 8078.232567906054, 8087.838243235139, 8272.420930534865, 7943.880841787378, 8167.795805104875, 8179.222973817477, 8180.754577362673, 8187.590620468967, 1905.571246469547, 2111.947201319964, 2181.182056728727, 2205.834562407818, 2241.4396400899777, 2208.729980261348, 2224.8776317302622, 2230.643097104464, 2237.686723858661, 2237.944051398712, 2137.3374253981237, 2196.615592271346, 2227.8551894126913, 2231.1967691631, 2232.229880691167, 1853.4161739052222, 2081.969425134568, 2151.333086743107, 2164.9134034638596, 2171.6091103601348, 2143.528423746773, 2157.1910533549917, 2161.6433288507533, 2164.6428339323993, 2183.759786423492, 8045.517268963881, 8086.433949623529, 8091.474054186518, 8091.959540202321, 8098.514089154611, 4437.889052773674, 4588.0, 4589.0, 4592.357070010201, 4592.7014744041535, 2862.7423531882023, 3024.561438591414, 3073.846307684629, 3090.860911258999, 3097.767667424952, 887.6360692116266, 887.7292425810125, 896.6458248991612, 908.159952044363, 924.570074915161, 11110.722231944184, 11115.777684446346, 11116.277441966246, 11137.05335046522, 11146.275492092907, 4003.179348233605, 4157.542670306264, 4221.767802770877, 4226.682998775104, 4227.429297044921, 9363.204127649089, 9406.1064198901, 9417.811643767087, 9428.10433008863, 9432.528373581294, 4573.131105090022, 4619.838305659353, 4628.907421851612, 4638.83764068256, 4661.813527458864, 3718.3678774608384, 4107.691923105779, 4270.572942705767, 4289.914201715948, 4333.674974376934, 3535.734819888519, 3605.2248766515327, 3623.9456408153897, 3648.5986541480415, 3685.3182161300247, 1178.1046404732465, 1191.880811918801, 1196.7726132034886, 1210.2738356985737, 1212.9636110916686, 865.6148014133651, 875.4922145155795, 877.4779006491127, 887.7469921072593, 896.0770406481205, 5544.861378465571, 5673.149027645886, 5690.2033715279895, 5778.104393818965, 5867.559933004956, 398.6671129606811, 417.42812347084686, 418.949726032878, 428.9270823959934, 432.71657064622724, 3708.3881159608363, 3792.7724336539345, 3805.06775839921, 3874.1476875087437, 3932.193900250499, 9419.623215071457, 9671.419714816993, 9791.853122203172, 9799.0, 9833.557489912972, 9649.179819715402, 9738.318317717692, 9777.804443911082, 9790.265730070274, 9795.755106122262, 7060.894086588808, 7352.558846469229, 7421.257874212643, 7451.627418629047, 7466.514676546007, 5649.322081350264, 5752.223449834386, 5774.595778295479, 5842.737076831468, 5897.498712609305, 9012.459252444874, 9218.907810921804, 9293.953530232306, 9389.859152112587, 9411.10594493522, 9248.537573121452, 9366.157045865904, 9366.67216647414, 9370.578323975302, 9377.296702747457, 6278.529110316836, 6743.865122697617, 6912.377885990285, 6927.89608155868, 7027.4729395294535, 7753.139246580893, 7813.570253635878, 7864.449488535747, 7870.9606451967375, 7892.684292628231, 6837.076994605664, 6839.521233513607, 6969.7909062728195, 7053.259407762316, 7128.501004929605, 7018.508704390643, 7043.0, 7050.15398152225, 7089.0784198053925, 7159.140903091662, 6537.411632953057, 6540.149780528691, 6599.736010559716, 6616.801495955129, 6619.27188009309, 4902.534259245366, 4904.166291730486, 4915.164422048332, 4940.135476291563, 4971.527704868032, 4992.076465853828, 5028.1954887219335, 5043.4365346742625, 5049.722265275445, 5093.4651861554], "value": 4162.109492304187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3027802994783, 297.6814808155274, 302.2986670923458, 307.76763543524635, 310.619491123374, 4564.922960053176, 4682.41469816273, 4706.223473126935, 4806.110869489143, 4840.515948405162, 4550.840720574773, 4717.433907931053, 4734.881627959294, 4743.620510359172, 4748.169070412681, 3767.566729826071, 3771.905702357449, 3771.962280377202, 3781.506305009533, 3783.9404966609395, 3593.6047034826147, 3613.187032917586, 3781.2626537825136, 3785.3564893967955, 3789.2800367930145, 3755.605661405554, 3761.755485893408, 3768.321702093622, 3779.433085037239, 3795.5635101963353, 3734.9813250933844, 3743.943840842403, 3752.2307926874923, 3773.245350929811, 3791.146991926822, 3346.4645656695056, 3347.2092430549783, 3361.9495707564406, 3366.394049071166, 3378.749862550872, 4475.418195634579, 4519.706219095781, 4553.385292985471, 4558.931616025762, 4579.610733087691, 4281.357796330544, 4285.4214681017975, 4290.549492303326, 4297.4413326267695, 4303.31147016479, 4918.385201849769, 4934.4572097069295, 4956.553910148068, 4967.801287948478, 4970.0, 3495.8252087395526, 3635.1093981974323, 3668.321360548307, 3668.8899333020054, 3673.669369756735, 5125.513076257786, 5174.404943431516, 5183.071564566008, 5204.479552044765, 5209.874075554675, 3714.795686237229, 3733.831977561016, 3741.85032598693, 3754.249150169977, 3767.453719210699, 3830.1765120499226, 3832.7317087804145, 3840.711946604016, 3842.8462861485227, 3853.094522787143, 4041.3533834586324, 4225.239456897788, 4233.809478573472, 4243.533211346749, 4250.362445633118, 4872.684375218742, 4924.138275801721, 4944.728039957765, 4958.826441074545, 4965.875853103701, 1249.2317224906617, 1270.8879730236044, 1314.1983390132011, 1317.2228385252556, 1329.6077657091182, 845.3321875718236, 846.6655671009917, 852.8507511185518, 864.2135656552633, 870.3776799588325, 3870.806459677005, 3909.9609003910164, 3914.9021274468364, 3917.764934103963, 3930.744501607386, 4493.73037617744, 4502.932456013163, 4523.32150177476, 4569.13186494565, 4575.0, 3872.780074276594, 3917.8451851481573, 3961.8613348532663, 3964.7819369934355, 3974.2448934702315, 2313.35226136682, 2408.2775167449695, 2411.831171817991, 2412.3969007748065, 2421.2252079334444, 4286.61420472159, 4306.849260275875, 4307.612314891675, 4318.50875089903, 4334.869953901388, 4508.176251410959, 4538.478075021415, 4547.204239258117, 4568.81724731007, 4630.527104671496, 4273.9358909616385, 4309.913801723948, 4312.827486900489, 4535.886602835021, 4929.359183306147, 5145.125328694056, 5153.922691159561, 5165.328507294028, 5179.870503237449, 5198.491018562379, 5062.82280120194, 5067.049186063318, 5068.771905264198, 5073.746312684277, 5096.267269128514, 4749.459039413897, 4950.950490495193, 4952.579030782424, 4972.359121489827, 4983.327250821238, 3592.317459682652, 3605.7656252343513, 3619.3304238715923, 3622.6558476944647, 3626.9818650906577, 4922.556969872729, 5165.302684137593, 5177.301064356264, 5186.611004174627, 5191.896162076661, 4870.512948705101, 4973.676711013773, 4981.825636102864, 4983.159599028519, 4990.930577694764, 4959.876003099951, 4967.162150004521, 4993.201087825931, 4994.400671919393, 4999.625028122832, 4783.7129772213775, 4932.679375840559, 4946.851594452172, 4968.27959945813, 4979.5102448775615, 5071.1632580625255, 5076.771545280398, 5090.720010399464, 5093.962415034016, 5105.489451054865, 4868.810928841614, 4921.581665558468, 4937.185364414831, 4939.357883475125, 4942.456329803791], "value": 3700.5045778626077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.2697302697303, 778.2101167315176, 781.7732857471335, 785.7788847870245, 790.7943934577008, 12017.459214335355, 12537.059720520952, 12562.560310389139, 12579.371031448436, 12634.810477842828, 11623.65129046128, 11678.708032299197, 11703.297802131856, 11714.062874970003, 11740.647780566596, 620.1844574384693, 637.9872402551946, 774.3650206830388, 786.3001928283832, 788.2826627768732, 779.2674885607539, 805.6616221187086, 807.1726480357622, 807.1887752808419, 809.0493669937829, 844.3709436469838, 850.6214734443175, 851.1360968616859, 851.2636569367514, 852.2244757270885, 649.8375406148463, 671.7749553899449, 845.5011543189516, 846.1834329871673, 846.5301757524571, 493.32907246145214, 494.9059678661043, 596.9403059694039, 611.62996387186, 613.1416017575385, 12276.75446491074, 12285.201461905037, 12299.56951506702, 12312.507499700001, 12345.38273086342, 11777.882221177764, 12192.51229950801, 12195.695107622292, 12242.326672033034, 12626.68433289166, 10942.23404361695, 10966.670999870017, 11065.889341106566, 11156.609518666888, 11196.832047519212, 4089.3661482469965, 4109.938350924738, 4114.979425102855, 4152.584741525823, 4222.9788851055855, 45667.77166114148, 46151.0, 46480.5351946483, 46606.76696616529, 46753.766231168964, 9667.661631842851, 9756.658516952015, 9808.509574521388, 9825.950870245746, 10017.69946901594, 17315.480535583953, 17362.565935851704, 17376.0, 17377.82622173762, 17428.0, 6649.434798042221, 6671.733130674816, 6745.325467453314, 6814.0, 6863.519553631298, 3547.219611685425, 3628.401313783196, 3711.628837116321, 3717.219383929351, 3744.213715119801, 2849.957250641242, 2892.262473069396, 2895.840728759896, 2897.565365195195, 2939.4855900217804, 521.6035812782237, 527.1512864288493, 528.6167528541853, 535.4912832808848, 545.8580769000009, 456.6529437627427, 513.7071869034689, 544.3685325022955, 547.4716898193262, 551.8813455107171, 7646.120696119906, 7668.80827979305, 7726.072871255486, 7745.573993430416, 7883.290503854566, 489.86283840524, 534.5269436548605, 538.3055857943209, 581.2995340614549, 581.316952580716, 3768.520773585575, 3817.10298079951, 3837.827297771607, 3852.903677408031, 3907.7264591478893, 53244.201336979975, 54346.184807227924, 54583.0, 54680.0, 54773.72613136909, 48086.51913480891, 49133.26300105501, 50204.748976255614, 51180.48819511757, 51387.22919156215, 45472.0, 45733.54266457293, 45989.0, 46427.28581713455, 46643.30035049409, 7230.323611665916, 7244.565326080452, 7351.70593176267, 7453.217412171861, 7456.627168641655, 31222.68777312198, 31607.367852643278, 31650.208744781565, 31896.5215521772, 32260.35479290448, 38252.80873595725, 40544.391834123104, 40592.59407406006, 40887.0, 41263.793681031406, 8963.820723585623, 9292.767680808034, 9430.0, 9577.377470464677, 9673.854892176481, 9894.901050989398, 10149.137323327599, 10159.7460063499, 10185.898141018792, 10471.476426178508, 9106.726798196065, 9244.168024877794, 9370.0, 9388.152475099447, 9400.106989835955, 9028.819423611621, 9282.62869485213, 9616.75958101053, 9648.276379271443, 10008.64969726056, 8626.439281446686, 8647.135286471303, 8910.509921954355, 8953.93545506402, 8956.059613740463, 8860.468371897707, 8967.461952282883, 8985.326100542356, 9524.095210954949, 9573.2820038496, 9966.800663986825, 10049.397036177852, 10128.240381971234, 10144.28989970695, 10150.593976241164], "value": 5820.401056149006, "unit": "score"}], "name": "dromaeo_css", "value": 6254.286689088678, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 114.0, 115.0, 113.0, 115.0, 112.0, 113.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 131.0, 182.0, 131.0, 130.0, 163.0, 135.0, 176.0, 129.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 162.0, 160.0, 163.0, 162.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 106.0, 84.0, 77.0, 76.0, 74.0, 100.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 114.0, 85.0, 86.0, 84.0, 116.0, 84.0, 84.0, 126.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 65.0, 64.0, 65.0, 65.0, 71.0, 64.0, 64.0, 72.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 91.0, 88.0, 84.0, 84.0, 83.0, 85.0, 112.0, 84.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 143.0, 140.0, 139.0, 130.0, 143.0, 139.0, 133.0, 141.0, 132.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 170.0, 169.0, 170.0, 169.0, 167.0, 172.0, 170.0, 167.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 72.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1549.9, "alertThreshold": 2.0}]} 02:27:33 INFO - Return code: 0 02:27:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:33 ERROR - # TBPL SUCCESS # 02:27:33 INFO - Running post-action listener: _resource_record_post_action 02:27:33 INFO - ##### 02:27:33 INFO - ##### Finished run-tests step (success) 02:27:33 INFO - ##### 02:27:33 INFO - Running post-run listener: _resource_record_post_run 02:27:33 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 523317248; Read time: 396; Write time: 488780 02:27:33 INFO - TinderboxPrint: CPU usage
13.1% 02:27:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 396 02:27:33 INFO - TinderboxPrint: I/O write bytes / time
523,317,248 / 488,780 02:27:33 INFO - TinderboxPrint: CPU idle
8,317.9 (86.8%) 02:27:33 INFO - TinderboxPrint: CPU user
1,216.0 (12.7%) 02:27:33 INFO - TinderboxPrint: Swap in / out
0 / 0 02:27:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 243326976; Read time: 224; Write time: 237388 02:27:33 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279990272; Read time: 172; Write time: 251392 02:27:34 INFO - Running post-run listener: _upload_blobber_files 02:27:34 INFO - Blob upload gear active. 02:27:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:34 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 02:27:34 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'] 02:27:34 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 02:27:34 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:35 INFO - (blobuploader) - INFO - Done attempting. 02:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:36 INFO - (blobuploader) - INFO - Done attempting. 02:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:27:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:40 INFO - (blobuploader) - INFO - Done attempting. 02:27:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:40 INFO - Return code: 0 02:27:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/725ffbcbb7229128c0ff7aaf61c9a852b7504edfdef5a579e145249951c3760a07bac30f165e2bfa5baf9871e9fa92906292a656417148169bbb0aee8511f9cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a908ec66a6a5280e0add1cf0486ccbe85aefeaf159c333cbc827f17302c5ffff67d170beb37a4a406eea93f0b02a1a2e3e9a0c0f21247de2a0217826ff4c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdc39baaf6d95bd56b2f42744df8b906d218bc7ac3b38a40b2a42417767c2538b53a029bb92ec55c15b042c391cc389323b871cf2cf778a0eaafd081b8d71da5"} 02:27:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:40 INFO - Contents: 02:27:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/725ffbcbb7229128c0ff7aaf61c9a852b7504edfdef5a579e145249951c3760a07bac30f165e2bfa5baf9871e9fa92906292a656417148169bbb0aee8511f9cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a908ec66a6a5280e0add1cf0486ccbe85aefeaf159c333cbc827f17302c5ffff67d170beb37a4a406eea93f0b02a1a2e3e9a0c0f21247de2a0217826ff4c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdc39baaf6d95bd56b2f42744df8b906d218bc7ac3b38a40b2a42417767c2538b53a029bb92ec55c15b042c391cc389323b871cf2cf778a0eaafd081b8d71da5"} 02:27:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:40 INFO - Copying logs to upload dir... 02:27:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.798792 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 02:27:39.759660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 02:27:39.767182) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436 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/725ffbcbb7229128c0ff7aaf61c9a852b7504edfdef5a579e145249951c3760a07bac30f165e2bfa5baf9871e9fa92906292a656417148169bbb0aee8511f9cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a908ec66a6a5280e0add1cf0486ccbe85aefeaf159c333cbc827f17302c5ffff67d170beb37a4a406eea93f0b02a1a2e3e9a0c0f21247de2a0217826ff4c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdc39baaf6d95bd56b2f42744df8b906d218bc7ac3b38a40b2a42417767c2538b53a029bb92ec55c15b042c391cc389323b871cf2cf778a0eaafd081b8d71da5"} build_url:https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/WuftPJK7T366hgJJkvh5Qg/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/725ffbcbb7229128c0ff7aaf61c9a852b7504edfdef5a579e145249951c3760a07bac30f165e2bfa5baf9871e9fa92906292a656417148169bbb0aee8511f9cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a908ec66a6a5280e0add1cf0486ccbe85aefeaf159c333cbc827f17302c5ffff67d170beb37a4a406eea93f0b02a1a2e3e9a0c0f21247de2a0217826ff4c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdc39baaf6d95bd56b2f42744df8b906d218bc7ac3b38a40b2a42417767c2538b53a029bb92ec55c15b042c391cc389323b871cf2cf778a0eaafd081b8d71da5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 02:27:39.798653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:27:39.799049) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464772018.37435-882324436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:27:39.878604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 02:27:39.882064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 02:27:40.140429) ========= ========= Total master_lag: 0.18 =========