builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1464237077.87 results: success (0) buildid: 20160525204851 builduid: 5d679e607a424656ad6003a26e637ab7 revision: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:17.874220) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:17.874822) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:17.875102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:17.931914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:17.932200) ========= 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=eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 21:31:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-25 21:31:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.094725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.095004) ========= 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=eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022835 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.146357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.146695) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 25566a14a7ac98674bfe9b6e73edc59fcc286c22 --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 25566a14a7ac98674bfe9b6e73edc59fcc286c22 --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=eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 21:31:18,347 truncating revision to first 12 chars 2016-05-25 21:31:18,347 Setting DEBUG logging. 2016-05-25 21:31:18,347 attempt 1/10 2016-05-25 21:31:18,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/25566a14a7ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 21:31:18,735 unpacking tar archive at: fx-team-25566a14a7ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.889230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.889585) ========= script_repo_revision: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.889987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.890252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 21:31:18.899013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-25 21:31:18.899359) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:31:19 INFO - MultiFileLogger online at 20160525 21:31:19 in /builds/slave/test 21:31:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:31:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:31:19 INFO - {'append_to_log': False, 21:31:19 INFO - 'base_work_dir': '/builds/slave/test', 21:31:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:31:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:31:19 INFO - 'branch': 'Fx-Team-Non-PGO', 21:31:19 INFO - 'buildbot_json_path': 'buildprops.json', 21:31:19 INFO - 'config_files': ('talos/linux_config.py',), 21:31:19 INFO - 'default_actions': ('clobber', 21:31:19 INFO - 'read-buildbot-config', 21:31:19 INFO - 'download-and-extract', 21:31:19 INFO - 'populate-webroot', 21:31:19 INFO - 'create-virtualenv', 21:31:19 INFO - 'install', 21:31:19 INFO - 'run-tests'), 21:31:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:31:19 INFO - 'download_minidump_stackwalk': True, 21:31:19 INFO - 'download_symbols': 'ondemand', 21:31:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:31:19 INFO - 'tooltool.py': '/tools/tooltool.py', 21:31:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:31:19 INFO - '/tools/misc-python/virtualenv.py')}, 21:31:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:31:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:31:19 INFO - 'installer_path': 'installer.exe', 21:31:19 INFO - 'log_level': 'info', 21:31:19 INFO - 'log_name': 'talos', 21:31:19 INFO - 'log_to_console': True, 21:31:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:31:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:31:19 INFO - 'opt_config_files': (), 21:31:19 INFO - 'pip_index': False, 21:31:19 INFO - 'sps_profile': False, 21:31:19 INFO - 'sps_profile_interval': 0, 21:31:19 INFO - 'suite': 'dromaeojs', 21:31:19 INFO - 'system_bits': '32', 21:31:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:31:19 INFO - 'title': 'talos-linux64-ix-010', 21:31:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:31:19 INFO - 'use_talos_json': True, 21:31:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:31:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:31:19 INFO - 'work_dir': 'build'} 21:31:19 INFO - ##### 21:31:19 INFO - ##### Running clobber step. 21:31:19 INFO - ##### 21:31:19 INFO - Running pre-action listener: _resource_record_pre_action 21:31:19 INFO - Running main action method: clobber 21:31:19 INFO - rmtree: /builds/slave/test/build 21:31:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:31:19 INFO - Running post-action listener: _resource_record_post_action 21:31:19 INFO - ##### 21:31:19 INFO - ##### Finished clobber step (success) 21:31:19 INFO - ##### 21:31:19 INFO - ##### 21:31:19 INFO - ##### Running read-buildbot-config step. 21:31:19 INFO - ##### 21:31:19 INFO - Running pre-action listener: _resource_record_pre_action 21:31:19 INFO - Running main action method: read_buildbot_config 21:31:19 INFO - Using buildbot properties: 21:31:19 INFO - { 21:31:19 INFO - "project": "", 21:31:19 INFO - "product": "firefox", 21:31:19 INFO - "script_repo_revision": "production", 21:31:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:31:19 INFO - "repository": "", 21:31:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:31:19 INFO - "buildid": "20160525204851", 21:31:19 INFO - "pgo_build": "False", 21:31:19 INFO - "basedir": "/builds/slave/test", 21:31:19 INFO - "buildnumber": 1785, 21:31:19 INFO - "slavename": "talos-linux64-ix-010", 21:31:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:31:19 INFO - "platform": "ubuntu64_hw", 21:31:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:31:19 INFO - "branch": "fx-team", 21:31:19 INFO - "repo_path": "integration/fx-team", 21:31:19 INFO - "revision": "25566a14a7ac98674bfe9b6e73edc59fcc286c22", 21:31:19 INFO - "stage_platform": "linux64", 21:31:19 INFO - "builduid": "5d679e607a424656ad6003a26e637ab7", 21:31:19 INFO - "slavebuilddir": "test" 21:31:19 INFO - } 21:31:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:31:19 INFO - Running post-action listener: _resource_record_post_action 21:31:19 INFO - ##### 21:31:19 INFO - ##### Finished read-buildbot-config step (success) 21:31:19 INFO - ##### 21:31:19 INFO - ##### 21:31:19 INFO - ##### Running download-and-extract step. 21:31:19 INFO - ##### 21:31:19 INFO - Running pre-action listener: _resource_record_pre_action 21:31:19 INFO - Running main action method: download_and_extract 21:31:19 INFO - mkdir: /builds/slave/test/build/tests 21:31:19 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')]} 21:31:19 INFO - https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:26 INFO - Downloaded 1361 bytes. 21:31:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:31:26 INFO - Using the following test package requirements: 21:31:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:31:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:31:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:31:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'jsshell-linux-x86_64.zip'], 21:31:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:31:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:31:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:31:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:31:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:31:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:31:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:31:26 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')]} 21:31:26 INFO - https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:27 INFO - Downloaded 22835896 bytes. 21:31:27 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'] 21:31:27 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 21:31:29 INFO - Return code: 0 21:31:29 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 21:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:29 INFO - https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:30 INFO - Downloaded 22835896 bytes. 21:31:30 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'] 21:31:30 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 21:31:32 INFO - Return code: 0 21:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:32 INFO - https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:33 INFO - Downloaded 10834034 bytes. 21:31:33 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'] 21:31:33 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 21:31:33 INFO - Return code: 0 21:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:33 INFO - https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/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 21:31:34 INFO - Downloaded 54821943 bytes. 21:31:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:31:34 INFO - mkdir: /builds/slave/test/properties 21:31:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:31:34 INFO - Writing to file /builds/slave/test/properties/build_url 21:31:34 INFO - Contents: 21:31:34 INFO - build_url:https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:31:35 INFO - Running post-action listener: _resource_record_post_action 21:31:35 INFO - Running post-action listener: set_extra_try_arguments 21:31:35 INFO - ##### 21:31:35 INFO - ##### Finished download-and-extract step (success) 21:31:35 INFO - ##### 21:31:35 INFO - ##### 21:31:35 INFO - ##### Running populate-webroot step. 21:31:35 INFO - ##### 21:31:35 INFO - Running pre-action listener: _resource_record_pre_action 21:31:35 INFO - Running main action method: populate_webroot 21:31:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:31:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:31:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:31:35 INFO - '--tppagecycles', 21:31:35 INFO - '7'], 21:31:35 INFO - 'tests': ['tsvgm']}}, 21:31:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:31:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:31:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:31:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:31:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:31:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:31:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['damp', 'tps']}, 21:31:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'tests': ['damp', 'tps']}, 21:31:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['dromaeo_dom']}, 21:31:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:31:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['a11yr', 21:31:35 INFO - 'ts_paint', 21:31:35 INFO - 'tpaint', 21:31:35 INFO - 'sessionrestore', 21:31:35 INFO - 'sessionrestore_no_auto_restore', 21:31:35 INFO - 'tabpaint']}, 21:31:35 INFO - 'other-e10s': {'tests': ['a11yr', 21:31:35 INFO - 'ts_paint', 21:31:35 INFO - 'tpaint', 21:31:35 INFO - 'sessionrestore', 21:31:35 INFO - 'sessionrestore_no_auto_restore', 21:31:35 INFO - 'tabpaint']}, 21:31:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:31:35 INFO - 'ts_paint', 21:31:35 INFO - 'tpaint', 21:31:35 INFO - 'sessionrestore', 21:31:35 INFO - 'sessionrestore_no_auto_restore', 21:31:35 INFO - 'tabpaint']}, 21:31:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:31:35 INFO - 'ts_paint', 21:31:35 INFO - 'tpaint', 21:31:35 INFO - 'sessionrestore', 21:31:35 INFO - 'sessionrestore_no_auto_restore', 21:31:35 INFO - 'tabpaint']}, 21:31:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['a11yr', 21:31:35 INFO - 'ts_paint', 21:31:35 INFO - 'tpaint', 21:31:35 INFO - 'sessionrestore', 21:31:35 INFO - 'sessionrestore_no_auto_restore', 21:31:35 INFO - 'tabpaint']}, 21:31:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['a11yr', 21:31:35 INFO - 'ts_paint', 21:31:35 INFO - 'tpaint', 21:31:35 INFO - 'sessionrestore', 21:31:35 INFO - 'sessionrestore_no_auto_restore', 21:31:35 INFO - 'tabpaint']}, 21:31:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['tsvgx', 21:31:35 INFO - 'tsvgr_opacity', 21:31:35 INFO - 'tart', 21:31:35 INFO - 'tscrollx', 21:31:35 INFO - 'cart']}, 21:31:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:31:35 INFO - 'tsvgr_opacity', 21:31:35 INFO - 'tart', 21:31:35 INFO - 'tscrollx', 21:31:35 INFO - 'cart']}, 21:31:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'talos_options': ['--disable-e10s'], 21:31:35 INFO - 'tests': ['tp5o']}, 21:31:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'tests': ['tp5o']}, 21:31:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'talos_options': ['--disable-e10s', 21:31:35 INFO - '--xperf_path', 21:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:31:35 INFO - 'tests': ['tp5n']}, 21:31:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:35 INFO - 'talos_options': ['--xperf_path', 21:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:31:35 INFO - 'tests': ['tp5n']}}, 21:31:35 INFO - 'talos.zip': {'path': '', 21:31:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:31:35 INFO - Running post-action listener: _resource_record_post_action 21:31:35 INFO - ##### 21:31:35 INFO - ##### Finished populate-webroot step (success) 21:31:35 INFO - ##### 21:31:35 INFO - ##### 21:31:35 INFO - ##### Running create-virtualenv step. 21:31:35 INFO - ##### 21:31:35 INFO - Running pre-action listener: _resource_record_pre_action 21:31:35 INFO - Running main action method: create_virtualenv 21:31:35 INFO - Creating virtualenv /builds/slave/test/build/venv 21:31:35 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 21:31:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:31:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:31:35 INFO - Using real prefix '/usr' 21:31:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:31:36 INFO - Installing distribute.............................................................................................................................................................................................done. 21:31:38 INFO - Installing pip.................done. 21:31:38 INFO - Return code: 0 21:31:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:31: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')]} 21:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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')]} 21:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:38 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:38 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 21:31:38 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 21:31:38 INFO - Using env: {'DISPLAY': ':0', 21:31:38 INFO - 'HOME': '/home/cltbld', 21:31:38 INFO - 'LANG': 'en_US.UTF-8', 21:31:38 INFO - 'LANGUAGE': 'en_US:en', 21:31:38 INFO - 'LOGNAME': 'cltbld', 21:31:38 INFO - 'MAIL': '/var/mail/cltbld', 21:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:38 INFO - 'MOZ_NO_REMOTE': '1', 21:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:38 INFO - 'NO_EM_RESTART': '1', 21:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:38 INFO - 'PWD': '/builds/slave/test', 21:31:38 INFO - 'SHELL': '/bin/bash', 21:31:38 INFO - 'SHLVL': '1', 21:31:38 INFO - 'TERM': 'linux', 21:31:38 INFO - 'TMOUT': '86400', 21:31:38 INFO - 'USER': 'cltbld', 21:31:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:38 INFO - '_': '/tools/buildbot/bin/python'} 21:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:38 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 21:31:38 INFO - Cleaning up... 21:31:38 INFO - Return code: 0 21:31:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:31: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')]} 21:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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')]} 21:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:38 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:38 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 21:31:38 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 21:31:38 INFO - Using env: {'DISPLAY': ':0', 21:31:38 INFO - 'HOME': '/home/cltbld', 21:31:38 INFO - 'LANG': 'en_US.UTF-8', 21:31:38 INFO - 'LANGUAGE': 'en_US:en', 21:31:38 INFO - 'LOGNAME': 'cltbld', 21:31:38 INFO - 'MAIL': '/var/mail/cltbld', 21:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:38 INFO - 'MOZ_NO_REMOTE': '1', 21:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:38 INFO - 'NO_EM_RESTART': '1', 21:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:38 INFO - 'PWD': '/builds/slave/test', 21:31:38 INFO - 'SHELL': '/bin/bash', 21:31:38 INFO - 'SHLVL': '1', 21:31:38 INFO - 'TERM': 'linux', 21:31:38 INFO - 'TMOUT': '86400', 21:31:38 INFO - 'USER': 'cltbld', 21:31:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:38 INFO - '_': '/tools/buildbot/bin/python'} 21:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:38 INFO - Downloading/unpacking psutil>=3.1.1 21:31:38 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 21:31:38 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 21:31:38 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 21:31:38 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 21:31:38 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 21:31:38 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 21:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:31:40 INFO - Installing collected packages: psutil 21:31:40 INFO - Running setup.py install for psutil 21:31:40 INFO - building 'psutil._psutil_linux' extension 21:31:40 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 21:31:40 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 21:31:40 INFO - building 'psutil._psutil_posix' extension 21:31:40 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 21:31:41 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 21:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:31:41 INFO - Successfully installed psutil 21:31:41 INFO - Cleaning up... 21:31:41 INFO - Return code: 0 21:31:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:31: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')]} 21:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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')]} 21:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:41 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:41 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 21:31:41 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 21:31:41 INFO - Using env: {'DISPLAY': ':0', 21:31:41 INFO - 'HOME': '/home/cltbld', 21:31:41 INFO - 'LANG': 'en_US.UTF-8', 21:31:41 INFO - 'LANGUAGE': 'en_US:en', 21:31:41 INFO - 'LOGNAME': 'cltbld', 21:31:41 INFO - 'MAIL': '/var/mail/cltbld', 21:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:41 INFO - 'MOZ_NO_REMOTE': '1', 21:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:41 INFO - 'NO_EM_RESTART': '1', 21:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:41 INFO - 'PWD': '/builds/slave/test', 21:31:41 INFO - 'SHELL': '/bin/bash', 21:31:41 INFO - 'SHLVL': '1', 21:31:41 INFO - 'TERM': 'linux', 21:31:41 INFO - 'TMOUT': '86400', 21:31:41 INFO - 'USER': 'cltbld', 21:31:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:41 INFO - '_': '/tools/buildbot/bin/python'} 21:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:31:41 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 21:31:41 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 21:31:41 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 21:31:41 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 21:31:41 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 21:31:41 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 21:31:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:31:43 INFO - Installing collected packages: mozsystemmonitor 21:31:43 INFO - Running setup.py install for mozsystemmonitor 21:31:43 INFO - Successfully installed mozsystemmonitor 21:31:43 INFO - Cleaning up... 21:31:43 INFO - Return code: 0 21:31:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:31:43 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')]} 21:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:43 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')]} 21:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:43 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:43 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 21:31:43 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 21:31:43 INFO - Using env: {'DISPLAY': ':0', 21:31:43 INFO - 'HOME': '/home/cltbld', 21:31:43 INFO - 'LANG': 'en_US.UTF-8', 21:31:43 INFO - 'LANGUAGE': 'en_US:en', 21:31:43 INFO - 'LOGNAME': 'cltbld', 21:31:43 INFO - 'MAIL': '/var/mail/cltbld', 21:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:43 INFO - 'MOZ_NO_REMOTE': '1', 21:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:43 INFO - 'NO_EM_RESTART': '1', 21:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:43 INFO - 'PWD': '/builds/slave/test', 21:31:43 INFO - 'SHELL': '/bin/bash', 21:31:43 INFO - 'SHLVL': '1', 21:31:43 INFO - 'TERM': 'linux', 21:31:43 INFO - 'TMOUT': '86400', 21:31:43 INFO - 'USER': 'cltbld', 21:31:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:43 INFO - '_': '/tools/buildbot/bin/python'} 21:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:43 INFO - Downloading/unpacking blobuploader==1.2.4 21:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:45 INFO - Downloading blobuploader-1.2.4.tar.gz 21:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:31:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:31:45 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 21:31:45 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 21:31:45 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 21:31:45 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 21:31:45 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 21:31:45 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 21:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:31:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:46 INFO - Downloading docopt-0.6.1.tar.gz 21:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:31:46 INFO - Installing collected packages: blobuploader, requests, docopt 21:31:46 INFO - Running setup.py install for blobuploader 21:31:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:31:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:31:46 INFO - Running setup.py install for requests 21:31:47 INFO - Running setup.py install for docopt 21:31:47 INFO - Successfully installed blobuploader requests docopt 21:31:47 INFO - Cleaning up... 21:31:47 INFO - Return code: 0 21:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31: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')]} 21:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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')]} 21:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:47 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:47 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 21:31:47 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 21:31:47 INFO - Using env: {'DISPLAY': ':0', 21:31:47 INFO - 'HOME': '/home/cltbld', 21:31:47 INFO - 'LANG': 'en_US.UTF-8', 21:31:47 INFO - 'LANGUAGE': 'en_US:en', 21:31:47 INFO - 'LOGNAME': 'cltbld', 21:31:47 INFO - 'MAIL': '/var/mail/cltbld', 21:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:47 INFO - 'MOZ_NO_REMOTE': '1', 21:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:47 INFO - 'NO_EM_RESTART': '1', 21:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:47 INFO - 'PWD': '/builds/slave/test', 21:31:47 INFO - 'SHELL': '/bin/bash', 21:31:47 INFO - 'SHLVL': '1', 21:31:47 INFO - 'TERM': 'linux', 21:31:47 INFO - 'TMOUT': '86400', 21:31:47 INFO - 'USER': 'cltbld', 21:31:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:47 INFO - '_': '/tools/buildbot/bin/python'} 21:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:31:47 INFO - Running setup.py (path:/tmp/pip-FZpvhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:31:47 INFO - Running setup.py (path:/tmp/pip-53bR_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:31:47 INFO - Running setup.py (path:/tmp/pip-r0ne87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:31:47 INFO - Running setup.py (path:/tmp/pip-3IATNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:31:47 INFO - Running setup.py (path:/tmp/pip-EnK9HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:31:47 INFO - Running setup.py (path:/tmp/pip-7vDPYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:31:47 INFO - Running setup.py (path:/tmp/pip-2wegqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:31:47 INFO - Running setup.py (path:/tmp/pip-D3mRsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:31:47 INFO - Running setup.py (path:/tmp/pip-9iQE_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:31:48 INFO - Running setup.py (path:/tmp/pip-dDAaIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:31:48 INFO - Running setup.py (path:/tmp/pip-eJV5SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:31:48 INFO - Running setup.py (path:/tmp/pip-AeXAXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:31:48 INFO - Running setup.py (path:/tmp/pip-xf2Wlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:31:48 INFO - Running setup.py (path:/tmp/pip-DxFy_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:48 INFO - Running setup.py (path:/tmp/pip-MxthvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:31:48 INFO - Running setup.py (path:/tmp/pip-Vppjf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:31:48 INFO - Running setup.py (path:/tmp/pip-nEfFxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:31:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:31:48 INFO - Running setup.py install for manifestparser 21:31:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:31:48 INFO - Running setup.py install for mozcrash 21:31:48 INFO - Running setup.py install for mozdebug 21:31:48 INFO - Running setup.py install for mozdevice 21:31:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Running setup.py install for mozfile 21:31:49 INFO - Running setup.py install for mozhttpd 21:31:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Running setup.py install for mozinfo 21:31:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Running setup.py install for mozInstall 21:31:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Running setup.py install for mozleak 21:31:49 INFO - Running setup.py install for mozlog 21:31:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Running setup.py install for moznetwork 21:31:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Running setup.py install for mozprocess 21:31:49 INFO - Running setup.py install for mozprofile 21:31:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:31:49 INFO - Running setup.py install for mozrunner 21:31:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:31:50 INFO - Running setup.py install for mozscreenshot 21:31:50 INFO - Running setup.py install for moztest 21:31:50 INFO - Running setup.py install for mozversion 21:31:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:31:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:31:50 INFO - Cleaning up... 21:31:50 INFO - Return code: 0 21:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31: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')]} 21:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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')]} 21:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:50 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:50 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 21:31:50 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 21:31:50 INFO - Using env: {'DISPLAY': ':0', 21:31:50 INFO - 'HOME': '/home/cltbld', 21:31:50 INFO - 'LANG': 'en_US.UTF-8', 21:31:50 INFO - 'LANGUAGE': 'en_US:en', 21:31:50 INFO - 'LOGNAME': 'cltbld', 21:31:50 INFO - 'MAIL': '/var/mail/cltbld', 21:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:50 INFO - 'MOZ_NO_REMOTE': '1', 21:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:50 INFO - 'NO_EM_RESTART': '1', 21:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:50 INFO - 'PWD': '/builds/slave/test', 21:31:50 INFO - 'SHELL': '/bin/bash', 21:31:50 INFO - 'SHLVL': '1', 21:31:50 INFO - 'TERM': 'linux', 21:31:50 INFO - 'TMOUT': '86400', 21:31:50 INFO - 'USER': 'cltbld', 21:31:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:50 INFO - '_': '/tools/buildbot/bin/python'} 21:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:31:50 INFO - Running setup.py (path:/tmp/pip-i2moDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:31:50 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)) 21:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:31:50 INFO - Running setup.py (path:/tmp/pip-4cSKlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:31:50 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)) 21:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:31:50 INFO - Running setup.py (path:/tmp/pip-yiAejn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:31:50 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)) 21:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:31:50 INFO - Running setup.py (path:/tmp/pip-e6rMMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:31:50 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)) 21:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:31:50 INFO - Running setup.py (path:/tmp/pip-V9_jOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:31:51 INFO - Running setup.py (path:/tmp/pip-KGCi9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:31:51 INFO - Running setup.py (path:/tmp/pip-MYdpEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:31:51 INFO - Running setup.py (path:/tmp/pip-9vizYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:31:51 INFO - Running setup.py (path:/tmp/pip-y80ybe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:31:51 INFO - Running setup.py (path:/tmp/pip-p4z_e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:31:51 INFO - Running setup.py (path:/tmp/pip-as9JRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:31:51 INFO - Running setup.py (path:/tmp/pip-hY_bAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:31:51 INFO - Running setup.py (path:/tmp/pip-NODJtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:31:51 INFO - Running setup.py (path:/tmp/pip-ikJ0gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:51 INFO - Running setup.py (path:/tmp/pip-_OcVgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:31:51 INFO - Running setup.py (path:/tmp/pip-SYa6aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:31:51 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)) 21:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:31:51 INFO - Running setup.py (path:/tmp/pip-8tROBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:31:51 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)) 21:31:51 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)) 21:31:51 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)) 21:31:51 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)) 21:31:51 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)) 21:31:51 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)) 21:31:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:31:51 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 21:31:51 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 21:31:51 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 21:31:51 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 21:31:51 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 21:31:51 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 21:31:53 INFO - Downloading blessings-1.6.tar.gz 21:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:31:53 INFO - Installing collected packages: blessings 21:31:53 INFO - Running setup.py install for blessings 21:31:54 INFO - Successfully installed blessings 21:31:54 INFO - Cleaning up... 21:31:54 INFO - Return code: 0 21:31:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:31:54 INFO - Reading from file tmpfile_stdout 21:31:54 INFO - Current package versions: 21:31:54 INFO - argparse == 1.2.1 21:31:54 INFO - blessings == 1.6 21:31:54 INFO - blobuploader == 1.2.4 21:31:54 INFO - docopt == 0.6.1 21:31:54 INFO - manifestparser == 1.1 21:31:54 INFO - mozInstall == 1.12 21:31:54 INFO - mozcrash == 0.17 21:31:54 INFO - mozdebug == 0.1 21:31:54 INFO - mozdevice == 0.48 21:31:54 INFO - mozfile == 1.2 21:31:54 INFO - mozhttpd == 0.7 21:31:54 INFO - mozinfo == 0.9 21:31:54 INFO - mozleak == 0.1 21:31:54 INFO - mozlog == 3.2 21:31:54 INFO - moznetwork == 0.27 21:31:54 INFO - mozprocess == 0.22 21:31:54 INFO - mozprofile == 0.28 21:31:54 INFO - mozrunner == 6.11 21:31:54 INFO - mozscreenshot == 0.1 21:31:54 INFO - mozsystemmonitor == 0.3 21:31:54 INFO - moztest == 0.7 21:31:54 INFO - mozversion == 1.4 21:31:54 INFO - psutil == 3.1.1 21:31:54 INFO - requests == 1.2.3 21:31:54 INFO - wsgiref == 0.1.2 21:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31:54 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')]} 21:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:54 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')]} 21:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:54 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:54 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 21:31:54 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 21:31:54 INFO - Using env: {'DISPLAY': ':0', 21:31:54 INFO - 'HOME': '/home/cltbld', 21:31:54 INFO - 'LANG': 'en_US.UTF-8', 21:31:54 INFO - 'LANGUAGE': 'en_US:en', 21:31:54 INFO - 'LOGNAME': 'cltbld', 21:31:54 INFO - 'MAIL': '/var/mail/cltbld', 21:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:54 INFO - 'MOZ_NO_REMOTE': '1', 21:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:54 INFO - 'NO_EM_RESTART': '1', 21:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:54 INFO - 'PWD': '/builds/slave/test', 21:31:54 INFO - 'SHELL': '/bin/bash', 21:31:54 INFO - 'SHLVL': '1', 21:31:54 INFO - 'TERM': 'linux', 21:31:54 INFO - 'TMOUT': '86400', 21:31:54 INFO - 'USER': 'cltbld', 21:31:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:54 INFO - '_': '/tools/buildbot/bin/python'} 21:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 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)) 21:31:54 INFO - Cleaning up... 21:31:54 INFO - Return code: 0 21:31:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:31:54 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')]} 21:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:54 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')]} 21:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:54 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:54 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 21:31:54 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 21:31:54 INFO - Using env: {'DISPLAY': ':0', 21:31:54 INFO - 'HOME': '/home/cltbld', 21:31:54 INFO - 'LANG': 'en_US.UTF-8', 21:31:54 INFO - 'LANGUAGE': 'en_US:en', 21:31:54 INFO - 'LOGNAME': 'cltbld', 21:31:54 INFO - 'MAIL': '/var/mail/cltbld', 21:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:54 INFO - 'MOZ_NO_REMOTE': '1', 21:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:54 INFO - 'NO_EM_RESTART': '1', 21:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:54 INFO - 'PWD': '/builds/slave/test', 21:31:54 INFO - 'SHELL': '/bin/bash', 21:31:54 INFO - 'SHLVL': '1', 21:31:54 INFO - 'TERM': 'linux', 21:31:54 INFO - 'TMOUT': '86400', 21:31:54 INFO - 'USER': 'cltbld', 21:31:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:54 INFO - '_': '/tools/buildbot/bin/python'} 21:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:54 INFO - Downloading/unpacking jsonschema 21:31: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 21:31: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 21:31: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 21:31: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 21:31: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 21:31: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 21:31:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:31:56 INFO - Downloading/unpacking functools32 (from jsonschema) 21:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:31:56 INFO - warning: no files found matching '*.txt' 21:31:56 INFO - no previously-included directories found matching 'build' 21:31:56 INFO - no previously-included directories found matching 'dist' 21:31:56 INFO - no previously-included directories found matching '.git*' 21:31:56 INFO - Installing collected packages: jsonschema, functools32 21:31:56 INFO - Running setup.py install for functools32 21:31:57 INFO - warning: no files found matching '*.txt' 21:31:57 INFO - no previously-included directories found matching 'build' 21:31:57 INFO - no previously-included directories found matching 'dist' 21:31:57 INFO - no previously-included directories found matching '.git*' 21:31:57 INFO - Successfully installed jsonschema functools32 21:31:57 INFO - Cleaning up... 21:31:57 INFO - Return code: 0 21:31:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:31:57 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')]} 21:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:57 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')]} 21:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:57 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 0x7f1ec7500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', '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 21:31:57 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 21:31:57 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 21:31:57 INFO - Using env: {'DISPLAY': ':0', 21:31:57 INFO - 'HOME': '/home/cltbld', 21:31:57 INFO - 'LANG': 'en_US.UTF-8', 21:31:57 INFO - 'LANGUAGE': 'en_US:en', 21:31:57 INFO - 'LOGNAME': 'cltbld', 21:31:57 INFO - 'MAIL': '/var/mail/cltbld', 21:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:57 INFO - 'MOZ_NO_REMOTE': '1', 21:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:57 INFO - 'NO_EM_RESTART': '1', 21:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:57 INFO - 'PWD': '/builds/slave/test', 21:31:57 INFO - 'SHELL': '/bin/bash', 21:31:57 INFO - 'SHLVL': '1', 21:31:57 INFO - 'TERM': 'linux', 21:31:57 INFO - 'TMOUT': '86400', 21:31:57 INFO - 'USER': 'cltbld', 21:31:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:57 INFO - '_': '/tools/buildbot/bin/python'} 21:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:57 INFO - Downloading/unpacking flake8 21:31:57 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 21:31:57 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 21:31:57 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 21:31:57 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 21:31:57 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 21:31:57 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 21:31:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:31:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:31:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 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 21:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:31:59 INFO - no previously-included directories found matching 'docs/_build' 21:31:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:31:59 INFO - Running setup.py install for pep8 21:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:32:00 INFO - no previously-included directories found matching 'docs/_build' 21:32:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:32:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:32:00 INFO - Cleaning up... 21:32:00 INFO - Return code: 0 21:32:00 INFO - Running post-action listener: _resource_record_post_action 21:32:00 INFO - Running post-action listener: _start_resource_monitoring 21:32:00 INFO - Starting resource monitoring. 21:32:00 INFO - ##### 21:32:00 INFO - ##### Finished create-virtualenv step (success) 21:32:00 INFO - ##### 21:32:00 INFO - ##### 21:32:00 INFO - ##### Running install step. 21:32:00 INFO - ##### 21:32:00 INFO - Running pre-action listener: _resource_record_pre_action 21:32:00 INFO - Running main action method: install 21:32:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:32:00 INFO - Reading from file tmpfile_stdout 21:32:00 INFO - Detecting whether we're running mozinstall >=1.0... 21:32:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:32:00 INFO - Reading from file tmpfile_stdout 21:32:00 INFO - Output received: 21:32:00 INFO - Usage: mozinstall [options] installer 21:32:00 INFO - Options: 21:32:00 INFO - -h, --help show this help message and exit 21:32:00 INFO - -d DEST, --destination=DEST 21:32:00 INFO - Directory to install application into. [default: 21:32:00 INFO - "/builds/slave/test"] 21:32:00 INFO - --app=APP Application being installed. [default: firefox] 21:32:00 INFO - mkdir: /builds/slave/test/build/application 21:32:00 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'] 21:32:00 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 21:32:16 INFO - Reading from file tmpfile_stdout 21:32:16 INFO - Output received: 21:32:16 INFO - /builds/slave/test/build/application/firefox/firefox 21:32:16 INFO - Running post-action listener: _resource_record_post_action 21:32:16 INFO - ##### 21:32:16 INFO - ##### Finished install step (success) 21:32:16 INFO - ##### 21:32:16 INFO - ##### 21:32:16 INFO - ##### Running run-tests step. 21:32:16 INFO - ##### 21:32:16 INFO - Running pre-action listener: _resource_record_pre_action 21:32:16 INFO - Running main action method: run_tests 21:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:32:16 INFO - Python 2.7.3 21:32:16 INFO - Return code: 0 21:32:16 INFO - grabbing minidump binary from tooltool 21:32:16 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')]} 21:32:16 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 0x1dbe9c0>, '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 0x1dbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:32:16 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 21:32:16 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 21:32:16 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 21:32:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:32:16 INFO - Return code: 0 21:32:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:32:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:32:17 INFO - Return code: 0 21:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:32:17 INFO - Using env: {'DISPLAY': ':0', 21:32:17 INFO - 'HOME': '/home/cltbld', 21:32:17 INFO - 'LANG': 'en_US.UTF-8', 21:32:17 INFO - 'LANGUAGE': 'en_US:en', 21:32:17 INFO - 'LOGNAME': 'cltbld', 21:32:17 INFO - 'MAIL': '/var/mail/cltbld', 21:32:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:32:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:17 INFO - 'MOZ_NO_REMOTE': '1', 21:32:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:17 INFO - 'NO_EM_RESTART': '1', 21:32:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:17 INFO - 'PWD': '/builds/slave/test', 21:32:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:32:17 INFO - 'SHELL': '/bin/bash', 21:32:17 INFO - 'SHLVL': '1', 21:32:17 INFO - 'TERM': 'linux', 21:32:17 INFO - 'TMOUT': '86400', 21:32:17 INFO - 'USER': 'cltbld', 21:32:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442', 21:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:17 INFO - '_': '/tools/buildbot/bin/python'} 21:32:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:32:17 INFO - mozversion application_buildid: 20160525204851 21:32:17 INFO - mozversion application_changeset: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 21:32:17 INFO - mozversion application_display_name: Nightly 21:32:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:32:17 INFO - mozversion application_name: Firefox 21:32:17 INFO - mozversion application_remotingname: firefox 21:32:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:32:17 INFO - mozversion application_vendor: Mozilla 21:32:17 INFO - mozversion application_version: 49.0a1 21:32:17 INFO - mozversion platform_buildid: 20160525204851 21:32:17 INFO - mozversion platform_changeset: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 21:32:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:32:17 INFO - mozversion platform_version: 49.0a1 21:32:17 INFO - using testdate: 1464237137 21:32:17 INFO - actual date: 1464237137 21:32:17 INFO - starting webserver on 'localhost:33481' 21:32:17 INFO - SUITE-START | Running 2 tests 21:32:17 INFO - TEST-START | dromaeo_css 21:32:17 INFO - operating with platform_type : linux_ 21:32:17 INFO - Initialising browser for dromaeo_css test... 21:32:17 INFO - TEST-INFO | started process 32356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPumT5/profile http://localhost:33481/getInfo.html) 21:32:22 INFO - PROCESS | 32356 | __metrics Screen width/height:1600/1200 21:32:22 INFO - PROCESS | 32356 | colorDepth:24 21:32:22 INFO - PROCESS | 32356 | Browser inner width/height: 1024/697 21:32:22 INFO - PROCESS | 32356 | __metrics 21:32:23 ERROR - PROCESS | 32356 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:32:24 INFO - TEST-INFO | 32356: exit 0 21:32:24 INFO - Browser initialized. 21:32:24 INFO - Running cycle 1/1 for dromaeo_css test... 21:32:24 INFO - TEST-INFO | started process 32435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPumT5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:32:36 INFO - PROCESS | 32435 | RSS: Main: 157024256 21:32:36 INFO - PROCESS | 32435 | 21:33:27 INFO - PROCESS | 32435 | 1464237207915 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] 21:35:39 INFO - PROCESS | 32435 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33481/tests/dromaeo/cssquery-ext.html) 21:35:40 INFO - PROCESS | 32435 | RSS: Main: 244015104 21:35:40 INFO - PROCESS | 32435 | 21:38:43 INFO - PROCESS | 32435 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-ext.html (next: http://localhost:33481/tests/dromaeo/cssquery-jquery.html) 21:38:43 INFO - PROCESS | 32435 | RSS: Main: 233959424 21:38:43 INFO - PROCESS | 32435 | 21:41:46 INFO - PROCESS | 32435 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33481/tests/dromaeo/cssquery-mootools.html) 21:41:46 INFO - PROCESS | 32435 | RSS: Main: 231694336 21:41:46 INFO - PROCESS | 32435 | 21:44:48 INFO - PROCESS | 32435 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33481/tests/dromaeo/cssquery-prototype.html) 21:44:49 INFO - PROCESS | 32435 | RSS: Main: 238788608 21:44:49 INFO - PROCESS | 32435 | 21:47:52 INFO - PROCESS | 32435 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33481/tests/dromaeo/cssquery-yui.html) 21:47:53 INFO - PROCESS | 32435 | RSS: Main: 221745152 21:47:53 INFO - PROCESS | 32435 | 21:50:55 INFO - PROCESS | 32435 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-yui.html (next: http://localhost:33481/tests/dromaeo/cssquery-dojo.html) 21:50:56 INFO - PROCESS | 32435 | RSS: Main: 265043968 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | __start_tp_report 21:50:56 INFO - PROCESS | 32435 | _x_x_mozilla_page_load 21:50:56 INFO - PROCESS | 32435 | _x_x_mozilla_page_load_details 21:50:56 INFO - PROCESS | 32435 | |i|pagename|runs| 21:50:56 INFO - PROCESS | 32435 | |0;dojo.html;2675.558532842081;2693.973060269399;2719.279390961395;2725.8228215166014;2726.33204864808;4568.954310456895;4652.418447694038;4659.534046595347;4678.578927896493;4732.0535892821445;4614.1233165698495;4615.192341340269;4619.2609182530805;4643.094596553673;4647.86056418308;4202.810873510692;4252.0858015526655;4286.164197981379;4317.956820431787;4454.354118652794;4389.802458889358;4415.492218394894;4418.734875907439;4450.2434586120435;4476.328550717386;4233.089885674594;4261.701680882339;4278.657707383401;4280.914381712349;4351.586599273064;4308.547602501723;4352.36890650857;4354.346847972798;4356.302991521341;4359.17175736609;4316.503602085769;4333.133373325348;4350.825966961318;4356.390105385217;4370.322599997005;4475.1049790042125;4587.9541204588195;4709.246520556729;4723.031778485402;4726.480087190406;5025.924611130836;5104.336436263262;5109.386873575195;5111.3355263815465;5112.744362781846;5107.106256405152;5138.023775482647;5143.691378517301;5150.613703972217;5155.252488389163;4609.95390046102;4655.906881862344;4669.486356500782;4788.4253889533475;4803.087413391444;5145.3568303962;5147.794088236428;5152.587792976553;5189.221616757516;5195.48045195485;4999.975000125049;5003.024410240041;5003.249512573143;5004.824831130893;5012.373453318335;4833.613310935117;5005.549500544968;5044.369453818273;5056.544910958031;5093.286939828427;4977.477364876709;4980.103581355318;5009;5017.67385119966;5065.670731402447;4967.602591792648;4999.0501804657;5003.499650034967;5004.599632029429;5060.746962651852;4194.664426845845;4232.809523571385;4235.639970602471;4283.7001409901;4284.592963668447;3791.6208379162413;3801.733878628525;3806.333891568964;3807.048237940515;3807.5430948286385;4255.4255175551525;4298.2263192625005;4332.458442694663;4341.522432532419;4389.604935555752;5085.110105731482;5087.64386492942;5092.083424983464;5093.923591146136;5135.820246291437;4333.111712099012;4341.978290108593;4343.153085148366;4346.739195648272;4382.276924307517;4441.178381999341;4562.520935301812;4607.285870690049;4619.3071039343695;4637.072585482917;4806.49531799163;4808.567228949411;4811.855644330676;4816;4855.757212139379;5099.6175286852895;5101.38783345986;5135.717535535432;5159.613029022763;5199;4635.235186194375;4738.881527961828;4789.760511974457;4797.4482934462985;4814.711117332971;5040.218766091261;5050.9747451263975;5073.568746656576;5084.720340381315;5110.054639891632;4912.214045752662;5107.10625640504;5110.259012443249;5111.87220319495;5118.976204758988;4823.589994850337;4865.1242776300605;4879.926801097916;4889.828855990166;4901.9019619608125;4884.072026314989;4894.657373983787;4898.583620392306;4906.55840974314;4947.703137811743;4719.079779442975;4787.54518320759;4848.3697119375665;4901.803927842846;4903.436104847988;4924.089043526959;4924.778384972757;4937.9259311109645;4939.234418665113;4995.575376092927;4828.806847726051;4835.58897493717;4838.104950584153;4844.224924012141;4894.853154405374 21:50:56 INFO - PROCESS | 32435 | |1;ext.html;564.6724899558257;595.2410676387606;605.3583201806089;610.4658423879105;617.5245061302797;28240.293992650193;30887.536686949712;30890.38219235614;38875.805620971856;39752.80123599385;40900;41617.37573936393;41664;41701.16597668045;41719.16561668765;7672.7314543991115;7845.372370210398;7850.803729906741;7853.096893857222;7853.175416581263;7126.109236345457;7659.080910290773;9759.219262458986;10103.141232995204;10116;10011.399316041061;10074.244431667617;10076.345037572572;10081.193504519657;10087.394756314645;10020.69937901864;10102.292839501275;10111.949440252825;10116.14012808912;10134.341267817643;7353.742619008362;7652.923470765277;7660.812574051031;9626.903730962671;10055.648052318134;38182.42726359107;38524;38577;38578.421323680166;38591.42112868309;2940.191447351974;3011.4428830666398;3021.561873528348;3032.6807838590285;3472.409690352646;28228;29434.233945963097;29591.556126658117;29629.70370296291;30236.395272094655;3454.4300190468543;3543.1496440854266;3559.839807208656;3604.1350075981836;3606.1886075633033;247194;251098;252272;252734.99999999817;252880;49247.75376123168;49309.753451233235;49468.75265623649;49501.75249123731;49625.255621165714;57688.71155644195;58049.4195058044;58072.419275807544;58075.12887306694;58139.70930145322;14597.41610335596;14817.036892601946;14860.70278594422;15086.622834429008;15092.64166225045;9321.021292764297;11320.830187547193;11390.544378224944;11393.14551408631;11398.088152947745;17773.822261777474;18159.546011349557;18408.631827363377;18805.81194188068;18813.435596932115;6728.31792051987;7007.474439417064;7069.8939515907305;7071.646417679199;7091.6454177290925;848.9830203395898;894.8076163624852;902.3605952588783;929.869818225449;987.3384832162325;26692.866535667585;27859.72140278612;27863.16410507688;28075.43849123047;28281.858590706914;967.1972263021676;973.2262851033446;977.0522593084696;1044.6030508406757;1060.3637817309707;14256.786148207786;14822.925885370503;14827.851721482863;14988.550343489713;15146.848531514765;390699;391212;391613;393881;395544;47315.52684473111;47793.28310075351;47809.282860757114;47870.76064619655;47932.28101578479;990.5146478225618;1079.4440862955585;1190.0776897904193;1197.21582363552;1225.540422341622;23680.28959131229;25971.740282596933;26232.94125859472;26398.20805375842;26540.867295663396;35856.4621530672;35942;36420.08949776277;36463.27073458569;36473;247664;248702;249023;249444;249725;19647.508812279808;24017.159399420936;24597.38506537351;24618.753812462364;24622.876885615457;40473.1905361897;41230.79384603058;41413;41559.1688166241;42042.57957420387;35233.47149792806;35758.64241357553;35910.8204458976;36171.63828361788;36396.454053188696;35704.82147589349;35911.46132808062;36006.45990310095;36135;36161.45757813582;30833.383332332778;31336.843315783277;31522.684773151974;35178;36325.45511817272;31301.8434907824;32516;32537.67462325441;32682.83658581692;33039.174020649676;24116.155934542207;24921.376965576004;25151.371215719755;25308.367290817878;25584.23247302584 21:50:56 INFO - PROCESS | 32435 | |2;jquery.html;355.99644003559973;357.6334257386178;362.69171204476214;364.6554006463891;373.9719521035923;15932.84067159328;17283.481495555137;17371.957682539025;17839.464816055508;17871.374501892435;15018.249087545633;15103.62240943977;15132.16773077483;15157;15164.469243576477;4283.721558098721;4635.212013957618;4635.443746750378;4668.953310466886;4689.437267527901;3427.2288735034667;3608.170120872201;4609.377734005917;5132.178851383779;5396.271503347057;5440.319960004999;5442.12925931851;5454.781808727646;5457.426970168135;5464.617476776627;5267.578593712532;5402.810901618444;5433.347998240197;5466.34403871534;5475.972620136914;5186.740662966837;5227.869303267449;5237.607179461517;5251;5251.711155886424;11347.943260283728;11976.640700778991;12004.459799309052;12008.879911200864;12012.819807702892;1849.676306646345;1871.008365566252;1922.2887531613253;2101.95796084079;2172.750133734625;8841.55792210387;8891.822163556693;8931.106889311082;9212.355135140542;9324.067593240621;1714.6827836850223;1765.8145894681131;1770.6016146367094;1772.140511851751;1781.6792977264088;37419.62580374189;37855;56439;57577.712111440014;61134.38865611331;9994.650187243411;10072.395656260647;10120.797584048425;10155.39067655943;10284.742881427874;13335.533256335983;13389;13398.732025359439;13415.664608384868;13430.186924765227;7263.309985551364;7270.63646817657;7403.888941665879;7454.36637885775;7491.10106787189;6990.161180658353;7010.193827709879;7023.473239506955;7134.857302853914;7197.856042879218;4227.112306415625;4231.238377092153;4262.296721041055;4265.445492086071;4269.103488267437;1522.6600591479648;1681.3946979087518;1755.3329734700733;1810.9637807244044;1820.335577514198;791.7664289034749;885.9069797671281;886.3263919421157;895.6686026170229;915.1854849184232;16210.432634857723;16548.089855058086;16571.25429355682;16610.916945415436;17183.054931978862;818.4352796570347;834.2033358142959;861.8319427711662;863.8661007543841;958.4872093429982;9232.21526170283;9517.90482095184;9564.282678799118;9566.808663826685;9714.854277185848;362541;368135;374555;375935;378756;73177.63411183016;73792.63103684447;74276.62861685657;75254;76984.61507692537;899.7120921305119;914.9954250228707;929.8884133903974;936.1013427109915;938.6198589571235;13860.792088118485;14811.777823332874;14852.331645075781;14864.479743208936;15181.92409037992;33420.16449588683;34441.48337774885;34535.82732086324;34536.82731586326;35534.822325888206;44716.55283447124;48082;48593.5140648589;48747.75626121847;48750.756246218545;7483.438742094474;7504.512206706547;7566.470347075652;7773.844523109393;7789.376849852111;11825.763484730085;11886.58396956137;11941.76116477683;11964.70088247766;12128.186351431375;5702.8651484498805;9500.714978550655;9538.332316738039;9708.2718796092;10067.647632332833;9609.327347085637;9849.26130540198;10169.288149829441;10559.841602376124;10718.839217411902;9009.504477253813;9665;9668.323217374716;9773.511324433892;10253.12848407864;7628.160902300853;7665.080190377191;7740.806479837824;7817.101033381234;7827.5519028979825;8680.826383472422;8766.21104100634;8980.371374003757;9004.099590040943;9482.857757133786 21:50:56 INFO - PROCESS | 32435 | |3;mootools.html;1292.9159604625704;1414.1868425655248;1456.8907331950104;1535.4856123198729;1756.5520792197979;6797.796066118019;7621.8094547636265;7856;7865.646045927925;8128.837423251532;7819.100803407609;7999.840003199933;8004.799880003003;8007.399445041616;8009.399295052865;1851.7685289338833;2185.49733561281;2213.2917466410713;2258.9096436142536;2262.45701031752;2234.854734442256;2262.230841513885;2266.5920134375806;2267.3764714703425;2268.0587556164173;2202.4383782135615;2222.7332720073614;2226.9109235630553;2228.687983682286;2229.643257078868;1821.5992481654082;2105.8315334773333;2165.2638103044883;2167.5556510915226;2205.5588882223537;2212.269950916194;2230.9776902230933;2236.4520692430297;2238.3285014495586;2242.8654280743044;7902.4863383879865;7952.483088599281;7958.681652733883;7972.720954766555;7976.441649084566;4427.468703755538;4544.681872268942;4550.8862278442975;4554.089182163548;4557.58981691646;2734.6855111662217;2802.9439411211865;2891.6240888684547;2931.7801164912717;2933.369325594986;921.4749589429438;926.314527249837;941.289326558444;941.7268991992382;951.8381875081184;11007.61473348429;11017;11022.669319920335;11023.99999999992;11025.83461248082;4298.140371925565;4339.913201735948;4426.977865110718;4455.509893911667;4465.977670111629;9351.719448416557;9352.766180845534;9357.578908949114;9368;9383.0616938307;4569.177548041384;4569.748663823521;4569.794359253841;4573.771311434415;4576.176288268077;3546.184377593168;3984.86052988144;4063.89840253996;4073.165001174752;4122.2786012447705;3744.6255374462335;3761.774293542396;3826.9043273918373;3852.2488114817343;3898.590647981978;1209.12338554549;1209.1475509765594;1213.5873802906876;1214.3199808107488;1223.8653748087704;786.7128498098267;787.165604459275;812.622130709223;818.9672413103409;827.3960009193322;4928.753562321869;5064;5077.822276220315;5173.63784535079;5183.870403239949;842.1957031035347;899.8920129584492;903.3405613901889;909.7589138878203;909.7998440343114;3358.328334333143;3446.0867870014467;3473.89578312651;3493.12671832042;3561.928761424757;9779.65771198019;9940.552675129637;10052.74868128288;10095;10106.646267380607;9837;9928.255380846465;9944.602215911282;9946.35348702332;9977.80044399108;7499.287567681062;7523.699052037857;7590.278923502258;7633.389328853678;7655.50239234448;5118.616103792305;5169.560587349967;5181.844544663666;5204.869878253074;5226.137687281708;8951.686690965786;9183.403078799856;9222.262219022328;9344.672936447192;9368.110029547182;9306.208972237435;9357.111074447917;9371.765705857408;9571.61713531451;9651.903480965382;5585.1901474286815;6061.060535616986;6219.968900155471;6425.839354016187;6553.4101930824545;7583.976163218115;7595.278448547379;7654.502457340478;7662.923370766444;7663.655135518804;6637.734490620321;6816.931830681629;6848.486363522856;6907.03301537775;6912.27421120775;6756.45948324123;6775.254721980479;6780.796576102724;6869.278725733926;6910.2398736137975;6312.873742525216;6330.651814150266;6375.713092910923;6397.104405383343;6556.672166391757;4286.464191976003;4342.109867477223;4348.913021739484;4351.521332653342;4413.646908247269;4396.4064851244675;4467.865964021084;4500.122476117126;4559.680822342404;4579.038401935498 21:50:56 INFO - PROCESS | 32435 | |4;prototype.html;282.8656388215598;284.4766276588867;285.04793988079814;287.0198272898052;287.57151843752814;4770.689905156162;4792.472827988919;4821.807127714896;4840.903181936364;4843.39457567804;4756.9286460703115;4759.785809638566;4770.284457331402;4779.35478710374;4801.495842936493;3513.6135025147214;3630.782153070811;3634.109643137435;3733.5146430964073;3771.8868433947027;3710.9404280624244;3741.2330472253257;3748.6626203641667;3773;3780.81095945203;3549.6272891346425;3736.178040831013;3742.419924911643;3745.8688945886897;3746.7751934883995;3569.3039857227723;3706.3328600851837;3707.29561383339;3731.8507259709577;3735.551733791935;3277.1807048237943;3280.6063272407223;3287.852046657882;3291.308825146722;3293.8682452701864;4501.887452813673;4551.635869130495;4563.292689633112;4568.428946381702;4595.058013107305;3894.844206231747;4159.958400415987;4194.622483976456;4236.406903033578;4261.637760790337;4995.950040499585;5001;5001.624878134155;5021.6735912165595;5037.370328708911;3450.913727156841;3475.4265546184847;3479.8782042628386;3486.7684681803667;3488.529048578435;5120.078385890538;5239.240310155006;5277.393099793535;5281.366236051698;5283.445238249967;3573.5711714594413;3588.3720348939355;3588.766730162531;3590.994521533975;3592.173800026009;3613.626821807749;3617.602063772983;3634.4184930411006;3634.6547078027547;3634.9636503635156;4197.4753155855515;4208.831646734157;4214.17823524416;4229.386738922839;4236.385724069993;4913.238448040559;4991.301217829507;5054.721990290495;5080.085584594734;5088.498892826625;1243.2167734327315;1243.533674871923;1244.1912756708211;1250.5435516036582;1254.6988722706667;781.9921800782033;785.4894318692895;825.1212458731552;836.6987884361625;840.5965136734402;4371.213181627338;4374.496932852762;4386.166628340605;4393.802278897458;4405.449318835145;5113.590912726973;5126.7952031272625;5130.256112863689;5139.563137133311;5154;4196.055887425366;4327.242732521796;4374.737515749065;4389.736615803062;4397.84607538741;2693.649825522709;2719.864006799652;2731.4537092581563;2731.6995130535624;2734.373048036415;4797;4811.831585894477;4833.589144922721;4838.346823178897;4848.878778030577;5102.107131252016;5142.2286657001005;5237.973810130925;5266.894662106736;5276;4787.664863459594;4821.360737349318;4821.831235906727;4828.637852161102;4836.5888899443235;5086.219823062047;5103.336566246513;5141.897162056663;5147.40804807452;5152.381714194321;4777.7577829765205;5024.346834911438;5040.269160971712;5045.94035252601;5058.9494105058475;4756.405449318835;4783.569478746929;4822.9758851206925;4824.638152138534;4834.516548345137;3546.2375589248436;3551.36075506401;3566.7324950628285;3576.481410195559;3584.766990145632;4881.975590122169;5096.694198348111;5121.308623335951;5123.820666276662;5129.179331306973;4975.0547395994645;4980.576650984707;4987.276844857548;4991.276264941491;4997.350344455198;4932.432770231326;4958.42978057528;4962.45413004562;4971.154903666313;4976.527229913152;4650.186217411871;4900.828471003498;4901.803927842846;4913.361263035782;4947.975260123676;4974.278729584263;4992.600591952708;4996.150654388835;5007.349044624176;5020.648554601289;4859.659823812299;4905.166121759238;4907.263910413324;4925.9014819704125;4926.916078462733 21:50:56 INFO - PROCESS | 32435 | |5;yui.html;661.8543920337526;739.4704756995726;739.5045319635843;753.4688044928323;759.4456047085628;10889.727756806084;11605;11605.535778568847;11667.591634292801;11964.700882477942;12634.11561190717;12718.491260349574;12721.872781272185;12739.745205095916;12753.872461275385;630.1744714424119;780.3912947900646;796.7530065679643;804.9839003219932;816.0819078536646;808.2200676347323;808.7492877208084;811.3022800391658;811.3671336357651;812.2405550809982;850.5789634131114;852.4373913217278;852.7484392104313;852.8209076094028;852.9744107676779;652.2368828470701;824.3570015387947;840.8528507511191;847.4195176304252;847.6058632735745;608.4128815692833;611.1749138662814;611.5963464113709;611.853155242743;613.7238242790718;12944.288064156468;13083.215007099605;13096;13100.279484628341;13102;12395.938020309932;12876.742465150644;12979.480820767158;13196.340182990813;13225.875800556963;9966.750831229278;10029.949850250701;10087.142592879614;10307.587696492206;10548.997845204693;3265.689759472846;3268.4607039838397;3380.053584996205;3383.9323213535836;3399.4220982433044;44231.115377692586;44478;44528.3320750189;44551.55448445507;44577.33134002992;10018.699439016842;10099;10143.64497242593;10501;10533.578656853793;17443.21505532254;17641.823581764274;17648.382306619464;17649.205785739672;17698.29206831738;6645.900311495331;6667.266600673922;6672.199336079701;6750.459963202932;6869.690863911036;3678.8160591970295;3698.7410881238593;3712.6287371263197;3720.925581488355;3827.7129215308964;2736.097087960968;2817.577363395466;2822.1533539938346;2823.6046953426535;2826.759725423362;506.57447743895307;518.7769259218572;529.5710474515655;530.0697276280104;531.2084993359866;483.18824375049553;508.2274942088006;520.9192575150857;530.2629345210161;534.2973989204185;6832.385085342343;6853.965730171317;6891.620960847202;6975.476839236976;6996.475264355092;446.25920971187674;459.5014409365809;498.185466761847;517.5083670513028;519.5999080707909;3305.371979323969;3378.5607870976614;3446.8965931022108;3447.207142357272;3508.6842184203542;51790.52618422697;52412.737936310834;52560;53261.467385326425;53617.1957420639;48747.512524875005;48896.26655600169;49473;49505.50494495081;49746.25380619294;43388.132237355705;44689.329660055126;44741;45305.320420193726;45503.544964550594;6550.63971481554;6567.540272180901;6577.3422657733845;6640.83397915056;6694.799156025327;30323.393532128794;30841.8457907718;31427;31651.841740791147;31665.525017125223;39524.20951580895;39800.805975820775;39881;40067.79966100151;40385;9109.726708198765;10000.24998125129;10434.37393756377;10497.9475102624;10587.576496940035;11048.834267486154;11253.549858005916;11275.336573487186;11340.376279304717;11533.308001519936;10742.19433542503;10773.353598784099;10790.67627971162;10861.619843305447;11089.66730998039;10502.68491945243;10661.413622250851;10780.730481738019;10802.459877006275;11069.280496767684;10356.637517686844;10543.683689489328;10873;10898.346099234072;11091.556337746722;9034.503102329172;9085.500297483437;9122.543872806466;9445.669401571187;9541.427514349161;8954.955225223832;9011;9029.683961061332;9096.090390960851;9206.953965230132 21:50:56 INFO - PROCESS | 32435 | __end_tp_report 21:50:56 INFO - PROCESS | 32435 | __start_cc_report 21:50:56 INFO - PROCESS | 32435 | _x_x_mozilla_cycle_collect,905 21:50:56 INFO - PROCESS | 32435 | __end_cc_report 21:50:56 INFO - PROCESS | 32435 | __startTimestamp1464238256061__endTimestamp 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | ------- Summary: start ------- 21:50:56 INFO - PROCESS | 32435 | Number of tests: 6 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | [#0] dojo.html Cycles:165 Average:4670.65 Median:4808.57 stddev:485.36 (10.1%) stddev-sans-first:460.93 21:50:56 INFO - PROCESS | 32435 | Values: 2675.6 2694.0 2719.3 2725.8 2726.3 4569.0 4652.4 4659.5 4678.6 4732.1 4614.1 4615.2 4619.3 4643.1 4647.9 4202.8 4252.1 4286.2 4318.0 4454.4 4389.8 4415.5 4418.7 4450.2 4476.3 4233.1 4261.7 4278.7 4280.9 4351.6 4308.5 4352.4 4354.3 4356.3 4359.2 4316.5 4333.1 4350.8 4356.4 4370.3 4475.1 4588.0 4709.2 4723.0 4726.5 5025.9 5104.3 5109.4 5111.3 5112.7 5107.1 5138.0 5143.7 5150.6 5155.3 4610.0 4655.9 4669.5 4788.4 4803.1 5145.4 5147.8 5152.6 5189.2 5195.5 5000.0 5003.0 5003.2 5004.8 5012.4 4833.6 5005.5 5044.4 5056.5 5093.3 4977.5 4980.1 5009.0 5017.7 5065.7 4967.6 4999.1 5003.5 5004.6 5060.7 4194.7 4232.8 4235.6 4283.7 4284.6 3791.6 3801.7 3806.3 3807.0 3807.5 4255.4 4298.2 4332.5 4341.5 4389.6 5085.1 5087.6 5092.1 5093.9 5135.8 4333.1 4342.0 4343.2 4346.7 4382.3 4441.2 4562.5 4607.3 4619.3 4637.1 4806.5 4808.6 4811.9 4816.0 4855.8 5099.6 5101.4 5135.7 5159.6 5199.0 4635.2 4738.9 4789.8 4797.4 4814.7 5040.2 5051.0 5073.6 5084.7 5110.1 4912.2 5107.1 5110.3 5111.9 5119.0 4823.6 4865.1 4879.9 4889.8 4901.9 4884.1 4894.7 4898.6 4906.6 4947.7 4719.1 4787.5 4848.4 4901.8 4903.4 4924.1 4924.8 4937.9 4939.2 4995.6 4828.8 4835.6 4838.1 4844.2 4894.9 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | [#1] ext.html Cycles:180 Average:45271.62 Median:35205.74 stddev:80242.87 (227.9%) stddev-sans-first:80397.76 21:50:56 INFO - PROCESS | 32435 | Values: 564.7 595.2 605.4 610.5 617.5 28240.3 30887.5 30890.4 38875.8 39752.8 40900.0 41617.4 41664.0 41701.2 41719.2 7672.7 7845.4 7850.8 7853.1 7853.2 7126.1 7659.1 9759.2 10103.1 10116.0 10011.4 10074.2 10076.3 10081.2 10087.4 10020.7 10102.3 10111.9 10116.1 10134.3 7353.7 7652.9 7660.8 9626.9 10055.6 38182.4 38524.0 38577.0 38578.4 38591.4 2940.2 3011.4 3021.6 3032.7 3472.4 28228.0 29434.2 29591.6 29629.7 30236.4 3454.4 3543.1 3559.8 3604.1 3606.2 247194.0 251098.0 252272.0 252735.0 252880.0 49247.8 49309.8 49468.8 49501.8 49625.3 57688.7 58049.4 58072.4 58075.1 58139.7 14597.4 14817.0 14860.7 15086.6 15092.6 9321.0 11320.8 11390.5 11393.1 11398.1 17773.8 18159.5 18408.6 18805.8 18813.4 6728.3 7007.5 7069.9 7071.6 7091.6 849.0 894.8 902.4 929.9 987.3 26692.9 27859.7 27863.2 28075.4 28281.9 967.2 973.2 977.1 1044.6 1060.4 14256.8 14822.9 14827.9 14988.6 15146.8 390699.0 391212.0 391613.0 393881.0 395544.0 47315.5 47793.3 47809.3 47870.8 47932.3 990.5 1079.4 1190.1 1197.2 1225.5 23680.3 25971.7 26232.9 26398.2 26540.9 35856.5 35942.0 36420.1 36463.3 36473.0 247664.0 248702.0 249023.0 249444.0 249725.0 19647.5 24017.2 24597.4 24618.8 24622.9 40473.2 41230.8 41413.0 41559.2 42042.6 35233.5 35758.6 35910.8 36171.6 36396.5 35704.8 35911.5 36006.5 36135.0 36161.5 30833.4 31336.8 31522.7 35178.0 36325.5 31301.8 32516.0 32537.7 32682.8 33039.2 24116.2 24921.4 25151.4 25308.4 25584.2 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | [#2] jquery.html Cycles:180 Average:22612.55 Median:48337.76 stddev:61218.80 (126.6%) stddev-sans-first:61367.73 21:50:56 INFO - PROCESS | 32435 | Values: 356.0 357.6 362.7 364.7 374.0 15932.8 17283.5 17372.0 17839.5 17871.4 15018.2 15103.6 15132.2 15157.0 15164.5 4283.7 4635.2 4635.4 4669.0 4689.4 3427.2 3608.2 4609.4 5132.2 5396.3 5440.3 5442.1 5454.8 5457.4 5464.6 5267.6 5402.8 5433.3 5466.3 5476.0 5186.7 5227.9 5237.6 5251.0 5251.7 11347.9 11976.6 12004.5 12008.9 12012.8 1849.7 1871.0 1922.3 2102.0 2172.8 8841.6 8891.8 8931.1 9212.4 9324.1 1714.7 1765.8 1770.6 1772.1 1781.7 37419.6 37855.0 56439.0 57577.7 61134.4 9994.7 10072.4 10120.8 10155.4 10284.7 13335.5 13389.0 13398.7 13415.7 13430.2 7263.3 7270.6 7403.9 7454.4 7491.1 6990.2 7010.2 7023.5 7134.9 7197.9 4227.1 4231.2 4262.3 4265.4 4269.1 1522.7 1681.4 1755.3 1811.0 1820.3 791.8 885.9 886.3 895.7 915.2 16210.4 16548.1 16571.3 16610.9 17183.1 818.4 834.2 861.8 863.9 958.5 9232.2 9517.9 9564.3 9566.8 9714.9 362541.0 368135.0 374555.0 375935.0 378756.0 73177.6 73792.6 74276.6 75254.0 76984.6 899.7 915.0 929.9 936.1 938.6 13860.8 14811.8 14852.3 14864.5 15181.9 33420.2 34441.5 34535.8 34536.8 35534.8 44716.6 48082.0 48593.5 48747.8 48750.8 7483.4 7504.5 7566.5 7773.8 7789.4 11825.8 11886.6 11941.8 11964.7 12128.2 5702.9 9500.7 9538.3 9708.3 10067.6 9609.3 9849.3 10169.3 10559.8 10718.8 9009.5 9665.0 9668.3 9773.5 10253.1 7628.2 7665.1 7740.8 7817.1 7827.6 8680.8 8766.2 8980.4 9004.1 9482.9 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | [#3] mootools.html Cycles:180 Average:5193.82 Median:5098.22 stddev:2977.23 (58.4%) stddev-sans-first:2971.14 21:50:56 INFO - PROCESS | 32435 | Values: 1292.9 1414.2 1456.9 1535.5 1756.6 6797.8 7621.8 7856.0 7865.6 8128.8 7819.1 7999.8 8004.8 8007.4 8009.4 1851.8 2185.5 2213.3 2258.9 2262.5 2234.9 2262.2 2266.6 2267.4 2268.1 2202.4 2222.7 2226.9 2228.7 2229.6 1821.6 2105.8 2165.3 2167.6 2205.6 2212.3 2231.0 2236.5 2238.3 2242.9 7902.5 7952.5 7958.7 7972.7 7976.4 4427.5 4544.7 4550.9 4554.1 4557.6 2734.7 2802.9 2891.6 2931.8 2933.4 921.5 926.3 941.3 941.7 951.8 11007.6 11017.0 11022.7 11024.0 11025.8 4298.1 4339.9 4427.0 4455.5 4466.0 9351.7 9352.8 9357.6 9368.0 9383.1 4569.2 4569.7 4569.8 4573.8 4576.2 3546.2 3984.9 4063.9 4073.2 4122.3 3744.6 3761.8 3826.9 3852.2 3898.6 1209.1 1209.1 1213.6 1214.3 1223.9 786.7 787.2 812.6 819.0 827.4 4928.8 5064.0 5077.8 5173.6 5183.9 842.2 899.9 903.3 909.8 909.8 3358.3 3446.1 3473.9 3493.1 3561.9 9779.7 9940.6 10052.7 10095.0 10106.6 9837.0 9928.3 9944.6 9946.4 9977.8 7499.3 7523.7 7590.3 7633.4 7655.5 5118.6 5169.6 5181.8 5204.9 5226.1 8951.7 9183.4 9222.3 9344.7 9368.1 9306.2 9357.1 9371.8 9571.6 9651.9 5585.2 6061.1 6220.0 6425.8 6553.4 7584.0 7595.3 7654.5 7662.9 7663.7 6637.7 6816.9 6848.5 6907.0 6912.3 6756.5 6775.3 6780.8 6869.3 6910.2 6312.9 6330.7 6375.7 6397.1 6556.7 4286.5 4342.1 4348.9 4351.5 4413.6 4396.4 4467.9 4500.1 4559.7 4579.0 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | [#4] prototype.html Cycles:180 Average:4128.04 Median:4774.22 stddev:1209.94 (25.3%) stddev-sans-first:1178.41 21:50:56 INFO - PROCESS | 32435 | Values: 282.9 284.5 285.0 287.0 287.6 4770.7 4792.5 4821.8 4840.9 4843.4 4756.9 4759.8 4770.3 4779.4 4801.5 3513.6 3630.8 3634.1 3733.5 3771.9 3710.9 3741.2 3748.7 3773.0 3780.8 3549.6 3736.2 3742.4 3745.9 3746.8 3569.3 3706.3 3707.3 3731.9 3735.6 3277.2 3280.6 3287.9 3291.3 3293.9 4501.9 4551.6 4563.3 4568.4 4595.1 3894.8 4160.0 4194.6 4236.4 4261.6 4996.0 5001.0 5001.6 5021.7 5037.4 3450.9 3475.4 3479.9 3486.8 3488.5 5120.1 5239.2 5277.4 5281.4 5283.4 3573.6 3588.4 3588.8 3591.0 3592.2 3613.6 3617.6 3634.4 3634.7 3635.0 4197.5 4208.8 4214.2 4229.4 4236.4 4913.2 4991.3 5054.7 5080.1 5088.5 1243.2 1243.5 1244.2 1250.5 1254.7 782.0 785.5 825.1 836.7 840.6 4371.2 4374.5 4386.2 4393.8 4405.4 5113.6 5126.8 5130.3 5139.6 5154.0 4196.1 4327.2 4374.7 4389.7 4397.8 2693.6 2719.9 2731.5 2731.7 2734.4 4797.0 4811.8 4833.6 4838.3 4848.9 5102.1 5142.2 5238.0 5266.9 5276.0 4787.7 4821.4 4821.8 4828.6 4836.6 5086.2 5103.3 5141.9 5147.4 5152.4 4777.8 5024.3 5040.3 5045.9 5058.9 4756.4 4783.6 4823.0 4824.6 4834.5 3546.2 3551.4 3566.7 3576.5 3584.8 4882.0 5096.7 5121.3 5123.8 5129.2 4975.1 4980.6 4987.3 4991.3 4997.4 4932.4 4958.4 4962.5 4971.2 4976.5 4650.2 4900.8 4901.8 4913.4 4948.0 4974.3 4992.6 4996.2 5007.3 5020.6 4859.7 4905.2 4907.3 4925.9 4926.9 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - PROCESS | 32435 | [#5] yui.html Cycles:180 Average:12843.18 Median:44503.17 stddev:14856.96 (33.4%) stddev-sans-first:14870.48 21:50:56 INFO - PROCESS | 32435 | Values: 661.9 739.5 739.5 753.5 759.4 10889.7 11605.0 11605.5 11667.6 11964.7 12634.1 12718.5 12721.9 12739.7 12753.9 630.2 780.4 796.8 805.0 816.1 808.2 808.7 811.3 811.4 812.2 850.6 852.4 852.7 852.8 853.0 652.2 824.4 840.9 847.4 847.6 608.4 611.2 611.6 611.9 613.7 12944.3 13083.2 13096.0 13100.3 13102.0 12395.9 12876.7 12979.5 13196.3 13225.9 9966.8 10029.9 10087.1 10307.6 10549.0 3265.7 3268.5 3380.1 3383.9 3399.4 44231.1 44478.0 44528.3 44551.6 44577.3 10018.7 10099.0 10143.6 10501.0 10533.6 17443.2 17641.8 17648.4 17649.2 17698.3 6645.9 6667.3 6672.2 6750.5 6869.7 3678.8 3698.7 3712.6 3720.9 3827.7 2736.1 2817.6 2822.2 2823.6 2826.8 506.6 518.8 529.6 530.1 531.2 483.2 508.2 520.9 530.3 534.3 6832.4 6854.0 6891.6 6975.5 6996.5 446.3 459.5 498.2 517.5 519.6 3305.4 3378.6 3446.9 3447.2 3508.7 51790.5 52412.7 52560.0 53261.5 53617.2 48747.5 48896.3 49473.0 49505.5 49746.3 43388.1 44689.3 44741.0 45305.3 45503.5 6550.6 6567.5 6577.3 6640.8 6694.8 30323.4 30841.8 31427.0 31651.8 31665.5 39524.2 39800.8 39881.0 40067.8 40385.0 9109.7 10000.2 10434.4 10497.9 10587.6 11048.8 11253.5 11275.3 11340.4 11533.3 10742.2 10773.4 10790.7 10861.6 11089.7 10502.7 10661.4 10780.7 10802.5 11069.3 10356.6 10543.7 10873.0 10898.3 11091.6 9034.5 9085.5 9122.5 9445.7 9541.4 8955.0 9011.0 9029.7 9096.1 9207.0 21:50:56 INFO - PROCESS | 32435 | -------- Summary: end -------- 21:50:56 INFO - PROCESS | 32435 | 21:50:56 INFO - TEST-INFO | 32435: exit 0 21:50:56 INFO - TEST-OK | dromaeo_css | took 1119410ms 21:50:56 INFO - TEST-START | kraken 21:50:56 INFO - operating with platform_type : linux_ 21:50:56 INFO - Initialising browser for kraken test... 21:50:56 INFO - TEST-INFO | started process 32612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRCyEO/profile http://localhost:33481/getInfo.html) 21:51:01 INFO - PROCESS | 32612 | __metrics Screen width/height:1600/1200 21:51:01 INFO - PROCESS | 32612 | colorDepth:24 21:51:01 INFO - PROCESS | 32612 | Browser inner width/height: 1024/697 21:51:01 INFO - PROCESS | 32612 | __metrics 21:51:02 ERROR - PROCESS | 32612 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:51:03 INFO - TEST-INFO | 32612: exit 0 21:51:03 INFO - Browser initialized. 21:51:03 INFO - Running cycle 1/1 for kraken test... 21:51:03 INFO - TEST-INFO | started process 32697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRCyEO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:51:15 INFO - PROCESS | 32697 | RSS: Main: 156774400 21:51:15 INFO - PROCESS | 32697 | 21:51:18 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-beat-detection) 21:51:19 INFO - PROCESS | 32697 | RSS: Main: 212652032 21:51:19 INFO - PROCESS | 32697 | 21:51:21 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-dft) 21:51:22 INFO - PROCESS | 32697 | RSS: Main: 200712192 21:51:22 INFO - PROCESS | 32697 | 21:51:25 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-fft) 21:51:26 INFO - PROCESS | 32697 | RSS: Main: 268718080 21:51:26 INFO - PROCESS | 32697 | 21:51:28 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-oscillator) 21:51:29 INFO - PROCESS | 32697 | RSS: Main: 177868800 21:51:29 INFO - PROCESS | 32697 | 21:51:31 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:51:31 INFO - PROCESS | 32697 | RSS: Main: 182661120 21:51:31 INFO - PROCESS | 32697 | 21:51:35 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33481/tests/kraken/driver.html?testName=imaging-darkroom) 21:51:35 INFO - PROCESS | 32697 | RSS: Main: 218562560 21:51:35 INFO - PROCESS | 32697 | 21:51:39 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33481/tests/kraken/driver.html?testName=imaging-desaturate) 21:51:39 INFO - PROCESS | 32697 | RSS: Main: 218603520 21:51:39 INFO - PROCESS | 32697 | 21:51:42 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33481/tests/kraken/driver.html?testName=json-parse-financial) 21:51:43 INFO - PROCESS | 32697 | RSS: Main: 219582464 21:51:43 INFO - PROCESS | 32697 | 21:51:44 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:51:45 INFO - PROCESS | 32697 | RSS: Main: 205451264 21:51:45 INFO - PROCESS | 32697 | 21:51:47 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:51:48 INFO - PROCESS | 32697 | RSS: Main: 209440768 21:51:48 INFO - PROCESS | 32697 | 21:51:50 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:51:50 INFO - PROCESS | 32697 | RSS: Main: 220221440 21:51:50 INFO - PROCESS | 32697 | 21:51:53 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:51:54 INFO - PROCESS | 32697 | RSS: Main: 228749312 21:51:54 INFO - PROCESS | 32697 | 21:51:57 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:51:57 INFO - PROCESS | 32697 | RSS: Main: 224636928 21:51:57 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33481/tests/kraken/driver.html?testName=ai-astar) 21:51:59 INFO - PROCESS | 32697 | RSS: Main: 270864384 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | __start_tp_report 21:51:59 INFO - PROCESS | 32697 | _x_x_mozilla_page_load 21:51:59 INFO - PROCESS | 32697 | _x_x_mozilla_page_load_details 21:51:59 INFO - PROCESS | 32697 | |i|pagename|runs| 21:51:59 INFO - PROCESS | 32697 | |0;ai-astar;113;108;115;113;114;113;113;115;114;114 21:51:59 INFO - PROCESS | 32697 | |1;audio-beat-detection;160;129;131;180;130;134;164;138;181;140 21:51:59 INFO - PROCESS | 32697 | |2;audio-dft;161;161;161;161;162;163;162;161;162;162 21:51:59 INFO - PROCESS | 32697 | |3;audio-fft;75;76;76;106;74;75;75;75;97;75 21:51:59 INFO - PROCESS | 32697 | |4;audio-oscillator;84;86;121;84;84;86;113;84;85;129 21:51:59 INFO - PROCESS | 32697 | |5;imaging-gaussian-blur;117;117;117;116;117;118;118;116;117;117 21:51:59 INFO - PROCESS | 32697 | |6;imaging-darkroom;147;146;145;146;146;146;146;146;146;145 21:51:59 INFO - PROCESS | 32697 | |7;imaging-desaturate;95;94;96;95;95;95;95;95;95;96 21:51:59 INFO - PROCESS | 32697 | |8;json-parse-financial;64;65;64;64;66;64;65;92;64;62 21:51:59 INFO - PROCESS | 32697 | |9;json-stringify-tinderbox;66;65;65;65;66;64;65;65;66;66 21:51:59 INFO - PROCESS | 32697 | |10;stanford-crypto-aes;84;91;83;83;84;82;83;84;83;83 21:51:59 INFO - PROCESS | 32697 | |11;stanford-crypto-ccm;139;132;141;140;137;136;139;146;169;134 21:51:59 INFO - PROCESS | 32697 | |12;stanford-crypto-pbkdf2;181;176;173;174;175;179;176;171;173;178 21:51:59 INFO - PROCESS | 32697 | |13;stanford-crypto-sha256-iterative;66;66;68;68;67;66;67;66;69;66 21:51:59 INFO - PROCESS | 32697 | __end_tp_report 21:51:59 INFO - PROCESS | 32697 | __start_cc_report 21:51:59 INFO - PROCESS | 32697 | _x_x_mozilla_cycle_collect,1923 21:51:59 INFO - PROCESS | 32697 | __end_cc_report 21:51:59 INFO - PROCESS | 32697 | __startTimestamp1464238319942__endTimestamp 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | ------- Summary: start ------- 21:51:59 INFO - PROCESS | 32697 | Number of tests: 14 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.99 (1.7%) stddev-sans-first:2.11 21:51:59 INFO - PROCESS | 32697 | Values: 113.0 108.0 115.0 113.0 114.0 113.0 113.0 115.0 114.0 114.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:150.00 stddev:20.66 (13.8%) stddev-sans-first:21.51 21:51:59 INFO - PROCESS | 32697 | Values: 160.0 129.0 131.0 180.0 130.0 134.0 164.0 138.0 181.0 140.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 21:51:59 INFO - PROCESS | 32697 | Values: 161.0 161.0 161.0 161.0 162.0 163.0 162.0 161.0 162.0 162.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:11.34 (15.1%) stddev-sans-first:11.85 21:51:59 INFO - PROCESS | 32697 | Values: 75.0 76.0 76.0 106.0 74.0 75.0 75.0 75.0 97.0 75.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.00 stddev:17.95 (21.4%) stddev-sans-first:18.54 21:51:59 INFO - PROCESS | 32697 | Values: 84.0 86.0 121.0 84.0 84.0 86.0 113.0 84.0 85.0 129.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 21:51:59 INFO - PROCESS | 32697 | Values: 117.0 117.0 117.0 116.0 117.0 118.0 118.0 116.0 117.0 117.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 21:51:59 INFO - PROCESS | 32697 | Values: 147.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:51:59 INFO - PROCESS | 32697 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:64.50 stddev:8.84 (13.7%) stddev-sans-first:9.31 21:51:59 INFO - PROCESS | 32697 | Values: 64.0 65.0 64.0 64.0 66.0 64.0 65.0 92.0 64.0 62.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 21:51:59 INFO - PROCESS | 32697 | Values: 66.0 65.0 65.0 65.0 66.0 64.0 65.0 65.0 66.0 66.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:2.54 (3.0%) stddev-sans-first:2.69 21:51:59 INFO - PROCESS | 32697 | Values: 84.0 91.0 83.0 83.0 84.0 82.0 83.0 84.0 83.0 83.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:139.50 stddev:10.48 (7.5%) stddev-sans-first:11.08 21:51:59 INFO - PROCESS | 32697 | Values: 139.0 132.0 141.0 140.0 137.0 136.0 139.0 146.0 169.0 134.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.00 stddev:3.06 (1.7%) stddev-sans-first:2.55 21:51:59 INFO - PROCESS | 32697 | Values: 181.0 176.0 173.0 174.0 175.0 179.0 176.0 171.0 173.0 178.0 21:51:59 INFO - PROCESS | 32697 | 21:51:59 INFO - PROCESS | 32697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 21:51:59 INFO - PROCESS | 32697 | Values: 66.0 66.0 68.0 68.0 67.0 66.0 67.0 66.0 69.0 66.0 21:51:59 INFO - PROCESS | 32697 | -------- Summary: end -------- 21:51:59 INFO - PROCESS | 32697 | 21:52:00 INFO - TEST-INFO | 32697: exit 0 21:52:01 INFO - TEST-OK | kraken | took 64150ms 21:52:01 INFO - SUITE-END | took 1183s 21:52:01 INFO - Completed test suite (00:19:43) 21:52:01 INFO - javascript benchmark 21:52:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2675.558532842081, 2693.973060269399, 2719.279390961395, 2725.8228215166014, 2726.33204864808, 4568.954310456895, 4652.418447694038, 4659.534046595347, 4678.578927896493, 4732.0535892821445, 4614.1233165698495, 4615.192341340269, 4619.2609182530805, 4643.094596553673, 4647.86056418308, 4202.810873510692, 4252.0858015526655, 4286.164197981379, 4317.956820431787, 4454.354118652794, 4389.802458889358, 4415.492218394894, 4418.734875907439, 4450.2434586120435, 4476.328550717386, 4233.089885674594, 4261.701680882339, 4278.657707383401, 4280.914381712349, 4351.586599273064, 4308.547602501723, 4352.36890650857, 4354.346847972798, 4356.302991521341, 4359.17175736609, 4316.503602085769, 4333.133373325348, 4350.825966961318, 4356.390105385217, 4370.322599997005, 4475.1049790042125, 4587.9541204588195, 4709.246520556729, 4723.031778485402, 4726.480087190406, 5025.924611130836, 5104.336436263262, 5109.386873575195, 5111.3355263815465, 5112.744362781846, 5107.106256405152, 5138.023775482647, 5143.691378517301, 5150.613703972217, 5155.252488389163, 4609.95390046102, 4655.906881862344, 4669.486356500782, 4788.4253889533475, 4803.087413391444, 5145.3568303962, 5147.794088236428, 5152.587792976553, 5189.221616757516, 5195.48045195485, 4999.975000125049, 5003.024410240041, 5003.249512573143, 5004.824831130893, 5012.373453318335, 4833.613310935117, 5005.549500544968, 5044.369453818273, 5056.544910958031, 5093.286939828427, 4977.477364876709, 4980.103581355318, 5009.0, 5017.67385119966, 5065.670731402447, 4967.602591792648, 4999.0501804657, 5003.499650034967, 5004.599632029429, 5060.746962651852, 4194.664426845845, 4232.809523571385, 4235.639970602471, 4283.7001409901, 4284.592963668447, 3791.6208379162413, 3801.733878628525, 3806.333891568964, 3807.048237940515, 3807.5430948286385, 4255.4255175551525, 4298.2263192625005, 4332.458442694663, 4341.522432532419, 4389.604935555752, 5085.110105731482, 5087.64386492942, 5092.083424983464, 5093.923591146136, 5135.820246291437, 4333.111712099012, 4341.978290108593, 4343.153085148366, 4346.739195648272, 4382.276924307517, 4441.178381999341, 4562.520935301812, 4607.285870690049, 4619.3071039343695, 4637.072585482917, 4806.49531799163, 4808.567228949411, 4811.855644330676, 4816.0, 4855.757212139379, 5099.6175286852895, 5101.38783345986, 5135.717535535432, 5159.613029022763, 5199.0, 4635.235186194375, 4738.881527961828, 4789.760511974457, 4797.4482934462985, 4814.711117332971, 5040.218766091261, 5050.9747451263975, 5073.568746656576, 5084.720340381315, 5110.054639891632, 4912.214045752662, 5107.10625640504, 5110.259012443249, 5111.87220319495, 5118.976204758988, 4823.589994850337, 4865.1242776300605, 4879.926801097916, 4889.828855990166, 4901.9019619608125, 4884.072026314989, 4894.657373983787, 4898.583620392306, 4906.55840974314, 4947.703137811743, 4719.079779442975, 4787.54518320759, 4848.3697119375665, 4901.803927842846, 4903.436104847988, 4924.089043526959, 4924.778384972757, 4937.9259311109645, 4939.234418665113, 4995.575376092927, 4828.806847726051, 4835.58897493717, 4838.104950584153, 4844.224924012141, 4894.853154405374], "value": 4640.57528632857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6724899558257, 595.2410676387606, 605.3583201806089, 610.4658423879105, 617.5245061302797, 28240.293992650193, 30887.536686949712, 30890.38219235614, 38875.805620971856, 39752.80123599385, 40900.0, 41617.37573936393, 41664.0, 41701.16597668045, 41719.16561668765, 7672.7314543991115, 7845.372370210398, 7850.803729906741, 7853.096893857222, 7853.175416581263, 7126.109236345457, 7659.080910290773, 9759.219262458986, 10103.141232995204, 10116.0, 10011.399316041061, 10074.244431667617, 10076.345037572572, 10081.193504519657, 10087.394756314645, 10020.69937901864, 10102.292839501275, 10111.949440252825, 10116.14012808912, 10134.341267817643, 7353.742619008362, 7652.923470765277, 7660.812574051031, 9626.903730962671, 10055.648052318134, 38182.42726359107, 38524.0, 38577.0, 38578.421323680166, 38591.42112868309, 2940.191447351974, 3011.4428830666398, 3021.561873528348, 3032.6807838590285, 3472.409690352646, 28228.0, 29434.233945963097, 29591.556126658117, 29629.70370296291, 30236.395272094655, 3454.4300190468543, 3543.1496440854266, 3559.839807208656, 3604.1350075981836, 3606.1886075633033, 247194.0, 251098.0, 252272.0, 252734.99999999817, 252880.0, 49247.75376123168, 49309.753451233235, 49468.75265623649, 49501.75249123731, 49625.255621165714, 57688.71155644195, 58049.4195058044, 58072.419275807544, 58075.12887306694, 58139.70930145322, 14597.41610335596, 14817.036892601946, 14860.70278594422, 15086.622834429008, 15092.64166225045, 9321.021292764297, 11320.830187547193, 11390.544378224944, 11393.14551408631, 11398.088152947745, 17773.822261777474, 18159.546011349557, 18408.631827363377, 18805.81194188068, 18813.435596932115, 6728.31792051987, 7007.474439417064, 7069.8939515907305, 7071.646417679199, 7091.6454177290925, 848.9830203395898, 894.8076163624852, 902.3605952588783, 929.869818225449, 987.3384832162325, 26692.866535667585, 27859.72140278612, 27863.16410507688, 28075.43849123047, 28281.858590706914, 967.1972263021676, 973.2262851033446, 977.0522593084696, 1044.6030508406757, 1060.3637817309707, 14256.786148207786, 14822.925885370503, 14827.851721482863, 14988.550343489713, 15146.848531514765, 390699.0, 391212.0, 391613.0, 393881.0, 395544.0, 47315.52684473111, 47793.28310075351, 47809.282860757114, 47870.76064619655, 47932.28101578479, 990.5146478225618, 1079.4440862955585, 1190.0776897904193, 1197.21582363552, 1225.540422341622, 23680.28959131229, 25971.740282596933, 26232.94125859472, 26398.20805375842, 26540.867295663396, 35856.4621530672, 35942.0, 36420.08949776277, 36463.27073458569, 36473.0, 247664.0, 248702.0, 249023.0, 249444.0, 249725.0, 19647.508812279808, 24017.159399420936, 24597.38506537351, 24618.753812462364, 24622.876885615457, 40473.1905361897, 41230.79384603058, 41413.0, 41559.1688166241, 42042.57957420387, 35233.47149792806, 35758.64241357553, 35910.8204458976, 36171.63828361788, 36396.454053188696, 35704.82147589349, 35911.46132808062, 36006.45990310095, 36135.0, 36161.45757813582, 30833.383332332778, 31336.843315783277, 31522.684773151974, 35178.0, 36325.45511817272, 31301.8434907824, 32516.0, 32537.67462325441, 32682.83658581692, 33039.174020649676, 24116.155934542207, 24921.376965576004, 25151.371215719755, 25308.367290817878, 25584.23247302584], "value": 17531.99242737125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.99644003559973, 357.6334257386178, 362.69171204476214, 364.6554006463891, 373.9719521035923, 15932.84067159328, 17283.481495555137, 17371.957682539025, 17839.464816055508, 17871.374501892435, 15018.249087545633, 15103.62240943977, 15132.16773077483, 15157.0, 15164.469243576477, 4283.721558098721, 4635.212013957618, 4635.443746750378, 4668.953310466886, 4689.437267527901, 3427.2288735034667, 3608.170120872201, 4609.377734005917, 5132.178851383779, 5396.271503347057, 5440.319960004999, 5442.12925931851, 5454.781808727646, 5457.426970168135, 5464.617476776627, 5267.578593712532, 5402.810901618444, 5433.347998240197, 5466.34403871534, 5475.972620136914, 5186.740662966837, 5227.869303267449, 5237.607179461517, 5251.0, 5251.711155886424, 11347.943260283728, 11976.640700778991, 12004.459799309052, 12008.879911200864, 12012.819807702892, 1849.676306646345, 1871.008365566252, 1922.2887531613253, 2101.95796084079, 2172.750133734625, 8841.55792210387, 8891.822163556693, 8931.106889311082, 9212.355135140542, 9324.067593240621, 1714.6827836850223, 1765.8145894681131, 1770.6016146367094, 1772.140511851751, 1781.6792977264088, 37419.62580374189, 37855.0, 56439.0, 57577.712111440014, 61134.38865611331, 9994.650187243411, 10072.395656260647, 10120.797584048425, 10155.39067655943, 10284.742881427874, 13335.533256335983, 13389.0, 13398.732025359439, 13415.664608384868, 13430.186924765227, 7263.309985551364, 7270.63646817657, 7403.888941665879, 7454.36637885775, 7491.10106787189, 6990.161180658353, 7010.193827709879, 7023.473239506955, 7134.857302853914, 7197.856042879218, 4227.112306415625, 4231.238377092153, 4262.296721041055, 4265.445492086071, 4269.103488267437, 1522.6600591479648, 1681.3946979087518, 1755.3329734700733, 1810.9637807244044, 1820.335577514198, 791.7664289034749, 885.9069797671281, 886.3263919421157, 895.6686026170229, 915.1854849184232, 16210.432634857723, 16548.089855058086, 16571.25429355682, 16610.916945415436, 17183.054931978862, 818.4352796570347, 834.2033358142959, 861.8319427711662, 863.8661007543841, 958.4872093429982, 9232.21526170283, 9517.90482095184, 9564.282678799118, 9566.808663826685, 9714.854277185848, 362541.0, 368135.0, 374555.0, 375935.0, 378756.0, 73177.63411183016, 73792.63103684447, 74276.62861685657, 75254.0, 76984.61507692537, 899.7120921305119, 914.9954250228707, 929.8884133903974, 936.1013427109915, 938.6198589571235, 13860.792088118485, 14811.777823332874, 14852.331645075781, 14864.479743208936, 15181.92409037992, 33420.16449588683, 34441.48337774885, 34535.82732086324, 34536.82731586326, 35534.822325888206, 44716.55283447124, 48082.0, 48593.5140648589, 48747.75626121847, 48750.756246218545, 7483.438742094474, 7504.512206706547, 7566.470347075652, 7773.844523109393, 7789.376849852111, 11825.763484730085, 11886.58396956137, 11941.76116477683, 11964.70088247766, 12128.186351431375, 5702.8651484498805, 9500.714978550655, 9538.332316738039, 9708.2718796092, 10067.647632332833, 9609.327347085637, 9849.26130540198, 10169.288149829441, 10559.841602376124, 10718.839217411902, 9009.504477253813, 9665.0, 9668.323217374716, 9773.511324433892, 10253.12848407864, 7628.160902300853, 7665.080190377191, 7740.806479837824, 7817.101033381234, 7827.5519028979825, 8680.826383472422, 8766.21104100634, 8980.371374003757, 9004.099590040943, 9482.857757133786], "value": 7782.428685683009, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.9159604625704, 1414.1868425655248, 1456.8907331950104, 1535.4856123198729, 1756.5520792197979, 6797.796066118019, 7621.8094547636265, 7856.0, 7865.646045927925, 8128.837423251532, 7819.100803407609, 7999.840003199933, 8004.799880003003, 8007.399445041616, 8009.399295052865, 1851.7685289338833, 2185.49733561281, 2213.2917466410713, 2258.9096436142536, 2262.45701031752, 2234.854734442256, 2262.230841513885, 2266.5920134375806, 2267.3764714703425, 2268.0587556164173, 2202.4383782135615, 2222.7332720073614, 2226.9109235630553, 2228.687983682286, 2229.643257078868, 1821.5992481654082, 2105.8315334773333, 2165.2638103044883, 2167.5556510915226, 2205.5588882223537, 2212.269950916194, 2230.9776902230933, 2236.4520692430297, 2238.3285014495586, 2242.8654280743044, 7902.4863383879865, 7952.483088599281, 7958.681652733883, 7972.720954766555, 7976.441649084566, 4427.468703755538, 4544.681872268942, 4550.8862278442975, 4554.089182163548, 4557.58981691646, 2734.6855111662217, 2802.9439411211865, 2891.6240888684547, 2931.7801164912717, 2933.369325594986, 921.4749589429438, 926.314527249837, 941.289326558444, 941.7268991992382, 951.8381875081184, 11007.61473348429, 11017.0, 11022.669319920335, 11023.99999999992, 11025.83461248082, 4298.140371925565, 4339.913201735948, 4426.977865110718, 4455.509893911667, 4465.977670111629, 9351.719448416557, 9352.766180845534, 9357.578908949114, 9368.0, 9383.0616938307, 4569.177548041384, 4569.748663823521, 4569.794359253841, 4573.771311434415, 4576.176288268077, 3546.184377593168, 3984.86052988144, 4063.89840253996, 4073.165001174752, 4122.2786012447705, 3744.6255374462335, 3761.774293542396, 3826.9043273918373, 3852.2488114817343, 3898.590647981978, 1209.12338554549, 1209.1475509765594, 1213.5873802906876, 1214.3199808107488, 1223.8653748087704, 786.7128498098267, 787.165604459275, 812.622130709223, 818.9672413103409, 827.3960009193322, 4928.753562321869, 5064.0, 5077.822276220315, 5173.63784535079, 5183.870403239949, 842.1957031035347, 899.8920129584492, 903.3405613901889, 909.7589138878203, 909.7998440343114, 3358.328334333143, 3446.0867870014467, 3473.89578312651, 3493.12671832042, 3561.928761424757, 9779.65771198019, 9940.552675129637, 10052.74868128288, 10095.0, 10106.646267380607, 9837.0, 9928.255380846465, 9944.602215911282, 9946.35348702332, 9977.80044399108, 7499.287567681062, 7523.699052037857, 7590.278923502258, 7633.389328853678, 7655.50239234448, 5118.616103792305, 5169.560587349967, 5181.844544663666, 5204.869878253074, 5226.137687281708, 8951.686690965786, 9183.403078799856, 9222.262219022328, 9344.672936447192, 9368.110029547182, 9306.208972237435, 9357.111074447917, 9371.765705857408, 9571.61713531451, 9651.903480965382, 5585.1901474286815, 6061.060535616986, 6219.968900155471, 6425.839354016187, 6553.4101930824545, 7583.976163218115, 7595.278448547379, 7654.502457340478, 7662.923370766444, 7663.655135518804, 6637.734490620321, 6816.931830681629, 6848.486363522856, 6907.03301537775, 6912.27421120775, 6756.45948324123, 6775.254721980479, 6780.796576102724, 6869.278725733926, 6910.2398736137975, 6312.873742525216, 6330.651814150266, 6375.713092910923, 6397.104405383343, 6556.672166391757, 4286.464191976003, 4342.109867477223, 4348.913021739484, 4351.521332653342, 4413.646908247269, 4396.4064851244675, 4467.865964021084, 4500.122476117126, 4559.680822342404, 4579.038401935498], "value": 4163.487123772147, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.8656388215598, 284.4766276588867, 285.04793988079814, 287.0198272898052, 287.57151843752814, 4770.689905156162, 4792.472827988919, 4821.807127714896, 4840.903181936364, 4843.39457567804, 4756.9286460703115, 4759.785809638566, 4770.284457331402, 4779.35478710374, 4801.495842936493, 3513.6135025147214, 3630.782153070811, 3634.109643137435, 3733.5146430964073, 3771.8868433947027, 3710.9404280624244, 3741.2330472253257, 3748.6626203641667, 3773.0, 3780.81095945203, 3549.6272891346425, 3736.178040831013, 3742.419924911643, 3745.8688945886897, 3746.7751934883995, 3569.3039857227723, 3706.3328600851837, 3707.29561383339, 3731.8507259709577, 3735.551733791935, 3277.1807048237943, 3280.6063272407223, 3287.852046657882, 3291.308825146722, 3293.8682452701864, 4501.887452813673, 4551.635869130495, 4563.292689633112, 4568.428946381702, 4595.058013107305, 3894.844206231747, 4159.958400415987, 4194.622483976456, 4236.406903033578, 4261.637760790337, 4995.950040499585, 5001.0, 5001.624878134155, 5021.6735912165595, 5037.370328708911, 3450.913727156841, 3475.4265546184847, 3479.8782042628386, 3486.7684681803667, 3488.529048578435, 5120.078385890538, 5239.240310155006, 5277.393099793535, 5281.366236051698, 5283.445238249967, 3573.5711714594413, 3588.3720348939355, 3588.766730162531, 3590.994521533975, 3592.173800026009, 3613.626821807749, 3617.602063772983, 3634.4184930411006, 3634.6547078027547, 3634.9636503635156, 4197.4753155855515, 4208.831646734157, 4214.17823524416, 4229.386738922839, 4236.385724069993, 4913.238448040559, 4991.301217829507, 5054.721990290495, 5080.085584594734, 5088.498892826625, 1243.2167734327315, 1243.533674871923, 1244.1912756708211, 1250.5435516036582, 1254.6988722706667, 781.9921800782033, 785.4894318692895, 825.1212458731552, 836.6987884361625, 840.5965136734402, 4371.213181627338, 4374.496932852762, 4386.166628340605, 4393.802278897458, 4405.449318835145, 5113.590912726973, 5126.7952031272625, 5130.256112863689, 5139.563137133311, 5154.0, 4196.055887425366, 4327.242732521796, 4374.737515749065, 4389.736615803062, 4397.84607538741, 2693.649825522709, 2719.864006799652, 2731.4537092581563, 2731.6995130535624, 2734.373048036415, 4797.0, 4811.831585894477, 4833.589144922721, 4838.346823178897, 4848.878778030577, 5102.107131252016, 5142.2286657001005, 5237.973810130925, 5266.894662106736, 5276.0, 4787.664863459594, 4821.360737349318, 4821.831235906727, 4828.637852161102, 4836.5888899443235, 5086.219823062047, 5103.336566246513, 5141.897162056663, 5147.40804807452, 5152.381714194321, 4777.7577829765205, 5024.346834911438, 5040.269160971712, 5045.94035252601, 5058.9494105058475, 4756.405449318835, 4783.569478746929, 4822.9758851206925, 4824.638152138534, 4834.516548345137, 3546.2375589248436, 3551.36075506401, 3566.7324950628285, 3576.481410195559, 3584.766990145632, 4881.975590122169, 5096.694198348111, 5121.308623335951, 5123.820666276662, 5129.179331306973, 4975.0547395994645, 4980.576650984707, 4987.276844857548, 4991.276264941491, 4997.350344455198, 4932.432770231326, 4958.42978057528, 4962.45413004562, 4971.154903666313, 4976.527229913152, 4650.186217411871, 4900.828471003498, 4901.803927842846, 4913.361263035782, 4947.975260123676, 4974.278729584263, 4992.600591952708, 4996.150654388835, 5007.349044624176, 5020.648554601289, 4859.659823812299, 4905.166121759238, 4907.263910413324, 4925.9014819704125, 4926.916078462733], "value": 3738.1976046116924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.8543920337526, 739.4704756995726, 739.5045319635843, 753.4688044928323, 759.4456047085628, 10889.727756806084, 11605.0, 11605.535778568847, 11667.591634292801, 11964.700882477942, 12634.11561190717, 12718.491260349574, 12721.872781272185, 12739.745205095916, 12753.872461275385, 630.1744714424119, 780.3912947900646, 796.7530065679643, 804.9839003219932, 816.0819078536646, 808.2200676347323, 808.7492877208084, 811.3022800391658, 811.3671336357651, 812.2405550809982, 850.5789634131114, 852.4373913217278, 852.7484392104313, 852.8209076094028, 852.9744107676779, 652.2368828470701, 824.3570015387947, 840.8528507511191, 847.4195176304252, 847.6058632735745, 608.4128815692833, 611.1749138662814, 611.5963464113709, 611.853155242743, 613.7238242790718, 12944.288064156468, 13083.215007099605, 13096.0, 13100.279484628341, 13102.0, 12395.938020309932, 12876.742465150644, 12979.480820767158, 13196.340182990813, 13225.875800556963, 9966.750831229278, 10029.949850250701, 10087.142592879614, 10307.587696492206, 10548.997845204693, 3265.689759472846, 3268.4607039838397, 3380.053584996205, 3383.9323213535836, 3399.4220982433044, 44231.115377692586, 44478.0, 44528.3320750189, 44551.55448445507, 44577.33134002992, 10018.699439016842, 10099.0, 10143.64497242593, 10501.0, 10533.578656853793, 17443.21505532254, 17641.823581764274, 17648.382306619464, 17649.205785739672, 17698.29206831738, 6645.900311495331, 6667.266600673922, 6672.199336079701, 6750.459963202932, 6869.690863911036, 3678.8160591970295, 3698.7410881238593, 3712.6287371263197, 3720.925581488355, 3827.7129215308964, 2736.097087960968, 2817.577363395466, 2822.1533539938346, 2823.6046953426535, 2826.759725423362, 506.57447743895307, 518.7769259218572, 529.5710474515655, 530.0697276280104, 531.2084993359866, 483.18824375049553, 508.2274942088006, 520.9192575150857, 530.2629345210161, 534.2973989204185, 6832.385085342343, 6853.965730171317, 6891.620960847202, 6975.476839236976, 6996.475264355092, 446.25920971187674, 459.5014409365809, 498.185466761847, 517.5083670513028, 519.5999080707909, 3305.371979323969, 3378.5607870976614, 3446.8965931022108, 3447.207142357272, 3508.6842184203542, 51790.52618422697, 52412.737936310834, 52560.0, 53261.467385326425, 53617.1957420639, 48747.512524875005, 48896.26655600169, 49473.0, 49505.50494495081, 49746.25380619294, 43388.132237355705, 44689.329660055126, 44741.0, 45305.320420193726, 45503.544964550594, 6550.63971481554, 6567.540272180901, 6577.3422657733845, 6640.83397915056, 6694.799156025327, 30323.393532128794, 30841.8457907718, 31427.0, 31651.841740791147, 31665.525017125223, 39524.20951580895, 39800.805975820775, 39881.0, 40067.79966100151, 40385.0, 9109.726708198765, 10000.24998125129, 10434.37393756377, 10497.9475102624, 10587.576496940035, 11048.834267486154, 11253.549858005916, 11275.336573487186, 11340.376279304717, 11533.308001519936, 10742.19433542503, 10773.353598784099, 10790.67627971162, 10861.619843305447, 11089.66730998039, 10502.68491945243, 10661.413622250851, 10780.730481738019, 10802.459877006275, 11069.280496767684, 10356.637517686844, 10543.683689489328, 10873.0, 10898.346099234072, 11091.556337746722, 9034.503102329172, 9085.500297483437, 9122.543872806466, 9445.669401571187, 9541.427514349161, 8954.955225223832, 9011.0, 9029.683961061332, 9096.090390960851, 9206.953965230132], "value": 5811.3565776744, "unit": "score"}], "name": "dromaeo_css", "value": 6208.60675030728, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 115.0, 113.0, 114.0, 113.0, 113.0, 115.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 131.0, 180.0, 130.0, 134.0, 164.0, 138.0, 181.0, 140.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 74.0, 75.0, 75.0, 75.0, 97.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 121.0, 84.0, 84.0, 86.0, 113.0, 84.0, 85.0, 129.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 65.0, 92.0, 64.0, 62.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 83.0, 83.0, 84.0, 82.0, 83.0, 84.0, 83.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 141.0, 140.0, 137.0, 136.0, 139.0, 146.0, 169.0, 134.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 173.0, 174.0, 175.0, 179.0, 176.0, 171.0, 173.0, 178.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 68.0, 67.0, 66.0, 67.0, 66.0, 69.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1557.6, "alertThreshold": 2.0}]} 21:52:01 INFO - Return code: 0 21:52:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:52:01 ERROR - # TBPL SUCCESS # 21:52:01 INFO - Running post-action listener: _resource_record_post_action 21:52:01 INFO - ##### 21:52:01 INFO - ##### Finished run-tests step (success) 21:52:01 INFO - ##### 21:52:01 INFO - Running post-run listener: _resource_record_post_run 21:52:01 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530833408; Read time: 16; Write time: 587864 21:52:01 INFO - TinderboxPrint: CPU usage
13.1% 21:52:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:52:01 INFO - TinderboxPrint: I/O write bytes / time
530,833,408 / 587,864 21:52:01 INFO - TinderboxPrint: CPU idle
8,330.6 (86.9%) 21:52:01 INFO - TinderboxPrint: CPU user
1,209.8 (12.6%) 21:52:01 INFO - TinderboxPrint: Swap in / out
0 / 0 21:52:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236806144; Read time: 0; Write time: 305988 21:52:01 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294027264; Read time: 16; Write time: 281876 21:52:01 INFO - Running post-run listener: _upload_blobber_files 21:52:01 INFO - Blob upload gear active. 21:52:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:52: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 21:52: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:52: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:52:02 INFO - (blobuploader) - INFO - Open directory for files ... 21:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:52:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:03 INFO - (blobuploader) - INFO - Done attempting. 21:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:52:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:06 INFO - (blobuploader) - INFO - Done attempting. 21:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:08 INFO - (blobuploader) - INFO - Done attempting. 21:52:08 INFO - (blobuploader) - INFO - Iteration through files over. 21:52:08 INFO - Return code: 0 21:52:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:52:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:52:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8556a7f7e319e6bb761a057a45f40f8f8eea64ed2a63674e694a7d36f6dca92392e3d43da7725357ea661f3d3d85a52d6a6a10108c75ef42f3eb3b55f6cfc38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09c793685d776ce18ed6430e67b26f25a8e6731ac93d6a838a62cf7a1580a93da8e4e162eb7c51792f297af78277837755bff36782da0b1f5e24b94fac51f8ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3cdba3143b3604d34d8060a87a25ec3b26282561b2aaab5a5d2b969fd91c31f7529ab92363f2eb6322fb5247f281d87a6f5dd33c942108c8c445b8ced2f9ddb"} 21:52:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:52:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:52:08 INFO - Contents: 21:52:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8556a7f7e319e6bb761a057a45f40f8f8eea64ed2a63674e694a7d36f6dca92392e3d43da7725357ea661f3d3d85a52d6a6a10108c75ef42f3eb3b55f6cfc38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09c793685d776ce18ed6430e67b26f25a8e6731ac93d6a838a62cf7a1580a93da8e4e162eb7c51792f297af78277837755bff36782da0b1f5e24b94fac51f8ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3cdba3143b3604d34d8060a87a25ec3b26282561b2aaab5a5d2b969fd91c31f7529ab92363f2eb6322fb5247f281d87a6f5dd33c942108c8c445b8ced2f9ddb"} 21:52:08 INFO - Running post-run listener: copy_logs_to_upload_dir 21:52:08 INFO - Copying logs to upload dir... 21:52:08 INFO - mkdir: /builds/slave/test/build/upload/logs 21:52:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.751660 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-25 21:52:08.679870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 21:52:08.684244) ========= 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=eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8556a7f7e319e6bb761a057a45f40f8f8eea64ed2a63674e694a7d36f6dca92392e3d43da7725357ea661f3d3d85a52d6a6a10108c75ef42f3eb3b55f6cfc38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09c793685d776ce18ed6430e67b26f25a8e6731ac93d6a838a62cf7a1580a93da8e4e162eb7c51792f297af78277837755bff36782da0b1f5e24b94fac51f8ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3cdba3143b3604d34d8060a87a25ec3b26282561b2aaab5a5d2b969fd91c31f7529ab92363f2eb6322fb5247f281d87a6f5dd33c942108c8c445b8ced2f9ddb"} build_url:https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/BBRybDs8Qbu0u6VS6Yw2Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8556a7f7e319e6bb761a057a45f40f8f8eea64ed2a63674e694a7d36f6dca92392e3d43da7725357ea661f3d3d85a52d6a6a10108c75ef42f3eb3b55f6cfc38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09c793685d776ce18ed6430e67b26f25a8e6731ac93d6a838a62cf7a1580a93da8e4e162eb7c51792f297af78277837755bff36782da0b1f5e24b94fac51f8ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3cdba3143b3604d34d8060a87a25ec3b26282561b2aaab5a5d2b969fd91c31f7529ab92363f2eb6322fb5247f281d87a6f5dd33c942108c8c445b8ced2f9ddb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 21:52:08.714009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:52:08.714351) ========= 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=eca2ab57546de7b41f256b19000001ef-1464236407.141023-520090442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:52:08.801379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 21:52:08.801712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 21:52:08.802011) ========= ========= Total master_lag: 0.19 =========