builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1463205865.08 results: success (0) buildid: 20160513203052 builduid: a7ce0406212944efbb072d3e148d0dde revision: 44dc9457053b0f6ecacbc01c7d11a8b457c3cb55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.080928) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.081514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.081814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.098680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.099033) ========= 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=df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 23:04:25-- 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% 40.4M=0s 2016-05-13 23:04:25 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.314217 ========= master_lag: 0.47 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.883043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.883367) ========= 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=df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016062 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.913495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:25.913802) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 44dc9457053b0f6ecacbc01c7d11a8b457c3cb55 --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 44dc9457053b0f6ecacbc01c7d11a8b457c3cb55 --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=df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 23:04:26,215 truncating revision to first 12 chars 2016-05-13 23:04:26,216 Setting DEBUG logging. 2016-05-13 23:04:26,216 attempt 1/10 2016-05-13 23:04:26,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/44dc9457053b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 23:04:26,699 unpacking tar archive at: fx-team-44dc9457053b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:26.740217) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:26.740558) ========= script_repo_revision: 44dc9457053b0f6ecacbc01c7d11a8b457c3cb55 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:26.740960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:26.741227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 23:04:26.749319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-13 23:04:26.749618) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:04:27 INFO - MultiFileLogger online at 20160513 23:04:27 in /builds/slave/test 23:04:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:04:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:04:27 INFO - {'append_to_log': False, 23:04:27 INFO - 'base_work_dir': '/builds/slave/test', 23:04:27 INFO - 'blob_upload_branch': 'Fx-Team', 23:04:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:04:27 INFO - 'branch': 'Fx-Team', 23:04:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:04:27 INFO - 'config_files': ('talos/linux_config.py',), 23:04:27 INFO - 'default_actions': ('clobber', 23:04:27 INFO - 'read-buildbot-config', 23:04:27 INFO - 'download-and-extract', 23:04:27 INFO - 'populate-webroot', 23:04:27 INFO - 'create-virtualenv', 23:04:27 INFO - 'install', 23:04:27 INFO - 'run-tests'), 23:04:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:04:27 INFO - 'download_minidump_stackwalk': True, 23:04:27 INFO - 'download_symbols': 'ondemand', 23:04:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:04:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:04:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:04:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:04:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:04:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:04:27 INFO - 'installer_path': 'installer.exe', 23:04:27 INFO - 'log_level': 'info', 23:04:27 INFO - 'log_name': 'talos', 23:04:27 INFO - 'log_to_console': True, 23:04:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:04:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:04:27 INFO - 'opt_config_files': (), 23:04:27 INFO - 'pip_index': False, 23:04:27 INFO - 'sps_profile': False, 23:04:27 INFO - 'sps_profile_interval': 0, 23:04:27 INFO - 'suite': 'dromaeojs', 23:04:27 INFO - 'system_bits': '32', 23:04:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:04:27 INFO - 'title': 'talos-linux64-ix-021', 23:04:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:04:27 INFO - 'use_talos_json': True, 23:04:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:04:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:04:27 INFO - 'work_dir': 'build'} 23:04:27 INFO - ##### 23:04:27 INFO - ##### Running clobber step. 23:04:27 INFO - ##### 23:04:27 INFO - Running pre-action listener: _resource_record_pre_action 23:04:27 INFO - Running main action method: clobber 23:04:27 INFO - rmtree: /builds/slave/test/build 23:04:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:04:28 INFO - Running post-action listener: _resource_record_post_action 23:04:28 INFO - ##### 23:04:28 INFO - ##### Finished clobber step (success) 23:04:28 INFO - ##### 23:04:28 INFO - ##### 23:04:28 INFO - ##### Running read-buildbot-config step. 23:04:28 INFO - ##### 23:04:28 INFO - Running pre-action listener: _resource_record_pre_action 23:04:28 INFO - Running main action method: read_buildbot_config 23:04:28 INFO - Using buildbot properties: 23:04:28 INFO - { 23:04:28 INFO - "project": "", 23:04:28 INFO - "product": "firefox", 23:04:28 INFO - "script_repo_revision": "production", 23:04:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:04:28 INFO - "repository": "", 23:04:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:04:28 INFO - "buildid": "20160513203052", 23:04:28 INFO - "pgo_build": "True", 23:04:28 INFO - "basedir": "/builds/slave/test", 23:04:28 INFO - "buildnumber": 85, 23:04:28 INFO - "slavename": "talos-linux64-ix-021", 23:04:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:04:28 INFO - "platform": "ubuntu64_hw", 23:04:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:04:28 INFO - "branch": "fx-team", 23:04:28 INFO - "repo_path": "integration/fx-team", 23:04:28 INFO - "revision": "44dc9457053b0f6ecacbc01c7d11a8b457c3cb55", 23:04:28 INFO - "stage_platform": "linux64-pgo", 23:04:28 INFO - "builduid": "a7ce0406212944efbb072d3e148d0dde", 23:04:28 INFO - "slavebuilddir": "test" 23:04:28 INFO - } 23:04:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:04:28 INFO - Running post-action listener: _resource_record_post_action 23:04:28 INFO - ##### 23:04:28 INFO - ##### Finished read-buildbot-config step (success) 23:04:28 INFO - ##### 23:04:28 INFO - ##### 23:04:28 INFO - ##### Running download-and-extract step. 23:04:28 INFO - ##### 23:04:28 INFO - Running pre-action listener: _resource_record_pre_action 23:04:28 INFO - Running main action method: download_and_extract 23:04:28 INFO - mkdir: /builds/slave/test/build/tests 23:04:28 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')]} 23:04:28 INFO - https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:38 INFO - Downloaded 1361 bytes. 23:04:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:38 INFO - Using the following test package requirements: 23:04:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:04:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:04:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'jsshell-linux-x86_64.zip'], 23:04:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:04:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:04:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:04:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:04:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:04:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:04: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')]} 23:04:38 INFO - https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:52 INFO - Downloaded 24022480 bytes. 23:04:52 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'] 23:04:52 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 23:04:53 INFO - Return code: 0 23:04:53 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 23:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:53 INFO - https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:55 INFO - Downloaded 24022480 bytes. 23:04:55 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'] 23:04:55 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 23:04:56 INFO - Return code: 0 23:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:56 INFO - https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:57 INFO - Downloaded 10840194 bytes. 23:04:57 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'] 23:04:57 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 23:04:58 INFO - Return code: 0 23:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:58 INFO - https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:04:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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 23:04:59 INFO - Downloaded 58395874 bytes. 23:04:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:59 INFO - mkdir: /builds/slave/test/properties 23:04:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:04:59 INFO - Writing to file /builds/slave/test/properties/build_url 23:04:59 INFO - Contents: 23:04:59 INFO - build_url:https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:05:00 INFO - Running post-action listener: _resource_record_post_action 23:05:00 INFO - Running post-action listener: set_extra_try_arguments 23:05:00 INFO - ##### 23:05:00 INFO - ##### Finished download-and-extract step (success) 23:05:00 INFO - ##### 23:05:00 INFO - ##### 23:05:00 INFO - ##### Running populate-webroot step. 23:05:00 INFO - ##### 23:05:00 INFO - Running pre-action listener: _resource_record_pre_action 23:05:00 INFO - Running main action method: populate_webroot 23:05:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:00 INFO - '--tppagecycles', 23:05:00 INFO - '7'], 23:05:00 INFO - 'tests': ['tsvgm']}}, 23:05:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:05:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:05:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:05:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['damp', 'tps']}, 23:05:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'tests': ['damp', 'tps']}, 23:05:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['dromaeo_dom']}, 23:05:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['a11yr', 23:05:00 INFO - 'ts_paint', 23:05:00 INFO - 'tpaint', 23:05:00 INFO - 'sessionrestore', 23:05:00 INFO - 'sessionrestore_no_auto_restore', 23:05:00 INFO - 'tabpaint']}, 23:05:00 INFO - 'other-e10s': {'tests': ['a11yr', 23:05:00 INFO - 'ts_paint', 23:05:00 INFO - 'tpaint', 23:05:00 INFO - 'sessionrestore', 23:05:00 INFO - 'sessionrestore_no_auto_restore', 23:05:00 INFO - 'tabpaint']}, 23:05:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:05:00 INFO - 'ts_paint', 23:05:00 INFO - 'tpaint', 23:05:00 INFO - 'sessionrestore', 23:05:00 INFO - 'sessionrestore_no_auto_restore', 23:05:00 INFO - 'tabpaint']}, 23:05:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:05:00 INFO - 'ts_paint', 23:05:00 INFO - 'tpaint', 23:05:00 INFO - 'sessionrestore', 23:05:00 INFO - 'sessionrestore_no_auto_restore', 23:05:00 INFO - 'tabpaint']}, 23:05:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['a11yr', 23:05:00 INFO - 'ts_paint', 23:05:00 INFO - 'tpaint', 23:05:00 INFO - 'sessionrestore', 23:05:00 INFO - 'sessionrestore_no_auto_restore', 23:05:00 INFO - 'tabpaint']}, 23:05:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['a11yr', 23:05:00 INFO - 'ts_paint', 23:05:00 INFO - 'tpaint', 23:05:00 INFO - 'sessionrestore', 23:05:00 INFO - 'sessionrestore_no_auto_restore', 23:05:00 INFO - 'tabpaint']}, 23:05:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['tsvgx', 23:05:00 INFO - 'tsvgr_opacity', 23:05:00 INFO - 'tart', 23:05:00 INFO - 'tscrollx', 23:05:00 INFO - 'cart']}, 23:05:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:05:00 INFO - 'tsvgr_opacity', 23:05:00 INFO - 'tart', 23:05:00 INFO - 'tscrollx', 23:05:00 INFO - 'cart']}, 23:05:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'talos_options': ['--disable-e10s'], 23:05:00 INFO - 'tests': ['tp5o']}, 23:05:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'tests': ['tp5o']}, 23:05:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'talos_options': ['--disable-e10s', 23:05:00 INFO - '--xperf_path', 23:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:00 INFO - 'tests': ['tp5n']}, 23:05:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:00 INFO - 'talos_options': ['--xperf_path', 23:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:00 INFO - 'tests': ['tp5n']}}, 23:05:00 INFO - 'talos.zip': {'path': '', 23:05:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:00 INFO - Running post-action listener: _resource_record_post_action 23:05:00 INFO - ##### 23:05:00 INFO - ##### Finished populate-webroot step (success) 23:05:00 INFO - ##### 23:05:00 INFO - ##### 23:05:00 INFO - ##### Running create-virtualenv step. 23:05:00 INFO - ##### 23:05:00 INFO - Running pre-action listener: _resource_record_pre_action 23:05:00 INFO - Running main action method: create_virtualenv 23:05:00 INFO - Creating virtualenv /builds/slave/test/build/venv 23:05:00 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 23:05:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:05:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:00 INFO - Using real prefix '/usr' 23:05:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:05:00 INFO - Installing distribute.............................................................................................................................................................................................done. 23:05:02 INFO - Installing pip.................done. 23:05:02 INFO - Return code: 0 23:05:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:02 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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:02 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 23:05:02 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 23:05:02 INFO - Using env: {'DISPLAY': ':0', 23:05:02 INFO - 'HOME': '/home/cltbld', 23:05:02 INFO - 'LANG': 'en_US.UTF-8', 23:05:02 INFO - 'LANGUAGE': 'en_US:en', 23:05:02 INFO - 'LOGNAME': 'cltbld', 23:05:02 INFO - 'MAIL': '/var/mail/cltbld', 23:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:02 INFO - 'MOZ_NO_REMOTE': '1', 23:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:02 INFO - 'NO_EM_RESTART': '1', 23:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:02 INFO - 'PWD': '/builds/slave/test', 23:05:02 INFO - 'SHELL': '/bin/bash', 23:05:02 INFO - 'SHLVL': '1', 23:05:02 INFO - 'TERM': 'linux', 23:05:02 INFO - 'TMOUT': '86400', 23:05:02 INFO - 'USER': 'cltbld', 23:05:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:02 INFO - '_': '/tools/buildbot/bin/python'} 23:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:02 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 23:05:02 INFO - Cleaning up... 23:05:02 INFO - Return code: 0 23:05:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:02 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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:02 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 23:05:02 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 23:05:02 INFO - Using env: {'DISPLAY': ':0', 23:05:02 INFO - 'HOME': '/home/cltbld', 23:05:02 INFO - 'LANG': 'en_US.UTF-8', 23:05:02 INFO - 'LANGUAGE': 'en_US:en', 23:05:02 INFO - 'LOGNAME': 'cltbld', 23:05:02 INFO - 'MAIL': '/var/mail/cltbld', 23:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:02 INFO - 'MOZ_NO_REMOTE': '1', 23:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:02 INFO - 'NO_EM_RESTART': '1', 23:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:02 INFO - 'PWD': '/builds/slave/test', 23:05:02 INFO - 'SHELL': '/bin/bash', 23:05:02 INFO - 'SHLVL': '1', 23:05:02 INFO - 'TERM': 'linux', 23:05:02 INFO - 'TMOUT': '86400', 23:05:02 INFO - 'USER': 'cltbld', 23:05:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:02 INFO - '_': '/tools/buildbot/bin/python'} 23:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:03 INFO - Downloading/unpacking psutil>=3.1.1 23:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:05 INFO - Installing collected packages: psutil 23:05:05 INFO - Running setup.py install for psutil 23:05:05 INFO - building 'psutil._psutil_linux' extension 23:05:05 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 23:05:05 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 23:05:05 INFO - building 'psutil._psutil_posix' extension 23:05:05 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 23:05:05 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 23:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:05 INFO - Successfully installed psutil 23:05:05 INFO - Cleaning up... 23:05:05 INFO - Return code: 0 23:05:05 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 23:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 23:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.1 23:05:05 INFO - Using env: {'DISPLAY': ':0', 23:05:05 INFO - 'HOME': '/home/cltbld', 23:05:05 INFO - 'LANG': 'en_US.UTF-8', 23:05:05 INFO - 'LANGUAGE': 'en_US:en', 23:05:05 INFO - 'LOGNAME': 'cltbld', 23:05:05 INFO - 'MAIL': '/var/mail/cltbld', 23:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:05 INFO - 'MOZ_NO_REMOTE': '1', 23:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:05 INFO - 'NO_EM_RESTART': '1', 23:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:05 INFO - 'PWD': '/builds/slave/test', 23:05:05 INFO - 'SHELL': '/bin/bash', 23:05:05 INFO - 'SHLVL': '1', 23:05:05 INFO - 'TERM': 'linux', 23:05:05 INFO - 'TMOUT': '86400', 23:05:05 INFO - 'USER': 'cltbld', 23:05:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:05 INFO - '_': '/tools/buildbot/bin/python'} 23:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:05 INFO - Downloading/unpacking mozsystemmonitor==0.1 23:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:07 INFO - Downloading mozsystemmonitor-0.1.tar.gz 23:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 23:05:07 INFO - Installing collected packages: mozsystemmonitor 23:05:07 INFO - Running setup.py install for mozsystemmonitor 23:05:07 INFO - Successfully installed mozsystemmonitor 23:05:07 INFO - Cleaning up... 23:05:08 INFO - Return code: 0 23:05:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:05:08 INFO - Using env: {'DISPLAY': ':0', 23:05:08 INFO - 'HOME': '/home/cltbld', 23:05:08 INFO - 'LANG': 'en_US.UTF-8', 23:05:08 INFO - 'LANGUAGE': 'en_US:en', 23:05:08 INFO - 'LOGNAME': 'cltbld', 23:05:08 INFO - 'MAIL': '/var/mail/cltbld', 23:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:08 INFO - 'MOZ_NO_REMOTE': '1', 23:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:08 INFO - 'NO_EM_RESTART': '1', 23:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:08 INFO - 'PWD': '/builds/slave/test', 23:05:08 INFO - 'SHELL': '/bin/bash', 23:05:08 INFO - 'SHLVL': '1', 23:05:08 INFO - 'TERM': 'linux', 23:05:08 INFO - 'TMOUT': '86400', 23:05:08 INFO - 'USER': 'cltbld', 23:05:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:08 INFO - '_': '/tools/buildbot/bin/python'} 23:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:08 INFO - Downloading/unpacking blobuploader==1.2.4 23:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:10 INFO - Downloading blobuploader-1.2.4.tar.gz 23:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:05:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:05:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 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 23:05:10 INFO - Downloading docopt-0.6.1.tar.gz 23:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:05:10 INFO - Installing collected packages: blobuploader, requests, docopt 23:05:10 INFO - Running setup.py install for blobuploader 23:05:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:05:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:05:10 INFO - Running setup.py install for requests 23:05:11 INFO - Running setup.py install for docopt 23:05:11 INFO - Successfully installed blobuploader requests docopt 23:05:11 INFO - Cleaning up... 23:05:11 INFO - Return code: 0 23:05:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:11 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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:11 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 23:05:11 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 23:05:11 INFO - Using env: {'DISPLAY': ':0', 23:05:11 INFO - 'HOME': '/home/cltbld', 23:05:11 INFO - 'LANG': 'en_US.UTF-8', 23:05:11 INFO - 'LANGUAGE': 'en_US:en', 23:05:11 INFO - 'LOGNAME': 'cltbld', 23:05:11 INFO - 'MAIL': '/var/mail/cltbld', 23:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:11 INFO - 'MOZ_NO_REMOTE': '1', 23:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:11 INFO - 'NO_EM_RESTART': '1', 23:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:11 INFO - 'PWD': '/builds/slave/test', 23:05:11 INFO - 'SHELL': '/bin/bash', 23:05:11 INFO - 'SHLVL': '1', 23:05:11 INFO - 'TERM': 'linux', 23:05:11 INFO - 'TMOUT': '86400', 23:05:11 INFO - 'USER': 'cltbld', 23:05:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:11 INFO - '_': '/tools/buildbot/bin/python'} 23:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:05:11 INFO - Running setup.py (path:/tmp/pip-uvBbRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:05:11 INFO - Running setup.py (path:/tmp/pip-uNl10r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:05:11 INFO - Running setup.py (path:/tmp/pip-RJbDtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:05:11 INFO - Running setup.py (path:/tmp/pip-a397MC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:05:12 INFO - Running setup.py (path:/tmp/pip-cL9xjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:05:12 INFO - Running setup.py (path:/tmp/pip-xIMRy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:05:12 INFO - Running setup.py (path:/tmp/pip-UuQsZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:05:12 INFO - Running setup.py (path:/tmp/pip-Jia5SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:05:12 INFO - Running setup.py (path:/tmp/pip-SQxiBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:05:12 INFO - Running setup.py (path:/tmp/pip-6BFFrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:05:12 INFO - Running setup.py (path:/tmp/pip-LBzA44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:05:12 INFO - Running setup.py (path:/tmp/pip-km2E3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:05:12 INFO - Running setup.py (path:/tmp/pip-oKkjFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:05:12 INFO - Running setup.py (path:/tmp/pip-Osyd24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:12 INFO - Running setup.py (path:/tmp/pip-U2Tuh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:05:12 INFO - Running setup.py (path:/tmp/pip-ulpQEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:05:12 INFO - Running setup.py (path:/tmp/pip-nsSifI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:05:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:05:12 INFO - Running setup.py install for manifestparser 23:05:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Running setup.py install for mozcrash 23:05:13 INFO - Running setup.py install for mozdebug 23:05:13 INFO - Running setup.py install for mozdevice 23:05:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Running setup.py install for mozfile 23:05:13 INFO - Running setup.py install for mozhttpd 23:05:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Running setup.py install for mozinfo 23:05:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Running setup.py install for mozInstall 23:05:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Running setup.py install for mozleak 23:05:13 INFO - Running setup.py install for mozlog 23:05:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:05:13 INFO - Running setup.py install for moznetwork 23:05:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:05:14 INFO - Running setup.py install for mozprocess 23:05:14 INFO - Running setup.py install for mozprofile 23:05:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:05:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:05:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:05:14 INFO - Running setup.py install for mozrunner 23:05:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:05:14 INFO - Running setup.py install for mozscreenshot 23:05:14 INFO - Running setup.py install for moztest 23:05:14 INFO - Running setup.py install for mozversion 23:05:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:05:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:05:14 INFO - Cleaning up... 23:05:14 INFO - Return code: 0 23:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:14 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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:14 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 23:05:14 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 23:05:14 INFO - Using env: {'DISPLAY': ':0', 23:05:14 INFO - 'HOME': '/home/cltbld', 23:05:14 INFO - 'LANG': 'en_US.UTF-8', 23:05:14 INFO - 'LANGUAGE': 'en_US:en', 23:05:14 INFO - 'LOGNAME': 'cltbld', 23:05:14 INFO - 'MAIL': '/var/mail/cltbld', 23:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:14 INFO - 'MOZ_NO_REMOTE': '1', 23:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:14 INFO - 'NO_EM_RESTART': '1', 23:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:14 INFO - 'PWD': '/builds/slave/test', 23:05:14 INFO - 'SHELL': '/bin/bash', 23:05:14 INFO - 'SHLVL': '1', 23:05:14 INFO - 'TERM': 'linux', 23:05:14 INFO - 'TMOUT': '86400', 23:05:14 INFO - 'USER': 'cltbld', 23:05:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:14 INFO - '_': '/tools/buildbot/bin/python'} 23:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:05:14 INFO - Running setup.py (path:/tmp/pip-rEyqmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:05:15 INFO - Running setup.py (path:/tmp/pip-MsNv0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:05:15 INFO - Running setup.py (path:/tmp/pip-T6YLJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:05:15 INFO - Running setup.py (path:/tmp/pip-hdmpMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:05:15 INFO - Running setup.py (path:/tmp/pip-Yle314-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:05:15 INFO - Running setup.py (path:/tmp/pip-kjTlSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:05:15 INFO - Running setup.py (path:/tmp/pip-5Zw8mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:05:15 INFO - Running setup.py (path:/tmp/pip-Fsx4Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:05:15 INFO - Running setup.py (path:/tmp/pip-kvz4Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:05:15 INFO - Running setup.py (path:/tmp/pip-GpHWAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:05:15 INFO - Running setup.py (path:/tmp/pip-OvBCzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:05:15 INFO - Running setup.py (path:/tmp/pip-VJ_b5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:05:15 INFO - Running setup.py (path:/tmp/pip-qOFlEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:05:15 INFO - Running setup.py (path:/tmp/pip-sKVrEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:05:15 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)) 23:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:15 INFO - Running setup.py (path:/tmp/pip-IT6G9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:16 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)) 23:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:05:16 INFO - Running setup.py (path:/tmp/pip-qsiYhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:05:16 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)) 23:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:05:16 INFO - Running setup.py (path:/tmp/pip-nS6REC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:05:16 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)) 23:05:16 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)) 23:05:16 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)) 23:05:16 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)) 23:05:16 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)) 23:05:16 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)) 23:05:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:05:16 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 23:05:16 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 23:05:16 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 23:05:16 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 23:05:16 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 23:05:16 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 23:05:18 INFO - Downloading blessings-1.6.tar.gz 23:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:05:18 INFO - Installing collected packages: blessings 23:05:18 INFO - Running setup.py install for blessings 23:05:18 INFO - Successfully installed blessings 23:05:18 INFO - Cleaning up... 23:05:18 INFO - Return code: 0 23:05:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:05:18 INFO - Reading from file tmpfile_stdout 23:05:18 INFO - Current package versions: 23:05:18 INFO - argparse == 1.2.1 23:05:18 INFO - blessings == 1.6 23:05:18 INFO - blobuploader == 1.2.4 23:05:18 INFO - docopt == 0.6.1 23:05:18 INFO - manifestparser == 1.1 23:05:18 INFO - mozInstall == 1.12 23:05:18 INFO - mozcrash == 0.17 23:05:18 INFO - mozdebug == 0.1 23:05:18 INFO - mozdevice == 0.48 23:05:18 INFO - mozfile == 1.2 23:05:18 INFO - mozhttpd == 0.7 23:05:18 INFO - mozinfo == 0.9 23:05:18 INFO - mozleak == 0.1 23:05:18 INFO - mozlog == 3.2 23:05:18 INFO - moznetwork == 0.27 23:05:18 INFO - mozprocess == 0.22 23:05:18 INFO - mozprofile == 0.28 23:05:18 INFO - mozrunner == 6.11 23:05:18 INFO - mozscreenshot == 0.1 23:05:18 INFO - mozsystemmonitor == 0.1 23:05:18 INFO - moztest == 0.7 23:05:18 INFO - mozversion == 1.4 23:05:18 INFO - psutil == 3.1.1 23:05:18 INFO - requests == 1.2.3 23:05:18 INFO - wsgiref == 0.1.2 23:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05:18 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')]} 23:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:18 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')]} 23:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:18 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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:18 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 23:05:18 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 23:05:18 INFO - Using env: {'DISPLAY': ':0', 23:05:18 INFO - 'HOME': '/home/cltbld', 23:05:18 INFO - 'LANG': 'en_US.UTF-8', 23:05:18 INFO - 'LANGUAGE': 'en_US:en', 23:05:18 INFO - 'LOGNAME': 'cltbld', 23:05:18 INFO - 'MAIL': '/var/mail/cltbld', 23:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:18 INFO - 'MOZ_NO_REMOTE': '1', 23:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:18 INFO - 'NO_EM_RESTART': '1', 23:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:18 INFO - 'PWD': '/builds/slave/test', 23:05:18 INFO - 'SHELL': '/bin/bash', 23:05:18 INFO - 'SHLVL': '1', 23:05:18 INFO - 'TERM': 'linux', 23:05:18 INFO - 'TMOUT': '86400', 23:05:18 INFO - 'USER': 'cltbld', 23:05:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:18 INFO - '_': '/tools/buildbot/bin/python'} 23:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 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)) 23:05:18 INFO - Cleaning up... 23:05:18 INFO - Return code: 0 23:05:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:05:18 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')]} 23:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:18 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')]} 23:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:18 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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:18 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 23:05:18 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 23:05:18 INFO - Using env: {'DISPLAY': ':0', 23:05:18 INFO - 'HOME': '/home/cltbld', 23:05:18 INFO - 'LANG': 'en_US.UTF-8', 23:05:18 INFO - 'LANGUAGE': 'en_US:en', 23:05:18 INFO - 'LOGNAME': 'cltbld', 23:05:18 INFO - 'MAIL': '/var/mail/cltbld', 23:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:18 INFO - 'MOZ_NO_REMOTE': '1', 23:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:18 INFO - 'NO_EM_RESTART': '1', 23:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:18 INFO - 'PWD': '/builds/slave/test', 23:05:18 INFO - 'SHELL': '/bin/bash', 23:05:18 INFO - 'SHLVL': '1', 23:05:18 INFO - 'TERM': 'linux', 23:05:18 INFO - 'TMOUT': '86400', 23:05:18 INFO - 'USER': 'cltbld', 23:05:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:18 INFO - '_': '/tools/buildbot/bin/python'} 23:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:19 INFO - Downloading/unpacking jsonschema 23:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:05:21 INFO - Downloading/unpacking functools32 (from jsonschema) 23:05:21 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 23:05:21 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 23:05:21 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 23:05:21 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 23:05:21 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 23:05:21 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 23:05:21 INFO - Downloading functools32-3.2.3-2.tar.gz 23:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:05:21 INFO - warning: no files found matching '*.txt' 23:05:21 INFO - no previously-included directories found matching 'build' 23:05:21 INFO - no previously-included directories found matching 'dist' 23:05:21 INFO - no previously-included directories found matching '.git*' 23:05:21 INFO - Installing collected packages: jsonschema, functools32 23:05:21 INFO - Running setup.py install for functools32 23:05:21 INFO - warning: no files found matching '*.txt' 23:05:21 INFO - no previously-included directories found matching 'build' 23:05:21 INFO - no previously-included directories found matching 'dist' 23:05:21 INFO - no previously-included directories found matching '.git*' 23:05:21 INFO - Successfully installed jsonschema functools32 23:05:21 INFO - Cleaning up... 23:05:21 INFO - Return code: 0 23:05:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:05:21 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')]} 23:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:21 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')]} 23:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:21 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 0x7f5747be9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, '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': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', '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 23:05:21 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 23:05:21 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 23:05:21 INFO - Using env: {'DISPLAY': ':0', 23:05:21 INFO - 'HOME': '/home/cltbld', 23:05:21 INFO - 'LANG': 'en_US.UTF-8', 23:05:21 INFO - 'LANGUAGE': 'en_US:en', 23:05:21 INFO - 'LOGNAME': 'cltbld', 23:05:21 INFO - 'MAIL': '/var/mail/cltbld', 23:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:21 INFO - 'MOZ_NO_REMOTE': '1', 23:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:21 INFO - 'NO_EM_RESTART': '1', 23:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:21 INFO - 'PWD': '/builds/slave/test', 23:05:21 INFO - 'SHELL': '/bin/bash', 23:05:21 INFO - 'SHLVL': '1', 23:05:21 INFO - 'TERM': 'linux', 23:05:21 INFO - 'TMOUT': '86400', 23:05:21 INFO - 'USER': 'cltbld', 23:05:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:21 INFO - '_': '/tools/buildbot/bin/python'} 23:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:21 INFO - Downloading/unpacking flake8 23:05:21 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 23:05:21 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 23:05:21 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 23:05:21 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 23:05:21 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 23:05:21 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 23:05:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:05:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:05:23 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 23:05:23 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 23:05:23 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 23:05:23 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 23:05:23 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 23:05:23 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 23:05:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:05:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:05:23 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 23:05:23 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 23:05:23 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 23:05:23 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 23:05:23 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 23:05:23 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 23:05:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:05:24 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 23:05:24 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 23:05:24 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 23:05:24 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 23:05:24 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 23:05:24 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 23:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:05:24 INFO - no previously-included directories found matching 'docs/_build' 23:05:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:05:24 INFO - Running setup.py install for pep8 23:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:05:24 INFO - no previously-included directories found matching 'docs/_build' 23:05:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:05:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:05:24 INFO - Cleaning up... 23:05:24 INFO - Return code: 0 23:05:24 INFO - Running post-action listener: _resource_record_post_action 23:05:24 INFO - Running post-action listener: _start_resource_monitoring 23:05:24 INFO - Starting resource monitoring. 23:05:24 INFO - ##### 23:05:24 INFO - ##### Finished create-virtualenv step (success) 23:05:24 INFO - ##### 23:05:24 INFO - ##### 23:05:24 INFO - ##### Running install step. 23:05:24 INFO - ##### 23:05:24 INFO - Running pre-action listener: _resource_record_pre_action 23:05:24 INFO - Running main action method: install 23:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:05:25 INFO - Reading from file tmpfile_stdout 23:05:25 INFO - Detecting whether we're running mozinstall >=1.0... 23:05:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:05:25 INFO - Reading from file tmpfile_stdout 23:05:25 INFO - Output received: 23:05:25 INFO - Usage: mozinstall [options] installer 23:05:25 INFO - Options: 23:05:25 INFO - -h, --help show this help message and exit 23:05:25 INFO - -d DEST, --destination=DEST 23:05:25 INFO - Directory to install application into. [default: 23:05:25 INFO - "/builds/slave/test"] 23:05:25 INFO - --app=APP Application being installed. [default: firefox] 23:05:25 INFO - mkdir: /builds/slave/test/build/application 23:05:25 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'] 23:05:25 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 23:05:41 INFO - Reading from file tmpfile_stdout 23:05:41 INFO - Output received: 23:05:41 INFO - /builds/slave/test/build/application/firefox/firefox 23:05:41 INFO - Running post-action listener: _resource_record_post_action 23:05:41 INFO - ##### 23:05:41 INFO - ##### Finished install step (success) 23:05:41 INFO - ##### 23:05:41 INFO - ##### 23:05:41 INFO - ##### Running run-tests step. 23:05:41 INFO - ##### 23:05:41 INFO - Running pre-action listener: _resource_record_pre_action 23:05:41 INFO - Running main action method: run_tests 23:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:05:41 INFO - Python 2.7.3 23:05:41 INFO - Return code: 0 23:05:41 INFO - grabbing minidump binary from tooltool 23:05: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')]} 23:05:41 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 0x1b3c9c0>, '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 0x1b3d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:05:41 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 23:05:41 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 23:05:41 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 23:05:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:05:42 INFO - Return code: 0 23:05:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:05:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:05:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:05:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:05:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:05:42 INFO - Return code: 0 23:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 23:05:42 INFO - Using env: {'DISPLAY': ':0', 23:05:42 INFO - 'HOME': '/home/cltbld', 23:05:42 INFO - 'LANG': 'en_US.UTF-8', 23:05:42 INFO - 'LANGUAGE': 'en_US:en', 23:05:42 INFO - 'LOGNAME': 'cltbld', 23:05:42 INFO - 'MAIL': '/var/mail/cltbld', 23:05:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:05:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:42 INFO - 'MOZ_NO_REMOTE': '1', 23:05:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:42 INFO - 'NO_EM_RESTART': '1', 23:05:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:42 INFO - 'PWD': '/builds/slave/test', 23:05:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:05:42 INFO - 'SHELL': '/bin/bash', 23:05:42 INFO - 'SHLVL': '1', 23:05:42 INFO - 'TERM': 'linux', 23:05:42 INFO - 'TMOUT': '86400', 23:05:42 INFO - 'USER': 'cltbld', 23:05:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742', 23:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:42 INFO - '_': '/tools/buildbot/bin/python'} 23:05:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:05:43 INFO - mozversion application_buildid: 20160513203052 23:05:43 INFO - mozversion application_changeset: 44dc9457053b0f6ecacbc01c7d11a8b457c3cb55 23:05:43 INFO - mozversion application_display_name: Nightly 23:05:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:05:43 INFO - mozversion application_name: Firefox 23:05:43 INFO - mozversion application_remotingname: firefox 23:05:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:05:43 INFO - mozversion application_vendor: Mozilla 23:05:43 INFO - mozversion application_version: 49.0a1 23:05:43 INFO - mozversion platform_buildid: 20160513203052 23:05:43 INFO - mozversion platform_changeset: 44dc9457053b0f6ecacbc01c7d11a8b457c3cb55 23:05:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:05:43 INFO - mozversion platform_version: 49.0a1 23:05:43 INFO - using testdate: 1463205943 23:05:43 INFO - actual date: 1463205943 23:05:43 INFO - starting webserver on 'localhost:39206' 23:05:43 INFO - SUITE-START | Running 2 tests 23:05:43 INFO - TEST-START | dromaeo_css 23:05:43 INFO - operating with platform_type : linux_ 23:05:43 INFO - Initialising browser for dromaeo_css test... 23:05:43 INFO - TEST-INFO | started process 14155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYSba6r/profile http://localhost:39206/getInfo.html) 23:05:48 INFO - PROCESS | 14155 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 23:05:48 INFO - PROCESS | 14155 | __metrics Screen width/height:1600/1200 23:05:48 INFO - PROCESS | 14155 | colorDepth:24 23:05:48 INFO - PROCESS | 14155 | Browser inner width/height: 1024/697 23:05:48 INFO - PROCESS | 14155 | __metrics 23:05:50 ERROR - PROCESS | 14155 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:05:50 INFO - PROCESS | 14155 | console.error: PushService: 23:05:50 INFO - PROCESS | 14155 | stateChangeProcessEnqueue: Error transitioning state 23:05:50 INFO - PROCESS | 14155 | UnknownError 23:05:51 INFO - TEST-INFO | 14155: exit 0 23:05:51 INFO - Browser initialized. 23:05:51 INFO - Running cycle 1/1 for dromaeo_css test... 23:05:51 INFO - TEST-INFO | started process 14239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYSba6r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:02 INFO - PROCESS | 14239 | RSS: Main: 153075712 23:06:02 INFO - PROCESS | 14239 | 23:06:54 INFO - PROCESS | 14239 | 1463206014177 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] 23:09:02 INFO - PROCESS | 14239 | Cycle 1(1): loaded http://localhost:39206/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39206/tests/dromaeo/cssquery-ext.html) 23:09:03 INFO - PROCESS | 14239 | RSS: Main: 280174592 23:09:03 INFO - PROCESS | 14239 | 23:12:05 INFO - PROCESS | 14239 | Cycle 1(1): loaded http://localhost:39206/tests/dromaeo/cssquery-ext.html (next: http://localhost:39206/tests/dromaeo/cssquery-jquery.html) 23:12:06 INFO - PROCESS | 14239 | RSS: Main: 236228608 23:12:06 INFO - PROCESS | 14239 | 23:15:08 INFO - PROCESS | 14239 | Cycle 1(1): loaded http://localhost:39206/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39206/tests/dromaeo/cssquery-mootools.html) 23:15:08 INFO - PROCESS | 14239 | RSS: Main: 237740032 23:15:08 INFO - PROCESS | 14239 | 23:18:10 INFO - PROCESS | 14239 | Cycle 1(1): loaded http://localhost:39206/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39206/tests/dromaeo/cssquery-prototype.html) 23:18:11 INFO - PROCESS | 14239 | RSS: Main: 231903232 23:18:11 INFO - PROCESS | 14239 | 23:21:14 INFO - PROCESS | 14239 | Cycle 1(1): loaded http://localhost:39206/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39206/tests/dromaeo/cssquery-yui.html) 23:21:14 INFO - PROCESS | 14239 | RSS: Main: 210157568 23:21:14 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | Cycle 1(1): loaded http://localhost:39206/tests/dromaeo/cssquery-yui.html (next: http://localhost:39206/tests/dromaeo/cssquery-dojo.html) 23:24:17 INFO - PROCESS | 14239 | RSS: Main: 278659072 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | __start_tp_report 23:24:17 INFO - PROCESS | 14239 | _x_x_mozilla_page_load 23:24:17 INFO - PROCESS | 14239 | _x_x_mozilla_page_load_details 23:24:17 INFO - PROCESS | 14239 | |i|pagename|runs| 23:24:17 INFO - PROCESS | 14239 | |0;dojo.html;3163.620365556133;3194.5048517479786;3206.326671399007;3218.7907785993925;3249.0577732457573;5217.243499692542;5281.498257665526;5324.201369794528;5428.375736790265;5448.809291674792;5263.31576895004;5309.150535914255;5312.92030619541;5337.572994160468;5346.8395948121615;4790.065937142267;4866.221404575269;4925.433575138851;4949.133901567229;4964.304997300363;4906.190478571031;4967.7019378837385;4977.6266779991465;4982.775775090112;4986.650934434573;4805.063012712522;4845.636577256702;4876.683015603992;4896.02079584081;4952.851414457572;4835.153848076608;4835.443923948756;4840.419149702023;4907.533784290486;4986.127427700138;4830.9275360869615;4883.682560633548;4885.5358740919555;4889.657723959324;4910.656254062217;5154.639175257696;5177.352830896138;5255.1329030709885;5273.7626806793405;5353.330833645794;5733.254676892019;5740.942590574083;5779.075347944351;5786.421357864222;5791.797287094932;5773.682447465388;5780.5953583248765;5784.82645520635;5816.738246778905;5842.97078514609;5197.948020519822;5365.356157261114;5365.892682146375;5414.458554144633;5419.458054194589;5952.226210592596;5957.344692083867;6000.069989151689;6005.669688167105;6012.579119461596;5731;5768.855778605568;5769.826905192851;5772;5779.422057794187;5641.605087643826;5709.200711900337;5757.596968212269;5761.279840019997;5852.4440178183;5785.537157027427;5787.623804452697;5787.884242315215;5795.971020144872;5826.854328641733;5740.368559458456;5787.797427090031;5788.218590490314;5797.594168408171;5798.797042103506;4201.516825565038;4312.611864932172;4359.542248063971;4366.345048242725;4406.449193850769;3898.1229223424502;3912.217556488714;3916.3538016227003;3937.350337194388;3946.5264168299414;5456.935897500029;5460.180972854024;5461.290032295856;5465.152901300305;5469.726513674301;5618.803341883015;5688;5763.6541807491685;5768.826935191951;5827.533797296206;5419.945800542023;5448.809291674773;5449.754761035763;5456.727163641802;5457.372402173722;4687.835925742583;4822.541858523435;4838.758062096881;4839.395075615548;4877.463479017305;5896.262967129109;5920.526357891358;5956.910646340309;5988.490978266809;5999.130126131774;5791.623544469596;5796.62321949072;5797.594168408171;5800.76796928135;5804.65172089676;5765.855853603525;5828.475437210672;5904.940950590439;5917.615355001911;5921.496672782861;5577.693226872561;5615.578831587729;5642.322921249476;5648.88702225945;5684.090545512699;5684.204211410323;5729.914051289317;5740.712964351682;5740.937926483447;5750.769969201185;5513.5037846594;5529.391766905556;5557.472040156179;5594.888102238014;5617.88764224705;5610.270664813548;5610.4670056344585;5615.410381909841;5616.522595579258;5655.293088363955;5482.725863706719;5515.944840551543;5516.255305533701;5519.503244707835;5525.613207075627;5488.17677348401;5511.807086751945;5562.833115006556;5598.468145526169;5678.403767604507;5409.107497262908;5435.10320797064;5437.075697131418;5472.452754724655;5529.253550770594 23:24:17 INFO - PROCESS | 14239 | |1;ext.html;579.898517759392;620.8106527509109;633.7401665317218;639.2584601861839;664.6278084272805;31441;31896.840515797416;43363.34954975674;44593.33110003344;44603.107937841225;42417;47014.29478557824;47023.29465058027;47064.2940355895;47097.29354059692;9043.276537876955;9198.77003074925;9203.17171454569;9205.171534561889;9206.953965230165;8944.15030572098;9053.999999999967;9059.818803623924;9060.818783624323;9062.410943288698;9051.321150913675;9093.09069093092;9097.22673572747;9098.909010909905;9100.180983711465;9044.547772611377;9089.863652045224;9098.272138228926;9102.226310763594;9102.681406150752;8806.603702833389;8865.423747456394;8874.689385871528;8890.466572005636;8890.555472226362;42551.7872410636;42857;42913.35629965553;42997;43025.13949720988;3590.8922732318074;3694.8891533253777;3779.2441511697493;3981;4289.335153051282;32372;33087.6691233087;33213.833930830435;33300.16749581256;34553;4236.724612900151;4402.097569998143;4445.644348452116;4462.598366147063;4468.977655111737;237172;237691.81154094293;238522;238559;239494;52197.73901130546;59667.403325967054;60614.696926515084;60649.96750162474;60652.786944260864;52615.47537508583;53090;53716.73141634267;59217.40782592119;59268;16833.41083062087;17288.740668889975;17318.82681173172;17328.39350622722;17331.220095095498;13653.590392288248;13815.930920345334;13817.654558636115;13824.585262442142;13826.239556824472;15919.761203581955;18105.275788968294;18172.454826354966;18199;18880.43358699241;6357.427831495188;6454.6449945252525;6613.702383392759;6678.666066696645;6699.899501507482;1006.6527048168371;1025.8102251083574;1086.0659832544006;1089.6404186618397;1096.627146770086;33093.66906330906;33109.3378132436;33661.66338336634;33722.662773372445;34026.659733402346;1126.774645070989;1138.9658310250707;1173.8826117388194;1190.2798806721808;1265.221888538542;17483.737743933852;17736.20187091584;17784.817400080985;17796.733049004277;17868.49841022258;494414;501665;502430;753628;754187;58000.4199957995;58849.705751471825;59044.40955590475;59109.40890591125;59111.40888591059;1454.8181477315336;1456.7232225877049;1462.6928345047659;1465.8167729033871;1470.3603932289489;32073.518897217025;34100.65899340975;34201.82899085488;34258.65741342555;34698;51921.70195745137;52228.73885630548;52282.908683653746;52399.476005240984;52465.73767131293;428030;429131;430927;432314;433466;28421.573676395285;28580.714192857806;29207.561886571293;29301;29329.266768330963;41796.58203417927;43765.56234437615;48436.273455898896;48864.51135488742;53842.46157538374;40287.39568906528;41480.37779433371;41708.374374385014;41984;42409;41058.384124237564;41252.1749565013;41496.792516037225;41580.79209604054;42184.36723449089;42146.7892660547;42693.35959960665;42868;42987.3551896728;43208.35187472127;35218.82390588031;36920.44619330658;37017.25965480729;37759.62240377671;37957.810210948766;28998.855005724836;29105.85447072751;29393.55909661314;29411.705882940896;29525.704742952297 23:24:17 INFO - PROCESS | 14239 | |2;jquery.html;396.44893597898914;400.92582872168634;407.27301766347057;408.53223059596763;418.1615860200298;12816.323129834225;17842;19378.12798424071;19381;19773.406797796055;15051.473198438056;17184.312627494885;18366.26534938601;18947.90526047368;19240.51898702533;5510.9448905510935;5722.256106706143;5746.425357464241;5748;5770.394108618598;5665.12190610456;5684.147377893308;5685.715714214293;5696.3733989261145;5706.77172913083;3963.960360396388;4143.937840932388;5944.464998150165;6253.718582663768;6277.340879207663;6194.4115309045565;6252.937470625304;6278.811635650938;6306.1171435998995;6309.400606942333;5435.510804027656;5487.945120548783;5509.47659972302;5563.499285064364;5571.108622620402;21149.68275475869;22373.664395034088;22457.32628021162;23263;23326.533469330687;2223.7331520217676;2313.664518644804;2616.882240299191;2668.866556672159;2825.4207887383036;9716.465594392306;10217.744556386075;10299.124574411184;10629.415382153978;10814.188935829765;1874.953126171843;1923.6922092465138;1955.4720225539168;1960.4510736993664;2104.042660589428;74229.62885185593;78083.60958195172;79515.60242198753;84923.15076849214;87357;11229.943850280697;11270.492827822767;11395.715107122389;11517.136214783757;11560.132990025613;15715;15818.288177032062;15868.04791712501;15870.761938570931;15960.441384551485;8174.918250817415;8219.931408916802;8362.289205417486;8522.914770852212;8557.614907329185;8007.599620019092;8023.1575684553445;8057.113717491071;8183.631736571869;8183.95908020456;4472.172648060119;4849.750667053083;4940.07264224942;4997.600191984705;5029.5221953914315;1877.6714075036814;1985.3150663021236;2004.178286902363;2072.336852207309;2130.957380852405;984.2863923655293;1011.3375738891039;1084.837274408845;1096.7641956979287;1146.5070019891527;18052.18765155545;18542.907285463487;18546.81453185451;18990;19707.507312317306;1014.3913651808856;1017.801528701896;1027.6454623155;1097.2812807611028;1098.6374496416324;10796;11217.270877392943;11236.83144752813;11244.606438774603;11294.265872718248;359205;360912;361533;498343;499844;96371;100252;102107;103260;104442.47778761058;1055.472263868066;1071.276888100529;1077.7305673581604;1111.2388014210292;1113.142879982409;17392;17408.036785285985;17509.38717144894;17810.5547361317;17832.465026049238;40285.39571906365;41758;42150.36774448447;42501;43660.56339436692;58574;58709;59017.704911475164;59204.70397647984;61345.69327153335;7601.277878601524;8693.478391296543;8927.598258078531;9058.411203271766;9202.493862837608;11554;13407.932960335136;13453.529126480526;13634;13663.428705698972;11038.44807759625;11807.586734464252;11925.582604609144;11953.581624643095;12079.57721479744;11711.590094346657;11958.820617690915;12025.699357515781;12128.454219559964;12341.691457713629;12139.817902731642;12154.574589889311;12176.512939482322;12363.134580579273;12621.305828179538;7571.697132114654;7795.688172473037;7803.960980195063;8121.1472795358;8604.956975215084;10825.837612435977;11661.533538658698;11686.824697629712;11691.532338706356;11719.41402929833 23:24:17 INFO - PROCESS | 14239 | |3;mootools.html;1387.6114687887396;1554.5647218778743;1573.881958853086;1765.6468706258752;1870.9812901870985;8603.440776349533;9000.279977601793;9002.234810041145;9263.536823158849;9265.861012084808;9019.098090190977;9253.537323133833;9256.814863702739;9262.166405023547;9262.814743705121;2122.4587730128796;2180.8364372672036;2183.2031308572336;2370.7155141382973;2400.135951057618;2370.8814559272055;2438.3782135555407;2440.255722004788;2455.1284294075613;2461.6307553866886;2347.2371479269223;2350.459394339303;2368.0291080656934;2375.1686909581595;2382.523495300938;2081.8334533237303;2263.8528495647893;2377.2986968844148;2415.68596082509;2416.142269494331;2411.7347091819884;2423.4547226873988;2423.8182136339847;2448.09420514409;2452.7424620414777;9013.459192448408;9057.954710226473;9061.773455663595;9062.592183351764;9082.500462474562;5367.865803354908;5527.806526771584;5528.585356098269;5534.391216966131;5539.058360078796;3328.7170590499836;3361;3520.4015317395847;3524.3832329342263;3531.770434921722;1206.318430086998;1251.2117366059415;1259.0431272233077;1260.9684757881034;1280.6414204022794;12702.555410560586;12707.618771436872;12751.10742248043;12755.936220318932;12764.553240636626;4826.251930950708;4841.225403935354;4847.515248475124;4856.17445034345;4950.009998000342;10748.462576871125;10768.192385571114;10769.946150269356;10770.353778773298;10780.946095269474;5403.594730395236;5405.324334458192;5405.891882162335;5411.18832175169;5413.377461591888;4434.82260709568;4861.562459378673;4956.504349565014;5004.174311238678;5033.496650335011;4144.088300573869;4179.456670632799;4232.238197124547;4234.87295381139;4279.422277992431;1325.721598464314;1353.8578449262686;1367.09771550776;1370.328539015875;1380.8481067082612;888.3470649072926;993.2451336983944;994.3337963564429;998.6804222648828;1009.7021378693303;5996.580239383288;6094.116353128771;6203.720832562545;6313.147725057151;6367.713452894631;961.9134277915022;995.2088089968348;1022.2844009193594;1024.5543188712934;1050.112654806687;4076.6534844537955;4119.855805046869;4139.151473947833;4145.751254924654;4175.144095460423;11918.880811191777;12335.753284934251;12356.814647780291;12385.566505172275;12414.441350139265;11955.760884782256;12087;12171.634850954486;12196.57311994076;12257.938710306391;8305.169483051646;8521.403501754941;8661.826763464822;8665.653373864974;8765.868511972198;5992.490638295793;6102.816915492543;6106.664133472524;6124.5406594506485;6127.172831667668;10768.676939691823;10783.892161078602;10793.406362649815;10897.237193396702;10915.727106822393;10528.157747380037;10889.292196007234;11071.335719856834;11182.888171118184;11185.384803835866;7083.114610673666;7499.137599176164;7787.338076263581;7796.415268854972;8010.038795344363;9045.77385565366;9058.184763371064;9088.409253398508;9111.772205694911;9111.908880911105;7935.920640793518;8124.187581241828;8157.918420815953;8170.754877353689;8345.123762004901;8018.959905200437;8064.395170362129;8106.47307924983;8188.959055204686;8244.267223174627;6987.637410704864;7000.264972178052;7020.262872398324;7053.576785392893;7136.678849451683;4941.431735350337;4947.876303092451;5091.567216786615;5142.485751424977;5161.638685291993;5121.718305493085;5128.076946149728;5220.425753167225;5234.2672025915645;5275.472452754694 23:24:17 INFO - PROCESS | 14239 | |4;prototype.html;320.3544857112918;323.8218979561241;325.49548200289547;329.5995365630759;329.7708092875452;5367.892642147155;5405.270313499682;5421.241026256317;5427.701476418795;5431.375391829941;5270.341207349082;5303;5366.677999320043;5370.570354371651;5413.160960051188;3963.9405408918888;4026.5772093930154;4155.625993660585;4156.418101465797;4157.48031496063;4092.3656833190903;4108.4864391951005;4139.79301034947;4155.854545090922;4161.895952601179;3988.9202215955665;4127.979360103211;4132.173565286939;4143.254214241435;4143.7720925349095;4051.817668204938;4174.728642638234;4188.602082802129;4191.601797829232;4213.873583792491;3695.7228207884245;3712.4988126602834;3723.422869455239;3746.8688595899284;3757.436384542313;5160.92258616121;5166.250893620404;5168.767405466763;5172.2241663750365;5210.400803907562;4483.646085804946;4749.26386410107;4749.453812811502;4761.761911904426;4763.928541071887;5518;5549.472800083986;5569.415211402785;5574.414686457904;5619.578531610146;4013.7190396672245;4036.1524079943247;4054.5134583850127;4066.1867626474527;4107.342825147962;5645.76992088127;5804.506616937565;5805.82582522525;5808.6224395414165;5810.559564982717;4072.633462988286;4075.9388609170887;4090.343410918583;4090.5295890972325;4094.9385759213637;4071.816768245377;4093.3655283431117;4112.794360281974;4134.338505839051;4151.709380343347;4560.722997560688;4723.0789995951145;4741.857744267678;4741.960956788614;4774.976125119352;5521.420250873601;5525.834224973257;5541.639793413496;5555.638883472561;5568.192612071227;1417.2984372735561;1419.8012278281049;1426.915544186426;1447.6742732885227;1453.273363318341;922.6125027488337;938.877945867033;957.9616815327308;982.9606815727434;986.7385142937128;5360.1239566151535;5456.099743542271;5465.9180112298345;5471;5476.890462190734;5683.630564013409;5694.316681998104;5743.9425605744245;5787.797427090031;5791.507721843691;5319.28189694394;5368.489993450616;5455.954017243534;5457.426970168154;5482.451754824486;3001.2196828824663;3045.8324792136646;3058.801177923428;3059.6787337329706;3068.6777888321403;5784.421557844182;5800.767969281182;5920.407959204132;5941.940580594139;5947.5539334550085;5784.739686714108;5790.36306006339;5800.9129863052085;5803.767849285981;5839.9124013139835;5767.307923049177;5780.393058728857;5831.329397119301;5868.501177399883;5901.40985901415;5471.604740791073;5605.467480589337;5657.858553536194;5666.433356664301;5716.456936591017;5594.216809646734;5596.356419011866;5616;5641.210230567642;5669.291338582677;5661.603687741818;5846.678432686073;5905;5930.851728706817;5938.495227905676;4154.273002224538;4170.562090980404;4189.120284740238;4192.580741925783;4221.7255878367805;5519.39286678473;5709.9714501427225;5747.195392645117;5784.50831679312;5842.5325973921135;5289.312389389354;5574.331080270394;5605.5235304997905;5607.943920560742;5613.073842815889;5566.88254577438;5567.415421380697;5612.635178713371;5618.381977982337;5629.493345598916;5456.072467680583;5457.972710136424;5495.890082198413;5519.902437073886;5549.139883318092;5453.509184173444;5616.634918730269;5634.1548767683535;5638;5647.6893770843;5509.641873278224;5514.558835293247;5535.612507124462;5536.52939500147;5544.390117087037 23:24:17 INFO - PROCESS | 14239 | |5;yui.html;756.2890882570383;792.4452882981914;820.2453742556845;852.9189726975935;888.409207876762;15001.39994400224;15506.224688765558;15675.372985080612;15695.607609809746;15701.607459813482;14438.27808609568;14488.927555362208;14489.420423183086;14519.274036298195;14521.709565808704;685.2770327304692;797.5812698333364;821.909589945104;825.9297959673405;836.4521238588734;819.7622689420061;824.8474032304043;827.3257295304307;827.6813426830653;828.0187977246951;879.4327658660193;880.4189235104832;881.3037700216821;881.576843115305;881.858902575588;732.4689600039982;749.9737509187207;750.951188172767;843.8902942617482;871.0984131423977;634.7397566997555;635.6662752055162;635.7171058878755;636.2015670333701;638.8434833465784;14339.42642294307;14359;14361.49734759289;14380.209088500233;14386.496472623408;14229.928850355785;14237.359318830677;14282.3572939218;14374.856251437457;14426.92786536071;10992.340459572451;11156.386398748065;12784.744305113845;13045.804312935314;13138.86861131386;4571.26859702446;4586.923592659724;4640.721556706575;4642.814287428499;4707.788149533245;59083.40916590822;59585.40414595842;60474;60594.09108863371;60786.39213607896;10910;11121.054710349548;11139.108871290277;11228.887711122785;11280.492377843017;18964.905175474036;18980.240790368232;18981.62036759285;19010.04949752507;19027;7809.3752499799875;7909.644066017043;8034.758957231293;8093.919060809317;8159.714409995621;4704.811807527729;4748.966214809192;4848.296996935424;4856.8785780355065;4935.185694360463;3329.583802024747;3401.2687272236094;3411.5394421752744;3412.709919656857;3416.9487457688156;606.3481757111123;608.9786857459968;614.1003429975108;622.8380621038563;624.5191202773839;698.678607840389;741.4253953186324;769.2384539306047;771.7453240430644;784.9803754906059;9571.28215383849;9851.310408271353;10004.949975250223;10028.899711002796;10099.798004040025;610.4414460768347;678.7352932356386;704.9130755922544;718.5904034700171;732.6776218463859;4554.908901822011;4953.529414705597;4982.800687972441;4986.401631804134;5147.150720131136;72623.6368818163;76843.61578192073;76941.61529192318;77156.2284377149;77511.79905607538;65853.670731647;66108;67109.66445167742;68109.3189068103;69822.3017769826;56465.04744667834;56588.43411565914;57498.7125064372;58564;59558.999999999134;10131.64539241123;10364.119049880543;10388.532516036948;10390.58437662485;10430;37722.24555508819;37773.62226377701;38666.80666596649;38849.41725874058;38995.41506877342;46806.53193468158;52482.212766809294;53605.73197133989;53867;54320.45679543154;12308.81536776967;12639.873601264237;12694.873051269738;12790.104692671424;13394.397252123872;12960.157589756636;14397.784033239719;14816.703665926836;15288.770668440206;15335.616609584404;13903;14033.29833508341;14136.293185340897;14497.420103195755;14765.483208087666;13592.32038398096;13790.65523361924;14103.365348559135;14221.360038798071;14223.786643200154;12391.75216495647;12872.485100596246;13259.734805304033;13698;13708.24604646754;9870.161036311994;9987;10186.694399168036;10600.628977985734;10775.461226938778;10241.129503992244;10272.024157705006;10278.588856445958;10279.434631095362;10294 23:24:17 INFO - PROCESS | 14239 | __end_tp_report 23:24:17 INFO - PROCESS | 14239 | __start_cc_report 23:24:17 INFO - PROCESS | 14239 | _x_x_mozilla_cycle_collect,1073 23:24:17 INFO - PROCESS | 14239 | __end_cc_report 23:24:17 INFO - PROCESS | 14239 | __startTimestamp1463207057593__endTimestamp 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | ------- Summary: start ------- 23:24:17 INFO - PROCESS | 14239 | Number of tests: 6 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | [#0] dojo.html Cycles:165 Average:5333.46 Median:5513.50 stddev:604.33 (11.0%) stddev-sans-first:581.72 23:24:17 INFO - PROCESS | 14239 | Values: 3163.6 3194.5 3206.3 3218.8 3249.1 5217.2 5281.5 5324.2 5428.4 5448.8 5263.3 5309.2 5312.9 5337.6 5346.8 4790.1 4866.2 4925.4 4949.1 4964.3 4906.2 4967.7 4977.6 4982.8 4986.7 4805.1 4845.6 4876.7 4896.0 4952.9 4835.2 4835.4 4840.4 4907.5 4986.1 4830.9 4883.7 4885.5 4889.7 4910.7 5154.6 5177.4 5255.1 5273.8 5353.3 5733.3 5740.9 5779.1 5786.4 5791.8 5773.7 5780.6 5784.8 5816.7 5843.0 5197.9 5365.4 5365.9 5414.5 5419.5 5952.2 5957.3 6000.1 6005.7 6012.6 5731.0 5768.9 5769.8 5772.0 5779.4 5641.6 5709.2 5757.6 5761.3 5852.4 5785.5 5787.6 5787.9 5796.0 5826.9 5740.4 5787.8 5788.2 5797.6 5798.8 4201.5 4312.6 4359.5 4366.3 4406.4 3898.1 3912.2 3916.4 3937.4 3946.5 5456.9 5460.2 5461.3 5465.2 5469.7 5618.8 5688.0 5763.7 5768.8 5827.5 5419.9 5448.8 5449.8 5456.7 5457.4 4687.8 4822.5 4838.8 4839.4 4877.5 5896.3 5920.5 5956.9 5988.5 5999.1 5791.6 5796.6 5797.6 5800.8 5804.7 5765.9 5828.5 5904.9 5917.6 5921.5 5577.7 5615.6 5642.3 5648.9 5684.1 5684.2 5729.9 5740.7 5740.9 5750.8 5513.5 5529.4 5557.5 5594.9 5617.9 5610.3 5610.5 5615.4 5616.5 5655.3 5482.7 5515.9 5516.3 5519.5 5525.6 5488.2 5511.8 5562.8 5598.5 5678.4 5409.1 5435.1 5437.1 5472.5 5529.3 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | [#1] ext.html Cycles:180 Average:59001.68 Median:42622.57 stddev:121442.09 (284.9%) stddev-sans-first:121703.55 23:24:17 INFO - PROCESS | 14239 | Values: 579.9 620.8 633.7 639.3 664.6 31441.0 31896.8 43363.3 44593.3 44603.1 42417.0 47014.3 47023.3 47064.3 47097.3 9043.3 9198.8 9203.2 9205.2 9207.0 8944.2 9054.0 9059.8 9060.8 9062.4 9051.3 9093.1 9097.2 9098.9 9100.2 9044.5 9089.9 9098.3 9102.2 9102.7 8806.6 8865.4 8874.7 8890.5 8890.6 42551.8 42857.0 42913.4 42997.0 43025.1 3590.9 3694.9 3779.2 3981.0 4289.3 32372.0 33087.7 33213.8 33300.2 34553.0 4236.7 4402.1 4445.6 4462.6 4469.0 237172.0 237691.8 238522.0 238559.0 239494.0 52197.7 59667.4 60614.7 60650.0 60652.8 52615.5 53090.0 53716.7 59217.4 59268.0 16833.4 17288.7 17318.8 17328.4 17331.2 13653.6 13815.9 13817.7 13824.6 13826.2 15919.8 18105.3 18172.5 18199.0 18880.4 6357.4 6454.6 6613.7 6678.7 6699.9 1006.7 1025.8 1086.1 1089.6 1096.6 33093.7 33109.3 33661.7 33722.7 34026.7 1126.8 1139.0 1173.9 1190.3 1265.2 17483.7 17736.2 17784.8 17796.7 17868.5 494414.0 501665.0 502430.0 753628.0 754187.0 58000.4 58849.7 59044.4 59109.4 59111.4 1454.8 1456.7 1462.7 1465.8 1470.4 32073.5 34100.7 34201.8 34258.7 34698.0 51921.7 52228.7 52282.9 52399.5 52465.7 428030.0 429131.0 430927.0 432314.0 433466.0 28421.6 28580.7 29207.6 29301.0 29329.3 41796.6 43765.6 48436.3 48864.5 53842.5 40287.4 41480.4 41708.4 41984.0 42409.0 41058.4 41252.2 41496.8 41580.8 42184.4 42146.8 42693.4 42868.0 42987.4 43208.4 35218.8 36920.4 37017.3 37759.6 37957.8 28998.9 29105.9 29393.6 29411.7 29525.7 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | [#2] jquery.html Cycles:180 Average:27223.85 Median:11626.86 stddev:70258.85 (604.3%) stddev-sans-first:70427.07 23:24:17 INFO - PROCESS | 14239 | Values: 396.4 400.9 407.3 408.5 418.2 12816.3 17842.0 19378.1 19381.0 19773.4 15051.5 17184.3 18366.3 18947.9 19240.5 5510.9 5722.3 5746.4 5748.0 5770.4 5665.1 5684.1 5685.7 5696.4 5706.8 3964.0 4143.9 5944.5 6253.7 6277.3 6194.4 6252.9 6278.8 6306.1 6309.4 5435.5 5487.9 5509.5 5563.5 5571.1 21149.7 22373.7 22457.3 23263.0 23326.5 2223.7 2313.7 2616.9 2668.9 2825.4 9716.5 10217.7 10299.1 10629.4 10814.2 1875.0 1923.7 1955.5 1960.5 2104.0 74229.6 78083.6 79515.6 84923.2 87357.0 11229.9 11270.5 11395.7 11517.1 11560.1 15715.0 15818.3 15868.0 15870.8 15960.4 8174.9 8219.9 8362.3 8522.9 8557.6 8007.6 8023.2 8057.1 8183.6 8184.0 4472.2 4849.8 4940.1 4997.6 5029.5 1877.7 1985.3 2004.2 2072.3 2131.0 984.3 1011.3 1084.8 1096.8 1146.5 18052.2 18542.9 18546.8 18990.0 19707.5 1014.4 1017.8 1027.6 1097.3 1098.6 10796.0 11217.3 11236.8 11244.6 11294.3 359205.0 360912.0 361533.0 498343.0 499844.0 96371.0 100252.0 102107.0 103260.0 104442.5 1055.5 1071.3 1077.7 1111.2 1113.1 17392.0 17408.0 17509.4 17810.6 17832.5 40285.4 41758.0 42150.4 42501.0 43660.6 58574.0 58709.0 59017.7 59204.7 61345.7 7601.3 8693.5 8927.6 9058.4 9202.5 11554.0 13407.9 13453.5 13634.0 13663.4 11038.4 11807.6 11925.6 11953.6 12079.6 11711.6 11958.8 12025.7 12128.5 12341.7 12139.8 12154.6 12176.5 12363.1 12621.3 7571.7 7795.7 7804.0 8121.1 8605.0 10825.8 11661.5 11686.8 11691.5 11719.4 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | [#3] mootools.html Cycles:180 Average:6072.76 Median:4833.74 stddev:3541.48 (73.3%) stddev-sans-first:3533.91 23:24:17 INFO - PROCESS | 14239 | Values: 1387.6 1554.6 1573.9 1765.6 1871.0 8603.4 9000.3 9002.2 9263.5 9265.9 9019.1 9253.5 9256.8 9262.2 9262.8 2122.5 2180.8 2183.2 2370.7 2400.1 2370.9 2438.4 2440.3 2455.1 2461.6 2347.2 2350.5 2368.0 2375.2 2382.5 2081.8 2263.9 2377.3 2415.7 2416.1 2411.7 2423.5 2423.8 2448.1 2452.7 9013.5 9058.0 9061.8 9062.6 9082.5 5367.9 5527.8 5528.6 5534.4 5539.1 3328.7 3361.0 3520.4 3524.4 3531.8 1206.3 1251.2 1259.0 1261.0 1280.6 12702.6 12707.6 12751.1 12755.9 12764.6 4826.3 4841.2 4847.5 4856.2 4950.0 10748.5 10768.2 10769.9 10770.4 10780.9 5403.6 5405.3 5405.9 5411.2 5413.4 4434.8 4861.6 4956.5 5004.2 5033.5 4144.1 4179.5 4232.2 4234.9 4279.4 1325.7 1353.9 1367.1 1370.3 1380.8 888.3 993.2 994.3 998.7 1009.7 5996.6 6094.1 6203.7 6313.1 6367.7 961.9 995.2 1022.3 1024.6 1050.1 4076.7 4119.9 4139.2 4145.8 4175.1 11918.9 12335.8 12356.8 12385.6 12414.4 11955.8 12087.0 12171.6 12196.6 12257.9 8305.2 8521.4 8661.8 8665.7 8765.9 5992.5 6102.8 6106.7 6124.5 6127.2 10768.7 10783.9 10793.4 10897.2 10915.7 10528.2 10889.3 11071.3 11182.9 11185.4 7083.1 7499.1 7787.3 7796.4 8010.0 9045.8 9058.2 9088.4 9111.8 9111.9 7935.9 8124.2 8157.9 8170.8 8345.1 8019.0 8064.4 8106.5 8189.0 8244.3 6987.6 7000.3 7020.3 7053.6 7136.7 4941.4 4947.9 5091.6 5142.5 5161.6 5121.7 5128.1 5220.4 5234.3 5275.5 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | [#4] prototype.html Cycles:180 Average:4704.13 Median:5456.01 stddev:1376.78 (25.2%) stddev-sans-first:1340.75 23:24:17 INFO - PROCESS | 14239 | Values: 320.4 323.8 325.5 329.6 329.8 5367.9 5405.3 5421.2 5427.7 5431.4 5270.3 5303.0 5366.7 5370.6 5413.2 3963.9 4026.6 4155.6 4156.4 4157.5 4092.4 4108.5 4139.8 4155.9 4161.9 3988.9 4128.0 4132.2 4143.3 4143.8 4051.8 4174.7 4188.6 4191.6 4213.9 3695.7 3712.5 3723.4 3746.9 3757.4 5160.9 5166.3 5168.8 5172.2 5210.4 4483.6 4749.3 4749.5 4761.8 4763.9 5518.0 5549.5 5569.4 5574.4 5619.6 4013.7 4036.2 4054.5 4066.2 4107.3 5645.8 5804.5 5805.8 5808.6 5810.6 4072.6 4075.9 4090.3 4090.5 4094.9 4071.8 4093.4 4112.8 4134.3 4151.7 4560.7 4723.1 4741.9 4742.0 4775.0 5521.4 5525.8 5541.6 5555.6 5568.2 1417.3 1419.8 1426.9 1447.7 1453.3 922.6 938.9 958.0 983.0 986.7 5360.1 5456.1 5465.9 5471.0 5476.9 5683.6 5694.3 5743.9 5787.8 5791.5 5319.3 5368.5 5456.0 5457.4 5482.5 3001.2 3045.8 3058.8 3059.7 3068.7 5784.4 5800.8 5920.4 5941.9 5947.6 5784.7 5790.4 5800.9 5803.8 5839.9 5767.3 5780.4 5831.3 5868.5 5901.4 5471.6 5605.5 5657.9 5666.4 5716.5 5594.2 5596.4 5616.0 5641.2 5669.3 5661.6 5846.7 5905.0 5930.9 5938.5 4154.3 4170.6 4189.1 4192.6 4221.7 5519.4 5710.0 5747.2 5784.5 5842.5 5289.3 5574.3 5605.5 5607.9 5613.1 5566.9 5567.4 5612.6 5618.4 5629.5 5456.1 5458.0 5495.9 5519.9 5549.1 5453.5 5616.6 5634.2 5638.0 5647.7 5509.6 5514.6 5535.6 5536.5 5544.4 23:24:17 INFO - PROCESS | 14239 | 23:24:17 INFO - PROCESS | 14239 | [#5] yui.html Cycles:180 Average:16534.95 Median:25724.67 stddev:20252.66 (78.7%) stddev-sans-first:20274.81 23:24:17 INFO - PROCESS | 14239 | Values: 756.3 792.4 820.2 852.9 888.4 15001.4 15506.2 15675.4 15695.6 15701.6 14438.3 14488.9 14489.4 14519.3 14521.7 685.3 797.6 821.9 825.9 836.5 819.8 824.8 827.3 827.7 828.0 879.4 880.4 881.3 881.6 881.9 732.5 750.0 751.0 843.9 871.1 634.7 635.7 635.7 636.2 638.8 14339.4 14359.0 14361.5 14380.2 14386.5 14229.9 14237.4 14282.4 14374.9 14426.9 10992.3 11156.4 12784.7 13045.8 13138.9 4571.3 4586.9 4640.7 4642.8 4707.8 59083.4 59585.4 60474.0 60594.1 60786.4 10910.0 11121.1 11139.1 11228.9 11280.5 18964.9 18980.2 18981.6 19010.0 19027.0 7809.4 7909.6 8034.8 8093.9 8159.7 4704.8 4749.0 4848.3 4856.9 4935.2 3329.6 3401.3 3411.5 3412.7 3416.9 606.3 609.0 614.1 622.8 624.5 698.7 741.4 769.2 771.7 785.0 9571.3 9851.3 10004.9 10028.9 10099.8 610.4 678.7 704.9 718.6 732.7 4554.9 4953.5 4982.8 4986.4 5147.2 72623.6 76843.6 76941.6 77156.2 77511.8 65853.7 66108.0 67109.7 68109.3 69822.3 56465.0 56588.4 57498.7 58564.0 59559.0 10131.6 10364.1 10388.5 10390.6 10430.0 37722.2 37773.6 38666.8 38849.4 38995.4 46806.5 52482.2 53605.7 53867.0 54320.5 12308.8 12639.9 12694.9 12790.1 13394.4 12960.2 14397.8 14816.7 15288.8 15335.6 13903.0 14033.3 14136.3 14497.4 14765.5 13592.3 13790.7 14103.4 14221.4 14223.8 12391.8 12872.5 13259.7 13698.0 13708.2 9870.2 9987.0 10186.7 10600.6 10775.5 10241.1 10272.0 10278.6 10279.4 10294.0 23:24:17 INFO - PROCESS | 14239 | -------- Summary: end -------- 23:24:17 INFO - PROCESS | 14239 | 23:24:18 INFO - TEST-INFO | 14239: exit 0 23:24:18 INFO - TEST-OK | dromaeo_css | took 1115221ms 23:24:18 INFO - TEST-START | kraken 23:24:18 INFO - operating with platform_type : linux_ 23:24:18 INFO - Initialising browser for kraken test... 23:24:18 INFO - TEST-INFO | started process 14421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmS8zy/profile http://localhost:39206/getInfo.html) 23:24:23 INFO - PROCESS | 14421 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 23:24:23 INFO - PROCESS | 14421 | __metrics Screen width/height:1600/1200 23:24:23 INFO - PROCESS | 14421 | colorDepth:24 23:24:23 INFO - PROCESS | 14421 | Browser inner width/height: 1024/697 23:24:23 INFO - PROCESS | 14421 | __metrics 23:24:24 ERROR - PROCESS | 14421 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:24:24 INFO - PROCESS | 14421 | console.error: PushService: 23:24:24 INFO - PROCESS | 14421 | stateChangeProcessEnqueue: Error transitioning state 23:24:24 INFO - PROCESS | 14421 | UnknownError 23:24:25 INFO - TEST-INFO | 14421: exit 0 23:24:25 INFO - Browser initialized. 23:24:25 INFO - Running cycle 1/1 for kraken test... 23:24:25 INFO - TEST-INFO | started process 14504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmS8zy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:24:37 INFO - PROCESS | 14504 | RSS: Main: 152518656 23:24:37 INFO - PROCESS | 14504 | 23:24:40 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39206/tests/kraken/driver.html?testName=audio-beat-detection) 23:24:40 INFO - PROCESS | 14504 | RSS: Main: 208449536 23:24:40 INFO - PROCESS | 14504 | 23:24:43 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39206/tests/kraken/driver.html?testName=audio-dft) 23:24:44 INFO - PROCESS | 14504 | RSS: Main: 198381568 23:24:44 INFO - PROCESS | 14504 | 23:24:47 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39206/tests/kraken/driver.html?testName=audio-fft) 23:24:48 INFO - PROCESS | 14504 | RSS: Main: 265129984 23:24:48 INFO - PROCESS | 14504 | 23:24:50 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39206/tests/kraken/driver.html?testName=audio-oscillator) 23:24:50 INFO - PROCESS | 14504 | RSS: Main: 174141440 23:24:50 INFO - PROCESS | 14504 | 23:24:53 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39206/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:24:53 INFO - PROCESS | 14504 | RSS: Main: 177979392 23:24:53 INFO - PROCESS | 14504 | 23:24:56 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39206/tests/kraken/driver.html?testName=imaging-darkroom) 23:24:57 INFO - PROCESS | 14504 | RSS: Main: 213712896 23:24:57 INFO - PROCESS | 14504 | 23:25:01 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39206/tests/kraken/driver.html?testName=imaging-desaturate) 23:25:01 INFO - PROCESS | 14504 | RSS: Main: 212062208 23:25:01 INFO - PROCESS | 14504 | 23:25:04 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39206/tests/kraken/driver.html?testName=json-parse-financial) 23:25:05 INFO - PROCESS | 14504 | RSS: Main: 213471232 23:25:05 INFO - PROCESS | 14504 | 23:25:06 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39206/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:25:07 INFO - PROCESS | 14504 | RSS: Main: 203710464 23:25:07 INFO - PROCESS | 14504 | 23:25:09 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:25:09 INFO - PROCESS | 14504 | RSS: Main: 208175104 23:25:09 INFO - PROCESS | 14504 | 23:25:11 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:25:12 INFO - PROCESS | 14504 | RSS: Main: 216985600 23:25:12 INFO - PROCESS | 14504 | 23:25:15 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:25:15 INFO - PROCESS | 14504 | RSS: Main: 222359552 23:25:15 INFO - PROCESS | 14504 | 23:25:18 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:25:19 INFO - PROCESS | 14504 | RSS: Main: 219549696 23:25:19 INFO - PROCESS | 14504 | 23:25:20 INFO - PROCESS | 14504 | Cycle 1(1): loaded http://localhost:39206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39206/tests/kraken/driver.html?testName=ai-astar) 23:25:21 INFO - PROCESS | 14504 | RSS: Main: 265129984 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | __start_tp_report 23:25:21 INFO - PROCESS | 14504 | _x_x_mozilla_page_load 23:25:21 INFO - PROCESS | 14504 | _x_x_mozilla_page_load_details 23:25:21 INFO - PROCESS | 14504 | |i|pagename|runs| 23:25:21 INFO - PROCESS | 14504 | |0;ai-astar;112;106;112;112;111;112;111;111;111;111 23:25:21 INFO - PROCESS | 14504 | |1;audio-beat-detection;162;123;151;206;123;154;153;125;173;138 23:25:21 INFO - PROCESS | 14504 | |2;audio-dft;160;160;160;161;162;161;162;162;160;162 23:25:21 INFO - PROCESS | 14504 | |3;audio-fft;75;75;75;151;75;75;81;74;130;75 23:25:21 INFO - PROCESS | 14504 | |4;audio-oscillator;91;93;146;92;92;92;120;91;92;134 23:25:21 INFO - PROCESS | 14504 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;116;117 23:25:21 INFO - PROCESS | 14504 | |6;imaging-darkroom;146;147;145;145;144;145;144;146;146;144 23:25:21 INFO - PROCESS | 14504 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;95 23:25:21 INFO - PROCESS | 14504 | |8;json-parse-financial;58;53;55;55;55;55;55;107;53;52 23:25:21 INFO - PROCESS | 14504 | |9;json-stringify-tinderbox;59;60;60;60;60;59;60;59;59;60 23:25:21 INFO - PROCESS | 14504 | |10;stanford-crypto-aes;85;78;78;77;78;79;79;83;79;80 23:25:21 INFO - PROCESS | 14504 | |11;stanford-crypto-ccm;119;129;120;118;121;123;126;116;193;123 23:25:21 INFO - PROCESS | 14504 | |12;stanford-crypto-pbkdf2;166;159;157;160;164;163;163;160;163;157 23:25:21 INFO - PROCESS | 14504 | |13;stanford-crypto-sha256-iterative;62;63;64;64;63;61;61;67;62;62 23:25:21 INFO - PROCESS | 14504 | __end_tp_report 23:25:21 INFO - PROCESS | 14504 | __start_cc_report 23:25:21 INFO - PROCESS | 14504 | _x_x_mozilla_cycle_collect,1814 23:25:21 INFO - PROCESS | 14504 | __end_cc_report 23:25:21 INFO - PROCESS | 14504 | __startTimestamp1463207121245__endTimestamp 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | ------- Summary: start ------- 23:25:21 INFO - PROCESS | 14504 | Number of tests: 14 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.79 (1.6%) stddev-sans-first:1.86 23:25:21 INFO - PROCESS | 14504 | Values: 112.0 106.0 112.0 112.0 111.0 112.0 111.0 111.0 111.0 111.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:153.50 stddev:25.94 (16.9%) stddev-sans-first:27.19 23:25:21 INFO - PROCESS | 14504 | Values: 162.0 123.0 151.0 206.0 123.0 154.0 153.0 125.0 173.0 138.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 23:25:21 INFO - PROCESS | 14504 | Values: 160.0 160.0 160.0 161.0 162.0 161.0 162.0 162.0 160.0 162.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#3] audio-fft Cycles:10 Average:88.60 Median:75.00 stddev:27.87 (37.2%) stddev-sans-first:29.12 23:25:21 INFO - PROCESS | 14504 | Values: 75.0 75.0 75.0 151.0 75.0 75.0 81.0 74.0 130.0 75.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:92.00 stddev:20.96 (22.8%) stddev-sans-first:21.67 23:25:21 INFO - PROCESS | 14504 | Values: 91.0 93.0 146.0 92.0 92.0 92.0 120.0 91.0 92.0 134.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:25:21 INFO - PROCESS | 14504 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 23:25:21 INFO - PROCESS | 14504 | Values: 146.0 147.0 145.0 145.0 144.0 145.0 144.0 146.0 146.0 144.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:25:21 INFO - PROCESS | 14504 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:55.00 stddev:16.67 (30.3%) stddev-sans-first:17.66 23:25:21 INFO - PROCESS | 14504 | Values: 58.0 53.0 55.0 55.0 55.0 55.0 55.0 107.0 53.0 52.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 23:25:21 INFO - PROCESS | 14504 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 59.0 60.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.50 (3.2%) stddev-sans-first:1.73 23:25:21 INFO - PROCESS | 14504 | Values: 85.0 78.0 78.0 77.0 78.0 79.0 79.0 83.0 79.0 80.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:123.00 stddev:22.88 (18.6%) stddev-sans-first:23.99 23:25:21 INFO - PROCESS | 14504 | Values: 119.0 129.0 120.0 118.0 121.0 123.0 126.0 116.0 193.0 123.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:163.00 stddev:3.05 (1.9%) stddev-sans-first:2.69 23:25:21 INFO - PROCESS | 14504 | Values: 166.0 159.0 157.0 160.0 164.0 163.0 163.0 160.0 163.0 157.0 23:25:21 INFO - PROCESS | 14504 | 23:25:21 INFO - PROCESS | 14504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.79 (2.8%) stddev-sans-first:1.87 23:25:21 INFO - PROCESS | 14504 | Values: 62.0 63.0 64.0 64.0 63.0 61.0 61.0 67.0 62.0 62.0 23:25:21 INFO - PROCESS | 14504 | -------- Summary: end -------- 23:25:21 INFO - PROCESS | 14504 | 23:25:22 INFO - TEST-INFO | 14504: exit 0 23:25:22 INFO - TEST-OK | kraken | took 63797ms 23:25:22 INFO - SUITE-END | took 1179s 23:25:22 INFO - Completed test suite (00:19:39) 23:25:22 INFO - javascript benchmark 23:25:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3163.620365556133, 3194.5048517479786, 3206.326671399007, 3218.7907785993925, 3249.0577732457573, 5217.243499692542, 5281.498257665526, 5324.201369794528, 5428.375736790265, 5448.809291674792, 5263.31576895004, 5309.150535914255, 5312.92030619541, 5337.572994160468, 5346.8395948121615, 4790.065937142267, 4866.221404575269, 4925.433575138851, 4949.133901567229, 4964.304997300363, 4906.190478571031, 4967.7019378837385, 4977.6266779991465, 4982.775775090112, 4986.650934434573, 4805.063012712522, 4845.636577256702, 4876.683015603992, 4896.02079584081, 4952.851414457572, 4835.153848076608, 4835.443923948756, 4840.419149702023, 4907.533784290486, 4986.127427700138, 4830.9275360869615, 4883.682560633548, 4885.5358740919555, 4889.657723959324, 4910.656254062217, 5154.639175257696, 5177.352830896138, 5255.1329030709885, 5273.7626806793405, 5353.330833645794, 5733.254676892019, 5740.942590574083, 5779.075347944351, 5786.421357864222, 5791.797287094932, 5773.682447465388, 5780.5953583248765, 5784.82645520635, 5816.738246778905, 5842.97078514609, 5197.948020519822, 5365.356157261114, 5365.892682146375, 5414.458554144633, 5419.458054194589, 5952.226210592596, 5957.344692083867, 6000.069989151689, 6005.669688167105, 6012.579119461596, 5731.0, 5768.855778605568, 5769.826905192851, 5772.0, 5779.422057794187, 5641.605087643826, 5709.200711900337, 5757.596968212269, 5761.279840019997, 5852.4440178183, 5785.537157027427, 5787.623804452697, 5787.884242315215, 5795.971020144872, 5826.854328641733, 5740.368559458456, 5787.797427090031, 5788.218590490314, 5797.594168408171, 5798.797042103506, 4201.516825565038, 4312.611864932172, 4359.542248063971, 4366.345048242725, 4406.449193850769, 3898.1229223424502, 3912.217556488714, 3916.3538016227003, 3937.350337194388, 3946.5264168299414, 5456.935897500029, 5460.180972854024, 5461.290032295856, 5465.152901300305, 5469.726513674301, 5618.803341883015, 5688.0, 5763.6541807491685, 5768.826935191951, 5827.533797296206, 5419.945800542023, 5448.809291674773, 5449.754761035763, 5456.727163641802, 5457.372402173722, 4687.835925742583, 4822.541858523435, 4838.758062096881, 4839.395075615548, 4877.463479017305, 5896.262967129109, 5920.526357891358, 5956.910646340309, 5988.490978266809, 5999.130126131774, 5791.623544469596, 5796.62321949072, 5797.594168408171, 5800.76796928135, 5804.65172089676, 5765.855853603525, 5828.475437210672, 5904.940950590439, 5917.615355001911, 5921.496672782861, 5577.693226872561, 5615.578831587729, 5642.322921249476, 5648.88702225945, 5684.090545512699, 5684.204211410323, 5729.914051289317, 5740.712964351682, 5740.937926483447, 5750.769969201185, 5513.5037846594, 5529.391766905556, 5557.472040156179, 5594.888102238014, 5617.88764224705, 5610.270664813548, 5610.4670056344585, 5615.410381909841, 5616.522595579258, 5655.293088363955, 5482.725863706719, 5515.944840551543, 5516.255305533701, 5519.503244707835, 5525.613207075627, 5488.17677348401, 5511.807086751945, 5562.833115006556, 5598.468145526169, 5678.403767604507, 5409.107497262908, 5435.10320797064, 5437.075697131418, 5472.452754724655, 5529.253550770594], "value": 5293.475895998238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.898517759392, 620.8106527509109, 633.7401665317218, 639.2584601861839, 664.6278084272805, 31441.0, 31896.840515797416, 43363.34954975674, 44593.33110003344, 44603.107937841225, 42417.0, 47014.29478557824, 47023.29465058027, 47064.2940355895, 47097.29354059692, 9043.276537876955, 9198.77003074925, 9203.17171454569, 9205.171534561889, 9206.953965230165, 8944.15030572098, 9053.999999999967, 9059.818803623924, 9060.818783624323, 9062.410943288698, 9051.321150913675, 9093.09069093092, 9097.22673572747, 9098.909010909905, 9100.180983711465, 9044.547772611377, 9089.863652045224, 9098.272138228926, 9102.226310763594, 9102.681406150752, 8806.603702833389, 8865.423747456394, 8874.689385871528, 8890.466572005636, 8890.555472226362, 42551.7872410636, 42857.0, 42913.35629965553, 42997.0, 43025.13949720988, 3590.8922732318074, 3694.8891533253777, 3779.2441511697493, 3981.0, 4289.335153051282, 32372.0, 33087.6691233087, 33213.833930830435, 33300.16749581256, 34553.0, 4236.724612900151, 4402.097569998143, 4445.644348452116, 4462.598366147063, 4468.977655111737, 237172.0, 237691.81154094293, 238522.0, 238559.0, 239494.0, 52197.73901130546, 59667.403325967054, 60614.696926515084, 60649.96750162474, 60652.786944260864, 52615.47537508583, 53090.0, 53716.73141634267, 59217.40782592119, 59268.0, 16833.41083062087, 17288.740668889975, 17318.82681173172, 17328.39350622722, 17331.220095095498, 13653.590392288248, 13815.930920345334, 13817.654558636115, 13824.585262442142, 13826.239556824472, 15919.761203581955, 18105.275788968294, 18172.454826354966, 18199.0, 18880.43358699241, 6357.427831495188, 6454.6449945252525, 6613.702383392759, 6678.666066696645, 6699.899501507482, 1006.6527048168371, 1025.8102251083574, 1086.0659832544006, 1089.6404186618397, 1096.627146770086, 33093.66906330906, 33109.3378132436, 33661.66338336634, 33722.662773372445, 34026.659733402346, 1126.774645070989, 1138.9658310250707, 1173.8826117388194, 1190.2798806721808, 1265.221888538542, 17483.737743933852, 17736.20187091584, 17784.817400080985, 17796.733049004277, 17868.49841022258, 494414.0, 501665.0, 502430.0, 753628.0, 754187.0, 58000.4199957995, 58849.705751471825, 59044.40955590475, 59109.40890591125, 59111.40888591059, 1454.8181477315336, 1456.7232225877049, 1462.6928345047659, 1465.8167729033871, 1470.3603932289489, 32073.518897217025, 34100.65899340975, 34201.82899085488, 34258.65741342555, 34698.0, 51921.70195745137, 52228.73885630548, 52282.908683653746, 52399.476005240984, 52465.73767131293, 428030.0, 429131.0, 430927.0, 432314.0, 433466.0, 28421.573676395285, 28580.714192857806, 29207.561886571293, 29301.0, 29329.266768330963, 41796.58203417927, 43765.56234437615, 48436.273455898896, 48864.51135488742, 53842.46157538374, 40287.39568906528, 41480.37779433371, 41708.374374385014, 41984.0, 42409.0, 41058.384124237564, 41252.1749565013, 41496.792516037225, 41580.79209604054, 42184.36723449089, 42146.7892660547, 42693.35959960665, 42868.0, 42987.3551896728, 43208.35187472127, 35218.82390588031, 36920.44619330658, 37017.25965480729, 37759.62240377671, 37957.810210948766, 28998.855005724836, 29105.85447072751, 29393.55909661314, 29411.705882940896, 29525.704742952297], "value": 20297.412599421332, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.44893597898914, 400.92582872168634, 407.27301766347057, 408.53223059596763, 418.1615860200298, 12816.323129834225, 17842.0, 19378.12798424071, 19381.0, 19773.406797796055, 15051.473198438056, 17184.312627494885, 18366.26534938601, 18947.90526047368, 19240.51898702533, 5510.9448905510935, 5722.256106706143, 5746.425357464241, 5748.0, 5770.394108618598, 5665.12190610456, 5684.147377893308, 5685.715714214293, 5696.3733989261145, 5706.77172913083, 3963.960360396388, 4143.937840932388, 5944.464998150165, 6253.718582663768, 6277.340879207663, 6194.4115309045565, 6252.937470625304, 6278.811635650938, 6306.1171435998995, 6309.400606942333, 5435.510804027656, 5487.945120548783, 5509.47659972302, 5563.499285064364, 5571.108622620402, 21149.68275475869, 22373.664395034088, 22457.32628021162, 23263.0, 23326.533469330687, 2223.7331520217676, 2313.664518644804, 2616.882240299191, 2668.866556672159, 2825.4207887383036, 9716.465594392306, 10217.744556386075, 10299.124574411184, 10629.415382153978, 10814.188935829765, 1874.953126171843, 1923.6922092465138, 1955.4720225539168, 1960.4510736993664, 2104.042660589428, 74229.62885185593, 78083.60958195172, 79515.60242198753, 84923.15076849214, 87357.0, 11229.943850280697, 11270.492827822767, 11395.715107122389, 11517.136214783757, 11560.132990025613, 15715.0, 15818.288177032062, 15868.04791712501, 15870.761938570931, 15960.441384551485, 8174.918250817415, 8219.931408916802, 8362.289205417486, 8522.914770852212, 8557.614907329185, 8007.599620019092, 8023.1575684553445, 8057.113717491071, 8183.631736571869, 8183.95908020456, 4472.172648060119, 4849.750667053083, 4940.07264224942, 4997.600191984705, 5029.5221953914315, 1877.6714075036814, 1985.3150663021236, 2004.178286902363, 2072.336852207309, 2130.957380852405, 984.2863923655293, 1011.3375738891039, 1084.837274408845, 1096.7641956979287, 1146.5070019891527, 18052.18765155545, 18542.907285463487, 18546.81453185451, 18990.0, 19707.507312317306, 1014.3913651808856, 1017.801528701896, 1027.6454623155, 1097.2812807611028, 1098.6374496416324, 10796.0, 11217.270877392943, 11236.83144752813, 11244.606438774603, 11294.265872718248, 359205.0, 360912.0, 361533.0, 498343.0, 499844.0, 96371.0, 100252.0, 102107.0, 103260.0, 104442.47778761058, 1055.472263868066, 1071.276888100529, 1077.7305673581604, 1111.2388014210292, 1113.142879982409, 17392.0, 17408.036785285985, 17509.38717144894, 17810.5547361317, 17832.465026049238, 40285.39571906365, 41758.0, 42150.36774448447, 42501.0, 43660.56339436692, 58574.0, 58709.0, 59017.704911475164, 59204.70397647984, 61345.69327153335, 7601.277878601524, 8693.478391296543, 8927.598258078531, 9058.411203271766, 9202.493862837608, 11554.0, 13407.932960335136, 13453.529126480526, 13634.0, 13663.428705698972, 11038.44807759625, 11807.586734464252, 11925.582604609144, 11953.581624643095, 12079.57721479744, 11711.590094346657, 11958.820617690915, 12025.699357515781, 12128.454219559964, 12341.691457713629, 12139.817902731642, 12154.574589889311, 12176.512939482322, 12363.134580579273, 12621.305828179538, 7571.697132114654, 7795.688172473037, 7803.960980195063, 8121.1472795358, 8604.956975215084, 10825.837612435977, 11661.533538658698, 11686.824697629712, 11691.532338706356, 11719.41402929833], "value": 9302.741187047912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.6114687887396, 1554.5647218778743, 1573.881958853086, 1765.6468706258752, 1870.9812901870985, 8603.440776349533, 9000.279977601793, 9002.234810041145, 9263.536823158849, 9265.861012084808, 9019.098090190977, 9253.537323133833, 9256.814863702739, 9262.166405023547, 9262.814743705121, 2122.4587730128796, 2180.8364372672036, 2183.2031308572336, 2370.7155141382973, 2400.135951057618, 2370.8814559272055, 2438.3782135555407, 2440.255722004788, 2455.1284294075613, 2461.6307553866886, 2347.2371479269223, 2350.459394339303, 2368.0291080656934, 2375.1686909581595, 2382.523495300938, 2081.8334533237303, 2263.8528495647893, 2377.2986968844148, 2415.68596082509, 2416.142269494331, 2411.7347091819884, 2423.4547226873988, 2423.8182136339847, 2448.09420514409, 2452.7424620414777, 9013.459192448408, 9057.954710226473, 9061.773455663595, 9062.592183351764, 9082.500462474562, 5367.865803354908, 5527.806526771584, 5528.585356098269, 5534.391216966131, 5539.058360078796, 3328.7170590499836, 3361.0, 3520.4015317395847, 3524.3832329342263, 3531.770434921722, 1206.318430086998, 1251.2117366059415, 1259.0431272233077, 1260.9684757881034, 1280.6414204022794, 12702.555410560586, 12707.618771436872, 12751.10742248043, 12755.936220318932, 12764.553240636626, 4826.251930950708, 4841.225403935354, 4847.515248475124, 4856.17445034345, 4950.009998000342, 10748.462576871125, 10768.192385571114, 10769.946150269356, 10770.353778773298, 10780.946095269474, 5403.594730395236, 5405.324334458192, 5405.891882162335, 5411.18832175169, 5413.377461591888, 4434.82260709568, 4861.562459378673, 4956.504349565014, 5004.174311238678, 5033.496650335011, 4144.088300573869, 4179.456670632799, 4232.238197124547, 4234.87295381139, 4279.422277992431, 1325.721598464314, 1353.8578449262686, 1367.09771550776, 1370.328539015875, 1380.8481067082612, 888.3470649072926, 993.2451336983944, 994.3337963564429, 998.6804222648828, 1009.7021378693303, 5996.580239383288, 6094.116353128771, 6203.720832562545, 6313.147725057151, 6367.713452894631, 961.9134277915022, 995.2088089968348, 1022.2844009193594, 1024.5543188712934, 1050.112654806687, 4076.6534844537955, 4119.855805046869, 4139.151473947833, 4145.751254924654, 4175.144095460423, 11918.880811191777, 12335.753284934251, 12356.814647780291, 12385.566505172275, 12414.441350139265, 11955.760884782256, 12087.0, 12171.634850954486, 12196.57311994076, 12257.938710306391, 8305.169483051646, 8521.403501754941, 8661.826763464822, 8665.653373864974, 8765.868511972198, 5992.490638295793, 6102.816915492543, 6106.664133472524, 6124.5406594506485, 6127.172831667668, 10768.676939691823, 10783.892161078602, 10793.406362649815, 10897.237193396702, 10915.727106822393, 10528.157747380037, 10889.292196007234, 11071.335719856834, 11182.888171118184, 11185.384803835866, 7083.114610673666, 7499.137599176164, 7787.338076263581, 7796.415268854972, 8010.038795344363, 9045.77385565366, 9058.184763371064, 9088.409253398508, 9111.772205694911, 9111.908880911105, 7935.920640793518, 8124.187581241828, 8157.918420815953, 8170.754877353689, 8345.123762004901, 8018.959905200437, 8064.395170362129, 8106.47307924983, 8188.959055204686, 8244.267223174627, 6987.637410704864, 7000.264972178052, 7020.262872398324, 7053.576785392893, 7136.678849451683, 4941.431735350337, 4947.876303092451, 5091.567216786615, 5142.485751424977, 5161.638685291993, 5121.718305493085, 5128.076946149728, 5220.425753167225, 5234.2672025915645, 5275.472452754694], "value": 4831.961674321292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.3544857112918, 323.8218979561241, 325.49548200289547, 329.5995365630759, 329.7708092875452, 5367.892642147155, 5405.270313499682, 5421.241026256317, 5427.701476418795, 5431.375391829941, 5270.341207349082, 5303.0, 5366.677999320043, 5370.570354371651, 5413.160960051188, 3963.9405408918888, 4026.5772093930154, 4155.625993660585, 4156.418101465797, 4157.48031496063, 4092.3656833190903, 4108.4864391951005, 4139.79301034947, 4155.854545090922, 4161.895952601179, 3988.9202215955665, 4127.979360103211, 4132.173565286939, 4143.254214241435, 4143.7720925349095, 4051.817668204938, 4174.728642638234, 4188.602082802129, 4191.601797829232, 4213.873583792491, 3695.7228207884245, 3712.4988126602834, 3723.422869455239, 3746.8688595899284, 3757.436384542313, 5160.92258616121, 5166.250893620404, 5168.767405466763, 5172.2241663750365, 5210.400803907562, 4483.646085804946, 4749.26386410107, 4749.453812811502, 4761.761911904426, 4763.928541071887, 5518.0, 5549.472800083986, 5569.415211402785, 5574.414686457904, 5619.578531610146, 4013.7190396672245, 4036.1524079943247, 4054.5134583850127, 4066.1867626474527, 4107.342825147962, 5645.76992088127, 5804.506616937565, 5805.82582522525, 5808.6224395414165, 5810.559564982717, 4072.633462988286, 4075.9388609170887, 4090.343410918583, 4090.5295890972325, 4094.9385759213637, 4071.816768245377, 4093.3655283431117, 4112.794360281974, 4134.338505839051, 4151.709380343347, 4560.722997560688, 4723.0789995951145, 4741.857744267678, 4741.960956788614, 4774.976125119352, 5521.420250873601, 5525.834224973257, 5541.639793413496, 5555.638883472561, 5568.192612071227, 1417.2984372735561, 1419.8012278281049, 1426.915544186426, 1447.6742732885227, 1453.273363318341, 922.6125027488337, 938.877945867033, 957.9616815327308, 982.9606815727434, 986.7385142937128, 5360.1239566151535, 5456.099743542271, 5465.9180112298345, 5471.0, 5476.890462190734, 5683.630564013409, 5694.316681998104, 5743.9425605744245, 5787.797427090031, 5791.507721843691, 5319.28189694394, 5368.489993450616, 5455.954017243534, 5457.426970168154, 5482.451754824486, 3001.2196828824663, 3045.8324792136646, 3058.801177923428, 3059.6787337329706, 3068.6777888321403, 5784.421557844182, 5800.767969281182, 5920.407959204132, 5941.940580594139, 5947.5539334550085, 5784.739686714108, 5790.36306006339, 5800.9129863052085, 5803.767849285981, 5839.9124013139835, 5767.307923049177, 5780.393058728857, 5831.329397119301, 5868.501177399883, 5901.40985901415, 5471.604740791073, 5605.467480589337, 5657.858553536194, 5666.433356664301, 5716.456936591017, 5594.216809646734, 5596.356419011866, 5616.0, 5641.210230567642, 5669.291338582677, 5661.603687741818, 5846.678432686073, 5905.0, 5930.851728706817, 5938.495227905676, 4154.273002224538, 4170.562090980404, 4189.120284740238, 4192.580741925783, 4221.7255878367805, 5519.39286678473, 5709.9714501427225, 5747.195392645117, 5784.50831679312, 5842.5325973921135, 5289.312389389354, 5574.331080270394, 5605.5235304997905, 5607.943920560742, 5613.073842815889, 5566.88254577438, 5567.415421380697, 5612.635178713371, 5618.381977982337, 5629.493345598916, 5456.072467680583, 5457.972710136424, 5495.890082198413, 5519.902437073886, 5549.139883318092, 5453.509184173444, 5616.634918730269, 5634.1548767683535, 5638.0, 5647.6893770843, 5509.641873278224, 5514.558835293247, 5535.612507124462, 5536.52939500147, 5544.390117087037], "value": 4262.814408192643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.2890882570383, 792.4452882981914, 820.2453742556845, 852.9189726975935, 888.409207876762, 15001.39994400224, 15506.224688765558, 15675.372985080612, 15695.607609809746, 15701.607459813482, 14438.27808609568, 14488.927555362208, 14489.420423183086, 14519.274036298195, 14521.709565808704, 685.2770327304692, 797.5812698333364, 821.909589945104, 825.9297959673405, 836.4521238588734, 819.7622689420061, 824.8474032304043, 827.3257295304307, 827.6813426830653, 828.0187977246951, 879.4327658660193, 880.4189235104832, 881.3037700216821, 881.576843115305, 881.858902575588, 732.4689600039982, 749.9737509187207, 750.951188172767, 843.8902942617482, 871.0984131423977, 634.7397566997555, 635.6662752055162, 635.7171058878755, 636.2015670333701, 638.8434833465784, 14339.42642294307, 14359.0, 14361.49734759289, 14380.209088500233, 14386.496472623408, 14229.928850355785, 14237.359318830677, 14282.3572939218, 14374.856251437457, 14426.92786536071, 10992.340459572451, 11156.386398748065, 12784.744305113845, 13045.804312935314, 13138.86861131386, 4571.26859702446, 4586.923592659724, 4640.721556706575, 4642.814287428499, 4707.788149533245, 59083.40916590822, 59585.40414595842, 60474.0, 60594.09108863371, 60786.39213607896, 10910.0, 11121.054710349548, 11139.108871290277, 11228.887711122785, 11280.492377843017, 18964.905175474036, 18980.240790368232, 18981.62036759285, 19010.04949752507, 19027.0, 7809.3752499799875, 7909.644066017043, 8034.758957231293, 8093.919060809317, 8159.714409995621, 4704.811807527729, 4748.966214809192, 4848.296996935424, 4856.8785780355065, 4935.185694360463, 3329.583802024747, 3401.2687272236094, 3411.5394421752744, 3412.709919656857, 3416.9487457688156, 606.3481757111123, 608.9786857459968, 614.1003429975108, 622.8380621038563, 624.5191202773839, 698.678607840389, 741.4253953186324, 769.2384539306047, 771.7453240430644, 784.9803754906059, 9571.28215383849, 9851.310408271353, 10004.949975250223, 10028.899711002796, 10099.798004040025, 610.4414460768347, 678.7352932356386, 704.9130755922544, 718.5904034700171, 732.6776218463859, 4554.908901822011, 4953.529414705597, 4982.800687972441, 4986.401631804134, 5147.150720131136, 72623.6368818163, 76843.61578192073, 76941.61529192318, 77156.2284377149, 77511.79905607538, 65853.670731647, 66108.0, 67109.66445167742, 68109.3189068103, 69822.3017769826, 56465.04744667834, 56588.43411565914, 57498.7125064372, 58564.0, 59558.999999999134, 10131.64539241123, 10364.119049880543, 10388.532516036948, 10390.58437662485, 10430.0, 37722.24555508819, 37773.62226377701, 38666.80666596649, 38849.41725874058, 38995.41506877342, 46806.53193468158, 52482.212766809294, 53605.73197133989, 53867.0, 54320.45679543154, 12308.81536776967, 12639.873601264237, 12694.873051269738, 12790.104692671424, 13394.397252123872, 12960.157589756636, 14397.784033239719, 14816.703665926836, 15288.770668440206, 15335.616609584404, 13903.0, 14033.29833508341, 14136.293185340897, 14497.420103195755, 14765.483208087666, 13592.32038398096, 13790.65523361924, 14103.365348559135, 14221.360038798071, 14223.786643200154, 12391.75216495647, 12872.485100596246, 13259.734805304033, 13698.0, 13708.24604646754, 9870.161036311994, 9987.0, 10186.694399168036, 10600.628977985734, 10775.461226938778, 10241.129503992244, 10272.024157705006, 10278.588856445958, 10279.434631095362, 10294.0], "value": 7131.6668304078, "unit": "score"}], "name": "dromaeo_css", "value": 7263.4216223842, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 123.0, 151.0, 206.0, 123.0, 154.0, 153.0, 125.0, 173.0, 138.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 162.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 151.0, 75.0, 75.0, 81.0, 74.0, 130.0, 75.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 146.0, 92.0, 92.0, 92.0, 120.0, 91.0, 92.0, 134.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 144.0, 145.0, 144.0, 146.0, 146.0, 144.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 55.0, 55.0, 55.0, 55.0, 55.0, 107.0, 53.0, 52.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 78.0, 77.0, 78.0, 79.0, 79.0, 83.0, 79.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 129.0, 120.0, 118.0, 121.0, 123.0, 126.0, 116.0, 193.0, 123.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 159.0, 157.0, 160.0, 164.0, 163.0, 163.0, 160.0, 163.0, 157.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 64.0, 63.0, 61.0, 61.0, 67.0, 62.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1524.1999999999998, "alertThreshold": 2.0}]} 23:25:22 INFO - Return code: 0 23:25:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:25:22 ERROR - # TBPL SUCCESS # 23:25:22 INFO - Running post-action listener: _resource_record_post_action 23:25:22 INFO - ##### 23:25:22 INFO - ##### Finished run-tests step (success) 23:25:22 INFO - ##### 23:25:22 INFO - Running post-run listener: _resource_record_post_run 23:25:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537546752; Read time: 4; Write time: 2047220 23:25:22 INFO - TinderboxPrint: CPU usage
13.2% 23:25:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 23:25:22 INFO - TinderboxPrint: I/O write bytes / time
537,546,752 / 2,047,220 23:25:22 INFO - TinderboxPrint: CPU idle
8,288.5 (86.7%) 23:25:22 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 23:25:22 INFO - TinderboxPrint: Swap in / out
0 / 0 23:25:22 INFO - install - Wall time: 17s; CPU: 22.0%; Read bytes: 0; Write bytes: 253472768; Read time: 0; Write time: 1402268 23:25:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284073984; Read time: 4; Write time: 644952 23:25:23 INFO - Running post-run listener: _upload_blobber_files 23:25:23 INFO - Blob upload gear active. 23:25:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:25:23 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 23:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:25:23 INFO - (blobuploader) - INFO - Open directory for files ... 23:25:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:25:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:25:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:27 INFO - (blobuploader) - INFO - Done attempting. 23:25:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:25:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:25:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:28 INFO - (blobuploader) - INFO - Done attempting. 23:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:29 INFO - (blobuploader) - INFO - Done attempting. 23:25:29 INFO - (blobuploader) - INFO - Iteration through files over. 23:25:29 INFO - Return code: 0 23:25:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:25:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:25:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcab24df7c3cc1b70a57d99f21d10f41d3ce67d01e823341c31538413eac109f63898128c6238f0652dba851387703ec6b5d9c33cf63128eb9bad57a961651b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e141b59dfdb73c4d9b981a2051bdb63ed7ab7816cd926b8d7aaf9cf7347a4a77fbb86d5e735a61652b7aba141ee9e1568bf8d1763ce54b21fd61cc60be54002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfbe7890f906ead6f7fbfabd683296c59d91644fb23836c72c52a06582241ed16cef5e2675fc7d44c62c6f3f0be2157107da3ec67c8ee4a0516dd4d89f749074"} 23:25:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:25:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:25:29 INFO - Contents: 23:25:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcab24df7c3cc1b70a57d99f21d10f41d3ce67d01e823341c31538413eac109f63898128c6238f0652dba851387703ec6b5d9c33cf63128eb9bad57a961651b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e141b59dfdb73c4d9b981a2051bdb63ed7ab7816cd926b8d7aaf9cf7347a4a77fbb86d5e735a61652b7aba141ee9e1568bf8d1763ce54b21fd61cc60be54002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfbe7890f906ead6f7fbfabd683296c59d91644fb23836c72c52a06582241ed16cef5e2675fc7d44c62c6f3f0be2157107da3ec67c8ee4a0516dd4d89f749074"} 23:25:29 INFO - Running post-run listener: copy_logs_to_upload_dir 23:25:29 INFO - Copying logs to upload dir... 23:25:29 INFO - mkdir: /builds/slave/test/build/upload/logs 23:25:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.044016 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-13 23:25:28.806698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 23:25:28.809870) ========= 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=df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742 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/sha512/bcab24df7c3cc1b70a57d99f21d10f41d3ce67d01e823341c31538413eac109f63898128c6238f0652dba851387703ec6b5d9c33cf63128eb9bad57a961651b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e141b59dfdb73c4d9b981a2051bdb63ed7ab7816cd926b8d7aaf9cf7347a4a77fbb86d5e735a61652b7aba141ee9e1568bf8d1763ce54b21fd61cc60be54002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfbe7890f906ead6f7fbfabd683296c59d91644fb23836c72c52a06582241ed16cef5e2675fc7d44c62c6f3f0be2157107da3ec67c8ee4a0516dd4d89f749074"} build_url:https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/R_V7VV2kRTq9DRCHuwPz_A/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/sha512/bcab24df7c3cc1b70a57d99f21d10f41d3ce67d01e823341c31538413eac109f63898128c6238f0652dba851387703ec6b5d9c33cf63128eb9bad57a961651b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e141b59dfdb73c4d9b981a2051bdb63ed7ab7816cd926b8d7aaf9cf7347a4a77fbb86d5e735a61652b7aba141ee9e1568bf8d1763ce54b21fd61cc60be54002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfbe7890f906ead6f7fbfabd683296c59d91644fb23836c72c52a06582241ed16cef5e2675fc7d44c62c6f3f0be2157107da3ec67c8ee4a0516dd4d89f749074"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 23:25:28.833789) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:25:28.834070) ========= 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=df17445c3590ff7897617a0e00000225-1463191806.274377-1987769742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 23:25:28.916170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 23:25:28.916512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 23:25:28.916803) ========= ========= Total master_lag: 0.60 =========