builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1464569597.83 results: success (0) buildid: 20160529172438 builduid: 866b07f2ee0d4d5c9a85923e39483441 revision: f59918cf04fa5954101b0274ebf60fb7e11e7a21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:17.832726) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:17.833522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:17.833851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:17.925265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:17.925598) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 17:53:19-- 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% 33.3M=0s 2016-05-29 17:53:19 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092658 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:18.066673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:18.067067) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015747 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:18.118764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 17:53:18.119132) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f59918cf04fa5954101b0274ebf60fb7e11e7a21 --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 f59918cf04fa5954101b0274ebf60fb7e11e7a21 --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=e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 17:53:19,795 truncating revision to first 12 chars 2016-05-29 17:53:19,795 Setting DEBUG logging. 2016-05-29 17:53:19,795 attempt 1/10 2016-05-29 17:53:19,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f59918cf04fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 17:53:20,597 unpacking tar archive at: fx-team-f59918cf04fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.117114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 17:53:19.252457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:19.252887) ========= script_repo_revision: f59918cf04fa5954101b0274ebf60fb7e11e7a21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:19.253352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:19.253687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 17:53:19.267195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-29 17:53:19.267584) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:53:21 INFO - MultiFileLogger online at 20160529 17:53:21 in /builds/slave/test 17:53:21 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 17:53:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:53:21 INFO - {'append_to_log': False, 17:53:21 INFO - 'base_work_dir': '/builds/slave/test', 17:53:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:53:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:53:21 INFO - 'branch': 'Fx-Team-Non-PGO', 17:53:21 INFO - 'buildbot_json_path': 'buildprops.json', 17:53:21 INFO - 'config_files': ('talos/linux_config.py',), 17:53:21 INFO - 'default_actions': ('clobber', 17:53:21 INFO - 'read-buildbot-config', 17:53:21 INFO - 'download-and-extract', 17:53:21 INFO - 'populate-webroot', 17:53:21 INFO - 'create-virtualenv', 17:53:21 INFO - 'install', 17:53:21 INFO - 'run-tests'), 17:53:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:53:21 INFO - 'download_minidump_stackwalk': True, 17:53:21 INFO - 'download_symbols': 'ondemand', 17:53:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:53:21 INFO - 'tooltool.py': '/tools/tooltool.py', 17:53:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:53:21 INFO - '/tools/misc-python/virtualenv.py')}, 17:53:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:53:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:53:21 INFO - 'installer_path': 'installer.exe', 17:53:21 INFO - 'log_level': 'info', 17:53:21 INFO - 'log_name': 'talos', 17:53:21 INFO - 'log_to_console': True, 17:53:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:53:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:53:21 INFO - 'opt_config_files': (), 17:53:21 INFO - 'pip_index': False, 17:53:21 INFO - 'sps_profile': False, 17:53:21 INFO - 'sps_profile_interval': 0, 17:53:21 INFO - 'suite': 'dromaeojs', 17:53:21 INFO - 'system_bits': '32', 17:53:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:53:21 INFO - 'title': 'talos-linux64-ix-006', 17:53:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:53:21 INFO - 'use_talos_json': True, 17:53:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:53:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:53:21 INFO - 'work_dir': 'build'} 17:53:21 INFO - ##### 17:53:21 INFO - ##### Running clobber step. 17:53:21 INFO - ##### 17:53:21 INFO - Running pre-action listener: _resource_record_pre_action 17:53:21 INFO - Running main action method: clobber 17:53:21 INFO - rmtree: /builds/slave/test/build 17:53:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:53:22 INFO - Running post-action listener: _resource_record_post_action 17:53:22 INFO - ##### 17:53:22 INFO - ##### Finished clobber step (success) 17:53:22 INFO - ##### 17:53:22 INFO - ##### 17:53:22 INFO - ##### Running read-buildbot-config step. 17:53:22 INFO - ##### 17:53:22 INFO - Running pre-action listener: _resource_record_pre_action 17:53:22 INFO - Running main action method: read_buildbot_config 17:53:22 INFO - Using buildbot properties: 17:53:22 INFO - { 17:53:22 INFO - "project": "", 17:53:22 INFO - "product": "firefox", 17:53:22 INFO - "script_repo_revision": "production", 17:53:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:53:22 INFO - "repository": "", 17:53:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:53:22 INFO - "buildid": "20160529172438", 17:53:22 INFO - "pgo_build": "False", 17:53:22 INFO - "basedir": "/builds/slave/test", 17:53:22 INFO - "buildnumber": 1799, 17:53:22 INFO - "slavename": "talos-linux64-ix-006", 17:53:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:53:22 INFO - "platform": "ubuntu64_hw", 17:53:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:53:22 INFO - "branch": "fx-team", 17:53:22 INFO - "repo_path": "integration/fx-team", 17:53:22 INFO - "revision": "f59918cf04fa5954101b0274ebf60fb7e11e7a21", 17:53:22 INFO - "stage_platform": "linux64", 17:53:22 INFO - "builduid": "866b07f2ee0d4d5c9a85923e39483441", 17:53:22 INFO - "slavebuilddir": "test" 17:53:22 INFO - } 17:53:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:53:22 INFO - Running post-action listener: _resource_record_post_action 17:53:22 INFO - ##### 17:53:22 INFO - ##### Finished read-buildbot-config step (success) 17:53:22 INFO - ##### 17:53:22 INFO - ##### 17:53:22 INFO - ##### Running download-and-extract step. 17:53:22 INFO - ##### 17:53:22 INFO - Running pre-action listener: _resource_record_pre_action 17:53:22 INFO - Running main action method: download_and_extract 17:53:22 INFO - mkdir: /builds/slave/test/build/tests 17:53:22 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')]} 17:53:22 INFO - https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:27 INFO - Downloaded 1361 bytes. 17:53:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:53:27 INFO - Using the following test package requirements: 17:53:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:53:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:53:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:53:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'jsshell-linux-x86_64.zip'], 17:53:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:53:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:53:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:53:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:53:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:53:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:53:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:53: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')]} 17:53:27 INFO - https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:32 INFO - Downloaded 22837897 bytes. 17:53:32 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'] 17:53:32 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 17:53:33 INFO - Return code: 0 17:53:33 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 17:53:33 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')]} 17:53:33 INFO - https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:53:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:45 INFO - Downloaded 22837897 bytes. 17:53:45 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'] 17:53:45 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 17:53:46 INFO - Return code: 0 17:53:46 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')]} 17:53:46 INFO - https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:47 INFO - Downloaded 10834034 bytes. 17:53:47 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'] 17:53:47 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 17:53:48 INFO - Return code: 0 17:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:48 INFO - https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:53:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:53:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:53:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-QvnegUTr6blC_xQLg3ng/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 17:53:49 INFO - Downloaded 54831916 bytes. 17:53:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:53:49 INFO - mkdir: /builds/slave/test/properties 17:53:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:53:49 INFO - Writing to file /builds/slave/test/properties/build_url 17:53:49 INFO - Contents: 17:53:49 INFO - build_url:https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:53:50 INFO - Running post-action listener: _resource_record_post_action 17:53:50 INFO - Running post-action listener: set_extra_try_arguments 17:53:50 INFO - ##### 17:53:50 INFO - ##### Finished download-and-extract step (success) 17:53:50 INFO - ##### 17:53:50 INFO - ##### 17:53:50 INFO - ##### Running populate-webroot step. 17:53:50 INFO - ##### 17:53:50 INFO - Running pre-action listener: _resource_record_pre_action 17:53:50 INFO - Running main action method: populate_webroot 17:53:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:53:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:53:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:53:50 INFO - '--tppagecycles', 17:53:50 INFO - '7'], 17:53:50 INFO - 'tests': ['tsvgm']}}, 17:53:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:53:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:53:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:53:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:53:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['damp', 'tps']}, 17:53:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'tests': ['damp', 'tps']}, 17:53:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['dromaeo_dom']}, 17:53:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:53:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['a11yr', 17:53:50 INFO - 'ts_paint', 17:53:50 INFO - 'tpaint', 17:53:50 INFO - 'sessionrestore', 17:53:50 INFO - 'sessionrestore_no_auto_restore', 17:53:50 INFO - 'tabpaint']}, 17:53:50 INFO - 'other-e10s': {'tests': ['a11yr', 17:53:50 INFO - 'ts_paint', 17:53:50 INFO - 'tpaint', 17:53:50 INFO - 'sessionrestore', 17:53:50 INFO - 'sessionrestore_no_auto_restore', 17:53:50 INFO - 'tabpaint']}, 17:53:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:53:50 INFO - 'ts_paint', 17:53:50 INFO - 'tpaint', 17:53:50 INFO - 'sessionrestore', 17:53:50 INFO - 'sessionrestore_no_auto_restore', 17:53:50 INFO - 'tabpaint']}, 17:53:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:53:50 INFO - 'ts_paint', 17:53:50 INFO - 'tpaint', 17:53:50 INFO - 'sessionrestore', 17:53:50 INFO - 'sessionrestore_no_auto_restore', 17:53:50 INFO - 'tabpaint']}, 17:53:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['a11yr', 17:53:50 INFO - 'ts_paint', 17:53:50 INFO - 'tpaint', 17:53:50 INFO - 'sessionrestore', 17:53:50 INFO - 'sessionrestore_no_auto_restore', 17:53:50 INFO - 'tabpaint']}, 17:53:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['a11yr', 17:53:50 INFO - 'ts_paint', 17:53:50 INFO - 'tpaint', 17:53:50 INFO - 'sessionrestore', 17:53:50 INFO - 'sessionrestore_no_auto_restore', 17:53:50 INFO - 'tabpaint']}, 17:53:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['tsvgx', 17:53:50 INFO - 'tsvgr_opacity', 17:53:50 INFO - 'tart', 17:53:50 INFO - 'tscrollx', 17:53:50 INFO - 'cart']}, 17:53:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:53:50 INFO - 'tsvgr_opacity', 17:53:50 INFO - 'tart', 17:53:50 INFO - 'tscrollx', 17:53:50 INFO - 'cart']}, 17:53:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'talos_options': ['--disable-e10s'], 17:53:50 INFO - 'tests': ['tp5o']}, 17:53:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'tests': ['tp5o']}, 17:53:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'talos_options': ['--disable-e10s', 17:53:50 INFO - '--xperf_path', 17:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:53:50 INFO - 'tests': ['tp5n']}, 17:53:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:50 INFO - 'talos_options': ['--xperf_path', 17:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:53:50 INFO - 'tests': ['tp5n']}}, 17:53:50 INFO - 'talos.zip': {'path': '', 17:53:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:53:50 INFO - Running post-action listener: _resource_record_post_action 17:53:50 INFO - ##### 17:53:50 INFO - ##### Finished populate-webroot step (success) 17:53:50 INFO - ##### 17:53:50 INFO - ##### 17:53:50 INFO - ##### Running create-virtualenv step. 17:53:50 INFO - ##### 17:53:50 INFO - Running pre-action listener: _resource_record_pre_action 17:53:50 INFO - Running main action method: create_virtualenv 17:53:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:53:50 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 17:53:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:53:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:53:50 INFO - Using real prefix '/usr' 17:53:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:53:50 INFO - Installing distribute.............................................................................................................................................................................................done. 17:53:52 INFO - Installing pip.................done. 17:53:52 INFO - Return code: 0 17:53:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:53:52 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')]} 17:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:52 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')]} 17:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:52 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:53:52 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 17:53:52 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 17:53:52 INFO - Using env: {'DISPLAY': ':0', 17:53:52 INFO - 'HOME': '/home/cltbld', 17:53:52 INFO - 'LANG': 'en_US.UTF-8', 17:53:52 INFO - 'LANGUAGE': 'en_US:en', 17:53:52 INFO - 'LOGNAME': 'cltbld', 17:53:52 INFO - 'MAIL': '/var/mail/cltbld', 17:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:52 INFO - 'MOZ_NO_REMOTE': '1', 17:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:52 INFO - 'NO_EM_RESTART': '1', 17:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:52 INFO - 'PWD': '/builds/slave/test', 17:53:52 INFO - 'SHELL': '/bin/bash', 17:53:52 INFO - 'SHLVL': '1', 17:53:52 INFO - 'TERM': 'linux', 17:53:52 INFO - 'TMOUT': '86400', 17:53:52 INFO - 'USER': 'cltbld', 17:53:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:52 INFO - '_': '/tools/buildbot/bin/python'} 17:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:53 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 17:53:53 INFO - Cleaning up... 17:53:53 INFO - Return code: 0 17:53:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:53:53 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')]} 17:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:53 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')]} 17:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:53 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:53:53 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 17:53:53 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 17:53:53 INFO - Using env: {'DISPLAY': ':0', 17:53:53 INFO - 'HOME': '/home/cltbld', 17:53:53 INFO - 'LANG': 'en_US.UTF-8', 17:53:53 INFO - 'LANGUAGE': 'en_US:en', 17:53:53 INFO - 'LOGNAME': 'cltbld', 17:53:53 INFO - 'MAIL': '/var/mail/cltbld', 17:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:53 INFO - 'MOZ_NO_REMOTE': '1', 17:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:53 INFO - 'NO_EM_RESTART': '1', 17:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:53 INFO - 'PWD': '/builds/slave/test', 17:53:53 INFO - 'SHELL': '/bin/bash', 17:53:53 INFO - 'SHLVL': '1', 17:53:53 INFO - 'TERM': 'linux', 17:53:53 INFO - 'TMOUT': '86400', 17:53:53 INFO - 'USER': 'cltbld', 17:53:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:53 INFO - '_': '/tools/buildbot/bin/python'} 17:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:53 INFO - Downloading/unpacking psutil>=3.1.1 17:53:53 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 17:53:53 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 17:53:53 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 17:53:53 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 17:53:53 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 17:53:53 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 17:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:55 INFO - Installing collected packages: psutil 17:53:55 INFO - Running setup.py install for psutil 17:53:55 INFO - building 'psutil._psutil_linux' extension 17:53:55 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 17:53:55 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 17:53:55 INFO - building 'psutil._psutil_posix' extension 17:53:55 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 17:53:55 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 17:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:55 INFO - Successfully installed psutil 17:53:55 INFO - Cleaning up... 17:53:55 INFO - Return code: 0 17:53:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:55 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:53:55 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 17:53:55 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 17:53:55 INFO - Using env: {'DISPLAY': ':0', 17:53:55 INFO - 'HOME': '/home/cltbld', 17:53:55 INFO - 'LANG': 'en_US.UTF-8', 17:53:55 INFO - 'LANGUAGE': 'en_US:en', 17:53:55 INFO - 'LOGNAME': 'cltbld', 17:53:55 INFO - 'MAIL': '/var/mail/cltbld', 17:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:55 INFO - 'MOZ_NO_REMOTE': '1', 17:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:55 INFO - 'NO_EM_RESTART': '1', 17:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:55 INFO - 'PWD': '/builds/slave/test', 17:53:55 INFO - 'SHELL': '/bin/bash', 17:53:55 INFO - 'SHLVL': '1', 17:53:55 INFO - 'TERM': 'linux', 17:53:55 INFO - 'TMOUT': '86400', 17:53:55 INFO - 'USER': 'cltbld', 17:53:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:55 INFO - '_': '/tools/buildbot/bin/python'} 17:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:53:56 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 17:53:56 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 17:53:56 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 17:53:56 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 17:53:56 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 17:53:56 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 17:53:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:53:58 INFO - Installing collected packages: mozsystemmonitor 17:53:58 INFO - Running setup.py install for mozsystemmonitor 17:53:58 INFO - Successfully installed mozsystemmonitor 17:53:58 INFO - Cleaning up... 17:53:58 INFO - Return code: 0 17:53:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:58 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:53:58 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 17:53:58 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 17:53:58 INFO - Using env: {'DISPLAY': ':0', 17:53:58 INFO - 'HOME': '/home/cltbld', 17:53:58 INFO - 'LANG': 'en_US.UTF-8', 17:53:58 INFO - 'LANGUAGE': 'en_US:en', 17:53:58 INFO - 'LOGNAME': 'cltbld', 17:53:58 INFO - 'MAIL': '/var/mail/cltbld', 17:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:58 INFO - 'MOZ_NO_REMOTE': '1', 17:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:58 INFO - 'NO_EM_RESTART': '1', 17:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:58 INFO - 'PWD': '/builds/slave/test', 17:53:58 INFO - 'SHELL': '/bin/bash', 17:53:58 INFO - 'SHLVL': '1', 17:53:58 INFO - 'TERM': 'linux', 17:53:58 INFO - 'TMOUT': '86400', 17:53:58 INFO - 'USER': 'cltbld', 17:53:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:58 INFO - '_': '/tools/buildbot/bin/python'} 17:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:53:58 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 17:53:58 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 17:53:58 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 17:53:58 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 17:53:58 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 17:53:58 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 17:54:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:54:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:54:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 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 17:54:00 INFO - Downloading docopt-0.6.1.tar.gz 17:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:54:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:54:01 INFO - Running setup.py install for blobuploader 17:54:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:54:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:54:01 INFO - Running setup.py install for requests 17:54:01 INFO - Running setup.py install for docopt 17:54:01 INFO - Successfully installed blobuploader requests docopt 17:54:01 INFO - Cleaning up... 17:54:01 INFO - Return code: 0 17:54:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:01 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:54:01 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 17:54:01 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 17:54:01 INFO - Using env: {'DISPLAY': ':0', 17:54:01 INFO - 'HOME': '/home/cltbld', 17:54:01 INFO - 'LANG': 'en_US.UTF-8', 17:54:01 INFO - 'LANGUAGE': 'en_US:en', 17:54:01 INFO - 'LOGNAME': 'cltbld', 17:54:01 INFO - 'MAIL': '/var/mail/cltbld', 17:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:01 INFO - 'MOZ_NO_REMOTE': '1', 17:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:01 INFO - 'NO_EM_RESTART': '1', 17:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:01 INFO - 'PWD': '/builds/slave/test', 17:54:01 INFO - 'SHELL': '/bin/bash', 17:54:01 INFO - 'SHLVL': '1', 17:54:01 INFO - 'TERM': 'linux', 17:54:01 INFO - 'TMOUT': '86400', 17:54:01 INFO - 'USER': 'cltbld', 17:54:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:01 INFO - '_': '/tools/buildbot/bin/python'} 17:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:54:01 INFO - Running setup.py (path:/tmp/pip-H2iw7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:54:01 INFO - Running setup.py (path:/tmp/pip-5BM1Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:54:02 INFO - Running setup.py (path:/tmp/pip-qONNbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:54:02 INFO - Running setup.py (path:/tmp/pip-Nw6FTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:54:02 INFO - Running setup.py (path:/tmp/pip-Qbfo28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:54:02 INFO - Running setup.py (path:/tmp/pip-2nsc6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:54:02 INFO - Running setup.py (path:/tmp/pip-KzLpSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:54:02 INFO - Running setup.py (path:/tmp/pip-NHoOL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:54:02 INFO - Running setup.py (path:/tmp/pip-2dgKUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:54:02 INFO - Running setup.py (path:/tmp/pip-x86R5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:54:02 INFO - Running setup.py (path:/tmp/pip-IM3LNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:54:02 INFO - Running setup.py (path:/tmp/pip-y9OQp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:54:02 INFO - Running setup.py (path:/tmp/pip-xKqNAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:54:02 INFO - Running setup.py (path:/tmp/pip-BD6jGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:02 INFO - Running setup.py (path:/tmp/pip-Gbeg7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:54:02 INFO - Running setup.py (path:/tmp/pip-cJl2JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:54:03 INFO - Running setup.py (path:/tmp/pip-uMqH2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:54:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:54:03 INFO - Running setup.py install for manifestparser 17:54:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Running setup.py install for mozcrash 17:54:03 INFO - Running setup.py install for mozdebug 17:54:03 INFO - Running setup.py install for mozdevice 17:54:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Running setup.py install for mozfile 17:54:03 INFO - Running setup.py install for mozhttpd 17:54:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Running setup.py install for mozinfo 17:54:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Running setup.py install for mozInstall 17:54:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:54:03 INFO - Running setup.py install for mozleak 17:54:03 INFO - Running setup.py install for mozlog 17:54:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:54:04 INFO - Running setup.py install for moznetwork 17:54:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:54:04 INFO - Running setup.py install for mozprocess 17:54:04 INFO - Running setup.py install for mozprofile 17:54:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:54:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:54:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:54:04 INFO - Running setup.py install for mozrunner 17:54:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:54:04 INFO - Running setup.py install for mozscreenshot 17:54:04 INFO - Running setup.py install for moztest 17:54:04 INFO - Running setup.py install for mozversion 17:54:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:54:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:54:04 INFO - Cleaning up... 17:54:04 INFO - Return code: 0 17:54:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:04 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:54:04 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 17:54:04 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 17:54:04 INFO - Using env: {'DISPLAY': ':0', 17:54:04 INFO - 'HOME': '/home/cltbld', 17:54:04 INFO - 'LANG': 'en_US.UTF-8', 17:54:04 INFO - 'LANGUAGE': 'en_US:en', 17:54:04 INFO - 'LOGNAME': 'cltbld', 17:54:04 INFO - 'MAIL': '/var/mail/cltbld', 17:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:04 INFO - 'MOZ_NO_REMOTE': '1', 17:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:04 INFO - 'NO_EM_RESTART': '1', 17:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:04 INFO - 'PWD': '/builds/slave/test', 17:54:04 INFO - 'SHELL': '/bin/bash', 17:54:04 INFO - 'SHLVL': '1', 17:54:04 INFO - 'TERM': 'linux', 17:54:04 INFO - 'TMOUT': '86400', 17:54:04 INFO - 'USER': 'cltbld', 17:54:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:04 INFO - '_': '/tools/buildbot/bin/python'} 17:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:54:05 INFO - Running setup.py (path:/tmp/pip-xuwj9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:54:05 INFO - Running setup.py (path:/tmp/pip-B8ZF7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:54:05 INFO - Running setup.py (path:/tmp/pip-Yh8u2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:54:05 INFO - Running setup.py (path:/tmp/pip-N7dHHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:54:05 INFO - Running setup.py (path:/tmp/pip-PYpR67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:54:05 INFO - Running setup.py (path:/tmp/pip-TkjMDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:54:05 INFO - Running setup.py (path:/tmp/pip-B6RqBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:54:05 INFO - Running setup.py (path:/tmp/pip-j4ofXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:54:05 INFO - Running setup.py (path:/tmp/pip-C8_YN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:54:05 INFO - Running setup.py (path:/tmp/pip-7Gql9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:54:05 INFO - Running setup.py (path:/tmp/pip-p3oEpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:54:05 INFO - Running setup.py (path:/tmp/pip-YNuytI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:54:05 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)) 17:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:54:05 INFO - Running setup.py (path:/tmp/pip-NCwlaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:54:06 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)) 17:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:54:06 INFO - Running setup.py (path:/tmp/pip-myRS5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:54:06 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)) 17:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:06 INFO - Running setup.py (path:/tmp/pip-jhZ9tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:06 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)) 17:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:54:06 INFO - Running setup.py (path:/tmp/pip-O7eMpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:54:06 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)) 17:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:54:06 INFO - Running setup.py (path:/tmp/pip-uJWWii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:54:06 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)) 17:54:06 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)) 17:54:06 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)) 17:54:06 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)) 17:54:06 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)) 17:54:06 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)) 17:54:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:08 INFO - Downloading blessings-1.6.tar.gz 17:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:54:08 INFO - Installing collected packages: blessings 17:54:08 INFO - Running setup.py install for blessings 17:54:08 INFO - Successfully installed blessings 17:54:08 INFO - Cleaning up... 17:54:08 INFO - Return code: 0 17:54:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:54:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:54:08 INFO - Reading from file tmpfile_stdout 17:54:08 INFO - Current package versions: 17:54:08 INFO - argparse == 1.2.1 17:54:08 INFO - blessings == 1.6 17:54:08 INFO - blobuploader == 1.2.4 17:54:08 INFO - docopt == 0.6.1 17:54:08 INFO - manifestparser == 1.1 17:54:08 INFO - mozInstall == 1.12 17:54:08 INFO - mozcrash == 0.17 17:54:08 INFO - mozdebug == 0.1 17:54:08 INFO - mozdevice == 0.48 17:54:08 INFO - mozfile == 1.2 17:54:08 INFO - mozhttpd == 0.7 17:54:08 INFO - mozinfo == 0.9 17:54:08 INFO - mozleak == 0.1 17:54:08 INFO - mozlog == 3.2 17:54:08 INFO - moznetwork == 0.27 17:54:08 INFO - mozprocess == 0.22 17:54:08 INFO - mozprofile == 0.28 17:54:08 INFO - mozrunner == 6.11 17:54:08 INFO - mozscreenshot == 0.1 17:54:08 INFO - mozsystemmonitor == 0.3 17:54:08 INFO - moztest == 0.7 17:54:08 INFO - mozversion == 1.4 17:54:08 INFO - psutil == 3.1.1 17:54:08 INFO - requests == 1.2.3 17:54:08 INFO - wsgiref == 0.1.2 17:54:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:08 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')]} 17:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:08 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')]} 17:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:08 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:54:08 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 17:54:08 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 17:54:08 INFO - Using env: {'DISPLAY': ':0', 17:54:08 INFO - 'HOME': '/home/cltbld', 17:54:08 INFO - 'LANG': 'en_US.UTF-8', 17:54:08 INFO - 'LANGUAGE': 'en_US:en', 17:54:08 INFO - 'LOGNAME': 'cltbld', 17:54:08 INFO - 'MAIL': '/var/mail/cltbld', 17:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:08 INFO - 'MOZ_NO_REMOTE': '1', 17:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:08 INFO - 'NO_EM_RESTART': '1', 17:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:08 INFO - 'PWD': '/builds/slave/test', 17:54:08 INFO - 'SHELL': '/bin/bash', 17:54:08 INFO - 'SHLVL': '1', 17:54:08 INFO - 'TERM': 'linux', 17:54:08 INFO - 'TMOUT': '86400', 17:54:08 INFO - 'USER': 'cltbld', 17:54:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:08 INFO - '_': '/tools/buildbot/bin/python'} 17:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 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)) 17:54:08 INFO - Cleaning up... 17:54:08 INFO - Return code: 0 17:54:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:54:08 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')]} 17:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:08 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')]} 17:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:08 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 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:54:08 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 17:54:08 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 17:54:08 INFO - Using env: {'DISPLAY': ':0', 17:54:08 INFO - 'HOME': '/home/cltbld', 17:54:08 INFO - 'LANG': 'en_US.UTF-8', 17:54:08 INFO - 'LANGUAGE': 'en_US:en', 17:54:08 INFO - 'LOGNAME': 'cltbld', 17:54:08 INFO - 'MAIL': '/var/mail/cltbld', 17:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:08 INFO - 'MOZ_NO_REMOTE': '1', 17:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:08 INFO - 'NO_EM_RESTART': '1', 17:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:08 INFO - 'PWD': '/builds/slave/test', 17:54:08 INFO - 'SHELL': '/bin/bash', 17:54:08 INFO - 'SHLVL': '1', 17:54:08 INFO - 'TERM': 'linux', 17:54:08 INFO - 'TMOUT': '86400', 17:54:08 INFO - 'USER': 'cltbld', 17:54:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:08 INFO - '_': '/tools/buildbot/bin/python'} 17:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:09 INFO - Downloading/unpacking jsonschema 17:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:54:11 INFO - Downloading/unpacking functools32 (from jsonschema) 17:54:11 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 17:54:11 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 17:54:11 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 17:54:11 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 17:54:11 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 17:54:11 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 17:54:11 INFO - Downloading functools32-3.2.3-2.tar.gz 17:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:54:11 INFO - warning: no files found matching '*.txt' 17:54:11 INFO - no previously-included directories found matching 'build' 17:54:11 INFO - no previously-included directories found matching 'dist' 17:54:11 INFO - no previously-included directories found matching '.git*' 17:54:11 INFO - Installing collected packages: jsonschema, functools32 17:54:11 INFO - Running setup.py install for functools32 17:54:11 INFO - warning: no files found matching '*.txt' 17:54:11 INFO - no previously-included directories found matching 'build' 17:54:11 INFO - no previously-included directories found matching 'dist' 17:54:11 INFO - no previously-included directories found matching '.git*' 17:54:11 INFO - Successfully installed jsonschema functools32 17:54:11 INFO - Cleaning up... 17:54:11 INFO - Return code: 0 17:54:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:54: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')]} 17:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54: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')]} 17:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad921cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', '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 17:54: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', 'flake8'] in /builds/slave/test/build 17:54: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 flake8 17:54:11 INFO - Using env: {'DISPLAY': ':0', 17:54:11 INFO - 'HOME': '/home/cltbld', 17:54:11 INFO - 'LANG': 'en_US.UTF-8', 17:54:11 INFO - 'LANGUAGE': 'en_US:en', 17:54:11 INFO - 'LOGNAME': 'cltbld', 17:54:11 INFO - 'MAIL': '/var/mail/cltbld', 17:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:11 INFO - 'MOZ_NO_REMOTE': '1', 17:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:11 INFO - 'NO_EM_RESTART': '1', 17:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:11 INFO - 'PWD': '/builds/slave/test', 17:54:11 INFO - 'SHELL': '/bin/bash', 17:54:11 INFO - 'SHLVL': '1', 17:54:11 INFO - 'TERM': 'linux', 17:54:11 INFO - 'TMOUT': '86400', 17:54:11 INFO - 'USER': 'cltbld', 17:54:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:11 INFO - '_': '/tools/buildbot/bin/python'} 17:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:11 INFO - Downloading/unpacking flake8 17:54:11 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 17:54:11 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 17:54:11 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 17:54:11 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 17:54:11 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 17:54:11 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 17:54:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:54:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:54:13 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 17:54:13 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 17:54:13 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 17:54:13 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 17:54:13 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 17:54:13 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 17:54:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:54:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:54:14 INFO - no previously-included directories found matching 'docs/_build' 17:54:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:54:14 INFO - Running setup.py install for pep8 17:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:54:14 INFO - no previously-included directories found matching 'docs/_build' 17:54:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:54:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:54:14 INFO - Cleaning up... 17:54:14 INFO - Return code: 0 17:54:14 INFO - Running post-action listener: _resource_record_post_action 17:54:14 INFO - Running post-action listener: _start_resource_monitoring 17:54:14 INFO - Starting resource monitoring. 17:54:14 INFO - ##### 17:54:14 INFO - ##### Finished create-virtualenv step (success) 17:54:14 INFO - ##### 17:54:14 INFO - ##### 17:54:14 INFO - ##### Running install step. 17:54:14 INFO - ##### 17:54:14 INFO - Running pre-action listener: _resource_record_pre_action 17:54:14 INFO - Running main action method: install 17:54:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:54:15 INFO - Reading from file tmpfile_stdout 17:54:15 INFO - Detecting whether we're running mozinstall >=1.0... 17:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:54:15 INFO - Reading from file tmpfile_stdout 17:54:15 INFO - Output received: 17:54:15 INFO - Usage: mozinstall [options] installer 17:54:15 INFO - Options: 17:54:15 INFO - -h, --help show this help message and exit 17:54:15 INFO - -d DEST, --destination=DEST 17:54:15 INFO - Directory to install application into. [default: 17:54:15 INFO - "/builds/slave/test"] 17:54:15 INFO - --app=APP Application being installed. [default: firefox] 17:54:15 INFO - mkdir: /builds/slave/test/build/application 17:54:15 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'] 17:54:15 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 17:54:30 INFO - Reading from file tmpfile_stdout 17:54:30 INFO - Output received: 17:54:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:54:30 INFO - Running post-action listener: _resource_record_post_action 17:54:30 INFO - ##### 17:54:30 INFO - ##### Finished install step (success) 17:54:30 INFO - ##### 17:54:30 INFO - ##### 17:54:30 INFO - ##### Running run-tests step. 17:54:30 INFO - ##### 17:54:30 INFO - Running pre-action listener: _resource_record_pre_action 17:54:30 INFO - Running main action method: run_tests 17:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:54:30 INFO - Python 2.7.3 17:54:30 INFO - Return code: 0 17:54:30 INFO - grabbing minidump binary from tooltool 17:54: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')]} 17:54:30 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 0x1cc29c0>, '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 0x1cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:54:30 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 17:54:30 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 17:54:30 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 17:54:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:54:31 INFO - Return code: 0 17:54:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:54:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:54:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:54:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:54:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:54:31 INFO - Return code: 0 17:54:31 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/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 17:54:31 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/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 17:54:31 INFO - Using env: {'DISPLAY': ':0', 17:54:31 INFO - 'HOME': '/home/cltbld', 17:54:31 INFO - 'LANG': 'en_US.UTF-8', 17:54:31 INFO - 'LANGUAGE': 'en_US:en', 17:54:31 INFO - 'LOGNAME': 'cltbld', 17:54:31 INFO - 'MAIL': '/var/mail/cltbld', 17:54:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:54:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:31 INFO - 'MOZ_NO_REMOTE': '1', 17:54:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:31 INFO - 'NO_EM_RESTART': '1', 17:54:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:31 INFO - 'PWD': '/builds/slave/test', 17:54:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:54:31 INFO - 'SHELL': '/bin/bash', 17:54:31 INFO - 'SHLVL': '1', 17:54:31 INFO - 'TERM': 'linux', 17:54:31 INFO - 'TMOUT': '86400', 17:54:31 INFO - 'USER': 'cltbld', 17:54:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324', 17:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:31 INFO - '_': '/tools/buildbot/bin/python'} 17:54:31 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/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 17:54:32 INFO - mozversion application_buildid: 20160529172438 17:54:32 INFO - mozversion application_changeset: f59918cf04fa5954101b0274ebf60fb7e11e7a21 17:54:32 INFO - mozversion application_display_name: Nightly 17:54:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:54:32 INFO - mozversion application_name: Firefox 17:54:32 INFO - mozversion application_remotingname: firefox 17:54:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:54:32 INFO - mozversion application_vendor: Mozilla 17:54:32 INFO - mozversion application_version: 49.0a1 17:54:32 INFO - mozversion platform_buildid: 20160529172438 17:54:32 INFO - mozversion platform_changeset: f59918cf04fa5954101b0274ebf60fb7e11e7a21 17:54:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:54:32 INFO - mozversion platform_version: 49.0a1 17:54:32 INFO - using testdate: 1464569672 17:54:32 INFO - actual date: 1464569672 17:54:32 INFO - starting webserver on 'localhost:42701' 17:54:32 INFO - SUITE-START | Running 2 tests 17:54:32 INFO - TEST-START | dromaeo_css 17:54:32 INFO - operating with platform_type : linux_ 17:54:32 INFO - Initialising browser for dromaeo_css test... 17:54:32 INFO - TEST-INFO | started process 4505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDJplkn/profile http://localhost:42701/getInfo.html) 17:54:36 INFO - PROCESS | 4505 | __metrics Screen width/height:1600/1200 17:54:36 INFO - PROCESS | 4505 | colorDepth:24 17:54:36 INFO - PROCESS | 4505 | Browser inner width/height: 1024/697 17:54:36 INFO - PROCESS | 4505 | __metrics 17:54:37 ERROR - PROCESS | 4505 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:54:38 INFO - TEST-INFO | 4505: exit 0 17:54:38 INFO - Browser initialized. 17:54:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:54:38 INFO - TEST-INFO | started process 4586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDJplkn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:50 INFO - PROCESS | 4586 | RSS: Main: 156983296 17:54:50 INFO - PROCESS | 4586 | 17:55:41 INFO - PROCESS | 4586 | 1464569741714 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] 17:57:53 INFO - PROCESS | 4586 | Cycle 1(1): loaded http://localhost:42701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42701/tests/dromaeo/cssquery-ext.html) 17:57:54 INFO - PROCESS | 4586 | RSS: Main: 266870784 17:57:54 INFO - PROCESS | 4586 | 18:00:57 INFO - PROCESS | 4586 | Cycle 1(1): loaded http://localhost:42701/tests/dromaeo/cssquery-ext.html (next: http://localhost:42701/tests/dromaeo/cssquery-jquery.html) 18:00:57 INFO - PROCESS | 4586 | RSS: Main: 236519424 18:00:57 INFO - PROCESS | 4586 | 18:04:00 INFO - PROCESS | 4586 | Cycle 1(1): loaded http://localhost:42701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42701/tests/dromaeo/cssquery-mootools.html) 18:04:00 INFO - PROCESS | 4586 | RSS: Main: 236425216 18:04:00 INFO - PROCESS | 4586 | 18:07:02 INFO - PROCESS | 4586 | Cycle 1(1): loaded http://localhost:42701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42701/tests/dromaeo/cssquery-prototype.html) 18:07:03 INFO - PROCESS | 4586 | RSS: Main: 231903232 18:07:03 INFO - PROCESS | 4586 | 18:10:06 INFO - PROCESS | 4586 | Cycle 1(1): loaded http://localhost:42701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42701/tests/dromaeo/cssquery-yui.html) 18:10:06 INFO - PROCESS | 4586 | RSS: Main: 212066304 18:10:06 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | Cycle 1(1): loaded http://localhost:42701/tests/dromaeo/cssquery-yui.html (next: http://localhost:42701/tests/dromaeo/cssquery-dojo.html) 18:13:09 INFO - PROCESS | 4586 | RSS: Main: 269926400 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | __start_tp_report 18:13:09 INFO - PROCESS | 4586 | _x_x_mozilla_page_load 18:13:09 INFO - PROCESS | 4586 | _x_x_mozilla_page_load_details 18:13:09 INFO - PROCESS | 4586 | |i|pagename|runs| 18:13:09 INFO - PROCESS | 4586 | |0;dojo.html;2652.3899503114294;2674.277944954862;2691.313715002674;2698;2702.351435655443;4628.514006029361;4689.991651794863;4708.0819240248165;4790.329353890458;4843.636727245457;4769.236922092466;4784.9712311852945;4797.6161907047435;4820.493848145947;4822.4213094428715;4309.849155279566;4389.561043895616;4410.426644536222;4448.221561226788;4532.592066713995;4431.446069241345;4477.462704475468;4493.910121797562;4495.6628252881;4515.412996310475;4305.763183024932;4342.218400687875;4354.194474022316;4374.737515749065;4398.934015989763;4371.4098596689355;4379.715318504287;4390.341448782676;4437.511873693891;4444.844430444951;4395.7362558246605;4406.933895991563;4413.315936029889;4461.5315391883705;4466.151431228056;4616.5152658970665;4698.107359601665;4744.359511465942;4752.667313288071;4787.736674482902;5177.8187763428095;5220.92168617471;5222.3733152022005;5237.711925844077;5239.240310155006;5201.985612805504;5218.765155568009;5240.711760853152;5257.553107985826;5258.842234732964;4675.251959686434;4763.404574428197;4805.038992201574;4809.807607695723;4880.267959806058;5335.09303418412;5365.865853353697;5369.704666243316;5384.703841288767;5395.433479484597;5098.439171691111;5138.614603904722;5148.459411761711;5148.56237219833;5149.073166829931;4951.207806750975;5135.075686376414;5194.039102766001;5204.9219261711105;5234.607404444682;5149.407818100892;5164.302819119446;5166.5866730661455;5183.922241166386;5218.165093585008;5129.333186685782;5142.99711556243;5145.3568303962;5151.330327057459;5195.272661827347;4187.623113919762;4210.115875666083;4213.1784302060805;4268.2530557152995;4371.978140109279;3706.2772759312215;3734.5705243896755;3767.1712223311374;3770.7549009314307;3816.0269131371324;4423.358613001097;4425.734455932655;4429.75636339998;4467.508574056851;4472.016156445577;5046.243063540498;5119.411267704188;5166.095933211673;5174.741262936838;5224.242484839677;4373.890652733707;4374.343848422762;4420.646348292129;4428.911421771547;4430.158269928703;4607.631389488833;4612.86161415158;4621.537846215351;4622.2835460503675;4668.276417155346;4749.9050019000115;4838.206067334421;4848.539388758062;4854.077725232336;4898.608111351084;5124.871878203075;5174.534291913746;5186.040582492251;5190.273361729285;5203;4887;4891.437484689306;4900.975495122501;4901.362822833009;4948.257761335684;4967.726775027409;5008.9248661269385;5124.923126153036;5126.923096153635;5128.102582048052;5074.2642316864585;5152.613553983391;5170.8965820684125;5172.922406163835;5210.452902445189;5021.1464051112125;5024.673396229234;5030.572401345927;5035.697858128524;5080.314157588678;4923.753812309298;4945.208766597327;4985.6510044298;5015.097282489041;5028.446870844277;4936.160852654985;4945;4981.950180498148;4989.525995030466;5000.499950004971;5007.29897814299;5053.974730126326;5054.974725126351;5099.515546023122;5113.028524580318;4874.975625121851;4875.366202393666;4915.508449155056;4927;4956.628252880976 18:13:09 INFO - PROCESS | 4586 | |1;ext.html;566.3147591414388;608.1759216261968;608.8021393047258;612.1063247658418;637.9840503987401;28017.299567510796;28443;40245.99999999996;40902.79548602253;40912.795436022854;39422.408663869996;43610;43662.56337436625;43680.3447948281;43706.12587748243;7744.45788794786;7900.446968712193;7906.407019473534;7909.525428474281;7917.445778795487;7850.646720897574;7971.123176450586;7976.082750483682;7978.561179135145;7979.920200798005;7906.565138917386;8013.599320034004;8023.879641805378;8024.117347091845;8030.638621262057;7946.6821327146845;7969.840603187962;7985.1615580363805;7990.720324788605;7991.160928102582;7847.176046515091;7917.881231781528;7927.563983980879;7932.722354717557;7934.404919631051;39089.80455097735;39357.21285574301;39511.80244098761;39716.40425393621;39751.60248397508;2915.9708402915912;2958.127352431038;3371.578552680915;3799.3731034379293;3878.3212937736066;30335;30700.2324941876;30819.229519261975;30935.535966960288;32067.83966080178;3618.5476815398074;3638.21778317663;3676.3382591133586;3680.7975561344115;3727.7763334200035;250198;252611;253690;253998;254186;29919.551206731918;56628.433715662315;57387;57504.137437938465;57529.42470575324;31903.36193276168;33921.830390847885;33998;34035;34041.659583403845;12508.937455312665;12678.556250531186;12691.746165076647;12694.873051269555;12703.809442858364;10134.341267817568;10154.339967902062;10182.592696292066;10186.898131018743;10187.286889917783;8032.277095061472;8052.798680033046;8063.83872322562;8066.354691624656;8128.83742325162;3059.25048363148;3077.2306923269184;3085.8148511089407;3150.7479401647815;3153.8896138635037;915.1306259053925;927.8608208768738;966.8163049020663;1017.6641708236265;1052.5263631365915;29156.854215728785;29174.562381564294;29284.267893302836;29485.115446536638;29771.85114074459;945.8817647794026;957.1051067252141;992.9304948653524;997.1723469520281;1017.801528701896;15176.696466070838;15223.771643425358;15267.923660381626;15491.147986860831;15508.777851126597;394756;400500;401308;402257;404428;50528.74735626372;51993;52049.73975130176;52126.21810672843;52145.478545214064;1056.3978532236706;1155.9190856639955;1169.9356535390634;1202.807550791869;1205.487667741224;27912.162635120978;29588.556171657874;29842;30067.699323007364;30339;43178.35232471453;43214.56785432105;43858.34212486879;43892.56107438885;43911.56088439203;296612;298537;298861;299057;299412;22617.85130412608;24927;25716;25897.741022590286;25945.22164335073;43080.138397231254;43232.56767432411;43875.341869871336;44457.77771111124;44718.329225061;36213.27573448569;37077.258454831295;37441;37491.43762843505;37713.81143094267;36499.27001459903;36959.44560831536;37229.432917293256;37584.43623345707;37750.43374349332;35431.468527971585;36214.8189259052;36343.454848177826;36561.45157822582;36895.63104369029;31909.36181276408;32812.34375312528;33307.33385332328;33633.66366336403;33894.3221135571;25335.746642534075;25519.23442296734;25574.48851022932;25721.356966075997;25889.6116558248 18:13:09 INFO - PROCESS | 4586 | |2;jquery.html;359.6493418916556;361.4523996145838;361.5065435680297;369.62852333404925;385.09118480386286;15847.128407937558;16731.49805505834;17780.110994450257;17811.198496067675;17843.10784460778;16467.917660411713;16732.665346693087;17750.201240944156;17792.55518612032;17796.377126800566;5019.222020586806;5178;5211.687298762067;5215.765290561933;5220.451852555484;3791.128040550675;3970.781607011628;5112.284280200774;5700.486956173943;6047.818565443022;6079.878402431948;6084.2090528231265;6110.2973158086725;6110.663913484756;6121.326654068049;5847.44449277318;5961.850953726148;5980.55145864062;5989.161517387569;5999.580029397944;3404.438267685829;4927.531884470969;5142.974285128588;5221.451747566527;5227.372715274191;20003.499912502302;20790.79209207904;20819;20865.478363040893;20936.47658808527;1921.567647279365;2140.4006878074165;2145.410012246629;2425.0057476434577;2502;13104.213747175105;13402;13436.126651767701;13731.313434328344;13756.587302380945;1712.743088536717;1718.8538974187209;1720.7849018872641;1756.6662334156597;1762.5153082902177;66528.6673566629;68708;68972.31027689709;69163.65418172877;69408.3059169412;8873.600687969058;9016.188543031027;9145.451272923647;9229.353945223904;9412.764680882896;12773.744525109632;12866.48534058646;12870.613881583567;12872.935635321763;12881.677958051123;6816.693248803816;6846.075779769667;6885.380315771605;6904.620245886525;6919.031335613018;6496.382843629847;6509;6651.66741662915;6657.600543967377;6727.596344219362;5854.5901786875365;5896.852578685482;5933.6736479493175;5975.4024597540765;6116.785912493041;1466.8899832512604;1622.3591681286061;1623.6781402594404;1690.0873528294828;1730.7923049234173;764.6176911544228;925.2413021322451;951.3293128344501;954.9570269337896;1019.8266294729914;16502.42241521565;17056.403025894284;17459;17469.38857139994;17497.737533937;857.9013413457533;868.0841711993907;877.8982377116678;900;935.4387367579534;9977.950110249401;10204.907993861241;10216.540255688511;10241.43672098027;10276.332038417479;372278;374708;376103;376152;381002;43381.78309108434;67853.66073169603;68614.31385686179;69367.65316173488;72931.8061744272;931.1666058877267;937.8499440089689;961.1253759079204;966.8646389505475;972.2513664478312;14571.635709107357;15235.23823808783;16551.83448165503;16674.333026678796;16833.494995150166;37641.81179094087;37778;38276;39369.80315098406;39788.602113978486;49442.50557494379;50014;50309.49690503195;51536.48463515317;52021.47978520166;7323.63381830917;7383.114026316876;7529.962350188214;7593.202713714981;7697.65360558765;9426.905730942603;11365.829512557484;11868.76262474763;11871;11900.345480998629;9602.08780165883;9715.465649389069;9720.222382209548;9764;9947.21477986165;10012.799744004933;10114.898851011396;10145.847812282675;10262;10309.22680798958;9964.850527241952;10013.849792252977;10112.191024717858;10117.29178957466;10176.745581360525;6528.37980391862;7411.444141689287;7543.47195696296;7568.470207085451;7635.732749353746;8239.505629662239;9786.951065244628;9975.351602146127;9990.60037598517;10120.595176193165 18:13:09 INFO - PROCESS | 4586 | |3;mootools.html;1241.5468354050763;1410.308948615179;1431.885449164067;1571.850674185952;1745.4763570928726;6798.45612351012;7653.961730191349;7922.801929951754;7932.56370899601;8154.143814899439;7815.140334563208;7952.801179970489;7956.641951112199;7956.721514746985;7970.083440404355;2220.045380486386;2247.797698207169;2253.2339004738387;2253.43664083979;2257.16484900587;2181.814545763612;2208.083645287204;2265.4562904902787;2267.081831858092;2271.6251818449937;2202.922897698581;2221.622324204889;2224.0992398078806;2225.087714037245;2264.2867496738477;2132.7760585138494;2152.300502336747;2153.8276937844935;2158.9784102158933;2160.8055275025245;2123.0870725587993;2125.0331099349914;2128;2129.659254519285;2131.9573608527744;7740.032495938008;7958.482698624571;7970.481918675326;8031.237032481905;8037.517748935083;4654.208784506642;4773.427188737339;4790.329353890458;4798.3282340472015;4801.087793319258;2815.8873645054173;2977.077106097095;3031.2876474028585;3035.5598438226334;3036.7266945974748;909.8180363927241;917.2432742987062;921.663592788634;924.6440120553568;930.516131611565;10586;10760.40817755023;10786.94606526978;10792.298500597515;10801.729956751065;4077.9796101019306;4184.644305234089;4237.978810105929;4304.418903447994;4307.052448461333;8422.073571907085;8491.405601607952;8508.319334453228;8509.531975741269;8515.914840851636;4627.884302892455;4636.884077898012;4661.277501987197;4681;4686.086213188396;3725.590185079639;3977.940330895039;4301.956980430155;4320.762358070274;4358.3898254243795;3255.706986371238;3285.078229235876;3315.834208289576;3337.4480866397244;3422.469517224834;1000.1298869983161;1013.159077965287;1023.8976102389851;1041.4792603698152;1046.131710680149;725.4196642685936;874.7506960516222;884.4162852517436;899.7030979776658;928.4011812380976;5015.648904576645;5251.501107394792;5335.573154147659;5412.296401467784;5516.255305533782;406.68481926507195;409.3103121240719;414.3529470355314;418.30561268295094;418.6943531222164;3557.181848174934;3557.875474358437;3591.892243232707;3641.126129728899;3751.174741556853;8898.73303800887;9133.178013978773;9207.447553146832;9214.354995150275;9227.584758685742;8972.102789721106;9034.728958131267;9114;9128.726138215865;9139.086091390807;7116.64416779159;7384.889226661497;7436.702531898772;7445.441591880631;7446.962765186247;5156.948430515647;5409.648372855751;5433.646812957145;5438.75525601341;5459.918101228564;8681.869771953552;8810.207081362709;8816.559172041501;9068.637254509746;9078.90921090807;8907.910920890708;9103.362764606414;9117.042710515301;9122.954385228297;9287.117723816227;5844.707764611838;6276.278228003655;6432.517561183024;6436.613803171825;6556.967215163893;7449.776506704808;7454.291842274975;7487.101547814297;7494.362979146834;7499.925000749922;6793.592384456949;6892.896606550806;6975.337342952412;7059.435245180476;7085.291470852873;6541.836454088686;6604.702788374439;6631.834204144935;6671;6753.223379311442;6203.286622038343;6449.7097630605795;6449.7420103195345;6465.77369792055;6519.250286217146;4634.397528321297;4646.558576935186;4657.790399432101;4779.713217206979;4817.301491283674;4847.515248475124;4877.9024419512125;4888.951110488992;4922.630802689741;4987.202047672355 18:13:09 INFO - PROCESS | 4586 | |4;prototype.html;288.5613866922278;296.951003084491;303.7311978898674;307.4972420093147;309.24081380211595;4789.736564488951;4799;4801.351817504636;4820.710162672729;4824.324594556765;4721.693089949151;4752.477227504972;4770.379850619423;4782.187028205205;4784.497627749089;3564.233689756695;3663.157473781032;3664.6885014773775;3761.2101458693705;3825.6939444844484;3750.6061863504347;3770.7737535747806;3786.1481166737403;3797.829097690597;3805.9429108563395;3546.3971124908826;3750.81849217497;3754.2491501699633;3759.55628841254;3763.3414152523337;3540.946885796715;3686.705063594906;3693.907652308687;3704.0369503928905;3764.9623503764888;3322.4684050551796;3329.6337402885665;3330.533725278463;3340.766146369755;3356.9496457553155;4549.044700612875;4574.268117101248;4574.4510658721165;4610.792514336863;4622.768861556942;4204.2432362174795;4284.592963668447;4292.399064130993;4297.5272720001085;4311.719738217006;4939.925901111486;4973.179425394806;4992.625553083497;4993.650444468889;5003.574696150831;3632.763870348419;3637.9636203638156;3655.342038433081;3658.432942893856;3660.5424321959754;4930.679505832145;5254.395744489356;5259.842204733826;5276.841694749163;5293.788248470095;3549.148204430918;3579.3892748263384;3585.8924232273075;3607.981960090183;3615.475756015363;3665.138692407282;3666.2850744105176;3673.669369756735;3681;3695.519582454264;4207.474065741782;4239.406483092308;4245.172191422705;4245.341971994346;4254.808533615995;4737.95262047382;4963.205887058126;4998.600111991032;5016.774245158977;5022.815075442194;1257.4970011995274;1258.8552316483722;1259.1249081888184;1264.8861602455638;1266.3478308671042;789.7916188232015;797.493591569346;797.767449290847;806.5483329335474;818.9844592705122;4287.142571485715;4417.182821178092;4419.823207071681;4443.178012067778;4466.553344665507;5147.536721695065;5172.172452407597;5172.741362931838;5176.844694659167;5178.948210517922;4443.6667249955735;4446.644268458515;4452;4458.6878918475395;4459.554044595515;2592.8703564821685;2766.9209008486705;2768.543190373606;2777.680566734811;2803.8878444862385;4952.232403977389;4952.90094198114;4958.157113290749;4968.850934471971;4988.226824842155;5140.1004824155625;5140.537351638371;5361.705106219118;5380.381256155514;5384.757685904144;4879.609631229422;4887.437944636412;4909.140900342426;4924.310596516419;4928.408590969107;5195.545247330602;5198.376194856642;5204.219367094966;5207.244949482228;5231.607629427732;4824.179889418878;5055.1406260936465;5068.746562671778;5103.7448127592725;5124.205748109049;4876.756427111064;4878.804847806048;4887.828925987574;4900.4854490278;4908.263760435821;3294.802311861296;3313.122022663948;3323.3685599735973;3323.4682450808723;3348.732101431831;4564.292534657134;4596.494385617646;4640.791164397678;4664.86005419838;4688.92966605508;4708.4349878014855;5008;5013.749312534432;5036.496350364934;5048.823291184791;4963.255511673278;4975.651704380659;4991.47589503097;4992.950070499393;5051.646384753032;4828.8792780180775;4953.72754498506;4971.825986090469;4976.502349765139;5001.224810154286;4753.524647535357;4936.851894443173;4984.775685094107;5024.949750502448;5093.363329583802;4960.23116416956;4969.776360063734;4970.378702662168;4973.452920178705;5005.24921261799 18:13:09 INFO - PROCESS | 4586 | |5;yui.html;595.6842873277162;642.9582077164984;713.3651050564998;736.1118730456376;778.1362687416963;12157.27056376618;12651.493940242392;12824.935875320634;12849.486020559178;12862.614121576367;12931.288779117145;13411.12827666201;13480.52818151365;13998.30008499576;14001.719965600681;625.5746092656991;804.3524962405262;804.7907544038563;808.8827120067587;810.3881569415083;754.238219398406;789.5815217934504;790.1111249843925;799.6521513141802;801.0987638906231;849.3841964575664;851.7444766570035;853.5177624642089;854.8674955381925;854.9658013679446;644.735658380062;796.7530065679658;847.9533625650587;847.9788005299855;848.749618862437;613.8557439001831;618.3198481670172;618.8112625649176;619.1363048547252;619.201230412767;13626.863731362659;13666.248356340397;13677.042607017513;13677.931610341884;13692;11709.355985420798;12078.335691536962;12183;12254;12362.690932726664;9657.227421806308;10170.23723220754;10239.590416383337;10251.38491690501;10262.538185781657;3016.8642411091555;3083.784135110543;3104.441200583894;3113.9688603113905;3126.5622812806228;48077.03845923097;48227;48381.27428088546;48625.75687121577;48963.26555101676;8948.418352807046;9174.908250917539;9306.441613503212;9343.439393636403;9565.04349565038;17110.91444542794;17135.48593542196;17146.39987600428;17157.227924743416;17172.484825455256;6707.932920670828;6854.657267136623;6929.688164032631;6978.651067446607;7080.822979425556;3583.390823560001;3608.224231790178;3613.584437789635;3666.4683620874825;3682.208325210093;2879.8128121672444;2955.852207389622;2960.09717036306;2962.4963756161505;2963.081444752134;558.2714557502499;578.6846168837993;583.2883881664362;592.2862950145064;597.1401182297478;421.67741677616647;550.7552930377376;565.1409857017311;586.5952492779968;607.7781609712512;7327.560346379234;7415.369693575999;7500.474966752384;7643.464957453036;7686.961565192139;475.5862399712203;519.7816916894914;579.342446323426;605.5095372748;612.4304396910827;3733.533308336458;3808.6953043756434;3842.538895332522;3863.8068096595057;3866.516685414323;59334.70332648309;59840.102398464056;61709.382906170365;62504.374956250766;62554;52737.47262527402;53368;54198.729006355505;54211.72894135504;54861.725691371284;48920;48984.51015489871;49847.75076124669;50003;50525.24212136821;6780.966095169492;6789.253182149861;6792.490563207878;6802.319768023158;6896.931030689629;32155.678443215267;32318.8688395905;32661.673383265865;32839;33223.501647474826;39168.804155979036;40022.59977400189;42430;42835;43288;9132.528923978245;9145.222656074307;9160.35877488596;9163.083691630784;9574.186194173295;10372.11836993864;10425.270231083752;10489.895101049196;10745.677629671123;10835.837462438227;9561.952190239004;9572.32993690435;9776.315657903879;9828.852567211641;9837.311388203043;8852.29181665478;9025.277977761632;9081.45511269326;9617;9921.900780992097;9379.484128373006;9508.85736713936;9574.569144388659;9611.567479463582;10008.599656013677;8086.1509541499645;8116.715914942949;8221.54781487024;8406.243438090602;8500.574971251537;7915.960420197862;7925.722599708983;7940.722074727357;8061.140388121769;8276.213759692819 18:13:09 INFO - PROCESS | 4586 | __end_tp_report 18:13:09 INFO - PROCESS | 4586 | __start_cc_report 18:13:09 INFO - PROCESS | 4586 | _x_x_mozilla_cycle_collect,998 18:13:09 INFO - PROCESS | 4586 | __end_cc_report 18:13:09 INFO - PROCESS | 4586 | __startTimestamp1464570789871__endTimestamp 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | ------- Summary: start ------- 18:13:09 INFO - PROCESS | 4586 | Number of tests: 6 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | [#0] dojo.html Cycles:165 Average:4757.23 Median:4891.44 stddev:517.78 (10.6%) stddev-sans-first:492.34 18:13:09 INFO - PROCESS | 4586 | Values: 2652.4 2674.3 2691.3 2698.0 2702.4 4628.5 4690.0 4708.1 4790.3 4843.6 4769.2 4785.0 4797.6 4820.5 4822.4 4309.8 4389.6 4410.4 4448.2 4532.6 4431.4 4477.5 4493.9 4495.7 4515.4 4305.8 4342.2 4354.2 4374.7 4398.9 4371.4 4379.7 4390.3 4437.5 4444.8 4395.7 4406.9 4413.3 4461.5 4466.2 4616.5 4698.1 4744.4 4752.7 4787.7 5177.8 5220.9 5222.4 5237.7 5239.2 5202.0 5218.8 5240.7 5257.6 5258.8 4675.3 4763.4 4805.0 4809.8 4880.3 5335.1 5365.9 5369.7 5384.7 5395.4 5098.4 5138.6 5148.5 5148.6 5149.1 4951.2 5135.1 5194.0 5204.9 5234.6 5149.4 5164.3 5166.6 5183.9 5218.2 5129.3 5143.0 5145.4 5151.3 5195.3 4187.6 4210.1 4213.2 4268.3 4372.0 3706.3 3734.6 3767.2 3770.8 3816.0 4423.4 4425.7 4429.8 4467.5 4472.0 5046.2 5119.4 5166.1 5174.7 5224.2 4373.9 4374.3 4420.6 4428.9 4430.2 4607.6 4612.9 4621.5 4622.3 4668.3 4749.9 4838.2 4848.5 4854.1 4898.6 5124.9 5174.5 5186.0 5190.3 5203.0 4887.0 4891.4 4901.0 4901.4 4948.3 4967.7 5008.9 5124.9 5126.9 5128.1 5074.3 5152.6 5170.9 5172.9 5210.5 5021.1 5024.7 5030.6 5035.7 5080.3 4923.8 4945.2 4985.7 5015.1 5028.4 4936.2 4945.0 4982.0 4989.5 5000.5 5007.3 5054.0 5055.0 5099.5 5113.0 4875.0 4875.4 4915.5 4927.0 4956.6 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | [#1] ext.html Cycles:180 Average:46634.89 Median:37018.35 stddev:85309.49 (230.5%) stddev-sans-first:85478.69 18:13:09 INFO - PROCESS | 4586 | Values: 566.3 608.2 608.8 612.1 638.0 28017.3 28443.0 40246.0 40902.8 40912.8 39422.4 43610.0 43662.6 43680.3 43706.1 7744.5 7900.4 7906.4 7909.5 7917.4 7850.6 7971.1 7976.1 7978.6 7979.9 7906.6 8013.6 8023.9 8024.1 8030.6 7946.7 7969.8 7985.2 7990.7 7991.2 7847.2 7917.9 7927.6 7932.7 7934.4 39089.8 39357.2 39511.8 39716.4 39751.6 2916.0 2958.1 3371.6 3799.4 3878.3 30335.0 30700.2 30819.2 30935.5 32067.8 3618.5 3638.2 3676.3 3680.8 3727.8 250198.0 252611.0 253690.0 253998.0 254186.0 29919.6 56628.4 57387.0 57504.1 57529.4 31903.4 33921.8 33998.0 34035.0 34041.7 12508.9 12678.6 12691.7 12694.9 12703.8 10134.3 10154.3 10182.6 10186.9 10187.3 8032.3 8052.8 8063.8 8066.4 8128.8 3059.3 3077.2 3085.8 3150.7 3153.9 915.1 927.9 966.8 1017.7 1052.5 29156.9 29174.6 29284.3 29485.1 29771.9 945.9 957.1 992.9 997.2 1017.8 15176.7 15223.8 15267.9 15491.1 15508.8 394756.0 400500.0 401308.0 402257.0 404428.0 50528.7 51993.0 52049.7 52126.2 52145.5 1056.4 1155.9 1169.9 1202.8 1205.5 27912.2 29588.6 29842.0 30067.7 30339.0 43178.4 43214.6 43858.3 43892.6 43911.6 296612.0 298537.0 298861.0 299057.0 299412.0 22617.9 24927.0 25716.0 25897.7 25945.2 43080.1 43232.6 43875.3 44457.8 44718.3 36213.3 37077.3 37441.0 37491.4 37713.8 36499.3 36959.4 37229.4 37584.4 37750.4 35431.5 36214.8 36343.5 36561.5 36895.6 31909.4 32812.3 33307.3 33633.7 33894.3 25335.7 25519.2 25574.5 25721.4 25889.6 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | [#2] jquery.html Cycles:180 Average:23698.17 Median:27516.61 stddev:61918.86 (225.0%) stddev-sans-first:62067.77 18:13:09 INFO - PROCESS | 4586 | Values: 359.6 361.5 361.5 369.6 385.1 15847.1 16731.5 17780.1 17811.2 17843.1 16467.9 16732.7 17750.2 17792.6 17796.4 5019.2 5178.0 5211.7 5215.8 5220.5 3791.1 3970.8 5112.3 5700.5 6047.8 6079.9 6084.2 6110.3 6110.7 6121.3 5847.4 5961.9 5980.6 5989.2 5999.6 3404.4 4927.5 5143.0 5221.5 5227.4 20003.5 20790.8 20819.0 20865.5 20936.5 1921.6 2140.4 2145.4 2425.0 2502.0 13104.2 13402.0 13436.1 13731.3 13756.6 1712.7 1718.9 1720.8 1756.7 1762.5 66528.7 68708.0 68972.3 69163.7 69408.3 8873.6 9016.2 9145.5 9229.4 9412.8 12773.7 12866.5 12870.6 12872.9 12881.7 6816.7 6846.1 6885.4 6904.6 6919.0 6496.4 6509.0 6651.7 6657.6 6727.6 5854.6 5896.9 5933.7 5975.4 6116.8 1466.9 1622.4 1623.7 1690.1 1730.8 764.6 925.2 951.3 955.0 1019.8 16502.4 17056.4 17459.0 17469.4 17497.7 857.9 868.1 877.9 900.0 935.4 9978.0 10204.9 10216.5 10241.4 10276.3 372278.0 374708.0 376103.0 376152.0 381002.0 43381.8 67853.7 68614.3 69367.7 72931.8 931.2 937.8 961.1 966.9 972.3 14571.6 15235.2 16551.8 16674.3 16833.5 37641.8 37778.0 38276.0 39369.8 39788.6 49442.5 50014.0 50309.5 51536.5 52021.5 7323.6 7383.1 7530.0 7593.2 7697.7 9426.9 11365.8 11868.8 11871.0 11900.3 9602.1 9715.5 9720.2 9764.0 9947.2 10012.8 10114.9 10145.8 10262.0 10309.2 9964.9 10013.8 10112.2 10117.3 10176.7 6528.4 7411.4 7543.5 7568.5 7635.7 8239.5 9787.0 9975.4 9990.6 10120.6 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | [#3] mootools.html Cycles:180 Average:5107.94 Median:5086.30 stddev:2848.70 (56.0%) stddev-sans-first:2841.87 18:13:09 INFO - PROCESS | 4586 | Values: 1241.5 1410.3 1431.9 1571.9 1745.5 6798.5 7654.0 7922.8 7932.6 8154.1 7815.1 7952.8 7956.6 7956.7 7970.1 2220.0 2247.8 2253.2 2253.4 2257.2 2181.8 2208.1 2265.5 2267.1 2271.6 2202.9 2221.6 2224.1 2225.1 2264.3 2132.8 2152.3 2153.8 2159.0 2160.8 2123.1 2125.0 2128.0 2129.7 2132.0 7740.0 7958.5 7970.5 8031.2 8037.5 4654.2 4773.4 4790.3 4798.3 4801.1 2815.9 2977.1 3031.3 3035.6 3036.7 909.8 917.2 921.7 924.6 930.5 10586.0 10760.4 10786.9 10792.3 10801.7 4078.0 4184.6 4238.0 4304.4 4307.1 8422.1 8491.4 8508.3 8509.5 8515.9 4627.9 4636.9 4661.3 4681.0 4686.1 3725.6 3977.9 4302.0 4320.8 4358.4 3255.7 3285.1 3315.8 3337.4 3422.5 1000.1 1013.2 1023.9 1041.5 1046.1 725.4 874.8 884.4 899.7 928.4 5015.6 5251.5 5335.6 5412.3 5516.3 406.7 409.3 414.4 418.3 418.7 3557.2 3557.9 3591.9 3641.1 3751.2 8898.7 9133.2 9207.4 9214.4 9227.6 8972.1 9034.7 9114.0 9128.7 9139.1 7116.6 7384.9 7436.7 7445.4 7447.0 5156.9 5409.6 5433.6 5438.8 5459.9 8681.9 8810.2 8816.6 9068.6 9078.9 8907.9 9103.4 9117.0 9123.0 9287.1 5844.7 6276.3 6432.5 6436.6 6557.0 7449.8 7454.3 7487.1 7494.4 7499.9 6793.6 6892.9 6975.3 7059.4 7085.3 6541.8 6604.7 6631.8 6671.0 6753.2 6203.3 6449.7 6449.7 6465.8 6519.3 4634.4 4646.6 4657.8 4779.7 4817.3 4847.5 4877.9 4889.0 4922.6 4987.2 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | [#4] prototype.html Cycles:180 Average:4142.61 Median:4715.06 stddev:1211.73 (25.7%) stddev-sans-first:1180.10 18:13:09 INFO - PROCESS | 4586 | Values: 288.6 297.0 303.7 307.5 309.2 4789.7 4799.0 4801.4 4820.7 4824.3 4721.7 4752.5 4770.4 4782.2 4784.5 3564.2 3663.2 3664.7 3761.2 3825.7 3750.6 3770.8 3786.1 3797.8 3805.9 3546.4 3750.8 3754.2 3759.6 3763.3 3540.9 3686.7 3693.9 3704.0 3765.0 3322.5 3329.6 3330.5 3340.8 3356.9 4549.0 4574.3 4574.5 4610.8 4622.8 4204.2 4284.6 4292.4 4297.5 4311.7 4939.9 4973.2 4992.6 4993.7 5003.6 3632.8 3638.0 3655.3 3658.4 3660.5 4930.7 5254.4 5259.8 5276.8 5293.8 3549.1 3579.4 3585.9 3608.0 3615.5 3665.1 3666.3 3673.7 3681.0 3695.5 4207.5 4239.4 4245.2 4245.3 4254.8 4738.0 4963.2 4998.6 5016.8 5022.8 1257.5 1258.9 1259.1 1264.9 1266.3 789.8 797.5 797.8 806.5 819.0 4287.1 4417.2 4419.8 4443.2 4466.6 5147.5 5172.2 5172.7 5176.8 5178.9 4443.7 4446.6 4452.0 4458.7 4459.6 2592.9 2766.9 2768.5 2777.7 2803.9 4952.2 4952.9 4958.2 4968.9 4988.2 5140.1 5140.5 5361.7 5380.4 5384.8 4879.6 4887.4 4909.1 4924.3 4928.4 5195.5 5198.4 5204.2 5207.2 5231.6 4824.2 5055.1 5068.7 5103.7 5124.2 4876.8 4878.8 4887.8 4900.5 4908.3 3294.8 3313.1 3323.4 3323.5 3348.7 4564.3 4596.5 4640.8 4664.9 4688.9 4708.4 5008.0 5013.7 5036.5 5048.8 4963.3 4975.7 4991.5 4993.0 5051.6 4828.9 4953.7 4971.8 4976.5 5001.2 4753.5 4936.9 4984.8 5024.9 5093.4 4960.2 4969.8 4970.4 4973.5 5005.2 18:13:09 INFO - PROCESS | 4586 | 18:13:09 INFO - PROCESS | 4586 | [#5] yui.html Cycles:180 Average:13377.01 Median:29963.49 stddev:16528.99 (55.2%) stddev-sans-first:16547.50 18:13:09 INFO - PROCESS | 4586 | Values: 595.7 643.0 713.4 736.1 778.1 12157.3 12651.5 12824.9 12849.5 12862.6 12931.3 13411.1 13480.5 13998.3 14001.7 625.6 804.4 804.8 808.9 810.4 754.2 789.6 790.1 799.7 801.1 849.4 851.7 853.5 854.9 855.0 644.7 796.8 848.0 848.0 848.7 613.9 618.3 618.8 619.1 619.2 13626.9 13666.2 13677.0 13677.9 13692.0 11709.4 12078.3 12183.0 12254.0 12362.7 9657.2 10170.2 10239.6 10251.4 10262.5 3016.9 3083.8 3104.4 3114.0 3126.6 48077.0 48227.0 48381.3 48625.8 48963.3 8948.4 9174.9 9306.4 9343.4 9565.0 17110.9 17135.5 17146.4 17157.2 17172.5 6707.9 6854.7 6929.7 6978.7 7080.8 3583.4 3608.2 3613.6 3666.5 3682.2 2879.8 2955.9 2960.1 2962.5 2963.1 558.3 578.7 583.3 592.3 597.1 421.7 550.8 565.1 586.6 607.8 7327.6 7415.4 7500.5 7643.5 7687.0 475.6 519.8 579.3 605.5 612.4 3733.5 3808.7 3842.5 3863.8 3866.5 59334.7 59840.1 61709.4 62504.4 62554.0 52737.5 53368.0 54198.7 54211.7 54861.7 48920.0 48984.5 49847.8 50003.0 50525.2 6781.0 6789.3 6792.5 6802.3 6896.9 32155.7 32318.9 32661.7 32839.0 33223.5 39168.8 40022.6 42430.0 42835.0 43288.0 9132.5 9145.2 9160.4 9163.1 9574.2 10372.1 10425.3 10489.9 10745.7 10835.8 9562.0 9572.3 9776.3 9828.9 9837.3 8852.3 9025.3 9081.5 9617.0 9921.9 9379.5 9508.9 9574.6 9611.6 10008.6 8086.2 8116.7 8221.5 8406.2 8500.6 7916.0 7925.7 7940.7 8061.1 8276.2 18:13:09 INFO - PROCESS | 4586 | -------- Summary: end -------- 18:13:09 INFO - PROCESS | 4586 | 18:13:10 INFO - TEST-INFO | 4586: exit 0 18:13:10 INFO - TEST-OK | dromaeo_css | took 1118509ms 18:13:10 INFO - TEST-START | kraken 18:13:10 INFO - operating with platform_type : linux_ 18:13:10 INFO - Initialising browser for kraken test... 18:13:10 INFO - TEST-INFO | started process 4766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKEMEh/profile http://localhost:42701/getInfo.html) 18:13:14 INFO - PROCESS | 4766 | __metrics Screen width/height:1600/1200 18:13:14 INFO - PROCESS | 4766 | colorDepth:24 18:13:14 INFO - PROCESS | 4766 | Browser inner width/height: 1024/697 18:13:14 INFO - PROCESS | 4766 | __metrics 18:13:15 ERROR - PROCESS | 4766 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:13:16 INFO - TEST-INFO | 4766: exit 0 18:13:16 INFO - Browser initialized. 18:13:16 INFO - Running cycle 1/1 for kraken test... 18:13:16 INFO - TEST-INFO | started process 4846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKEMEh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:28 INFO - PROCESS | 4846 | RSS: Main: 157614080 18:13:28 INFO - PROCESS | 4846 | 18:13:31 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42701/tests/kraken/driver.html?testName=audio-beat-detection) 18:13:32 INFO - PROCESS | 4846 | RSS: Main: 214941696 18:13:32 INFO - PROCESS | 4846 | 18:13:35 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42701/tests/kraken/driver.html?testName=audio-dft) 18:13:35 INFO - PROCESS | 4846 | RSS: Main: 203452416 18:13:35 INFO - PROCESS | 4846 | 18:13:38 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42701/tests/kraken/driver.html?testName=audio-fft) 18:13:39 INFO - PROCESS | 4846 | RSS: Main: 270372864 18:13:39 INFO - PROCESS | 4846 | 18:13:41 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42701/tests/kraken/driver.html?testName=audio-oscillator) 18:13:42 INFO - PROCESS | 4846 | RSS: Main: 181006336 18:13:42 INFO - PROCESS | 4846 | 18:13:44 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:13:45 INFO - PROCESS | 4846 | RSS: Main: 183906304 18:13:45 INFO - PROCESS | 4846 | 18:13:48 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42701/tests/kraken/driver.html?testName=imaging-darkroom) 18:13:48 INFO - PROCESS | 4846 | RSS: Main: 220950528 18:13:48 INFO - PROCESS | 4846 | 18:13:52 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42701/tests/kraken/driver.html?testName=imaging-desaturate) 18:13:53 INFO - PROCESS | 4846 | RSS: Main: 216526848 18:13:53 INFO - PROCESS | 4846 | 18:13:56 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42701/tests/kraken/driver.html?testName=json-parse-financial) 18:13:56 INFO - PROCESS | 4846 | RSS: Main: 218906624 18:13:56 INFO - PROCESS | 4846 | 18:13:58 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:13:59 INFO - PROCESS | 4846 | RSS: Main: 208334848 18:13:59 INFO - PROCESS | 4846 | 18:14:00 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:14:01 INFO - PROCESS | 4846 | RSS: Main: 211120128 18:14:01 INFO - PROCESS | 4846 | 18:14:03 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:14:04 INFO - PROCESS | 4846 | RSS: Main: 218411008 18:14:04 INFO - PROCESS | 4846 | 18:14:07 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:14:07 INFO - PROCESS | 4846 | RSS: Main: 222834688 18:14:07 INFO - PROCESS | 4846 | 18:14:10 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:14:11 INFO - PROCESS | 4846 | RSS: Main: 221605888 18:14:11 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:42701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42701/tests/kraken/driver.html?testName=ai-astar) 18:14:13 INFO - PROCESS | 4846 | RSS: Main: 264269824 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | __start_tp_report 18:14:13 INFO - PROCESS | 4846 | _x_x_mozilla_page_load 18:14:13 INFO - PROCESS | 4846 | _x_x_mozilla_page_load_details 18:14:13 INFO - PROCESS | 4846 | |i|pagename|runs| 18:14:13 INFO - PROCESS | 4846 | |0;ai-astar;112;107;114;113;113;112;114;112;113;113 18:14:13 INFO - PROCESS | 4846 | |1;audio-beat-detection;160;128;129;184;131;135;162;136;193;131 18:14:13 INFO - PROCESS | 4846 | |2;audio-dft;161;162;161;161;162;160;162;161;160;161 18:14:13 INFO - PROCESS | 4846 | |3;audio-fft;76;76;76;128;76;77;76;76;97;74 18:14:13 INFO - PROCESS | 4846 | |4;audio-oscillator;85;84;117;83;84;84;123;85;85;124 18:14:13 INFO - PROCESS | 4846 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;116;117 18:14:13 INFO - PROCESS | 4846 | |6;imaging-darkroom;162;165;162;162;165;162;161;162;162;161 18:14:13 INFO - PROCESS | 4846 | |7;imaging-desaturate;95;94;95;95;95;96;95;95;95;95 18:14:13 INFO - PROCESS | 4846 | |8;json-parse-financial;62;63;64;76;63;63;62;63;63;63 18:14:13 INFO - PROCESS | 4846 | |9;json-stringify-tinderbox;64;65;64;65;64;65;65;65;64;65 18:14:13 INFO - PROCESS | 4846 | |10;stanford-crypto-aes;85;82;82;82;82;84;83;83;123;82 18:14:13 INFO - PROCESS | 4846 | |11;stanford-crypto-ccm;131;144;135;129;147;130;135;131;150;129 18:14:13 INFO - PROCESS | 4846 | |12;stanford-crypto-pbkdf2;175;173;166;173;173;167;165;171;167;169 18:14:13 INFO - PROCESS | 4846 | |13;stanford-crypto-sha256-iterative;72;67;67;67;66;66;66;66;68;65 18:14:13 INFO - PROCESS | 4846 | __end_tp_report 18:14:13 INFO - PROCESS | 4846 | __start_cc_report 18:14:13 INFO - PROCESS | 4846 | _x_x_mozilla_cycle_collect,1821 18:14:13 INFO - PROCESS | 4846 | __end_cc_report 18:14:13 INFO - PROCESS | 4846 | __startTimestamp1464570853275__endTimestamp 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | ------- Summary: start ------- 18:14:13 INFO - PROCESS | 4846 | Number of tests: 14 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.00 (1.8%) stddev-sans-first:2.12 18:14:13 INFO - PROCESS | 4846 | Values: 112.0 107.0 114.0 113.0 113.0 112.0 114.0 112.0 113.0 113.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:148.00 stddev:24.28 (16.4%) stddev-sans-first:25.42 18:14:13 INFO - PROCESS | 4846 | Values: 160.0 128.0 129.0 184.0 131.0 135.0 162.0 136.0 193.0 131.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 18:14:13 INFO - PROCESS | 4846 | Values: 161.0 162.0 161.0 161.0 162.0 160.0 162.0 161.0 160.0 161.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:17.10 (22.5%) stddev-sans-first:17.94 18:14:13 INFO - PROCESS | 4846 | Values: 76.0 76.0 76.0 128.0 76.0 77.0 76.0 76.0 97.0 74.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:18.00 (21.4%) stddev-sans-first:18.69 18:14:13 INFO - PROCESS | 4846 | Values: 85.0 84.0 117.0 83.0 84.0 84.0 123.0 85.0 85.0 124.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:14:13 INFO - PROCESS | 4846 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#6] imaging-darkroom Cycles:10 Average:162.40 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 18:14:13 INFO - PROCESS | 4846 | Values: 162.0 165.0 162.0 162.0 165.0 162.0 161.0 162.0 162.0 161.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:14:13 INFO - PROCESS | 4846 | Values: 95.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:63.00 stddev:4.18 (6.6%) stddev-sans-first:4.36 18:14:13 INFO - PROCESS | 4846 | Values: 62.0 63.0 64.0 76.0 63.0 63.0 62.0 63.0 63.0 63.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 18:14:13 INFO - PROCESS | 4846 | Values: 64.0 65.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:82.50 stddev:12.76 (15.5%) stddev-sans-first:13.52 18:14:13 INFO - PROCESS | 4846 | Values: 85.0 82.0 82.0 82.0 82.0 84.0 83.0 83.0 123.0 82.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:135.00 stddev:7.94 (5.9%) stddev-sans-first:8.20 18:14:13 INFO - PROCESS | 4846 | Values: 131.0 144.0 135.0 129.0 147.0 130.0 135.0 131.0 150.0 129.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:172.00 stddev:3.54 (2.1%) stddev-sans-first:3.24 18:14:13 INFO - PROCESS | 4846 | Values: 175.0 173.0 166.0 173.0 173.0 167.0 165.0 171.0 167.0 169.0 18:14:13 INFO - PROCESS | 4846 | 18:14:13 INFO - PROCESS | 4846 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.94 (2.9%) stddev-sans-first:0.88 18:14:13 INFO - PROCESS | 4846 | Values: 72.0 67.0 67.0 67.0 66.0 66.0 66.0 66.0 68.0 65.0 18:14:13 INFO - PROCESS | 4846 | -------- Summary: end -------- 18:14:13 INFO - PROCESS | 4846 | 18:14:14 INFO - TEST-INFO | 4846: exit 0 18:14:14 INFO - TEST-OK | kraken | took 63659ms 18:14:14 INFO - SUITE-END | took 1182s 18:14:14 INFO - Completed test suite (00:19:42) 18:14:14 INFO - javascript benchmark 18:14:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.3899503114294, 2674.277944954862, 2691.313715002674, 2698.0, 2702.351435655443, 4628.514006029361, 4689.991651794863, 4708.0819240248165, 4790.329353890458, 4843.636727245457, 4769.236922092466, 4784.9712311852945, 4797.6161907047435, 4820.493848145947, 4822.4213094428715, 4309.849155279566, 4389.561043895616, 4410.426644536222, 4448.221561226788, 4532.592066713995, 4431.446069241345, 4477.462704475468, 4493.910121797562, 4495.6628252881, 4515.412996310475, 4305.763183024932, 4342.218400687875, 4354.194474022316, 4374.737515749065, 4398.934015989763, 4371.4098596689355, 4379.715318504287, 4390.341448782676, 4437.511873693891, 4444.844430444951, 4395.7362558246605, 4406.933895991563, 4413.315936029889, 4461.5315391883705, 4466.151431228056, 4616.5152658970665, 4698.107359601665, 4744.359511465942, 4752.667313288071, 4787.736674482902, 5177.8187763428095, 5220.92168617471, 5222.3733152022005, 5237.711925844077, 5239.240310155006, 5201.985612805504, 5218.765155568009, 5240.711760853152, 5257.553107985826, 5258.842234732964, 4675.251959686434, 4763.404574428197, 4805.038992201574, 4809.807607695723, 4880.267959806058, 5335.09303418412, 5365.865853353697, 5369.704666243316, 5384.703841288767, 5395.433479484597, 5098.439171691111, 5138.614603904722, 5148.459411761711, 5148.56237219833, 5149.073166829931, 4951.207806750975, 5135.075686376414, 5194.039102766001, 5204.9219261711105, 5234.607404444682, 5149.407818100892, 5164.302819119446, 5166.5866730661455, 5183.922241166386, 5218.165093585008, 5129.333186685782, 5142.99711556243, 5145.3568303962, 5151.330327057459, 5195.272661827347, 4187.623113919762, 4210.115875666083, 4213.1784302060805, 4268.2530557152995, 4371.978140109279, 3706.2772759312215, 3734.5705243896755, 3767.1712223311374, 3770.7549009314307, 3816.0269131371324, 4423.358613001097, 4425.734455932655, 4429.75636339998, 4467.508574056851, 4472.016156445577, 5046.243063540498, 5119.411267704188, 5166.095933211673, 5174.741262936838, 5224.242484839677, 4373.890652733707, 4374.343848422762, 4420.646348292129, 4428.911421771547, 4430.158269928703, 4607.631389488833, 4612.86161415158, 4621.537846215351, 4622.2835460503675, 4668.276417155346, 4749.9050019000115, 4838.206067334421, 4848.539388758062, 4854.077725232336, 4898.608111351084, 5124.871878203075, 5174.534291913746, 5186.040582492251, 5190.273361729285, 5203.0, 4887.0, 4891.437484689306, 4900.975495122501, 4901.362822833009, 4948.257761335684, 4967.726775027409, 5008.9248661269385, 5124.923126153036, 5126.923096153635, 5128.102582048052, 5074.2642316864585, 5152.613553983391, 5170.8965820684125, 5172.922406163835, 5210.452902445189, 5021.1464051112125, 5024.673396229234, 5030.572401345927, 5035.697858128524, 5080.314157588678, 4923.753812309298, 4945.208766597327, 4985.6510044298, 5015.097282489041, 5028.446870844277, 4936.160852654985, 4945.0, 4981.950180498148, 4989.525995030466, 5000.499950004971, 5007.29897814299, 5053.974730126326, 5054.974725126351, 5099.515546023122, 5113.028524580318, 4874.975625121851, 4875.366202393666, 4915.508449155056, 4927.0, 4956.628252880976], "value": 4723.249448775601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.3147591414388, 608.1759216261968, 608.8021393047258, 612.1063247658418, 637.9840503987401, 28017.299567510796, 28443.0, 40245.99999999996, 40902.79548602253, 40912.795436022854, 39422.408663869996, 43610.0, 43662.56337436625, 43680.3447948281, 43706.12587748243, 7744.45788794786, 7900.446968712193, 7906.407019473534, 7909.525428474281, 7917.445778795487, 7850.646720897574, 7971.123176450586, 7976.082750483682, 7978.561179135145, 7979.920200798005, 7906.565138917386, 8013.599320034004, 8023.879641805378, 8024.117347091845, 8030.638621262057, 7946.6821327146845, 7969.840603187962, 7985.1615580363805, 7990.720324788605, 7991.160928102582, 7847.176046515091, 7917.881231781528, 7927.563983980879, 7932.722354717557, 7934.404919631051, 39089.80455097735, 39357.21285574301, 39511.80244098761, 39716.40425393621, 39751.60248397508, 2915.9708402915912, 2958.127352431038, 3371.578552680915, 3799.3731034379293, 3878.3212937736066, 30335.0, 30700.2324941876, 30819.229519261975, 30935.535966960288, 32067.83966080178, 3618.5476815398074, 3638.21778317663, 3676.3382591133586, 3680.7975561344115, 3727.7763334200035, 250198.0, 252611.0, 253690.0, 253998.0, 254186.0, 29919.551206731918, 56628.433715662315, 57387.0, 57504.137437938465, 57529.42470575324, 31903.36193276168, 33921.830390847885, 33998.0, 34035.0, 34041.659583403845, 12508.937455312665, 12678.556250531186, 12691.746165076647, 12694.873051269555, 12703.809442858364, 10134.341267817568, 10154.339967902062, 10182.592696292066, 10186.898131018743, 10187.286889917783, 8032.277095061472, 8052.798680033046, 8063.83872322562, 8066.354691624656, 8128.83742325162, 3059.25048363148, 3077.2306923269184, 3085.8148511089407, 3150.7479401647815, 3153.8896138635037, 915.1306259053925, 927.8608208768738, 966.8163049020663, 1017.6641708236265, 1052.5263631365915, 29156.854215728785, 29174.562381564294, 29284.267893302836, 29485.115446536638, 29771.85114074459, 945.8817647794026, 957.1051067252141, 992.9304948653524, 997.1723469520281, 1017.801528701896, 15176.696466070838, 15223.771643425358, 15267.923660381626, 15491.147986860831, 15508.777851126597, 394756.0, 400500.0, 401308.0, 402257.0, 404428.0, 50528.74735626372, 51993.0, 52049.73975130176, 52126.21810672843, 52145.478545214064, 1056.3978532236706, 1155.9190856639955, 1169.9356535390634, 1202.807550791869, 1205.487667741224, 27912.162635120978, 29588.556171657874, 29842.0, 30067.699323007364, 30339.0, 43178.35232471453, 43214.56785432105, 43858.34212486879, 43892.56107438885, 43911.56088439203, 296612.0, 298537.0, 298861.0, 299057.0, 299412.0, 22617.85130412608, 24927.0, 25716.0, 25897.741022590286, 25945.22164335073, 43080.138397231254, 43232.56767432411, 43875.341869871336, 44457.77771111124, 44718.329225061, 36213.27573448569, 37077.258454831295, 37441.0, 37491.43762843505, 37713.81143094267, 36499.27001459903, 36959.44560831536, 37229.432917293256, 37584.43623345707, 37750.43374349332, 35431.468527971585, 36214.8189259052, 36343.454848177826, 36561.45157822582, 36895.63104369029, 31909.36181276408, 32812.34375312528, 33307.33385332328, 33633.66366336403, 33894.3221135571, 25335.746642534075, 25519.23442296734, 25574.48851022932, 25721.356966075997, 25889.6116558248], "value": 16759.14549515855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6493418916556, 361.4523996145838, 361.5065435680297, 369.62852333404925, 385.09118480386286, 15847.128407937558, 16731.49805505834, 17780.110994450257, 17811.198496067675, 17843.10784460778, 16467.917660411713, 16732.665346693087, 17750.201240944156, 17792.55518612032, 17796.377126800566, 5019.222020586806, 5178.0, 5211.687298762067, 5215.765290561933, 5220.451852555484, 3791.128040550675, 3970.781607011628, 5112.284280200774, 5700.486956173943, 6047.818565443022, 6079.878402431948, 6084.2090528231265, 6110.2973158086725, 6110.663913484756, 6121.326654068049, 5847.44449277318, 5961.850953726148, 5980.55145864062, 5989.161517387569, 5999.580029397944, 3404.438267685829, 4927.531884470969, 5142.974285128588, 5221.451747566527, 5227.372715274191, 20003.499912502302, 20790.79209207904, 20819.0, 20865.478363040893, 20936.47658808527, 1921.567647279365, 2140.4006878074165, 2145.410012246629, 2425.0057476434577, 2502.0, 13104.213747175105, 13402.0, 13436.126651767701, 13731.313434328344, 13756.587302380945, 1712.743088536717, 1718.8538974187209, 1720.7849018872641, 1756.6662334156597, 1762.5153082902177, 66528.6673566629, 68708.0, 68972.31027689709, 69163.65418172877, 69408.3059169412, 8873.600687969058, 9016.188543031027, 9145.451272923647, 9229.353945223904, 9412.764680882896, 12773.744525109632, 12866.48534058646, 12870.613881583567, 12872.935635321763, 12881.677958051123, 6816.693248803816, 6846.075779769667, 6885.380315771605, 6904.620245886525, 6919.031335613018, 6496.382843629847, 6509.0, 6651.66741662915, 6657.600543967377, 6727.596344219362, 5854.5901786875365, 5896.852578685482, 5933.6736479493175, 5975.4024597540765, 6116.785912493041, 1466.8899832512604, 1622.3591681286061, 1623.6781402594404, 1690.0873528294828, 1730.7923049234173, 764.6176911544228, 925.2413021322451, 951.3293128344501, 954.9570269337896, 1019.8266294729914, 16502.42241521565, 17056.403025894284, 17459.0, 17469.38857139994, 17497.737533937, 857.9013413457533, 868.0841711993907, 877.8982377116678, 900.0, 935.4387367579534, 9977.950110249401, 10204.907993861241, 10216.540255688511, 10241.43672098027, 10276.332038417479, 372278.0, 374708.0, 376103.0, 376152.0, 381002.0, 43381.78309108434, 67853.66073169603, 68614.31385686179, 69367.65316173488, 72931.8061744272, 931.1666058877267, 937.8499440089689, 961.1253759079204, 966.8646389505475, 972.2513664478312, 14571.635709107357, 15235.23823808783, 16551.83448165503, 16674.333026678796, 16833.494995150166, 37641.81179094087, 37778.0, 38276.0, 39369.80315098406, 39788.602113978486, 49442.50557494379, 50014.0, 50309.49690503195, 51536.48463515317, 52021.47978520166, 7323.63381830917, 7383.114026316876, 7529.962350188214, 7593.202713714981, 7697.65360558765, 9426.905730942603, 11365.829512557484, 11868.76262474763, 11871.0, 11900.345480998629, 9602.08780165883, 9715.465649389069, 9720.222382209548, 9764.0, 9947.21477986165, 10012.799744004933, 10114.898851011396, 10145.847812282675, 10262.0, 10309.22680798958, 9964.850527241952, 10013.849792252977, 10112.191024717858, 10117.29178957466, 10176.745581360525, 6528.37980391862, 7411.444141689287, 7543.47195696296, 7568.470207085451, 7635.732749353746, 8239.505629662239, 9786.951065244628, 9975.351602146127, 9990.60037598517, 10120.595176193165], "value": 8286.276206115184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.5468354050763, 1410.308948615179, 1431.885449164067, 1571.850674185952, 1745.4763570928726, 6798.45612351012, 7653.961730191349, 7922.801929951754, 7932.56370899601, 8154.143814899439, 7815.140334563208, 7952.801179970489, 7956.641951112199, 7956.721514746985, 7970.083440404355, 2220.045380486386, 2247.797698207169, 2253.2339004738387, 2253.43664083979, 2257.16484900587, 2181.814545763612, 2208.083645287204, 2265.4562904902787, 2267.081831858092, 2271.6251818449937, 2202.922897698581, 2221.622324204889, 2224.0992398078806, 2225.087714037245, 2264.2867496738477, 2132.7760585138494, 2152.300502336747, 2153.8276937844935, 2158.9784102158933, 2160.8055275025245, 2123.0870725587993, 2125.0331099349914, 2128.0, 2129.659254519285, 2131.9573608527744, 7740.032495938008, 7958.482698624571, 7970.481918675326, 8031.237032481905, 8037.517748935083, 4654.208784506642, 4773.427188737339, 4790.329353890458, 4798.3282340472015, 4801.087793319258, 2815.8873645054173, 2977.077106097095, 3031.2876474028585, 3035.5598438226334, 3036.7266945974748, 909.8180363927241, 917.2432742987062, 921.663592788634, 924.6440120553568, 930.516131611565, 10586.0, 10760.40817755023, 10786.94606526978, 10792.298500597515, 10801.729956751065, 4077.9796101019306, 4184.644305234089, 4237.978810105929, 4304.418903447994, 4307.052448461333, 8422.073571907085, 8491.405601607952, 8508.319334453228, 8509.531975741269, 8515.914840851636, 4627.884302892455, 4636.884077898012, 4661.277501987197, 4681.0, 4686.086213188396, 3725.590185079639, 3977.940330895039, 4301.956980430155, 4320.762358070274, 4358.3898254243795, 3255.706986371238, 3285.078229235876, 3315.834208289576, 3337.4480866397244, 3422.469517224834, 1000.1298869983161, 1013.159077965287, 1023.8976102389851, 1041.4792603698152, 1046.131710680149, 725.4196642685936, 874.7506960516222, 884.4162852517436, 899.7030979776658, 928.4011812380976, 5015.648904576645, 5251.501107394792, 5335.573154147659, 5412.296401467784, 5516.255305533782, 406.68481926507195, 409.3103121240719, 414.3529470355314, 418.30561268295094, 418.6943531222164, 3557.181848174934, 3557.875474358437, 3591.892243232707, 3641.126129728899, 3751.174741556853, 8898.73303800887, 9133.178013978773, 9207.447553146832, 9214.354995150275, 9227.584758685742, 8972.102789721106, 9034.728958131267, 9114.0, 9128.726138215865, 9139.086091390807, 7116.64416779159, 7384.889226661497, 7436.702531898772, 7445.441591880631, 7446.962765186247, 5156.948430515647, 5409.648372855751, 5433.646812957145, 5438.75525601341, 5459.918101228564, 8681.869771953552, 8810.207081362709, 8816.559172041501, 9068.637254509746, 9078.90921090807, 8907.910920890708, 9103.362764606414, 9117.042710515301, 9122.954385228297, 9287.117723816227, 5844.707764611838, 6276.278228003655, 6432.517561183024, 6436.613803171825, 6556.967215163893, 7449.776506704808, 7454.291842274975, 7487.101547814297, 7494.362979146834, 7499.925000749922, 6793.592384456949, 6892.896606550806, 6975.337342952412, 7059.435245180476, 7085.291470852873, 6541.836454088686, 6604.702788374439, 6631.834204144935, 6671.0, 6753.223379311442, 6203.286622038343, 6449.7097630605795, 6449.7420103195345, 6465.77369792055, 6519.250286217146, 4634.397528321297, 4646.558576935186, 4657.790399432101, 4779.713217206979, 4817.301491283674, 4847.515248475124, 4877.9024419512125, 4888.951110488992, 4922.630802689741, 4987.202047672355], "value": 4047.0516687534086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5613866922278, 296.951003084491, 303.7311978898674, 307.4972420093147, 309.24081380211595, 4789.736564488951, 4799.0, 4801.351817504636, 4820.710162672729, 4824.324594556765, 4721.693089949151, 4752.477227504972, 4770.379850619423, 4782.187028205205, 4784.497627749089, 3564.233689756695, 3663.157473781032, 3664.6885014773775, 3761.2101458693705, 3825.6939444844484, 3750.6061863504347, 3770.7737535747806, 3786.1481166737403, 3797.829097690597, 3805.9429108563395, 3546.3971124908826, 3750.81849217497, 3754.2491501699633, 3759.55628841254, 3763.3414152523337, 3540.946885796715, 3686.705063594906, 3693.907652308687, 3704.0369503928905, 3764.9623503764888, 3322.4684050551796, 3329.6337402885665, 3330.533725278463, 3340.766146369755, 3356.9496457553155, 4549.044700612875, 4574.268117101248, 4574.4510658721165, 4610.792514336863, 4622.768861556942, 4204.2432362174795, 4284.592963668447, 4292.399064130993, 4297.5272720001085, 4311.719738217006, 4939.925901111486, 4973.179425394806, 4992.625553083497, 4993.650444468889, 5003.574696150831, 3632.763870348419, 3637.9636203638156, 3655.342038433081, 3658.432942893856, 3660.5424321959754, 4930.679505832145, 5254.395744489356, 5259.842204733826, 5276.841694749163, 5293.788248470095, 3549.148204430918, 3579.3892748263384, 3585.8924232273075, 3607.981960090183, 3615.475756015363, 3665.138692407282, 3666.2850744105176, 3673.669369756735, 3681.0, 3695.519582454264, 4207.474065741782, 4239.406483092308, 4245.172191422705, 4245.341971994346, 4254.808533615995, 4737.95262047382, 4963.205887058126, 4998.600111991032, 5016.774245158977, 5022.815075442194, 1257.4970011995274, 1258.8552316483722, 1259.1249081888184, 1264.8861602455638, 1266.3478308671042, 789.7916188232015, 797.493591569346, 797.767449290847, 806.5483329335474, 818.9844592705122, 4287.142571485715, 4417.182821178092, 4419.823207071681, 4443.178012067778, 4466.553344665507, 5147.536721695065, 5172.172452407597, 5172.741362931838, 5176.844694659167, 5178.948210517922, 4443.6667249955735, 4446.644268458515, 4452.0, 4458.6878918475395, 4459.554044595515, 2592.8703564821685, 2766.9209008486705, 2768.543190373606, 2777.680566734811, 2803.8878444862385, 4952.232403977389, 4952.90094198114, 4958.157113290749, 4968.850934471971, 4988.226824842155, 5140.1004824155625, 5140.537351638371, 5361.705106219118, 5380.381256155514, 5384.757685904144, 4879.609631229422, 4887.437944636412, 4909.140900342426, 4924.310596516419, 4928.408590969107, 5195.545247330602, 5198.376194856642, 5204.219367094966, 5207.244949482228, 5231.607629427732, 4824.179889418878, 5055.1406260936465, 5068.746562671778, 5103.7448127592725, 5124.205748109049, 4876.756427111064, 4878.804847806048, 4887.828925987574, 4900.4854490278, 4908.263760435821, 3294.802311861296, 3313.122022663948, 3323.3685599735973, 3323.4682450808723, 3348.732101431831, 4564.292534657134, 4596.494385617646, 4640.791164397678, 4664.86005419838, 4688.92966605508, 4708.4349878014855, 5008.0, 5013.749312534432, 5036.496350364934, 5048.823291184791, 4963.255511673278, 4975.651704380659, 4991.47589503097, 4992.950070499393, 5051.646384753032, 4828.8792780180775, 4953.72754498506, 4971.825986090469, 4976.502349765139, 5001.224810154286, 4753.524647535357, 4936.851894443173, 4984.775685094107, 5024.949750502448, 5093.363329583802, 4960.23116416956, 4969.776360063734, 4970.378702662168, 4973.452920178705, 5005.24921261799], "value": 3755.691478732784, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.6842873277162, 642.9582077164984, 713.3651050564998, 736.1118730456376, 778.1362687416963, 12157.27056376618, 12651.493940242392, 12824.935875320634, 12849.486020559178, 12862.614121576367, 12931.288779117145, 13411.12827666201, 13480.52818151365, 13998.30008499576, 14001.719965600681, 625.5746092656991, 804.3524962405262, 804.7907544038563, 808.8827120067587, 810.3881569415083, 754.238219398406, 789.5815217934504, 790.1111249843925, 799.6521513141802, 801.0987638906231, 849.3841964575664, 851.7444766570035, 853.5177624642089, 854.8674955381925, 854.9658013679446, 644.735658380062, 796.7530065679658, 847.9533625650587, 847.9788005299855, 848.749618862437, 613.8557439001831, 618.3198481670172, 618.8112625649176, 619.1363048547252, 619.201230412767, 13626.863731362659, 13666.248356340397, 13677.042607017513, 13677.931610341884, 13692.0, 11709.355985420798, 12078.335691536962, 12183.0, 12254.0, 12362.690932726664, 9657.227421806308, 10170.23723220754, 10239.590416383337, 10251.38491690501, 10262.538185781657, 3016.8642411091555, 3083.784135110543, 3104.441200583894, 3113.9688603113905, 3126.5622812806228, 48077.03845923097, 48227.0, 48381.27428088546, 48625.75687121577, 48963.26555101676, 8948.418352807046, 9174.908250917539, 9306.441613503212, 9343.439393636403, 9565.04349565038, 17110.91444542794, 17135.48593542196, 17146.39987600428, 17157.227924743416, 17172.484825455256, 6707.932920670828, 6854.657267136623, 6929.688164032631, 6978.651067446607, 7080.822979425556, 3583.390823560001, 3608.224231790178, 3613.584437789635, 3666.4683620874825, 3682.208325210093, 2879.8128121672444, 2955.852207389622, 2960.09717036306, 2962.4963756161505, 2963.081444752134, 558.2714557502499, 578.6846168837993, 583.2883881664362, 592.2862950145064, 597.1401182297478, 421.67741677616647, 550.7552930377376, 565.1409857017311, 586.5952492779968, 607.7781609712512, 7327.560346379234, 7415.369693575999, 7500.474966752384, 7643.464957453036, 7686.961565192139, 475.5862399712203, 519.7816916894914, 579.342446323426, 605.5095372748, 612.4304396910827, 3733.533308336458, 3808.6953043756434, 3842.538895332522, 3863.8068096595057, 3866.516685414323, 59334.70332648309, 59840.102398464056, 61709.382906170365, 62504.374956250766, 62554.0, 52737.47262527402, 53368.0, 54198.729006355505, 54211.72894135504, 54861.725691371284, 48920.0, 48984.51015489871, 49847.75076124669, 50003.0, 50525.24212136821, 6780.966095169492, 6789.253182149861, 6792.490563207878, 6802.319768023158, 6896.931030689629, 32155.678443215267, 32318.8688395905, 32661.673383265865, 32839.0, 33223.501647474826, 39168.804155979036, 40022.59977400189, 42430.0, 42835.0, 43288.0, 9132.528923978245, 9145.222656074307, 9160.35877488596, 9163.083691630784, 9574.186194173295, 10372.11836993864, 10425.270231083752, 10489.895101049196, 10745.677629671123, 10835.837462438227, 9561.952190239004, 9572.32993690435, 9776.315657903879, 9828.852567211641, 9837.311388203043, 8852.29181665478, 9025.277977761632, 9081.45511269326, 9617.0, 9921.900780992097, 9379.484128373006, 9508.85736713936, 9574.569144388659, 9611.567479463582, 10008.599656013677, 8086.1509541499645, 8116.715914942949, 8221.54781487024, 8406.243438090602, 8500.574971251537, 7915.960420197862, 7925.722599708983, 7940.722074727357, 8061.140388121769, 8276.213759692819], "value": 5840.93069672554, "unit": "score"}], "name": "dromaeo_css", "value": 6225.897727234177, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 114.0, 113.0, 113.0, 112.0, 114.0, 112.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 129.0, 184.0, 131.0, 135.0, 162.0, 136.0, 193.0, 131.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 160.0, 162.0, 161.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 128.0, 76.0, 77.0, 76.0, 76.0, 97.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 83.0, 84.0, 84.0, 123.0, 85.0, 85.0, 124.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 162.0, 165.0, 162.0, 161.0, 162.0, 162.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 76.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 82.0, 82.0, 82.0, 84.0, 83.0, 83.0, 123.0, 82.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 144.0, 135.0, 129.0, 147.0, 130.0, 135.0, 131.0, 150.0, 129.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 166.0, 173.0, 173.0, 167.0, 165.0, 171.0, 167.0, 169.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 68.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1563.6, "alertThreshold": 2.0}]} 18:14:14 INFO - Return code: 0 18:14:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:14:14 ERROR - # TBPL SUCCESS # 18:14:14 INFO - Running post-action listener: _resource_record_post_action 18:14:14 INFO - ##### 18:14:14 INFO - ##### Finished run-tests step (success) 18:14:14 INFO - ##### 18:14:14 INFO - Running post-run listener: _resource_record_post_run 18:14:14 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 521957376; Read time: 0; Write time: 506568 18:14:14 INFO - TinderboxPrint: CPU usage
13.1% 18:14:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:14:14 INFO - TinderboxPrint: I/O write bytes / time
521,957,376 / 506,568 18:14:14 INFO - TinderboxPrint: CPU idle
8,316.4 (86.9%) 18:14:14 INFO - TinderboxPrint: CPU user
1,211.6 (12.7%) 18:14:14 INFO - TinderboxPrint: Swap in / out
0 / 0 18:14:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237039616; Read time: 0; Write time: 298324 18:14:14 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 278933504; Read time: 0; Write time: 207732 18:14:15 INFO - Running post-run listener: _upload_blobber_files 18:14:15 INFO - Blob upload gear active. 18:14:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:14:15 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 18:14:15 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'] 18:14:15 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 18:14:15 INFO - (blobuploader) - INFO - Open directory for files ... 18:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:19 INFO - (blobuploader) - INFO - Done attempting. 18:14:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:14:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:14:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:20 INFO - (blobuploader) - INFO - Done attempting. 18:14:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:14:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:14:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:22 INFO - (blobuploader) - INFO - Done attempting. 18:14:22 INFO - (blobuploader) - INFO - Iteration through files over. 18:14:22 INFO - Return code: 0 18:14:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:14:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:14:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1043b06a04c932810210c6ffb9899723ccd1c821ac2a440420a6bf8c1802c0f873400903b12b24e67836248b2548c470e74ff43173357610b3a0082f25e1c75b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bca5a2f9fe764b027b9f7b31e7c60f18d253fbf77dd890f5bdfe88db7582998faa15fc89412fa1d34bb012659f67b4d549578bac75813307103200836e1928e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35c9eff64291f9758201effd3d83424502764c966269735edadf5e85b0d1a94659d9006d4f7d3b1c06372c32402b527ca9dc6c8e5c11e46068445b9d2cb6ea41"} 18:14:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:14:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:14:22 INFO - Contents: 18:14:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1043b06a04c932810210c6ffb9899723ccd1c821ac2a440420a6bf8c1802c0f873400903b12b24e67836248b2548c470e74ff43173357610b3a0082f25e1c75b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bca5a2f9fe764b027b9f7b31e7c60f18d253fbf77dd890f5bdfe88db7582998faa15fc89412fa1d34bb012659f67b4d549578bac75813307103200836e1928e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35c9eff64291f9758201effd3d83424502764c966269735edadf5e85b0d1a94659d9006d4f7d3b1c06372c32402b527ca9dc6c8e5c11e46068445b9d2cb6ea41"} 18:14:22 INFO - Running post-run listener: copy_logs_to_upload_dir 18:14:22 INFO - Copying logs to upload dir... 18:14:22 INFO - mkdir: /builds/slave/test/build/upload/logs 18:14:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.200587 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-29 18:14:20.483630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 18:14:20.486935) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324 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/1043b06a04c932810210c6ffb9899723ccd1c821ac2a440420a6bf8c1802c0f873400903b12b24e67836248b2548c470e74ff43173357610b3a0082f25e1c75b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bca5a2f9fe764b027b9f7b31e7c60f18d253fbf77dd890f5bdfe88db7582998faa15fc89412fa1d34bb012659f67b4d549578bac75813307103200836e1928e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35c9eff64291f9758201effd3d83424502764c966269735edadf5e85b0d1a94659d9006d4f7d3b1c06372c32402b527ca9dc6c8e5c11e46068445b9d2cb6ea41"} build_url:https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/D-QvnegUTr6blC_xQLg3ng/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/1043b06a04c932810210c6ffb9899723ccd1c821ac2a440420a6bf8c1802c0f873400903b12b24e67836248b2548c470e74ff43173357610b3a0082f25e1c75b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bca5a2f9fe764b027b9f7b31e7c60f18d253fbf77dd890f5bdfe88db7582998faa15fc89412fa1d34bb012659f67b4d549578bac75813307103200836e1928e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35c9eff64291f9758201effd3d83424502764c966269735edadf5e85b0d1a94659d9006d4f7d3b1c06372c32402b527ca9dc6c8e5c11e46068445b9d2cb6ea41"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 18:14:20.513152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 18:14:20.513521) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464565066.448091-1977265324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004692 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 18:14:20.595601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 18:14:20.595950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 18:14:20.596259) ========= ========= Total master_lag: 0.21 =========