builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1463411732.77 results: success (0) buildid: 20160516053010 builduid: 797e29dcf96b4d119651053e0316412f revision: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.768011) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.768483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.768785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.786156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.786423) ========= 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=d2a8c569965ab8367867b893000001a1-1463410897.859006-300278106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 08:15:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.0M=0s 2016-05-16 08:15:34 (37.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.898723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.899060) ========= 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=d2a8c569965ab8367867b893000001a1-1463410897.859006-300278106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019316 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.948425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:32.948789) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 --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 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 --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=d2a8c569965ab8367867b893000001a1-1463410897.859006-300278106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 08:15:34,383 truncating revision to first 12 chars 2016-05-16 08:15:34,383 Setting DEBUG logging. 2016-05-16 08:15:34,383 attempt 1/10 2016-05-16 08:15:34,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/26656bbb6d39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 08:15:34,668 unpacking tar archive at: fx-team-26656bbb6d39/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:33.517022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:33.517350) ========= script_repo_revision: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:33.517790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:33.518072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 08:15:33.528293) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-16 08:15:33.528613) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d2a8c569965ab8367867b893000001a1-1463410897.859006-300278106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:15:35 INFO - MultiFileLogger online at 20160516 08:15:35 in /builds/slave/test 08:15:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:15:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:35 INFO - {'append_to_log': False, 08:15:35 INFO - 'base_work_dir': '/builds/slave/test', 08:15:35 INFO - 'blob_upload_branch': 'Fx-Team', 08:15:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:35 INFO - 'branch': 'Fx-Team', 08:15:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:35 INFO - 'config_files': ('talos/linux_config.py',), 08:15:35 INFO - 'default_actions': ('clobber', 08:15:35 INFO - 'read-buildbot-config', 08:15:35 INFO - 'download-and-extract', 08:15:35 INFO - 'populate-webroot', 08:15:35 INFO - 'create-virtualenv', 08:15:35 INFO - 'install', 08:15:35 INFO - 'run-tests'), 08:15:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:35 INFO - 'download_minidump_stackwalk': True, 08:15:35 INFO - 'download_symbols': 'ondemand', 08:15:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:35 INFO - 'installer_path': 'installer.exe', 08:15:35 INFO - 'log_level': 'info', 08:15:35 INFO - 'log_name': 'talos', 08:15:35 INFO - 'log_to_console': True, 08:15:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:15:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:15:35 INFO - 'opt_config_files': (), 08:15:35 INFO - 'pip_index': False, 08:15:35 INFO - 'sps_profile': False, 08:15:35 INFO - 'sps_profile_interval': 0, 08:15:35 INFO - 'suite': 'dromaeojs-e10s', 08:15:35 INFO - 'system_bits': '32', 08:15:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:35 INFO - 'title': 'talos-linux64-ix-043', 08:15:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:35 INFO - 'use_talos_json': True, 08:15:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:35 INFO - 'work_dir': 'build'} 08:15:35 INFO - ##### 08:15:35 INFO - ##### Running clobber step. 08:15:35 INFO - ##### 08:15:35 INFO - Running pre-action listener: _resource_record_pre_action 08:15:35 INFO - Running main action method: clobber 08:15:35 INFO - rmtree: /builds/slave/test/build 08:15:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:35 INFO - Running post-action listener: _resource_record_post_action 08:15:35 INFO - ##### 08:15:35 INFO - ##### Finished clobber step (success) 08:15:35 INFO - ##### 08:15:35 INFO - ##### 08:15:35 INFO - ##### Running read-buildbot-config step. 08:15:35 INFO - ##### 08:15:35 INFO - Running pre-action listener: _resource_record_pre_action 08:15:35 INFO - Running main action method: read_buildbot_config 08:15:35 INFO - Using buildbot properties: 08:15:35 INFO - { 08:15:35 INFO - "project": "", 08:15:35 INFO - "product": "firefox", 08:15:35 INFO - "script_repo_revision": "production", 08:15:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:15:35 INFO - "repository": "", 08:15:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:15:35 INFO - "buildid": "20160516053010", 08:15:35 INFO - "pgo_build": "True", 08:15:35 INFO - "basedir": "/builds/slave/test", 08:15:35 INFO - "buildnumber": 466, 08:15:35 INFO - "slavename": "talos-linux64-ix-043", 08:15:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:15:35 INFO - "platform": "ubuntu64_hw", 08:15:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:15:35 INFO - "branch": "fx-team", 08:15:35 INFO - "repo_path": "integration/fx-team", 08:15:35 INFO - "revision": "26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89", 08:15:35 INFO - "stage_platform": "linux64-pgo", 08:15:35 INFO - "builduid": "797e29dcf96b4d119651053e0316412f", 08:15:35 INFO - "slavebuilddir": "test" 08:15:35 INFO - } 08:15:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:15:35 INFO - Running post-action listener: _resource_record_post_action 08:15:35 INFO - ##### 08:15:35 INFO - ##### Finished read-buildbot-config step (success) 08:15:35 INFO - ##### 08:15:35 INFO - ##### 08:15:35 INFO - ##### Running download-and-extract step. 08:15:35 INFO - ##### 08:15:35 INFO - Running pre-action listener: _resource_record_pre_action 08:15:35 INFO - Running main action method: download_and_extract 08:15:35 INFO - mkdir: /builds/slave/test/build/tests 08:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:35 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:36 INFO - Downloaded 1361 bytes. 08:15:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:15:36 INFO - Using the following test package requirements: 08:15:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:15:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:15:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'jsshell-linux-x86_64.zip'], 08:15:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:15:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:15:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:15:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:15:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:15:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:15:36 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')]} 08:15:36 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:15:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:15:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:37 INFO - Downloaded 24023288 bytes. 08:15:37 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'] 08:15:37 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 08:15:38 INFO - Return code: 0 08:15:38 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 08:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:38 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:15:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:15:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:39 INFO - Downloaded 24023288 bytes. 08:15:39 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'] 08:15:39 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 08:15:41 INFO - Return code: 0 08:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:41 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:42 INFO - Downloaded 10840194 bytes. 08:15:42 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'] 08:15:42 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 08:15:42 INFO - Return code: 0 08:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:42 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:15:43 INFO - Downloaded 58421766 bytes. 08:15:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:15:43 INFO - mkdir: /builds/slave/test/properties 08:15:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:43 INFO - Contents: 08:15:43 INFO - build_url:https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:15:44 INFO - Running post-action listener: _resource_record_post_action 08:15:44 INFO - Running post-action listener: set_extra_try_arguments 08:15:44 INFO - ##### 08:15:44 INFO - ##### Finished download-and-extract step (success) 08:15:44 INFO - ##### 08:15:44 INFO - ##### 08:15:44 INFO - ##### Running populate-webroot step. 08:15:44 INFO - ##### 08:15:44 INFO - Running pre-action listener: _resource_record_pre_action 08:15:44 INFO - Running main action method: populate_webroot 08:15:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:44 INFO - '--tppagecycles', 08:15:44 INFO - '7'], 08:15:44 INFO - 'tests': ['tsvgm']}}, 08:15:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['damp', 'tps']}, 08:15:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'tests': ['damp', 'tps']}, 08:15:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['dromaeo_dom']}, 08:15:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['a11yr', 08:15:44 INFO - 'ts_paint', 08:15:44 INFO - 'tpaint', 08:15:44 INFO - 'sessionrestore', 08:15:44 INFO - 'sessionrestore_no_auto_restore', 08:15:44 INFO - 'tabpaint']}, 08:15:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tsvgx', 08:15:44 INFO - 'tsvgr_opacity', 08:15:44 INFO - 'tart', 08:15:44 INFO - 'tscrollx', 08:15:44 INFO - 'cart']}, 08:15:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:44 INFO - 'tsvgr_opacity', 08:15:44 INFO - 'tart', 08:15:44 INFO - 'tscrollx', 08:15:44 INFO - 'cart']}, 08:15:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s'], 08:15:44 INFO - 'tests': ['tp5o']}, 08:15:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'tests': ['tp5o']}, 08:15:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'talos_options': ['--disable-e10s', 08:15:44 INFO - '--xperf_path', 08:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:44 INFO - 'tests': ['tp5n']}, 08:15:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:44 INFO - 'talos_options': ['--xperf_path', 08:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:44 INFO - 'tests': ['tp5n']}}, 08:15:44 INFO - 'talos.zip': {'path': '', 08:15:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:44 INFO - Running post-action listener: _resource_record_post_action 08:15:44 INFO - ##### 08:15:44 INFO - ##### Finished populate-webroot step (success) 08:15:44 INFO - ##### 08:15:44 INFO - ##### 08:15:44 INFO - ##### Running create-virtualenv step. 08:15:44 INFO - ##### 08:15:44 INFO - Running pre-action listener: _resource_record_pre_action 08:15:44 INFO - Running main action method: create_virtualenv 08:15:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:44 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 08:15:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:44 INFO - Using real prefix '/usr' 08:15:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:47 INFO - Installing pip.................done. 08:15:47 INFO - Return code: 0 08:15:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15:47 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')]} 08:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:47 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')]} 08:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:47 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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:15:47 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 08:15:47 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 08:15:47 INFO - Using env: {'DISPLAY': ':0', 08:15:47 INFO - 'HOME': '/home/cltbld', 08:15:47 INFO - 'LANG': 'en_US.UTF-8', 08:15:47 INFO - 'LANGUAGE': 'en_US:en', 08:15:47 INFO - 'LOGNAME': 'cltbld', 08:15:47 INFO - 'MAIL': '/var/mail/cltbld', 08:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:47 INFO - 'MOZ_NO_REMOTE': '1', 08:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:47 INFO - 'NO_EM_RESTART': '1', 08:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:47 INFO - 'PWD': '/builds/slave/test', 08:15:47 INFO - 'SHELL': '/bin/bash', 08:15:47 INFO - 'SHLVL': '1', 08:15:47 INFO - 'TERM': 'linux', 08:15:47 INFO - 'TMOUT': '86400', 08:15:47 INFO - 'USER': 'cltbld', 08:15:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:47 INFO - '_': '/tools/buildbot/bin/python'} 08:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:47 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 08:15:47 INFO - Cleaning up... 08:15:47 INFO - Return code: 0 08:15:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:47 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')]} 08:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:47 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')]} 08:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:47 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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:15:47 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 08:15:47 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 08:15:47 INFO - Using env: {'DISPLAY': ':0', 08:15:47 INFO - 'HOME': '/home/cltbld', 08:15:47 INFO - 'LANG': 'en_US.UTF-8', 08:15:47 INFO - 'LANGUAGE': 'en_US:en', 08:15:47 INFO - 'LOGNAME': 'cltbld', 08:15:47 INFO - 'MAIL': '/var/mail/cltbld', 08:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:47 INFO - 'MOZ_NO_REMOTE': '1', 08:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:47 INFO - 'NO_EM_RESTART': '1', 08:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:47 INFO - 'PWD': '/builds/slave/test', 08:15:47 INFO - 'SHELL': '/bin/bash', 08:15:47 INFO - 'SHLVL': '1', 08:15:47 INFO - 'TERM': 'linux', 08:15:47 INFO - 'TMOUT': '86400', 08:15:47 INFO - 'USER': 'cltbld', 08:15:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:47 INFO - '_': '/tools/buildbot/bin/python'} 08:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:47 INFO - Downloading/unpacking psutil>=3.1.1 08:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:49 INFO - Installing collected packages: psutil 08:15:49 INFO - Running setup.py install for psutil 08:15:49 INFO - building 'psutil._psutil_linux' extension 08:15:49 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 08:15:49 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 08:15:49 INFO - building 'psutil._psutil_posix' extension 08:15:49 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 08:15:49 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 08:15:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:49 INFO - Successfully installed psutil 08:15:49 INFO - Cleaning up... 08:15:50 INFO - Return code: 0 08:15:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:50 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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:15:50 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 08:15:50 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 08:15:50 INFO - Using env: {'DISPLAY': ':0', 08:15:50 INFO - 'HOME': '/home/cltbld', 08:15:50 INFO - 'LANG': 'en_US.UTF-8', 08:15:50 INFO - 'LANGUAGE': 'en_US:en', 08:15:50 INFO - 'LOGNAME': 'cltbld', 08:15:50 INFO - 'MAIL': '/var/mail/cltbld', 08:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:50 INFO - 'MOZ_NO_REMOTE': '1', 08:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:50 INFO - 'NO_EM_RESTART': '1', 08:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:50 INFO - 'PWD': '/builds/slave/test', 08:15:50 INFO - 'SHELL': '/bin/bash', 08:15:50 INFO - 'SHLVL': '1', 08:15:50 INFO - 'TERM': 'linux', 08:15:50 INFO - 'TMOUT': '86400', 08:15:50 INFO - 'USER': 'cltbld', 08:15:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:50 INFO - '_': '/tools/buildbot/bin/python'} 08:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:52 INFO - Installing collected packages: mozsystemmonitor 08:15:52 INFO - Running setup.py install for mozsystemmonitor 08:15:52 INFO - Successfully installed mozsystemmonitor 08:15:52 INFO - Cleaning up... 08:15:52 INFO - Return code: 0 08:15:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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', '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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:15: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 blobuploader==1.2.4 08:15:52 INFO - Using env: {'DISPLAY': ':0', 08:15:52 INFO - 'HOME': '/home/cltbld', 08:15:52 INFO - 'LANG': 'en_US.UTF-8', 08:15:52 INFO - 'LANGUAGE': 'en_US:en', 08:15:52 INFO - 'LOGNAME': 'cltbld', 08:15:52 INFO - 'MAIL': '/var/mail/cltbld', 08:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:52 INFO - 'MOZ_NO_REMOTE': '1', 08:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:52 INFO - 'NO_EM_RESTART': '1', 08:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:52 INFO - 'PWD': '/builds/slave/test', 08:15:52 INFO - 'SHELL': '/bin/bash', 08:15:52 INFO - 'SHLVL': '1', 08:15:52 INFO - 'TERM': 'linux', 08:15:52 INFO - 'TMOUT': '86400', 08:15:52 INFO - 'USER': 'cltbld', 08:15:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:52 INFO - '_': '/tools/buildbot/bin/python'} 08:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:15:52 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 08:15:52 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 08:15:52 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 08:15:52 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 08:15:52 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 08:15:52 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 08:15:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15:54 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 08:15:54 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 08:15:54 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 08:15:54 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 08:15:54 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 08:15:54 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 08:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15:54 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 08:15:54 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 08:15:54 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 08:15:54 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 08:15:54 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 08:15:54 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 08:15:55 INFO - Downloading docopt-0.6.1.tar.gz 08:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:55 INFO - Running setup.py install for blobuploader 08:15:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:55 INFO - Running setup.py install for requests 08:15:55 INFO - Running setup.py install for docopt 08:15:55 INFO - Successfully installed blobuploader requests docopt 08:15:55 INFO - Cleaning up... 08:15:55 INFO - Return code: 0 08:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:55 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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:15:55 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 08:15:55 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 08:15:55 INFO - Using env: {'DISPLAY': ':0', 08:15:55 INFO - 'HOME': '/home/cltbld', 08:15:55 INFO - 'LANG': 'en_US.UTF-8', 08:15:55 INFO - 'LANGUAGE': 'en_US:en', 08:15:55 INFO - 'LOGNAME': 'cltbld', 08:15:55 INFO - 'MAIL': '/var/mail/cltbld', 08:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:55 INFO - 'MOZ_NO_REMOTE': '1', 08:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:55 INFO - 'NO_EM_RESTART': '1', 08:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:55 INFO - 'PWD': '/builds/slave/test', 08:15:55 INFO - 'SHELL': '/bin/bash', 08:15:55 INFO - 'SHLVL': '1', 08:15:55 INFO - 'TERM': 'linux', 08:15:55 INFO - 'TMOUT': '86400', 08:15:55 INFO - 'USER': 'cltbld', 08:15:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:55 INFO - '_': '/tools/buildbot/bin/python'} 08:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:55 INFO - Running setup.py (path:/tmp/pip-FqcIEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:56 INFO - Running setup.py (path:/tmp/pip-UKqGSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:56 INFO - Running setup.py (path:/tmp/pip-E5rvCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:56 INFO - Running setup.py (path:/tmp/pip-WxtHm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:56 INFO - Running setup.py (path:/tmp/pip-YhIDI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:56 INFO - Running setup.py (path:/tmp/pip-hcvQpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:56 INFO - Running setup.py (path:/tmp/pip-MPU_n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:56 INFO - Running setup.py (path:/tmp/pip-37P2VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:56 INFO - Running setup.py (path:/tmp/pip-6jhIHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:56 INFO - Running setup.py (path:/tmp/pip-UVTsUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:56 INFO - Running setup.py (path:/tmp/pip-BLvWx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:56 INFO - Running setup.py (path:/tmp/pip-ApNhUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:56 INFO - Running setup.py (path:/tmp/pip-ibmb17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:56 INFO - Running setup.py (path:/tmp/pip-4HVKJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:57 INFO - Running setup.py (path:/tmp/pip-chywJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:57 INFO - Running setup.py (path:/tmp/pip-oYPuVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:57 INFO - Running setup.py (path:/tmp/pip-IWVanS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:57 INFO - Running setup.py install for manifestparser 08:15:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:57 INFO - Running setup.py install for mozcrash 08:15:57 INFO - Running setup.py install for mozdebug 08:15:57 INFO - Running setup.py install for mozdevice 08:15:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:57 INFO - Running setup.py install for mozfile 08:15:57 INFO - Running setup.py install for mozhttpd 08:15:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:57 INFO - Running setup.py install for mozinfo 08:15:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:57 INFO - Running setup.py install for mozInstall 08:15:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Running setup.py install for mozleak 08:15:58 INFO - Running setup.py install for mozlog 08:15:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Running setup.py install for moznetwork 08:15:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Running setup.py install for mozprocess 08:15:58 INFO - Running setup.py install for mozprofile 08:15:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Running setup.py install for mozrunner 08:15:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Running setup.py install for mozscreenshot 08:15:58 INFO - Running setup.py install for moztest 08:15:58 INFO - Running setup.py install for mozversion 08:15:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:58 INFO - Cleaning up... 08:15:59 INFO - Return code: 0 08:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:59 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')]} 08:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:59 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')]} 08:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:59 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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:15:59 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 08:15:59 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 08:15:59 INFO - Using env: {'DISPLAY': ':0', 08:15:59 INFO - 'HOME': '/home/cltbld', 08:15:59 INFO - 'LANG': 'en_US.UTF-8', 08:15:59 INFO - 'LANGUAGE': 'en_US:en', 08:15:59 INFO - 'LOGNAME': 'cltbld', 08:15:59 INFO - 'MAIL': '/var/mail/cltbld', 08:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:59 INFO - 'MOZ_NO_REMOTE': '1', 08:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:59 INFO - 'NO_EM_RESTART': '1', 08:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:59 INFO - 'PWD': '/builds/slave/test', 08:15:59 INFO - 'SHELL': '/bin/bash', 08:15:59 INFO - 'SHLVL': '1', 08:15:59 INFO - 'TERM': 'linux', 08:15:59 INFO - 'TMOUT': '86400', 08:15:59 INFO - 'USER': 'cltbld', 08:15:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:59 INFO - '_': '/tools/buildbot/bin/python'} 08:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:59 INFO - Running setup.py (path:/tmp/pip-Kdokm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:59 INFO - Running setup.py (path:/tmp/pip-qg0uKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:59 INFO - Running setup.py (path:/tmp/pip-hLwOqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:59 INFO - Running setup.py (path:/tmp/pip-HnuSGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:59 INFO - Running setup.py (path:/tmp/pip-CvXnyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:59 INFO - Running setup.py (path:/tmp/pip-hLfM16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:59 INFO - Running setup.py (path:/tmp/pip-qPhGdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:59 INFO - Running setup.py (path:/tmp/pip-FH9IED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:59 INFO - Running setup.py (path:/tmp/pip-Iyx0ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:59 INFO - Running setup.py (path:/tmp/pip-uJU_bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:59 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)) 08:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:59 INFO - Running setup.py (path:/tmp/pip-FMjcnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:00 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)) 08:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:00 INFO - Running setup.py (path:/tmp/pip-sMynjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:00 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)) 08:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:00 INFO - Running setup.py (path:/tmp/pip-KvLX0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:00 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)) 08:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:00 INFO - Running setup.py (path:/tmp/pip-fv0k5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:00 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)) 08:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:00 INFO - Running setup.py (path:/tmp/pip-X8GDyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:00 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)) 08:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:00 INFO - Running setup.py (path:/tmp/pip-uNhqJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:00 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)) 08:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:00 INFO - Running setup.py (path:/tmp/pip-eRclZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:00 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)) 08:16:00 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)) 08:16:00 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)) 08:16:00 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)) 08:16:00 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)) 08:16:00 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)) 08:16:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16:02 INFO - Downloading blessings-1.6.tar.gz 08:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:02 INFO - Installing collected packages: blessings 08:16:02 INFO - Running setup.py install for blessings 08:16:02 INFO - Successfully installed blessings 08:16:02 INFO - Cleaning up... 08:16:02 INFO - Return code: 0 08:16:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:02 INFO - Reading from file tmpfile_stdout 08:16:02 INFO - Current package versions: 08:16:02 INFO - argparse == 1.2.1 08:16:02 INFO - blessings == 1.6 08:16:02 INFO - blobuploader == 1.2.4 08:16:02 INFO - docopt == 0.6.1 08:16:02 INFO - manifestparser == 1.1 08:16:02 INFO - mozInstall == 1.12 08:16:02 INFO - mozcrash == 0.17 08:16:02 INFO - mozdebug == 0.1 08:16:02 INFO - mozdevice == 0.48 08:16:02 INFO - mozfile == 1.2 08:16:02 INFO - mozhttpd == 0.7 08:16:02 INFO - mozinfo == 0.9 08:16:02 INFO - mozleak == 0.1 08:16:02 INFO - mozlog == 3.2 08:16:02 INFO - moznetwork == 0.27 08:16:02 INFO - mozprocess == 0.22 08:16:02 INFO - mozprofile == 0.28 08:16:02 INFO - mozrunner == 6.11 08:16:02 INFO - mozscreenshot == 0.1 08:16:02 INFO - mozsystemmonitor == 0.3 08:16:02 INFO - moztest == 0.7 08:16:02 INFO - mozversion == 1.4 08:16:02 INFO - psutil == 3.1.1 08:16:02 INFO - requests == 1.2.3 08:16:02 INFO - wsgiref == 0.1.2 08:16:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:02 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')]} 08:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:02 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')]} 08:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:02 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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:16:02 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 08:16:02 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 08:16:02 INFO - Using env: {'DISPLAY': ':0', 08:16:02 INFO - 'HOME': '/home/cltbld', 08:16:02 INFO - 'LANG': 'en_US.UTF-8', 08:16:02 INFO - 'LANGUAGE': 'en_US:en', 08:16:02 INFO - 'LOGNAME': 'cltbld', 08:16:02 INFO - 'MAIL': '/var/mail/cltbld', 08:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:02 INFO - 'MOZ_NO_REMOTE': '1', 08:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:02 INFO - 'NO_EM_RESTART': '1', 08:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:02 INFO - 'PWD': '/builds/slave/test', 08:16:02 INFO - 'SHELL': '/bin/bash', 08:16:02 INFO - 'SHLVL': '1', 08:16:02 INFO - 'TERM': 'linux', 08:16:02 INFO - 'TMOUT': '86400', 08:16:02 INFO - 'USER': 'cltbld', 08:16:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:02 INFO - '_': '/tools/buildbot/bin/python'} 08:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 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)) 08:16:03 INFO - Cleaning up... 08:16:03 INFO - Return code: 0 08:16:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 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 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:16:03 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 08:16:03 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 08:16:03 INFO - Using env: {'DISPLAY': ':0', 08:16:03 INFO - 'HOME': '/home/cltbld', 08:16:03 INFO - 'LANG': 'en_US.UTF-8', 08:16:03 INFO - 'LANGUAGE': 'en_US:en', 08:16:03 INFO - 'LOGNAME': 'cltbld', 08:16:03 INFO - 'MAIL': '/var/mail/cltbld', 08:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:03 INFO - 'MOZ_NO_REMOTE': '1', 08:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:03 INFO - 'NO_EM_RESTART': '1', 08:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:03 INFO - 'PWD': '/builds/slave/test', 08:16:03 INFO - 'SHELL': '/bin/bash', 08:16:03 INFO - 'SHLVL': '1', 08:16:03 INFO - 'TERM': 'linux', 08:16:03 INFO - 'TMOUT': '86400', 08:16:03 INFO - 'USER': 'cltbld', 08:16:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:03 INFO - '_': '/tools/buildbot/bin/python'} 08:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:03 INFO - Downloading/unpacking jsonschema 08:16:03 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 08:16:03 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 08:16:03 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 08:16:03 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 08:16:03 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 08:16:03 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 08:16:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:05 INFO - Downloading/unpacking functools32 (from jsonschema) 08:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:05 INFO - warning: no files found matching '*.txt' 08:16:05 INFO - no previously-included directories found matching 'build' 08:16:05 INFO - no previously-included directories found matching 'dist' 08:16:05 INFO - no previously-included directories found matching '.git*' 08:16:05 INFO - Installing collected packages: jsonschema, functools32 08:16:05 INFO - Running setup.py install for functools32 08:16:05 INFO - warning: no files found matching '*.txt' 08:16:05 INFO - no previously-included directories found matching 'build' 08:16:05 INFO - no previously-included directories found matching 'dist' 08:16:05 INFO - no previously-included directories found matching '.git*' 08:16:05 INFO - Successfully installed jsonschema functools32 08:16:05 INFO - Cleaning up... 08:16:05 INFO - Return code: 0 08:16:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff296a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, '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': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', '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 08:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:16:05 INFO - Using env: {'DISPLAY': ':0', 08:16:05 INFO - 'HOME': '/home/cltbld', 08:16:05 INFO - 'LANG': 'en_US.UTF-8', 08:16:05 INFO - 'LANGUAGE': 'en_US:en', 08:16:05 INFO - 'LOGNAME': 'cltbld', 08:16:05 INFO - 'MAIL': '/var/mail/cltbld', 08:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:05 INFO - 'MOZ_NO_REMOTE': '1', 08:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:05 INFO - 'NO_EM_RESTART': '1', 08:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:05 INFO - 'PWD': '/builds/slave/test', 08:16:05 INFO - 'SHELL': '/bin/bash', 08:16:05 INFO - 'SHLVL': '1', 08:16:05 INFO - 'TERM': 'linux', 08:16:05 INFO - 'TMOUT': '86400', 08:16:05 INFO - 'USER': 'cltbld', 08:16:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:05 INFO - '_': '/tools/buildbot/bin/python'} 08:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:05 INFO - Downloading/unpacking flake8 08:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:16:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:16:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:08 INFO - no previously-included directories found matching 'docs/_build' 08:16:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:16:08 INFO - Running setup.py install for pep8 08:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:08 INFO - no previously-included directories found matching 'docs/_build' 08:16:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:16:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:16:08 INFO - Cleaning up... 08:16:08 INFO - Return code: 0 08:16:08 INFO - Running post-action listener: _resource_record_post_action 08:16:08 INFO - Running post-action listener: _start_resource_monitoring 08:16:08 INFO - Starting resource monitoring. 08:16:08 INFO - ##### 08:16:08 INFO - ##### Finished create-virtualenv step (success) 08:16:08 INFO - ##### 08:16:08 INFO - ##### 08:16:08 INFO - ##### Running install step. 08:16:08 INFO - ##### 08:16:08 INFO - Running pre-action listener: _resource_record_pre_action 08:16:08 INFO - Running main action method: install 08:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:08 INFO - Reading from file tmpfile_stdout 08:16:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:08 INFO - Reading from file tmpfile_stdout 08:16:08 INFO - Output received: 08:16:08 INFO - Usage: mozinstall [options] installer 08:16:08 INFO - Options: 08:16:08 INFO - -h, --help show this help message and exit 08:16:08 INFO - -d DEST, --destination=DEST 08:16:08 INFO - Directory to install application into. [default: 08:16:08 INFO - "/builds/slave/test"] 08:16:08 INFO - --app=APP Application being installed. [default: firefox] 08:16:08 INFO - mkdir: /builds/slave/test/build/application 08:16:08 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'] 08:16:08 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 08:16:25 INFO - Reading from file tmpfile_stdout 08:16:25 INFO - Output received: 08:16:25 INFO - /builds/slave/test/build/application/firefox/firefox 08:16:25 INFO - Running post-action listener: _resource_record_post_action 08:16:25 INFO - ##### 08:16:25 INFO - ##### Finished install step (success) 08:16:25 INFO - ##### 08:16:25 INFO - ##### 08:16:25 INFO - ##### Running run-tests step. 08:16:25 INFO - ##### 08:16:25 INFO - Running pre-action listener: _resource_record_pre_action 08:16:25 INFO - Running main action method: run_tests 08:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:25 INFO - Python 2.7.3 08:16:25 INFO - Return code: 0 08:16:25 INFO - grabbing minidump binary from tooltool 08:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:25 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 0xf1b9c0>, '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 0xf1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:25 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 08:16:25 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 08:16:25 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 08:16:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:25 INFO - Return code: 0 08:16:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:16:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:16:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:16:26 INFO - Return code: 0 08:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:16:26 INFO - Using env: {'DISPLAY': ':0', 08:16:26 INFO - 'HOME': '/home/cltbld', 08:16:26 INFO - 'LANG': 'en_US.UTF-8', 08:16:26 INFO - 'LANGUAGE': 'en_US:en', 08:16:26 INFO - 'LOGNAME': 'cltbld', 08:16:26 INFO - 'MAIL': '/var/mail/cltbld', 08:16:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:26 INFO - 'MOZ_NO_REMOTE': '1', 08:16:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:26 INFO - 'NO_EM_RESTART': '1', 08:16:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:26 INFO - 'PWD': '/builds/slave/test', 08:16:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:26 INFO - 'SHELL': '/bin/bash', 08:16:26 INFO - 'SHLVL': '1', 08:16:26 INFO - 'TERM': 'linux', 08:16:26 INFO - 'TMOUT': '86400', 08:16:26 INFO - 'USER': 'cltbld', 08:16:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463410897.859006-300278106', 08:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:26 INFO - '_': '/tools/buildbot/bin/python'} 08:16:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:16:26 INFO - mozversion application_buildid: 20160516053010 08:16:26 INFO - mozversion application_changeset: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 08:16:26 INFO - mozversion application_display_name: Nightly 08:16:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:26 INFO - mozversion application_name: Firefox 08:16:26 INFO - mozversion application_remotingname: firefox 08:16:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:16:26 INFO - mozversion application_vendor: Mozilla 08:16:26 INFO - mozversion application_version: 49.0a1 08:16:26 INFO - mozversion platform_buildid: 20160516053010 08:16:26 INFO - mozversion platform_changeset: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 08:16:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:16:26 INFO - mozversion platform_version: 49.0a1 08:16:26 INFO - using testdate: 1463411786 08:16:26 INFO - actual date: 1463411786 08:16:26 INFO - starting webserver on 'localhost:35552' 08:16:26 INFO - SUITE-START | Running 2 tests 08:16:26 INFO - TEST-START | dromaeo_css 08:16:26 INFO - operating with platform_type : linux_ 08:16:26 INFO - Initialising browser for dromaeo_css test... 08:16:26 INFO - TEST-INFO | started process 9168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvnaAV_/profile http://localhost:35552/getInfo.html) 08:16:30 INFO - PROCESS | 9168 | 08:16:30 INFO - PROCESS | 9168 | (process:9236): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:16:31 INFO - PROCESS | 9168 | __metrics Screen width/height:1600/1200 08:16:31 INFO - PROCESS | 9168 | colorDepth:24 08:16:31 INFO - PROCESS | 9168 | Browser inner width/height: 1024/697 08:16:31 INFO - PROCESS | 9168 | __metrics 08:16:32 ERROR - PROCESS | 9168 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:16:33 INFO - TEST-INFO | 9168: exit 0 08:16:33 INFO - Browser initialized. 08:16:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:33 INFO - TEST-INFO | started process 9287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvnaAV_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:35 INFO - PROCESS | 9287 | 08:16:35 INFO - PROCESS | 9287 | (process:9350): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:16:45 INFO - PROCESS | 9287 | RSS: Main: 163151872 08:16:45 INFO - PROCESS | 9287 | 08:17:34 INFO - PROCESS | 9287 | 1463411854697 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] 08:19:42 INFO - PROCESS | 9287 | Cycle 1(1): loaded http://localhost:35552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35552/tests/dromaeo/cssquery-ext.html) 08:19:43 INFO - PROCESS | 9287 | RSS: Main: 166772736 08:19:43 INFO - PROCESS | 9287 | 08:22:45 INFO - PROCESS | 9287 | Cycle 1(1): loaded http://localhost:35552/tests/dromaeo/cssquery-ext.html (next: http://localhost:35552/tests/dromaeo/cssquery-jquery.html) 08:22:46 INFO - PROCESS | 9287 | RSS: Main: 166572032 08:22:46 INFO - PROCESS | 9287 | 08:25:47 INFO - PROCESS | 9287 | Cycle 1(1): loaded http://localhost:35552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35552/tests/dromaeo/cssquery-mootools.html) 08:25:48 INFO - PROCESS | 9287 | RSS: Main: 167591936 08:25:48 INFO - PROCESS | 9287 | 08:28:50 INFO - PROCESS | 9287 | Cycle 1(1): loaded http://localhost:35552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35552/tests/dromaeo/cssquery-prototype.html) 08:28:50 INFO - PROCESS | 9287 | RSS: Main: 165289984 08:28:50 INFO - PROCESS | 9287 | 08:31:53 INFO - PROCESS | 9287 | Cycle 1(1): loaded http://localhost:35552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35552/tests/dromaeo/cssquery-yui.html) 08:31:53 INFO - PROCESS | 9287 | RSS: Main: 166461440 08:31:53 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | Cycle 1(1): loaded http://localhost:35552/tests/dromaeo/cssquery-yui.html (next: http://localhost:35552/tests/dromaeo/cssquery-dojo.html) 08:34:56 INFO - PROCESS | 9287 | RSS: Main: 168697856 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | __start_tp_report 08:34:56 INFO - PROCESS | 9287 | _x_x_mozilla_page_load 08:34:56 INFO - PROCESS | 9287 | _x_x_mozilla_page_load_details 08:34:56 INFO - PROCESS | 9287 | |i|pagename|runs| 08:34:56 INFO - PROCESS | 9287 | |0;dojo.html;3195.1213416310516;3216.903492895214;3233.5634689316935;3266.705996460318;3272.8690852365908;5428.457154284574;5445.319335083114;5454.563634909203;5527.143292789624;5528.778848846051;5323.387810401805;5441.782328706847;5458.91811622825;5492.340919089715;5532.6680399175975;4944.480829512903;4977.950220497803;5095.439501654815;5137.5633071188995;5185.585153187755;862.5969241516515;4985.52637499437;5030.723310217936;5056.342675452204;5057.0897238497055;5008.198688209887;5029.069622119883;5045.268436076785;5048.6465947383695;5096.057229412552;4946.505349465061;5062.594992400599;5078.187490001582;5083.720395378253;5092.261622064817;4932.457429682732;5000.599952003831;5002.1246281900885;5002.89994200114;5037.068142393632;5395.10980688186;5410.621256512046;5417.133258678632;5433.429489903582;5481.205225242357;5765.625234359795;5837.182794408786;5874.1776151338845;5893.911591326134;5915.349311575723;5927.407259274081;5971.70141492928;5973.790917317917;5990.880182396371;6016.96991515044;5511.22842802008;5519.613627046108;5526.088195447746;5544.140658197985;5547.916781248285;5848.625572990344;5939.940600594025;5973.910391344133;6003.879922401527;6060.818175454743;5726.0838265877255;5750.396208398141;5759.308882934075;5764.942350576524;5771.913421298684;5810.331811841608;5811.593188476851;5836.358000619928;5837.3870743571315;5845.941540584625;5652.858678532987;5816.941830581724;5836.9124463133085;5860.70696465175;5878.882422351529;5703.800366987219;5721.5136713379825;5725.026745453283;5736.627119237236;5838.299404071538;4447.043885564619;4450.109978004412;4457.130859482435;4464.665150113689;4512.842050528216;3925.0972276376024;3958.5249770027203;3976.840926362971;4000.0599859033105;4003.459532963013;5625.015622266169;5665.065264231355;5669.291338582677;5672.602917795714;5686.488216060575;5796.913046304308;5933.910991335133;5960.791372301948;5963.463288304073;5972.193753843262;5549.056660367747;5586.329640443173;5588.832335029955;5608.775648974077;5614.943850561442;4888.437829649564;4895.412550493892;4911.557959783637;4946.332245146931;4958.281049247911;5927.407259274038;6095.2685677718955;6097.725602347905;6109.419605137505;6115.510759139258;5908.054711246266;6005.789797357072;6006.279246490274;6015.187949626745;6030.5778595497895;6178.351273116438;6191.380861913953;6192.628442293477;6201.782937597162;6204;5629.380768115422;5761.251037365116;5799.2750906136735;5881.411858814085;5886.293644762656;5896;5932;5948.226730525004;5965.9105113422465;6019.277686677451;5745.2818397700285;5783;5789.8552536186935;5790.01569733138;5804.593678442468;5595.748191331481;5643.576731745217;5707.8858422832145;5715.514181294637;5796.391378905323;5476.644018138808;5616.859578510406;5636.098224284095;5647.971760141173;5662.915056274077;5796.217510636179;5805.158252053344;5810;5839.970800145972;5852.092925596539;5526.088195447867;5605.159226116115;5618.129189975561;5693.373728889902;5748 08:34:56 INFO - PROCESS | 9287 | |1;ext.html;607.2439812433519;642.1267076775586;652.7421668440963;661.2164584966814;677.062268757771;40195;44209.33685994713;44238;44257;44436;44371.11257774843;44651.77674111633;44806.32790508145;44892;44959.32561011588;8874.467531948088;8949.686760963368;8960.23837973773;8985.95507022464;9017.54912254388;8905.643774249022;9008.909910900906;9038.86441703375;9051.14014168653;9054.592543335566;9106.63573457061;9121.17909388155;9145.085491450869;9146.954265228664;9150.130737579919;9037.141471560224;9043.547822608876;9047.592858321392;9054.139856713635;9104.81790364189;8949.328800340001;9019.774505637411;9021.458712477206;9028.322875784343;9033.367664263504;41294.38058429126;41451.58548414507;41476.58523414758;41789.58210417918;41792.79103604493;3619.040954147153;3758.49260349852;3774.01875512366;4096.32410652242;4123.422720819088;33114.834425827954;33839.661603383895;33855.32289354224;33985.6601433985;34133.82933085319;4390.209762242795;4406.581374769392;4491.483479399845;4525.162844873676;4538.841140560097;371075;372186;372444;373081;374429;60985;61347;61501.07748383778;61734.38265617376;61772.38227617756;37249.627503725154;38372.61627383746;64741.35258647447;64757;64983.35016649773;17533;17603.911980440014;17722.91138544299;17786;17852.732209016875;12142.271463712206;12164.270143791224;12177.025837932944;12188.573399931138;12262.01903847708;20037.899810500854;20478.283260085824;20624.07191676348;20652.896735516228;20739.688904666444;7388.743913534712;7716.305532502101;7723.9613801931755;7758.262965018314;7818;1068.604616291977;1123.7920984617872;1172.3141961952183;1178;1187.922785018971;32908.50637240443;32991;33371.49942750861;33668.98993030213;33952.320953581286;1136.1024790415645;1197.0483465644834;1222.2727477151082;1256.1207154991544;1287.2340957130493;17470;17491.38780142689;17522.386716465116;17543.473695789147;17656.55858603545;575282;579574;585817;586184;587552;58592;59643.403565964654;59658;59993.70003149956;60139.39860601338;1412.3856122586708;1413.2721648350903;1413.5476647472915;1449.2753623188617;1452.5424491285212;30941.535876962313;32052.67947320497;32904.50643240305;33621.66378336185;33638;54837.725811370685;56943;58284.54288642648;58327.708361457924;63864;412510;414003;414206;414552;417050;43281;43410.13179736325;43516.56483435125;43795;43830.34254486249;48525.51474485351;48621.756891215315;48917.510824891295;49216.50783492119;49651;39870;40954.79522602368;40997;41486.377704335064;41941.790291048346;39308;39313.41029884497;39936.2012759749;40428.1914361717;40927.59072409357;41543.58456415518;45765.542344576126;45874.77062614666;46628.300575492074;46717.53282467132;37092.258154836214;37285.25429491449;37348;37897.81051094727;37921.4311785329;29152.125436236947;29312;29821.85089074541;29883.70116298896;29988.850055749583 08:34:56 INFO - PROCESS | 9287 | |2;jquery.html;394.30405334584464;395.2529718831409;403.1493548612427;405.06834281153374;417.478152309613;13868.37592308346;17801.732974005383;18960.525986850334;19537.99999999998;19544.21823127075;18529.722054169197;18823.247070117213;19302.420927372164;19435.902820485877;19525.804741952576;5265.684058956455;5545.223668686387;5567.526760225385;5671.404502527237;5861.384554621746;5213.426523082458;5527.281453411051;5614.2701448811595;5628.099504079348;5669.518090962273;5581.162825576176;5590.049691552425;5599.356074051475;5600.747966341504;5636;5998;6206.7827626033095;6377.968110159466;6387.233531976192;6394.904076438811;5503.559715222773;5605.327360716699;5641.71791410432;5658.773649054033;5665.631733937281;13187.07690461668;13282.601521954357;17362.739558906625;22270.88864555683;22590;2246.135237933391;2281.908723651052;2394.964075538868;2395.5208958208254;2571.7942564594787;9860.668770091122;10079.596816127347;10154.9492252539;12399.814002789966;14085.436582536686;1963.185278109583;1999.530110424049;2043.559290700053;2051.138521820824;2069.4826293426645;82365.58817205936;83524.58237708773;83658.58170709168;83844.58077709633;84473.57763211206;9352.298577606707;9969.80060398788;10542.156627469938;10675.306105103144;10843.722818208107;14988.325525351385;15048.548543543711;15101.697966040618;15143.621409464851;15167.317470713844;8081.878771818428;8202.58987050657;8245.340372770284;8338.082810890797;8360.613951349713;8048.315893149148;8112.310453611509;8156.918430815735;8181.304589109992;8217.506949583045;4499.595036446735;4625.8843528911375;4655.2784318430695;4689.20283551797;4735;1959.4709428454237;1962.3328068456792;1975.7629084509952;1994.5412555112405;1997.7902320256164;948.2698322291797;1017.8524114003576;1045.1690905729963;1107.180686292138;1123.4720779739548;18444.446666600023;18698.532536686693;18877.339293124674;19107.522311942314;19149.90425047866;1034.1416624201895;1039.6205385034407;1047.9109275711498;1052.547404616007;1063.7659714862873;10189.796204075878;10525.736856578647;10750.301230419998;10772.569097236023;10778.137748980063;506453.5482516262;518451;519183;522553;526247;77464.61267693738;87524.5623771877;94531.52734236285;94931;95686;1014.6905193915779;1025.7692019295748;1037.5382954585136;1045.2892033417197;1070.261519551507;16551;16790.24443900003;16876.324947001984;16979.320827166775;17184.828151718324;38788.6121138785;39743.801280994565;39880.40179397253;41036.38445423261;41835;55560;57784.42215577958;58285.708571456875;58339.4166058334;58555;5901.852453688693;7972.880406793786;8284.585770711561;8436.789080273042;8440.704575339834;11344.319340839576;12380.504779808707;12644.620661380173;12856.357182140668;12864.871351286742;11203.103751700008;11212.49543770516;11287.363332316603;11393.487293071998;11580.710482238012;10952.507137179005;11050.226484146033;11090.445477726244;11104.888951110386;11634.6509604712;11514.82727759101;11526.308421494738;11528.077753779846;11542;11610.535578576762;7113.608751518716;7498.737544185928;7714.035745531809;8391.874121888055;8394.496330220207;8246.793830154294;10938.45307734626;11300.547978081113;11327.32036077838;11337.342440112256 08:34:56 INFO - PROCESS | 9287 | |3;mootools.html;1516.6132636177772;1565.3269094289456;1713.6487020160869;1848.898310592917;1864.8321651051403;7978.281954624083;8579.871301930469;8702.477851328924;9085.318601104918;9092.363534552576;8701.390902636818;8954.059823718497;8998.100189981014;9012.369134160595;9098.408603440788;2317.8261630377747;2350.1304517328613;2358.41039740065;2360.114956891166;2363.2555744940373;2258.54829034193;2286.4969706664506;2296.1045192374986;2297.977020229793;2304.665823455606;2276.738175109867;2286.965695514569;2310.0875154314035;2375.3111597636666;2386.3556839653284;2291.9770802292014;2296.4832912594698;2298.494331247123;2298.54029194161;2300.827437942161;2289.828262880291;2297.058206135493;2305.3660243433023;2319.8028167605776;2322.431004403915;8965.462072275684;8968.327375446803;8984.191422771983;9036.277097832224;9051.728448146567;5180.456052114511;5290.285811415487;5298.867528311785;5301.363836339626;5305.628605997582;3222.2943614842884;3397.13373089863;3411.1472131967007;3458.4120699480895;3484.390231709466;1100.1693721240413;1124.578283143821;1135.5741596901162;1150.551284998851;1156.7686462707409;12123.151379403445;12257.632271031884;12266.386680665932;12279.815802762965;12304.446299916615;4559.224931761609;4590.977045114753;4658.697184682985;4689.601383882408;4710.0579884022645;9979.501024948724;10003.599856005678;10026.799464010679;10031.347962382422;10042.69871903844;5361.517463428232;5422.322209723785;5433.239346491494;5484.2047903053835;5485.122380419193;4356.6950313477755;4713.835015774432;4810.278458231293;4858.125537403231;5027.321311622884;3866.980665096713;3870.6903447724117;3948.6643635290748;3952.940705889414;3986.5415477219913;1158.09089864456;1174.236746115032;1177.652592485219;1184.029096141156;1187.8396416483663;911.3165126155384;1044.984325235122;1049.275999560301;1055.2560444886337;1061.6337363609543;6218.19163508741;6237.812865614039;6268.09112678659;6290.779822706275;6447.2907980122145;433.6465780388973;453.9251023581072;471.0625854549422;472.1030042918482;472.3057106054095;4348.826046958086;4368.4321038264825;4374.212641724456;4389.100234451929;4444.466664000276;10758.623448179276;11218.382988935524;11262.267952583055;11271.54913803455;11303.830442543369;11218.66344009681;11227.157963152797;11252.606158784403;11273.323600583828;11274.887251127548;8354.373421993374;8447.493150410995;8504.022037465647;8512.106228846005;8516.829663406697;5968.6717230551;6005.159277701038;6096.908546371719;6106.938930610637;6150.846228844314;10547.419891905713;10547.472626368497;10634.149268058381;10729.409882456539;10746.73133171677;10294.3823370598;10400.167986560906;10481.528331224961;10531.631392901212;10742.462876855969;6996.685149168198;7190.89213661785;7379.778606641809;7609.695612175451;7704.499207551491;8763.737087887373;8770.25452836516;8841.381103322705;8853.557322133996;8865.202131808168;7581.128170260491;7633;7746.457747957589;7827.334676552329;8118.878216826871;7559.395248380227;7712.498687585289;7760.728374506865;7771.611419428893;7904.762857114296;6957.373836354753;6975.651217439209;7045.295470452914;7070.858582828418;7078.964605176941;5144.0997825381155;5199.4020687619895;5233.921491177712;5308.203769434461;5318.97340513295;5334.866628334323;5416.350037995466;5485.588580856532;5530.585206109638;5597.020521408818 08:34:56 INFO - PROCESS | 9287 | |4;prototype.html;322.849874808214;331.51267636574227;334.12792611284544;334.4765442083141;337.3657523855153;5483.232347471358;5528.55771538277;5672.829815105543;5732.684702341365;5742.827715168546;5512.228288039668;5559.861003474915;5578.553715702744;5584.1902924075985;5595.38450770415;4291.163223171483;4310.676699247553;4365.380771537084;4405.273129933557;4423.845165419211;4137.3173426384765;4305.3541968704785;4339.175556644243;4345.804438800245;4352.651787856964;4258;4263.829446822139;4290.678199135062;4307.633851122659;4309.676774241929;4243.108947121108;4284.900398804594;4303.612674859278;4324.20002299574;4325.610695037446;3550.751447398683;3780.6030366811365;3803.505544279226;3808.828602712857;3818.3890577507464;5273.604479664041;5294.41761406245;5321.600879934021;5342.652727572734;5347.41178470368;4878.853634390974;4902.338184345139;4910.558049775502;4913.6314776391555;4919.975400123012;5550.805721799758;5791.189233507313;5797.623154494944;5802.810423863098;5819.359870414251;4076.7757773322455;4101.5488296287385;4109.609587089221;4124.4019617155645;4128.380742888591;6051.576389652726;6052.878942421171;6059.484943779784;6061.848453788691;6120.877582448371;4008;4210.200061988213;4214.852480163179;4229.534751177368;4263.59495847894;4274.914501710011;4287.592678695519;4302.709187243814;4323.546027667113;4326.6754993375625;4973;4976.975115124401;4987.875303117378;4999.325091112653;5012;5652.802151924663;5882.882342353215;5956.493698035629;5967.1347654589845;5971.671558064261;1468.955931322062;1472.5655931500232;1481.6962522682825;1484.450753221315;1487.2415068315022;920.5905417845823;937.0769791755116;937.9343445958717;943.3255222515934;947.2232769129386;5030.245463180552;5031.195008798574;5053.418856831438;5068.949310506848;5114.621700909021;5317.41508434072;5330.680159190461;5343.251944727741;5374.946250537445;5390.811321603725;5068.847934561969;5075.436904363273;5084.644074914794;5324.866878327995;5791.710414479259;3201.3917355702342;3210.0369889033664;3242.5136229565755;3274.9029075259577;3278.60656721195;6039.191130062263;6310.643211709505;6344.206974128234;6354.936450635527;6375.3624637536805;6161.938380616226;6210.72051757672;6216.098665693449;6222.62664240147;6241.188645476059;6187.47314030998;6240.438360547572;6270.592411493239;6272.937270627235;6288.937110628926;5774;6068.605540640021;6111.908321375094;6124.173236613178;6128.601640893327;5972.283326000907;5983.521318294439;6020.578559500793;6048.185544336769;6059.182010428536;5992.580519363777;6231.937680623317;6234.501239900706;6299.338569450325;6364.459020983083;4212.810423530887;4234.851780187679;4245.320748680197;4247.129338485542;4251.213525497793;6050;6094.299155597163;6096.451319381277;6105.572609917263;6132.693365331805;5731;5798.6810725410505;5821.301443826768;5888.528917686489;5907.645541267538;5863.1791549184;5888.440598143169;5900.734466948912;5924.377940316377;5946.851328716817;5603.915941260802;5788.855278618068;5810.564207684356;5835.403245555687;5846.532277417881;5879.147523608967;5908.231929849092;5931.9110213345975;5933.940660593512;5944.435278648694;5731.570132240182;5759.94240057594;5794.681292528951;5812.883742325045;5815.185873977562 08:34:56 INFO - PROCESS | 9287 | |5;yui.html;808.9474184178026;822.4530687093084;866.8786369908214;874.3573473496982;886.2998231397197;14577.92711036446;14634.926825365885;14733.631659208526;14767.187804670766;15089.094654320736;12233.694157646041;14364.497242596512;14403.207823569699;14475.420983160688;14491.637709057253;830.2693629605953;849.3247867944998;850.0606829453458;851.706161374328;851.8637018077109;841.6170642357744;848.503625379154;850.4642075492432;852.5694524265238;853.2022558907411;897.5108565831605;910.0990019880337;910.1444642036464;911.4075850697034;911.6444586611227;910.2717825739383;910.7996240827008;910.968116115936;911.4258017449031;912.5300470257789;651.2347991110473;653.9117219175446;654.035297935546;655.1483072006421;656.5633853487425;14749.188794616291;14867.107973521515;14886.10683359002;14921.925390372979;14944.626384340478;15103.47137850181;15265.236738163047;15322.310496027594;15398.230088495531;15402.537923862303;11720.129085511737;11904.702382440422;11933.701657458547;11945.522179112824;12101.455434505468;3702.148505843644;3720.694184611717;3739.196072844324;3795.1081495848453;3800.809959502014;57414.71292643552;58450.70774646142;61031.69484152551;61222.387776122116;61296;11346.716332091764;11581;11721.644466958642;11855;11859.110566707532;20416.979151042684;20550.897245513977;20665.070071846803;20748.273810416562;20908.79091209099;8607.870881936777;8852.114788521096;8927.196552310323;8954.507502087448;8963.462192268486;4984.327115839388;5031.094403007421;5099.490050994871;5103.311053007871;5257.605679574047;3393.474011528217;3482.89551313461;3508.8947331580093;3511.438169892805;3516.613172551017;633.8732253549308;642.2549842183046;643.6556442303439;654.649762377126;667.562746401108;655.8753836770999;781.9100803407567;786.1509569664748;800.3317230112921;804.4248362420781;9841.655542055994;10245.48772561369;10285.177185825116;10301.484925753832;10473.109785668152;640.9551331406757;682.2529330383222;685.3146853146853;687.9920915858191;760.5702777930452;4756.381670382828;4899.681520701143;4926.605871530269;4932.457429682732;4977.576905962961;66979.66510167418;67250.66374668095;69833.30166698268;70079.64960175166;70917.64541177261;60875.39124608786;61040;61314;61656.38343616596;64297.67851160714;55255.72372138194;56088.43911560914;56512.717436413375;56667;58551.41448585545;9377.578008989476;9453.320606299925;9474.38416502925;9568.09103135201;9636.277279203947;38326.61673383342;38565.4215186778;38736.03159920912;38880.41679374755;39882.20235595214;50476.242856356446;50846.23730644117;50905;51094;51318.74340628273;11679.416029198335;11906.166568340479;11908.40457977115;12010.579629712918;12176.269423834598;12318;13091.410886509939;13491;13559.79660305116;13667;12383.380830958236;12715.491380344683;12725;12876.163049401759;12894.03294752916;11586.36275004849;11775.941120294343;12274.938625306817;12386.256824590553;12444.440000199831;12471.750564988468;12628.305443200712;12671.746565068463;12950.805737914126;13225.074244802772;10316;10343.224258180517;10363.32638378503;10558.208134389797;10576.4711764413;9992.250581206294;10331.380117192992;10427.478626068818;10480.161587072864;10566.415037744093 08:34:56 INFO - PROCESS | 9287 | __end_tp_report 08:34:56 INFO - PROCESS | 9287 | __start_cc_report 08:34:56 INFO - PROCESS | 9287 | _x_x_mozilla_cycle_collect,349 08:34:56 INFO - PROCESS | 9287 | __end_cc_report 08:34:56 INFO - PROCESS | 9287 | __startTimestamp1463412896481__endTimestamp 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | ------- Summary: start ------- 08:34:56 INFO - PROCESS | 9287 | Number of tests: 6 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | [#0] dojo.html Cycles:165 Average:5439.26 Median:5665.07 stddev:716.84 (12.7%) stddev-sans-first:697.08 08:34:56 INFO - PROCESS | 9287 | Values: 3195.1 3216.9 3233.6 3266.7 3272.9 5428.5 5445.3 5454.6 5527.1 5528.8 5323.4 5441.8 5458.9 5492.3 5532.7 4944.5 4978.0 5095.4 5137.6 5185.6 862.6 4985.5 5030.7 5056.3 5057.1 5008.2 5029.1 5045.3 5048.6 5096.1 4946.5 5062.6 5078.2 5083.7 5092.3 4932.5 5000.6 5002.1 5002.9 5037.1 5395.1 5410.6 5417.1 5433.4 5481.2 5765.6 5837.2 5874.2 5893.9 5915.3 5927.4 5971.7 5973.8 5990.9 6017.0 5511.2 5519.6 5526.1 5544.1 5547.9 5848.6 5939.9 5973.9 6003.9 6060.8 5726.1 5750.4 5759.3 5764.9 5771.9 5810.3 5811.6 5836.4 5837.4 5845.9 5652.9 5816.9 5836.9 5860.7 5878.9 5703.8 5721.5 5725.0 5736.6 5838.3 4447.0 4450.1 4457.1 4464.7 4512.8 3925.1 3958.5 3976.8 4000.1 4003.5 5625.0 5665.1 5669.3 5672.6 5686.5 5796.9 5933.9 5960.8 5963.5 5972.2 5549.1 5586.3 5588.8 5608.8 5614.9 4888.4 4895.4 4911.6 4946.3 4958.3 5927.4 6095.3 6097.7 6109.4 6115.5 5908.1 6005.8 6006.3 6015.2 6030.6 6178.4 6191.4 6192.6 6201.8 6204.0 5629.4 5761.3 5799.3 5881.4 5886.3 5896.0 5932.0 5948.2 5965.9 6019.3 5745.3 5783.0 5789.9 5790.0 5804.6 5595.7 5643.6 5707.9 5715.5 5796.4 5476.6 5616.9 5636.1 5648.0 5662.9 5796.2 5805.2 5810.0 5840.0 5852.1 5526.1 5605.2 5618.1 5693.4 5748.0 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | [#1] ext.html Cycles:180 Average:62574.89 Median:229419.79 stddev:123482.09 (53.8%) stddev-sans-first:123740.84 08:34:56 INFO - PROCESS | 9287 | Values: 607.2 642.1 652.7 661.2 677.1 40195.0 44209.3 44238.0 44257.0 44436.0 44371.1 44651.8 44806.3 44892.0 44959.3 8874.5 8949.7 8960.2 8986.0 9017.5 8905.6 9008.9 9038.9 9051.1 9054.6 9106.6 9121.2 9145.1 9147.0 9150.1 9037.1 9043.5 9047.6 9054.1 9104.8 8949.3 9019.8 9021.5 9028.3 9033.4 41294.4 41451.6 41476.6 41789.6 41792.8 3619.0 3758.5 3774.0 4096.3 4123.4 33114.8 33839.7 33855.3 33985.7 34133.8 4390.2 4406.6 4491.5 4525.2 4538.8 371075.0 372186.0 372444.0 373081.0 374429.0 60985.0 61347.0 61501.1 61734.4 61772.4 37249.6 38372.6 64741.4 64757.0 64983.4 17533.0 17603.9 17722.9 17786.0 17852.7 12142.3 12164.3 12177.0 12188.6 12262.0 20037.9 20478.3 20624.1 20652.9 20739.7 7388.7 7716.3 7724.0 7758.3 7818.0 1068.6 1123.8 1172.3 1178.0 1187.9 32908.5 32991.0 33371.5 33669.0 33952.3 1136.1 1197.0 1222.3 1256.1 1287.2 17470.0 17491.4 17522.4 17543.5 17656.6 575282.0 579574.0 585817.0 586184.0 587552.0 58592.0 59643.4 59658.0 59993.7 60139.4 1412.4 1413.3 1413.5 1449.3 1452.5 30941.5 32052.7 32904.5 33621.7 33638.0 54837.7 56943.0 58284.5 58327.7 63864.0 412510.0 414003.0 414206.0 414552.0 417050.0 43281.0 43410.1 43516.6 43795.0 43830.3 48525.5 48621.8 48917.5 49216.5 49651.0 39870.0 40954.8 40997.0 41486.4 41941.8 39308.0 39313.4 39936.2 40428.2 40927.6 41543.6 45765.5 45874.8 46628.3 46717.5 37092.3 37285.3 37348.0 37897.8 37921.4 29152.1 29312.0 29821.9 29883.7 29988.9 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | [#2] jquery.html Cycles:180 Average:29451.07 Median:12435.95 stddev:85415.51 (686.8%) stddev-sans-first:85627.26 08:34:56 INFO - PROCESS | 9287 | Values: 394.3 395.3 403.1 405.1 417.5 13868.4 17801.7 18960.5 19538.0 19544.2 18529.7 18823.2 19302.4 19435.9 19525.8 5265.7 5545.2 5567.5 5671.4 5861.4 5213.4 5527.3 5614.3 5628.1 5669.5 5581.2 5590.0 5599.4 5600.7 5636.0 5998.0 6206.8 6378.0 6387.2 6394.9 5503.6 5605.3 5641.7 5658.8 5665.6 13187.1 13282.6 17362.7 22270.9 22590.0 2246.1 2281.9 2395.0 2395.5 2571.8 9860.7 10079.6 10154.9 12399.8 14085.4 1963.2 1999.5 2043.6 2051.1 2069.5 82365.6 83524.6 83658.6 83844.6 84473.6 9352.3 9969.8 10542.2 10675.3 10843.7 14988.3 15048.5 15101.7 15143.6 15167.3 8081.9 8202.6 8245.3 8338.1 8360.6 8048.3 8112.3 8156.9 8181.3 8217.5 4499.6 4625.9 4655.3 4689.2 4735.0 1959.5 1962.3 1975.8 1994.5 1997.8 948.3 1017.9 1045.2 1107.2 1123.5 18444.4 18698.5 18877.3 19107.5 19149.9 1034.1 1039.6 1047.9 1052.5 1063.8 10189.8 10525.7 10750.3 10772.6 10778.1 506453.5 518451.0 519183.0 522553.0 526247.0 77464.6 87524.6 94531.5 94931.0 95686.0 1014.7 1025.8 1037.5 1045.3 1070.3 16551.0 16790.2 16876.3 16979.3 17184.8 38788.6 39743.8 39880.4 41036.4 41835.0 55560.0 57784.4 58285.7 58339.4 58555.0 5901.9 7972.9 8284.6 8436.8 8440.7 11344.3 12380.5 12644.6 12856.4 12864.9 11203.1 11212.5 11287.4 11393.5 11580.7 10952.5 11050.2 11090.4 11104.9 11634.7 11514.8 11526.3 11528.1 11542.0 11610.5 7113.6 7498.7 7714.0 8391.9 8394.5 8246.8 10938.5 11300.5 11327.3 11337.3 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | [#3] mootools.html Cycles:180 Average:5878.06 Median:2506.58 stddev:3371.15 (134.5%) stddev-sans-first:3364.68 08:34:56 INFO - PROCESS | 9287 | Values: 1516.6 1565.3 1713.6 1848.9 1864.8 7978.3 8579.9 8702.5 9085.3 9092.4 8701.4 8954.1 8998.1 9012.4 9098.4 2317.8 2350.1 2358.4 2360.1 2363.3 2258.5 2286.5 2296.1 2298.0 2304.7 2276.7 2287.0 2310.1 2375.3 2386.4 2292.0 2296.5 2298.5 2298.5 2300.8 2289.8 2297.1 2305.4 2319.8 2322.4 8965.5 8968.3 8984.2 9036.3 9051.7 5180.5 5290.3 5298.9 5301.4 5305.6 3222.3 3397.1 3411.1 3458.4 3484.4 1100.2 1124.6 1135.6 1150.6 1156.8 12123.2 12257.6 12266.4 12279.8 12304.4 4559.2 4591.0 4658.7 4689.6 4710.1 9979.5 10003.6 10026.8 10031.3 10042.7 5361.5 5422.3 5433.2 5484.2 5485.1 4356.7 4713.8 4810.3 4858.1 5027.3 3867.0 3870.7 3948.7 3952.9 3986.5 1158.1 1174.2 1177.7 1184.0 1187.8 911.3 1045.0 1049.3 1055.3 1061.6 6218.2 6237.8 6268.1 6290.8 6447.3 433.6 453.9 471.1 472.1 472.3 4348.8 4368.4 4374.2 4389.1 4444.5 10758.6 11218.4 11262.3 11271.5 11303.8 11218.7 11227.2 11252.6 11273.3 11274.9 8354.4 8447.5 8504.0 8512.1 8516.8 5968.7 6005.2 6096.9 6106.9 6150.8 10547.4 10547.5 10634.1 10729.4 10746.7 10294.4 10400.2 10481.5 10531.6 10742.5 6996.7 7190.9 7379.8 7609.7 7704.5 8763.7 8770.3 8841.4 8853.6 8865.2 7581.1 7633.0 7746.5 7827.3 8118.9 7559.4 7712.5 7760.7 7771.6 7904.8 6957.4 6975.7 7045.3 7070.9 7079.0 5144.1 5199.4 5233.9 5308.2 5319.0 5334.9 5416.4 5485.6 5530.6 5597.0 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | [#4] prototype.html Cycles:180 Average:4887.53 Median:5520.39 stddev:1458.31 (26.4%) stddev-sans-first:1421.59 08:34:56 INFO - PROCESS | 9287 | Values: 322.8 331.5 334.1 334.5 337.4 5483.2 5528.6 5672.8 5732.7 5742.8 5512.2 5559.9 5578.6 5584.2 5595.4 4291.2 4310.7 4365.4 4405.3 4423.8 4137.3 4305.4 4339.2 4345.8 4352.7 4258.0 4263.8 4290.7 4307.6 4309.7 4243.1 4284.9 4303.6 4324.2 4325.6 3550.8 3780.6 3803.5 3808.8 3818.4 5273.6 5294.4 5321.6 5342.7 5347.4 4878.9 4902.3 4910.6 4913.6 4920.0 5550.8 5791.2 5797.6 5802.8 5819.4 4076.8 4101.5 4109.6 4124.4 4128.4 6051.6 6052.9 6059.5 6061.8 6120.9 4008.0 4210.2 4214.9 4229.5 4263.6 4274.9 4287.6 4302.7 4323.5 4326.7 4973.0 4977.0 4987.9 4999.3 5012.0 5652.8 5882.9 5956.5 5967.1 5971.7 1469.0 1472.6 1481.7 1484.5 1487.2 920.6 937.1 937.9 943.3 947.2 5030.2 5031.2 5053.4 5068.9 5114.6 5317.4 5330.7 5343.3 5374.9 5390.8 5068.8 5075.4 5084.6 5324.9 5791.7 3201.4 3210.0 3242.5 3274.9 3278.6 6039.2 6310.6 6344.2 6354.9 6375.4 6161.9 6210.7 6216.1 6222.6 6241.2 6187.5 6240.4 6270.6 6272.9 6288.9 5774.0 6068.6 6111.9 6124.2 6128.6 5972.3 5983.5 6020.6 6048.2 6059.2 5992.6 6231.9 6234.5 6299.3 6364.5 4212.8 4234.9 4245.3 4247.1 4251.2 6050.0 6094.3 6096.5 6105.6 6132.7 5731.0 5798.7 5821.3 5888.5 5907.6 5863.2 5888.4 5900.7 5924.4 5946.9 5603.9 5788.9 5810.6 5835.4 5846.5 5879.1 5908.2 5931.9 5933.9 5944.4 5731.6 5759.9 5794.7 5812.9 5815.2 08:34:56 INFO - PROCESS | 9287 | 08:34:56 INFO - PROCESS | 9287 | [#5] yui.html Cycles:180 Average:16023.14 Median:4929.53 stddev:19190.75 (389.3%) stddev-sans-first:19210.58 08:34:56 INFO - PROCESS | 9287 | Values: 808.9 822.5 866.9 874.4 886.3 14577.9 14634.9 14733.6 14767.2 15089.1 12233.7 14364.5 14403.2 14475.4 14491.6 830.3 849.3 850.1 851.7 851.9 841.6 848.5 850.5 852.6 853.2 897.5 910.1 910.1 911.4 911.6 910.3 910.8 911.0 911.4 912.5 651.2 653.9 654.0 655.1 656.6 14749.2 14867.1 14886.1 14921.9 14944.6 15103.5 15265.2 15322.3 15398.2 15402.5 11720.1 11904.7 11933.7 11945.5 12101.5 3702.1 3720.7 3739.2 3795.1 3800.8 57414.7 58450.7 61031.7 61222.4 61296.0 11346.7 11581.0 11721.6 11855.0 11859.1 20417.0 20550.9 20665.1 20748.3 20908.8 8607.9 8852.1 8927.2 8954.5 8963.5 4984.3 5031.1 5099.5 5103.3 5257.6 3393.5 3482.9 3508.9 3511.4 3516.6 633.9 642.3 643.7 654.6 667.6 655.9 781.9 786.2 800.3 804.4 9841.7 10245.5 10285.2 10301.5 10473.1 641.0 682.3 685.3 688.0 760.6 4756.4 4899.7 4926.6 4932.5 4977.6 66979.7 67250.7 69833.3 70079.6 70917.6 60875.4 61040.0 61314.0 61656.4 64297.7 55255.7 56088.4 56512.7 56667.0 58551.4 9377.6 9453.3 9474.4 9568.1 9636.3 38326.6 38565.4 38736.0 38880.4 39882.2 50476.2 50846.2 50905.0 51094.0 51318.7 11679.4 11906.2 11908.4 12010.6 12176.3 12318.0 13091.4 13491.0 13559.8 13667.0 12383.4 12715.5 12725.0 12876.2 12894.0 11586.4 11775.9 12274.9 12386.3 12444.4 12471.8 12628.3 12671.7 12950.8 13225.1 10316.0 10343.2 10363.3 10558.2 10576.5 9992.3 10331.4 10427.5 10480.2 10566.4 08:34:56 INFO - PROCESS | 9287 | -------- Summary: end -------- 08:34:56 INFO - PROCESS | 9287 | 08:34:57 INFO - TEST-INFO | 9287: exit 0 08:34:57 INFO - TEST-OK | dromaeo_css | took 1110487ms 08:34:57 INFO - TEST-START | kraken 08:34:57 INFO - operating with platform_type : linux_ 08:34:57 INFO - Initialising browser for kraken test... 08:34:57 INFO - TEST-INFO | started process 9529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV02jiW/profile http://localhost:35552/getInfo.html) 08:35:01 INFO - PROCESS | 9529 | 08:35:01 INFO - PROCESS | 9529 | (process:9596): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:35:01 INFO - PROCESS | 9529 | __metrics Screen width/height:1600/1200 08:35:01 INFO - PROCESS | 9529 | colorDepth:24 08:35:01 INFO - PROCESS | 9529 | Browser inner width/height: 1024/697 08:35:01 INFO - PROCESS | 9529 | __metrics 08:35:02 ERROR - PROCESS | 9529 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:35:03 INFO - TEST-INFO | 9529: exit 0 08:35:03 INFO - Browser initialized. 08:35:03 INFO - Running cycle 1/1 for kraken test... 08:35:03 INFO - TEST-INFO | started process 9647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV02jiW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:05 INFO - PROCESS | 9647 | 08:35:05 INFO - PROCESS | 9647 | (process:9711): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:35:15 INFO - PROCESS | 9647 | RSS: Main: 163323904 08:35:15 INFO - PROCESS | 9647 | 08:35:17 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35552/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:18 INFO - PROCESS | 9647 | RSS: Main: 167960576 08:35:18 INFO - PROCESS | 9647 | 08:35:21 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35552/tests/kraken/driver.html?testName=audio-dft) 08:35:22 INFO - PROCESS | 9647 | RSS: Main: 168108032 08:35:22 INFO - PROCESS | 9647 | 08:35:25 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35552/tests/kraken/driver.html?testName=audio-fft) 08:35:25 INFO - PROCESS | 9647 | RSS: Main: 162512896 08:35:25 INFO - PROCESS | 9647 | 08:35:27 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35552/tests/kraken/driver.html?testName=audio-oscillator) 08:35:28 INFO - PROCESS | 9647 | RSS: Main: 162861056 08:35:28 INFO - PROCESS | 9647 | 08:35:30 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:31 INFO - PROCESS | 9647 | RSS: Main: 163938304 08:35:31 INFO - PROCESS | 9647 | 08:35:34 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35552/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:35 INFO - PROCESS | 9647 | RSS: Main: 163561472 08:35:35 INFO - PROCESS | 9647 | 08:35:38 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35552/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:39 INFO - PROCESS | 9647 | RSS: Main: 162283520 08:35:39 INFO - PROCESS | 9647 | 08:35:42 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35552/tests/kraken/driver.html?testName=json-parse-financial) 08:35:43 INFO - PROCESS | 9647 | RSS: Main: 162750464 08:35:43 INFO - PROCESS | 9647 | 08:35:44 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:45 INFO - PROCESS | 9647 | RSS: Main: 162926592 08:35:45 INFO - PROCESS | 9647 | 08:35:47 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:47 INFO - PROCESS | 9647 | RSS: Main: 163110912 08:35:47 INFO - PROCESS | 9647 | 08:35:49 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:50 INFO - PROCESS | 9647 | RSS: Main: 163299328 08:35:50 INFO - PROCESS | 9647 | 08:35:53 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:53 INFO - PROCESS | 9647 | RSS: Main: 163135488 08:35:53 INFO - PROCESS | 9647 | 08:35:56 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:57 INFO - PROCESS | 9647 | RSS: Main: 163979264 08:35:57 INFO - PROCESS | 9647 | 08:35:58 INFO - PROCESS | 9647 | Cycle 1(1): loaded http://localhost:35552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35552/tests/kraken/driver.html?testName=ai-astar) 08:35:59 INFO - PROCESS | 9647 | RSS: Main: 164802560 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | __start_tp_report 08:35:59 INFO - PROCESS | 9647 | _x_x_mozilla_page_load 08:35:59 INFO - PROCESS | 9647 | _x_x_mozilla_page_load_details 08:35:59 INFO - PROCESS | 9647 | |i|pagename|runs| 08:35:59 INFO - PROCESS | 9647 | |0;ai-astar;107;110;103;111;112;111;106;112;114;111 08:35:59 INFO - PROCESS | 9647 | |1;audio-beat-detection;148;123;151;212;124;156;152;124;191;127 08:35:59 INFO - PROCESS | 9647 | |2;audio-dft;165;164;163;163;164;166;168;164;164;161 08:35:59 INFO - PROCESS | 9647 | |3;audio-fft;74;75;73;157;77;75;74;75;157;76 08:35:59 INFO - PROCESS | 9647 | |4;audio-oscillator;91;92;175;92;92;93;147;90;92;153 08:35:59 INFO - PROCESS | 9647 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;117;118;118 08:35:59 INFO - PROCESS | 9647 | |6;imaging-darkroom;150;150;148;150;150;149;149;150;150;150 08:35:59 INFO - PROCESS | 9647 | |7;imaging-desaturate;95;95;96;96;95;100;99;99;100;100 08:35:59 INFO - PROCESS | 9647 | |8;json-parse-financial;55;55;55;62;55;58;53;60;55;55 08:35:59 INFO - PROCESS | 9647 | |9;json-stringify-tinderbox;58;60;59;60;59;58;60;59;60;59 08:35:59 INFO - PROCESS | 9647 | |10;stanford-crypto-aes;79;78;79;77;77;78;78;78;159;80 08:35:59 INFO - PROCESS | 9647 | |11;stanford-crypto-ccm;147;125;131;126;121;124;135;130;142;126 08:35:59 INFO - PROCESS | 9647 | |12;stanford-crypto-pbkdf2;160;165;165;158;159;157;163;159;157;159 08:35:59 INFO - PROCESS | 9647 | |13;stanford-crypto-sha256-iterative;63;66;62;65;61;64;62;61;63;61 08:35:59 INFO - PROCESS | 9647 | __end_tp_report 08:35:59 INFO - PROCESS | 9647 | __start_cc_report 08:35:59 INFO - PROCESS | 9647 | _x_x_mozilla_cycle_collect,868 08:35:59 INFO - PROCESS | 9647 | __end_cc_report 08:35:59 INFO - PROCESS | 9647 | __startTimestamp1463412959138__endTimestamp 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | ------- Summary: start ------- 08:35:59 INFO - PROCESS | 9647 | Number of tests: 14 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.33 (3.0%) stddev-sans-first:3.39 08:35:59 INFO - PROCESS | 9647 | Values: 107.0 110.0 103.0 111.0 112.0 111.0 106.0 112.0 114.0 111.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:151.50 stddev:30.14 (19.9%) stddev-sans-first:31.95 08:35:59 INFO - PROCESS | 9647 | Values: 148.0 123.0 151.0 212.0 124.0 156.0 152.0 124.0 191.0 127.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:1.87 (1.1%) stddev-sans-first:1.96 08:35:59 INFO - PROCESS | 9647 | Values: 165.0 164.0 163.0 163.0 164.0 166.0 168.0 164.0 164.0 161.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#3] audio-fft Cycles:10 Average:91.30 Median:75.00 stddev:34.64 (46.2%) stddev-sans-first:36.18 08:35:59 INFO - PROCESS | 9647 | Values: 74.0 75.0 73.0 157.0 77.0 75.0 74.0 75.0 157.0 76.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:92.00 stddev:32.93 (35.8%) stddev-sans-first:34.07 08:35:59 INFO - PROCESS | 9647 | Values: 91.0 92.0 175.0 92.0 92.0 93.0 147.0 90.0 92.0 153.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:35:59 INFO - PROCESS | 9647 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:35:59 INFO - PROCESS | 9647 | Values: 150.0 150.0 148.0 150.0 150.0 149.0 149.0 150.0 150.0 150.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:95.50 stddev:2.27 (2.4%) stddev-sans-first:2.22 08:35:59 INFO - PROCESS | 9647 | Values: 95.0 95.0 96.0 96.0 95.0 100.0 99.0 99.0 100.0 100.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:2.79 (5.1%) stddev-sans-first:2.92 08:35:59 INFO - PROCESS | 9647 | Values: 55.0 55.0 55.0 62.0 55.0 58.0 53.0 60.0 55.0 55.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 08:35:59 INFO - PROCESS | 9647 | Values: 58.0 60.0 59.0 60.0 59.0 58.0 60.0 59.0 60.0 59.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:78.00 stddev:25.56 (32.8%) stddev-sans-first:26.97 08:35:59 INFO - PROCESS | 9647 | Values: 79.0 78.0 79.0 77.0 77.0 78.0 78.0 78.0 159.0 80.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:130.50 stddev:8.35 (6.4%) stddev-sans-first:6.45 08:35:59 INFO - PROCESS | 9647 | Values: 147.0 125.0 131.0 126.0 121.0 124.0 135.0 130.0 142.0 126.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:159.50 stddev:3.05 (1.9%) stddev-sans-first:3.23 08:35:59 INFO - PROCESS | 9647 | Values: 160.0 165.0 165.0 158.0 159.0 157.0 163.0 159.0 157.0 159.0 08:35:59 INFO - PROCESS | 9647 | 08:35:59 INFO - PROCESS | 9647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.86 08:35:59 INFO - PROCESS | 9647 | Values: 63.0 66.0 62.0 65.0 61.0 64.0 62.0 61.0 63.0 61.0 08:35:59 INFO - PROCESS | 9647 | -------- Summary: end -------- 08:35:59 INFO - PROCESS | 9647 | 08:36:00 INFO - TEST-INFO | 9647: exit 0 08:36:00 INFO - TEST-OK | kraken | took 62855ms 08:36:00 INFO - SUITE-END | took 1173s 08:36:00 INFO - Completed test suite (00:19:33) 08:36:00 INFO - javascript benchmark 08:36:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7282.401391734115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3195.1213416310516, 3216.903492895214, 3233.5634689316935, 3266.705996460318, 3272.8690852365908, 5428.457154284574, 5445.319335083114, 5454.563634909203, 5527.143292789624, 5528.778848846051, 5323.387810401805, 5441.782328706847, 5458.91811622825, 5492.340919089715, 5532.6680399175975, 4944.480829512903, 4977.950220497803, 5095.439501654815, 5137.5633071188995, 5185.585153187755, 862.5969241516515, 4985.52637499437, 5030.723310217936, 5056.342675452204, 5057.0897238497055, 5008.198688209887, 5029.069622119883, 5045.268436076785, 5048.6465947383695, 5096.057229412552, 4946.505349465061, 5062.594992400599, 5078.187490001582, 5083.720395378253, 5092.261622064817, 4932.457429682732, 5000.599952003831, 5002.1246281900885, 5002.89994200114, 5037.068142393632, 5395.10980688186, 5410.621256512046, 5417.133258678632, 5433.429489903582, 5481.205225242357, 5765.625234359795, 5837.182794408786, 5874.1776151338845, 5893.911591326134, 5915.349311575723, 5927.407259274081, 5971.70141492928, 5973.790917317917, 5990.880182396371, 6016.96991515044, 5511.22842802008, 5519.613627046108, 5526.088195447746, 5544.140658197985, 5547.916781248285, 5848.625572990344, 5939.940600594025, 5973.910391344133, 6003.879922401527, 6060.818175454743, 5726.0838265877255, 5750.396208398141, 5759.308882934075, 5764.942350576524, 5771.913421298684, 5810.331811841608, 5811.593188476851, 5836.358000619928, 5837.3870743571315, 5845.941540584625, 5652.858678532987, 5816.941830581724, 5836.9124463133085, 5860.70696465175, 5878.882422351529, 5703.800366987219, 5721.5136713379825, 5725.026745453283, 5736.627119237236, 5838.299404071538, 4447.043885564619, 4450.109978004412, 4457.130859482435, 4464.665150113689, 4512.842050528216, 3925.0972276376024, 3958.5249770027203, 3976.840926362971, 4000.0599859033105, 4003.459532963013, 5625.015622266169, 5665.065264231355, 5669.291338582677, 5672.602917795714, 5686.488216060575, 5796.913046304308, 5933.910991335133, 5960.791372301948, 5963.463288304073, 5972.193753843262, 5549.056660367747, 5586.329640443173, 5588.832335029955, 5608.775648974077, 5614.943850561442, 4888.437829649564, 4895.412550493892, 4911.557959783637, 4946.332245146931, 4958.281049247911, 5927.407259274038, 6095.2685677718955, 6097.725602347905, 6109.419605137505, 6115.510759139258, 5908.054711246266, 6005.789797357072, 6006.279246490274, 6015.187949626745, 6030.5778595497895, 6178.351273116438, 6191.380861913953, 6192.628442293477, 6201.782937597162, 6204.0, 5629.380768115422, 5761.251037365116, 5799.2750906136735, 5881.411858814085, 5886.293644762656, 5896.0, 5932.0, 5948.226730525004, 5965.9105113422465, 6019.277686677451, 5745.2818397700285, 5783.0, 5789.8552536186935, 5790.01569733138, 5804.593678442468, 5595.748191331481, 5643.576731745217, 5707.8858422832145, 5715.514181294637, 5796.391378905323, 5476.644018138808, 5616.859578510406, 5636.098224284095, 5647.971760141173, 5662.915056274077, 5796.217510636179, 5805.158252053344, 5810.0, 5839.970800145972, 5852.092925596539, 5526.088195447867, 5605.159226116115, 5618.129189975561, 5693.373728889902, 5748.0], "value": 5393.125600567774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.2439812433519, 642.1267076775586, 652.7421668440963, 661.2164584966814, 677.062268757771, 40195.0, 44209.33685994713, 44238.0, 44257.0, 44436.0, 44371.11257774843, 44651.77674111633, 44806.32790508145, 44892.0, 44959.32561011588, 8874.467531948088, 8949.686760963368, 8960.23837973773, 8985.95507022464, 9017.54912254388, 8905.643774249022, 9008.909910900906, 9038.86441703375, 9051.14014168653, 9054.592543335566, 9106.63573457061, 9121.17909388155, 9145.085491450869, 9146.954265228664, 9150.130737579919, 9037.141471560224, 9043.547822608876, 9047.592858321392, 9054.139856713635, 9104.81790364189, 8949.328800340001, 9019.774505637411, 9021.458712477206, 9028.322875784343, 9033.367664263504, 41294.38058429126, 41451.58548414507, 41476.58523414758, 41789.58210417918, 41792.79103604493, 3619.040954147153, 3758.49260349852, 3774.01875512366, 4096.32410652242, 4123.422720819088, 33114.834425827954, 33839.661603383895, 33855.32289354224, 33985.6601433985, 34133.82933085319, 4390.209762242795, 4406.581374769392, 4491.483479399845, 4525.162844873676, 4538.841140560097, 371075.0, 372186.0, 372444.0, 373081.0, 374429.0, 60985.0, 61347.0, 61501.07748383778, 61734.38265617376, 61772.38227617756, 37249.627503725154, 38372.61627383746, 64741.35258647447, 64757.0, 64983.35016649773, 17533.0, 17603.911980440014, 17722.91138544299, 17786.0, 17852.732209016875, 12142.271463712206, 12164.270143791224, 12177.025837932944, 12188.573399931138, 12262.01903847708, 20037.899810500854, 20478.283260085824, 20624.07191676348, 20652.896735516228, 20739.688904666444, 7388.743913534712, 7716.305532502101, 7723.9613801931755, 7758.262965018314, 7818.0, 1068.604616291977, 1123.7920984617872, 1172.3141961952183, 1178.0, 1187.922785018971, 32908.50637240443, 32991.0, 33371.49942750861, 33668.98993030213, 33952.320953581286, 1136.1024790415645, 1197.0483465644834, 1222.2727477151082, 1256.1207154991544, 1287.2340957130493, 17470.0, 17491.38780142689, 17522.386716465116, 17543.473695789147, 17656.55858603545, 575282.0, 579574.0, 585817.0, 586184.0, 587552.0, 58592.0, 59643.403565964654, 59658.0, 59993.70003149956, 60139.39860601338, 1412.3856122586708, 1413.2721648350903, 1413.5476647472915, 1449.2753623188617, 1452.5424491285212, 30941.535876962313, 32052.67947320497, 32904.50643240305, 33621.66378336185, 33638.0, 54837.725811370685, 56943.0, 58284.54288642648, 58327.708361457924, 63864.0, 412510.0, 414003.0, 414206.0, 414552.0, 417050.0, 43281.0, 43410.13179736325, 43516.56483435125, 43795.0, 43830.34254486249, 48525.51474485351, 48621.756891215315, 48917.510824891295, 49216.50783492119, 49651.0, 39870.0, 40954.79522602368, 40997.0, 41486.377704335064, 41941.790291048346, 39308.0, 39313.41029884497, 39936.2012759749, 40428.1914361717, 40927.59072409357, 41543.58456415518, 45765.542344576126, 45874.77062614666, 46628.300575492074, 46717.53282467132, 37092.258154836214, 37285.25429491449, 37348.0, 37897.81051094727, 37921.4311785329, 29152.125436236947, 29312.0, 29821.85089074541, 29883.70116298896, 29988.850055749583], "value": 21059.613212915032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.30405334584464, 395.2529718831409, 403.1493548612427, 405.06834281153374, 417.478152309613, 13868.37592308346, 17801.732974005383, 18960.525986850334, 19537.99999999998, 19544.21823127075, 18529.722054169197, 18823.247070117213, 19302.420927372164, 19435.902820485877, 19525.804741952576, 5265.684058956455, 5545.223668686387, 5567.526760225385, 5671.404502527237, 5861.384554621746, 5213.426523082458, 5527.281453411051, 5614.2701448811595, 5628.099504079348, 5669.518090962273, 5581.162825576176, 5590.049691552425, 5599.356074051475, 5600.747966341504, 5636.0, 5998.0, 6206.7827626033095, 6377.968110159466, 6387.233531976192, 6394.904076438811, 5503.559715222773, 5605.327360716699, 5641.71791410432, 5658.773649054033, 5665.631733937281, 13187.07690461668, 13282.601521954357, 17362.739558906625, 22270.88864555683, 22590.0, 2246.135237933391, 2281.908723651052, 2394.964075538868, 2395.5208958208254, 2571.7942564594787, 9860.668770091122, 10079.596816127347, 10154.9492252539, 12399.814002789966, 14085.436582536686, 1963.185278109583, 1999.530110424049, 2043.559290700053, 2051.138521820824, 2069.4826293426645, 82365.58817205936, 83524.58237708773, 83658.58170709168, 83844.58077709633, 84473.57763211206, 9352.298577606707, 9969.80060398788, 10542.156627469938, 10675.306105103144, 10843.722818208107, 14988.325525351385, 15048.548543543711, 15101.697966040618, 15143.621409464851, 15167.317470713844, 8081.878771818428, 8202.58987050657, 8245.340372770284, 8338.082810890797, 8360.613951349713, 8048.315893149148, 8112.310453611509, 8156.918430815735, 8181.304589109992, 8217.506949583045, 4499.595036446735, 4625.8843528911375, 4655.2784318430695, 4689.20283551797, 4735.0, 1959.4709428454237, 1962.3328068456792, 1975.7629084509952, 1994.5412555112405, 1997.7902320256164, 948.2698322291797, 1017.8524114003576, 1045.1690905729963, 1107.180686292138, 1123.4720779739548, 18444.446666600023, 18698.532536686693, 18877.339293124674, 19107.522311942314, 19149.90425047866, 1034.1416624201895, 1039.6205385034407, 1047.9109275711498, 1052.547404616007, 1063.7659714862873, 10189.796204075878, 10525.736856578647, 10750.301230419998, 10772.569097236023, 10778.137748980063, 506453.5482516262, 518451.0, 519183.0, 522553.0, 526247.0, 77464.61267693738, 87524.5623771877, 94531.52734236285, 94931.0, 95686.0, 1014.6905193915779, 1025.7692019295748, 1037.5382954585136, 1045.2892033417197, 1070.261519551507, 16551.0, 16790.24443900003, 16876.324947001984, 16979.320827166775, 17184.828151718324, 38788.6121138785, 39743.801280994565, 39880.40179397253, 41036.38445423261, 41835.0, 55560.0, 57784.42215577958, 58285.708571456875, 58339.4166058334, 58555.0, 5901.852453688693, 7972.880406793786, 8284.585770711561, 8436.789080273042, 8440.704575339834, 11344.319340839576, 12380.504779808707, 12644.620661380173, 12856.357182140668, 12864.871351286742, 11203.103751700008, 11212.49543770516, 11287.363332316603, 11393.487293071998, 11580.710482238012, 10952.507137179005, 11050.226484146033, 11090.445477726244, 11104.888951110386, 11634.6509604712, 11514.82727759101, 11526.308421494738, 11528.077753779846, 11542.0, 11610.535578576762, 7113.608751518716, 7498.737544185928, 7714.035745531809, 8391.874121888055, 8394.496330220207, 8246.793830154294, 10938.45307734626, 11300.547978081113, 11327.32036077838, 11337.342440112256], "value": 9089.538910832958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.6132636177772, 1565.3269094289456, 1713.6487020160869, 1848.898310592917, 1864.8321651051403, 7978.281954624083, 8579.871301930469, 8702.477851328924, 9085.318601104918, 9092.363534552576, 8701.390902636818, 8954.059823718497, 8998.100189981014, 9012.369134160595, 9098.408603440788, 2317.8261630377747, 2350.1304517328613, 2358.41039740065, 2360.114956891166, 2363.2555744940373, 2258.54829034193, 2286.4969706664506, 2296.1045192374986, 2297.977020229793, 2304.665823455606, 2276.738175109867, 2286.965695514569, 2310.0875154314035, 2375.3111597636666, 2386.3556839653284, 2291.9770802292014, 2296.4832912594698, 2298.494331247123, 2298.54029194161, 2300.827437942161, 2289.828262880291, 2297.058206135493, 2305.3660243433023, 2319.8028167605776, 2322.431004403915, 8965.462072275684, 8968.327375446803, 8984.191422771983, 9036.277097832224, 9051.728448146567, 5180.456052114511, 5290.285811415487, 5298.867528311785, 5301.363836339626, 5305.628605997582, 3222.2943614842884, 3397.13373089863, 3411.1472131967007, 3458.4120699480895, 3484.390231709466, 1100.1693721240413, 1124.578283143821, 1135.5741596901162, 1150.551284998851, 1156.7686462707409, 12123.151379403445, 12257.632271031884, 12266.386680665932, 12279.815802762965, 12304.446299916615, 4559.224931761609, 4590.977045114753, 4658.697184682985, 4689.601383882408, 4710.0579884022645, 9979.501024948724, 10003.599856005678, 10026.799464010679, 10031.347962382422, 10042.69871903844, 5361.517463428232, 5422.322209723785, 5433.239346491494, 5484.2047903053835, 5485.122380419193, 4356.6950313477755, 4713.835015774432, 4810.278458231293, 4858.125537403231, 5027.321311622884, 3866.980665096713, 3870.6903447724117, 3948.6643635290748, 3952.940705889414, 3986.5415477219913, 1158.09089864456, 1174.236746115032, 1177.652592485219, 1184.029096141156, 1187.8396416483663, 911.3165126155384, 1044.984325235122, 1049.275999560301, 1055.2560444886337, 1061.6337363609543, 6218.19163508741, 6237.812865614039, 6268.09112678659, 6290.779822706275, 6447.2907980122145, 433.6465780388973, 453.9251023581072, 471.0625854549422, 472.1030042918482, 472.3057106054095, 4348.826046958086, 4368.4321038264825, 4374.212641724456, 4389.100234451929, 4444.466664000276, 10758.623448179276, 11218.382988935524, 11262.267952583055, 11271.54913803455, 11303.830442543369, 11218.66344009681, 11227.157963152797, 11252.606158784403, 11273.323600583828, 11274.887251127548, 8354.373421993374, 8447.493150410995, 8504.022037465647, 8512.106228846005, 8516.829663406697, 5968.6717230551, 6005.159277701038, 6096.908546371719, 6106.938930610637, 6150.846228844314, 10547.419891905713, 10547.472626368497, 10634.149268058381, 10729.409882456539, 10746.73133171677, 10294.3823370598, 10400.167986560906, 10481.528331224961, 10531.631392901212, 10742.462876855969, 6996.685149168198, 7190.89213661785, 7379.778606641809, 7609.695612175451, 7704.499207551491, 8763.737087887373, 8770.25452836516, 8841.381103322705, 8853.557322133996, 8865.202131808168, 7581.128170260491, 7633.0, 7746.457747957589, 7827.334676552329, 8118.878216826871, 7559.395248380227, 7712.498687585289, 7760.728374506865, 7771.611419428893, 7904.762857114296, 6957.373836354753, 6975.651217439209, 7045.295470452914, 7070.858582828418, 7078.964605176941, 5144.0997825381155, 5199.4020687619895, 5233.921491177712, 5308.203769434461, 5318.97340513295, 5334.866628334323, 5416.350037995466, 5485.588580856532, 5530.585206109638, 5597.020521408818], "value": 4614.4906851402575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.849874808214, 331.51267636574227, 334.12792611284544, 334.4765442083141, 337.3657523855153, 5483.232347471358, 5528.55771538277, 5672.829815105543, 5732.684702341365, 5742.827715168546, 5512.228288039668, 5559.861003474915, 5578.553715702744, 5584.1902924075985, 5595.38450770415, 4291.163223171483, 4310.676699247553, 4365.380771537084, 4405.273129933557, 4423.845165419211, 4137.3173426384765, 4305.3541968704785, 4339.175556644243, 4345.804438800245, 4352.651787856964, 4258.0, 4263.829446822139, 4290.678199135062, 4307.633851122659, 4309.676774241929, 4243.108947121108, 4284.900398804594, 4303.612674859278, 4324.20002299574, 4325.610695037446, 3550.751447398683, 3780.6030366811365, 3803.505544279226, 3808.828602712857, 3818.3890577507464, 5273.604479664041, 5294.41761406245, 5321.600879934021, 5342.652727572734, 5347.41178470368, 4878.853634390974, 4902.338184345139, 4910.558049775502, 4913.6314776391555, 4919.975400123012, 5550.805721799758, 5791.189233507313, 5797.623154494944, 5802.810423863098, 5819.359870414251, 4076.7757773322455, 4101.5488296287385, 4109.609587089221, 4124.4019617155645, 4128.380742888591, 6051.576389652726, 6052.878942421171, 6059.484943779784, 6061.848453788691, 6120.877582448371, 4008.0, 4210.200061988213, 4214.852480163179, 4229.534751177368, 4263.59495847894, 4274.914501710011, 4287.592678695519, 4302.709187243814, 4323.546027667113, 4326.6754993375625, 4973.0, 4976.975115124401, 4987.875303117378, 4999.325091112653, 5012.0, 5652.802151924663, 5882.882342353215, 5956.493698035629, 5967.1347654589845, 5971.671558064261, 1468.955931322062, 1472.5655931500232, 1481.6962522682825, 1484.450753221315, 1487.2415068315022, 920.5905417845823, 937.0769791755116, 937.9343445958717, 943.3255222515934, 947.2232769129386, 5030.245463180552, 5031.195008798574, 5053.418856831438, 5068.949310506848, 5114.621700909021, 5317.41508434072, 5330.680159190461, 5343.251944727741, 5374.946250537445, 5390.811321603725, 5068.847934561969, 5075.436904363273, 5084.644074914794, 5324.866878327995, 5791.710414479259, 3201.3917355702342, 3210.0369889033664, 3242.5136229565755, 3274.9029075259577, 3278.60656721195, 6039.191130062263, 6310.643211709505, 6344.206974128234, 6354.936450635527, 6375.3624637536805, 6161.938380616226, 6210.72051757672, 6216.098665693449, 6222.62664240147, 6241.188645476059, 6187.47314030998, 6240.438360547572, 6270.592411493239, 6272.937270627235, 6288.937110628926, 5774.0, 6068.605540640021, 6111.908321375094, 6124.173236613178, 6128.601640893327, 5972.283326000907, 5983.521318294439, 6020.578559500793, 6048.185544336769, 6059.182010428536, 5992.580519363777, 6231.937680623317, 6234.501239900706, 6299.338569450325, 6364.459020983083, 4212.810423530887, 4234.851780187679, 4245.320748680197, 4247.129338485542, 4251.213525497793, 6050.0, 6094.299155597163, 6096.451319381277, 6105.572609917263, 6132.693365331805, 5731.0, 5798.6810725410505, 5821.301443826768, 5888.528917686489, 5907.645541267538, 5863.1791549184, 5888.440598143169, 5900.734466948912, 5924.377940316377, 5946.851328716817, 5603.915941260802, 5788.855278618068, 5810.564207684356, 5835.403245555687, 5846.532277417881, 5879.147523608967, 5908.231929849092, 5931.9110213345975, 5933.940660593512, 5944.435278648694, 5731.570132240182, 5759.94240057594, 5794.681292528951, 5812.883742325045, 5815.185873977562], "value": 4416.018495280519, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.9474184178026, 822.4530687093084, 866.8786369908214, 874.3573473496982, 886.2998231397197, 14577.92711036446, 14634.926825365885, 14733.631659208526, 14767.187804670766, 15089.094654320736, 12233.694157646041, 14364.497242596512, 14403.207823569699, 14475.420983160688, 14491.637709057253, 830.2693629605953, 849.3247867944998, 850.0606829453458, 851.706161374328, 851.8637018077109, 841.6170642357744, 848.503625379154, 850.4642075492432, 852.5694524265238, 853.2022558907411, 897.5108565831605, 910.0990019880337, 910.1444642036464, 911.4075850697034, 911.6444586611227, 910.2717825739383, 910.7996240827008, 910.968116115936, 911.4258017449031, 912.5300470257789, 651.2347991110473, 653.9117219175446, 654.035297935546, 655.1483072006421, 656.5633853487425, 14749.188794616291, 14867.107973521515, 14886.10683359002, 14921.925390372979, 14944.626384340478, 15103.47137850181, 15265.236738163047, 15322.310496027594, 15398.230088495531, 15402.537923862303, 11720.129085511737, 11904.702382440422, 11933.701657458547, 11945.522179112824, 12101.455434505468, 3702.148505843644, 3720.694184611717, 3739.196072844324, 3795.1081495848453, 3800.809959502014, 57414.71292643552, 58450.70774646142, 61031.69484152551, 61222.387776122116, 61296.0, 11346.716332091764, 11581.0, 11721.644466958642, 11855.0, 11859.110566707532, 20416.979151042684, 20550.897245513977, 20665.070071846803, 20748.273810416562, 20908.79091209099, 8607.870881936777, 8852.114788521096, 8927.196552310323, 8954.507502087448, 8963.462192268486, 4984.327115839388, 5031.094403007421, 5099.490050994871, 5103.311053007871, 5257.605679574047, 3393.474011528217, 3482.89551313461, 3508.8947331580093, 3511.438169892805, 3516.613172551017, 633.8732253549308, 642.2549842183046, 643.6556442303439, 654.649762377126, 667.562746401108, 655.8753836770999, 781.9100803407567, 786.1509569664748, 800.3317230112921, 804.4248362420781, 9841.655542055994, 10245.48772561369, 10285.177185825116, 10301.484925753832, 10473.109785668152, 640.9551331406757, 682.2529330383222, 685.3146853146853, 687.9920915858191, 760.5702777930452, 4756.381670382828, 4899.681520701143, 4926.605871530269, 4932.457429682732, 4977.576905962961, 66979.66510167418, 67250.66374668095, 69833.30166698268, 70079.64960175166, 70917.64541177261, 60875.39124608786, 61040.0, 61314.0, 61656.38343616596, 64297.67851160714, 55255.72372138194, 56088.43911560914, 56512.717436413375, 56667.0, 58551.41448585545, 9377.578008989476, 9453.320606299925, 9474.38416502925, 9568.09103135201, 9636.277279203947, 38326.61673383342, 38565.4215186778, 38736.03159920912, 38880.41679374755, 39882.20235595214, 50476.242856356446, 50846.23730644117, 50905.0, 51094.0, 51318.74340628273, 11679.416029198335, 11906.166568340479, 11908.40457977115, 12010.579629712918, 12176.269423834598, 12318.0, 13091.410886509939, 13491.0, 13559.79660305116, 13667.0, 12383.380830958236, 12715.491380344683, 12725.0, 12876.163049401759, 12894.03294752916, 11586.36275004849, 11775.941120294343, 12274.938625306817, 12386.256824590553, 12444.440000199831, 12471.750564988468, 12628.305443200712, 12671.746565068463, 12950.805737914126, 13225.074244802772, 10316.0, 10343.224258180517, 10363.32638378503, 10558.208134389797, 10576.4711764413, 9992.250581206294, 10331.380117192992, 10427.478626068818, 10480.161587072864, 10566.415037744093], "value": 7089.496960727163, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 103.0, 111.0, 112.0, 111.0, 106.0, 112.0, 114.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 151.0, 212.0, 124.0, 156.0, 152.0, 124.0, 191.0, 127.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 163.0, 164.0, 166.0, 168.0, 164.0, 164.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 157.0, 77.0, 75.0, 74.0, 75.0, 157.0, 76.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 175.0, 92.0, 92.0, 93.0, 147.0, 90.0, 92.0, 153.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 100.0, 99.0, 99.0, 100.0, 100.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 62.0, 55.0, 58.0, 53.0, 60.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 60.0, 59.0, 58.0, 60.0, 59.0, 60.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 77.0, 77.0, 78.0, 78.0, 78.0, 159.0, 80.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 125.0, 131.0, 126.0, 121.0, 124.0, 135.0, 130.0, 142.0, 126.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 165.0, 158.0, 159.0, 157.0, 163.0, 159.0, 157.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 62.0, 65.0, 61.0, 64.0, 62.0, 61.0, 63.0, 61.0], "value": 62.8, "unit": "score"}]}]} 08:36:00 INFO - Return code: 0 08:36:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:36:00 ERROR - # TBPL SUCCESS # 08:36:00 INFO - Running post-action listener: _resource_record_post_action 08:36:00 INFO - ##### 08:36:00 INFO - ##### Finished run-tests step (success) 08:36:00 INFO - ##### 08:36:00 INFO - Running post-run listener: _resource_record_post_run 08:36:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 556142592; Read time: 0; Write time: 615468 08:36:00 INFO - TinderboxPrint: CPU usage
13.4% 08:36:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:36:00 INFO - TinderboxPrint: I/O write bytes / time
556,142,592 / 615,468 08:36:00 INFO - TinderboxPrint: CPU idle
8,225.7 (86.6%) 08:36:00 INFO - TinderboxPrint: CPU user
1,218.5 (12.8%) 08:36:00 INFO - TinderboxPrint: Swap in / out
0 / 0 08:36:00 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256270336; Read time: 0; Write time: 346804 08:36:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295981056; Read time: 0; Write time: 267976 08:36:01 INFO - Running post-run listener: _upload_blobber_files 08:36:01 INFO - Blob upload gear active. 08:36:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:01 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 08:36:01 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:36:01 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:36:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:02 INFO - (blobuploader) - INFO - Done attempting. 08:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:06 INFO - (blobuploader) - INFO - Done attempting. 08:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:07 INFO - (blobuploader) - INFO - Done attempting. 08:36:07 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:07 INFO - Return code: 0 08:36:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/934ee2cc18456ed4cbfe55144ba143eaf1c5301253815d7c60a7ad5b4764302b4052dc713205f6a61242e476112013153293ff77c69844926589f60a34ad50dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c8130b380ed4ca0a0a9888ec7cf4dd5bfb8db1d67c23afb63e5bc91a9d03925cc0f7cce1d8d4e916b407aa9af2537bfb07d280df48f95ed6a2d0e75963aef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41438685e1ddbee70c3f0b4ce9d2288dbe12b4f3d1c0a72c7dc005eb817780ff69b2ec65a130af756b5e4a025ba26009c289bd462f22bfb4a323b587efc8b293"} 08:36:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:07 INFO - Contents: 08:36:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/934ee2cc18456ed4cbfe55144ba143eaf1c5301253815d7c60a7ad5b4764302b4052dc713205f6a61242e476112013153293ff77c69844926589f60a34ad50dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c8130b380ed4ca0a0a9888ec7cf4dd5bfb8db1d67c23afb63e5bc91a9d03925cc0f7cce1d8d4e916b407aa9af2537bfb07d280df48f95ed6a2d0e75963aef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41438685e1ddbee70c3f0b4ce9d2288dbe12b4f3d1c0a72c7dc005eb817780ff69b2ec65a130af756b5e4a025ba26009c289bd462f22bfb4a323b587efc8b293"} 08:36:07 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:07 INFO - Copying logs to upload dir... 08:36:07 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.448704 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-16 08:36:05.988513) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 08:36:05.991900) ========= 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=d2a8c569965ab8367867b893000001a1-1463410897.859006-300278106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/934ee2cc18456ed4cbfe55144ba143eaf1c5301253815d7c60a7ad5b4764302b4052dc713205f6a61242e476112013153293ff77c69844926589f60a34ad50dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c8130b380ed4ca0a0a9888ec7cf4dd5bfb8db1d67c23afb63e5bc91a9d03925cc0f7cce1d8d4e916b407aa9af2537bfb07d280df48f95ed6a2d0e75963aef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41438685e1ddbee70c3f0b4ce9d2288dbe12b4f3d1c0a72c7dc005eb817780ff69b2ec65a130af756b5e4a025ba26009c289bd462f22bfb4a323b587efc8b293"} build_url:https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/934ee2cc18456ed4cbfe55144ba143eaf1c5301253815d7c60a7ad5b4764302b4052dc713205f6a61242e476112013153293ff77c69844926589f60a34ad50dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c8130b380ed4ca0a0a9888ec7cf4dd5bfb8db1d67c23afb63e5bc91a9d03925cc0f7cce1d8d4e916b407aa9af2537bfb07d280df48f95ed6a2d0e75963aef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41438685e1ddbee70c3f0b4ce9d2288dbe12b4f3d1c0a72c7dc005eb817780ff69b2ec65a130af756b5e4a025ba26009c289bd462f22bfb4a323b587efc8b293"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 08:36:06.016453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:36:06.016772) ========= 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=d2a8c569965ab8367867b893000001a1-1463410897.859006-300278106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:36:06.100403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 08:36:06.100720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 08:36:06.101001) ========= ========= Total master_lag: 0.16 =========