builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1463617428.88 results: success (0) buildid: 20160518143017 builduid: 75d200dc6e06414593b2558b19efb34d revision: 536b16b34e0f0132322cb82f0e0a1554877bbdc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:48.882627) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:48.883218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:48.883496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:48.906915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:48.907188) ========= 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=4300f881736b422476174874000001bc-1463617225.344664-188601395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 17:23:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-05-18 17:23:48 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113760 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.034996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.035292) ========= 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=4300f881736b422476174874000001bc-1463617225.344664-188601395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018739 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.085554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.085918) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 536b16b34e0f0132322cb82f0e0a1554877bbdc0 --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 536b16b34e0f0132322cb82f0e0a1554877bbdc0 --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=4300f881736b422476174874000001bc-1463617225.344664-188601395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 17:23:49,117 truncating revision to first 12 chars 2016-05-18 17:23:49,117 Setting DEBUG logging. 2016-05-18 17:23:49,117 attempt 1/10 2016-05-18 17:23:49,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/536b16b34e0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 17:23:49,597 unpacking tar archive at: fx-team-536b16b34e0f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.875188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.875505) ========= script_repo_revision: 536b16b34e0f0132322cb82f0e0a1554877bbdc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.875915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.876180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 17:23:49.884432) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-18 17:23:49.884770) ========= /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=4300f881736b422476174874000001bc-1463617225.344664-188601395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:23:49 INFO - MultiFileLogger online at 20160518 17:23:49 in /builds/slave/test 17:23:49 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 17:23:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:23:49 INFO - {'append_to_log': False, 17:23:49 INFO - 'base_work_dir': '/builds/slave/test', 17:23:49 INFO - 'blob_upload_branch': 'Fx-Team', 17:23:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:23:49 INFO - 'branch': 'Fx-Team', 17:23:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:23:49 INFO - 'config_files': ('talos/linux_config.py',), 17:23:49 INFO - 'default_actions': ('clobber', 17:23:49 INFO - 'read-buildbot-config', 17:23:49 INFO - 'download-and-extract', 17:23:49 INFO - 'populate-webroot', 17:23:49 INFO - 'create-virtualenv', 17:23:49 INFO - 'install', 17:23:49 INFO - 'run-tests'), 17:23:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:23:49 INFO - 'download_minidump_stackwalk': True, 17:23:49 INFO - 'download_symbols': 'ondemand', 17:23:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:23:49 INFO - 'tooltool.py': '/tools/tooltool.py', 17:23:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:23:49 INFO - '/tools/misc-python/virtualenv.py')}, 17:23:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:23:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:23:50 INFO - 'installer_path': 'installer.exe', 17:23:50 INFO - 'log_level': 'info', 17:23:50 INFO - 'log_name': 'talos', 17:23:50 INFO - 'log_to_console': True, 17:23:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:23:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:23:50 INFO - 'opt_config_files': (), 17:23:50 INFO - 'pip_index': False, 17:23:50 INFO - 'sps_profile': False, 17:23:50 INFO - 'sps_profile_interval': 0, 17:23:50 INFO - 'suite': 'dromaeojs', 17:23:50 INFO - 'system_bits': '32', 17:23:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:23:50 INFO - 'title': 'talos-linux64-ix-045', 17:23:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:23:50 INFO - 'use_talos_json': True, 17:23:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:23:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:23:50 INFO - 'work_dir': 'build'} 17:23:50 INFO - ##### 17:23:50 INFO - ##### Running clobber step. 17:23:50 INFO - ##### 17:23:50 INFO - Running pre-action listener: _resource_record_pre_action 17:23:50 INFO - Running main action method: clobber 17:23:50 INFO - rmtree: /builds/slave/test/build 17:23:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:23:50 INFO - Running post-action listener: _resource_record_post_action 17:23:50 INFO - ##### 17:23:50 INFO - ##### Finished clobber step (success) 17:23:50 INFO - ##### 17:23:50 INFO - ##### 17:23:50 INFO - ##### Running read-buildbot-config step. 17:23:50 INFO - ##### 17:23:50 INFO - Running pre-action listener: _resource_record_pre_action 17:23:50 INFO - Running main action method: read_buildbot_config 17:23:50 INFO - Using buildbot properties: 17:23:50 INFO - { 17:23:50 INFO - "project": "", 17:23:50 INFO - "product": "firefox", 17:23:50 INFO - "script_repo_revision": "production", 17:23:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:23:50 INFO - "repository": "", 17:23:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:23:50 INFO - "buildid": "20160518143017", 17:23:50 INFO - "pgo_build": "True", 17:23:50 INFO - "basedir": "/builds/slave/test", 17:23:50 INFO - "buildnumber": 1164, 17:23:50 INFO - "slavename": "talos-linux64-ix-045", 17:23:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:23:50 INFO - "platform": "ubuntu64_hw", 17:23:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:23:50 INFO - "branch": "fx-team", 17:23:50 INFO - "repo_path": "integration/fx-team", 17:23:50 INFO - "revision": "536b16b34e0f0132322cb82f0e0a1554877bbdc0", 17:23:50 INFO - "stage_platform": "linux64-pgo", 17:23:50 INFO - "builduid": "75d200dc6e06414593b2558b19efb34d", 17:23:50 INFO - "slavebuilddir": "test" 17:23:50 INFO - } 17:23:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:23:50 INFO - Running post-action listener: _resource_record_post_action 17:23:50 INFO - ##### 17:23:50 INFO - ##### Finished read-buildbot-config step (success) 17:23:50 INFO - ##### 17:23:50 INFO - ##### 17:23:50 INFO - ##### Running download-and-extract step. 17:23:50 INFO - ##### 17:23:50 INFO - Running pre-action listener: _resource_record_pre_action 17:23:50 INFO - Running main action method: download_and_extract 17:23:50 INFO - mkdir: /builds/slave/test/build/tests 17:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:50 INFO - https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:23:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:23:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:23:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:23:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:23:51 INFO - Downloaded 1361 bytes. 17:23:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:23:51 INFO - Using the following test package requirements: 17:23:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:23:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:23:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:23:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'jsshell-linux-x86_64.zip'], 17:23:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:23:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:23:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:23:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:23:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:23:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:23:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:51 INFO - https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:23:52 INFO - Downloaded 24386547 bytes. 17:23: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'] 17:23: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 17:23:53 INFO - Return code: 0 17:23: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 17:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:53 INFO - https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:23:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:23:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:23:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:23:57 INFO - Downloaded 24386547 bytes. 17:23:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:23:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:23:58 INFO - Return code: 0 17:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:58 INFO - https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:23:59 INFO - Downloaded 10840194 bytes. 17:23:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:23:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:24:00 INFO - Return code: 0 17:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:00 INFO - https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:24:01 INFO - Downloaded 58435715 bytes. 17:24:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:01 INFO - mkdir: /builds/slave/test/properties 17:24:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:01 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:01 INFO - Contents: 17:24:01 INFO - build_url:https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:02 INFO - Running post-action listener: _resource_record_post_action 17:24:02 INFO - Running post-action listener: set_extra_try_arguments 17:24:02 INFO - ##### 17:24:02 INFO - ##### Finished download-and-extract step (success) 17:24:02 INFO - ##### 17:24:02 INFO - ##### 17:24:02 INFO - ##### Running populate-webroot step. 17:24:02 INFO - ##### 17:24:02 INFO - Running pre-action listener: _resource_record_pre_action 17:24:02 INFO - Running main action method: populate_webroot 17:24:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:02 INFO - '--tppagecycles', 17:24:02 INFO - '7'], 17:24:02 INFO - 'tests': ['tsvgm']}}, 17:24:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['damp', 'tps']}, 17:24:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'tests': ['damp', 'tps']}, 17:24:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['dromaeo_dom']}, 17:24:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['a11yr', 17:24:02 INFO - 'ts_paint', 17:24:02 INFO - 'tpaint', 17:24:02 INFO - 'sessionrestore', 17:24:02 INFO - 'sessionrestore_no_auto_restore', 17:24:02 INFO - 'tabpaint']}, 17:24:02 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:02 INFO - 'ts_paint', 17:24:02 INFO - 'tpaint', 17:24:02 INFO - 'sessionrestore', 17:24:02 INFO - 'sessionrestore_no_auto_restore', 17:24:02 INFO - 'tabpaint']}, 17:24:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:02 INFO - 'ts_paint', 17:24:02 INFO - 'tpaint', 17:24:02 INFO - 'sessionrestore', 17:24:02 INFO - 'sessionrestore_no_auto_restore', 17:24:02 INFO - 'tabpaint']}, 17:24:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:02 INFO - 'ts_paint', 17:24:02 INFO - 'tpaint', 17:24:02 INFO - 'sessionrestore', 17:24:02 INFO - 'sessionrestore_no_auto_restore', 17:24:02 INFO - 'tabpaint']}, 17:24:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['a11yr', 17:24:02 INFO - 'ts_paint', 17:24:02 INFO - 'tpaint', 17:24:02 INFO - 'sessionrestore', 17:24:02 INFO - 'sessionrestore_no_auto_restore', 17:24:02 INFO - 'tabpaint']}, 17:24:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['a11yr', 17:24:02 INFO - 'ts_paint', 17:24:02 INFO - 'tpaint', 17:24:02 INFO - 'sessionrestore', 17:24:02 INFO - 'sessionrestore_no_auto_restore', 17:24:02 INFO - 'tabpaint']}, 17:24:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['tsvgx', 17:24:02 INFO - 'tsvgr_opacity', 17:24:02 INFO - 'tart', 17:24:02 INFO - 'tscrollx', 17:24:02 INFO - 'cart']}, 17:24:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:02 INFO - 'tsvgr_opacity', 17:24:02 INFO - 'tart', 17:24:02 INFO - 'tscrollx', 17:24:02 INFO - 'cart']}, 17:24:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'talos_options': ['--disable-e10s'], 17:24:02 INFO - 'tests': ['tp5o']}, 17:24:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'tests': ['tp5o']}, 17:24:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'talos_options': ['--disable-e10s', 17:24:02 INFO - '--xperf_path', 17:24:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:02 INFO - 'tests': ['tp5n']}, 17:24:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:02 INFO - 'talos_options': ['--xperf_path', 17:24:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:02 INFO - 'tests': ['tp5n']}}, 17:24:02 INFO - 'talos.zip': {'path': '', 17:24:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:02 INFO - Running post-action listener: _resource_record_post_action 17:24:02 INFO - ##### 17:24:02 INFO - ##### Finished populate-webroot step (success) 17:24:02 INFO - ##### 17:24:02 INFO - ##### 17:24:02 INFO - ##### Running create-virtualenv step. 17:24:02 INFO - ##### 17:24:02 INFO - Running pre-action listener: _resource_record_pre_action 17:24:02 INFO - Running main action method: create_virtualenv 17:24:02 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:24:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:02 INFO - Using real prefix '/usr' 17:24:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:03 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:05 INFO - Installing pip.................done. 17:24:05 INFO - Return code: 0 17:24:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24: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', 'pip>=1.5'] in /builds/slave/test/build 17:24: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 pip>=1.5 17:24:05 INFO - Using env: {'DISPLAY': ':0', 17:24:05 INFO - 'HOME': '/home/cltbld', 17:24:05 INFO - 'LANG': 'en_US.UTF-8', 17:24:05 INFO - 'LANGUAGE': 'en_US:en', 17:24:05 INFO - 'LOGNAME': 'cltbld', 17:24:05 INFO - 'MAIL': '/var/mail/cltbld', 17:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:05 INFO - 'MOZ_NO_REMOTE': '1', 17:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:05 INFO - 'NO_EM_RESTART': '1', 17:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:05 INFO - 'PWD': '/builds/slave/test', 17:24:05 INFO - 'SHELL': '/bin/bash', 17:24:05 INFO - 'SHLVL': '1', 17:24:05 INFO - 'TERM': 'linux', 17:24:05 INFO - 'TMOUT': '86400', 17:24:05 INFO - 'USER': 'cltbld', 17:24:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:05 INFO - '_': '/tools/buildbot/bin/python'} 17:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:24:05 INFO - Cleaning up... 17:24:05 INFO - Return code: 0 17:24:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', '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 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:24: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 psutil>=3.1.1 17:24:05 INFO - Using env: {'DISPLAY': ':0', 17:24:05 INFO - 'HOME': '/home/cltbld', 17:24:05 INFO - 'LANG': 'en_US.UTF-8', 17:24:05 INFO - 'LANGUAGE': 'en_US:en', 17:24:05 INFO - 'LOGNAME': 'cltbld', 17:24:05 INFO - 'MAIL': '/var/mail/cltbld', 17:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:05 INFO - 'MOZ_NO_REMOTE': '1', 17:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:05 INFO - 'NO_EM_RESTART': '1', 17:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:05 INFO - 'PWD': '/builds/slave/test', 17:24:05 INFO - 'SHELL': '/bin/bash', 17:24:05 INFO - 'SHLVL': '1', 17:24:05 INFO - 'TERM': 'linux', 17:24:05 INFO - 'TMOUT': '86400', 17:24:05 INFO - 'USER': 'cltbld', 17:24:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:05 INFO - '_': '/tools/buildbot/bin/python'} 17:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:05 INFO - Downloading/unpacking psutil>=3.1.1 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:07 INFO - Installing collected packages: psutil 17:24:07 INFO - Running setup.py install for psutil 17:24:07 INFO - building 'psutil._psutil_linux' extension 17:24:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:24:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:24:08 INFO - building 'psutil._psutil_posix' extension 17:24:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:24:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:24:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:08 INFO - Successfully installed psutil 17:24:08 INFO - Cleaning up... 17:24:08 INFO - Return code: 0 17:24:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:24: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 mozsystemmonitor==0.3 17:24:08 INFO - Using env: {'DISPLAY': ':0', 17:24:08 INFO - 'HOME': '/home/cltbld', 17:24:08 INFO - 'LANG': 'en_US.UTF-8', 17:24:08 INFO - 'LANGUAGE': 'en_US:en', 17:24:08 INFO - 'LOGNAME': 'cltbld', 17:24:08 INFO - 'MAIL': '/var/mail/cltbld', 17:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:08 INFO - 'MOZ_NO_REMOTE': '1', 17:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:08 INFO - 'NO_EM_RESTART': '1', 17:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:08 INFO - 'PWD': '/builds/slave/test', 17:24:08 INFO - 'SHELL': '/bin/bash', 17:24:08 INFO - 'SHLVL': '1', 17:24:08 INFO - 'TERM': 'linux', 17:24:08 INFO - 'TMOUT': '86400', 17:24:08 INFO - 'USER': 'cltbld', 17:24:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:08 INFO - '_': '/tools/buildbot/bin/python'} 17:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:24:10 INFO - Installing collected packages: mozsystemmonitor 17:24:10 INFO - Running setup.py install for mozsystemmonitor 17:24:10 INFO - Successfully installed mozsystemmonitor 17:24:10 INFO - Cleaning up... 17:24:10 INFO - Return code: 0 17:24:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:10 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 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:24:10 INFO - Using env: {'DISPLAY': ':0', 17:24:10 INFO - 'HOME': '/home/cltbld', 17:24:10 INFO - 'LANG': 'en_US.UTF-8', 17:24:10 INFO - 'LANGUAGE': 'en_US:en', 17:24:10 INFO - 'LOGNAME': 'cltbld', 17:24:10 INFO - 'MAIL': '/var/mail/cltbld', 17:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:10 INFO - 'MOZ_NO_REMOTE': '1', 17:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:10 INFO - 'NO_EM_RESTART': '1', 17:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:10 INFO - 'PWD': '/builds/slave/test', 17:24:10 INFO - 'SHELL': '/bin/bash', 17:24:10 INFO - 'SHLVL': '1', 17:24:10 INFO - 'TERM': 'linux', 17:24:10 INFO - 'TMOUT': '86400', 17:24:10 INFO - 'USER': 'cltbld', 17:24:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:10 INFO - '_': '/tools/buildbot/bin/python'} 17:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:12 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:13 INFO - Downloading docopt-0.6.1.tar.gz 17:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:13 INFO - Running setup.py install for blobuploader 17:24:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:13 INFO - Running setup.py install for requests 17:24:14 INFO - Running setup.py install for docopt 17:24:14 INFO - Successfully installed blobuploader requests docopt 17:24:14 INFO - Cleaning up... 17:24:14 INFO - Return code: 0 17:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:14 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 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:24:14 INFO - Using env: {'DISPLAY': ':0', 17:24:14 INFO - 'HOME': '/home/cltbld', 17:24:14 INFO - 'LANG': 'en_US.UTF-8', 17:24:14 INFO - 'LANGUAGE': 'en_US:en', 17:24:14 INFO - 'LOGNAME': 'cltbld', 17:24:14 INFO - 'MAIL': '/var/mail/cltbld', 17:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:14 INFO - 'MOZ_NO_REMOTE': '1', 17:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:14 INFO - 'NO_EM_RESTART': '1', 17:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:14 INFO - 'PWD': '/builds/slave/test', 17:24:14 INFO - 'SHELL': '/bin/bash', 17:24:14 INFO - 'SHLVL': '1', 17:24:14 INFO - 'TERM': 'linux', 17:24:14 INFO - 'TMOUT': '86400', 17:24:14 INFO - 'USER': 'cltbld', 17:24:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:14 INFO - '_': '/tools/buildbot/bin/python'} 17:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:14 INFO - Running setup.py (path:/tmp/pip-Q372JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:14 INFO - Running setup.py (path:/tmp/pip-t3JI0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:14 INFO - Running setup.py (path:/tmp/pip-fa2cQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:14 INFO - Running setup.py (path:/tmp/pip-lCQbUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:14 INFO - Running setup.py (path:/tmp/pip-J3IJcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:14 INFO - Running setup.py (path:/tmp/pip-7k1WAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:14 INFO - Running setup.py (path:/tmp/pip-Vx5WHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:14 INFO - Running setup.py (path:/tmp/pip-efzpzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:14 INFO - Running setup.py (path:/tmp/pip-rjxyBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:15 INFO - Running setup.py (path:/tmp/pip-RpeE5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:15 INFO - Running setup.py (path:/tmp/pip-ww6_QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:15 INFO - Running setup.py (path:/tmp/pip-IkBRx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:15 INFO - Running setup.py (path:/tmp/pip-F5paKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:15 INFO - Running setup.py (path:/tmp/pip-uraxmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:15 INFO - Running setup.py (path:/tmp/pip-9N0ue8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:15 INFO - Running setup.py (path:/tmp/pip-gYFTrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:15 INFO - Running setup.py (path:/tmp/pip-ArrfNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:15 INFO - Running setup.py install for manifestparser 17:24:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:24:15 INFO - Running setup.py install for mozcrash 17:24:15 INFO - Running setup.py install for mozdebug 17:24:15 INFO - Running setup.py install for mozdevice 17:24:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Running setup.py install for mozfile 17:24:16 INFO - Running setup.py install for mozhttpd 17:24:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Running setup.py install for mozinfo 17:24:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Running setup.py install for mozInstall 17:24:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Running setup.py install for mozleak 17:24:16 INFO - Running setup.py install for mozlog 17:24:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Running setup.py install for moznetwork 17:24:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Running setup.py install for mozprocess 17:24:16 INFO - Running setup.py install for mozprofile 17:24:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:24:16 INFO - Running setup.py install for mozrunner 17:24:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:24:17 INFO - Running setup.py install for mozscreenshot 17:24:17 INFO - Running setup.py install for moztest 17:24:17 INFO - Running setup.py install for mozversion 17:24:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:24:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:24:17 INFO - Cleaning up... 17:24:17 INFO - Return code: 0 17:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:17 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 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:24:17 INFO - Using env: {'DISPLAY': ':0', 17:24:17 INFO - 'HOME': '/home/cltbld', 17:24:17 INFO - 'LANG': 'en_US.UTF-8', 17:24:17 INFO - 'LANGUAGE': 'en_US:en', 17:24:17 INFO - 'LOGNAME': 'cltbld', 17:24:17 INFO - 'MAIL': '/var/mail/cltbld', 17:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:17 INFO - 'MOZ_NO_REMOTE': '1', 17:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:17 INFO - 'NO_EM_RESTART': '1', 17:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:17 INFO - 'PWD': '/builds/slave/test', 17:24:17 INFO - 'SHELL': '/bin/bash', 17:24:17 INFO - 'SHLVL': '1', 17:24:17 INFO - 'TERM': 'linux', 17:24:17 INFO - 'TMOUT': '86400', 17:24:17 INFO - 'USER': 'cltbld', 17:24:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:17 INFO - '_': '/tools/buildbot/bin/python'} 17:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:17 INFO - Running setup.py (path:/tmp/pip-_f8JQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:17 INFO - Running setup.py (path:/tmp/pip-ox4VR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:17 INFO - Running setup.py (path:/tmp/pip-e2_pXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:17 INFO - Running setup.py (path:/tmp/pip-VDMwv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:17 INFO - Running setup.py (path:/tmp/pip-9rkv_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:17 INFO - Running setup.py (path:/tmp/pip-5A8yqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:18 INFO - Running setup.py (path:/tmp/pip-rN5tHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:18 INFO - Running setup.py (path:/tmp/pip-SkgbsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:18 INFO - Running setup.py (path:/tmp/pip-V_hKnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:18 INFO - Running setup.py (path:/tmp/pip-ms2Rtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:18 INFO - Running setup.py (path:/tmp/pip-SiTSv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:18 INFO - Running setup.py (path:/tmp/pip-jMNxtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:18 INFO - Running setup.py (path:/tmp/pip-S9T2Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:18 INFO - Running setup.py (path:/tmp/pip-mAL13r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:18 INFO - Running setup.py (path:/tmp/pip-5Po_YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:18 INFO - Running setup.py (path:/tmp/pip-A6b55I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:18 INFO - Running setup.py (path:/tmp/pip-aggB2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:24:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:20 INFO - Downloading blessings-1.6.tar.gz 17:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:24:20 INFO - Installing collected packages: blessings 17:24:20 INFO - Running setup.py install for blessings 17:24:20 INFO - Successfully installed blessings 17:24:20 INFO - Cleaning up... 17:24:20 INFO - Return code: 0 17:24:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:21 INFO - Reading from file tmpfile_stdout 17:24:21 INFO - Current package versions: 17:24:21 INFO - argparse == 1.2.1 17:24:21 INFO - blessings == 1.6 17:24:21 INFO - blobuploader == 1.2.4 17:24:21 INFO - docopt == 0.6.1 17:24:21 INFO - manifestparser == 1.1 17:24:21 INFO - mozInstall == 1.12 17:24:21 INFO - mozcrash == 0.17 17:24:21 INFO - mozdebug == 0.1 17:24:21 INFO - mozdevice == 0.48 17:24:21 INFO - mozfile == 1.2 17:24:21 INFO - mozhttpd == 0.7 17:24:21 INFO - mozinfo == 0.9 17:24:21 INFO - mozleak == 0.1 17:24:21 INFO - mozlog == 3.2 17:24:21 INFO - moznetwork == 0.27 17:24:21 INFO - mozprocess == 0.22 17:24:21 INFO - mozprofile == 0.28 17:24:21 INFO - mozrunner == 6.11 17:24:21 INFO - mozscreenshot == 0.1 17:24:21 INFO - mozsystemmonitor == 0.3 17:24:21 INFO - moztest == 0.7 17:24:21 INFO - mozversion == 1.4 17:24:21 INFO - psutil == 3.1.1 17:24:21 INFO - requests == 1.2.3 17:24:21 INFO - wsgiref == 0.1.2 17:24:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:21 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 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:24:21 INFO - Using env: {'DISPLAY': ':0', 17:24:21 INFO - 'HOME': '/home/cltbld', 17:24:21 INFO - 'LANG': 'en_US.UTF-8', 17:24:21 INFO - 'LANGUAGE': 'en_US:en', 17:24:21 INFO - 'LOGNAME': 'cltbld', 17:24:21 INFO - 'MAIL': '/var/mail/cltbld', 17:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:21 INFO - 'MOZ_NO_REMOTE': '1', 17:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:21 INFO - 'NO_EM_RESTART': '1', 17:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:21 INFO - 'PWD': '/builds/slave/test', 17:24:21 INFO - 'SHELL': '/bin/bash', 17:24:21 INFO - 'SHLVL': '1', 17:24:21 INFO - 'TERM': 'linux', 17:24:21 INFO - 'TMOUT': '86400', 17:24:21 INFO - 'USER': 'cltbld', 17:24:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:21 INFO - '_': '/tools/buildbot/bin/python'} 17:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:24:21 INFO - Cleaning up... 17:24:21 INFO - Return code: 0 17:24:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24: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', 'jsonschema'] in /builds/slave/test/build 17:24: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 jsonschema 17:24:21 INFO - Using env: {'DISPLAY': ':0', 17:24:21 INFO - 'HOME': '/home/cltbld', 17:24:21 INFO - 'LANG': 'en_US.UTF-8', 17:24:21 INFO - 'LANGUAGE': 'en_US:en', 17:24:21 INFO - 'LOGNAME': 'cltbld', 17:24:21 INFO - 'MAIL': '/var/mail/cltbld', 17:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:21 INFO - 'MOZ_NO_REMOTE': '1', 17:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:21 INFO - 'NO_EM_RESTART': '1', 17:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:21 INFO - 'PWD': '/builds/slave/test', 17:24:21 INFO - 'SHELL': '/bin/bash', 17:24:21 INFO - 'SHLVL': '1', 17:24:21 INFO - 'TERM': 'linux', 17:24:21 INFO - 'TMOUT': '86400', 17:24:21 INFO - 'USER': 'cltbld', 17:24:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:21 INFO - '_': '/tools/buildbot/bin/python'} 17:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:21 INFO - Downloading/unpacking jsonschema 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:23 INFO - Downloading/unpacking functools32 (from jsonschema) 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:23 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:23 INFO - warning: no files found matching '*.txt' 17:24:23 INFO - no previously-included directories found matching 'build' 17:24:23 INFO - no previously-included directories found matching 'dist' 17:24:23 INFO - no previously-included directories found matching '.git*' 17:24:23 INFO - Installing collected packages: jsonschema, functools32 17:24:23 INFO - Running setup.py install for functools32 17:24:23 INFO - warning: no files found matching '*.txt' 17:24:23 INFO - no previously-included directories found matching 'build' 17:24:23 INFO - no previously-included directories found matching 'dist' 17:24:23 INFO - no previously-included directories found matching '.git*' 17:24:23 INFO - Successfully installed jsonschema functools32 17:24:23 INFO - Cleaning up... 17:24:23 INFO - Return code: 0 17:24:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:23 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 0x7f1bd4948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, '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': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:24:23 INFO - Using env: {'DISPLAY': ':0', 17:24:23 INFO - 'HOME': '/home/cltbld', 17:24:23 INFO - 'LANG': 'en_US.UTF-8', 17:24:23 INFO - 'LANGUAGE': 'en_US:en', 17:24:23 INFO - 'LOGNAME': 'cltbld', 17:24:23 INFO - 'MAIL': '/var/mail/cltbld', 17:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:23 INFO - 'MOZ_NO_REMOTE': '1', 17:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:23 INFO - 'NO_EM_RESTART': '1', 17:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:23 INFO - 'PWD': '/builds/slave/test', 17:24:23 INFO - 'SHELL': '/bin/bash', 17:24:23 INFO - 'SHLVL': '1', 17:24:23 INFO - 'TERM': 'linux', 17:24:23 INFO - 'TMOUT': '86400', 17:24:23 INFO - 'USER': 'cltbld', 17:24:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:23 INFO - '_': '/tools/buildbot/bin/python'} 17:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:24 INFO - Downloading/unpacking flake8 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:24:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:24:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:24:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:24:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:24:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:24:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:24:26 INFO - no previously-included directories found matching 'docs/_build' 17:24:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:24:26 INFO - Running setup.py install for pep8 17:24:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:24:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:24:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:24:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:24:26 INFO - no previously-included directories found matching 'docs/_build' 17:24:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:24:26 INFO - Cleaning up... 17:24:27 INFO - Return code: 0 17:24:27 INFO - Running post-action listener: _resource_record_post_action 17:24:27 INFO - Running post-action listener: _start_resource_monitoring 17:24:27 INFO - Starting resource monitoring. 17:24:27 INFO - ##### 17:24:27 INFO - ##### Finished create-virtualenv step (success) 17:24:27 INFO - ##### 17:24:27 INFO - ##### 17:24:27 INFO - ##### Running install step. 17:24:27 INFO - ##### 17:24:27 INFO - Running pre-action listener: _resource_record_pre_action 17:24:27 INFO - Running main action method: install 17:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:27 INFO - Reading from file tmpfile_stdout 17:24:27 INFO - Detecting whether we're running mozinstall >=1.0... 17:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:24:27 INFO - Reading from file tmpfile_stdout 17:24:27 INFO - Output received: 17:24:27 INFO - Usage: mozinstall [options] installer 17:24:27 INFO - Options: 17:24:27 INFO - -h, --help show this help message and exit 17:24:27 INFO - -d DEST, --destination=DEST 17:24:27 INFO - Directory to install application into. [default: 17:24:27 INFO - "/builds/slave/test"] 17:24:27 INFO - --app=APP Application being installed. [default: firefox] 17:24:27 INFO - mkdir: /builds/slave/test/build/application 17:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:24:43 INFO - Reading from file tmpfile_stdout 17:24:43 INFO - Output received: 17:24:43 INFO - /builds/slave/test/build/application/firefox/firefox 17:24:43 INFO - Running post-action listener: _resource_record_post_action 17:24:43 INFO - ##### 17:24:43 INFO - ##### Finished install step (success) 17:24:43 INFO - ##### 17:24:43 INFO - ##### 17:24:43 INFO - ##### Running run-tests step. 17:24:43 INFO - ##### 17:24:43 INFO - Running pre-action listener: _resource_record_pre_action 17:24:43 INFO - Running main action method: run_tests 17:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:24:43 INFO - Python 2.7.3 17:24:43 INFO - Return code: 0 17:24:43 INFO - grabbing minidump binary from tooltool 17:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:43 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 0x15529c0>, '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 0x15538c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1553d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:24:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:24:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:24:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:24:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:24:43 INFO - Return code: 0 17:24:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:24:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:24:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:24:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:24:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:24:44 INFO - Return code: 0 17:24:44 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/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:24:44 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/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:24:44 INFO - Using env: {'DISPLAY': ':0', 17:24:44 INFO - 'HOME': '/home/cltbld', 17:24:44 INFO - 'LANG': 'en_US.UTF-8', 17:24:44 INFO - 'LANGUAGE': 'en_US:en', 17:24:44 INFO - 'LOGNAME': 'cltbld', 17:24:44 INFO - 'MAIL': '/var/mail/cltbld', 17:24:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:24:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:44 INFO - 'MOZ_NO_REMOTE': '1', 17:24:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:44 INFO - 'NO_EM_RESTART': '1', 17:24:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:44 INFO - 'PWD': '/builds/slave/test', 17:24:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:24:44 INFO - 'SHELL': '/bin/bash', 17:24:44 INFO - 'SHLVL': '1', 17:24:44 INFO - 'TERM': 'linux', 17:24:44 INFO - 'TMOUT': '86400', 17:24:44 INFO - 'USER': 'cltbld', 17:24:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463617225.344664-188601395', 17:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:44 INFO - '_': '/tools/buildbot/bin/python'} 17:24:44 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/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:24:45 INFO - mozversion application_buildid: 20160518143017 17:24:45 INFO - mozversion application_changeset: 536b16b34e0f0132322cb82f0e0a1554877bbdc0 17:24:45 INFO - mozversion application_display_name: Nightly 17:24:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:24:45 INFO - mozversion application_name: Firefox 17:24:45 INFO - mozversion application_remotingname: firefox 17:24:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:24:45 INFO - mozversion application_vendor: Mozilla 17:24:45 INFO - mozversion application_version: 49.0a1 17:24:45 INFO - mozversion platform_buildid: 20160518143017 17:24:45 INFO - mozversion platform_changeset: 536b16b34e0f0132322cb82f0e0a1554877bbdc0 17:24:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:24:45 INFO - mozversion platform_version: 49.0a1 17:24:45 INFO - using testdate: 1463617485 17:24:45 INFO - actual date: 1463617485 17:24:45 INFO - starting webserver on 'localhost:40694' 17:24:45 INFO - SUITE-START | Running 2 tests 17:24:45 INFO - TEST-START | dromaeo_css 17:24:45 INFO - operating with platform_type : linux_ 17:24:45 INFO - Initialising browser for dromaeo_css test... 17:24:45 INFO - TEST-INFO | started process 3950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbvD5cc/profile http://localhost:40694/getInfo.html) 17:24:49 INFO - PROCESS | 3950 | __metrics Screen width/height:1600/1200 17:24:49 INFO - PROCESS | 3950 | colorDepth:24 17:24:49 INFO - PROCESS | 3950 | Browser inner width/height: 1024/697 17:24:49 INFO - PROCESS | 3950 | __metrics 17:24:51 ERROR - PROCESS | 3950 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:24:52 INFO - TEST-INFO | 3950: exit 0 17:24:52 INFO - Browser initialized. 17:24:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:24:52 INFO - TEST-INFO | started process 4031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbvD5cc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:04 INFO - PROCESS | 4031 | RSS: Main: 152158208 17:25:04 INFO - PROCESS | 4031 | 17:25:55 INFO - PROCESS | 4031 | 1463617555419 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:28:03 INFO - PROCESS | 4031 | Cycle 1(1): loaded http://localhost:40694/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40694/tests/dromaeo/cssquery-ext.html) 17:28:04 INFO - PROCESS | 4031 | RSS: Main: 261201920 17:28:04 INFO - PROCESS | 4031 | 17:31:06 INFO - PROCESS | 4031 | Cycle 1(1): loaded http://localhost:40694/tests/dromaeo/cssquery-ext.html (next: http://localhost:40694/tests/dromaeo/cssquery-jquery.html) 17:31:07 INFO - PROCESS | 4031 | RSS: Main: 236208128 17:31:07 INFO - PROCESS | 4031 | 17:34:09 INFO - PROCESS | 4031 | Cycle 1(1): loaded http://localhost:40694/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40694/tests/dromaeo/cssquery-mootools.html) 17:34:09 INFO - PROCESS | 4031 | RSS: Main: 244506624 17:34:09 INFO - PROCESS | 4031 | 17:37:11 INFO - PROCESS | 4031 | Cycle 1(1): loaded http://localhost:40694/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40694/tests/dromaeo/cssquery-prototype.html) 17:37:12 INFO - PROCESS | 4031 | RSS: Main: 232177664 17:37:12 INFO - PROCESS | 4031 | 17:40:14 INFO - PROCESS | 4031 | Cycle 1(1): loaded http://localhost:40694/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40694/tests/dromaeo/cssquery-yui.html) 17:40:15 INFO - PROCESS | 4031 | RSS: Main: 234356736 17:40:15 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | Cycle 1(1): loaded http://localhost:40694/tests/dromaeo/cssquery-yui.html (next: http://localhost:40694/tests/dromaeo/cssquery-dojo.html) 17:43:18 INFO - PROCESS | 4031 | RSS: Main: 271024128 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | __start_tp_report 17:43:18 INFO - PROCESS | 4031 | _x_x_mozilla_page_load 17:43:18 INFO - PROCESS | 4031 | _x_x_mozilla_page_load_details 17:43:18 INFO - PROCESS | 4031 | |i|pagename|runs| 17:43:18 INFO - PROCESS | 4031 | |0;dojo.html;3080.599522062132;3083.9383212335756;3107.7358424533913;3126.71859532642;3148.1342630776535;5282.128448805947;5308;5405.594580406466;5408.107662235731;5447.400785913551;5245.973770131153;5299.60252981027;5331.360236771583;5349.117395629716;5352.759125839337;4870.65905386623;4887.413510378759;4897.191963326047;4905.632077594177;5017.5484206421415;4924.975375123119;4928.137575924199;4962.0820148272505;4978.178600530926;4986.252062190664;4777.689450185744;4785.928211076819;4786.784594693212;4813.735244561531;4838.588719958772;4822.300766388854;4896.192128298862;4907.386576677915;4911.926321105187;4939.629527785431;4683.414573178353;4728.645351598644;4858.805647774085;4890.73100979446;4919.08996835583;5248.842534723926;5355.116405793039;5357.223202635635;5358.785648574052;5366.490183432567;5708.828735137952;5718.885622287573;5727.914081288784;5755.712214389264;5761.164631128505;5606.6636001840025;5633.464820842013;5658.292713410824;5762.510186634141;5820.214271073435;5337.4662533746705;5361.705106219118;5364.597655175878;5367.704776237305;5369.516743493065;5843.035899076604;5845.298564172242;5849.356570777211;5850.619709718854;5851.61964472308;5457.536109430743;5525.834224973257;5548.889022219614;5579.721013949286;5585.413531579125;5783.739731712083;5786.958347497491;5790.276215473066;5831.591788574759;5845.444682755132;5747.741351639186;5762.683052432073;5765.019946609086;5765.279340082489;5767.307923049261;5599.916001259984;5700.6009579329875;5746.396628354046;5766.740496677659;5814.127880817911;4396.780160991938;4406.845760398435;4413.7351758894565;4417.293233082755;4448.822047118079;3852.287326844543;3925.21495700861;3939.995301198176;3954.7231693781737;3956.782376969237;5399.055165346049;5429.158480435539;5447.891042179134;5471.699056551928;5493.917591236134;5772.538196944234;5777.826665200051;5782.132680098019;5786.045302525036;5789.9710501447225;5309.946900530946;5314.548263397577;5452.291202143696;5462.344518657707;5477.835664930059;4875.853724388274;4909.459959404463;4918.704877707349;4921.606271498343;4956.925646115311;5806.477417032487;5814.738336774855;5826.184334193216;5828.368702703488;5883.352831188566;5675.57433192504;5730.885382292414;5760.596758227051;5775.595708300379;5786.392428795084;5843.29880414336;5865.618734782225;5874.353821079592;5882.352941176381;5894.528437725057;5664.433556644302;5686.57350698691;5693.003724348306;5695.658260504383;5697.601167918206;5583.274174357308;5675.971620141873;5725.627834190931;5749.1663708762835;5803.419658034163;5619.971900140473;5636.88726225465;5640.294963129609;5644.491995720241;5645.322561292671;5575.330960284629;5616.157576363578;5636.802711905064;5637.605367624391;5646.548276137982;5393;5422.48486393792;5436.646617969819;5502.0371434997915;5523.696196709219;5623.8594035149445;5632.605717599892;5655.349634791887;5681.77272909079;5705.828825135252;5398.703071330958;5547.33431988164;5549.5837812165055;5552.305961754781;5591.496765291144 17:43:18 INFO - PROCESS | 4031 | |1;ext.html;609.548933788996;655.4821690864217;659.8416380068785;664.1830548425435;668.5888178770052;33232.83383583082;33989.490157647626;34016;44058.33912491315;45014.54985450144;45754.025988310736;46350.304745428846;46352.76823615877;46525.069498610006;46552.534474655244;8934.687285945009;9099.04460031697;9121.452712837217;9130.041345658676;9135.13216244459;8933.687320943769;9080.273578113734;9096.181343679067;9101.226395756335;9101.226395756368;9076;9128.72613821583;9150.588223529923;9154.084591540859;9154.359194856363;9054.049324820899;9090.090990900922;9111.49886756228;9115.22520585751;9116.133967273132;8738.519381434018;8840.646374145026;8843.911560884373;8844.33667474942;8846.380753347268;43879.34180987288;44331.33502997458;44378;44432;44444.77777611124;3595.7482976191677;3704.240630670706;3778.2254637799183;3812.218495208476;4076.1236334188293;33588.32823343544;34059.65940340614;34399.484007739906;34439;35241.823790881135;4375.912481750347;4383.364412160219;4429.734215947054;4430.844920427802;4475.39582156408;246928;248339;248533.757331214;249298;250159;54505.45494545083;58756.7062164695;60113;60650.39349606448;60802;59939.70030149821;65162.34837651657;65223;65266.347336526975;65334.673326634016;15753.44862929792;15932.522024339289;15962.60093497672;15966.201689915457;15976.680466390608;11694.824577631342;11714;11786.469608867621;11802.822957655642;11813.1140164488;16702.916485417496;16862.325506979585;17142.657146857244;17284.65430691379;17479.38822141219;6722.193336799615;6757.222919364238;6827.317268273232;6997;7043.330883566053;971.2133172130597;1065.8188108021654;1069.9679009629724;1106.269861891148;1136.1829025844931;33812.80965139445;34132.31735365279;34187.65812341894;34275.14312142217;34289.39961304077;1124.8031594470935;1151.6890439581434;1169.7426566155432;1192.3322939153927;1196.7427003194355;17699.38052168194;17799.199036043152;18065.367712130013;18131.54671133206;18170.2738239867;489607;492909;493599;495322;498802;61065;61785.38214617886;61940.07089893655;61956;62023.37976620266;1306.9869301307056;1406.7327207830479;1407.2119613016744;1412.555045160771;1424.1241636393543;31117.222069448446;34825.303493929474;35125.64874351326;35301.29397411986;35649.82175089108;51112.74443627758;51675.483245167066;51786.741066294424;51793;51989.7400512995;321811;325353;326159;326876;328328;36918.815405922796;42000.789996049825;42520.57479425166;43390;43959.78020109879;49828.25257621211;49836.75081624569;50479;50522.49477505178;51329.48670513247;39563.2087358257;42614;42887.78556107199;43280.567194327654;43286.56713432951;41751;41838.372424414265;42416.1516769669;42486.78756606197;43247.56752432435;42344.153116936875;42796.35805462858;43214.351784722625;43684.344734828366;43853.56146438495;36926.815365923;37822.676206332646;37862.45650521955;38435.80782096072;38685.80657096697;28660.713392866637;29212.415751685272;29266;29268.41463170682;29332.560011599417 17:43:18 INFO - PROCESS | 4031 | |2;jquery.html;403.28618345528406;414.5025968837395;415.2145773175345;419.5573669778383;419.58670709351264;18623.813761862377;18903.905480472597;19528.41414757556;19752.70370944437;19773.60452790945;12433.751324973495;12464.875351246485;12565.308908010056;15779.211039448039;18902.527436814085;5022.321986531808;5108.438071812097;5311.415744268127;5332;5346.545543628797;5263.289455923459;5272;5288.0745869472885;5314.9468505314835;5315.867103322409;5271.367435907697;5283.498067683564;5293.814716484924;5327.973360133194;5807.622504537191;5742.6841523716175;5769.798057068025;5779.248697669318;5793.536517078624;5800.245968024151;5038.84883453497;5242.8689282767855;5248.6588371755715;5335.51980321769;5337.919931200996;13879.791803122962;14199.716005679931;14241.78637320441;14252.21612811295;14504.129752214796;2193.9451513712124;2244.6184148694597;2262.830287728427;2332.9066837326486;2352.823538234622;9861;10232.948835255776;10391.064804167661;12442.191257568229;13625.863741362558;1941.2429152630486;1953.8925359105244;2162.5350549631903;2229.9108035678555;2285.108807565051;80855;95087;96731;96978.9999999993;99450.50274748652;16078.678426431406;17303.826961730472;17494.125293735262;18061;18068.36760713369;32541.51187732186;32594.83702581519;32946.835265823516;32979.83510082482;33010.66989330124;9411.10594493522;9831.950840245752;10030.899691003142;10369.429681367597;10377.117944974761;8771.122887711177;8781.209691127702;8784.516851573226;8869.73390798277;8930.642774289086;8819.735407937773;8903.551523331136;8912.777180570409;8957.283417326598;9214.262858971266;3222.4038552867796;3345.782524135972;3363.983180084084;3404.3531728971416;3509.6314886937016;939.7556635274877;1038.8285932821;1061.7717190804015;1115.068917453935;1125.898669119783;19018.144183511777;19408.32070877541;19411.223551058083;19471.318503852297;19717;1004.9296549241483;1015.7968406318765;1022.4070039377143;1056.8890266521905;1132.5696235430485;10506.73733156662;10987.285826421257;11077;11089.889101109047;11128.165387595962;496608;501940;506161;517281;522630;86188.56905715431;86936.56531717301;87636;89477;89754.55122724344;1023.2683631203726;1042.8070806900748;1057.603398725478;1060.6605886116522;1086.1528008153653;17245.137743113046;17398.826011740228;17588.38440654571;17712.734308985633;17724.46826595204;29231.561526577545;36503.26993460169;40187.79906100451;41258.587414125475;41303.38044929269;53591.464085358646;56469.43530564806;56893.71553142208;57023;57125.42874571201;8523.786905327417;8970.641174352953;9024.774380640536;9074.546272686472;9193.724188274362;12687.936560317139;13804.585862424143;13875.861241387456;13930.512432064828;14011.719765604834;12182.634520964386;12229.93885030569;12429.875701242872;12604.306763128116;12689.175203611736;11896.940515297369;11975.76048479043;12161.331126787758;12279.140460167702;12601.306928118674;12413.255204687748;12576.937115314366;12712.237265764084;12713.55502557406;12784.296863672587;8780;8948.105189481;9058.547072646474;9208.171264586219;9315.534223288672;11846.466908989289;12551.811722823983;12553.748925021266;12569.1201615886;12582.24506529611 17:43:18 INFO - PROCESS | 4031 | |3;mootools.html;1378.800073989271;1530.0284319457148;1551.224387806097;1688.9746653800196;1846.3722334406307;8750.256228220602;9104.817903641931;9169.81660366793;9394.812103757939;9403.059694030593;9109.134632209945;9154.542272886363;9192.954035229814;9245.16793488586;9261.768455788591;2019.5153163240864;2337.801286890616;2377.6909001829736;2407.9398015049587;2412.7707867752533;2439.7194322652945;2453.582890908541;2456.5946618807875;2458.8032957363457;2459.102427613917;2156.687280344357;2179.3135162423864;2288.7139107611547;2354.2937118864356;2360.36270207044;1995.4512509060053;2266.5920134375806;2318.4088057545387;2340.2862127051244;2356.481574053714;2344.1326709117566;2358.705161854768;2361.2089949866813;2362.574736547421;2364.3261670424017;9116.407433516866;9166.724998250063;9169.724908252763;9173;9178.67874624385;5189.273501709764;5270.4729527047375;5271.710055946922;5272;5279.1817268323475;3338.2989572189867;3360.6471320511237;3512.929741405183;3523;3537.0803591066506;1114.3481063577735;1130.8982191602795;1141;1143.3425780176433;1144.7824913266536;12306.138570300083;12320.876791232062;12341.074419418579;12352.567660131943;12365.010799136047;4656.906861862743;4690.7654617269;4775.904481910342;4785.353977213102;4785.832495862628;10684.946575267073;10718.08896243828;10721.303115297636;10724.088452481627;10728.141748660088;5220.425753167148;5276.973615131899;5284.154535274338;5284.497972692588;5286.127788914863;4592.471865735416;4878.512148785164;4947.084789313988;5059.316992206079;5117.002184573972;4243.3634954757035;4289.163613095417;4319.503257125471;4343.305071188658;4356.324769660708;1344.8050032745393;1368.2418092750768;1377.9517716880061;1378.4555100735154;1383.3429121167567;851.9914800851913;951.2247518272586;998.0668075349571;1013.4122209118693;1028.5525796278644;5882.617629854046;6145.5698101133385;6235.532335074797;6244.375562443719;6408.391202835724;438.9517153113155;446.698478526993;452.36894532127496;454.65446260842;458.54145854145855;3916.236333914859;3923.313420151519;4037.273290807624;4047.352423612208;4105.712600117963;11481.253718508271;11838.052955763518;11899.98850097734;11931.224470409396;11957.521699131938;11634.418279086012;11645.47595358194;11646.126540509496;11646.475908583965;11663.125265605113;7957.323627491613;8156.959215203886;8285.95857020711;8450.746477605804;8663.870041949376;5928.318243402064;6047.939520604914;6098.451139397475;6146.846328841814;6160.722767475385;10674.626388076691;10857.457127143769;11024.44877756125;11069.335839849635;11075;11147.944260278648;11326.546938122383;11332.716682083013;11410.543578256777;11521.423928803693;7235.131784185932;7918;8182.959085204536;8269.255766981001;8403.789905252417;9315.534223288943;9331.346805723535;9360.15758581731;9397.812043759222;9402.52987350616;7987;8238.83522329562;8245.587720614065;8269.62786674589;8480.660773568989;7932.682692692459;8152.2662960333855;8152.796180095545;8166.632501537564;8367.163283671583;7005.089338386181;7053.506254562131;7069.187043490065;7094.751683691046;7103.076600041962;5054.444011158843;5102.260172275073;5148.382194136728;5187.792488300426;5196.636235463632;5168.095583272837;5194.246834209094;5202.817901373433;5204.765785539584;5258.921116183184 17:43:18 INFO - PROCESS | 4031 | |4;prototype.html;308.18946171568786;320.5144206527111;324.8116092666253;327.34040907571233;330.67428582845895;5380.461953804617;5424.159255315432;5432.239486471887;5452.263944367509;5466.835994920154;5075.035743208788;5169.405518365389;5247.370315562129;5329.2006199070065;5365.087935051041;4090.2433049885867;4161.604647558477;4163.437935878648;4174.144300418422;4187.811548480326;4145.212409642173;4161.41866090885;4173.123644034741;4184.4141820145205;4197.265478541243;3976.76139431635;3983.4423180754575;4084.938725919099;4119.423280740699;4135.862637774621;4076.3070278052505;4085.611866872642;4114.382842573623;4115.341545352744;4120.793960302003;3623.492711020433;3636.5272514573203;3655.342038433081;3661.3043521730788;3666.863272385542;4870;5148.845534633967;5170.689758614495;5172.508611681884;5178.97410512945;4654.813807447698;4677.087967846272;4687;4705.988212534322;4720.088364212499;5538.9169162462595;5561.805336813192;5573.498385145356;5594.636348637326;5613.635113717595;3845.5193100862393;3906.257811015898;3957.762534247954;3959.425883246913;3968.72218944674;5743.253377060997;5773.220615216976;5800.346901133199;5813.796517121923;5831.737571809279;3990.5035611645635;4014.437978682987;4015.7791321477016;4042.130941847517;4062.309407400749;3901.297766402075;4053.574374690674;4092.631663150331;4095.9385609215888;4119.340905455113;4648.604868586141;4666.603338716247;4686.320483529869;4691.507391723888;4695.765211739399;5522.447755224526;5537.944620553823;5571.721413929287;5581.665100094007;5620.18507316445;1352.6212660455087;1390.5480718766441;1394.5119208277022;1407.7606806842862;1412.484443178253;887.6862243878966;892.5269607108243;900.6397441023643;906.6264609117193;908.8500397434482;4748.264019077049;4785.904281914342;4848.903021939612;4897.3878265216845;4910.729909854921;5175.661698204637;5196.402413722395;5215.973920130375;5227.26818245446;5249;4610.4697959734385;4834.830780922721;4891.315215869781;4894.706317620954;4915.837031706038;2713.972860271372;2719.442514284567;2739.493278696709;2754.559270516708;2760.806743527974;5128.692278463304;5231.9476805232225;5236.895262094813;5237.397699264633;5266.0257852297445;5190.662606930613;5190.92213616796;5191.844244672666;5358.91961620576;5852.356240813507;5864.618799778001;5876.236089308362;5881.617819812341;5907.881842363128;5911.615744976562;5661.490465858093;5732.828015159552;5739.598228124159;5780.566457515619;5786.739596718074;5521.861953451196;5678.296511046752;5706.771729130788;5726.9713651431475;5745.597808153389;5910.867240362615;5946.226990491208;5964.463198312173;5979.40205979416;5989.251343582052;3809.684897569297;4035.1526179502634;4060.127072679388;4071.429999799971;4072.837086516506;4933.235348520985;5784.884302314014;5789.957807594674;5800.1299805029585;5802;5540.529055030368;5598.188262701967;5605.299337582802;5609.21470994053;5652.802151924828;5387.353517577759;5460.180972854104;5599.356074051536;5618.269624948894;5618.353889302619;5483.725813709379;5486.506214440719;5486.945130548803;5495.587830912617;5529.004779139794;5577.247071645438;5590.636608620427;5597.160425936142;5601.831945041656;5647.887042259214;5418.268533747893;5462.289902312674;5476.945230547643;5519.475649813261;5552.7223638818705 17:43:18 INFO - PROCESS | 4031 | |5;yui.html;775.7982924439644;808.4421748993198;843.1669787672522;853.2747164909831;867.5402036920431;14886.181260030708;15287.847121528781;15363.462278820243;15367.615809604766;15421.999999999985;13484.190948543095;13553.457861685545;13555.52555660552;13570.050096493249;13571.389287482063;697.2017040488638;818.758466252457;842.8187939592987;845.9027211870622;846.0143932318841;837.660747397305;842.3682238321259;842.6208206307156;845.6955496021427;846.0693237438799;726.5531698005741;880.867869819529;881.6958149438434;882.1311008656468;882.7881308485981;747.7756672998106;749.6626518066864;880.3485420788602;898.2589363774912;900.6217388696698;652.7454292825802;652.9608223506557;653.0922018394435;653.3923451190391;654.169205109513;13171.275579843104;13176.472941082346;13200.933995329962;13230.27233502157;13388.263645499494;13475.460981560725;13540.119892206974;13915.79126313096;13937.09408888419;13986.300684965812;11768;11882.168248222628;11907.345096019715;12014.038876889828;12025.098117641212;4493.775311234425;4557.1051079040235;4586.610138138262;4594.609458196057;4702.177119004161;59149.70425147847;60020.39979600192;60202;60303.69848150775;60453;10840.13278937683;10963.50664220112;11192.768795432496;11206.775864482828;11421.086313094933;20599.279025234344;20669.58660826775;20675.8966205168;20685.379438616867;20685.89657051735;8640.351973602004;8728.083551227157;8747.195935406176;8761.211490965843;8868.423552469068;4804.25534042217;4831.879203019953;4903.6077113831525;4937.901241975141;4938.827141050046;3454.516367708523;3639.6542328478754;3640.9635903641156;3666.3217304798163;3669.2478042001326;649.95775274607;654.2508827392609;655.9344065593402;673.474689742002;674.6356967237637;652.7128063651978;763.5304287863036;773.8490994256066;777.0908037596026;800.727752564131;10110.887802341736;10235.897641023643;10560.52477638508;10631.415272160106;10649.307794993301;626.5801912718398;712.9719360006366;732.6886073418775;740.326303064209;757.3297631596078;4676.228422310349;4685.557423192032;4708.434987801417;4719.716816990923;4905.411350637946;66859.66570167118;67792.6610366945;67926.66036669884;68113;69443;59320.70339648274;59731;60022;62587;62773.372266276754;53067.734661325674;53572.196417053776;54157.45842541603;54198.187027194625;54941;9407.952960235156;9447.95276023643;9513.191378732885;9648.469334186688;9651.9034809651;35302.82348588241;35740.28519429649;35946.8202658985;36323.81838090793;36721.63278367289;46093.76953115213;48863.755681221366;48984;49341.2598811011;49628;11747.941260293986;11907.52369905194;12142.878571214174;12380.752384952071;12437.440315185657;12522.87477125217;12910.289934053342;13125.474981001034;13191.274479903697;13477;11273.943630281796;12824.358782060674;12849.935750321189;13137.934310328386;13561.118527295694;10917.23579349438;11201.587892321051;11429;12042.518299267931;12090.516379344728;11745.236559623598;11809.763804724029;11902.166848320534;12141.332226727262;12161.209521381083;9725.562349694423;9990.400575965175;10030.247731420319;10037.949810250902;10088;10123.949380253052;10491.213159013258;10560.366378017343;10573.682789516326;10660.573577056832 17:43:18 INFO - PROCESS | 4031 | __end_tp_report 17:43:18 INFO - PROCESS | 4031 | __start_cc_report 17:43:18 INFO - PROCESS | 4031 | _x_x_mozilla_cycle_collect,955 17:43:18 INFO - PROCESS | 4031 | __end_cc_report 17:43:18 INFO - PROCESS | 4031 | __startTimestamp1463618598295__endTimestamp 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | ------- Summary: start ------- 17:43:18 INFO - PROCESS | 4031 | Number of tests: 6 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | [#0] dojo.html Cycles:165 Average:5322.12 Median:5525.83 stddev:598.62 (10.8%) stddev-sans-first:574.05 17:43:18 INFO - PROCESS | 4031 | Values: 3080.6 3083.9 3107.7 3126.7 3148.1 5282.1 5308.0 5405.6 5408.1 5447.4 5246.0 5299.6 5331.4 5349.1 5352.8 4870.7 4887.4 4897.2 4905.6 5017.5 4925.0 4928.1 4962.1 4978.2 4986.3 4777.7 4785.9 4786.8 4813.7 4838.6 4822.3 4896.2 4907.4 4911.9 4939.6 4683.4 4728.6 4858.8 4890.7 4919.1 5248.8 5355.1 5357.2 5358.8 5366.5 5708.8 5718.9 5727.9 5755.7 5761.2 5606.7 5633.5 5658.3 5762.5 5820.2 5337.5 5361.7 5364.6 5367.7 5369.5 5843.0 5845.3 5849.4 5850.6 5851.6 5457.5 5525.8 5548.9 5579.7 5585.4 5783.7 5787.0 5790.3 5831.6 5845.4 5747.7 5762.7 5765.0 5765.3 5767.3 5599.9 5700.6 5746.4 5766.7 5814.1 4396.8 4406.8 4413.7 4417.3 4448.8 3852.3 3925.2 3940.0 3954.7 3956.8 5399.1 5429.2 5447.9 5471.7 5493.9 5772.5 5777.8 5782.1 5786.0 5790.0 5309.9 5314.5 5452.3 5462.3 5477.8 4875.9 4909.5 4918.7 4921.6 4956.9 5806.5 5814.7 5826.2 5828.4 5883.4 5675.6 5730.9 5760.6 5775.6 5786.4 5843.3 5865.6 5874.4 5882.4 5894.5 5664.4 5686.6 5693.0 5695.7 5697.6 5583.3 5676.0 5725.6 5749.2 5803.4 5620.0 5636.9 5640.3 5644.5 5645.3 5575.3 5616.2 5636.8 5637.6 5646.5 5393.0 5422.5 5436.6 5502.0 5523.7 5623.9 5632.6 5655.3 5681.8 5705.8 5398.7 5547.3 5549.6 5552.3 5591.5 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | [#1] ext.html Cycles:180 Average:54192.96 Median:43264.07 stddev:97885.72 (226.3%) stddev-sans-first:98077.63 17:43:18 INFO - PROCESS | 4031 | Values: 609.5 655.5 659.8 664.2 668.6 33232.8 33989.5 34016.0 44058.3 45014.5 45754.0 46350.3 46352.8 46525.1 46552.5 8934.7 9099.0 9121.5 9130.0 9135.1 8933.7 9080.3 9096.2 9101.2 9101.2 9076.0 9128.7 9150.6 9154.1 9154.4 9054.0 9090.1 9111.5 9115.2 9116.1 8738.5 8840.6 8843.9 8844.3 8846.4 43879.3 44331.3 44378.0 44432.0 44444.8 3595.7 3704.2 3778.2 3812.2 4076.1 33588.3 34059.7 34399.5 34439.0 35241.8 4375.9 4383.4 4429.7 4430.8 4475.4 246928.0 248339.0 248533.8 249298.0 250159.0 54505.5 58756.7 60113.0 60650.4 60802.0 59939.7 65162.3 65223.0 65266.3 65334.7 15753.4 15932.5 15962.6 15966.2 15976.7 11694.8 11714.0 11786.5 11802.8 11813.1 16702.9 16862.3 17142.7 17284.7 17479.4 6722.2 6757.2 6827.3 6997.0 7043.3 971.2 1065.8 1070.0 1106.3 1136.2 33812.8 34132.3 34187.7 34275.1 34289.4 1124.8 1151.7 1169.7 1192.3 1196.7 17699.4 17799.2 18065.4 18131.5 18170.3 489607.0 492909.0 493599.0 495322.0 498802.0 61065.0 61785.4 61940.1 61956.0 62023.4 1307.0 1406.7 1407.2 1412.6 1424.1 31117.2 34825.3 35125.6 35301.3 35649.8 51112.7 51675.5 51786.7 51793.0 51989.7 321811.0 325353.0 326159.0 326876.0 328328.0 36918.8 42000.8 42520.6 43390.0 43959.8 49828.3 49836.8 50479.0 50522.5 51329.5 39563.2 42614.0 42887.8 43280.6 43286.6 41751.0 41838.4 42416.2 42486.8 43247.6 42344.2 42796.4 43214.4 43684.3 43853.6 36926.8 37822.7 37862.5 38435.8 38685.8 28660.7 29212.4 29266.0 29268.4 29332.6 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | [#2] jquery.html Cycles:180 Average:30262.58 Median:15792.19 stddev:83869.95 (531.1%) stddev-sans-first:84075.26 17:43:18 INFO - PROCESS | 4031 | Values: 403.3 414.5 415.2 419.6 419.6 18623.8 18903.9 19528.4 19752.7 19773.6 12433.8 12464.9 12565.3 15779.2 18902.5 5022.3 5108.4 5311.4 5332.0 5346.5 5263.3 5272.0 5288.1 5314.9 5315.9 5271.4 5283.5 5293.8 5328.0 5807.6 5742.7 5769.8 5779.2 5793.5 5800.2 5038.8 5242.9 5248.7 5335.5 5337.9 13879.8 14199.7 14241.8 14252.2 14504.1 2193.9 2244.6 2262.8 2332.9 2352.8 9861.0 10232.9 10391.1 12442.2 13625.9 1941.2 1953.9 2162.5 2229.9 2285.1 80855.0 95087.0 96731.0 96979.0 99450.5 16078.7 17303.8 17494.1 18061.0 18068.4 32541.5 32594.8 32946.8 32979.8 33010.7 9411.1 9832.0 10030.9 10369.4 10377.1 8771.1 8781.2 8784.5 8869.7 8930.6 8819.7 8903.6 8912.8 8957.3 9214.3 3222.4 3345.8 3364.0 3404.4 3509.6 939.8 1038.8 1061.8 1115.1 1125.9 19018.1 19408.3 19411.2 19471.3 19717.0 1004.9 1015.8 1022.4 1056.9 1132.6 10506.7 10987.3 11077.0 11089.9 11128.2 496608.0 501940.0 506161.0 517281.0 522630.0 86188.6 86936.6 87636.0 89477.0 89754.6 1023.3 1042.8 1057.6 1060.7 1086.2 17245.1 17398.8 17588.4 17712.7 17724.5 29231.6 36503.3 40187.8 41258.6 41303.4 53591.5 56469.4 56893.7 57023.0 57125.4 8523.8 8970.6 9024.8 9074.5 9193.7 12687.9 13804.6 13875.9 13930.5 14011.7 12182.6 12229.9 12429.9 12604.3 12689.2 11896.9 11975.8 12161.3 12279.1 12601.3 12413.3 12576.9 12712.2 12713.6 12784.3 8780.0 8948.1 9058.5 9208.2 9315.5 11846.5 12551.8 12553.7 12569.1 12582.2 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | [#3] mootools.html Cycles:180 Average:6032.94 Median:456.60 stddev:3544.96 (776.4%) stddev-sans-first:3537.66 17:43:18 INFO - PROCESS | 4031 | Values: 1378.8 1530.0 1551.2 1689.0 1846.4 8750.3 9104.8 9169.8 9394.8 9403.1 9109.1 9154.5 9193.0 9245.2 9261.8 2019.5 2337.8 2377.7 2407.9 2412.8 2439.7 2453.6 2456.6 2458.8 2459.1 2156.7 2179.3 2288.7 2354.3 2360.4 1995.5 2266.6 2318.4 2340.3 2356.5 2344.1 2358.7 2361.2 2362.6 2364.3 9116.4 9166.7 9169.7 9173.0 9178.7 5189.3 5270.5 5271.7 5272.0 5279.2 3338.3 3360.6 3512.9 3523.0 3537.1 1114.3 1130.9 1141.0 1143.3 1144.8 12306.1 12320.9 12341.1 12352.6 12365.0 4656.9 4690.8 4775.9 4785.4 4785.8 10684.9 10718.1 10721.3 10724.1 10728.1 5220.4 5277.0 5284.2 5284.5 5286.1 4592.5 4878.5 4947.1 5059.3 5117.0 4243.4 4289.2 4319.5 4343.3 4356.3 1344.8 1368.2 1378.0 1378.5 1383.3 852.0 951.2 998.1 1013.4 1028.6 5882.6 6145.6 6235.5 6244.4 6408.4 439.0 446.7 452.4 454.7 458.5 3916.2 3923.3 4037.3 4047.4 4105.7 11481.3 11838.1 11900.0 11931.2 11957.5 11634.4 11645.5 11646.1 11646.5 11663.1 7957.3 8157.0 8286.0 8450.7 8663.9 5928.3 6047.9 6098.5 6146.8 6160.7 10674.6 10857.5 11024.4 11069.3 11075.0 11147.9 11326.5 11332.7 11410.5 11521.4 7235.1 7918.0 8183.0 8269.3 8403.8 9315.5 9331.3 9360.2 9397.8 9402.5 7987.0 8238.8 8245.6 8269.6 8480.7 7932.7 8152.3 8152.8 8166.6 8367.2 7005.1 7053.5 7069.2 7094.8 7103.1 5054.4 5102.3 5148.4 5187.8 5196.6 5168.1 5194.2 5202.8 5204.8 5258.9 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | [#4] prototype.html Cycles:180 Average:4601.37 Median:5190.79 stddev:1366.98 (26.3%) stddev-sans-first:1332.30 17:43:18 INFO - PROCESS | 4031 | Values: 308.2 320.5 324.8 327.3 330.7 5380.5 5424.2 5432.2 5452.3 5466.8 5075.0 5169.4 5247.4 5329.2 5365.1 4090.2 4161.6 4163.4 4174.1 4187.8 4145.2 4161.4 4173.1 4184.4 4197.3 3976.8 3983.4 4084.9 4119.4 4135.9 4076.3 4085.6 4114.4 4115.3 4120.8 3623.5 3636.5 3655.3 3661.3 3666.9 4870.0 5148.8 5170.7 5172.5 5179.0 4654.8 4677.1 4687.0 4706.0 4720.1 5538.9 5561.8 5573.5 5594.6 5613.6 3845.5 3906.3 3957.8 3959.4 3968.7 5743.3 5773.2 5800.3 5813.8 5831.7 3990.5 4014.4 4015.8 4042.1 4062.3 3901.3 4053.6 4092.6 4095.9 4119.3 4648.6 4666.6 4686.3 4691.5 4695.8 5522.4 5537.9 5571.7 5581.7 5620.2 1352.6 1390.5 1394.5 1407.8 1412.5 887.7 892.5 900.6 906.6 908.9 4748.3 4785.9 4848.9 4897.4 4910.7 5175.7 5196.4 5216.0 5227.3 5249.0 4610.5 4834.8 4891.3 4894.7 4915.8 2714.0 2719.4 2739.5 2754.6 2760.8 5128.7 5231.9 5236.9 5237.4 5266.0 5190.7 5190.9 5191.8 5358.9 5852.4 5864.6 5876.2 5881.6 5907.9 5911.6 5661.5 5732.8 5739.6 5780.6 5786.7 5521.9 5678.3 5706.8 5727.0 5745.6 5910.9 5946.2 5964.5 5979.4 5989.3 3809.7 4035.2 4060.1 4071.4 4072.8 4933.2 5784.9 5790.0 5800.1 5802.0 5540.5 5598.2 5605.3 5609.2 5652.8 5387.4 5460.2 5599.4 5618.3 5618.4 5483.7 5486.5 5486.9 5495.6 5529.0 5577.2 5590.6 5597.2 5601.8 5647.9 5418.3 5462.3 5476.9 5519.5 5552.7 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - PROCESS | 4031 | [#5] yui.html Cycles:180 Average:15621.61 Median:4705.31 stddev:18709.45 (397.6%) stddev-sans-first:18728.72 17:43:18 INFO - PROCESS | 4031 | Values: 775.8 808.4 843.2 853.3 867.5 14886.2 15287.8 15363.5 15367.6 15422.0 13484.2 13553.5 13555.5 13570.1 13571.4 697.2 818.8 842.8 845.9 846.0 837.7 842.4 842.6 845.7 846.1 726.6 880.9 881.7 882.1 882.8 747.8 749.7 880.3 898.3 900.6 652.7 653.0 653.1 653.4 654.2 13171.3 13176.5 13200.9 13230.3 13388.3 13475.5 13540.1 13915.8 13937.1 13986.3 11768.0 11882.2 11907.3 12014.0 12025.1 4493.8 4557.1 4586.6 4594.6 4702.2 59149.7 60020.4 60202.0 60303.7 60453.0 10840.1 10963.5 11192.8 11206.8 11421.1 20599.3 20669.6 20675.9 20685.4 20685.9 8640.4 8728.1 8747.2 8761.2 8868.4 4804.3 4831.9 4903.6 4937.9 4938.8 3454.5 3639.7 3641.0 3666.3 3669.2 650.0 654.3 655.9 673.5 674.6 652.7 763.5 773.8 777.1 800.7 10110.9 10235.9 10560.5 10631.4 10649.3 626.6 713.0 732.7 740.3 757.3 4676.2 4685.6 4708.4 4719.7 4905.4 66859.7 67792.7 67926.7 68113.0 69443.0 59320.7 59731.0 60022.0 62587.0 62773.4 53067.7 53572.2 54157.5 54198.2 54941.0 9408.0 9448.0 9513.2 9648.5 9651.9 35302.8 35740.3 35946.8 36323.8 36721.6 46093.8 48863.8 48984.0 49341.3 49628.0 11747.9 11907.5 12142.9 12380.8 12437.4 12522.9 12910.3 13125.5 13191.3 13477.0 11273.9 12824.4 12849.9 13137.9 13561.1 10917.2 11201.6 11429.0 12042.5 12090.5 11745.2 11809.8 11902.2 12141.3 12161.2 9725.6 9990.4 10030.2 10037.9 10088.0 10123.9 10491.2 10560.4 10573.7 10660.6 17:43:18 INFO - PROCESS | 4031 | -------- Summary: end -------- 17:43:18 INFO - PROCESS | 4031 | 17:43:18 INFO - TEST-INFO | 4031: exit 0 17:43:19 INFO - TEST-OK | dromaeo_css | took 1113904ms 17:43:19 INFO - TEST-START | kraken 17:43:19 INFO - operating with platform_type : linux_ 17:43:19 INFO - Initialising browser for kraken test... 17:43:19 INFO - TEST-INFO | started process 4210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qI9Hi/profile http://localhost:40694/getInfo.html) 17:43:22 INFO - PROCESS | 4210 | __metrics Screen width/height:1600/1200 17:43:22 INFO - PROCESS | 4210 | colorDepth:24 17:43:22 INFO - PROCESS | 4210 | Browser inner width/height: 1024/697 17:43:22 INFO - PROCESS | 4210 | __metrics 17:43:24 ERROR - PROCESS | 4210 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:43:24 INFO - TEST-INFO | 4210: exit 0 17:43:24 INFO - Browser initialized. 17:43:24 INFO - Running cycle 1/1 for kraken test... 17:43:24 INFO - TEST-INFO | started process 4292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qI9Hi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:36 INFO - PROCESS | 4292 | RSS: Main: 152731648 17:43:36 INFO - PROCESS | 4292 | 17:43:39 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40694/tests/kraken/driver.html?testName=audio-beat-detection) 17:43:40 INFO - PROCESS | 4292 | RSS: Main: 208838656 17:43:40 INFO - PROCESS | 4292 | 17:43:42 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40694/tests/kraken/driver.html?testName=audio-dft) 17:43:43 INFO - PROCESS | 4292 | RSS: Main: 197980160 17:43:43 INFO - PROCESS | 4292 | 17:43:46 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40694/tests/kraken/driver.html?testName=audio-fft) 17:43:47 INFO - PROCESS | 4292 | RSS: Main: 265728000 17:43:47 INFO - PROCESS | 4292 | 17:43:49 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40694/tests/kraken/driver.html?testName=audio-oscillator) 17:43:50 INFO - PROCESS | 4292 | RSS: Main: 174559232 17:43:50 INFO - PROCESS | 4292 | 17:43:52 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40694/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:43:52 INFO - PROCESS | 4292 | RSS: Main: 178651136 17:43:52 INFO - PROCESS | 4292 | 17:43:56 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40694/tests/kraken/driver.html?testName=imaging-darkroom) 17:43:56 INFO - PROCESS | 4292 | RSS: Main: 214487040 17:43:56 INFO - PROCESS | 4292 | 17:44:00 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40694/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:00 INFO - PROCESS | 4292 | RSS: Main: 212627456 17:44:00 INFO - PROCESS | 4292 | 17:44:03 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40694/tests/kraken/driver.html?testName=json-parse-financial) 17:44:04 INFO - PROCESS | 4292 | RSS: Main: 214130688 17:44:04 INFO - PROCESS | 4292 | 17:44:06 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40694/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:06 INFO - PROCESS | 4292 | RSS: Main: 203862016 17:44:06 INFO - PROCESS | 4292 | 17:44:08 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:09 INFO - PROCESS | 4292 | RSS: Main: 206667776 17:44:09 INFO - PROCESS | 4292 | 17:44:11 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:11 INFO - PROCESS | 4292 | RSS: Main: 216940544 17:44:11 INFO - PROCESS | 4292 | 17:44:14 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:15 INFO - PROCESS | 4292 | RSS: Main: 223195136 17:44:15 INFO - PROCESS | 4292 | 17:44:17 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:18 INFO - PROCESS | 4292 | RSS: Main: 221356032 17:44:18 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:40694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40694/tests/kraken/driver.html?testName=ai-astar) 17:44:20 INFO - PROCESS | 4292 | RSS: Main: 266608640 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | __start_tp_report 17:44:20 INFO - PROCESS | 4292 | _x_x_mozilla_page_load 17:44:20 INFO - PROCESS | 4292 | _x_x_mozilla_page_load_details 17:44:20 INFO - PROCESS | 4292 | |i|pagename|runs| 17:44:20 INFO - PROCESS | 4292 | |0;ai-astar;111;106;113;110;110;110;109;109;110;110 17:44:20 INFO - PROCESS | 4292 | |1;audio-beat-detection;158;123;150;204;124;153;150;134;187;124 17:44:20 INFO - PROCESS | 4292 | |2;audio-dft;160;160;161;160;160;161;160;160;160;160 17:44:20 INFO - PROCESS | 4292 | |3;audio-fft;73;75;74;151;75;74;76;75;127;75 17:44:20 INFO - PROCESS | 4292 | |4;audio-oscillator;92;93;147;94;94;93;123;92;92;117 17:44:20 INFO - PROCESS | 4292 | |5;imaging-gaussian-blur;116;116;117;117;116;117;117;117;117;117 17:44:20 INFO - PROCESS | 4292 | |6;imaging-darkroom;145;145;146;145;147;146;145;145;145;145 17:44:20 INFO - PROCESS | 4292 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;94 17:44:20 INFO - PROCESS | 4292 | |8;json-parse-financial;54;56;53;54;55;55;53;111;52;52 17:44:20 INFO - PROCESS | 4292 | |9;json-stringify-tinderbox;58;58;58;58;58;58;58;58;58;57 17:44:20 INFO - PROCESS | 4292 | |10;stanford-crypto-aes;80;79;84;78;79;85;82;80;80;81 17:44:20 INFO - PROCESS | 4292 | |11;stanford-crypto-ccm;117;119;116;124;123;120;126;132;195;119 17:44:20 INFO - PROCESS | 4292 | |12;stanford-crypto-pbkdf2;169;161;162;160;160;159;162;163;159;157 17:44:20 INFO - PROCESS | 4292 | |13;stanford-crypto-sha256-iterative;64;63;62;62;62;65;61;63;61;63 17:44:20 INFO - PROCESS | 4292 | __end_tp_report 17:44:20 INFO - PROCESS | 4292 | __start_cc_report 17:44:20 INFO - PROCESS | 4292 | _x_x_mozilla_cycle_collect,1845 17:44:20 INFO - PROCESS | 4292 | __end_cc_report 17:44:20 INFO - PROCESS | 4292 | __startTimestamp1463618660404__endTimestamp 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | ------- Summary: start ------- 17:44:20 INFO - PROCESS | 4292 | Number of tests: 14 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.75 (1.6%) stddev-sans-first:1.80 17:44:20 INFO - PROCESS | 4292 | Values: 111.0 106.0 113.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:151.50 stddev:27.26 (18.0%) stddev-sans-first:28.79 17:44:20 INFO - PROCESS | 4292 | Values: 158.0 123.0 150.0 204.0 124.0 153.0 150.0 134.0 187.0 124.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:44:20 INFO - PROCESS | 4292 | Values: 160.0 160.0 161.0 160.0 160.0 161.0 160.0 160.0 160.0 160.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#3] audio-fft Cycles:10 Average:87.50 Median:75.00 stddev:27.74 (37.0%) stddev-sans-first:28.92 17:44:20 INFO - PROCESS | 4292 | Values: 73.0 75.0 74.0 151.0 75.0 74.0 76.0 75.0 127.0 75.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:92.50 stddev:19.01 (20.6%) stddev-sans-first:19.69 17:44:20 INFO - PROCESS | 4292 | Values: 92.0 93.0 147.0 94.0 94.0 93.0 123.0 92.0 92.0 117.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:44:20 INFO - PROCESS | 4292 | Values: 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:44:20 INFO - PROCESS | 4292 | Values: 145.0 145.0 146.0 145.0 147.0 146.0 145.0 145.0 145.0 145.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:44:20 INFO - PROCESS | 4292 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:54.00 stddev:18.14 (33.6%) stddev-sans-first:19.13 17:44:20 INFO - PROCESS | 4292 | Values: 54.0 56.0 53.0 54.0 55.0 55.0 53.0 111.0 52.0 52.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 17:44:20 INFO - PROCESS | 4292 | Values: 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 57.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.25 (2.8%) stddev-sans-first:2.37 17:44:20 INFO - PROCESS | 4292 | Values: 80.0 79.0 84.0 78.0 79.0 85.0 82.0 80.0 80.0 81.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:123.50 stddev:23.64 (19.1%) stddev-sans-first:24.66 17:44:20 INFO - PROCESS | 4292 | Values: 117.0 119.0 116.0 124.0 123.0 120.0 126.0 132.0 195.0 119.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.50 stddev:3.26 (2.0%) stddev-sans-first:1.87 17:44:20 INFO - PROCESS | 4292 | Values: 169.0 161.0 162.0 160.0 160.0 159.0 162.0 163.0 159.0 157.0 17:44:20 INFO - PROCESS | 4292 | 17:44:20 INFO - PROCESS | 4292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 17:44:20 INFO - PROCESS | 4292 | Values: 64.0 63.0 62.0 62.0 62.0 65.0 61.0 63.0 61.0 63.0 17:44:20 INFO - PROCESS | 4292 | -------- Summary: end -------- 17:44:20 INFO - PROCESS | 4292 | 17:44:21 INFO - TEST-INFO | 4292: exit 0 17:44:21 INFO - TEST-OK | kraken | took 62397ms 17:44:21 INFO - SUITE-END | took 1176s 17:44:21 INFO - Completed test suite (00:19:36) 17:44:21 INFO - javascript benchmark 17:44:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.599522062132, 3083.9383212335756, 3107.7358424533913, 3126.71859532642, 3148.1342630776535, 5282.128448805947, 5308.0, 5405.594580406466, 5408.107662235731, 5447.400785913551, 5245.973770131153, 5299.60252981027, 5331.360236771583, 5349.117395629716, 5352.759125839337, 4870.65905386623, 4887.413510378759, 4897.191963326047, 4905.632077594177, 5017.5484206421415, 4924.975375123119, 4928.137575924199, 4962.0820148272505, 4978.178600530926, 4986.252062190664, 4777.689450185744, 4785.928211076819, 4786.784594693212, 4813.735244561531, 4838.588719958772, 4822.300766388854, 4896.192128298862, 4907.386576677915, 4911.926321105187, 4939.629527785431, 4683.414573178353, 4728.645351598644, 4858.805647774085, 4890.73100979446, 4919.08996835583, 5248.842534723926, 5355.116405793039, 5357.223202635635, 5358.785648574052, 5366.490183432567, 5708.828735137952, 5718.885622287573, 5727.914081288784, 5755.712214389264, 5761.164631128505, 5606.6636001840025, 5633.464820842013, 5658.292713410824, 5762.510186634141, 5820.214271073435, 5337.4662533746705, 5361.705106219118, 5364.597655175878, 5367.704776237305, 5369.516743493065, 5843.035899076604, 5845.298564172242, 5849.356570777211, 5850.619709718854, 5851.61964472308, 5457.536109430743, 5525.834224973257, 5548.889022219614, 5579.721013949286, 5585.413531579125, 5783.739731712083, 5786.958347497491, 5790.276215473066, 5831.591788574759, 5845.444682755132, 5747.741351639186, 5762.683052432073, 5765.019946609086, 5765.279340082489, 5767.307923049261, 5599.916001259984, 5700.6009579329875, 5746.396628354046, 5766.740496677659, 5814.127880817911, 4396.780160991938, 4406.845760398435, 4413.7351758894565, 4417.293233082755, 4448.822047118079, 3852.287326844543, 3925.21495700861, 3939.995301198176, 3954.7231693781737, 3956.782376969237, 5399.055165346049, 5429.158480435539, 5447.891042179134, 5471.699056551928, 5493.917591236134, 5772.538196944234, 5777.826665200051, 5782.132680098019, 5786.045302525036, 5789.9710501447225, 5309.946900530946, 5314.548263397577, 5452.291202143696, 5462.344518657707, 5477.835664930059, 4875.853724388274, 4909.459959404463, 4918.704877707349, 4921.606271498343, 4956.925646115311, 5806.477417032487, 5814.738336774855, 5826.184334193216, 5828.368702703488, 5883.352831188566, 5675.57433192504, 5730.885382292414, 5760.596758227051, 5775.595708300379, 5786.392428795084, 5843.29880414336, 5865.618734782225, 5874.353821079592, 5882.352941176381, 5894.528437725057, 5664.433556644302, 5686.57350698691, 5693.003724348306, 5695.658260504383, 5697.601167918206, 5583.274174357308, 5675.971620141873, 5725.627834190931, 5749.1663708762835, 5803.419658034163, 5619.971900140473, 5636.88726225465, 5640.294963129609, 5644.491995720241, 5645.322561292671, 5575.330960284629, 5616.157576363578, 5636.802711905064, 5637.605367624391, 5646.548276137982, 5393.0, 5422.48486393792, 5436.646617969819, 5502.0371434997915, 5523.696196709219, 5623.8594035149445, 5632.605717599892, 5655.349634791887, 5681.77272909079, 5705.828825135252, 5398.703071330958, 5547.33431988164, 5549.5837812165055, 5552.305961754781, 5591.496765291144], "value": 5282.0078782836645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.548933788996, 655.4821690864217, 659.8416380068785, 664.1830548425435, 668.5888178770052, 33232.83383583082, 33989.490157647626, 34016.0, 44058.33912491315, 45014.54985450144, 45754.025988310736, 46350.304745428846, 46352.76823615877, 46525.069498610006, 46552.534474655244, 8934.687285945009, 9099.04460031697, 9121.452712837217, 9130.041345658676, 9135.13216244459, 8933.687320943769, 9080.273578113734, 9096.181343679067, 9101.226395756335, 9101.226395756368, 9076.0, 9128.72613821583, 9150.588223529923, 9154.084591540859, 9154.359194856363, 9054.049324820899, 9090.090990900922, 9111.49886756228, 9115.22520585751, 9116.133967273132, 8738.519381434018, 8840.646374145026, 8843.911560884373, 8844.33667474942, 8846.380753347268, 43879.34180987288, 44331.33502997458, 44378.0, 44432.0, 44444.77777611124, 3595.7482976191677, 3704.240630670706, 3778.2254637799183, 3812.218495208476, 4076.1236334188293, 33588.32823343544, 34059.65940340614, 34399.484007739906, 34439.0, 35241.823790881135, 4375.912481750347, 4383.364412160219, 4429.734215947054, 4430.844920427802, 4475.39582156408, 246928.0, 248339.0, 248533.757331214, 249298.0, 250159.0, 54505.45494545083, 58756.7062164695, 60113.0, 60650.39349606448, 60802.0, 59939.70030149821, 65162.34837651657, 65223.0, 65266.347336526975, 65334.673326634016, 15753.44862929792, 15932.522024339289, 15962.60093497672, 15966.201689915457, 15976.680466390608, 11694.824577631342, 11714.0, 11786.469608867621, 11802.822957655642, 11813.1140164488, 16702.916485417496, 16862.325506979585, 17142.657146857244, 17284.65430691379, 17479.38822141219, 6722.193336799615, 6757.222919364238, 6827.317268273232, 6997.0, 7043.330883566053, 971.2133172130597, 1065.8188108021654, 1069.9679009629724, 1106.269861891148, 1136.1829025844931, 33812.80965139445, 34132.31735365279, 34187.65812341894, 34275.14312142217, 34289.39961304077, 1124.8031594470935, 1151.6890439581434, 1169.7426566155432, 1192.3322939153927, 1196.7427003194355, 17699.38052168194, 17799.199036043152, 18065.367712130013, 18131.54671133206, 18170.2738239867, 489607.0, 492909.0, 493599.0, 495322.0, 498802.0, 61065.0, 61785.38214617886, 61940.07089893655, 61956.0, 62023.37976620266, 1306.9869301307056, 1406.7327207830479, 1407.2119613016744, 1412.555045160771, 1424.1241636393543, 31117.222069448446, 34825.303493929474, 35125.64874351326, 35301.29397411986, 35649.82175089108, 51112.74443627758, 51675.483245167066, 51786.741066294424, 51793.0, 51989.7400512995, 321811.0, 325353.0, 326159.0, 326876.0, 328328.0, 36918.815405922796, 42000.789996049825, 42520.57479425166, 43390.0, 43959.78020109879, 49828.25257621211, 49836.75081624569, 50479.0, 50522.49477505178, 51329.48670513247, 39563.2087358257, 42614.0, 42887.78556107199, 43280.567194327654, 43286.56713432951, 41751.0, 41838.372424414265, 42416.1516769669, 42486.78756606197, 43247.56752432435, 42344.153116936875, 42796.35805462858, 43214.351784722625, 43684.344734828366, 43853.56146438495, 36926.815365923, 37822.676206332646, 37862.45650521955, 38435.80782096072, 38685.80657096697, 28660.713392866637, 29212.415751685272, 29266.0, 29268.41463170682, 29332.560011599417], "value": 20333.246070361143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.28618345528406, 414.5025968837395, 415.2145773175345, 419.5573669778383, 419.58670709351264, 18623.813761862377, 18903.905480472597, 19528.41414757556, 19752.70370944437, 19773.60452790945, 12433.751324973495, 12464.875351246485, 12565.308908010056, 15779.211039448039, 18902.527436814085, 5022.321986531808, 5108.438071812097, 5311.415744268127, 5332.0, 5346.545543628797, 5263.289455923459, 5272.0, 5288.0745869472885, 5314.9468505314835, 5315.867103322409, 5271.367435907697, 5283.498067683564, 5293.814716484924, 5327.973360133194, 5807.622504537191, 5742.6841523716175, 5769.798057068025, 5779.248697669318, 5793.536517078624, 5800.245968024151, 5038.84883453497, 5242.8689282767855, 5248.6588371755715, 5335.51980321769, 5337.919931200996, 13879.791803122962, 14199.716005679931, 14241.78637320441, 14252.21612811295, 14504.129752214796, 2193.9451513712124, 2244.6184148694597, 2262.830287728427, 2332.9066837326486, 2352.823538234622, 9861.0, 10232.948835255776, 10391.064804167661, 12442.191257568229, 13625.863741362558, 1941.2429152630486, 1953.8925359105244, 2162.5350549631903, 2229.9108035678555, 2285.108807565051, 80855.0, 95087.0, 96731.0, 96978.9999999993, 99450.50274748652, 16078.678426431406, 17303.826961730472, 17494.125293735262, 18061.0, 18068.36760713369, 32541.51187732186, 32594.83702581519, 32946.835265823516, 32979.83510082482, 33010.66989330124, 9411.10594493522, 9831.950840245752, 10030.899691003142, 10369.429681367597, 10377.117944974761, 8771.122887711177, 8781.209691127702, 8784.516851573226, 8869.73390798277, 8930.642774289086, 8819.735407937773, 8903.551523331136, 8912.777180570409, 8957.283417326598, 9214.262858971266, 3222.4038552867796, 3345.782524135972, 3363.983180084084, 3404.3531728971416, 3509.6314886937016, 939.7556635274877, 1038.8285932821, 1061.7717190804015, 1115.068917453935, 1125.898669119783, 19018.144183511777, 19408.32070877541, 19411.223551058083, 19471.318503852297, 19717.0, 1004.9296549241483, 1015.7968406318765, 1022.4070039377143, 1056.8890266521905, 1132.5696235430485, 10506.73733156662, 10987.285826421257, 11077.0, 11089.889101109047, 11128.165387595962, 496608.0, 501940.0, 506161.0, 517281.0, 522630.0, 86188.56905715431, 86936.56531717301, 87636.0, 89477.0, 89754.55122724344, 1023.2683631203726, 1042.8070806900748, 1057.603398725478, 1060.6605886116522, 1086.1528008153653, 17245.137743113046, 17398.826011740228, 17588.38440654571, 17712.734308985633, 17724.46826595204, 29231.561526577545, 36503.26993460169, 40187.79906100451, 41258.587414125475, 41303.38044929269, 53591.464085358646, 56469.43530564806, 56893.71553142208, 57023.0, 57125.42874571201, 8523.786905327417, 8970.641174352953, 9024.774380640536, 9074.546272686472, 9193.724188274362, 12687.936560317139, 13804.585862424143, 13875.861241387456, 13930.512432064828, 14011.719765604834, 12182.634520964386, 12229.93885030569, 12429.875701242872, 12604.306763128116, 12689.175203611736, 11896.940515297369, 11975.76048479043, 12161.331126787758, 12279.140460167702, 12601.306928118674, 12413.255204687748, 12576.937115314366, 12712.237265764084, 12713.55502557406, 12784.296863672587, 8780.0, 8948.105189481, 9058.547072646474, 9208.171264586219, 9315.534223288672, 11846.466908989289, 12551.811722823983, 12553.748925021266, 12569.1201615886, 12582.24506529611], "value": 9872.70400715085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.800073989271, 1530.0284319457148, 1551.224387806097, 1688.9746653800196, 1846.3722334406307, 8750.256228220602, 9104.817903641931, 9169.81660366793, 9394.812103757939, 9403.059694030593, 9109.134632209945, 9154.542272886363, 9192.954035229814, 9245.16793488586, 9261.768455788591, 2019.5153163240864, 2337.801286890616, 2377.6909001829736, 2407.9398015049587, 2412.7707867752533, 2439.7194322652945, 2453.582890908541, 2456.5946618807875, 2458.8032957363457, 2459.102427613917, 2156.687280344357, 2179.3135162423864, 2288.7139107611547, 2354.2937118864356, 2360.36270207044, 1995.4512509060053, 2266.5920134375806, 2318.4088057545387, 2340.2862127051244, 2356.481574053714, 2344.1326709117566, 2358.705161854768, 2361.2089949866813, 2362.574736547421, 2364.3261670424017, 9116.407433516866, 9166.724998250063, 9169.724908252763, 9173.0, 9178.67874624385, 5189.273501709764, 5270.4729527047375, 5271.710055946922, 5272.0, 5279.1817268323475, 3338.2989572189867, 3360.6471320511237, 3512.929741405183, 3523.0, 3537.0803591066506, 1114.3481063577735, 1130.8982191602795, 1141.0, 1143.3425780176433, 1144.7824913266536, 12306.138570300083, 12320.876791232062, 12341.074419418579, 12352.567660131943, 12365.010799136047, 4656.906861862743, 4690.7654617269, 4775.904481910342, 4785.353977213102, 4785.832495862628, 10684.946575267073, 10718.08896243828, 10721.303115297636, 10724.088452481627, 10728.141748660088, 5220.425753167148, 5276.973615131899, 5284.154535274338, 5284.497972692588, 5286.127788914863, 4592.471865735416, 4878.512148785164, 4947.084789313988, 5059.316992206079, 5117.002184573972, 4243.3634954757035, 4289.163613095417, 4319.503257125471, 4343.305071188658, 4356.324769660708, 1344.8050032745393, 1368.2418092750768, 1377.9517716880061, 1378.4555100735154, 1383.3429121167567, 851.9914800851913, 951.2247518272586, 998.0668075349571, 1013.4122209118693, 1028.5525796278644, 5882.617629854046, 6145.5698101133385, 6235.532335074797, 6244.375562443719, 6408.391202835724, 438.9517153113155, 446.698478526993, 452.36894532127496, 454.65446260842, 458.54145854145855, 3916.236333914859, 3923.313420151519, 4037.273290807624, 4047.352423612208, 4105.712600117963, 11481.253718508271, 11838.052955763518, 11899.98850097734, 11931.224470409396, 11957.521699131938, 11634.418279086012, 11645.47595358194, 11646.126540509496, 11646.475908583965, 11663.125265605113, 7957.323627491613, 8156.959215203886, 8285.95857020711, 8450.746477605804, 8663.870041949376, 5928.318243402064, 6047.939520604914, 6098.451139397475, 6146.846328841814, 6160.722767475385, 10674.626388076691, 10857.457127143769, 11024.44877756125, 11069.335839849635, 11075.0, 11147.944260278648, 11326.546938122383, 11332.716682083013, 11410.543578256777, 11521.423928803693, 7235.131784185932, 7918.0, 8182.959085204536, 8269.255766981001, 8403.789905252417, 9315.534223288943, 9331.346805723535, 9360.15758581731, 9397.812043759222, 9402.52987350616, 7987.0, 8238.83522329562, 8245.587720614065, 8269.62786674589, 8480.660773568989, 7932.682692692459, 8152.2662960333855, 8152.796180095545, 8166.632501537564, 8367.163283671583, 7005.089338386181, 7053.506254562131, 7069.187043490065, 7094.751683691046, 7103.076600041962, 5054.444011158843, 5102.260172275073, 5148.382194136728, 5187.792488300426, 5196.636235463632, 5168.095583272837, 5194.246834209094, 5202.817901373433, 5204.765785539584, 5258.921116183184], "value": 4692.888203622698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.18946171568786, 320.5144206527111, 324.8116092666253, 327.34040907571233, 330.67428582845895, 5380.461953804617, 5424.159255315432, 5432.239486471887, 5452.263944367509, 5466.835994920154, 5075.035743208788, 5169.405518365389, 5247.370315562129, 5329.2006199070065, 5365.087935051041, 4090.2433049885867, 4161.604647558477, 4163.437935878648, 4174.144300418422, 4187.811548480326, 4145.212409642173, 4161.41866090885, 4173.123644034741, 4184.4141820145205, 4197.265478541243, 3976.76139431635, 3983.4423180754575, 4084.938725919099, 4119.423280740699, 4135.862637774621, 4076.3070278052505, 4085.611866872642, 4114.382842573623, 4115.341545352744, 4120.793960302003, 3623.492711020433, 3636.5272514573203, 3655.342038433081, 3661.3043521730788, 3666.863272385542, 4870.0, 5148.845534633967, 5170.689758614495, 5172.508611681884, 5178.97410512945, 4654.813807447698, 4677.087967846272, 4687.0, 4705.988212534322, 4720.088364212499, 5538.9169162462595, 5561.805336813192, 5573.498385145356, 5594.636348637326, 5613.635113717595, 3845.5193100862393, 3906.257811015898, 3957.762534247954, 3959.425883246913, 3968.72218944674, 5743.253377060997, 5773.220615216976, 5800.346901133199, 5813.796517121923, 5831.737571809279, 3990.5035611645635, 4014.437978682987, 4015.7791321477016, 4042.130941847517, 4062.309407400749, 3901.297766402075, 4053.574374690674, 4092.631663150331, 4095.9385609215888, 4119.340905455113, 4648.604868586141, 4666.603338716247, 4686.320483529869, 4691.507391723888, 4695.765211739399, 5522.447755224526, 5537.944620553823, 5571.721413929287, 5581.665100094007, 5620.18507316445, 1352.6212660455087, 1390.5480718766441, 1394.5119208277022, 1407.7606806842862, 1412.484443178253, 887.6862243878966, 892.5269607108243, 900.6397441023643, 906.6264609117193, 908.8500397434482, 4748.264019077049, 4785.904281914342, 4848.903021939612, 4897.3878265216845, 4910.729909854921, 5175.661698204637, 5196.402413722395, 5215.973920130375, 5227.26818245446, 5249.0, 4610.4697959734385, 4834.830780922721, 4891.315215869781, 4894.706317620954, 4915.837031706038, 2713.972860271372, 2719.442514284567, 2739.493278696709, 2754.559270516708, 2760.806743527974, 5128.692278463304, 5231.9476805232225, 5236.895262094813, 5237.397699264633, 5266.0257852297445, 5190.662606930613, 5190.92213616796, 5191.844244672666, 5358.91961620576, 5852.356240813507, 5864.618799778001, 5876.236089308362, 5881.617819812341, 5907.881842363128, 5911.615744976562, 5661.490465858093, 5732.828015159552, 5739.598228124159, 5780.566457515619, 5786.739596718074, 5521.861953451196, 5678.296511046752, 5706.771729130788, 5726.9713651431475, 5745.597808153389, 5910.867240362615, 5946.226990491208, 5964.463198312173, 5979.40205979416, 5989.251343582052, 3809.684897569297, 4035.1526179502634, 4060.127072679388, 4071.429999799971, 4072.837086516506, 4933.235348520985, 5784.884302314014, 5789.957807594674, 5800.1299805029585, 5802.0, 5540.529055030368, 5598.188262701967, 5605.299337582802, 5609.21470994053, 5652.802151924828, 5387.353517577759, 5460.180972854104, 5599.356074051536, 5618.269624948894, 5618.353889302619, 5483.725813709379, 5486.506214440719, 5486.945130548803, 5495.587830912617, 5529.004779139794, 5577.247071645438, 5590.636608620427, 5597.160425936142, 5601.831945041656, 5647.887042259214, 5418.268533747893, 5462.289902312674, 5476.945230547643, 5519.475649813261, 5552.7223638818705], "value": 4161.924524420693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.7982924439644, 808.4421748993198, 843.1669787672522, 853.2747164909831, 867.5402036920431, 14886.181260030708, 15287.847121528781, 15363.462278820243, 15367.615809604766, 15421.999999999985, 13484.190948543095, 13553.457861685545, 13555.52555660552, 13570.050096493249, 13571.389287482063, 697.2017040488638, 818.758466252457, 842.8187939592987, 845.9027211870622, 846.0143932318841, 837.660747397305, 842.3682238321259, 842.6208206307156, 845.6955496021427, 846.0693237438799, 726.5531698005741, 880.867869819529, 881.6958149438434, 882.1311008656468, 882.7881308485981, 747.7756672998106, 749.6626518066864, 880.3485420788602, 898.2589363774912, 900.6217388696698, 652.7454292825802, 652.9608223506557, 653.0922018394435, 653.3923451190391, 654.169205109513, 13171.275579843104, 13176.472941082346, 13200.933995329962, 13230.27233502157, 13388.263645499494, 13475.460981560725, 13540.119892206974, 13915.79126313096, 13937.09408888419, 13986.300684965812, 11768.0, 11882.168248222628, 11907.345096019715, 12014.038876889828, 12025.098117641212, 4493.775311234425, 4557.1051079040235, 4586.610138138262, 4594.609458196057, 4702.177119004161, 59149.70425147847, 60020.39979600192, 60202.0, 60303.69848150775, 60453.0, 10840.13278937683, 10963.50664220112, 11192.768795432496, 11206.775864482828, 11421.086313094933, 20599.279025234344, 20669.58660826775, 20675.8966205168, 20685.379438616867, 20685.89657051735, 8640.351973602004, 8728.083551227157, 8747.195935406176, 8761.211490965843, 8868.423552469068, 4804.25534042217, 4831.879203019953, 4903.6077113831525, 4937.901241975141, 4938.827141050046, 3454.516367708523, 3639.6542328478754, 3640.9635903641156, 3666.3217304798163, 3669.2478042001326, 649.95775274607, 654.2508827392609, 655.9344065593402, 673.474689742002, 674.6356967237637, 652.7128063651978, 763.5304287863036, 773.8490994256066, 777.0908037596026, 800.727752564131, 10110.887802341736, 10235.897641023643, 10560.52477638508, 10631.415272160106, 10649.307794993301, 626.5801912718398, 712.9719360006366, 732.6886073418775, 740.326303064209, 757.3297631596078, 4676.228422310349, 4685.557423192032, 4708.434987801417, 4719.716816990923, 4905.411350637946, 66859.66570167118, 67792.6610366945, 67926.66036669884, 68113.0, 69443.0, 59320.70339648274, 59731.0, 60022.0, 62587.0, 62773.372266276754, 53067.734661325674, 53572.196417053776, 54157.45842541603, 54198.187027194625, 54941.0, 9407.952960235156, 9447.95276023643, 9513.191378732885, 9648.469334186688, 9651.9034809651, 35302.82348588241, 35740.28519429649, 35946.8202658985, 36323.81838090793, 36721.63278367289, 46093.76953115213, 48863.755681221366, 48984.0, 49341.2598811011, 49628.0, 11747.941260293986, 11907.52369905194, 12142.878571214174, 12380.752384952071, 12437.440315185657, 12522.87477125217, 12910.289934053342, 13125.474981001034, 13191.274479903697, 13477.0, 11273.943630281796, 12824.358782060674, 12849.935750321189, 13137.934310328386, 13561.118527295694, 10917.23579349438, 11201.587892321051, 11429.0, 12042.518299267931, 12090.516379344728, 11745.236559623598, 11809.763804724029, 11902.166848320534, 12141.332226727262, 12161.209521381083, 9725.562349694423, 9990.400575965175, 10030.247731420319, 10037.949810250902, 10088.0, 10123.949380253052, 10491.213159013258, 10560.366378017343, 10573.682789516326, 10660.573577056832], "value": 6965.589510553289, "unit": "score"}], "name": "dromaeo_css", "value": 7242.083460584407, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 113.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 150.0, 204.0, 124.0, 153.0, 150.0, 134.0, 187.0, 124.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 151.0, 75.0, 74.0, 76.0, 75.0, 127.0, 75.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 147.0, 94.0, 94.0, 93.0, 123.0, 92.0, 92.0, 117.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 54.0, 55.0, 55.0, 53.0, 111.0, 52.0, 52.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 84.0, 78.0, 79.0, 85.0, 82.0, 80.0, 80.0, 81.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 116.0, 124.0, 123.0, 120.0, 126.0, 132.0, 195.0, 119.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 161.0, 162.0, 160.0, 160.0, 159.0, 162.0, 163.0, 159.0, 157.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 62.0, 65.0, 61.0, 63.0, 61.0, 63.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1519.8999999999999, "alertThreshold": 2.0}]} 17:44:21 INFO - Return code: 0 17:44:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:44:21 ERROR - # TBPL SUCCESS # 17:44:21 INFO - Running post-action listener: _resource_record_post_action 17:44:21 INFO - ##### 17:44:21 INFO - ##### Finished run-tests step (success) 17:44:21 INFO - ##### 17:44:21 INFO - Running post-run listener: _resource_record_post_run 17:44:21 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 430080; Write bytes: 397459456; Read time: 216; Write time: 277504 17:44:21 INFO - TinderboxPrint: CPU usage
13.1% 17:44:21 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 216 17:44:21 INFO - TinderboxPrint: I/O write bytes / time
397,459,456 / 277,504 17:44:21 INFO - TinderboxPrint: CPU idle
8,280.0 (86.9%) 17:44:21 INFO - TinderboxPrint: CPU user
1,203.7 (12.6%) 17:44:21 INFO - TinderboxPrint: Swap in / out
0 / 0 17:44:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112295936; Read time: 184; Write time: 101148 17:44:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 425984; Write bytes: 285163520; Read time: 32; Write time: 176356 17:44:22 INFO - Running post-run listener: _upload_blobber_files 17:44:22 INFO - Blob upload gear active. 17:44:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:44:22 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 17:44:22 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'] 17:44:22 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 17:44:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:44:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:23 INFO - (blobuploader) - INFO - Done attempting. 17:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:44:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:27 INFO - (blobuploader) - INFO - Done attempting. 17:44:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:44:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:28 INFO - (blobuploader) - INFO - Done attempting. 17:44:28 INFO - (blobuploader) - INFO - Iteration through files over. 17:44:28 INFO - Return code: 0 17:44:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:44:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:44:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/956ac73d142b084869a04f977b7a7aa50924f2f44090620bf26410c273d835ea8321062c156000f1d07ebe0f7d89d0caa7e2ada109a18a17b5544b2b6aaae760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/801f5e80cee3fe2c0f99a1c2104dbc3d09046addca17a1606415e52e446187825b792daf4e1adb5596b8d5d253cfa5164bd3a377fca0354ea6913c9d7eefdddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/346b962518687393e6fe272b546df9281c9873fc737eaff257a442791d6cfffb7fd2286b127fc0c3e88c6e995fffa5f9a1b6a3bfad7cfdc69f13245f9ff93393"} 17:44:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:44:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:44:28 INFO - Contents: 17:44:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/956ac73d142b084869a04f977b7a7aa50924f2f44090620bf26410c273d835ea8321062c156000f1d07ebe0f7d89d0caa7e2ada109a18a17b5544b2b6aaae760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/801f5e80cee3fe2c0f99a1c2104dbc3d09046addca17a1606415e52e446187825b792daf4e1adb5596b8d5d253cfa5164bd3a377fca0354ea6913c9d7eefdddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/346b962518687393e6fe272b546df9281c9873fc737eaff257a442791d6cfffb7fd2286b127fc0c3e88c6e995fffa5f9a1b6a3bfad7cfdc69f13245f9ff93393"} 17:44:28 INFO - Running post-run listener: copy_logs_to_upload_dir 17:44:28 INFO - Copying logs to upload dir... 17:44:28 INFO - mkdir: /builds/slave/test/build/upload/logs 17:44:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.529325 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-18 17:44:28.427481) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 17:44:28.433155) ========= 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=4300f881736b422476174874000001bc-1463617225.344664-188601395 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/956ac73d142b084869a04f977b7a7aa50924f2f44090620bf26410c273d835ea8321062c156000f1d07ebe0f7d89d0caa7e2ada109a18a17b5544b2b6aaae760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/801f5e80cee3fe2c0f99a1c2104dbc3d09046addca17a1606415e52e446187825b792daf4e1adb5596b8d5d253cfa5164bd3a377fca0354ea6913c9d7eefdddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/346b962518687393e6fe272b546df9281c9873fc737eaff257a442791d6cfffb7fd2286b127fc0c3e88c6e995fffa5f9a1b6a3bfad7cfdc69f13245f9ff93393"} build_url:https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/DN-XXBavT-izFMWShro-Nw/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/956ac73d142b084869a04f977b7a7aa50924f2f44090620bf26410c273d835ea8321062c156000f1d07ebe0f7d89d0caa7e2ada109a18a17b5544b2b6aaae760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/801f5e80cee3fe2c0f99a1c2104dbc3d09046addca17a1606415e52e446187825b792daf4e1adb5596b8d5d253cfa5164bd3a377fca0354ea6913c9d7eefdddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/346b962518687393e6fe272b546df9281c9873fc737eaff257a442791d6cfffb7fd2286b127fc0c3e88c6e995fffa5f9a1b6a3bfad7cfdc69f13245f9ff93393"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 17:44:28.457176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:44:28.457486) ========= 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=4300f881736b422476174874000001bc-1463617225.344664-188601395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004328 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:44:28.541608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 17:44:28.541936) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 17:44:28.542269) ========= ========= Total master_lag: 0.16 =========