builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1464394531.64 results: success (0) buildid: 20160527143015 builduid: 3d1c5d5012584dd9bed5423f7774708b revision: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.643746) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.644172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.644600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.684511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.684769) ========= 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-1464392812.756162-103401560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 17:15:32-- 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% 70.4M=0s 2016-05-27 17:15:32 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.773806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.774083) ========= 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-1464392812.756162-103401560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015565 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:31.823147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 17:15:31.823450) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d --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 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d --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-1464392812.756162-103401560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 17:15:32,231 truncating revision to first 12 chars 2016-05-27 17:15:32,231 Setting DEBUG logging. 2016-05-27 17:15:32,231 attempt 1/10 2016-05-27 17:15:32,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e1d7c5d1a58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 17:15:33,337 unpacking tar archive at: fx-team-3e1d7c5d1a58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.450750 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 17:15:33.287572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:33.287890) ========= script_repo_revision: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:33.288337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:33.288611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 17:15:33.297360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-27 17:15:33.297634) ========= /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-1464392812.756162-103401560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:33 INFO - MultiFileLogger online at 20160527 17:15:33 in /builds/slave/test 17:15:33 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:15:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:33 INFO - {'append_to_log': False, 17:15:33 INFO - 'base_work_dir': '/builds/slave/test', 17:15:33 INFO - 'blob_upload_branch': 'Fx-Team', 17:15:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:33 INFO - 'branch': 'Fx-Team', 17:15:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:33 INFO - 'config_files': ('talos/linux_config.py',), 17:15:33 INFO - 'default_actions': ('clobber', 17:15:33 INFO - 'read-buildbot-config', 17:15:33 INFO - 'download-and-extract', 17:15:33 INFO - 'populate-webroot', 17:15:33 INFO - 'create-virtualenv', 17:15:33 INFO - 'install', 17:15:33 INFO - 'run-tests'), 17:15:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:33 INFO - 'download_minidump_stackwalk': True, 17:15:33 INFO - 'download_symbols': 'ondemand', 17:15:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:33 INFO - 'installer_path': 'installer.exe', 17:15:33 INFO - 'log_level': 'info', 17:15:33 INFO - 'log_name': 'talos', 17:15:33 INFO - 'log_to_console': True, 17:15:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:33 INFO - 'opt_config_files': (), 17:15:33 INFO - 'pip_index': False, 17:15:33 INFO - 'sps_profile': False, 17:15:33 INFO - 'sps_profile_interval': 0, 17:15:33 INFO - 'suite': 'dromaeojs', 17:15:33 INFO - 'system_bits': '32', 17:15:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:33 INFO - 'title': 'talos-linux64-ix-045', 17:15:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:33 INFO - 'use_talos_json': True, 17:15:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:33 INFO - 'work_dir': 'build'} 17:15:33 INFO - ##### 17:15:33 INFO - ##### Running clobber step. 17:15:33 INFO - ##### 17:15:33 INFO - Running pre-action listener: _resource_record_pre_action 17:15:33 INFO - Running main action method: clobber 17:15:33 INFO - rmtree: /builds/slave/test/build 17:15:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:34 INFO - Running post-action listener: _resource_record_post_action 17:15:34 INFO - ##### 17:15:34 INFO - ##### Finished clobber step (success) 17:15:34 INFO - ##### 17:15:34 INFO - ##### 17:15:34 INFO - ##### Running read-buildbot-config step. 17:15:34 INFO - ##### 17:15:34 INFO - Running pre-action listener: _resource_record_pre_action 17:15:34 INFO - Running main action method: read_buildbot_config 17:15:34 INFO - Using buildbot properties: 17:15:34 INFO - { 17:15:34 INFO - "project": "", 17:15:34 INFO - "product": "firefox", 17:15:34 INFO - "script_repo_revision": "production", 17:15:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:15:34 INFO - "repository": "", 17:15:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:15:34 INFO - "buildid": "20160527143015", 17:15:34 INFO - "pgo_build": "True", 17:15:34 INFO - "basedir": "/builds/slave/test", 17:15:34 INFO - "buildnumber": 1198, 17:15:34 INFO - "slavename": "talos-linux64-ix-045", 17:15:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:15:34 INFO - "platform": "ubuntu64_hw", 17:15:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:15:34 INFO - "branch": "fx-team", 17:15:34 INFO - "repo_path": "integration/fx-team", 17:15:34 INFO - "revision": "3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d", 17:15:34 INFO - "stage_platform": "linux64-pgo", 17:15:34 INFO - "builduid": "3d1c5d5012584dd9bed5423f7774708b", 17:15:34 INFO - "slavebuilddir": "test" 17:15:34 INFO - } 17:15:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:15:34 INFO - Running post-action listener: _resource_record_post_action 17:15:34 INFO - ##### 17:15:34 INFO - ##### Finished read-buildbot-config step (success) 17:15:34 INFO - ##### 17:15:34 INFO - ##### 17:15:34 INFO - ##### Running download-and-extract step. 17:15:34 INFO - ##### 17:15:34 INFO - Running pre-action listener: _resource_record_pre_action 17:15:34 INFO - Running main action method: download_and_extract 17:15:34 INFO - mkdir: /builds/slave/test/build/tests 17:15:34 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:15:34 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:39 INFO - Downloaded 1361 bytes. 17:15:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:39 INFO - Using the following test package requirements: 17:15:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'jsshell-linux-x86_64.zip'], 17:15:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:39 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:15:39 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:47 INFO - Downloaded 24410534 bytes. 17:15:47 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:15:47 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:15:48 INFO - Return code: 0 17:15:48 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:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:48 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:50 INFO - Downloaded 24410534 bytes. 17:15:50 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:15:50 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:15:52 INFO - Return code: 0 17:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:52 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:53 INFO - Downloaded 10834034 bytes. 17:15:53 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:15:53 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:15:53 INFO - Return code: 0 17:15: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:15:53 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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:15:54 INFO - Downloaded 58741812 bytes. 17:15:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:54 INFO - mkdir: /builds/slave/test/properties 17:15:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:54 INFO - Contents: 17:15:54 INFO - build_url:https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:55 INFO - Running post-action listener: _resource_record_post_action 17:15:55 INFO - Running post-action listener: set_extra_try_arguments 17:15:55 INFO - ##### 17:15:55 INFO - ##### Finished download-and-extract step (success) 17:15:55 INFO - ##### 17:15:55 INFO - ##### 17:15:55 INFO - ##### Running populate-webroot step. 17:15:55 INFO - ##### 17:15:55 INFO - Running pre-action listener: _resource_record_pre_action 17:15:55 INFO - Running main action method: populate_webroot 17:15:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:55 INFO - '--tppagecycles', 17:15:55 INFO - '7'], 17:15:55 INFO - 'tests': ['tsvgm']}}, 17:15:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['damp', 'tps']}, 17:15:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'tests': ['damp', 'tps']}, 17:15:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['dromaeo_dom']}, 17:15:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['a11yr', 17:15:55 INFO - 'ts_paint', 17:15:55 INFO - 'tpaint', 17:15:55 INFO - 'sessionrestore', 17:15:55 INFO - 'sessionrestore_no_auto_restore', 17:15:55 INFO - 'tabpaint']}, 17:15:55 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:55 INFO - 'ts_paint', 17:15:55 INFO - 'tpaint', 17:15:55 INFO - 'sessionrestore', 17:15:55 INFO - 'sessionrestore_no_auto_restore', 17:15:55 INFO - 'tabpaint']}, 17:15:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:55 INFO - 'ts_paint', 17:15:55 INFO - 'tpaint', 17:15:55 INFO - 'sessionrestore', 17:15:55 INFO - 'sessionrestore_no_auto_restore', 17:15:55 INFO - 'tabpaint']}, 17:15:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:55 INFO - 'ts_paint', 17:15:55 INFO - 'tpaint', 17:15:55 INFO - 'sessionrestore', 17:15:55 INFO - 'sessionrestore_no_auto_restore', 17:15:55 INFO - 'tabpaint']}, 17:15:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['a11yr', 17:15:55 INFO - 'ts_paint', 17:15:55 INFO - 'tpaint', 17:15:55 INFO - 'sessionrestore', 17:15:55 INFO - 'sessionrestore_no_auto_restore', 17:15:55 INFO - 'tabpaint']}, 17:15:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['a11yr', 17:15:55 INFO - 'ts_paint', 17:15:55 INFO - 'tpaint', 17:15:55 INFO - 'sessionrestore', 17:15:55 INFO - 'sessionrestore_no_auto_restore', 17:15:55 INFO - 'tabpaint']}, 17:15:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['tsvgx', 17:15:55 INFO - 'tsvgr_opacity', 17:15:55 INFO - 'tart', 17:15:55 INFO - 'tscrollx', 17:15:55 INFO - 'cart']}, 17:15:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:55 INFO - 'tsvgr_opacity', 17:15:55 INFO - 'tart', 17:15:55 INFO - 'tscrollx', 17:15:55 INFO - 'cart']}, 17:15:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'talos_options': ['--disable-e10s'], 17:15:55 INFO - 'tests': ['tp5o']}, 17:15:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'tests': ['tp5o']}, 17:15:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'talos_options': ['--disable-e10s', 17:15:55 INFO - '--xperf_path', 17:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:55 INFO - 'tests': ['tp5n']}, 17:15:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:55 INFO - 'talos_options': ['--xperf_path', 17:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:55 INFO - 'tests': ['tp5n']}}, 17:15:55 INFO - 'talos.zip': {'path': '', 17:15:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:55 INFO - Running post-action listener: _resource_record_post_action 17:15:55 INFO - ##### 17:15:55 INFO - ##### Finished populate-webroot step (success) 17:15:55 INFO - ##### 17:15:55 INFO - ##### 17:15:55 INFO - ##### Running create-virtualenv step. 17:15:55 INFO - ##### 17:15:55 INFO - Running pre-action listener: _resource_record_pre_action 17:15:55 INFO - Running main action method: create_virtualenv 17:15:55 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:55 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:15:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:55 INFO - Using real prefix '/usr' 17:15:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:57 INFO - Installing pip.................done. 17:15:57 INFO - Return code: 0 17:15:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:15:57 INFO - Using env: {'DISPLAY': ':0', 17:15:57 INFO - 'HOME': '/home/cltbld', 17:15:57 INFO - 'LANG': 'en_US.UTF-8', 17:15:57 INFO - 'LANGUAGE': 'en_US:en', 17:15:57 INFO - 'LOGNAME': 'cltbld', 17:15:57 INFO - 'MAIL': '/var/mail/cltbld', 17:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:57 INFO - 'MOZ_NO_REMOTE': '1', 17:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:57 INFO - 'NO_EM_RESTART': '1', 17:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:57 INFO - 'PWD': '/builds/slave/test', 17:15:57 INFO - 'SHELL': '/bin/bash', 17:15:57 INFO - 'SHLVL': '1', 17:15:57 INFO - 'TERM': 'linux', 17:15:57 INFO - 'TMOUT': '86400', 17:15:57 INFO - 'USER': 'cltbld', 17:15:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:57 INFO - '_': '/tools/buildbot/bin/python'} 17:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:58 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:15:58 INFO - Cleaning up... 17:15:58 INFO - Return code: 0 17:15:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15: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:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:15:58 INFO - Using env: {'DISPLAY': ':0', 17:15:58 INFO - 'HOME': '/home/cltbld', 17:15:58 INFO - 'LANG': 'en_US.UTF-8', 17:15:58 INFO - 'LANGUAGE': 'en_US:en', 17:15:58 INFO - 'LOGNAME': 'cltbld', 17:15:58 INFO - 'MAIL': '/var/mail/cltbld', 17:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:58 INFO - 'MOZ_NO_REMOTE': '1', 17:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:58 INFO - 'NO_EM_RESTART': '1', 17:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:58 INFO - 'PWD': '/builds/slave/test', 17:15:58 INFO - 'SHELL': '/bin/bash', 17:15:58 INFO - 'SHLVL': '1', 17:15:58 INFO - 'TERM': 'linux', 17:15:58 INFO - 'TMOUT': '86400', 17:15:58 INFO - 'USER': 'cltbld', 17:15:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:58 INFO - '_': '/tools/buildbot/bin/python'} 17:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:58 INFO - Downloading/unpacking psutil>=3.1.1 17:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:00 INFO - Installing collected packages: psutil 17:16:00 INFO - Running setup.py install for psutil 17:16:00 INFO - building 'psutil._psutil_linux' extension 17:16:00 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:16:00 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:16:00 INFO - building 'psutil._psutil_posix' extension 17:16:00 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:16:00 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:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:00 INFO - Successfully installed psutil 17:16:00 INFO - Cleaning up... 17:16:00 INFO - Return code: 0 17:16:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:16: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:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:00 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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:16:00 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:16:00 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:16:00 INFO - Using env: {'DISPLAY': ':0', 17:16:00 INFO - 'HOME': '/home/cltbld', 17:16:00 INFO - 'LANG': 'en_US.UTF-8', 17:16:00 INFO - 'LANGUAGE': 'en_US:en', 17:16:00 INFO - 'LOGNAME': 'cltbld', 17:16:00 INFO - 'MAIL': '/var/mail/cltbld', 17:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:00 INFO - 'MOZ_NO_REMOTE': '1', 17:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:00 INFO - 'NO_EM_RESTART': '1', 17:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:00 INFO - 'PWD': '/builds/slave/test', 17:16:00 INFO - 'SHELL': '/bin/bash', 17:16:00 INFO - 'SHLVL': '1', 17:16:00 INFO - 'TERM': 'linux', 17:16:00 INFO - 'TMOUT': '86400', 17:16:00 INFO - 'USER': 'cltbld', 17:16:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:00 INFO - '_': '/tools/buildbot/bin/python'} 17:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:16:01 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:16:01 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:16:01 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:16:01 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:16:01 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:16:01 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:16:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:16:03 INFO - Installing collected packages: mozsystemmonitor 17:16:03 INFO - Running setup.py install for mozsystemmonitor 17:16:03 INFO - Successfully installed mozsystemmonitor 17:16:03 INFO - Cleaning up... 17:16:03 INFO - Return code: 0 17:16:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:16:03 INFO - Using env: {'DISPLAY': ':0', 17:16:03 INFO - 'HOME': '/home/cltbld', 17:16:03 INFO - 'LANG': 'en_US.UTF-8', 17:16:03 INFO - 'LANGUAGE': 'en_US:en', 17:16:03 INFO - 'LOGNAME': 'cltbld', 17:16:03 INFO - 'MAIL': '/var/mail/cltbld', 17:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:03 INFO - 'MOZ_NO_REMOTE': '1', 17:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:03 INFO - 'NO_EM_RESTART': '1', 17:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:03 INFO - 'PWD': '/builds/slave/test', 17:16:03 INFO - 'SHELL': '/bin/bash', 17:16:03 INFO - 'SHLVL': '1', 17:16:03 INFO - 'TERM': 'linux', 17:16:03 INFO - 'TMOUT': '86400', 17:16:03 INFO - 'USER': 'cltbld', 17:16:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:03 INFO - '_': '/tools/buildbot/bin/python'} 17:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:03 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:05 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:06 INFO - Downloading docopt-0.6.1.tar.gz 17:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:06 INFO - Running setup.py install for blobuploader 17:16:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:06 INFO - Running setup.py install for requests 17:16:06 INFO - Running setup.py install for docopt 17:16:06 INFO - Successfully installed blobuploader requests docopt 17:16:06 INFO - Cleaning up... 17:16:06 INFO - Return code: 0 17:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:06 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:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:06 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:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:06 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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:16:06 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:16:06 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:16:06 INFO - Using env: {'DISPLAY': ':0', 17:16:06 INFO - 'HOME': '/home/cltbld', 17:16:06 INFO - 'LANG': 'en_US.UTF-8', 17:16:06 INFO - 'LANGUAGE': 'en_US:en', 17:16:06 INFO - 'LOGNAME': 'cltbld', 17:16:06 INFO - 'MAIL': '/var/mail/cltbld', 17:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:06 INFO - 'MOZ_NO_REMOTE': '1', 17:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:06 INFO - 'NO_EM_RESTART': '1', 17:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:06 INFO - 'PWD': '/builds/slave/test', 17:16:06 INFO - 'SHELL': '/bin/bash', 17:16:06 INFO - 'SHLVL': '1', 17:16:06 INFO - 'TERM': 'linux', 17:16:06 INFO - 'TMOUT': '86400', 17:16:06 INFO - 'USER': 'cltbld', 17:16:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:06 INFO - '_': '/tools/buildbot/bin/python'} 17:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:07 INFO - Running setup.py (path:/tmp/pip-XWHhVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:07 INFO - Running setup.py (path:/tmp/pip-1sC5Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:07 INFO - Running setup.py (path:/tmp/pip-Atw7Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:07 INFO - Running setup.py (path:/tmp/pip-A7LHK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:07 INFO - Running setup.py (path:/tmp/pip-Pp0CN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:07 INFO - Running setup.py (path:/tmp/pip-_pUuqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:07 INFO - Running setup.py (path:/tmp/pip-TKkeYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:07 INFO - Running setup.py (path:/tmp/pip-GVwVuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:07 INFO - Running setup.py (path:/tmp/pip-UwLf9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:07 INFO - Running setup.py (path:/tmp/pip-oT1BQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:07 INFO - Running setup.py (path:/tmp/pip-uDqHLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:07 INFO - Running setup.py (path:/tmp/pip-R9wG9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:07 INFO - Running setup.py (path:/tmp/pip-3ERg3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:07 INFO - Running setup.py (path:/tmp/pip-W9fRWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:08 INFO - Running setup.py (path:/tmp/pip-H9lfbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:08 INFO - Running setup.py (path:/tmp/pip-E2KRIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:08 INFO - Running setup.py (path:/tmp/pip-1BrJsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:08 INFO - Running setup.py install for manifestparser 17:16:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:08 INFO - Running setup.py install for mozcrash 17:16:08 INFO - Running setup.py install for mozdebug 17:16:08 INFO - Running setup.py install for mozdevice 17:16:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:16:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:08 INFO - Running setup.py install for mozfile 17:16:08 INFO - Running setup.py install for mozhttpd 17:16:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:08 INFO - Running setup.py install for mozinfo 17:16:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:08 INFO - Running setup.py install for mozInstall 17:16:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Running setup.py install for mozleak 17:16:09 INFO - Running setup.py install for mozlog 17:16:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Running setup.py install for moznetwork 17:16:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Running setup.py install for mozprocess 17:16:09 INFO - Running setup.py install for mozprofile 17:16:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Running setup.py install for mozrunner 17:16:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Running setup.py install for mozscreenshot 17:16:09 INFO - Running setup.py install for moztest 17:16:09 INFO - Running setup.py install for mozversion 17:16:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:09 INFO - Cleaning up... 17:16:10 INFO - Return code: 0 17:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16: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:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:10 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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:16:10 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:16:10 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:16:10 INFO - Using env: {'DISPLAY': ':0', 17:16:10 INFO - 'HOME': '/home/cltbld', 17:16:10 INFO - 'LANG': 'en_US.UTF-8', 17:16:10 INFO - 'LANGUAGE': 'en_US:en', 17:16:10 INFO - 'LOGNAME': 'cltbld', 17:16:10 INFO - 'MAIL': '/var/mail/cltbld', 17:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:10 INFO - 'MOZ_NO_REMOTE': '1', 17:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:10 INFO - 'NO_EM_RESTART': '1', 17:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:10 INFO - 'PWD': '/builds/slave/test', 17:16:10 INFO - 'SHELL': '/bin/bash', 17:16:10 INFO - 'SHLVL': '1', 17:16:10 INFO - 'TERM': 'linux', 17:16:10 INFO - 'TMOUT': '86400', 17:16:10 INFO - 'USER': 'cltbld', 17:16:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:10 INFO - '_': '/tools/buildbot/bin/python'} 17:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:10 INFO - Running setup.py (path:/tmp/pip-B_L1u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:10 INFO - Running setup.py (path:/tmp/pip-AVoQC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:10 INFO - Running setup.py (path:/tmp/pip-hQ7FBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:10 INFO - Running setup.py (path:/tmp/pip-TzHBMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:10 INFO - Running setup.py (path:/tmp/pip-_QQ9jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:10 INFO - Running setup.py (path:/tmp/pip-Ejvuab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:10 INFO - Running setup.py (path:/tmp/pip-mKNJOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:10 INFO - Running setup.py (path:/tmp/pip-i8v749-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:10 INFO - Running setup.py (path:/tmp/pip-13nLhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:10 INFO - Running setup.py (path:/tmp/pip-pmVQ0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:10 INFO - Running setup.py (path:/tmp/pip-uDAqwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:11 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:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:11 INFO - Running setup.py (path:/tmp/pip-tAT9_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:11 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:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:11 INFO - Running setup.py (path:/tmp/pip-0gGjhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:11 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:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:11 INFO - Running setup.py (path:/tmp/pip-IVLGBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:11 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:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:11 INFO - Running setup.py (path:/tmp/pip-ksqBZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:11 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:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:11 INFO - Running setup.py (path:/tmp/pip-cxqzoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:11 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:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:11 INFO - Running setup.py (path:/tmp/pip-EMuQZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:11 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:16:11 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:16:11 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:16:11 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:16:11 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:16:11 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:16:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:13 INFO - Downloading blessings-1.6.tar.gz 17:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:13 INFO - Installing collected packages: blessings 17:16:13 INFO - Running setup.py install for blessings 17:16:13 INFO - Successfully installed blessings 17:16:13 INFO - Cleaning up... 17:16:13 INFO - Return code: 0 17:16:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:13 INFO - Reading from file tmpfile_stdout 17:16:13 INFO - Current package versions: 17:16:13 INFO - argparse == 1.2.1 17:16:13 INFO - blessings == 1.6 17:16:13 INFO - blobuploader == 1.2.4 17:16:13 INFO - docopt == 0.6.1 17:16:13 INFO - manifestparser == 1.1 17:16:13 INFO - mozInstall == 1.12 17:16:13 INFO - mozcrash == 0.17 17:16:13 INFO - mozdebug == 0.1 17:16:13 INFO - mozdevice == 0.48 17:16:13 INFO - mozfile == 1.2 17:16:13 INFO - mozhttpd == 0.7 17:16:13 INFO - mozinfo == 0.9 17:16:13 INFO - mozleak == 0.1 17:16:13 INFO - mozlog == 3.2 17:16:13 INFO - moznetwork == 0.27 17:16:13 INFO - mozprocess == 0.22 17:16:13 INFO - mozprofile == 0.28 17:16:13 INFO - mozrunner == 6.11 17:16:13 INFO - mozscreenshot == 0.1 17:16:13 INFO - mozsystemmonitor == 0.3 17:16:13 INFO - moztest == 0.7 17:16:13 INFO - mozversion == 1.4 17:16:13 INFO - psutil == 3.1.1 17:16:13 INFO - requests == 1.2.3 17:16:13 INFO - wsgiref == 0.1.2 17:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:13 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:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:13 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:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:13 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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:16:13 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:16:13 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:16:13 INFO - Using env: {'DISPLAY': ':0', 17:16:13 INFO - 'HOME': '/home/cltbld', 17:16:13 INFO - 'LANG': 'en_US.UTF-8', 17:16:13 INFO - 'LANGUAGE': 'en_US:en', 17:16:13 INFO - 'LOGNAME': 'cltbld', 17:16:13 INFO - 'MAIL': '/var/mail/cltbld', 17:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:13 INFO - 'MOZ_NO_REMOTE': '1', 17:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:13 INFO - 'NO_EM_RESTART': '1', 17:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:13 INFO - 'PWD': '/builds/slave/test', 17:16:13 INFO - 'SHELL': '/bin/bash', 17:16:13 INFO - 'SHLVL': '1', 17:16:13 INFO - 'TERM': 'linux', 17:16:13 INFO - 'TMOUT': '86400', 17:16:13 INFO - 'USER': 'cltbld', 17:16:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:13 INFO - '_': '/tools/buildbot/bin/python'} 17:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 INFO - Cleaning up... 17:16:13 INFO - Return code: 0 17:16:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:13 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:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:13 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:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:13 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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:16:13 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:16:13 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:16:14 INFO - Using env: {'DISPLAY': ':0', 17:16:14 INFO - 'HOME': '/home/cltbld', 17:16:14 INFO - 'LANG': 'en_US.UTF-8', 17:16:14 INFO - 'LANGUAGE': 'en_US:en', 17:16:14 INFO - 'LOGNAME': 'cltbld', 17:16:14 INFO - 'MAIL': '/var/mail/cltbld', 17:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:14 INFO - 'MOZ_NO_REMOTE': '1', 17:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:14 INFO - 'NO_EM_RESTART': '1', 17:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:14 INFO - 'PWD': '/builds/slave/test', 17:16:14 INFO - 'SHELL': '/bin/bash', 17:16:14 INFO - 'SHLVL': '1', 17:16:14 INFO - 'TERM': 'linux', 17:16:14 INFO - 'TMOUT': '86400', 17:16:14 INFO - 'USER': 'cltbld', 17:16:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:14 INFO - '_': '/tools/buildbot/bin/python'} 17:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:14 INFO - Downloading/unpacking jsonschema 17:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:17 INFO - Downloading/unpacking functools32 (from jsonschema) 17:16:17 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:16:17 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:16:17 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:16:17 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:16:17 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:16:17 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:16:17 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:17 INFO - warning: no files found matching '*.txt' 17:16:17 INFO - no previously-included directories found matching 'build' 17:16:17 INFO - no previously-included directories found matching 'dist' 17:16:17 INFO - no previously-included directories found matching '.git*' 17:16:17 INFO - Installing collected packages: jsonschema, functools32 17:16:17 INFO - Running setup.py install for functools32 17:16:17 INFO - warning: no files found matching '*.txt' 17:16:17 INFO - no previously-included directories found matching 'build' 17:16:17 INFO - no previously-included directories found matching 'dist' 17:16:17 INFO - no previously-included directories found matching '.git*' 17:16:17 INFO - Successfully installed jsonschema functools32 17:16:17 INFO - Cleaning up... 17:16:17 INFO - Return code: 0 17:16:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:16: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:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:17 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 0x7fb25f9aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, '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-1464392812.756162-103401560', '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:16:17 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:16:17 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:16:17 INFO - Using env: {'DISPLAY': ':0', 17:16:17 INFO - 'HOME': '/home/cltbld', 17:16:17 INFO - 'LANG': 'en_US.UTF-8', 17:16:17 INFO - 'LANGUAGE': 'en_US:en', 17:16:17 INFO - 'LOGNAME': 'cltbld', 17:16:17 INFO - 'MAIL': '/var/mail/cltbld', 17:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:17 INFO - 'MOZ_NO_REMOTE': '1', 17:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:17 INFO - 'NO_EM_RESTART': '1', 17:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:17 INFO - 'PWD': '/builds/slave/test', 17:16:17 INFO - 'SHELL': '/bin/bash', 17:16:17 INFO - 'SHLVL': '1', 17:16:17 INFO - 'TERM': 'linux', 17:16:17 INFO - 'TMOUT': '86400', 17:16:17 INFO - 'USER': 'cltbld', 17:16:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:17 INFO - '_': '/tools/buildbot/bin/python'} 17:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:17 INFO - Downloading/unpacking flake8 17:16:17 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:16:17 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:16:17 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:16:17 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:16:17 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:16:17 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:16:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:16:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:16:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:16:20 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:16:20 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:16:20 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:16:20 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:16:20 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:16:20 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:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:20 INFO - no previously-included directories found matching 'docs/_build' 17:16:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:16:20 INFO - Running setup.py install for pep8 17:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:20 INFO - no previously-included directories found matching 'docs/_build' 17:16:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:16:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:16:20 INFO - Cleaning up... 17:16:20 INFO - Return code: 0 17:16:20 INFO - Running post-action listener: _resource_record_post_action 17:16:20 INFO - Running post-action listener: _start_resource_monitoring 17:16:20 INFO - Starting resource monitoring. 17:16:20 INFO - ##### 17:16:20 INFO - ##### Finished create-virtualenv step (success) 17:16:20 INFO - ##### 17:16:20 INFO - ##### 17:16:20 INFO - ##### Running install step. 17:16:20 INFO - ##### 17:16:20 INFO - Running pre-action listener: _resource_record_pre_action 17:16:20 INFO - Running main action method: install 17:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:20 INFO - Reading from file tmpfile_stdout 17:16:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:20 INFO - Reading from file tmpfile_stdout 17:16:20 INFO - Output received: 17:16:20 INFO - Usage: mozinstall [options] installer 17:16:20 INFO - Options: 17:16:20 INFO - -h, --help show this help message and exit 17:16:20 INFO - -d DEST, --destination=DEST 17:16:20 INFO - Directory to install application into. [default: 17:16:20 INFO - "/builds/slave/test"] 17:16:20 INFO - --app=APP Application being installed. [default: firefox] 17:16:20 INFO - mkdir: /builds/slave/test/build/application 17:16:20 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:16:20 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:16:37 INFO - Reading from file tmpfile_stdout 17:16:37 INFO - Output received: 17:16:37 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:37 INFO - Running post-action listener: _resource_record_post_action 17:16:37 INFO - ##### 17:16:37 INFO - ##### Finished install step (success) 17:16:37 INFO - ##### 17:16:37 INFO - ##### 17:16:37 INFO - ##### Running run-tests step. 17:16:37 INFO - ##### 17:16:37 INFO - Running pre-action listener: _resource_record_pre_action 17:16:37 INFO - Running main action method: run_tests 17:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:37 INFO - Python 2.7.3 17:16:37 INFO - Return code: 0 17:16:37 INFO - grabbing minidump binary from tooltool 17:16:37 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:16:37 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 0x250e9c0>, '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 0x250f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:37 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:16:37 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:16:37 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:16:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:37 INFO - Return code: 0 17:16:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:16:38 INFO - Return code: 0 17:16:38 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/HiuoJDpcTlOjumpwmAN_MQ/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:16:38 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/HiuoJDpcTlOjumpwmAN_MQ/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:16:38 INFO - Using env: {'DISPLAY': ':0', 17:16:38 INFO - 'HOME': '/home/cltbld', 17:16:38 INFO - 'LANG': 'en_US.UTF-8', 17:16:38 INFO - 'LANGUAGE': 'en_US:en', 17:16:38 INFO - 'LOGNAME': 'cltbld', 17:16:38 INFO - 'MAIL': '/var/mail/cltbld', 17:16:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:38 INFO - 'MOZ_NO_REMOTE': '1', 17:16:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:38 INFO - 'NO_EM_RESTART': '1', 17:16:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:38 INFO - 'PWD': '/builds/slave/test', 17:16:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:38 INFO - 'SHELL': '/bin/bash', 17:16:38 INFO - 'SHLVL': '1', 17:16:38 INFO - 'TERM': 'linux', 17:16:38 INFO - 'TMOUT': '86400', 17:16:38 INFO - 'USER': 'cltbld', 17:16:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464392812.756162-103401560', 17:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:38 INFO - '_': '/tools/buildbot/bin/python'} 17:16:38 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/HiuoJDpcTlOjumpwmAN_MQ/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:16:38 INFO - mozversion application_buildid: 20160527143015 17:16:38 INFO - mozversion application_changeset: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d 17:16:38 INFO - mozversion application_display_name: Nightly 17:16:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:38 INFO - mozversion application_name: Firefox 17:16:38 INFO - mozversion application_remotingname: firefox 17:16:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:38 INFO - mozversion application_vendor: Mozilla 17:16:38 INFO - mozversion application_version: 49.0a1 17:16:38 INFO - mozversion platform_buildid: 20160527143015 17:16:38 INFO - mozversion platform_changeset: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d 17:16:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:38 INFO - mozversion platform_version: 49.0a1 17:16:38 INFO - using testdate: 1464394598 17:16:38 INFO - actual date: 1464394598 17:16:38 INFO - starting webserver on 'localhost:43031' 17:16:38 INFO - SUITE-START | Running 2 tests 17:16:38 INFO - TEST-START | dromaeo_css 17:16:38 INFO - operating with platform_type : linux_ 17:16:38 INFO - Initialising browser for dromaeo_css test... 17:16:38 INFO - TEST-INFO | started process 10513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TOQdJ/profile http://localhost:43031/getInfo.html) 17:16:42 INFO - PROCESS | 10513 | __metrics Screen width/height:1600/1200 17:16:42 INFO - PROCESS | 10513 | colorDepth:24 17:16:42 INFO - PROCESS | 10513 | Browser inner width/height: 1024/697 17:16:42 INFO - PROCESS | 10513 | __metrics 17:16:43 ERROR - PROCESS | 10513 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:16:44 INFO - TEST-INFO | 10513: exit 0 17:16:44 INFO - Browser initialized. 17:16:44 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:44 INFO - TEST-INFO | started process 10593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TOQdJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:56 INFO - PROCESS | 10593 | RSS: Main: 155467776 17:16:56 INFO - PROCESS | 10593 | 17:17:48 INFO - PROCESS | 10593 | 1464394668003 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:19:55 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:43031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43031/tests/dromaeo/cssquery-ext.html) 17:19:57 INFO - PROCESS | 10593 | RSS: Main: 300417024 17:19:57 INFO - PROCESS | 10593 | 17:22:59 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:43031/tests/dromaeo/cssquery-ext.html (next: http://localhost:43031/tests/dromaeo/cssquery-jquery.html) 17:23:00 INFO - PROCESS | 10593 | RSS: Main: 235737088 17:23:00 INFO - PROCESS | 10593 | 17:26:01 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:43031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43031/tests/dromaeo/cssquery-mootools.html) 17:26:02 INFO - PROCESS | 10593 | RSS: Main: 237015040 17:26:02 INFO - PROCESS | 10593 | 17:29:04 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:43031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43031/tests/dromaeo/cssquery-prototype.html) 17:29:05 INFO - PROCESS | 10593 | RSS: Main: 234708992 17:29:05 INFO - PROCESS | 10593 | 17:32:07 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:43031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43031/tests/dromaeo/cssquery-yui.html) 17:32:08 INFO - PROCESS | 10593 | RSS: Main: 223571968 17:32:08 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:43031/tests/dromaeo/cssquery-yui.html (next: http://localhost:43031/tests/dromaeo/cssquery-dojo.html) 17:35:11 INFO - PROCESS | 10593 | RSS: Main: 325910528 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | __start_tp_report 17:35:11 INFO - PROCESS | 10593 | _x_x_mozilla_page_load 17:35:11 INFO - PROCESS | 10593 | _x_x_mozilla_page_load_details 17:35:11 INFO - PROCESS | 10593 | |i|pagename|runs| 17:35:11 INFO - PROCESS | 10593 | |0;dojo.html;3092.2733157707935;3128.124125244932;3156.5580818685376;3170.223295292654;3201.8399080045992;5330.253764472977;5364.758585863636;5410;5448.4006759256545;5503.449655034499;5449.7275136243225;5456.072467680494;5503.944960550393;5578.191162281467;5580.4698553637445;4983.451820299764;4984.850454486371;5007.974960125212;5032.798688052473;5071.644984851062;5153.742312884359;5182.585393168556;5183.507566781169;5225.6864588124645;5233.241180028894;4871.391076115486;5121.718305493215;5139.563137133329;5158.509941555546;5177.818776342829;4982.377202849644;4994.126027945095;4995.775190116454;5002.699838009695;5046.26829109777;4963.925541116886;4991.550760431579;5030.924536131961;5047.369078865142;5075.238714192864;5306.442823503515;5396.082665946759;5508.9724551377385;5548.223248745179;5560.388357280696;5867.090600956859;5890.469857712784;5989.3112292086535;5993.850153746148;5995.1906492623375;5980.282366116094;5981.730822113015;6023.006203976339;6033.698315084228;6042.667653279068;5336.466353364672;5425.430329815392;5478.698671573102;5575.2473416088715;5580.497755202011;6057.644847511935;6076.092565395143;6083.050509083631;6084.756609735649;6111.022236442148;5886.381929897385;5893.204417403681;5898.203742494794;5899.380565040695;5900.911486327708;5669.659820410789;5747.798827041033;5752.9712351437975;5777.94222057774;5998.220231369894;5793.391693872167;5796.42035796417;5801.158831969341;5803.187553742479;5806.187133801272;5759.452851979056;5789.189513468118;5800;5802.82591522255;5808.709564521757;4346.065595896835;4392.780360981938;4412.0955204183065;4444.511103778582;4461.353103799996;3983.24318379507;3991.3613821788376;3991.481107456012;4005.759654420744;4029.597040295947;5454.509094181542;5525.723713814293;5545.306836645419;5595.8880822384135;5610.046292130348;5887.234659494238;5908.084246941731;5943.375945525744;5948.613340132878;6006.759729610854;5578.470045345685;5587.888242235133;5594.0769772987815;5595.664260144405;5597.440255974451;4794.113089078532;4899.853004409873;4919.36048313724;4925.7783399747095;4935;6127.433875357673;6145.4161854623735;6156.107364432132;6156.661383623854;6165.475934545524;5987.191729116514;5988.371221021905;5991.940080599138;5993.101034844808;6023.518118550418;5908.084246941731;5937.732802024006;5953.672548009901;5975.760969561343;6120.387961203844;5719.542436604978;5720.914186287292;5730.455606717355;5731.8567035824435;5734.111212762028;5753.712314384347;5797;5806.390329015561;5813.82558523245;5813.94186058134;5525.806596769094;5763.6541807491685;5797.362290148165;5847.298324201123;5890.087036509348;5841.707914604168;5853.560982926383;5859.062549991981;5862.824115276549;5868.911966320594;5619;5699.772009119754;5766.3368712598585;5772.336181339032;5772.826815195551;5671.517920976763;5689.6586204827845;5695.487406133468;5714.942850571441;5787.594868359174;5704.743286552198;5708.400617935057;5761.337446193741;5765.682887441231;5813 17:35:11 INFO - PROCESS | 10593 | |1;ext.html;579.4611011759063;617.3116974573351;624.5347216323839;628.224143183169;634.5114262018246;30548.236294092658;42553.78723106388;44148.77925610376;44180.999999999956;47942.28086578704;43899.56100438994;44445.33332000022;44530.777346113304;44546.55453445465;44565.331520027146;8015.118336982956;8736.694215702468;8927.419717718327;8929.196372326489;8929.866052009225;10194.847077293847;10493.947530262376;10498.212634052477;10759.462026898664;10762.408067556282;10631.574737010511;10751.193660475457;10753.677389678322;10754.892451075468;10756.946215268912;8056.436049476539;10587.523561439677;10608;10688.786224275509;10831.350118992807;10252.333598316085;10607.15142788575;10611.469426528643;10617.256792024562;10624.09695175911;42086.78956605228;42742.358864617054;42771.35842962358;42818.571814282084;42889.571104289185;3759.6804271636943;3889.611038896116;4049.5140583130215;4249.32010878258;4347.239233134189;31930.521042184388;32222.51666224985;32312;32671.346573068644;33924.66075339264;4389.2977123660385;4437.2234858899565;4446.155230506226;4483.3723278741;4519.796609152596;341172;343498.28250858834;344643;344656;345743;63024;63290;63614;63718.36281637217;63750.36249637537;36934.8153259232;37730.62269377271;37737.81131094327;39672.404913926315;39686.20627587432;16436.260368283456;16576.83423165777;16588.170591470378;16593.6681266374;16597.751033734505;11684.70788230301;12177.756444871053;12289.385530723428;12400.503979840705;12462.127651064338;20964;20970.79029209719;21197.576048478943;21210.575788484144;21275;7672.884906726404;7745.961270193613;7851.9977405761165;7963.362930965509;7965.442419030613;1037.2117190934944;1072.6621114349111;1083.8297978413111;1154.6189757380043;1245.2092920995053;33208.66791332104;33236.83381583125;33489.33021339608;33494.16264593405;33783.32433351369;1144.4449442020614;1214.8359971403925;1233.2045830439317;1240.3674126195524;1294.5792617399384;17594.38419655306;17616;17660.381886634164;17744.822551774574;17749.467515974542;560208;565927.5332610043;566675;566878;567188;57632.71183644139;59247.40752592505;59312.40687593155;59377.40622593805;59449.702751485966;1299.1944994103717;1332.513632524141;1371.4377105386743;1381.7650999330137;1401.7617005108953;31912.5213121808;34322.313553729284;34341.656583434844;34384.312313753086;34531.59420578177;50777.74611127069;51027.23459148042;51386;51487.742561286956;51504.652197607036;406168;407506;407621;407733;408536;25676;27915.720842791314;28841.85579072091;29033;29975.550366744952;44637.77681111704;45994;45995;47063.76468117638;47140.05719885651;38832;39015.21969560536;39278.4108238371;39299.07009299047;40341.1931761369;39120.80439597784;39242.60757392504;39524;39854.60145398509;40054.1989160221;39588.60411395849;39941.600583993786;40219;40361.59638403696;40525.1894962105;33213;34672.653273466945;35339;35423.46864797082;35880.46179307365;27248.182554523395;27590.20605672831;27631.408435259873;27816.304592385353;28029.579556306264 17:35:11 INFO - PROCESS | 10593 | |2;jquery.html;395.6458969222547;396.40935006839817;404.92104039712257;406.12480105372896;420.8989842437814;17438.91280543597;18774.62450750984;19157.712634310497;19164.329248476308;20017.399478015646;18226.453206403796;18793.342233021845;18923.43229703111;18952.810471895278;19080.809191908076;5522.392536820947;5672.290963629556;5803.187553742479;5811.709414529278;5912.17229587858;5796.449337312949;5813.82558523245;5861.677607731573;5893.292804863422;6646.1027761252335;6559.376859198393;6588.802335929906;6617.4706023518;6619.536632435731;6619.768308109217;5950.285965684102;5951.4048595140575;5957.493613042897;6105.20632317798;6580.473562115019;5744.655320680731;5745.224394706703;5755.309362876482;5759.222504961818;5793.420657934215;13204.801927971088;16538.421155259628;19389.32137375199;22457.550848983094;22471.101155953744;2193.331034034619;2278.5442911417617;2296.8392212545127;2354.8233882458885;2363.8818059096975;9978.201743860474;10159.4920253987;10354.223433242538;10491.055804977512;10646.307989980627;1896.506908203863;1929.4211736479;1934.177974360891;1952.6094781043848;1993.8903360315321;75068;75642.62178689126;77527.22472775256;78165.21834781693;78185;9799.461029643295;9820.754481138028;9989;10042.74893127663;10048.547815348327;13304.401301941241;13368.799468007988;13401.463941442427;13430.597082087554;13458.192508449329;7694.846103078019;7769.300762931251;7800.6099695016155;7819.413543984224;7948.324392426708;7808.2191780822595;7829.960850195713;8032.879506807402;8035.236652518001;8056.033276006917;4141.503019637603;4167.499500299857;4214.704970652025;4292.441982542249;4297.09760950204;1881.2380985700813;1964.5424053665365;1978.0703069557285;2003.719479272903;2011.7384739983709;896.7085697148453;923.4505469245788;1014.4319181258519;1027.0499787696351;1117.1230583991528;18337.908310458628;18434;19132.713009304873;19287.710684339745;19442.125104370338;978.2125389061731;989.1740396768779;1014.7361685961703;1037.2117190934794;1063.3832377221192;10181;10440.63457778974;10740.355578665149;10825.29635573701;11241.466623637632;492290.7698230545;508322;509284;512189;515273;66145;79237.60381198057;80484;90914.54542727245;91140;1028.290479569095;1045.6915210013065;1053.167997282154;1053.8155822730992;1062.9893701063045;12965.675858103623;16197.838021619633;16732.916335418246;17427.302907883543;17490.387836425663;38633;39235;39360.80319598383;40014.79992600018;40652.3902141474;50691;51731.224031638805;52169.478305216464;52949;53043.734781325846;7393.55638661682;8327.916720832714;8373.246407823324;8471.872921906053;8727.476351418934;10847.511861966073;12252.081093917814;12912.935435322763;13036.608901732963;13184.670383240496;10878.836817447585;11175.329480231212;11256.099512038854;11269.211155219056;11362.375069371265;10950.507227174956;11004.779904402027;11400.429978500875;11482.253653512495;11492.425378731197;11234.269772464764;11325.603603873826;11527.8270825936;11836.171467997501;11855.407229638311;7372.189059203376;7382.446316526175;7500;7536;7813.531188128731;10859.674209773719;11130.443477826238;11172.385518796544;11376.94311528437;11752.882471175179 17:35:11 INFO - PROCESS | 10593 | |3;mootools.html;1334.3595074364298;1480.400437822682;1517.1276516003297;1669.9415520456787;1817.2095138614711;8697.869531957018;9041.593128309234;9106.453612783238;9269.212116970066;9271.90728092719;8973.955130224356;9172.12864777845;9176.082391760821;9177;9178.724638260846;1955.8533110016735;2012.2956965062258;2014.526586252237;2411.7226518950283;2441.706995160583;2409.4578719787996;2482.689663792026;2487.4776296977657;2492.264781889338;2497.8126640501946;2378.512404956988;2393.581123303415;2398.940026499334;2411.9276421707377;2447.8898449569724;2063.123172651617;2355.163916809542;2374.964375534368;2408.3136306152664;2414.7343792182846;2424.854508729482;2446.54738873309;2447.865367404792;2452.3746444656676;2453.8036957043396;9019.909800901973;9086.273098152133;9100.36297459178;9101.817963640757;9118.316126290554;5363.517283444469;5486.067368547317;5493.7802487900435;5499.642523235977;5500.477454641803;3140.5289206618963;3168.556402103707;3338.88313909012;3359.7312215022985;3365.6634336566394;1053.8682664666917;1055.4669891704716;1063.2344711807486;1067.0769784136744;1094.7372630568686;12884.80672789909;12972.481100755958;12990;13012.154209976321;13018.218906865619;4964.950350496521;5004.549590536869;5008.373953255843;5014.147594908874;5045.5459008689395;10642.521086550969;10647.520861561248;10668;10721.678349649523;10736.194785391126;5625.156226566048;5625.746841392147;5627.6904770237215;5630.943690563124;5633.746481408347;4461.821527138943;4670.696404733681;5065.214891691794;5093.592512599057;5128.8461346159675;4087.8978025549004;4166.354215096665;4191.057012172298;4192.895177620584;4243.9814444533085;1302.374860067154;1324.595998220552;1328.4221363706818;1341.0679577693409;1355.857634948336;1030.3714734012246;1030.8762948446235;1052.7210289273348;1054.4833031814355;1054.8892366301582;6220.564560480723;6244.469220116341;6315.210598675166;6326.2724786649205;6352.396522330371;944.9338546301693;981.425865868475;1000.8098461292332;1013.1034034879185;1021.1881554164457;4236.661067114624;4320.503142138631;4333.653307735373;4370.475542934868;4380.956190438119;11302.321860688386;11688.18182727201;11727.882721172678;11728.061755059574;11748.118891083202;10895.128389728803;11211.495482703298;11251.493682784294;11668.88331116678;11702.356370399539;8463.830723385621;8657.870131948026;8671.132886711279;8673.262772664268;8673.522956237468;6181.165542651865;6412.070249813844;6448.419642232222;6511.967440162769;6537.411632953057;10501.527431265458;10818.729531761768;10871.67384978452;10889.237753357505;10939.398333091756;10965.232433729563;10977.121830253402;11034.613788517363;11105.888941110485;11107.888921110685;7401.370883474965;7618.69525218985;7620.237976202336;7835.138134805053;8083.110857805755;8449.028361738234;8586.570671466277;8830.95584522099;8844.911550884666;9083.046280140754;7779.92220077792;7811.336036436966;7918;7983.32141767933;8120.02559692817;7834.216578342348;7937.087234968052;7967.04395472547;7998.040235171817;8051.275385215359;7186.173590037212;7194.4244460442;7239;7258.346748792634;7261.5280006799385;5292.5501332387175;5329.067413202752;5370.704611246419;5410.702411367412;5455.045367060828;5417.539509141767;5450.863728406822;5451.373092094302;5476.534494567847;5577.358603760619 17:35:11 INFO - PROCESS | 10593 | |4;prototype.html;320.6040539933183;324.36262743708625;328.64834626949175;329.7774002548279;332.37347599774415;5314.548263397611;5320.680759154454;5332.786688532459;5343.919841202385;5393.2449457076045;5300.178472336785;5310.256564081032;5322;5326.840194794153;5336.252924590551;3945.763254204757;4006.577664928952;4109.137081212949;4151.484708081543;4154.646855017312;4106.876793696194;4123.505179378479;4127.504699436057;4140.296149654551;4146.834126634931;3919.960800391988;4042.636162745367;4092.4679791627045;4113.794310284488;4119.876403707894;4042.171354872244;4102.651274641659;4131.338985762263;4137.193247316759;4138.503379594438;3615.493830863681;3643.635636436362;3649.2701459708164;3653.9586217928027;3661.487391765155;5054.393472783253;5096.082705113078;5100.744962751847;5117.41149767774;5186.273921650972;4464.843730469418;4651.674382793206;4659.254519276899;4684;4725.480197178307;5417.891642167135;5449.891002179974;5471.671699697991;5518.586106042063;5521.972390138064;3739.25214957007;3921.627445392683;3924.3132451820816;3925.8233379497706;3976.204759048202;5667.263255776723;5698.145278208261;5767.394423585505;5787.652740835563;5788.450097240755;4021.7788021658503;4031.8992025199605;4034.2738307104414;4034.757914525138;4039.8990025249605;3888.5916978716828;4085.8151136170773;4104.938425923614;4120.567340429272;4122.670186385082;4610.27114831938;4627.583517483443;4653.6509761768;4677.298405239241;4678.391809064868;5543.805966791224;5551.057130004466;5557.249771280906;5557.305336832896;5576.749046292926;1374.3403166479945;1410.746065708162;1422.9470192058009;1425.2659880161725;1426.1300606629948;951.6050838901916;954.236610711428;975.7072878136672;984.945827979468;1018.3024628129755;5286.524212820865;5318.65428747138;5330.840074797762;5335.893282134336;5345.625806193529;5643.98047044829;5645;5664.405237450009;5664.745086471119;5679.545636349082;5227.921581176285;5254.527092561688;5262.421133675292;5293.655912365684;5384.865378365494;2931.51629981055;2956.0046968296315;2980.8211507309197;2983.4033193361415;2998.9850050749606;5538.418466061005;5753.769849205984;5763.308402991668;5794.942050579441;5797.594168408255;5653.434656534314;5682.289713785777;5685.289338832646;5707.34365547959;5717.799877004285;5774.711264436762;5779.913301300484;5804.216430781875;5859.033259512218;5876.529877609695;5393.622446428869;5646.435356464485;5669.711567291044;5698.31620205578;5704.229928959538;5533.6403133796175;5542.972285138549;5594.300712410949;5630.18362337467;5671.631343962629;5813.168851811666;5837.562182836389;5843;5862.124120281469;5882.23530940975;3841.5390153181797;4065.2682517146013;4072.735272207297;4082.6116721718126;4086.959130408658;5723.484886360081;5743.684097374685;5749.511291540099;5758.395368486249;5759.308882933907;5407.188921661782;5665.858353541194;5672.75199456119;5673.74468148926;5694.345150307602;5622.269105016485;5646.548276137817;5653.2085508028085;5664.178694089416;5664.433556644467;5286.180642000496;5340.092184328596;5469.562435005269;5519.696416696959;5530.723463826873;5559.19391688211;5599.608027438203;5611.3266408031295;5625.746841392065;5637.267155269788;5407.432219616883;5457.308234447334;5466.781328746805;5482.862928426821;5501.111916243844 17:35:11 INFO - PROCESS | 10593 | |5;yui.html;726.4551586310267;849.4266370200113;851.7189327521914;857.8584533551964;858.5106489301099;14404.783928241071;15085;15159.090454572706;15340.923295383536;15363;13960.441582336694;13978.860211397883;14098.506552270672;14118.152910825333;14149.36327865246;668.7625892808056;775.8797386405088;780.8516381887438;796.24356860982;800.0958916424432;799.436397339874;801.0867610923552;802.5866678660494;802.6749166587513;803.0724513187278;855.7988872614931;856.4775486952954;857.395536147018;857.4212406625534;857.5797859049052;700.8318003679132;826.2439867521181;848.1772680499967;848.567230712335;850.7617866997251;615.6213928433981;616.2174038970483;616.2512547255106;616.3435940723116;616.6793267500874;13045.934770326183;13064.085514014023;13080.345982700826;13085.803712944313;13090.934545327307;13574.86425135746;13941.512047078304;13944.58166255014;13959.302034898315;14025;12143.514259429612;12174.756504869942;12330.691732706664;12605.11764176508;12707.110502264844;4392.802323895432;4482.238019536654;4489.865304040884;4544.636429085665;4585.3122031695175;56940.71529642325;57347.42652573463;57592.71203643955;60503.697481512754;61137;11138.164637652208;11198.38408887519;11226;11250.831237531444;11314.208005439541;19887.204511819655;19929.601407972048;19943.800561994485;19951.800481994993;19970;8047.476914000571;8167.183281671785;8309.169083091763;8417.452865563719;8510.78723031929;4575.81696732127;4617.445906491175;4675.696079754873;4690.038542098861;4738.549837765407;3367.461206206995;3491.877784277538;3493.056874643832;3494.650534946536;3496.5104885316077;544.8692313844728;580.6109906362747;642.0529718664932;646.6249575246346;647.5499527828208;537.7150110441394;635.5763883371784;715.5027256056991;774.8334108166771;792.5126047480873;9694;9910.702678919644;10048.497575121215;10080.344777589433;10088.142507886765;727.3889932456761;733.5158795195146;736.6832262127336;749.456643933155;753.2806170107534;4628.143793398232;4669.556392142741;4706.717596944194;4769.499202583679;4803.351547541037;68429.31570684329;68589.3141068593;68602.31397685959;68801.65599171972;69115;61290;63284.36715632785;63285;63760.36239637637;66320.33679663239;57540.71229643825;57672.71163644155;57823;57864;58288;9041.63833446681;9154.725358239264;9188.862167067366;9217.124373184537;9326.393784403992;38036;38142.618573815016;38398.42402363911;38611.806940965114;39189.80405097956;47338.76330618463;51908.221376680136;52588.211176833145;52982;53377;11782.877537452754;11801.602283030394;11849.940750296193;12074.577389791315;12240.08199385032;13470.393832277767;13805.378757956118;14167.64580885486;14555.345009474811;14598.562043138723;12769.936150319189;12832.615021549369;13039.217646941213;13170.407331670289;13788.172709637454;12410.875891240972;12582.559610413591;12839.550615728405;13020.41408136655;13233.602991910258;13477.797833032708;13558.525451609146;13635.795463067863;13768.793468098187;13916;10857.511411986321;10907.945460272647;11137.888621113685;11294.152938529478;11531.654050378502;11526.308421494401;11807.17349785541;12072.456739446921;12098.334591597546;12167.878321216675 17:35:11 INFO - PROCESS | 10593 | __end_tp_report 17:35:11 INFO - PROCESS | 10593 | __start_cc_report 17:35:11 INFO - PROCESS | 10593 | _x_x_mozilla_cycle_collect,1241 17:35:11 INFO - PROCESS | 10593 | __end_cc_report 17:35:11 INFO - PROCESS | 10593 | __startTimestamp1464395711378__endTimestamp 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | ------- Summary: start ------- 17:35:11 INFO - PROCESS | 10593 | Number of tests: 6 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | [#0] dojo.html Cycles:165 Average:5470.07 Median:5704.74 stddev:634.02 (11.1%) stddev-sans-first:607.90 17:35:11 INFO - PROCESS | 10593 | Values: 3092.3 3128.1 3156.6 3170.2 3201.8 5330.3 5364.8 5410.0 5448.4 5503.4 5449.7 5456.1 5503.9 5578.2 5580.5 4983.5 4984.9 5008.0 5032.8 5071.6 5153.7 5182.6 5183.5 5225.7 5233.2 4871.4 5121.7 5139.6 5158.5 5177.8 4982.4 4994.1 4995.8 5002.7 5046.3 4963.9 4991.6 5030.9 5047.4 5075.2 5306.4 5396.1 5509.0 5548.2 5560.4 5867.1 5890.5 5989.3 5993.9 5995.2 5980.3 5981.7 6023.0 6033.7 6042.7 5336.5 5425.4 5478.7 5575.2 5580.5 6057.6 6076.1 6083.1 6084.8 6111.0 5886.4 5893.2 5898.2 5899.4 5900.9 5669.7 5747.8 5753.0 5777.9 5998.2 5793.4 5796.4 5801.2 5803.2 5806.2 5759.5 5789.2 5800.0 5802.8 5808.7 4346.1 4392.8 4412.1 4444.5 4461.4 3983.2 3991.4 3991.5 4005.8 4029.6 5454.5 5525.7 5545.3 5595.9 5610.0 5887.2 5908.1 5943.4 5948.6 6006.8 5578.5 5587.9 5594.1 5595.7 5597.4 4794.1 4899.9 4919.4 4925.8 4935.0 6127.4 6145.4 6156.1 6156.7 6165.5 5987.2 5988.4 5991.9 5993.1 6023.5 5908.1 5937.7 5953.7 5975.8 6120.4 5719.5 5720.9 5730.5 5731.9 5734.1 5753.7 5797.0 5806.4 5813.8 5813.9 5525.8 5763.7 5797.4 5847.3 5890.1 5841.7 5853.6 5859.1 5862.8 5868.9 5619.0 5699.8 5766.3 5772.3 5772.8 5671.5 5689.7 5695.5 5714.9 5787.6 5704.7 5708.4 5761.3 5765.7 5813.0 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | [#1] ext.html Cycles:180 Average:59798.88 Median:20347.25 stddev:119034.39 (585.0%) stddev-sans-first:119285.28 17:35:11 INFO - PROCESS | 10593 | Values: 579.5 617.3 624.5 628.2 634.5 30548.2 42553.8 44148.8 44181.0 47942.3 43899.6 44445.3 44530.8 44546.6 44565.3 8015.1 8736.7 8927.4 8929.2 8929.9 10194.8 10493.9 10498.2 10759.5 10762.4 10631.6 10751.2 10753.7 10754.9 10756.9 8056.4 10587.5 10608.0 10688.8 10831.4 10252.3 10607.2 10611.5 10617.3 10624.1 42086.8 42742.4 42771.4 42818.6 42889.6 3759.7 3889.6 4049.5 4249.3 4347.2 31930.5 32222.5 32312.0 32671.3 33924.7 4389.3 4437.2 4446.2 4483.4 4519.8 341172.0 343498.3 344643.0 344656.0 345743.0 63024.0 63290.0 63614.0 63718.4 63750.4 36934.8 37730.6 37737.8 39672.4 39686.2 16436.3 16576.8 16588.2 16593.7 16597.8 11684.7 12177.8 12289.4 12400.5 12462.1 20964.0 20970.8 21197.6 21210.6 21275.0 7672.9 7746.0 7852.0 7963.4 7965.4 1037.2 1072.7 1083.8 1154.6 1245.2 33208.7 33236.8 33489.3 33494.2 33783.3 1144.4 1214.8 1233.2 1240.4 1294.6 17594.4 17616.0 17660.4 17744.8 17749.5 560208.0 565927.5 566675.0 566878.0 567188.0 57632.7 59247.4 59312.4 59377.4 59449.7 1299.2 1332.5 1371.4 1381.8 1401.8 31912.5 34322.3 34341.7 34384.3 34531.6 50777.7 51027.2 51386.0 51487.7 51504.7 406168.0 407506.0 407621.0 407733.0 408536.0 25676.0 27915.7 28841.9 29033.0 29975.6 44637.8 45994.0 45995.0 47063.8 47140.1 38832.0 39015.2 39278.4 39299.1 40341.2 39120.8 39242.6 39524.0 39854.6 40054.2 39588.6 39941.6 40219.0 40361.6 40525.2 33213.0 34672.7 35339.0 35423.5 35880.5 27248.2 27590.2 27631.4 27816.3 28029.6 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | [#2] jquery.html Cycles:180 Average:28527.43 Median:2359.35 stddev:83326.64 (3531.8%) stddev-sans-first:83533.62 17:35:11 INFO - PROCESS | 10593 | Values: 395.6 396.4 404.9 406.1 420.9 17438.9 18774.6 19157.7 19164.3 20017.4 18226.5 18793.3 18923.4 18952.8 19080.8 5522.4 5672.3 5803.2 5811.7 5912.2 5796.4 5813.8 5861.7 5893.3 6646.1 6559.4 6588.8 6617.5 6619.5 6619.8 5950.3 5951.4 5957.5 6105.2 6580.5 5744.7 5745.2 5755.3 5759.2 5793.4 13204.8 16538.4 19389.3 22457.6 22471.1 2193.3 2278.5 2296.8 2354.8 2363.9 9978.2 10159.5 10354.2 10491.1 10646.3 1896.5 1929.4 1934.2 1952.6 1993.9 75068.0 75642.6 77527.2 78165.2 78185.0 9799.5 9820.8 9989.0 10042.7 10048.5 13304.4 13368.8 13401.5 13430.6 13458.2 7694.8 7769.3 7800.6 7819.4 7948.3 7808.2 7830.0 8032.9 8035.2 8056.0 4141.5 4167.5 4214.7 4292.4 4297.1 1881.2 1964.5 1978.1 2003.7 2011.7 896.7 923.5 1014.4 1027.0 1117.1 18337.9 18434.0 19132.7 19287.7 19442.1 978.2 989.2 1014.7 1037.2 1063.4 10181.0 10440.6 10740.4 10825.3 11241.5 492290.8 508322.0 509284.0 512189.0 515273.0 66145.0 79237.6 80484.0 90914.5 91140.0 1028.3 1045.7 1053.2 1053.8 1063.0 12965.7 16197.8 16732.9 17427.3 17490.4 38633.0 39235.0 39360.8 40014.8 40652.4 50691.0 51731.2 52169.5 52949.0 53043.7 7393.6 8327.9 8373.2 8471.9 8727.5 10847.5 12252.1 12912.9 13036.6 13184.7 10878.8 11175.3 11256.1 11269.2 11362.4 10950.5 11004.8 11400.4 11482.3 11492.4 11234.3 11325.6 11527.8 11836.2 11855.4 7372.2 7382.4 7500.0 7536.0 7813.5 10859.7 11130.4 11172.4 11376.9 11752.9 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | [#3] mootools.html Cycles:180 Average:6059.14 Median:4352.06 stddev:3481.50 (80.0%) stddev-sans-first:3473.16 17:35:11 INFO - PROCESS | 10593 | Values: 1334.4 1480.4 1517.1 1669.9 1817.2 8697.9 9041.6 9106.5 9269.2 9271.9 8974.0 9172.1 9176.1 9177.0 9178.7 1955.9 2012.3 2014.5 2411.7 2441.7 2409.5 2482.7 2487.5 2492.3 2497.8 2378.5 2393.6 2398.9 2411.9 2447.9 2063.1 2355.2 2375.0 2408.3 2414.7 2424.9 2446.5 2447.9 2452.4 2453.8 9019.9 9086.3 9100.4 9101.8 9118.3 5363.5 5486.1 5493.8 5499.6 5500.5 3140.5 3168.6 3338.9 3359.7 3365.7 1053.9 1055.5 1063.2 1067.1 1094.7 12884.8 12972.5 12990.0 13012.2 13018.2 4965.0 5004.5 5008.4 5014.1 5045.5 10642.5 10647.5 10668.0 10721.7 10736.2 5625.2 5625.7 5627.7 5630.9 5633.7 4461.8 4670.7 5065.2 5093.6 5128.8 4087.9 4166.4 4191.1 4192.9 4244.0 1302.4 1324.6 1328.4 1341.1 1355.9 1030.4 1030.9 1052.7 1054.5 1054.9 6220.6 6244.5 6315.2 6326.3 6352.4 944.9 981.4 1000.8 1013.1 1021.2 4236.7 4320.5 4333.7 4370.5 4381.0 11302.3 11688.2 11727.9 11728.1 11748.1 10895.1 11211.5 11251.5 11668.9 11702.4 8463.8 8657.9 8671.1 8673.3 8673.5 6181.2 6412.1 6448.4 6512.0 6537.4 10501.5 10818.7 10871.7 10889.2 10939.4 10965.2 10977.1 11034.6 11105.9 11107.9 7401.4 7618.7 7620.2 7835.1 8083.1 8449.0 8586.6 8831.0 8844.9 9083.0 7779.9 7811.3 7918.0 7983.3 8120.0 7834.2 7937.1 7967.0 7998.0 8051.3 7186.2 7194.4 7239.0 7258.3 7261.5 5292.6 5329.1 5370.7 5410.7 5455.0 5417.5 5450.9 5451.4 5476.5 5577.4 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | [#4] prototype.html Cycles:180 Average:4656.87 Median:5334.34 stddev:1372.65 (25.7%) stddev-sans-first:1337.36 17:35:11 INFO - PROCESS | 10593 | Values: 320.6 324.4 328.6 329.8 332.4 5314.5 5320.7 5332.8 5343.9 5393.2 5300.2 5310.3 5322.0 5326.8 5336.3 3945.8 4006.6 4109.1 4151.5 4154.6 4106.9 4123.5 4127.5 4140.3 4146.8 3920.0 4042.6 4092.5 4113.8 4119.9 4042.2 4102.7 4131.3 4137.2 4138.5 3615.5 3643.6 3649.3 3654.0 3661.5 5054.4 5096.1 5100.7 5117.4 5186.3 4464.8 4651.7 4659.3 4684.0 4725.5 5417.9 5449.9 5471.7 5518.6 5522.0 3739.3 3921.6 3924.3 3925.8 3976.2 5667.3 5698.1 5767.4 5787.7 5788.5 4021.8 4031.9 4034.3 4034.8 4039.9 3888.6 4085.8 4104.9 4120.6 4122.7 4610.3 4627.6 4653.7 4677.3 4678.4 5543.8 5551.1 5557.2 5557.3 5576.7 1374.3 1410.7 1422.9 1425.3 1426.1 951.6 954.2 975.7 984.9 1018.3 5286.5 5318.7 5330.8 5335.9 5345.6 5644.0 5645.0 5664.4 5664.7 5679.5 5227.9 5254.5 5262.4 5293.7 5384.9 2931.5 2956.0 2980.8 2983.4 2999.0 5538.4 5753.8 5763.3 5794.9 5797.6 5653.4 5682.3 5685.3 5707.3 5717.8 5774.7 5779.9 5804.2 5859.0 5876.5 5393.6 5646.4 5669.7 5698.3 5704.2 5533.6 5543.0 5594.3 5630.2 5671.6 5813.2 5837.6 5843.0 5862.1 5882.2 3841.5 4065.3 4072.7 4082.6 4087.0 5723.5 5743.7 5749.5 5758.4 5759.3 5407.2 5665.9 5672.8 5673.7 5694.3 5622.3 5646.5 5653.2 5664.2 5664.4 5286.2 5340.1 5469.6 5519.7 5530.7 5559.2 5599.6 5611.3 5625.7 5637.3 5407.4 5457.3 5466.8 5482.9 5501.1 17:35:11 INFO - PROCESS | 10593 | 17:35:11 INFO - PROCESS | 10593 | [#5] yui.html Cycles:180 Average:16079.68 Median:4648.85 stddev:19301.87 (415.2%) stddev-sans-first:19321.58 17:35:11 INFO - PROCESS | 10593 | Values: 726.5 849.4 851.7 857.9 858.5 14404.8 15085.0 15159.1 15340.9 15363.0 13960.4 13978.9 14098.5 14118.2 14149.4 668.8 775.9 780.9 796.2 800.1 799.4 801.1 802.6 802.7 803.1 855.8 856.5 857.4 857.4 857.6 700.8 826.2 848.2 848.6 850.8 615.6 616.2 616.3 616.3 616.7 13045.9 13064.1 13080.3 13085.8 13090.9 13574.9 13941.5 13944.6 13959.3 14025.0 12143.5 12174.8 12330.7 12605.1 12707.1 4392.8 4482.2 4489.9 4544.6 4585.3 56940.7 57347.4 57592.7 60503.7 61137.0 11138.2 11198.4 11226.0 11250.8 11314.2 19887.2 19929.6 19943.8 19951.8 19970.0 8047.5 8167.2 8309.2 8417.5 8510.8 4575.8 4617.4 4675.7 4690.0 4738.5 3367.5 3491.9 3493.1 3494.7 3496.5 544.9 580.6 642.1 646.6 647.5 537.7 635.6 715.5 774.8 792.5 9694.0 9910.7 10048.5 10080.3 10088.1 727.4 733.5 736.7 749.5 753.3 4628.1 4669.6 4706.7 4769.5 4803.4 68429.3 68589.3 68602.3 68801.7 69115.0 61290.0 63284.4 63285.0 63760.4 66320.3 57540.7 57672.7 57823.0 57864.0 58288.0 9041.6 9154.7 9188.9 9217.1 9326.4 38036.0 38142.6 38398.4 38611.8 39189.8 47338.8 51908.2 52588.2 52982.0 53377.0 11782.9 11801.6 11849.9 12074.6 12240.1 13470.4 13805.4 14167.6 14555.3 14598.6 12769.9 12832.6 13039.2 13170.4 13788.2 12410.9 12582.6 12839.6 13020.4 13233.6 13477.8 13558.5 13635.8 13768.8 13916.0 10857.5 10907.9 11137.9 11294.2 11531.7 11526.3 11807.2 12072.5 12098.3 12167.9 17:35:11 INFO - PROCESS | 10593 | -------- Summary: end -------- 17:35:11 INFO - PROCESS | 10593 | 17:35:12 INFO - TEST-INFO | 10593: exit 0 17:35:12 INFO - TEST-OK | dromaeo_css | took 1113271ms 17:35:12 INFO - TEST-START | kraken 17:35:12 INFO - operating with platform_type : linux_ 17:35:12 INFO - Initialising browser for kraken test... 17:35:12 INFO - TEST-INFO | started process 10790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppgXc7R/profile http://localhost:43031/getInfo.html) 17:35:16 INFO - PROCESS | 10790 | __metrics Screen width/height:1600/1200 17:35:16 INFO - PROCESS | 10790 | colorDepth:24 17:35:16 INFO - PROCESS | 10790 | Browser inner width/height: 1024/697 17:35:16 INFO - PROCESS | 10790 | __metrics 17:35:17 ERROR - PROCESS | 10790 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:35:18 INFO - TEST-INFO | 10790: exit 0 17:35:18 INFO - Browser initialized. 17:35:18 INFO - Running cycle 1/1 for kraken test... 17:35:18 INFO - TEST-INFO | started process 10870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppgXc7R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:30 INFO - PROCESS | 10870 | RSS: Main: 155217920 17:35:30 INFO - PROCESS | 10870 | 17:35:32 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43031/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:33 INFO - PROCESS | 10870 | RSS: Main: 214294528 17:35:33 INFO - PROCESS | 10870 | 17:35:36 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43031/tests/kraken/driver.html?testName=audio-dft) 17:35:36 INFO - PROCESS | 10870 | RSS: Main: 199864320 17:35:36 INFO - PROCESS | 10870 | 17:35:39 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43031/tests/kraken/driver.html?testName=audio-fft) 17:35:40 INFO - PROCESS | 10870 | RSS: Main: 267796480 17:35:40 INFO - PROCESS | 10870 | 17:35:42 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43031/tests/kraken/driver.html?testName=audio-oscillator) 17:35:43 INFO - PROCESS | 10870 | RSS: Main: 179490816 17:35:43 INFO - PROCESS | 10870 | 17:35:45 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:45 INFO - PROCESS | 10870 | RSS: Main: 183078912 17:35:45 INFO - PROCESS | 10870 | 17:35:48 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43031/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:49 INFO - PROCESS | 10870 | RSS: Main: 217477120 17:35:49 INFO - PROCESS | 10870 | 17:35:52 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43031/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:53 INFO - PROCESS | 10870 | RSS: Main: 219398144 17:35:53 INFO - PROCESS | 10870 | 17:35:56 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43031/tests/kraken/driver.html?testName=json-parse-financial) 17:35:56 INFO - PROCESS | 10870 | RSS: Main: 220147712 17:35:56 INFO - PROCESS | 10870 | 17:35:58 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:58 INFO - PROCESS | 10870 | RSS: Main: 208482304 17:35:58 INFO - PROCESS | 10870 | 17:36:00 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:01 INFO - PROCESS | 10870 | RSS: Main: 212033536 17:36:01 INFO - PROCESS | 10870 | 17:36:03 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:04 INFO - PROCESS | 10870 | RSS: Main: 217243648 17:36:04 INFO - PROCESS | 10870 | 17:36:06 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:07 INFO - PROCESS | 10870 | RSS: Main: 222470144 17:36:07 INFO - PROCESS | 10870 | 17:36:09 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:10 INFO - PROCESS | 10870 | RSS: Main: 221827072 17:36:10 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | Cycle 1(1): loaded http://localhost:43031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43031/tests/kraken/driver.html?testName=ai-astar) 17:36:12 INFO - PROCESS | 10870 | RSS: Main: 264806400 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | __start_tp_report 17:36:12 INFO - PROCESS | 10870 | _x_x_mozilla_page_load 17:36:12 INFO - PROCESS | 10870 | _x_x_mozilla_page_load_details 17:36:12 INFO - PROCESS | 10870 | |i|pagename|runs| 17:36:12 INFO - PROCESS | 10870 | |0;ai-astar;113;104;109;109;109;110;111;110;110;109 17:36:12 INFO - PROCESS | 10870 | |1;audio-beat-detection;149;127;126;182;128;125;155;124;163;123 17:36:12 INFO - PROCESS | 10870 | |2;audio-dft;163;163;161;160;161;161;162;161;162;160 17:36:12 INFO - PROCESS | 10870 | |3;audio-fft;76;75;74;111;74;74;77;74;97;74 17:36:12 INFO - PROCESS | 10870 | |4;audio-oscillator;83;83;124;83;83;83;113;83;83;128 17:36:12 INFO - PROCESS | 10870 | |5;imaging-gaussian-blur;116;116;116;118;116;117;117;116;116;117 17:36:12 INFO - PROCESS | 10870 | |6;imaging-darkroom;146;146;145;146;146;147;146;146;146;145 17:36:12 INFO - PROCESS | 10870 | |7;imaging-desaturate;95;95;96;96;95;94;95;95;95;95 17:36:12 INFO - PROCESS | 10870 | |8;json-parse-financial;53;62;52;53;53;53;54;52;53;55 17:36:12 INFO - PROCESS | 10870 | |9;json-stringify-tinderbox;62;62;61;61;62;62;62;61;62;61 17:36:12 INFO - PROCESS | 10870 | |10;stanford-crypto-aes;78;80;78;84;80;80;79;81;109;79 17:36:12 INFO - PROCESS | 10870 | |11;stanford-crypto-ccm;120;122;120;121;137;134;120;130;131;128 17:36:12 INFO - PROCESS | 10870 | |12;stanford-crypto-pbkdf2;164;165;160;162;161;163;164;162;162;160 17:36:12 INFO - PROCESS | 10870 | |13;stanford-crypto-sha256-iterative;66;64;66;67;66;63;63;64;64;64 17:36:12 INFO - PROCESS | 10870 | __end_tp_report 17:36:12 INFO - PROCESS | 10870 | __start_cc_report 17:36:12 INFO - PROCESS | 10870 | _x_x_mozilla_cycle_collect,1624 17:36:12 INFO - PROCESS | 10870 | __end_cc_report 17:36:12 INFO - PROCESS | 10870 | __startTimestamp1464395772403__endTimestamp 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | ------- Summary: start ------- 17:36:12 INFO - PROCESS | 10870 | Number of tests: 14 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.27 (2.1%) stddev-sans-first:2.00 17:36:12 INFO - PROCESS | 10870 | Values: 113.0 104.0 109.0 109.0 109.0 110.0 111.0 110.0 110.0 109.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:138.50 stddev:20.76 (15.0%) stddev-sans-first:21.77 17:36:12 INFO - PROCESS | 10870 | Values: 149.0 127.0 126.0 182.0 128.0 125.0 155.0 124.0 163.0 123.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 17:36:12 INFO - PROCESS | 10870 | Values: 163.0 163.0 161.0 160.0 161.0 161.0 162.0 161.0 162.0 160.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#3] audio-fft Cycles:10 Average:80.60 Median:74.50 stddev:12.81 (17.2%) stddev-sans-first:13.48 17:36:12 INFO - PROCESS | 10870 | Values: 76.0 75.0 74.0 111.0 74.0 74.0 77.0 74.0 97.0 74.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.00 stddev:19.03 (22.9%) stddev-sans-first:19.72 17:36:12 INFO - PROCESS | 10870 | Values: 83.0 83.0 124.0 83.0 83.0 83.0 113.0 83.0 83.0 128.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 17:36:12 INFO - PROCESS | 10870 | Values: 116.0 116.0 116.0 118.0 116.0 117.0 117.0 116.0 116.0 117.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:36:12 INFO - PROCESS | 10870 | Values: 146.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:36:12 INFO - PROCESS | 10870 | Values: 95.0 95.0 96.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.00 stddev:2.94 (5.6%) stddev-sans-first:3.10 17:36:12 INFO - PROCESS | 10870 | Values: 53.0 62.0 52.0 53.0 53.0 53.0 54.0 52.0 53.0 55.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 17:36:12 INFO - PROCESS | 10870 | Values: 62.0 62.0 61.0 61.0 62.0 62.0 62.0 61.0 62.0 61.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:80.00 stddev:9.37 (11.7%) stddev-sans-first:9.77 17:36:12 INFO - PROCESS | 10870 | Values: 78.0 80.0 78.0 84.0 80.0 80.0 79.0 81.0 109.0 79.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:129.00 stddev:6.48 (5.0%) stddev-sans-first:6.46 17:36:12 INFO - PROCESS | 10870 | Values: 120.0 122.0 120.0 121.0 137.0 134.0 120.0 130.0 131.0 128.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:1.70 (1.0%) stddev-sans-first:1.69 17:36:12 INFO - PROCESS | 10870 | Values: 164.0 165.0 160.0 162.0 161.0 163.0 164.0 162.0 162.0 160.0 17:36:12 INFO - PROCESS | 10870 | 17:36:12 INFO - PROCESS | 10870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.42 17:36:12 INFO - PROCESS | 10870 | Values: 66.0 64.0 66.0 67.0 66.0 63.0 63.0 64.0 64.0 64.0 17:36:12 INFO - PROCESS | 10870 | -------- Summary: end -------- 17:36:12 INFO - PROCESS | 10870 | 17:36:13 INFO - TEST-INFO | 10870: exit 0 17:36:13 INFO - TEST-OK | kraken | took 61170ms 17:36:13 INFO - SUITE-END | took 1174s 17:36:13 INFO - Completed test suite (00:19:34) 17:36:13 INFO - javascript benchmark 17:36:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.2733157707935, 3128.124125244932, 3156.5580818685376, 3170.223295292654, 3201.8399080045992, 5330.253764472977, 5364.758585863636, 5410.0, 5448.4006759256545, 5503.449655034499, 5449.7275136243225, 5456.072467680494, 5503.944960550393, 5578.191162281467, 5580.4698553637445, 4983.451820299764, 4984.850454486371, 5007.974960125212, 5032.798688052473, 5071.644984851062, 5153.742312884359, 5182.585393168556, 5183.507566781169, 5225.6864588124645, 5233.241180028894, 4871.391076115486, 5121.718305493215, 5139.563137133329, 5158.509941555546, 5177.818776342829, 4982.377202849644, 4994.126027945095, 4995.775190116454, 5002.699838009695, 5046.26829109777, 4963.925541116886, 4991.550760431579, 5030.924536131961, 5047.369078865142, 5075.238714192864, 5306.442823503515, 5396.082665946759, 5508.9724551377385, 5548.223248745179, 5560.388357280696, 5867.090600956859, 5890.469857712784, 5989.3112292086535, 5993.850153746148, 5995.1906492623375, 5980.282366116094, 5981.730822113015, 6023.006203976339, 6033.698315084228, 6042.667653279068, 5336.466353364672, 5425.430329815392, 5478.698671573102, 5575.2473416088715, 5580.497755202011, 6057.644847511935, 6076.092565395143, 6083.050509083631, 6084.756609735649, 6111.022236442148, 5886.381929897385, 5893.204417403681, 5898.203742494794, 5899.380565040695, 5900.911486327708, 5669.659820410789, 5747.798827041033, 5752.9712351437975, 5777.94222057774, 5998.220231369894, 5793.391693872167, 5796.42035796417, 5801.158831969341, 5803.187553742479, 5806.187133801272, 5759.452851979056, 5789.189513468118, 5800.0, 5802.82591522255, 5808.709564521757, 4346.065595896835, 4392.780360981938, 4412.0955204183065, 4444.511103778582, 4461.353103799996, 3983.24318379507, 3991.3613821788376, 3991.481107456012, 4005.759654420744, 4029.597040295947, 5454.509094181542, 5525.723713814293, 5545.306836645419, 5595.8880822384135, 5610.046292130348, 5887.234659494238, 5908.084246941731, 5943.375945525744, 5948.613340132878, 6006.759729610854, 5578.470045345685, 5587.888242235133, 5594.0769772987815, 5595.664260144405, 5597.440255974451, 4794.113089078532, 4899.853004409873, 4919.36048313724, 4925.7783399747095, 4935.0, 6127.433875357673, 6145.4161854623735, 6156.107364432132, 6156.661383623854, 6165.475934545524, 5987.191729116514, 5988.371221021905, 5991.940080599138, 5993.101034844808, 6023.518118550418, 5908.084246941731, 5937.732802024006, 5953.672548009901, 5975.760969561343, 6120.387961203844, 5719.542436604978, 5720.914186287292, 5730.455606717355, 5731.8567035824435, 5734.111212762028, 5753.712314384347, 5797.0, 5806.390329015561, 5813.82558523245, 5813.94186058134, 5525.806596769094, 5763.6541807491685, 5797.362290148165, 5847.298324201123, 5890.087036509348, 5841.707914604168, 5853.560982926383, 5859.062549991981, 5862.824115276549, 5868.911966320594, 5619.0, 5699.772009119754, 5766.3368712598585, 5772.336181339032, 5772.826815195551, 5671.517920976763, 5689.6586204827845, 5695.487406133468, 5714.942850571441, 5787.594868359174, 5704.743286552198, 5708.400617935057, 5761.337446193741, 5765.682887441231, 5813.0], "value": 5426.218394074279, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.4611011759063, 617.3116974573351, 624.5347216323839, 628.224143183169, 634.5114262018246, 30548.236294092658, 42553.78723106388, 44148.77925610376, 44180.999999999956, 47942.28086578704, 43899.56100438994, 44445.33332000022, 44530.777346113304, 44546.55453445465, 44565.331520027146, 8015.118336982956, 8736.694215702468, 8927.419717718327, 8929.196372326489, 8929.866052009225, 10194.847077293847, 10493.947530262376, 10498.212634052477, 10759.462026898664, 10762.408067556282, 10631.574737010511, 10751.193660475457, 10753.677389678322, 10754.892451075468, 10756.946215268912, 8056.436049476539, 10587.523561439677, 10608.0, 10688.786224275509, 10831.350118992807, 10252.333598316085, 10607.15142788575, 10611.469426528643, 10617.256792024562, 10624.09695175911, 42086.78956605228, 42742.358864617054, 42771.35842962358, 42818.571814282084, 42889.571104289185, 3759.6804271636943, 3889.611038896116, 4049.5140583130215, 4249.32010878258, 4347.239233134189, 31930.521042184388, 32222.51666224985, 32312.0, 32671.346573068644, 33924.66075339264, 4389.2977123660385, 4437.2234858899565, 4446.155230506226, 4483.3723278741, 4519.796609152596, 341172.0, 343498.28250858834, 344643.0, 344656.0, 345743.0, 63024.0, 63290.0, 63614.0, 63718.36281637217, 63750.36249637537, 36934.8153259232, 37730.62269377271, 37737.81131094327, 39672.404913926315, 39686.20627587432, 16436.260368283456, 16576.83423165777, 16588.170591470378, 16593.6681266374, 16597.751033734505, 11684.70788230301, 12177.756444871053, 12289.385530723428, 12400.503979840705, 12462.127651064338, 20964.0, 20970.79029209719, 21197.576048478943, 21210.575788484144, 21275.0, 7672.884906726404, 7745.961270193613, 7851.9977405761165, 7963.362930965509, 7965.442419030613, 1037.2117190934944, 1072.6621114349111, 1083.8297978413111, 1154.6189757380043, 1245.2092920995053, 33208.66791332104, 33236.83381583125, 33489.33021339608, 33494.16264593405, 33783.32433351369, 1144.4449442020614, 1214.8359971403925, 1233.2045830439317, 1240.3674126195524, 1294.5792617399384, 17594.38419655306, 17616.0, 17660.381886634164, 17744.822551774574, 17749.467515974542, 560208.0, 565927.5332610043, 566675.0, 566878.0, 567188.0, 57632.71183644139, 59247.40752592505, 59312.40687593155, 59377.40622593805, 59449.702751485966, 1299.1944994103717, 1332.513632524141, 1371.4377105386743, 1381.7650999330137, 1401.7617005108953, 31912.5213121808, 34322.313553729284, 34341.656583434844, 34384.312313753086, 34531.59420578177, 50777.74611127069, 51027.23459148042, 51386.0, 51487.742561286956, 51504.652197607036, 406168.0, 407506.0, 407621.0, 407733.0, 408536.0, 25676.0, 27915.720842791314, 28841.85579072091, 29033.0, 29975.550366744952, 44637.77681111704, 45994.0, 45995.0, 47063.76468117638, 47140.05719885651, 38832.0, 39015.21969560536, 39278.4108238371, 39299.07009299047, 40341.1931761369, 39120.80439597784, 39242.60757392504, 39524.0, 39854.60145398509, 40054.1989160221, 39588.60411395849, 39941.600583993786, 40219.0, 40361.59638403696, 40525.1894962105, 33213.0, 34672.653273466945, 35339.0, 35423.46864797082, 35880.46179307365, 27248.182554523395, 27590.20605672831, 27631.408435259873, 27816.304592385353, 28029.579556306264], "value": 20526.400651524076, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.6458969222547, 396.40935006839817, 404.92104039712257, 406.12480105372896, 420.8989842437814, 17438.91280543597, 18774.62450750984, 19157.712634310497, 19164.329248476308, 20017.399478015646, 18226.453206403796, 18793.342233021845, 18923.43229703111, 18952.810471895278, 19080.809191908076, 5522.392536820947, 5672.290963629556, 5803.187553742479, 5811.709414529278, 5912.17229587858, 5796.449337312949, 5813.82558523245, 5861.677607731573, 5893.292804863422, 6646.1027761252335, 6559.376859198393, 6588.802335929906, 6617.4706023518, 6619.536632435731, 6619.768308109217, 5950.285965684102, 5951.4048595140575, 5957.493613042897, 6105.20632317798, 6580.473562115019, 5744.655320680731, 5745.224394706703, 5755.309362876482, 5759.222504961818, 5793.420657934215, 13204.801927971088, 16538.421155259628, 19389.32137375199, 22457.550848983094, 22471.101155953744, 2193.331034034619, 2278.5442911417617, 2296.8392212545127, 2354.8233882458885, 2363.8818059096975, 9978.201743860474, 10159.4920253987, 10354.223433242538, 10491.055804977512, 10646.307989980627, 1896.506908203863, 1929.4211736479, 1934.177974360891, 1952.6094781043848, 1993.8903360315321, 75068.0, 75642.62178689126, 77527.22472775256, 78165.21834781693, 78185.0, 9799.461029643295, 9820.754481138028, 9989.0, 10042.74893127663, 10048.547815348327, 13304.401301941241, 13368.799468007988, 13401.463941442427, 13430.597082087554, 13458.192508449329, 7694.846103078019, 7769.300762931251, 7800.6099695016155, 7819.413543984224, 7948.324392426708, 7808.2191780822595, 7829.960850195713, 8032.879506807402, 8035.236652518001, 8056.033276006917, 4141.503019637603, 4167.499500299857, 4214.704970652025, 4292.441982542249, 4297.09760950204, 1881.2380985700813, 1964.5424053665365, 1978.0703069557285, 2003.719479272903, 2011.7384739983709, 896.7085697148453, 923.4505469245788, 1014.4319181258519, 1027.0499787696351, 1117.1230583991528, 18337.908310458628, 18434.0, 19132.713009304873, 19287.710684339745, 19442.125104370338, 978.2125389061731, 989.1740396768779, 1014.7361685961703, 1037.2117190934794, 1063.3832377221192, 10181.0, 10440.63457778974, 10740.355578665149, 10825.29635573701, 11241.466623637632, 492290.7698230545, 508322.0, 509284.0, 512189.0, 515273.0, 66145.0, 79237.60381198057, 80484.0, 90914.54542727245, 91140.0, 1028.290479569095, 1045.6915210013065, 1053.167997282154, 1053.8155822730992, 1062.9893701063045, 12965.675858103623, 16197.838021619633, 16732.916335418246, 17427.302907883543, 17490.387836425663, 38633.0, 39235.0, 39360.80319598383, 40014.79992600018, 40652.3902141474, 50691.0, 51731.224031638805, 52169.478305216464, 52949.0, 53043.734781325846, 7393.55638661682, 8327.916720832714, 8373.246407823324, 8471.872921906053, 8727.476351418934, 10847.511861966073, 12252.081093917814, 12912.935435322763, 13036.608901732963, 13184.670383240496, 10878.836817447585, 11175.329480231212, 11256.099512038854, 11269.211155219056, 11362.375069371265, 10950.507227174956, 11004.779904402027, 11400.429978500875, 11482.253653512495, 11492.425378731197, 11234.269772464764, 11325.603603873826, 11527.8270825936, 11836.171467997501, 11855.407229638311, 7372.189059203376, 7382.446316526175, 7500.0, 7536.0, 7813.531188128731, 10859.674209773719, 11130.443477826238, 11172.385518796544, 11376.94311528437, 11752.882471175179], "value": 8969.336243962649, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.3595074364298, 1480.400437822682, 1517.1276516003297, 1669.9415520456787, 1817.2095138614711, 8697.869531957018, 9041.593128309234, 9106.453612783238, 9269.212116970066, 9271.90728092719, 8973.955130224356, 9172.12864777845, 9176.082391760821, 9177.0, 9178.724638260846, 1955.8533110016735, 2012.2956965062258, 2014.526586252237, 2411.7226518950283, 2441.706995160583, 2409.4578719787996, 2482.689663792026, 2487.4776296977657, 2492.264781889338, 2497.8126640501946, 2378.512404956988, 2393.581123303415, 2398.940026499334, 2411.9276421707377, 2447.8898449569724, 2063.123172651617, 2355.163916809542, 2374.964375534368, 2408.3136306152664, 2414.7343792182846, 2424.854508729482, 2446.54738873309, 2447.865367404792, 2452.3746444656676, 2453.8036957043396, 9019.909800901973, 9086.273098152133, 9100.36297459178, 9101.817963640757, 9118.316126290554, 5363.517283444469, 5486.067368547317, 5493.7802487900435, 5499.642523235977, 5500.477454641803, 3140.5289206618963, 3168.556402103707, 3338.88313909012, 3359.7312215022985, 3365.6634336566394, 1053.8682664666917, 1055.4669891704716, 1063.2344711807486, 1067.0769784136744, 1094.7372630568686, 12884.80672789909, 12972.481100755958, 12990.0, 13012.154209976321, 13018.218906865619, 4964.950350496521, 5004.549590536869, 5008.373953255843, 5014.147594908874, 5045.5459008689395, 10642.521086550969, 10647.520861561248, 10668.0, 10721.678349649523, 10736.194785391126, 5625.156226566048, 5625.746841392147, 5627.6904770237215, 5630.943690563124, 5633.746481408347, 4461.821527138943, 4670.696404733681, 5065.214891691794, 5093.592512599057, 5128.8461346159675, 4087.8978025549004, 4166.354215096665, 4191.057012172298, 4192.895177620584, 4243.9814444533085, 1302.374860067154, 1324.595998220552, 1328.4221363706818, 1341.0679577693409, 1355.857634948336, 1030.3714734012246, 1030.8762948446235, 1052.7210289273348, 1054.4833031814355, 1054.8892366301582, 6220.564560480723, 6244.469220116341, 6315.210598675166, 6326.2724786649205, 6352.396522330371, 944.9338546301693, 981.425865868475, 1000.8098461292332, 1013.1034034879185, 1021.1881554164457, 4236.661067114624, 4320.503142138631, 4333.653307735373, 4370.475542934868, 4380.956190438119, 11302.321860688386, 11688.18182727201, 11727.882721172678, 11728.061755059574, 11748.118891083202, 10895.128389728803, 11211.495482703298, 11251.493682784294, 11668.88331116678, 11702.356370399539, 8463.830723385621, 8657.870131948026, 8671.132886711279, 8673.262772664268, 8673.522956237468, 6181.165542651865, 6412.070249813844, 6448.419642232222, 6511.967440162769, 6537.411632953057, 10501.527431265458, 10818.729531761768, 10871.67384978452, 10889.237753357505, 10939.398333091756, 10965.232433729563, 10977.121830253402, 11034.613788517363, 11105.888941110485, 11107.888921110685, 7401.370883474965, 7618.69525218985, 7620.237976202336, 7835.138134805053, 8083.110857805755, 8449.028361738234, 8586.570671466277, 8830.95584522099, 8844.911550884666, 9083.046280140754, 7779.92220077792, 7811.336036436966, 7918.0, 7983.32141767933, 8120.02559692817, 7834.216578342348, 7937.087234968052, 7967.04395472547, 7998.040235171817, 8051.275385215359, 7186.173590037212, 7194.4244460442, 7239.0, 7258.346748792634, 7261.5280006799385, 5292.5501332387175, 5329.067413202752, 5370.704611246419, 5410.702411367412, 5455.045367060828, 5417.539509141767, 5450.863728406822, 5451.373092094302, 5476.534494567847, 5577.358603760619], "value": 4820.725768009314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.6040539933183, 324.36262743708625, 328.64834626949175, 329.7774002548279, 332.37347599774415, 5314.548263397611, 5320.680759154454, 5332.786688532459, 5343.919841202385, 5393.2449457076045, 5300.178472336785, 5310.256564081032, 5322.0, 5326.840194794153, 5336.252924590551, 3945.763254204757, 4006.577664928952, 4109.137081212949, 4151.484708081543, 4154.646855017312, 4106.876793696194, 4123.505179378479, 4127.504699436057, 4140.296149654551, 4146.834126634931, 3919.960800391988, 4042.636162745367, 4092.4679791627045, 4113.794310284488, 4119.876403707894, 4042.171354872244, 4102.651274641659, 4131.338985762263, 4137.193247316759, 4138.503379594438, 3615.493830863681, 3643.635636436362, 3649.2701459708164, 3653.9586217928027, 3661.487391765155, 5054.393472783253, 5096.082705113078, 5100.744962751847, 5117.41149767774, 5186.273921650972, 4464.843730469418, 4651.674382793206, 4659.254519276899, 4684.0, 4725.480197178307, 5417.891642167135, 5449.891002179974, 5471.671699697991, 5518.586106042063, 5521.972390138064, 3739.25214957007, 3921.627445392683, 3924.3132451820816, 3925.8233379497706, 3976.204759048202, 5667.263255776723, 5698.145278208261, 5767.394423585505, 5787.652740835563, 5788.450097240755, 4021.7788021658503, 4031.8992025199605, 4034.2738307104414, 4034.757914525138, 4039.8990025249605, 3888.5916978716828, 4085.8151136170773, 4104.938425923614, 4120.567340429272, 4122.670186385082, 4610.27114831938, 4627.583517483443, 4653.6509761768, 4677.298405239241, 4678.391809064868, 5543.805966791224, 5551.057130004466, 5557.249771280906, 5557.305336832896, 5576.749046292926, 1374.3403166479945, 1410.746065708162, 1422.9470192058009, 1425.2659880161725, 1426.1300606629948, 951.6050838901916, 954.236610711428, 975.7072878136672, 984.945827979468, 1018.3024628129755, 5286.524212820865, 5318.65428747138, 5330.840074797762, 5335.893282134336, 5345.625806193529, 5643.98047044829, 5645.0, 5664.405237450009, 5664.745086471119, 5679.545636349082, 5227.921581176285, 5254.527092561688, 5262.421133675292, 5293.655912365684, 5384.865378365494, 2931.51629981055, 2956.0046968296315, 2980.8211507309197, 2983.4033193361415, 2998.9850050749606, 5538.418466061005, 5753.769849205984, 5763.308402991668, 5794.942050579441, 5797.594168408255, 5653.434656534314, 5682.289713785777, 5685.289338832646, 5707.34365547959, 5717.799877004285, 5774.711264436762, 5779.913301300484, 5804.216430781875, 5859.033259512218, 5876.529877609695, 5393.622446428869, 5646.435356464485, 5669.711567291044, 5698.31620205578, 5704.229928959538, 5533.6403133796175, 5542.972285138549, 5594.300712410949, 5630.18362337467, 5671.631343962629, 5813.168851811666, 5837.562182836389, 5843.0, 5862.124120281469, 5882.23530940975, 3841.5390153181797, 4065.2682517146013, 4072.735272207297, 4082.6116721718126, 4086.959130408658, 5723.484886360081, 5743.684097374685, 5749.511291540099, 5758.395368486249, 5759.308882933907, 5407.188921661782, 5665.858353541194, 5672.75199456119, 5673.74468148926, 5694.345150307602, 5622.269105016485, 5646.548276137817, 5653.2085508028085, 5664.178694089416, 5664.433556644467, 5286.180642000496, 5340.092184328596, 5469.562435005269, 5519.696416696959, 5530.723463826873, 5559.19391688211, 5599.608027438203, 5611.3266408031295, 5625.746841392065, 5637.267155269788, 5407.432219616883, 5457.308234447334, 5466.781328746805, 5482.862928426821, 5501.111916243844], "value": 4220.6949996202575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.4551586310267, 849.4266370200113, 851.7189327521914, 857.8584533551964, 858.5106489301099, 14404.783928241071, 15085.0, 15159.090454572706, 15340.923295383536, 15363.0, 13960.441582336694, 13978.860211397883, 14098.506552270672, 14118.152910825333, 14149.36327865246, 668.7625892808056, 775.8797386405088, 780.8516381887438, 796.24356860982, 800.0958916424432, 799.436397339874, 801.0867610923552, 802.5866678660494, 802.6749166587513, 803.0724513187278, 855.7988872614931, 856.4775486952954, 857.395536147018, 857.4212406625534, 857.5797859049052, 700.8318003679132, 826.2439867521181, 848.1772680499967, 848.567230712335, 850.7617866997251, 615.6213928433981, 616.2174038970483, 616.2512547255106, 616.3435940723116, 616.6793267500874, 13045.934770326183, 13064.085514014023, 13080.345982700826, 13085.803712944313, 13090.934545327307, 13574.86425135746, 13941.512047078304, 13944.58166255014, 13959.302034898315, 14025.0, 12143.514259429612, 12174.756504869942, 12330.691732706664, 12605.11764176508, 12707.110502264844, 4392.802323895432, 4482.238019536654, 4489.865304040884, 4544.636429085665, 4585.3122031695175, 56940.71529642325, 57347.42652573463, 57592.71203643955, 60503.697481512754, 61137.0, 11138.164637652208, 11198.38408887519, 11226.0, 11250.831237531444, 11314.208005439541, 19887.204511819655, 19929.601407972048, 19943.800561994485, 19951.800481994993, 19970.0, 8047.476914000571, 8167.183281671785, 8309.169083091763, 8417.452865563719, 8510.78723031929, 4575.81696732127, 4617.445906491175, 4675.696079754873, 4690.038542098861, 4738.549837765407, 3367.461206206995, 3491.877784277538, 3493.056874643832, 3494.650534946536, 3496.5104885316077, 544.8692313844728, 580.6109906362747, 642.0529718664932, 646.6249575246346, 647.5499527828208, 537.7150110441394, 635.5763883371784, 715.5027256056991, 774.8334108166771, 792.5126047480873, 9694.0, 9910.702678919644, 10048.497575121215, 10080.344777589433, 10088.142507886765, 727.3889932456761, 733.5158795195146, 736.6832262127336, 749.456643933155, 753.2806170107534, 4628.143793398232, 4669.556392142741, 4706.717596944194, 4769.499202583679, 4803.351547541037, 68429.31570684329, 68589.3141068593, 68602.31397685959, 68801.65599171972, 69115.0, 61290.0, 63284.36715632785, 63285.0, 63760.36239637637, 66320.33679663239, 57540.71229643825, 57672.71163644155, 57823.0, 57864.0, 58288.0, 9041.63833446681, 9154.725358239264, 9188.862167067366, 9217.124373184537, 9326.393784403992, 38036.0, 38142.618573815016, 38398.42402363911, 38611.806940965114, 39189.80405097956, 47338.76330618463, 51908.221376680136, 52588.211176833145, 52982.0, 53377.0, 11782.877537452754, 11801.602283030394, 11849.940750296193, 12074.577389791315, 12240.08199385032, 13470.393832277767, 13805.378757956118, 14167.64580885486, 14555.345009474811, 14598.562043138723, 12769.936150319189, 12832.615021549369, 13039.217646941213, 13170.407331670289, 13788.172709637454, 12410.875891240972, 12582.559610413591, 12839.550615728405, 13020.41408136655, 13233.602991910258, 13477.797833032708, 13558.525451609146, 13635.795463067863, 13768.793468098187, 13916.0, 10857.511411986321, 10907.945460272647, 11137.888621113685, 11294.152938529478, 11531.654050378502, 11526.308421494401, 11807.17349785541, 12072.456739446921, 12098.334591597546, 12167.878321216675], "value": 7018.671526556976, "unit": "score"}], "name": "dromaeo_css", "value": 7228.712408406807, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 109.0, 109.0, 109.0, 110.0, 111.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 126.0, 182.0, 128.0, 125.0, 155.0, 124.0, 163.0, 123.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 111.0, 74.0, 74.0, 77.0, 74.0, 97.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 124.0, 83.0, 83.0, 83.0, 113.0, 83.0, 83.0, 128.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 118.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 62.0, 52.0, 53.0, 53.0, 53.0, 54.0, 52.0, 53.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 84.0, 80.0, 80.0, 79.0, 81.0, 109.0, 79.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 120.0, 121.0, 137.0, 134.0, 120.0, 130.0, 131.0, 128.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 160.0, 162.0, 161.0, 163.0, 164.0, 162.0, 162.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 67.0, 66.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1495.3999999999999, "alertThreshold": 2.0}]} 17:36:13 INFO - Return code: 0 17:36:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:36:13 ERROR - # TBPL SUCCESS # 17:36:13 INFO - Running post-action listener: _resource_record_post_action 17:36:13 INFO - ##### 17:36:13 INFO - ##### Finished run-tests step (success) 17:36:13 INFO - ##### 17:36:13 INFO - Running post-run listener: _resource_record_post_run 17:36:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 538624000; Read time: 0; Write time: 413776 17:36:13 INFO - TinderboxPrint: CPU usage
13.1% 17:36:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:36:13 INFO - TinderboxPrint: I/O write bytes / time
538,624,000 / 413,776 17:36:13 INFO - TinderboxPrint: CPU idle
8,267.8 (86.9%) 17:36:13 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 17:36:13 INFO - TinderboxPrint: Swap in / out
0 / 0 17:36:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247046144; Read time: 0; Write time: 220184 17:36:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291528704; Read time: 0; Write time: 193572 17:36:14 INFO - Running post-run listener: _upload_blobber_files 17:36:14 INFO - Blob upload gear active. 17:36:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:14 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:36:14 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:36:14 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:36:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:15 INFO - (blobuploader) - INFO - Done attempting. 17:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:19 INFO - (blobuploader) - INFO - Done attempting. 17:36:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:36:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:20 INFO - (blobuploader) - INFO - Done attempting. 17:36:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:20 INFO - Return code: 0 17:36:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fbaf8d9e9b3e940eb76ea5116a0b168fb4e16fceedc489a457bba5a9f35f1743a54d85f55ff984f2ea62cf5633fb21fe0703865069f482ae03ed9e2308a63f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/070dd227583881c6fd2d9a9811ec66d3088402846c10b7c278a5ebb90223d3bfe8929f0974fe58f5068e1aed1093f023d2e1334fb480cfc0e9887997d0396fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612d0e1c5f5fa3b6921613c9e3f3a4a1427c59116d457d6bc281a091f2eebbe6757cdbbc430864f22679dabac1c5f28b17f60d25777c693dd785473ebc6d8906"} 17:36:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:20 INFO - Contents: 17:36:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fbaf8d9e9b3e940eb76ea5116a0b168fb4e16fceedc489a457bba5a9f35f1743a54d85f55ff984f2ea62cf5633fb21fe0703865069f482ae03ed9e2308a63f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/070dd227583881c6fd2d9a9811ec66d3088402846c10b7c278a5ebb90223d3bfe8929f0974fe58f5068e1aed1093f023d2e1334fb480cfc0e9887997d0396fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612d0e1c5f5fa3b6921613c9e3f3a4a1427c59116d457d6bc281a091f2eebbe6757cdbbc430864f22679dabac1c5f28b17f60d25777c693dd785473ebc6d8906"} 17:36:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:20 INFO - Copying logs to upload dir... 17:36:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.051651 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-27 17:36:20.370515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 17:36:20.374316) ========= 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-1464392812.756162-103401560 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/4fbaf8d9e9b3e940eb76ea5116a0b168fb4e16fceedc489a457bba5a9f35f1743a54d85f55ff984f2ea62cf5633fb21fe0703865069f482ae03ed9e2308a63f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/070dd227583881c6fd2d9a9811ec66d3088402846c10b7c278a5ebb90223d3bfe8929f0974fe58f5068e1aed1093f023d2e1334fb480cfc0e9887997d0396fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612d0e1c5f5fa3b6921613c9e3f3a4a1427c59116d457d6bc281a091f2eebbe6757cdbbc430864f22679dabac1c5f28b17f60d25777c693dd785473ebc6d8906"} build_url:https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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/4fbaf8d9e9b3e940eb76ea5116a0b168fb4e16fceedc489a457bba5a9f35f1743a54d85f55ff984f2ea62cf5633fb21fe0703865069f482ae03ed9e2308a63f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/070dd227583881c6fd2d9a9811ec66d3088402846c10b7c278a5ebb90223d3bfe8929f0974fe58f5068e1aed1093f023d2e1334fb480cfc0e9887997d0396fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612d0e1c5f5fa3b6921613c9e3f3a4a1427c59116d457d6bc281a091f2eebbe6757cdbbc430864f22679dabac1c5f28b17f60d25777c693dd785473ebc6d8906"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 17:36:20.403605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:36:20.403969) ========= 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-1464392812.756162-103401560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:36:20.485339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 17:36:20.485697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 17:36:20.486043) ========= ========= Total master_lag: 0.18 =========