builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1470095573.45 results: success (0) buildid: 20160801141652 builduid: f43ab8988dfc4cd3a86b90787d8f9381 revision: 548a789b4f12769eb61c9daf826c49fe255ec2a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.450114) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.450561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.450839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.465214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.465488) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 16:52:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-01 16:52:53 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.556282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.556649) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015607 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.606487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:53.606861) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 548a789b4f12769eb61c9daf826c49fe255ec2a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 548a789b4f12769eb61c9daf826c49fe255ec2a1 --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=652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 16:52:53,746 truncating revision to first 12 chars 2016-08-01 16:52:53,746 Setting DEBUG logging. 2016-08-01 16:52:53,746 attempt 1/10 2016-08-01 16:52:53,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/548a789b4f12?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 16:52:54,053 unpacking tar archive at: mozilla-aurora-548a789b4f12/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:54.269194) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:54.269518) ========= script_repo_revision: 548a789b4f12769eb61c9daf826c49fe255ec2a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:54.269899) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:54.270163) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:54.279899) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-01 16:52:54.280167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:54 INFO - MultiFileLogger online at 20160801 16:52:54 in /builds/slave/test 16:52:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:52:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:54 INFO - {'append_to_log': False, 16:52:54 INFO - 'base_work_dir': '/builds/slave/test', 16:52:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:52:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:54 INFO - 'branch': 'Mozilla-Aurora', 16:52:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:54 INFO - 'config_files': ('talos/linux_config.py',), 16:52:54 INFO - 'default_actions': ('clobber', 16:52:54 INFO - 'read-buildbot-config', 16:52:54 INFO - 'download-and-extract', 16:52:54 INFO - 'populate-webroot', 16:52:54 INFO - 'create-virtualenv', 16:52:54 INFO - 'install', 16:52:54 INFO - 'run-tests'), 16:52:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:54 INFO - 'download_minidump_stackwalk': True, 16:52:54 INFO - 'download_symbols': 'ondemand', 16:52:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:54 INFO - 'installer_path': 'installer.exe', 16:52:54 INFO - 'log_level': 'info', 16:52:54 INFO - 'log_name': 'talos', 16:52:54 INFO - 'log_to_console': True, 16:52:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:54 INFO - 'opt_config_files': (), 16:52:54 INFO - 'pip_index': False, 16:52:54 INFO - 'sps_profile': False, 16:52:54 INFO - 'sps_profile_interval': 0, 16:52:54 INFO - 'suite': 'dromaeojs', 16:52:54 INFO - 'system_bits': '32', 16:52:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:54 INFO - 'title': 'talos-linux64-ix-046', 16:52:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:54 INFO - 'use_talos_json': True, 16:52:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:54 INFO - 'work_dir': 'build'} 16:52:54 INFO - [mozharness: 2016-08-01 23:52:54.514216Z] Running clobber step. 16:52:54 INFO - Running pre-action listener: _resource_record_pre_action 16:52:54 INFO - Running main action method: clobber 16:52:54 INFO - rmtree: /builds/slave/test/build 16:52:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:54 INFO - Running post-action listener: _resource_record_post_action 16:52:54 INFO - [mozharness: 2016-08-01 23:52:54.966388Z] Finished clobber step (success) 16:52:54 INFO - [mozharness: 2016-08-01 23:52:54.966488Z] Running read-buildbot-config step. 16:52:54 INFO - Running pre-action listener: _resource_record_pre_action 16:52:54 INFO - Running main action method: read_buildbot_config 16:52:54 INFO - Using buildbot properties: 16:52:54 INFO - { 16:52:54 INFO - "project": "", 16:52:54 INFO - "product": "firefox", 16:52:54 INFO - "script_repo_revision": "production", 16:52:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:52:54 INFO - "repository": "", 16:52:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:52:54 INFO - "buildid": "20160801141652", 16:52:54 INFO - "pgo_build": "True", 16:52:54 INFO - "basedir": "/builds/slave/test", 16:52:54 INFO - "buildnumber": 655, 16:52:54 INFO - "slavename": "talos-linux64-ix-046", 16:52:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:52:54 INFO - "platform": "ubuntu64_hw", 16:52:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:52:54 INFO - "branch": "mozilla-aurora", 16:52:54 INFO - "repo_path": "releases/mozilla-aurora", 16:52:54 INFO - "revision": "548a789b4f12769eb61c9daf826c49fe255ec2a1", 16:52:54 INFO - "stage_platform": "linux64-pgo", 16:52:54 INFO - "builduid": "f43ab8988dfc4cd3a86b90787d8f9381", 16:52:54 INFO - "slavebuilddir": "test" 16:52:54 INFO - } 16:52:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 16:52:54 INFO - Running post-action listener: _resource_record_post_action 16:52:54 INFO - [mozharness: 2016-08-01 23:52:54.968902Z] Finished read-buildbot-config step (success) 16:52:54 INFO - [mozharness: 2016-08-01 23:52:54.968990Z] Running download-and-extract step. 16:52:54 INFO - Running pre-action listener: _resource_record_pre_action 16:52:54 INFO - Running main action method: download_and_extract 16:52:54 INFO - mkdir: /builds/slave/test/build/tests 16:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:54 INFO - https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:52:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:52:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:52:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:52:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:52:55 INFO - Downloaded 1361 bytes. 16:52:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:52:55 INFO - Using the following test package requirements: 16:52:55 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 16:52:55 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:55 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:52:55 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'jsshell-linux-x86_64.zip'], 16:52:55 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:55 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 16:52:55 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:52:55 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:52:55 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:55 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:52:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:55 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:55 INFO - https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:52:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:52:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:52:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:57 INFO - Downloaded 21765381 bytes. 16:52:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:52:58 INFO - Return code: 0 16:52:58 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:52: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')]} 16:52:58 INFO - https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:52:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:52:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:59 INFO - Downloaded 21765381 bytes. 16:52:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:53:00 INFO - Return code: 0 16:53: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')]} 16:53:00 INFO - https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:53:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:53:01 INFO - Downloaded 14413723 bytes. 16:53:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:53:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:53:01 INFO - Return code: 0 16:53:01 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')]} 16:53:01 INFO - https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:53:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:53:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:53:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:53:03 INFO - Downloaded 63754554 bytes. 16:53:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:53:03 INFO - mkdir: /builds/slave/test/properties 16:53:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:03 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:03 INFO - Contents: 16:53:03 INFO - build_url:https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:53:03 INFO - Running post-action listener: _resource_record_post_action 16:53:03 INFO - Running post-action listener: set_extra_try_arguments 16:53:03 INFO - [mozharness: 2016-08-01 23:53:03.696689Z] Finished download-and-extract step (success) 16:53:03 INFO - [mozharness: 2016-08-01 23:53:03.696922Z] Running populate-webroot step. 16:53:03 INFO - Running pre-action listener: _resource_record_pre_action 16:53:03 INFO - Running main action method: populate_webroot 16:53:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:03 INFO - '--tppagecycles', 16:53:03 INFO - '7'], 16:53:03 INFO - 'tests': ['tsvgm']}}, 16:53:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:53:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:53:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['damp', 'tps']}, 16:53:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'tests': ['damp', 'tps']}, 16:53:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['dromaeo_dom']}, 16:53:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['basic_compositor_video']}, 16:53:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:53:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['a11yr', 16:53:03 INFO - 'ts_paint', 16:53:03 INFO - 'tpaint', 16:53:03 INFO - 'sessionrestore', 16:53:03 INFO - 'sessionrestore_no_auto_restore', 16:53:03 INFO - 'tabpaint']}, 16:53:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:53:03 INFO - 'ts_paint', 16:53:03 INFO - 'tpaint', 16:53:03 INFO - 'sessionrestore', 16:53:03 INFO - 'sessionrestore_no_auto_restore', 16:53:03 INFO - 'tabpaint']}, 16:53:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:53:03 INFO - 'ts_paint', 16:53:03 INFO - 'tpaint', 16:53:03 INFO - 'sessionrestore', 16:53:03 INFO - 'sessionrestore_no_auto_restore', 16:53:03 INFO - 'tabpaint']}, 16:53:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:53:03 INFO - 'ts_paint', 16:53:03 INFO - 'tpaint', 16:53:03 INFO - 'sessionrestore', 16:53:03 INFO - 'sessionrestore_no_auto_restore', 16:53:03 INFO - 'tabpaint']}, 16:53:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['a11yr', 16:53:03 INFO - 'ts_paint', 16:53:03 INFO - 'tpaint', 16:53:03 INFO - 'sessionrestore', 16:53:03 INFO - 'sessionrestore_no_auto_restore', 16:53:03 INFO - 'tabpaint']}, 16:53:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['a11yr', 16:53:03 INFO - 'ts_paint', 16:53:03 INFO - 'tpaint', 16:53:03 INFO - 'sessionrestore', 16:53:03 INFO - 'sessionrestore_no_auto_restore', 16:53:03 INFO - 'tabpaint']}, 16:53:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['tsvgx', 16:53:03 INFO - 'tsvgr_opacity', 16:53:03 INFO - 'tart', 16:53:03 INFO - 'tscrollx', 16:53:03 INFO - 'cart']}, 16:53:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:53:03 INFO - 'tsvgr_opacity', 16:53:03 INFO - 'tart', 16:53:03 INFO - 'tscrollx', 16:53:03 INFO - 'cart']}, 16:53:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'talos_options': ['--disable-e10s'], 16:53:03 INFO - 'tests': ['tp5o']}, 16:53:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'tests': ['tp5o']}, 16:53:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'talos_options': ['--disable-e10s', 16:53:03 INFO - '--xperf_path', 16:53:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:03 INFO - 'tests': ['tp5n']}, 16:53:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:03 INFO - 'talos_options': ['--xperf_path', 16:53:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:03 INFO - 'tests': ['tp5n']}}, 16:53:03 INFO - 'talos.zip': {'path': '', 16:53:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:03 INFO - Running post-action listener: _resource_record_post_action 16:53:03 INFO - [mozharness: 2016-08-01 23:53:03.715693Z] Finished populate-webroot step (success) 16:53:03 INFO - [mozharness: 2016-08-01 23:53:03.715782Z] Running create-virtualenv step. 16:53:03 INFO - Running pre-action listener: _resource_record_pre_action 16:53:03 INFO - Running main action method: create_virtualenv 16:53:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:03 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 16:53:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:03 INFO - Using real prefix '/usr' 16:53:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:06 INFO - Installing pip.................done. 16:53:06 INFO - Return code: 0 16:53:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:06 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 16:53:06 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 16:53:06 INFO - Using env: {'DISPLAY': ':0', 16:53:06 INFO - 'HOME': '/home/cltbld', 16:53:06 INFO - 'LANG': 'en_US.UTF-8', 16:53:06 INFO - 'LANGUAGE': 'en_US:en', 16:53:06 INFO - 'LOGNAME': 'cltbld', 16:53:06 INFO - 'MAIL': '/var/mail/cltbld', 16:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:06 INFO - 'MOZ_NO_REMOTE': '1', 16:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:06 INFO - 'NO_EM_RESTART': '1', 16:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:06 INFO - 'PWD': '/builds/slave/test', 16:53:06 INFO - 'SHELL': '/bin/bash', 16:53:06 INFO - 'SHLVL': '1', 16:53:06 INFO - 'TERM': 'linux', 16:53:06 INFO - 'TMOUT': '86400', 16:53:06 INFO - 'USER': 'cltbld', 16:53:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:06 INFO - '_': '/tools/buildbot/bin/python'} 16:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:06 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 16:53:06 INFO - Cleaning up... 16:53:06 INFO - Return code: 0 16:53:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:06 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 16:53:06 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 16:53:06 INFO - Using env: {'DISPLAY': ':0', 16:53:06 INFO - 'HOME': '/home/cltbld', 16:53:06 INFO - 'LANG': 'en_US.UTF-8', 16:53:06 INFO - 'LANGUAGE': 'en_US:en', 16:53:06 INFO - 'LOGNAME': 'cltbld', 16:53:06 INFO - 'MAIL': '/var/mail/cltbld', 16:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:06 INFO - 'MOZ_NO_REMOTE': '1', 16:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:06 INFO - 'NO_EM_RESTART': '1', 16:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:06 INFO - 'PWD': '/builds/slave/test', 16:53:06 INFO - 'SHELL': '/bin/bash', 16:53:06 INFO - 'SHLVL': '1', 16:53:06 INFO - 'TERM': 'linux', 16:53:06 INFO - 'TMOUT': '86400', 16:53:06 INFO - 'USER': 'cltbld', 16:53:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:06 INFO - '_': '/tools/buildbot/bin/python'} 16:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:06 INFO - Downloading/unpacking psutil>=3.1.1 16:53:06 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 16:53:06 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 16:53:06 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 16:53:06 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 16:53:06 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 16:53:06 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 16:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:08 INFO - Installing collected packages: psutil 16:53:08 INFO - Running setup.py install for psutil 16:53:08 INFO - building 'psutil._psutil_linux' extension 16:53:08 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 16:53:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:53:08 INFO - building 'psutil._psutil_posix' extension 16:53:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:53:09 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 16:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:09 INFO - Successfully installed psutil 16:53:09 INFO - Cleaning up... 16:53:09 INFO - Return code: 0 16:53:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:53:09 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')]} 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:09 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')]} 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:09 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:09 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 16:53:09 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 16:53:09 INFO - Using env: {'DISPLAY': ':0', 16:53:09 INFO - 'HOME': '/home/cltbld', 16:53:09 INFO - 'LANG': 'en_US.UTF-8', 16:53:09 INFO - 'LANGUAGE': 'en_US:en', 16:53:09 INFO - 'LOGNAME': 'cltbld', 16:53:09 INFO - 'MAIL': '/var/mail/cltbld', 16:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:09 INFO - 'MOZ_NO_REMOTE': '1', 16:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:09 INFO - 'NO_EM_RESTART': '1', 16:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:09 INFO - 'PWD': '/builds/slave/test', 16:53:09 INFO - 'SHELL': '/bin/bash', 16:53:09 INFO - 'SHLVL': '1', 16:53:09 INFO - 'TERM': 'linux', 16:53:09 INFO - 'TMOUT': '86400', 16:53:09 INFO - 'USER': 'cltbld', 16:53:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:09 INFO - '_': '/tools/buildbot/bin/python'} 16:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:53:09 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 16:53:09 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 16:53:09 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 16:53:09 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 16:53:09 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 16:53:09 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 16:53:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:53:11 INFO - Installing collected packages: mozsystemmonitor 16:53:11 INFO - Running setup.py install for mozsystemmonitor 16:53:11 INFO - Successfully installed mozsystemmonitor 16:53:11 INFO - Cleaning up... 16:53:11 INFO - Return code: 0 16:53:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:11 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:11 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==2.5.1'] in /builds/slave/test/build 16:53:11 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==2.5.1 16:53:11 INFO - Using env: {'DISPLAY': ':0', 16:53:11 INFO - 'HOME': '/home/cltbld', 16:53:11 INFO - 'LANG': 'en_US.UTF-8', 16:53:11 INFO - 'LANGUAGE': 'en_US:en', 16:53:11 INFO - 'LOGNAME': 'cltbld', 16:53:11 INFO - 'MAIL': '/var/mail/cltbld', 16:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:11 INFO - 'MOZ_NO_REMOTE': '1', 16:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:11 INFO - 'NO_EM_RESTART': '1', 16:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:11 INFO - 'PWD': '/builds/slave/test', 16:53:11 INFO - 'SHELL': '/bin/bash', 16:53:11 INFO - 'SHLVL': '1', 16:53:11 INFO - 'TERM': 'linux', 16:53:11 INFO - 'TMOUT': '86400', 16:53:11 INFO - 'USER': 'cltbld', 16:53:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:11 INFO - '_': '/tools/buildbot/bin/python'} 16:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:11 INFO - Downloading/unpacking jsonschema==2.5.1 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:13 INFO - warning: no files found matching '*.txt' 16:53:13 INFO - no previously-included directories found matching 'build' 16:53:13 INFO - no previously-included directories found matching 'dist' 16:53:13 INFO - no previously-included directories found matching '.git*' 16:53:13 INFO - Installing collected packages: jsonschema, functools32 16:53:13 INFO - Running setup.py install for functools32 16:53:14 INFO - warning: no files found matching '*.txt' 16:53:14 INFO - no previously-included directories found matching 'build' 16:53:14 INFO - no previously-included directories found matching 'dist' 16:53:14 INFO - no previously-included directories found matching '.git*' 16:53:14 INFO - Successfully installed jsonschema functools32 16:53:14 INFO - Cleaning up... 16:53:14 INFO - Return code: 0 16:53:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:14 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:14 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:53:14 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 functools32==3.2.3-2 16:53:14 INFO - Using env: {'DISPLAY': ':0', 16:53:14 INFO - 'HOME': '/home/cltbld', 16:53:14 INFO - 'LANG': 'en_US.UTF-8', 16:53:14 INFO - 'LANGUAGE': 'en_US:en', 16:53:14 INFO - 'LOGNAME': 'cltbld', 16:53:14 INFO - 'MAIL': '/var/mail/cltbld', 16:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:14 INFO - 'MOZ_NO_REMOTE': '1', 16:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:14 INFO - 'NO_EM_RESTART': '1', 16:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:14 INFO - 'PWD': '/builds/slave/test', 16:53:14 INFO - 'SHELL': '/bin/bash', 16:53:14 INFO - 'SHLVL': '1', 16:53:14 INFO - 'TERM': 'linux', 16:53:14 INFO - 'TMOUT': '86400', 16:53:14 INFO - 'USER': 'cltbld', 16:53:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:14 INFO - '_': '/tools/buildbot/bin/python'} 16:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:53:14 INFO - Cleaning up... 16:53:14 INFO - Return code: 0 16:53:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:14 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:14 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 16:53:14 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 16:53:14 INFO - Using env: {'DISPLAY': ':0', 16:53:14 INFO - 'HOME': '/home/cltbld', 16:53:14 INFO - 'LANG': 'en_US.UTF-8', 16:53:14 INFO - 'LANGUAGE': 'en_US:en', 16:53:14 INFO - 'LOGNAME': 'cltbld', 16:53:14 INFO - 'MAIL': '/var/mail/cltbld', 16:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:14 INFO - 'MOZ_NO_REMOTE': '1', 16:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:14 INFO - 'NO_EM_RESTART': '1', 16:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:14 INFO - 'PWD': '/builds/slave/test', 16:53:14 INFO - 'SHELL': '/bin/bash', 16:53:14 INFO - 'SHLVL': '1', 16:53:14 INFO - 'TERM': 'linux', 16:53:14 INFO - 'TMOUT': '86400', 16:53:14 INFO - 'USER': 'cltbld', 16:53:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:14 INFO - '_': '/tools/buildbot/bin/python'} 16:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:17 INFO - Downloading docopt-0.6.1.tar.gz 16:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:17 INFO - Running setup.py install for blobuploader 16:53:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:17 INFO - Running setup.py install for requests 16:53:17 INFO - Running setup.py install for docopt 16:53:17 INFO - Successfully installed blobuploader requests docopt 16:53:17 INFO - Cleaning up... 16:53:17 INFO - Return code: 0 16:53:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:17 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:17 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 16:53:17 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 16:53:17 INFO - Using env: {'DISPLAY': ':0', 16:53:17 INFO - 'HOME': '/home/cltbld', 16:53:17 INFO - 'LANG': 'en_US.UTF-8', 16:53:17 INFO - 'LANGUAGE': 'en_US:en', 16:53:17 INFO - 'LOGNAME': 'cltbld', 16:53:17 INFO - 'MAIL': '/var/mail/cltbld', 16:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:17 INFO - 'MOZ_NO_REMOTE': '1', 16:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:17 INFO - 'NO_EM_RESTART': '1', 16:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:17 INFO - 'PWD': '/builds/slave/test', 16:53:17 INFO - 'SHELL': '/bin/bash', 16:53:17 INFO - 'SHLVL': '1', 16:53:17 INFO - 'TERM': 'linux', 16:53:17 INFO - 'TMOUT': '86400', 16:53:17 INFO - 'USER': 'cltbld', 16:53:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:17 INFO - '_': '/tools/buildbot/bin/python'} 16:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:18 INFO - Running setup.py (path:/tmp/pip-8Wugss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:18 INFO - Running setup.py (path:/tmp/pip-I05rpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:18 INFO - Running setup.py (path:/tmp/pip-LK041A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:18 INFO - Running setup.py (path:/tmp/pip-v5JDhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:18 INFO - Running setup.py (path:/tmp/pip-Famd2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:18 INFO - Running setup.py (path:/tmp/pip-9GYFo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:18 INFO - Running setup.py (path:/tmp/pip-UH5lQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:18 INFO - Running setup.py (path:/tmp/pip-OBiCcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:18 INFO - Running setup.py (path:/tmp/pip-6Nr2Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:18 INFO - Running setup.py (path:/tmp/pip-vUufjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:18 INFO - Running setup.py (path:/tmp/pip-QQNcSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:18 INFO - Running setup.py (path:/tmp/pip-KZ8UrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:18 INFO - Running setup.py (path:/tmp/pip-ckokIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:18 INFO - Running setup.py (path:/tmp/pip-bzc7sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:19 INFO - Running setup.py (path:/tmp/pip-e7_umQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:19 INFO - Running setup.py (path:/tmp/pip-tMKu0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:19 INFO - Running setup.py (path:/tmp/pip-nzRntV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:19 INFO - Running setup.py install for manifestparser 16:53:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:19 INFO - Running setup.py install for mozcrash 16:53:19 INFO - Running setup.py install for mozdebug 16:53:19 INFO - Running setup.py install for mozdevice 16:53:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:19 INFO - Running setup.py install for mozfile 16:53:19 INFO - Running setup.py install for mozhttpd 16:53:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:19 INFO - Running setup.py install for mozinfo 16:53:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:19 INFO - Running setup.py install for mozInstall 16:53:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Running setup.py install for mozleak 16:53:20 INFO - Running setup.py install for mozlog 16:53:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Running setup.py install for moznetwork 16:53:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Running setup.py install for mozprocess 16:53:20 INFO - Running setup.py install for mozprofile 16:53:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Running setup.py install for mozrunner 16:53:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Running setup.py install for mozscreenshot 16:53:20 INFO - Running setup.py install for moztest 16:53:20 INFO - Running setup.py install for mozversion 16:53:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:20 INFO - Cleaning up... 16:53:21 INFO - Return code: 0 16:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:21 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:21 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 16:53:21 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 16:53:21 INFO - Using env: {'DISPLAY': ':0', 16:53:21 INFO - 'HOME': '/home/cltbld', 16:53:21 INFO - 'LANG': 'en_US.UTF-8', 16:53:21 INFO - 'LANGUAGE': 'en_US:en', 16:53:21 INFO - 'LOGNAME': 'cltbld', 16:53:21 INFO - 'MAIL': '/var/mail/cltbld', 16:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:21 INFO - 'MOZ_NO_REMOTE': '1', 16:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:21 INFO - 'NO_EM_RESTART': '1', 16:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:21 INFO - 'PWD': '/builds/slave/test', 16:53:21 INFO - 'SHELL': '/bin/bash', 16:53:21 INFO - 'SHLVL': '1', 16:53:21 INFO - 'TERM': 'linux', 16:53:21 INFO - 'TMOUT': '86400', 16:53:21 INFO - 'USER': 'cltbld', 16:53:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:21 INFO - '_': '/tools/buildbot/bin/python'} 16:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:21 INFO - Running setup.py (path:/tmp/pip-BDHeVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:21 INFO - Running setup.py (path:/tmp/pip-MyjLVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:21 INFO - Running setup.py (path:/tmp/pip-Roqbx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:21 INFO - Running setup.py (path:/tmp/pip-AOOk89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:21 INFO - Running setup.py (path:/tmp/pip-7RnuKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:21 INFO - Running setup.py (path:/tmp/pip-fSkQYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:21 INFO - Running setup.py (path:/tmp/pip-wvahJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:21 INFO - Running setup.py (path:/tmp/pip-bZC2Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:21 INFO - Running setup.py (path:/tmp/pip-XKhVLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:21 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:21 INFO - Running setup.py (path:/tmp/pip-AFyihb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 16:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:21 INFO - Running setup.py (path:/tmp/pip-onKbOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:22 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)) 16:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:22 INFO - Running setup.py (path:/tmp/pip-drwnNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:22 INFO - Running setup.py (path:/tmp/pip-zslbEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:22 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)) 16:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:22 INFO - Running setup.py (path:/tmp/pip-gOQKUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:22 INFO - Running setup.py (path:/tmp/pip-jrEMzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:22 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)) 16:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:22 INFO - Running setup.py (path:/tmp/pip-g5T2HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:22 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)) 16:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:22 INFO - Running setup.py (path:/tmp/pip-dQoN2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:22 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)) 16:53:22 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)) 16:53:22 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)) 16:53:22 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)) 16:53:22 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)) 16:53:22 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)) 16:53:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:22 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 16:53:22 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 16:53:22 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 16:53:22 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 16:53:22 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 16:53:22 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 16:53:24 INFO - Downloading blessings-1.6.tar.gz 16:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:24 INFO - Installing collected packages: blessings 16:53:24 INFO - Running setup.py install for blessings 16:53:24 INFO - Successfully installed blessings 16:53:24 INFO - Cleaning up... 16:53:24 INFO - Return code: 0 16:53:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:24 INFO - Reading from file tmpfile_stdout 16:53:24 INFO - Current package versions: 16:53:24 INFO - argparse == 1.2.1 16:53:24 INFO - blessings == 1.6 16:53:24 INFO - blobuploader == 1.2.4 16:53:24 INFO - docopt == 0.6.1 16:53:24 INFO - functools32 == 3.2.3-2 16:53:24 INFO - jsonschema == 2.5.1 16:53:24 INFO - manifestparser == 1.1 16:53:24 INFO - mozInstall == 1.12 16:53:24 INFO - mozcrash == 0.17 16:53:24 INFO - mozdebug == 0.1 16:53:24 INFO - mozdevice == 0.48 16:53:24 INFO - mozfile == 1.2 16:53:24 INFO - mozhttpd == 0.7 16:53:24 INFO - mozinfo == 0.9 16:53:24 INFO - mozleak == 0.1 16:53:24 INFO - mozlog == 3.3 16:53:24 INFO - moznetwork == 0.27 16:53:24 INFO - mozprocess == 0.23 16:53:24 INFO - mozprofile == 0.28 16:53:24 INFO - mozrunner == 6.12 16:53:24 INFO - mozscreenshot == 0.1 16:53:24 INFO - mozsystemmonitor == 0.3 16:53:24 INFO - moztest == 0.7 16:53:24 INFO - mozversion == 1.4 16:53:24 INFO - psutil == 3.1.1 16:53:24 INFO - requests == 1.2.3 16:53:24 INFO - wsgiref == 0.1.2 16:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:24 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')]} 16:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:24 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')]} 16:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:24 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:24 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 16:53:24 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 16:53:24 INFO - Using env: {'DISPLAY': ':0', 16:53:24 INFO - 'HOME': '/home/cltbld', 16:53:24 INFO - 'LANG': 'en_US.UTF-8', 16:53:24 INFO - 'LANGUAGE': 'en_US:en', 16:53:24 INFO - 'LOGNAME': 'cltbld', 16:53:24 INFO - 'MAIL': '/var/mail/cltbld', 16:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:24 INFO - 'MOZ_NO_REMOTE': '1', 16:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:24 INFO - 'NO_EM_RESTART': '1', 16:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:24 INFO - 'PWD': '/builds/slave/test', 16:53:24 INFO - 'SHELL': '/bin/bash', 16:53:24 INFO - 'SHLVL': '1', 16:53:24 INFO - 'TERM': 'linux', 16:53:24 INFO - 'TMOUT': '86400', 16:53:24 INFO - 'USER': 'cltbld', 16:53:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:24 INFO - '_': '/tools/buildbot/bin/python'} 16:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 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)) 16:53:25 INFO - Cleaning up... 16:53:25 INFO - Return code: 0 16:53:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:25 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 0xd1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', '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 16:53:25 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 16:53:25 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 16:53:25 INFO - Using env: {'DISPLAY': ':0', 16:53:25 INFO - 'HOME': '/home/cltbld', 16:53:25 INFO - 'LANG': 'en_US.UTF-8', 16:53:25 INFO - 'LANGUAGE': 'en_US:en', 16:53:25 INFO - 'LOGNAME': 'cltbld', 16:53:25 INFO - 'MAIL': '/var/mail/cltbld', 16:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:25 INFO - 'MOZ_NO_REMOTE': '1', 16:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:25 INFO - 'NO_EM_RESTART': '1', 16:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:25 INFO - 'PWD': '/builds/slave/test', 16:53:25 INFO - 'SHELL': '/bin/bash', 16:53:25 INFO - 'SHLVL': '1', 16:53:25 INFO - 'TERM': 'linux', 16:53:25 INFO - 'TMOUT': '86400', 16:53:25 INFO - 'USER': 'cltbld', 16:53:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:25 INFO - '_': '/tools/buildbot/bin/python'} 16:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:53:25 INFO - Cleaning up... 16:53:25 INFO - Return code: 0 16:53:25 INFO - Running post-action listener: _resource_record_post_action 16:53:25 INFO - Running post-action listener: _start_resource_monitoring 16:53:25 INFO - Starting resource monitoring. 16:53:25 INFO - [mozharness: 2016-08-01 23:53:25.368618Z] Finished create-virtualenv step (success) 16:53:25 INFO - [mozharness: 2016-08-01 23:53:25.369056Z] Running install step. 16:53:25 INFO - Running pre-action listener: _resource_record_pre_action 16:53:25 INFO - Running main action method: install 16:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:25 INFO - Reading from file tmpfile_stdout 16:53:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:25 INFO - Reading from file tmpfile_stdout 16:53:25 INFO - Output received: 16:53:25 INFO - Usage: mozinstall [options] installer 16:53:25 INFO - Options: 16:53:25 INFO - -h, --help show this help message and exit 16:53:25 INFO - -d DEST, --destination=DEST 16:53:25 INFO - Directory to install application into. [default: 16:53:25 INFO - "/builds/slave/test"] 16:53:25 INFO - --app=APP Application being installed. [default: firefox] 16:53:25 INFO - mkdir: /builds/slave/test/build/application 16:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:53:41 INFO - Reading from file tmpfile_stdout 16:53:41 INFO - Output received: 16:53:41 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:41 INFO - Running post-action listener: _resource_record_post_action 16:53:41 INFO - [mozharness: 2016-08-01 23:53:41.639343Z] Finished install step (success) 16:53:41 INFO - [mozharness: 2016-08-01 23:53:41.639621Z] Running run-tests step. 16:53:41 INFO - Running pre-action listener: _resource_record_pre_action 16:53:41 INFO - Running main action method: run_tests 16:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:41 INFO - Python 2.7.3 16:53:41 INFO - Return code: 0 16:53:41 INFO - grabbing minidump binary from tooltool 16:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb3b0>, '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 0xfdc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:53:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:53:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:53:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:41 INFO - Return code: 0 16:53:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 16:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 16:53:41 INFO - Using env: {'DISPLAY': ':0', 16:53:41 INFO - 'HOME': '/home/cltbld', 16:53:41 INFO - 'LANG': 'en_US.UTF-8', 16:53:41 INFO - 'LANGUAGE': 'en_US:en', 16:53:41 INFO - 'LOGNAME': 'cltbld', 16:53:41 INFO - 'MAIL': '/var/mail/cltbld', 16:53:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:41 INFO - 'MOZ_NO_REMOTE': '1', 16:53:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:41 INFO - 'NO_EM_RESTART': '1', 16:53:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:41 INFO - 'PWD': '/builds/slave/test', 16:53:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:41 INFO - 'SHELL': '/bin/bash', 16:53:41 INFO - 'SHLVL': '1', 16:53:41 INFO - 'TERM': 'linux', 16:53:41 INFO - 'TMOUT': '86400', 16:53:41 INFO - 'USER': 'cltbld', 16:53:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725', 16:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:41 INFO - '_': '/tools/buildbot/bin/python'} 16:53:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 16:53:41 INFO - mozversion application_buildid: 20160801141652 16:53:41 INFO - mozversion application_changeset: 548a789b4f12769eb61c9daf826c49fe255ec2a1 16:53:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:53:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:41 INFO - mozversion application_name: Firefox 16:53:41 INFO - mozversion application_remotingname: firefox-dev 16:53:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:53:41 INFO - mozversion application_vendor: Mozilla 16:53:41 INFO - mozversion application_version: 50.0a2 16:53:41 INFO - mozversion platform_buildid: 20160801141652 16:53:41 INFO - mozversion platform_changeset: 548a789b4f12769eb61c9daf826c49fe255ec2a1 16:53:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:53:41 INFO - mozversion platform_version: 50.0a2 16:53:41 INFO - using testdate: 1470095621 16:53:41 INFO - actual date: 1470095621 16:53:41 INFO - starting webserver on 'localhost:44597' 16:53:41 INFO - SUITE-START | Running 2 tests 16:53:41 INFO - TEST-START | dromaeo_css 16:53:41 INFO - operating with platform_type : linux_ 16:53:41 INFO - Initialising browser for dromaeo_css test... 16:53:41 INFO - TEST-INFO | started process 19455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdaI2Zy/profile http://localhost:44597/getInfo.html) 16:53:45 INFO - PROCESS | 19455 | __metrics Screen width/height:1600/1200 16:53:45 INFO - PROCESS | 19455 | colorDepth:24 16:53:45 INFO - PROCESS | 19455 | Browser inner width/height: 1024/697 16:53:45 INFO - PROCESS | 19455 | __metrics 16:53:46 INFO - PROCESS | 19455 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:53:46 INFO - PROCESS | 19455 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:53:47 INFO - TEST-INFO | 19455: exit 0 16:53:47 INFO - Browser initialized. 16:53:47 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:47 INFO - TEST-INFO | started process 19545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdaI2Zy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:59 INFO - PROCESS | 19545 | RSS: Main: 145211392 16:53:59 INFO - PROCESS | 19545 | 16:54:50 INFO - PROCESS | 19545 | 1470095690546 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] 16:56:59 INFO - PROCESS | 19545 | Cycle 1(1): loaded http://localhost:44597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44597/tests/dromaeo/cssquery-ext.html) 16:57:01 INFO - PROCESS | 19545 | RSS: Main: 278339584 16:57:01 INFO - PROCESS | 19545 | 17:00:03 INFO - PROCESS | 19545 | Cycle 1(1): loaded http://localhost:44597/tests/dromaeo/cssquery-ext.html (next: http://localhost:44597/tests/dromaeo/cssquery-jquery.html) 17:00:04 INFO - PROCESS | 19545 | RSS: Main: 233095168 17:00:04 INFO - PROCESS | 19545 | 17:03:05 INFO - PROCESS | 19545 | Cycle 1(1): loaded http://localhost:44597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44597/tests/dromaeo/cssquery-mootools.html) 17:03:06 INFO - PROCESS | 19545 | RSS: Main: 208416768 17:03:06 INFO - PROCESS | 19545 | 17:06:08 INFO - PROCESS | 19545 | Cycle 1(1): loaded http://localhost:44597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44597/tests/dromaeo/cssquery-prototype.html) 17:06:09 INFO - PROCESS | 19545 | RSS: Main: 173850624 17:06:09 INFO - PROCESS | 19545 | 17:09:11 INFO - PROCESS | 19545 | Cycle 1(1): loaded http://localhost:44597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44597/tests/dromaeo/cssquery-yui.html) 17:09:12 INFO - PROCESS | 19545 | RSS: Main: 175984640 17:09:12 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | Cycle 1(1): loaded http://localhost:44597/tests/dromaeo/cssquery-yui.html (next: http://localhost:44597/tests/dromaeo/cssquery-dojo.html) 17:12:15 INFO - PROCESS | 19545 | RSS: Main: 264663040 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | __start_tp_report 17:12:15 INFO - PROCESS | 19545 | _x_x_mozilla_page_load 17:12:15 INFO - PROCESS | 19545 | _x_x_mozilla_page_load_details 17:12:15 INFO - PROCESS | 19545 | |i|pagename|runs| 17:12:15 INFO - PROCESS | 19545 | |0;dojo.html;3310.056633859349;3319.850606722697;3340.098173493156;3362.89911302661;3370.3764803511353;5723.799667011655;5833.941660583393;5851;5857.56068294878;5864.296284445867;5776.740046697898;5838.562107841918;5858.326292476367;5875.676837773921;5877.8824423511505;5128.71792051437;5188.740562971855;5286.762095705692;5307.867303317409;5416.864578385552;5269;5325.600579956499;5338.412774594792;5338.733063346836;5339.199120131972;5176.482351764831;5212.035773381917;5225.817096401626;5242.397124330693;5286.154215325549;5323.9467605324035;5346.732663366855;5350.30446042012;5353;5355.062863998784;5093.388793344785;5148.639595228336;5214.087534681454;5244.108501554745;5249.711265880375;5576.302962129734;5643.633163844337;5679.233303504016;5679.914801277984;5708.086706127;6191.938080619181;6192.8761424771255;6196;6198.597091189104;6200.162977997958;5937.435943585396;6099.786507472217;6111.052786818051;6111.419415155553;6225.688715564203;5762.567807414461;5762.769489220426;5789.623674461189;5794.333651630117;5808.88382232353;6281.089242059876;6301.117843501914;6318.241810982619;6320.083587879823;6329.493640508748;5882.911756323659;5955;5959.612625179349;5993.970030149909;6104.7485265521345;6215.378462153749;6217.440430361289;6220.191375121205;6221.626702397871;6225.750969961241;6124.173236613089;6159.784407545714;6166.290876549254;6169.01295792671;6183.288921773964;6017.669028203403;6060;6106.572539922163;6110.315755984981;6123.00810456741;4717.363155973968;4755.310479980383;4756.9286460703115;4781.258904869751;4797.688150270221;4220.282551966173;4232.830686772556;4235.576442355739;4243.936340954888;4259.998900258437;5702.429757024347;5804.187413762077;5859;5862.355140934494;5943.31651860033;6243.875122497525;6258.780942666985;6262.279837818618;6265.530085243625;6268.843278918063;5867.6772777497645;5878.882422351615;5881.705914704247;5883.61756485827;5933.3473317934995;5151.948480515147;5209.869753256123;5284.7886084556185;5286.392064912584;5349.117395629755;6336.904946425715;6373.1714877066615;6391.744330226739;6392.4566411854585;6409.519286053472;6191.133241346125;6205.875882482415;6207.720652570735;6213.1922850029205;6216.44052035319;6181.258249010148;6280.5289603279025;6317.020861766434;6330.240371155491;6409.35906409374;6148.9692551536955;6150.7539698411565;6154.630722156685;6160.876782464416;6161.476274516716;6185.195924529782;6205.441510264098;6246.219222597176;6266.780662676784;6278.183836101461;5933.762649493972;5982.341942386421;6000.279966404059;6012.248468941382;6022.397760223943;5935.99088155006;5979.043353063489;5996.730147143477;5997.3402925677265;6009.338972712911;5942.732577033958;5952.464278214981;5956.344802071682;5978.252718410199;6023.5181185505935;5929.555283353679;6040.879182416239;6062.42406971337;6111.938880611137;6123.84690382744;5972.13404056418;5972.701364931823;5977.820665380045;5980.551458640706;6011.458968692664 17:12:15 INFO - PROCESS | 19545 | |1;ext.html;596.0909612840418;631.9888178913739;648.3872740260456;658.8814013477572;659.172738213542;34577;38481.61518384815;50929.23606145906;52442;52483.47516524834;49591;49965.75017124919;50013.24980125292;50047.498575042715;50235.24647130287;9315.906840931588;9472.763180920498;9482.146606805387;9482.762930926747;9489.71530854072;8629.784255393633;11021.614243501479;11235.269707468988;11275;11749.236299640539;11534.192606517547;11643.301401915869;11643.883561164364;11643.941780291087;11656.883431165706;11421.086313094975;11504.194706370557;11506;11508.539658413696;11509.539618415254;11274.323540587591;11362.091032717362;11367.658970230907;11370.260933039326;11371.260868043551;46892.2966155508;47152.29271560929;47284.763576182246;47421.288680669815;47553.286700699515;3854.258381725902;3887.2225554889137;4024.014116541437;4062.857799976987;4544;33275.88704561243;35988.280234395424;36260.27479450396;36337.27325453476;36887.26225475476;4747.667663263573;4841.346418233528;4859.927101093486;4899.975500122477;4932.112219800434;382927;383855.0807245974;384333;386185;386810;65233.673831630535;65783;65796;65802.67098664476;65804;36201;36890.44664330037;37009;37044.259114817556;37079.25841483155;19374.70937935932;19590.608187836162;19593.510162246057;19597.412077637695;19603.901980490005;11960.581379651845;14589.708205836036;15113.09321440717;15229.771553426708;15232.923835380752;20432;21226.36320910375;21289.254876079263;21361.89319053395;21527.78472215289;7729.149793522708;7855.489393189425;7908.604569771488;7932.603369831485;8000.799980000546;1093.283899046126;1097.7749561339906;1104.089126470665;1184.4373922386796;1198.7302856857311;35262.06331113646;35486.290274194886;35893.936148485904;36251.01238863723;36283.27433451369;1180.816973369129;1202.3086725133082;1237.8638349781518;1239.4856134703996;1249.9687507812378;18932.43202703921;18933.242670293308;18981.81018189828;19029;19198.13608387626;642114;646495;647714;648014;649845;65339.34660653428;66105.6694716533;66133;66136;66149.66925165344;1378.676011137382;1423.849986520341;1480.1193289992436;1496.6632507685902;1508.1554329575254;34349.31301374009;36921.261574767814;37165.814170930054;37413.625863742105;37988;55673;55748.163777542555;55940.44059559352;56301.436985631255;56351.30946071624;449024;451279;451466;452732;523433;45230;48681;49479;49539.752301238266;49743.25385119153;52801;53875.73062134664;54244.18633720576;54540.18189727078;55130.72434637801;45543.77228113971;47808.760956194994;47930.281045783646;48049.75975120102;49727.502724972284;45777.313340300585;47256.7637161812;47719.28421073617;47939.92510636635;48684.26973595328;46791.29813052875;46912.53087469082;47691.523084768705;48028;48279.75860120677;38261;40941;41329.380059298535;41396.79301603593;42042;31082.378352433276;31118.56019793331;31319;31466.213344666565;31784.841075794473 17:12:15 INFO - PROCESS | 19545 | |2;jquery.html;404.280380921959;410.8993296642323;428.80489377333305;433.5252898076606;438.67318847458625;16292;19822;20137.39587812366;20536.589268214626;20709.585808283824;19637.901810490963;19804.70292945607;19860.106295216712;19890.40328790135;20095.397138085846;5626.718664066801;5804.390538993398;5827.1550625159325;5888.205092312547;5899.085641725518;6001.399860013986;6022.638641681491;6028.547858910577;6173.228346456693;6384.170057892491;6500.9674951625175;6609.140811694473;6725.697343619524;6733.797986060402;6748.223954245275;6182.536309776762;6217.3471785462325;6234.376562343775;6234.4077312655;6518.543701940866;5864.824055278348;5870.941290587082;5914.053751399755;5994.7901823436405;6001.4298641628975;23197.652035219486;23244.535109297718;23875.88062059696;24015.519689606284;24196.637050444257;2353.646952957053;2355.246321177207;2762.5165596020615;2977.776666749981;3128.9061328159964;12330.383480825923;14163.079399838978;14310.069845460011;14390.712185756227;15084.321205545668;1913.2729562766199;2031.4210450021674;2048.528838367169;2083.9687404688943;2117.2907076129513;58951;76263.23736762616;76298;87031.56484217601;87333.99999999936;11278.15413843965;11514.194006419637;11668.241564298463;11693.298402095732;11911.880881191077;16787.412440564767;16810.327586896386;16818.831811681728;16822.747658785127;16839.158042097846;10285.43430111336;10469.267151299488;10766.78466430667;10812.5134368952;10889.891101089046;8808.867866982;8988.910110898938;9040.502772347583;9299.76750581241;9468.573914173741;8953.238974687094;9069.909300907038;9200.539973001323;9336.906630933603;9470.337076404723;3332.5667663204113;3490.4571859562566;3513.683768460851;3576.1774791798034;3617;931.1945167430124;975.4586204656483;1004.1013293102632;1017.3946501831399;1023.9334443261164;20374;20908;21077.578448431253;21161.576768464853;21306.36080917575;1030.1861529391847;1050.9054185123375;1065.9893401066045;1085.4409978860892;1117.7149826794277;10544.472776361152;11622.593209237637;11688.47401866918;11722;11794.76410471803;559151;588353;601745;603896;604555;85063.5746821262;93006;100082;100733.49633251787;102072.48963755133;1029.1920842138884;1037.4138611684375;1045.7751583409452;1095.0308976555805;1098.9175811814146;17686.380976665754;18026.549336266697;18103;18176;18667.066646667885;45664.54335456603;46167.307490387;47216.527834721215;47530.52469475261;48026;63401;64823.67588162029;65400.34599654133;65606;66408;8893.4663920165;9084.364094513321;9148;9171.954140229256;9180.403273787182;11820.172587918763;12635.93682031584;13994.510192143227;14011.159330440207;14286.142831430148;11619.070474361863;12028.255902894207;12047.33739644328;12111.515539378326;12148.149629526202;12163.391830408267;12184.086193535342;12253;12426.875731242571;12739.235645861278;11476.770464590829;11938;12019.519219231483;12035.458404371999;12282.263064216175;8789.648414063366;8895.866562001705;8905.955470222607;9224.07759224099;9251.629934802802;9090.681826136053;11408.543658253577;11816.586419475278;12134.33261170644;12137.21108127969 17:12:15 INFO - PROCESS | 19545 | |3;mootools.html;1428.4928850258163;1560.1341255603143;1616.9029858208507;1806.1059775411165;1936.4577918182904;8546.102659220778;9529.380590261628;9858.704238872828;9873.407595544273;10232.33489823161;10032.949835250833;10052.497375131232;10094.848577271347;10120.595176192963;10124.493775311243;2536.5561026820324;2543.707473640527;2558.692956845181;2563.7564431379083;2566.217303722364;2521.558727222738;2569.100814714844;2569.9486010279784;2570.7686308232255;2571.395722005327;2497.1759319424636;2508.285138735461;2537.1500547316673;2545.083769842855;2546.9490610187786;2425.8787060646987;2429.416939934412;2430.040134147011;2477.2444404456633;2478.5538603051623;2360.704911886014;2412.975870241293;2419.2742177346727;2421.055788242587;2457.5699252630898;9762.609495620167;10053.04496072872;10102.898971010269;10172.949135254275;10178.389296642225;5854.297484301911;6120.877582448326;6129.601575897597;6129.938700612981;6134.294556126058;3579.1052236940764;3680.9079773005888;3682.723795715332;3745.419459983707;3758.586555478895;1178.7524619829846;1185.0874826383722;1187.7921363761393;1199.0407673860964;1223.9143259971806;14548.272586370638;14668.633284167874;14694.55916322512;14708.926455367762;14709;4896;5025.422076461181;5073.898522029539;5128.9230661540105;5147.6911385317;11175.83236251457;11210.607628733118;11210.66368008961;11211.439428028565;11217.831732524019;5835.037218858841;5839.124131380327;5840.649561026352;5843.152742852262;5852.180694702745;4861.124997500413;4904.190808516555;5430.266913966564;5441.238226648273;5464.12573988168;4256.446661933929;4299.269124248885;4338.7830608470085;4354.912901741947;4368.36658684489;1246.214884622682;1261.8359613250218;1262.551794113095;1263.7346157306886;1272.580048583965;961.3318743473219;991.3605724307781;1098.5715570927346;1105.6461932181624;1114.5820317380983;6486.4486518646445;6908.9309106909295;6928.44572434204;6944;7069.08101946754;486.47217768721333;487.63671065056053;490.5952589113995;490.9018196360742;502.43977964569973;4713.95286047142;4718.245080787057;4770.284457331428;4777.450593181759;4800.135975524369;12463.813042804366;12642.2414655121;12855.678608034874;12952.481900724055;13004.089713720137;12723.491060357666;12842.101052926393;12938.676533086747;12959.416826242841;12960;9106.86339704905;9575.23398128148;9608.135267826068;9615.182709469633;9615.182709469773;6773.62745049027;6787.219469760843;6854.760083397057;6943.548669336477;7010.964945175241;11603.6518904433;11628.127890408085;11733.471993760131;11805.114616403633;11837.644870653894;10255.897441025494;10514.316569422963;11777.175597708077;11921.46353414081;12089.57686480969;8144.59277036134;8518.446300990416;8519.148085191431;8524.488530688179;8830.293576513992;10072.093511583993;10116.747081323027;10161.593536258466;10164.288499804943;10175;8427.95786021066;8575.785605359666;8640.438371506083;8641.481511109354;8821.691240806542;8497.447665901696;8503.74488765338;8583.785405364915;8679.088695686862;8880.333974952033;7967;8011.479253848481;8100.71647492335;8108.6756529740505;8134.633941472766;5715.914261286167;5853.765849365977;5879.382664820132;5889.293284805679;5917.260342457193;5727;5752.194692742935;5775.393583673654;5840.561957853263;5845.18167456565 17:12:15 INFO - PROCESS | 19545 | |4;prototype.html;354.2189472213769;359.83987125729055;364.9726270529711;365.6617628693458;365.81160702238367;5551.417101204371;5567.721613919298;5599.468050535198;5617.848341090077;5623.718814059301;5469.72651367432;5469.972650136754;5488.69812160332;5556.9444305556935;5559.360673522546;4164.251014573879;4336.761478118702;4343.522212556616;4385.386045953554;4412.1175764847;4313.956860431387;4330.198913201052;4355.956440435602;4376.97811510942;4379.4525684289465;4332.220200363933;4349.064951035527;4358;4364.214441400547;4367.279398899178;4178.331466965271;4310.892227694333;4340.435743353344;4356.368326592658;4360.454943132108;3838.2899163654815;3848.5189351331082;3858.614138586147;3860.3823388257742;3866.574676785551;5362.892742145174;5379.81644038311;5389.948959952811;5390.56875449967;5454.61817672763;4896.216605343128;4897.681650692693;4975.502449755032;4990.87522811929;5011.223260394645;5715.342735585419;5740.4833564978935;5745.798897038583;5751.3961034091235;5751.683657398841;4199.727017743837;4209.621134097946;4214.136102099063;4221.219074471202;4260.744355338658;5653.992832544429;5828.941710582924;5850.180974663551;6025.397460253984;6042.637441753465;4144.7513149211145;4170.9582904171175;4178.979105104516;4179.185058913544;4302.397664326997;4342.827436592165;4361.476622805284;4369.126174764996;4378.5183629800695;4386.539413361615;4815.759212039454;4923.95240047623;4948.975255123702;4965.577925876341;4966.503349665077;5733.512651424676;5750.367459579443;5760.3951585083805;5765.913511297334;5776.884462310731;1477.5567329801017;1502.894797364196;1504.9924750376397;1507.8944473886722;1508.3589474473524;928.9860652090224;972.0959507657946;974.815599047147;976.1214906583989;989.2629990657007;4877.536634019833;4907.460179380265;4915.16442204826;4927.531884470969;4989.351384320015;5213.191955246943;5224.60815438836;5228.869278268074;5245.190409308782;5265.736713164327;5025.321581586439;5030.673006254582;5057.31726216956;5288.2596436498925;5675.886482270332;3139.5290706393766;3164.810111393324;3167.9250091190306;3172.857221425041;3199.0242975892575;6083.452489275986;6130.754769809158;6185.979313413326;6186.257649082139;6193.783217587363;6098.603590766586;6105.32841387447;6112.135798581476;6116.480099191618;6120.449159575571;6188.845278868064;6192.628442293477;6195.907061394083;6211.627302361782;6241.781537646251;5873.970630146822;5937.34689184198;5978.9402105980125;5981.371955944737;6064.181335519825;5880.882382352243;5907.438793314628;5909.645421274738;5922.437368449991;5971.552133589911;5827.766889324549;5893.616914900518;6058.787942421994;6091.664958427152;6141.977005061692;4298.517011630982;4299.849505267301;4308.784560771886;4310.728335141203;4324.459442569679;5747.252857128547;5946.167536544801;5995.640261584319;6009.399060093956;6027.21646185993;5741.770329186786;5743.62666426681;5771.2686194142425;5784.681842498703;5794.913076303943;5757.466714645542;5759.65442073477;5769.105788602773;5784.2769653793275;5790.160426738184;5424.647397919122;5744.971275143597;5764.625299355528;5786.739596718074;5811.215485909517;5798.391168927371;5831.329397119385;5851.824445266649;5894.911576326273;5895.734691938959;5527.778888844401;5714.628549144292;5720.513756330592;5744.396838331915;5748.39641837601 17:12:15 INFO - PROCESS | 19545 | |5;yui.html;803.0644299391209;818.5620692929284;832.4048305461594;891.2558014058261;930.7626555228416;15557.455489057886;17278.2224799884;17423.82576174238;17431.564210894703;17445.21496532656;15864.682706345895;15968.201589920487;16034.919825400886;16036.43872464464;17009.744853827204;764.5641984069083;876.2376732242958;898.3307435960219;898.5866501409326;905.8414777413959;907.4101833808012;909.222614664459;911.7994041310934;915.5193523400235;916.9541522923861;955.1880901233931;955.7132860141965;959.3572306554626;960.0975083421562;960.8462645976645;781.0432220529834;926.4302453990781;942.2885721280458;947.8199142162968;952.0764858087643;701.8596280743872;702.6135625406057;703.9507234493587;704.1163340008308;704.3977399323607;16557.25492352835;16743.246553905105;16747.83252167487;16783.32866685331;16785.664286714196;14771.77842332355;14845.406183752637;14970;15159.924200379039;15185.088894666356;13995.720085598332;14031.305419086324;14140.222287774168;14455.638609034859;14474.348654310581;4570.314452832068;4581.221192397267;4627.329037289574;4648.031990745815;4762.119007983534;89156;90006.54996724974;90630.54684726534;91274;92023.99999999933;12046.457909394097;12087.637370878887;12111.939440302742;12129.939350303192;12465.626031219077;22916.19793307226;22963.311100667008;22964.770352296597;22976.770232297462;22982.080716771477;9036.277097832157;9044.547772611342;9052.818943621223;9089.181973622406;9376.296777741696;4965.627577931597;5080.898382032413;5112.693238405707;5157.071727089085;5231.712255825966;3777.8299976501125;3892.6107389261415;3900.64894159527;3901;3902.3951287550476;711.7757906259511;714.3677845107014;719.6617589732817;720.6937051752984;738.7183237083656;683.9692213850388;775.6780935911646;781.6404453951246;804.6057431858347;814.767791179511;10498.685039448676;10700.197485188643;10866.07638350749;11023.17326200538;11181.496832642551;661.543534960885;709.2552819539463;747.3386053342831;815.1318845429598;820.7660816667221;4950.3069570260195;5162.457941916045;5322.627416080914;5324.92012619811;5338.626296159232;77693.61153194311;137156;138183.47266109445;140151;143587;119212;120103.39948300202;121807;123327;126291;102092;102315;104844;105801.94198058076;108973.45513272383;10058.647947321808;10396.532156052845;10436.321639093434;10471.109955653856;10506.684799456028;40613.39079913744;44898.551014489436;49440.50559494359;49913.29985258418;50553;79184.60407697925;80917.59541202257;81099.59450202712;83804;84044;13008.21950682962;13184.340782960622;13348.399322030726;13975.09161904473;14127.717445651235;13913.791293130409;16704.916475417544;16769.245383957506;16825.663486730442;17635.29458821633;11860.703482413008;14739.631509212355;15108.320125594595;15232.771508427604;15316.157611331484;14474.855251447772;14786.704265914837;15497.767533487233;15599.766003510184;15644;15257.771133432785;15553.68892622164;16132.596685082966;16263.186840658156;16379.344826206818;12178.208416452902;12373.62879113628;12389.504419823106;13097.934510327768;13151.73696526045;11369.658910232707;12708.364581771059;12856.357182141042;12916.095873289156;13302 17:12:15 INFO - PROCESS | 19545 | __end_tp_report 17:12:15 INFO - PROCESS | 19545 | __start_cc_report 17:12:15 INFO - PROCESS | 19545 | _x_x_mozilla_cycle_collect,1111 17:12:15 INFO - PROCESS | 19545 | __end_cc_report 17:12:15 INFO - PROCESS | 19545 | __startTimestamp1470096735531__endTimestamp 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | ------- Summary: start ------- 17:12:15 INFO - PROCESS | 19545 | Number of tests: 6 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | [#0] dojo.html Cycles:165 Average:5738.06 Median:5955.00 stddev:645.25 (10.8%) stddev-sans-first:618.48 17:12:15 INFO - PROCESS | 19545 | Values: 3310.1 3319.9 3340.1 3362.9 3370.4 5723.8 5833.9 5851.0 5857.6 5864.3 5776.7 5838.6 5858.3 5875.7 5877.9 5128.7 5188.7 5286.8 5307.9 5416.9 5269.0 5325.6 5338.4 5338.7 5339.2 5176.5 5212.0 5225.8 5242.4 5286.2 5323.9 5346.7 5350.3 5353.0 5355.1 5093.4 5148.6 5214.1 5244.1 5249.7 5576.3 5643.6 5679.2 5679.9 5708.1 6191.9 6192.9 6196.0 6198.6 6200.2 5937.4 6099.8 6111.1 6111.4 6225.7 5762.6 5762.8 5789.6 5794.3 5808.9 6281.1 6301.1 6318.2 6320.1 6329.5 5882.9 5955.0 5959.6 5994.0 6104.7 6215.4 6217.4 6220.2 6221.6 6225.8 6124.2 6159.8 6166.3 6169.0 6183.3 6017.7 6060.0 6106.6 6110.3 6123.0 4717.4 4755.3 4756.9 4781.3 4797.7 4220.3 4232.8 4235.6 4243.9 4260.0 5702.4 5804.2 5859.0 5862.4 5943.3 6243.9 6258.8 6262.3 6265.5 6268.8 5867.7 5878.9 5881.7 5883.6 5933.3 5151.9 5209.9 5284.8 5286.4 5349.1 6336.9 6373.2 6391.7 6392.5 6409.5 6191.1 6205.9 6207.7 6213.2 6216.4 6181.3 6280.5 6317.0 6330.2 6409.4 6149.0 6150.8 6154.6 6160.9 6161.5 6185.2 6205.4 6246.2 6266.8 6278.2 5933.8 5982.3 6000.3 6012.2 6022.4 5936.0 5979.0 5996.7 5997.3 6009.3 5942.7 5952.5 5956.3 5978.3 6023.5 5929.6 6040.9 6062.4 6111.9 6123.8 5972.1 5972.7 5977.8 5980.6 6011.5 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | [#1] ext.html Cycles:180 Average:67801.93 Median:22501.93 stddev:135719.05 (603.1%) stddev-sans-first:136005.97 17:12:15 INFO - PROCESS | 19545 | Values: 596.1 632.0 648.4 658.9 659.2 34577.0 38481.6 50929.2 52442.0 52483.5 49591.0 49965.8 50013.2 50047.5 50235.2 9315.9 9472.8 9482.1 9482.8 9489.7 8629.8 11021.6 11235.3 11275.0 11749.2 11534.2 11643.3 11643.9 11643.9 11656.9 11421.1 11504.2 11506.0 11508.5 11509.5 11274.3 11362.1 11367.7 11370.3 11371.3 46892.3 47152.3 47284.8 47421.3 47553.3 3854.3 3887.2 4024.0 4062.9 4544.0 33275.9 35988.3 36260.3 36337.3 36887.3 4747.7 4841.3 4859.9 4900.0 4932.1 382927.0 383855.1 384333.0 386185.0 386810.0 65233.7 65783.0 65796.0 65802.7 65804.0 36201.0 36890.4 37009.0 37044.3 37079.3 19374.7 19590.6 19593.5 19597.4 19603.9 11960.6 14589.7 15113.1 15229.8 15232.9 20432.0 21226.4 21289.3 21361.9 21527.8 7729.1 7855.5 7908.6 7932.6 8000.8 1093.3 1097.8 1104.1 1184.4 1198.7 35262.1 35486.3 35893.9 36251.0 36283.3 1180.8 1202.3 1237.9 1239.5 1250.0 18932.4 18933.2 18981.8 19029.0 19198.1 642114.0 646495.0 647714.0 648014.0 649845.0 65339.3 66105.7 66133.0 66136.0 66149.7 1378.7 1423.8 1480.1 1496.7 1508.2 34349.3 36921.3 37165.8 37413.6 37988.0 55673.0 55748.2 55940.4 56301.4 56351.3 449024.0 451279.0 451466.0 452732.0 523433.0 45230.0 48681.0 49479.0 49539.8 49743.3 52801.0 53875.7 54244.2 54540.2 55130.7 45543.8 47808.8 47930.3 48049.8 49727.5 45777.3 47256.8 47719.3 47939.9 48684.3 46791.3 46912.5 47691.5 48028.0 48279.8 38261.0 40941.0 41329.4 41396.8 42042.0 31082.4 31118.6 31319.0 31466.2 31784.8 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | [#2] jquery.html Cycles:180 Average:32881.26 Median:23221.09 stddev:97074.90 (418.0%) stddev-sans-first:97316.59 17:12:15 INFO - PROCESS | 19545 | Values: 404.3 410.9 428.8 433.5 438.7 16292.0 19822.0 20137.4 20536.6 20709.6 19637.9 19804.7 19860.1 19890.4 20095.4 5626.7 5804.4 5827.2 5888.2 5899.1 6001.4 6022.6 6028.5 6173.2 6384.2 6501.0 6609.1 6725.7 6733.8 6748.2 6182.5 6217.3 6234.4 6234.4 6518.5 5864.8 5870.9 5914.1 5994.8 6001.4 23197.7 23244.5 23875.9 24015.5 24196.6 2353.6 2355.2 2762.5 2977.8 3128.9 12330.4 14163.1 14310.1 14390.7 15084.3 1913.3 2031.4 2048.5 2084.0 2117.3 58951.0 76263.2 76298.0 87031.6 87334.0 11278.2 11514.2 11668.2 11693.3 11911.9 16787.4 16810.3 16818.8 16822.7 16839.2 10285.4 10469.3 10766.8 10812.5 10889.9 8808.9 8988.9 9040.5 9299.8 9468.6 8953.2 9069.9 9200.5 9336.9 9470.3 3332.6 3490.5 3513.7 3576.2 3617.0 931.2 975.5 1004.1 1017.4 1023.9 20374.0 20908.0 21077.6 21161.6 21306.4 1030.2 1050.9 1066.0 1085.4 1117.7 10544.5 11622.6 11688.5 11722.0 11794.8 559151.0 588353.0 601745.0 603896.0 604555.0 85063.6 93006.0 100082.0 100733.5 102072.5 1029.2 1037.4 1045.8 1095.0 1098.9 17686.4 18026.5 18103.0 18176.0 18667.1 45664.5 46167.3 47216.5 47530.5 48026.0 63401.0 64823.7 65400.3 65606.0 66408.0 8893.5 9084.4 9148.0 9172.0 9180.4 11820.2 12635.9 13994.5 14011.2 14286.1 11619.1 12028.3 12047.3 12111.5 12148.1 12163.4 12184.1 12253.0 12426.9 12739.2 11476.8 11938.0 12019.5 12035.5 12282.3 8789.6 8895.9 8906.0 9224.1 9251.6 9090.7 11408.5 11816.6 12134.3 12137.2 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | [#3] mootools.html Cycles:180 Average:6563.88 Median:3714.07 stddev:3881.89 (104.5%) stddev-sans-first:3873.60 17:12:15 INFO - PROCESS | 19545 | Values: 1428.5 1560.1 1616.9 1806.1 1936.5 8546.1 9529.4 9858.7 9873.4 10232.3 10032.9 10052.5 10094.8 10120.6 10124.5 2536.6 2543.7 2558.7 2563.8 2566.2 2521.6 2569.1 2569.9 2570.8 2571.4 2497.2 2508.3 2537.2 2545.1 2546.9 2425.9 2429.4 2430.0 2477.2 2478.6 2360.7 2413.0 2419.3 2421.1 2457.6 9762.6 10053.0 10102.9 10172.9 10178.4 5854.3 6120.9 6129.6 6129.9 6134.3 3579.1 3680.9 3682.7 3745.4 3758.6 1178.8 1185.1 1187.8 1199.0 1223.9 14548.3 14668.6 14694.6 14708.9 14709.0 4896.0 5025.4 5073.9 5128.9 5147.7 11175.8 11210.6 11210.7 11211.4 11217.8 5835.0 5839.1 5840.6 5843.2 5852.2 4861.1 4904.2 5430.3 5441.2 5464.1 4256.4 4299.3 4338.8 4354.9 4368.4 1246.2 1261.8 1262.6 1263.7 1272.6 961.3 991.4 1098.6 1105.6 1114.6 6486.4 6908.9 6928.4 6944.0 7069.1 486.5 487.6 490.6 490.9 502.4 4714.0 4718.2 4770.3 4777.5 4800.1 12463.8 12642.2 12855.7 12952.5 13004.1 12723.5 12842.1 12938.7 12959.4 12960.0 9106.9 9575.2 9608.1 9615.2 9615.2 6773.6 6787.2 6854.8 6943.5 7011.0 11603.7 11628.1 11733.5 11805.1 11837.6 10255.9 10514.3 11777.2 11921.5 12089.6 8144.6 8518.4 8519.1 8524.5 8830.3 10072.1 10116.7 10161.6 10164.3 10175.0 8428.0 8575.8 8640.4 8641.5 8821.7 8497.4 8503.7 8583.8 8679.1 8880.3 7967.0 8011.5 8100.7 8108.7 8134.6 5715.9 5853.8 5879.4 5889.3 5917.3 5727.0 5752.2 5775.4 5840.6 5845.2 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | [#4] prototype.html Cycles:180 Average:4847.65 Median:5469.85 stddev:1411.12 (25.8%) stddev-sans-first:1374.18 17:12:15 INFO - PROCESS | 19545 | Values: 354.2 359.8 365.0 365.7 365.8 5551.4 5567.7 5599.5 5617.8 5623.7 5469.7 5470.0 5488.7 5556.9 5559.4 4164.3 4336.8 4343.5 4385.4 4412.1 4314.0 4330.2 4356.0 4377.0 4379.5 4332.2 4349.1 4358.0 4364.2 4367.3 4178.3 4310.9 4340.4 4356.4 4360.5 3838.3 3848.5 3858.6 3860.4 3866.6 5362.9 5379.8 5389.9 5390.6 5454.6 4896.2 4897.7 4975.5 4990.9 5011.2 5715.3 5740.5 5745.8 5751.4 5751.7 4199.7 4209.6 4214.1 4221.2 4260.7 5654.0 5828.9 5850.2 6025.4 6042.6 4144.8 4171.0 4179.0 4179.2 4302.4 4342.8 4361.5 4369.1 4378.5 4386.5 4815.8 4924.0 4949.0 4965.6 4966.5 5733.5 5750.4 5760.4 5765.9 5776.9 1477.6 1502.9 1505.0 1507.9 1508.4 929.0 972.1 974.8 976.1 989.3 4877.5 4907.5 4915.2 4927.5 4989.4 5213.2 5224.6 5228.9 5245.2 5265.7 5025.3 5030.7 5057.3 5288.3 5675.9 3139.5 3164.8 3167.9 3172.9 3199.0 6083.5 6130.8 6186.0 6186.3 6193.8 6098.6 6105.3 6112.1 6116.5 6120.4 6188.8 6192.6 6195.9 6211.6 6241.8 5874.0 5937.3 5978.9 5981.4 6064.2 5880.9 5907.4 5909.6 5922.4 5971.6 5827.8 5893.6 6058.8 6091.7 6142.0 4298.5 4299.8 4308.8 4310.7 4324.5 5747.3 5946.2 5995.6 6009.4 6027.2 5741.8 5743.6 5771.3 5784.7 5794.9 5757.5 5759.7 5769.1 5784.3 5790.2 5424.6 5745.0 5764.6 5786.7 5811.2 5798.4 5831.3 5851.8 5894.9 5895.7 5527.8 5714.6 5720.5 5744.4 5748.4 17:12:15 INFO - PROCESS | 19545 | 17:12:15 INFO - PROCESS | 19545 | [#5] yui.html Cycles:180 Average:23485.16 Median:22964.04 stddev:34997.64 (152.4%) stddev-sans-first:35054.38 17:12:15 INFO - PROCESS | 19545 | Values: 803.1 818.6 832.4 891.3 930.8 15557.5 17278.2 17423.8 17431.6 17445.2 15864.7 15968.2 16034.9 16036.4 17009.7 764.6 876.2 898.3 898.6 905.8 907.4 909.2 911.8 915.5 917.0 955.2 955.7 959.4 960.1 960.8 781.0 926.4 942.3 947.8 952.1 701.9 702.6 704.0 704.1 704.4 16557.3 16743.2 16747.8 16783.3 16785.7 14771.8 14845.4 14970.0 15159.9 15185.1 13995.7 14031.3 14140.2 14455.6 14474.3 4570.3 4581.2 4627.3 4648.0 4762.1 89156.0 90006.5 90630.5 91274.0 92024.0 12046.5 12087.6 12111.9 12129.9 12465.6 22916.2 22963.3 22964.8 22976.8 22982.1 9036.3 9044.5 9052.8 9089.2 9376.3 4965.6 5080.9 5112.7 5157.1 5231.7 3777.8 3892.6 3900.6 3901.0 3902.4 711.8 714.4 719.7 720.7 738.7 684.0 775.7 781.6 804.6 814.8 10498.7 10700.2 10866.1 11023.2 11181.5 661.5 709.3 747.3 815.1 820.8 4950.3 5162.5 5322.6 5324.9 5338.6 77693.6 137156.0 138183.5 140151.0 143587.0 119212.0 120103.4 121807.0 123327.0 126291.0 102092.0 102315.0 104844.0 105801.9 108973.5 10058.6 10396.5 10436.3 10471.1 10506.7 40613.4 44898.6 49440.5 49913.3 50553.0 79184.6 80917.6 81099.6 83804.0 84044.0 13008.2 13184.3 13348.4 13975.1 14127.7 13913.8 16704.9 16769.2 16825.7 17635.3 11860.7 14739.6 15108.3 15232.8 15316.2 14474.9 14786.7 15497.8 15599.8 15644.0 15257.8 15553.7 16132.6 16263.2 16379.3 12178.2 12373.6 12389.5 13097.9 13151.7 11369.7 12708.4 12856.4 12916.1 13302.0 17:12:15 INFO - PROCESS | 19545 | -------- Summary: end -------- 17:12:15 INFO - PROCESS | 19545 | 17:12:16 INFO - TEST-INFO | 19545: exit 0 17:12:16 INFO - TEST-OK | dromaeo_css | took 1114346ms 17:12:16 INFO - TEST-START | kraken 17:12:16 INFO - operating with platform_type : linux_ 17:12:16 INFO - Initialising browser for kraken test... 17:12:16 INFO - TEST-INFO | started process 19745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpht4bom/profile http://localhost:44597/getInfo.html) 17:12:20 INFO - PROCESS | 19745 | __metrics Screen width/height:1600/1200 17:12:20 INFO - PROCESS | 19745 | colorDepth:24 17:12:20 INFO - PROCESS | 19745 | Browser inner width/height: 1024/697 17:12:20 INFO - PROCESS | 19745 | __metrics 17:12:21 INFO - PROCESS | 19745 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:12:21 INFO - PROCESS | 19745 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:22 INFO - TEST-INFO | 19745: exit 0 17:12:22 INFO - Browser initialized. 17:12:22 INFO - Running cycle 1/1 for kraken test... 17:12:22 INFO - TEST-INFO | started process 19831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpht4bom/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:33 INFO - PROCESS | 19831 | RSS: Main: 144977920 17:12:33 INFO - PROCESS | 19831 | 17:12:36 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44597/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:37 INFO - PROCESS | 19831 | RSS: Main: 191721472 17:12:37 INFO - PROCESS | 19831 | 17:12:39 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44597/tests/kraken/driver.html?testName=audio-dft) 17:12:40 INFO - PROCESS | 19831 | RSS: Main: 180101120 17:12:40 INFO - PROCESS | 19831 | 17:12:43 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44597/tests/kraken/driver.html?testName=audio-fft) 17:12:43 INFO - PROCESS | 19831 | RSS: Main: 268660736 17:12:43 INFO - PROCESS | 19831 | 17:12:45 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44597/tests/kraken/driver.html?testName=audio-oscillator) 17:12:46 INFO - PROCESS | 19831 | RSS: Main: 175681536 17:12:46 INFO - PROCESS | 19831 | 17:12:48 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:49 INFO - PROCESS | 19831 | RSS: Main: 176791552 17:12:49 INFO - PROCESS | 19831 | 17:12:52 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44597/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:52 INFO - PROCESS | 19831 | RSS: Main: 212668416 17:12:52 INFO - PROCESS | 19831 | 17:12:56 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44597/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:56 INFO - PROCESS | 19831 | RSS: Main: 211632128 17:12:56 INFO - PROCESS | 19831 | 17:12:59 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44597/tests/kraken/driver.html?testName=json-parse-financial) 17:13:00 INFO - PROCESS | 19831 | RSS: Main: 211046400 17:13:00 INFO - PROCESS | 19831 | 17:13:01 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:02 INFO - PROCESS | 19831 | RSS: Main: 175726592 17:13:02 INFO - PROCESS | 19831 | 17:13:03 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:04 INFO - PROCESS | 19831 | RSS: Main: 180387840 17:13:04 INFO - PROCESS | 19831 | 17:13:06 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:07 INFO - PROCESS | 19831 | RSS: Main: 185716736 17:13:07 INFO - PROCESS | 19831 | 17:13:09 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:10 INFO - PROCESS | 19831 | RSS: Main: 181051392 17:13:10 INFO - PROCESS | 19831 | 17:13:12 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:13 INFO - PROCESS | 19831 | RSS: Main: 184614912 17:13:13 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | Cycle 1(1): loaded http://localhost:44597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44597/tests/kraken/driver.html?testName=ai-astar) 17:13:15 INFO - PROCESS | 19831 | RSS: Main: 235753472 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | __start_tp_report 17:13:15 INFO - PROCESS | 19831 | _x_x_mozilla_page_load 17:13:15 INFO - PROCESS | 19831 | _x_x_mozilla_page_load_details 17:13:15 INFO - PROCESS | 19831 | |i|pagename|runs| 17:13:15 INFO - PROCESS | 19831 | |0;ai-astar;100;110;108;109;110;109;108;109;108;108 17:13:15 INFO - PROCESS | 19831 | |1;audio-beat-detection;152;116;117;182;118;123;147;120;146;116 17:13:15 INFO - PROCESS | 19831 | |2;audio-dft;161;160;160;161;159;160;160;160;159;159 17:13:15 INFO - PROCESS | 19831 | |3;audio-fft;73;75;74;122;74;75;74;75;97;75 17:13:15 INFO - PROCESS | 19831 | |4;audio-oscillator;83;83;126;84;82;82;111;81;83;124 17:13:15 INFO - PROCESS | 19831 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 17:13:15 INFO - PROCESS | 19831 | |6;imaging-darkroom;146;146;145;146;145;145;146;146;146;146 17:13:15 INFO - PROCESS | 19831 | |7;imaging-desaturate;94;95;95;94;95;94;95;98;94;94 17:13:15 INFO - PROCESS | 19831 | |8;json-parse-financial;51;51;63;52;54;54;51;51;51;53 17:13:15 INFO - PROCESS | 19831 | |9;json-stringify-tinderbox;60;61;60;60;60;60;61;60;60;60 17:13:15 INFO - PROCESS | 19831 | |10;stanford-crypto-aes;74;73;73;77;72;72;75;72;73;81 17:13:15 INFO - PROCESS | 19831 | |11;stanford-crypto-ccm;119;117;121;118;116;114;117;117;161;121 17:13:15 INFO - PROCESS | 19831 | |12;stanford-crypto-pbkdf2;151;151;157;154;152;151;156;154;157;151 17:13:15 INFO - PROCESS | 19831 | |13;stanford-crypto-sha256-iterative;64;62;62;62;61;64;61;61;62;61 17:13:15 INFO - PROCESS | 19831 | __end_tp_report 17:13:15 INFO - PROCESS | 19831 | __start_cc_report 17:13:15 INFO - PROCESS | 19831 | _x_x_mozilla_cycle_collect,1652 17:13:15 INFO - PROCESS | 19831 | __end_cc_report 17:13:15 INFO - PROCESS | 19831 | __startTimestamp1470096795265__endTimestamp 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | ------- Summary: start ------- 17:13:15 INFO - PROCESS | 19831 | Number of tests: 14 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:2.88 (2.6%) stddev-sans-first:0.83 17:13:15 INFO - PROCESS | 19831 | Values: 100.0 110.0 108.0 109.0 110.0 109.0 108.0 109.0 108.0 108.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:134.50 stddev:22.24 (16.5%) stddev-sans-first:22.58 17:13:15 INFO - PROCESS | 19831 | Values: 152.0 116.0 117.0 182.0 118.0 123.0 147.0 120.0 146.0 116.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 17:13:15 INFO - PROCESS | 19831 | Values: 161.0 160.0 160.0 161.0 159.0 160.0 160.0 160.0 159.0 159.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:15.95 (21.3%) stddev-sans-first:16.63 17:13:15 INFO - PROCESS | 19831 | Values: 73.0 75.0 74.0 122.0 74.0 75.0 74.0 75.0 97.0 75.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:82.50 stddev:18.66 (22.6%) stddev-sans-first:19.37 17:13:15 INFO - PROCESS | 19831 | Values: 83.0 83.0 126.0 84.0 82.0 82.0 111.0 81.0 83.0 124.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:13:15 INFO - PROCESS | 19831 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:13:15 INFO - PROCESS | 19831 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 17:13:15 INFO - PROCESS | 19831 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 98.0 94.0 94.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:52.50 stddev:3.70 (7.0%) stddev-sans-first:3.84 17:13:15 INFO - PROCESS | 19831 | Values: 51.0 51.0 63.0 52.0 54.0 54.0 51.0 51.0 51.0 53.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 17:13:15 INFO - PROCESS | 19831 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:73.50 stddev:2.86 (3.9%) stddev-sans-first:3.03 17:13:15 INFO - PROCESS | 19831 | Values: 74.0 73.0 73.0 77.0 72.0 72.0 75.0 72.0 73.0 81.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:118.50 stddev:13.84 (11.7%) stddev-sans-first:14.63 17:13:15 INFO - PROCESS | 19831 | Values: 119.0 117.0 121.0 118.0 116.0 114.0 117.0 117.0 161.0 121.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.00 stddev:2.55 (1.7%) stddev-sans-first:2.55 17:13:15 INFO - PROCESS | 19831 | Values: 151.0 151.0 157.0 154.0 152.0 151.0 156.0 154.0 157.0 151.0 17:13:15 INFO - PROCESS | 19831 | 17:13:15 INFO - PROCESS | 19831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.15 (1.9%) stddev-sans-first:0.97 17:13:15 INFO - PROCESS | 19831 | Values: 64.0 62.0 62.0 62.0 61.0 64.0 61.0 61.0 62.0 61.0 17:13:15 INFO - PROCESS | 19831 | -------- Summary: end -------- 17:13:15 INFO - PROCESS | 19831 | 17:13:16 INFO - TEST-INFO | 19831: exit 0 17:13:16 INFO - TEST-OK | kraken | took 60006ms 17:13:16 INFO - SUITE-END | took 1174s 17:13:16 INFO - Completed test suite (00:19:34) 17:13:16 INFO - javascript benchmark 17:13:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.056633859349, 3319.850606722697, 3340.098173493156, 3362.89911302661, 3370.3764803511353, 5723.799667011655, 5833.941660583393, 5851.0, 5857.56068294878, 5864.296284445867, 5776.740046697898, 5838.562107841918, 5858.326292476367, 5875.676837773921, 5877.8824423511505, 5128.71792051437, 5188.740562971855, 5286.762095705692, 5307.867303317409, 5416.864578385552, 5269.0, 5325.600579956499, 5338.412774594792, 5338.733063346836, 5339.199120131972, 5176.482351764831, 5212.035773381917, 5225.817096401626, 5242.397124330693, 5286.154215325549, 5323.9467605324035, 5346.732663366855, 5350.30446042012, 5353.0, 5355.062863998784, 5093.388793344785, 5148.639595228336, 5214.087534681454, 5244.108501554745, 5249.711265880375, 5576.302962129734, 5643.633163844337, 5679.233303504016, 5679.914801277984, 5708.086706127, 6191.938080619181, 6192.8761424771255, 6196.0, 6198.597091189104, 6200.162977997958, 5937.435943585396, 6099.786507472217, 6111.052786818051, 6111.419415155553, 6225.688715564203, 5762.567807414461, 5762.769489220426, 5789.623674461189, 5794.333651630117, 5808.88382232353, 6281.089242059876, 6301.117843501914, 6318.241810982619, 6320.083587879823, 6329.493640508748, 5882.911756323659, 5955.0, 5959.612625179349, 5993.970030149909, 6104.7485265521345, 6215.378462153749, 6217.440430361289, 6220.191375121205, 6221.626702397871, 6225.750969961241, 6124.173236613089, 6159.784407545714, 6166.290876549254, 6169.01295792671, 6183.288921773964, 6017.669028203403, 6060.0, 6106.572539922163, 6110.315755984981, 6123.00810456741, 4717.363155973968, 4755.310479980383, 4756.9286460703115, 4781.258904869751, 4797.688150270221, 4220.282551966173, 4232.830686772556, 4235.576442355739, 4243.936340954888, 4259.998900258437, 5702.429757024347, 5804.187413762077, 5859.0, 5862.355140934494, 5943.31651860033, 6243.875122497525, 6258.780942666985, 6262.279837818618, 6265.530085243625, 6268.843278918063, 5867.6772777497645, 5878.882422351615, 5881.705914704247, 5883.61756485827, 5933.3473317934995, 5151.948480515147, 5209.869753256123, 5284.7886084556185, 5286.392064912584, 5349.117395629755, 6336.904946425715, 6373.1714877066615, 6391.744330226739, 6392.4566411854585, 6409.519286053472, 6191.133241346125, 6205.875882482415, 6207.720652570735, 6213.1922850029205, 6216.44052035319, 6181.258249010148, 6280.5289603279025, 6317.020861766434, 6330.240371155491, 6409.35906409374, 6148.9692551536955, 6150.7539698411565, 6154.630722156685, 6160.876782464416, 6161.476274516716, 6185.195924529782, 6205.441510264098, 6246.219222597176, 6266.780662676784, 6278.183836101461, 5933.762649493972, 5982.341942386421, 6000.279966404059, 6012.248468941382, 6022.397760223943, 5935.99088155006, 5979.043353063489, 5996.730147143477, 5997.3402925677265, 6009.338972712911, 5942.732577033958, 5952.464278214981, 5956.344802071682, 5978.252718410199, 6023.5181185505935, 5929.555283353679, 6040.879182416239, 6062.42406971337, 6111.938880611137, 6123.84690382744, 5972.13404056418, 5972.701364931823, 5977.820665380045, 5980.551458640706, 6011.458968692664], "value": 5694.731231844705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.0909612840418, 631.9888178913739, 648.3872740260456, 658.8814013477572, 659.172738213542, 34577.0, 38481.61518384815, 50929.23606145906, 52442.0, 52483.47516524834, 49591.0, 49965.75017124919, 50013.24980125292, 50047.498575042715, 50235.24647130287, 9315.906840931588, 9472.763180920498, 9482.146606805387, 9482.762930926747, 9489.71530854072, 8629.784255393633, 11021.614243501479, 11235.269707468988, 11275.0, 11749.236299640539, 11534.192606517547, 11643.301401915869, 11643.883561164364, 11643.941780291087, 11656.883431165706, 11421.086313094975, 11504.194706370557, 11506.0, 11508.539658413696, 11509.539618415254, 11274.323540587591, 11362.091032717362, 11367.658970230907, 11370.260933039326, 11371.260868043551, 46892.2966155508, 47152.29271560929, 47284.763576182246, 47421.288680669815, 47553.286700699515, 3854.258381725902, 3887.2225554889137, 4024.014116541437, 4062.857799976987, 4544.0, 33275.88704561243, 35988.280234395424, 36260.27479450396, 36337.27325453476, 36887.26225475476, 4747.667663263573, 4841.346418233528, 4859.927101093486, 4899.975500122477, 4932.112219800434, 382927.0, 383855.0807245974, 384333.0, 386185.0, 386810.0, 65233.673831630535, 65783.0, 65796.0, 65802.67098664476, 65804.0, 36201.0, 36890.44664330037, 37009.0, 37044.259114817556, 37079.25841483155, 19374.70937935932, 19590.608187836162, 19593.510162246057, 19597.412077637695, 19603.901980490005, 11960.581379651845, 14589.708205836036, 15113.09321440717, 15229.771553426708, 15232.923835380752, 20432.0, 21226.36320910375, 21289.254876079263, 21361.89319053395, 21527.78472215289, 7729.149793522708, 7855.489393189425, 7908.604569771488, 7932.603369831485, 8000.799980000546, 1093.283899046126, 1097.7749561339906, 1104.089126470665, 1184.4373922386796, 1198.7302856857311, 35262.06331113646, 35486.290274194886, 35893.936148485904, 36251.01238863723, 36283.27433451369, 1180.816973369129, 1202.3086725133082, 1237.8638349781518, 1239.4856134703996, 1249.9687507812378, 18932.43202703921, 18933.242670293308, 18981.81018189828, 19029.0, 19198.13608387626, 642114.0, 646495.0, 647714.0, 648014.0, 649845.0, 65339.34660653428, 66105.6694716533, 66133.0, 66136.0, 66149.66925165344, 1378.676011137382, 1423.849986520341, 1480.1193289992436, 1496.6632507685902, 1508.1554329575254, 34349.31301374009, 36921.261574767814, 37165.814170930054, 37413.625863742105, 37988.0, 55673.0, 55748.163777542555, 55940.44059559352, 56301.436985631255, 56351.30946071624, 449024.0, 451279.0, 451466.0, 452732.0, 523433.0, 45230.0, 48681.0, 49479.0, 49539.752301238266, 49743.25385119153, 52801.0, 53875.73062134664, 54244.18633720576, 54540.18189727078, 55130.72434637801, 45543.77228113971, 47808.760956194994, 47930.281045783646, 48049.75975120102, 49727.502724972284, 45777.313340300585, 47256.7637161812, 47719.28421073617, 47939.92510636635, 48684.26973595328, 46791.29813052875, 46912.53087469082, 47691.523084768705, 48028.0, 48279.75860120677, 38261.0, 40941.0, 41329.380059298535, 41396.79301603593, 42042.0, 31082.378352433276, 31118.56019793331, 31319.0, 31466.213344666565, 31784.841075794473], "value": 22721.770119122044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.280380921959, 410.8993296642323, 428.80489377333305, 433.5252898076606, 438.67318847458625, 16292.0, 19822.0, 20137.39587812366, 20536.589268214626, 20709.585808283824, 19637.901810490963, 19804.70292945607, 19860.106295216712, 19890.40328790135, 20095.397138085846, 5626.718664066801, 5804.390538993398, 5827.1550625159325, 5888.205092312547, 5899.085641725518, 6001.399860013986, 6022.638641681491, 6028.547858910577, 6173.228346456693, 6384.170057892491, 6500.9674951625175, 6609.140811694473, 6725.697343619524, 6733.797986060402, 6748.223954245275, 6182.536309776762, 6217.3471785462325, 6234.376562343775, 6234.4077312655, 6518.543701940866, 5864.824055278348, 5870.941290587082, 5914.053751399755, 5994.7901823436405, 6001.4298641628975, 23197.652035219486, 23244.535109297718, 23875.88062059696, 24015.519689606284, 24196.637050444257, 2353.646952957053, 2355.246321177207, 2762.5165596020615, 2977.776666749981, 3128.9061328159964, 12330.383480825923, 14163.079399838978, 14310.069845460011, 14390.712185756227, 15084.321205545668, 1913.2729562766199, 2031.4210450021674, 2048.528838367169, 2083.9687404688943, 2117.2907076129513, 58951.0, 76263.23736762616, 76298.0, 87031.56484217601, 87333.99999999936, 11278.15413843965, 11514.194006419637, 11668.241564298463, 11693.298402095732, 11911.880881191077, 16787.412440564767, 16810.327586896386, 16818.831811681728, 16822.747658785127, 16839.158042097846, 10285.43430111336, 10469.267151299488, 10766.78466430667, 10812.5134368952, 10889.891101089046, 8808.867866982, 8988.910110898938, 9040.502772347583, 9299.76750581241, 9468.573914173741, 8953.238974687094, 9069.909300907038, 9200.539973001323, 9336.906630933603, 9470.337076404723, 3332.5667663204113, 3490.4571859562566, 3513.683768460851, 3576.1774791798034, 3617.0, 931.1945167430124, 975.4586204656483, 1004.1013293102632, 1017.3946501831399, 1023.9334443261164, 20374.0, 20908.0, 21077.578448431253, 21161.576768464853, 21306.36080917575, 1030.1861529391847, 1050.9054185123375, 1065.9893401066045, 1085.4409978860892, 1117.7149826794277, 10544.472776361152, 11622.593209237637, 11688.47401866918, 11722.0, 11794.76410471803, 559151.0, 588353.0, 601745.0, 603896.0, 604555.0, 85063.5746821262, 93006.0, 100082.0, 100733.49633251787, 102072.48963755133, 1029.1920842138884, 1037.4138611684375, 1045.7751583409452, 1095.0308976555805, 1098.9175811814146, 17686.380976665754, 18026.549336266697, 18103.0, 18176.0, 18667.066646667885, 45664.54335456603, 46167.307490387, 47216.527834721215, 47530.52469475261, 48026.0, 63401.0, 64823.67588162029, 65400.34599654133, 65606.0, 66408.0, 8893.4663920165, 9084.364094513321, 9148.0, 9171.954140229256, 9180.403273787182, 11820.172587918763, 12635.93682031584, 13994.510192143227, 14011.159330440207, 14286.142831430148, 11619.070474361863, 12028.255902894207, 12047.33739644328, 12111.515539378326, 12148.149629526202, 12163.391830408267, 12184.086193535342, 12253.0, 12426.875731242571, 12739.235645861278, 11476.770464590829, 11938.0, 12019.519219231483, 12035.458404371999, 12282.263064216175, 8789.648414063366, 8895.866562001705, 8905.955470222607, 9224.07759224099, 9251.629934802802, 9090.681826136053, 11408.543658253577, 11816.586419475278, 12134.33261170644, 12137.21108127969], "value": 10242.386494724613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.4928850258163, 1560.1341255603143, 1616.9029858208507, 1806.1059775411165, 1936.4577918182904, 8546.102659220778, 9529.380590261628, 9858.704238872828, 9873.407595544273, 10232.33489823161, 10032.949835250833, 10052.497375131232, 10094.848577271347, 10120.595176192963, 10124.493775311243, 2536.5561026820324, 2543.707473640527, 2558.692956845181, 2563.7564431379083, 2566.217303722364, 2521.558727222738, 2569.100814714844, 2569.9486010279784, 2570.7686308232255, 2571.395722005327, 2497.1759319424636, 2508.285138735461, 2537.1500547316673, 2545.083769842855, 2546.9490610187786, 2425.8787060646987, 2429.416939934412, 2430.040134147011, 2477.2444404456633, 2478.5538603051623, 2360.704911886014, 2412.975870241293, 2419.2742177346727, 2421.055788242587, 2457.5699252630898, 9762.609495620167, 10053.04496072872, 10102.898971010269, 10172.949135254275, 10178.389296642225, 5854.297484301911, 6120.877582448326, 6129.601575897597, 6129.938700612981, 6134.294556126058, 3579.1052236940764, 3680.9079773005888, 3682.723795715332, 3745.419459983707, 3758.586555478895, 1178.7524619829846, 1185.0874826383722, 1187.7921363761393, 1199.0407673860964, 1223.9143259971806, 14548.272586370638, 14668.633284167874, 14694.55916322512, 14708.926455367762, 14709.0, 4896.0, 5025.422076461181, 5073.898522029539, 5128.9230661540105, 5147.6911385317, 11175.83236251457, 11210.607628733118, 11210.66368008961, 11211.439428028565, 11217.831732524019, 5835.037218858841, 5839.124131380327, 5840.649561026352, 5843.152742852262, 5852.180694702745, 4861.124997500413, 4904.190808516555, 5430.266913966564, 5441.238226648273, 5464.12573988168, 4256.446661933929, 4299.269124248885, 4338.7830608470085, 4354.912901741947, 4368.36658684489, 1246.214884622682, 1261.8359613250218, 1262.551794113095, 1263.7346157306886, 1272.580048583965, 961.3318743473219, 991.3605724307781, 1098.5715570927346, 1105.6461932181624, 1114.5820317380983, 6486.4486518646445, 6908.9309106909295, 6928.44572434204, 6944.0, 7069.08101946754, 486.47217768721333, 487.63671065056053, 490.5952589113995, 490.9018196360742, 502.43977964569973, 4713.95286047142, 4718.245080787057, 4770.284457331428, 4777.450593181759, 4800.135975524369, 12463.813042804366, 12642.2414655121, 12855.678608034874, 12952.481900724055, 13004.089713720137, 12723.491060357666, 12842.101052926393, 12938.676533086747, 12959.416826242841, 12960.0, 9106.86339704905, 9575.23398128148, 9608.135267826068, 9615.182709469633, 9615.182709469773, 6773.62745049027, 6787.219469760843, 6854.760083397057, 6943.548669336477, 7010.964945175241, 11603.6518904433, 11628.127890408085, 11733.471993760131, 11805.114616403633, 11837.644870653894, 10255.897441025494, 10514.316569422963, 11777.175597708077, 11921.46353414081, 12089.57686480969, 8144.59277036134, 8518.446300990416, 8519.148085191431, 8524.488530688179, 8830.293576513992, 10072.093511583993, 10116.747081323027, 10161.593536258466, 10164.288499804943, 10175.0, 8427.95786021066, 8575.785605359666, 8640.438371506083, 8641.481511109354, 8821.691240806542, 8497.447665901696, 8503.74488765338, 8583.785405364915, 8679.088695686862, 8880.333974952033, 7967.0, 8011.479253848481, 8100.71647492335, 8108.6756529740505, 8134.633941472766, 5715.914261286167, 5853.765849365977, 5879.382664820132, 5889.293284805679, 5917.260342457193, 5727.0, 5752.194692742935, 5775.393583673654, 5840.561957853263, 5845.18167456565], "value": 5075.525130534686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2189472213769, 359.83987125729055, 364.9726270529711, 365.6617628693458, 365.81160702238367, 5551.417101204371, 5567.721613919298, 5599.468050535198, 5617.848341090077, 5623.718814059301, 5469.72651367432, 5469.972650136754, 5488.69812160332, 5556.9444305556935, 5559.360673522546, 4164.251014573879, 4336.761478118702, 4343.522212556616, 4385.386045953554, 4412.1175764847, 4313.956860431387, 4330.198913201052, 4355.956440435602, 4376.97811510942, 4379.4525684289465, 4332.220200363933, 4349.064951035527, 4358.0, 4364.214441400547, 4367.279398899178, 4178.331466965271, 4310.892227694333, 4340.435743353344, 4356.368326592658, 4360.454943132108, 3838.2899163654815, 3848.5189351331082, 3858.614138586147, 3860.3823388257742, 3866.574676785551, 5362.892742145174, 5379.81644038311, 5389.948959952811, 5390.56875449967, 5454.61817672763, 4896.216605343128, 4897.681650692693, 4975.502449755032, 4990.87522811929, 5011.223260394645, 5715.342735585419, 5740.4833564978935, 5745.798897038583, 5751.3961034091235, 5751.683657398841, 4199.727017743837, 4209.621134097946, 4214.136102099063, 4221.219074471202, 4260.744355338658, 5653.992832544429, 5828.941710582924, 5850.180974663551, 6025.397460253984, 6042.637441753465, 4144.7513149211145, 4170.9582904171175, 4178.979105104516, 4179.185058913544, 4302.397664326997, 4342.827436592165, 4361.476622805284, 4369.126174764996, 4378.5183629800695, 4386.539413361615, 4815.759212039454, 4923.95240047623, 4948.975255123702, 4965.577925876341, 4966.503349665077, 5733.512651424676, 5750.367459579443, 5760.3951585083805, 5765.913511297334, 5776.884462310731, 1477.5567329801017, 1502.894797364196, 1504.9924750376397, 1507.8944473886722, 1508.3589474473524, 928.9860652090224, 972.0959507657946, 974.815599047147, 976.1214906583989, 989.2629990657007, 4877.536634019833, 4907.460179380265, 4915.16442204826, 4927.531884470969, 4989.351384320015, 5213.191955246943, 5224.60815438836, 5228.869278268074, 5245.190409308782, 5265.736713164327, 5025.321581586439, 5030.673006254582, 5057.31726216956, 5288.2596436498925, 5675.886482270332, 3139.5290706393766, 3164.810111393324, 3167.9250091190306, 3172.857221425041, 3199.0242975892575, 6083.452489275986, 6130.754769809158, 6185.979313413326, 6186.257649082139, 6193.783217587363, 6098.603590766586, 6105.32841387447, 6112.135798581476, 6116.480099191618, 6120.449159575571, 6188.845278868064, 6192.628442293477, 6195.907061394083, 6211.627302361782, 6241.781537646251, 5873.970630146822, 5937.34689184198, 5978.9402105980125, 5981.371955944737, 6064.181335519825, 5880.882382352243, 5907.438793314628, 5909.645421274738, 5922.437368449991, 5971.552133589911, 5827.766889324549, 5893.616914900518, 6058.787942421994, 6091.664958427152, 6141.977005061692, 4298.517011630982, 4299.849505267301, 4308.784560771886, 4310.728335141203, 4324.459442569679, 5747.252857128547, 5946.167536544801, 5995.640261584319, 6009.399060093956, 6027.21646185993, 5741.770329186786, 5743.62666426681, 5771.2686194142425, 5784.681842498703, 5794.913076303943, 5757.466714645542, 5759.65442073477, 5769.105788602773, 5784.2769653793275, 5790.160426738184, 5424.647397919122, 5744.971275143597, 5764.625299355528, 5786.739596718074, 5811.215485909517, 5798.391168927371, 5831.329397119385, 5851.824445266649, 5894.911576326273, 5895.734691938959, 5527.778888844401, 5714.628549144292, 5720.513756330592, 5744.396838331915, 5748.39641837601], "value": 4403.088706072588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.0644299391209, 818.5620692929284, 832.4048305461594, 891.2558014058261, 930.7626555228416, 15557.455489057886, 17278.2224799884, 17423.82576174238, 17431.564210894703, 17445.21496532656, 15864.682706345895, 15968.201589920487, 16034.919825400886, 16036.43872464464, 17009.744853827204, 764.5641984069083, 876.2376732242958, 898.3307435960219, 898.5866501409326, 905.8414777413959, 907.4101833808012, 909.222614664459, 911.7994041310934, 915.5193523400235, 916.9541522923861, 955.1880901233931, 955.7132860141965, 959.3572306554626, 960.0975083421562, 960.8462645976645, 781.0432220529834, 926.4302453990781, 942.2885721280458, 947.8199142162968, 952.0764858087643, 701.8596280743872, 702.6135625406057, 703.9507234493587, 704.1163340008308, 704.3977399323607, 16557.25492352835, 16743.246553905105, 16747.83252167487, 16783.32866685331, 16785.664286714196, 14771.77842332355, 14845.406183752637, 14970.0, 15159.924200379039, 15185.088894666356, 13995.720085598332, 14031.305419086324, 14140.222287774168, 14455.638609034859, 14474.348654310581, 4570.314452832068, 4581.221192397267, 4627.329037289574, 4648.031990745815, 4762.119007983534, 89156.0, 90006.54996724974, 90630.54684726534, 91274.0, 92023.99999999933, 12046.457909394097, 12087.637370878887, 12111.939440302742, 12129.939350303192, 12465.626031219077, 22916.19793307226, 22963.311100667008, 22964.770352296597, 22976.770232297462, 22982.080716771477, 9036.277097832157, 9044.547772611342, 9052.818943621223, 9089.181973622406, 9376.296777741696, 4965.627577931597, 5080.898382032413, 5112.693238405707, 5157.071727089085, 5231.712255825966, 3777.8299976501125, 3892.6107389261415, 3900.64894159527, 3901.0, 3902.3951287550476, 711.7757906259511, 714.3677845107014, 719.6617589732817, 720.6937051752984, 738.7183237083656, 683.9692213850388, 775.6780935911646, 781.6404453951246, 804.6057431858347, 814.767791179511, 10498.685039448676, 10700.197485188643, 10866.07638350749, 11023.17326200538, 11181.496832642551, 661.543534960885, 709.2552819539463, 747.3386053342831, 815.1318845429598, 820.7660816667221, 4950.3069570260195, 5162.457941916045, 5322.627416080914, 5324.92012619811, 5338.626296159232, 77693.61153194311, 137156.0, 138183.47266109445, 140151.0, 143587.0, 119212.0, 120103.39948300202, 121807.0, 123327.0, 126291.0, 102092.0, 102315.0, 104844.0, 105801.94198058076, 108973.45513272383, 10058.647947321808, 10396.532156052845, 10436.321639093434, 10471.109955653856, 10506.684799456028, 40613.39079913744, 44898.551014489436, 49440.50559494359, 49913.29985258418, 50553.0, 79184.60407697925, 80917.59541202257, 81099.59450202712, 83804.0, 84044.0, 13008.21950682962, 13184.340782960622, 13348.399322030726, 13975.09161904473, 14127.717445651235, 13913.791293130409, 16704.916475417544, 16769.245383957506, 16825.663486730442, 17635.29458821633, 11860.703482413008, 14739.631509212355, 15108.320125594595, 15232.771508427604, 15316.157611331484, 14474.855251447772, 14786.704265914837, 15497.767533487233, 15599.766003510184, 15644.0, 15257.771133432785, 15553.68892622164, 16132.596685082966, 16263.186840658156, 16379.344826206818, 12178.208416452902, 12373.62879113628, 12389.504419823106, 13097.934510327768, 13151.73696526045, 11369.658910232707, 12708.364581771059, 12856.357182141042, 12916.095873289156, 13302.0], "value": 8371.76136921859, "unit": "score"}], "name": "dromaeo_css", "value": 7926.281352918173, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 108.0, 109.0, 110.0, 109.0, 108.0, 109.0, 108.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 117.0, 182.0, 118.0, 123.0, 147.0, 120.0, 146.0, 116.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 159.0, 160.0, 160.0, 160.0, 159.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 122.0, 74.0, 75.0, 74.0, 75.0, 97.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 126.0, 84.0, 82.0, 82.0, 111.0, 81.0, 83.0, 124.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 98.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 63.0, 52.0, 54.0, 54.0, 51.0, 51.0, 51.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 77.0, 72.0, 72.0, 75.0, 72.0, 73.0, 81.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 121.0, 118.0, 116.0, 114.0, 117.0, 117.0, 161.0, 121.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 157.0, 154.0, 152.0, 151.0, 156.0, 154.0, 157.0, 151.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 61.0, 64.0, 61.0, 61.0, 62.0, 61.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1459.1, "alertThreshold": 2.0}]} 17:13:16 INFO - Return code: 0 17:13:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:13:16 INFO - # TBPL SUCCESS # 17:13:16 INFO - Running post-action listener: _resource_record_post_action 17:13:16 INFO - [mozharness: 2016-08-02 00:13:16.584916Z] Finished run-tests step (success) 17:13:16 INFO - Running post-run listener: _resource_record_post_run 17:13:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506912768; Read time: 4; Write time: 485760 17:13:16 INFO - TinderboxPrint: CPU usage
13.0% 17:13:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 17:13:16 INFO - TinderboxPrint: I/O write bytes / time
506,912,768 / 485,760 17:13:16 INFO - TinderboxPrint: CPU idle
8,272.6 (87.0%) 17:13:16 INFO - TinderboxPrint: CPU user
1,185.8 (12.5%) 17:13:16 INFO - TinderboxPrint: Swap in / out
0 / 0 17:13:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252952576; Read time: 0; Write time: 326444 17:13:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 253960192; Read time: 0; Write time: 159316 17:13:17 INFO - Running post-run listener: _upload_blobber_files 17:13:17 INFO - Blob upload gear active. 17:13:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:17 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:13:17 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:13:17 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:13:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:13:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:13:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:18 INFO - (blobuploader) - INFO - Done attempting. 17:13:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:13:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:13:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:24 INFO - (blobuploader) - INFO - Done attempting. 17:13:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:13:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:13:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:27 INFO - (blobuploader) - INFO - Done attempting. 17:13:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:27 INFO - Return code: 0 17:13:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42e39d2137e1d8fb887572bfde0d503aa561af25c5cf1b5990889ef62289d3cda3595578608195542b4293bf492dc822d3ca1f46bd8187d52ab93c79f88100fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611a32aea28986ebbaf43991b30acf5e0d0ad9f471f2c49de41c9530b8102b2f9e6ed63ae6c19bfd6aacd2ae8311ae701f50d63763f8c52a6399c1c3bbcb17a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604a13d72d311b8d0e92124683f4025c93fd39644f47c182cfa22329cc97e3e3a91108cd5e17e1d4b82c2b0954956fd35ab1c4d3bad90d61ab120eb6b4a526a6"} 17:13:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:27 INFO - Contents: 17:13:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42e39d2137e1d8fb887572bfde0d503aa561af25c5cf1b5990889ef62289d3cda3595578608195542b4293bf492dc822d3ca1f46bd8187d52ab93c79f88100fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611a32aea28986ebbaf43991b30acf5e0d0ad9f471f2c49de41c9530b8102b2f9e6ed63ae6c19bfd6aacd2ae8311ae701f50d63763f8c52a6399c1c3bbcb17a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604a13d72d311b8d0e92124683f4025c93fd39644f47c182cfa22329cc97e3e3a91108cd5e17e1d4b82c2b0954956fd35ab1c4d3bad90d61ab120eb6b4a526a6"} 17:13:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:27 INFO - Copying logs to upload dir... 17:13:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.577358 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-01 17:13:27.877736) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 17:13:27.881792) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42e39d2137e1d8fb887572bfde0d503aa561af25c5cf1b5990889ef62289d3cda3595578608195542b4293bf492dc822d3ca1f46bd8187d52ab93c79f88100fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611a32aea28986ebbaf43991b30acf5e0d0ad9f471f2c49de41c9530b8102b2f9e6ed63ae6c19bfd6aacd2ae8311ae701f50d63763f8c52a6399c1c3bbcb17a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604a13d72d311b8d0e92124683f4025c93fd39644f47c182cfa22329cc97e3e3a91108cd5e17e1d4b82c2b0954956fd35ab1c4d3bad90d61ab120eb6b4a526a6"} build_url:https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/VbMp5SeOQn-RyOBJjxKuIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42e39d2137e1d8fb887572bfde0d503aa561af25c5cf1b5990889ef62289d3cda3595578608195542b4293bf492dc822d3ca1f46bd8187d52ab93c79f88100fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611a32aea28986ebbaf43991b30acf5e0d0ad9f471f2c49de41c9530b8102b2f9e6ed63ae6c19bfd6aacd2ae8311ae701f50d63763f8c52a6399c1c3bbcb17a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604a13d72d311b8d0e92124683f4025c93fd39644f47c182cfa22329cc97e3e3a91108cd5e17e1d4b82c2b0954956fd35ab1c4d3bad90d61ab120eb6b4a526a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 17:13:27.906819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 17:13:27.907116) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470095572.29029-1445691725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 17:13:27.990062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 17:13:27.990375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 17:13:27.990699) ========= ========= Total master_lag: 0.17 =========