builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1469659978.69 results: success (0) buildid: 20160727131625 builduid: 0dffb885355149a08691c447b656af38 revision: f430f9a12c98a00bfb0edce37947614e0a2b83cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.686988) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.687508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.687810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.710141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.710706) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 15:52:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-27 15:52:59 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.803427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.803836) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015619 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:52:58.854683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 15:52:58.855219) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f430f9a12c98a00bfb0edce37947614e0a2b83cc --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 f430f9a12c98a00bfb0edce37947614e0a2b83cc --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=6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 15:52:59,143 truncating revision to first 12 chars 2016-07-27 15:52:59,143 Setting DEBUG logging. 2016-07-27 15:52:59,143 attempt 1/10 2016-07-27 15:52:59,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f430f9a12c98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 15:53:00,252 unpacking tar archive at: mozilla-aurora-f430f9a12c98/testing/mozharness/ program finished with exit code 0 elapsedTime=1.439828 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 15:53:00.408458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:00.408846) ========= script_repo_revision: f430f9a12c98a00bfb0edce37947614e0a2b83cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:00.409319) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:00.409617) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:00.421791) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-27 15:53:00.422451) ========= /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=6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:00 INFO - MultiFileLogger online at 20160727 15:53:00 in /builds/slave/test 15:53:00 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 15:53:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:00 INFO - {'append_to_log': False, 15:53:00 INFO - 'base_work_dir': '/builds/slave/test', 15:53:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:53:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:00 INFO - 'branch': 'Mozilla-Aurora', 15:53:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:00 INFO - 'config_files': ('talos/linux_config.py',), 15:53:00 INFO - 'default_actions': ('clobber', 15:53:00 INFO - 'read-buildbot-config', 15:53:00 INFO - 'download-and-extract', 15:53:00 INFO - 'populate-webroot', 15:53:00 INFO - 'create-virtualenv', 15:53:00 INFO - 'install', 15:53:00 INFO - 'run-tests'), 15:53:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:00 INFO - 'download_minidump_stackwalk': True, 15:53:00 INFO - 'download_symbols': 'ondemand', 15:53:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:53:00 INFO - 'tooltool.py': '/tools/tooltool.py', 15:53:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:53:00 INFO - '/tools/misc-python/virtualenv.py')}, 15:53:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:00 INFO - 'installer_path': 'installer.exe', 15:53:00 INFO - 'log_level': 'info', 15:53:00 INFO - 'log_name': 'talos', 15:53:00 INFO - 'log_to_console': True, 15:53:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:00 INFO - 'opt_config_files': (), 15:53:00 INFO - 'pip_index': False, 15:53:00 INFO - 'sps_profile': False, 15:53:00 INFO - 'sps_profile_interval': 0, 15:53:00 INFO - 'suite': 'dromaeojs', 15:53:00 INFO - 'system_bits': '32', 15:53:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:00 INFO - 'title': 'talos-linux64-ix-023', 15:53:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:00 INFO - 'use_talos_json': True, 15:53:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:00 INFO - 'work_dir': 'build'} 15:53:00 INFO - ##### 15:53:00 INFO - ##### Running clobber step. 15:53:00 INFO - ##### 15:53:00 INFO - Running pre-action listener: _resource_record_pre_action 15:53:00 INFO - Running main action method: clobber 15:53:00 INFO - rmtree: /builds/slave/test/build 15:53:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:01 INFO - Running post-action listener: _resource_record_post_action 15:53:01 INFO - ##### 15:53:01 INFO - ##### Finished clobber step (success) 15:53:01 INFO - ##### 15:53:01 INFO - ##### 15:53:01 INFO - ##### Running read-buildbot-config step. 15:53:01 INFO - ##### 15:53:01 INFO - Running pre-action listener: _resource_record_pre_action 15:53:01 INFO - Running main action method: read_buildbot_config 15:53:01 INFO - Using buildbot properties: 15:53:01 INFO - { 15:53:01 INFO - "project": "", 15:53:01 INFO - "product": "firefox", 15:53:01 INFO - "script_repo_revision": "production", 15:53:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:53:01 INFO - "repository": "", 15:53:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:53:01 INFO - "buildid": "20160727131625", 15:53:01 INFO - "pgo_build": "True", 15:53:01 INFO - "basedir": "/builds/slave/test", 15:53:01 INFO - "buildnumber": 635, 15:53:01 INFO - "slavename": "talos-linux64-ix-023", 15:53:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:53:01 INFO - "platform": "ubuntu64_hw", 15:53:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:53:01 INFO - "branch": "mozilla-aurora", 15:53:01 INFO - "repo_path": "releases/mozilla-aurora", 15:53:01 INFO - "revision": "f430f9a12c98a00bfb0edce37947614e0a2b83cc", 15:53:01 INFO - "stage_platform": "linux64-pgo", 15:53:01 INFO - "builduid": "0dffb885355149a08691c447b656af38", 15:53:01 INFO - "slavebuilddir": "test" 15:53:01 INFO - } 15:53:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:53:01 INFO - Running post-action listener: _resource_record_post_action 15:53:01 INFO - ##### 15:53:01 INFO - ##### Finished read-buildbot-config step (success) 15:53:01 INFO - ##### 15:53:01 INFO - ##### 15:53:01 INFO - ##### Running download-and-extract step. 15:53:01 INFO - ##### 15:53:01 INFO - Running pre-action listener: _resource_record_pre_action 15:53:01 INFO - Running main action method: download_and_extract 15:53:01 INFO - mkdir: /builds/slave/test/build/tests 15: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')]} 15:53:01 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:53:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:53:02 INFO - Downloaded 1361 bytes. 15:53:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:02 INFO - Using the following test package requirements: 15:53:02 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:53:02 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:53:02 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:53:02 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'jsshell-linux-x86_64.zip'], 15:53:02 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:53:02 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:53:02 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:53:02 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:53:02 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:53:02 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:53:02 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:02 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:53:03 INFO - Downloaded 24494588 bytes. 15:53:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:53:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:53:04 INFO - Return code: 0 15:53:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:53:04 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')]} 15:53:04 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:53:07 INFO - Downloaded 24494588 bytes. 15:53:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:53:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:53:09 INFO - Return code: 0 15: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')]} 15:53:09 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:53:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:53:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:53:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:53:10 INFO - Downloaded 10833369 bytes. 15:53:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:53:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:53:10 INFO - Return code: 0 15:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:10 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:53:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:53:11 INFO - Downloaded 63646822 bytes. 15:53:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:11 INFO - mkdir: /builds/slave/test/properties 15:53:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:11 INFO - Contents: 15:53:11 INFO - build_url:https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:12 INFO - Running post-action listener: _resource_record_post_action 15:53:12 INFO - Running post-action listener: set_extra_try_arguments 15:53:12 INFO - ##### 15:53:12 INFO - ##### Finished download-and-extract step (success) 15:53:12 INFO - ##### 15:53:12 INFO - ##### 15:53:12 INFO - ##### Running populate-webroot step. 15:53:12 INFO - ##### 15:53:12 INFO - Running pre-action listener: _resource_record_pre_action 15:53:12 INFO - Running main action method: populate_webroot 15:53:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:12 INFO - '--tppagecycles', 15:53:12 INFO - '7'], 15:53:12 INFO - 'tests': ['tsvgm']}}, 15:53:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['damp', 'tps']}, 15:53:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'tests': ['damp', 'tps']}, 15:53:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['dromaeo_dom']}, 15:53:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['a11yr', 15:53:12 INFO - 'ts_paint', 15:53:12 INFO - 'tpaint', 15:53:12 INFO - 'sessionrestore', 15:53:12 INFO - 'sessionrestore_no_auto_restore', 15:53:12 INFO - 'tabpaint']}, 15:53:12 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:12 INFO - 'ts_paint', 15:53:12 INFO - 'tpaint', 15:53:12 INFO - 'sessionrestore', 15:53:12 INFO - 'sessionrestore_no_auto_restore', 15:53:12 INFO - 'tabpaint']}, 15:53:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:12 INFO - 'ts_paint', 15:53:12 INFO - 'tpaint', 15:53:12 INFO - 'sessionrestore', 15:53:12 INFO - 'sessionrestore_no_auto_restore', 15:53:12 INFO - 'tabpaint']}, 15:53:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:12 INFO - 'ts_paint', 15:53:12 INFO - 'tpaint', 15:53:12 INFO - 'sessionrestore', 15:53:12 INFO - 'sessionrestore_no_auto_restore', 15:53:12 INFO - 'tabpaint']}, 15:53:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['a11yr', 15:53:12 INFO - 'ts_paint', 15:53:12 INFO - 'tpaint', 15:53:12 INFO - 'sessionrestore', 15:53:12 INFO - 'sessionrestore_no_auto_restore', 15:53:12 INFO - 'tabpaint']}, 15:53:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['a11yr', 15:53:12 INFO - 'ts_paint', 15:53:12 INFO - 'tpaint', 15:53:12 INFO - 'sessionrestore', 15:53:12 INFO - 'sessionrestore_no_auto_restore', 15:53:12 INFO - 'tabpaint']}, 15:53:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['tsvgx', 15:53:12 INFO - 'tsvgr_opacity', 15:53:12 INFO - 'tart', 15:53:12 INFO - 'tscrollx', 15:53:12 INFO - 'cart']}, 15:53:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:12 INFO - 'tsvgr_opacity', 15:53:12 INFO - 'tart', 15:53:12 INFO - 'tscrollx', 15:53:12 INFO - 'cart']}, 15:53:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'talos_options': ['--disable-e10s'], 15:53:12 INFO - 'tests': ['tp5o']}, 15:53:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'tests': ['tp5o']}, 15:53:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'talos_options': ['--disable-e10s', 15:53:12 INFO - '--xperf_path', 15:53:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:12 INFO - 'tests': ['tp5n']}, 15:53:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:12 INFO - 'talos_options': ['--xperf_path', 15:53:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:12 INFO - 'tests': ['tp5n']}}, 15:53:12 INFO - 'talos.zip': {'path': '', 15:53:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:12 INFO - Running post-action listener: _resource_record_post_action 15:53:12 INFO - ##### 15:53:12 INFO - ##### Finished populate-webroot step (success) 15:53:12 INFO - ##### 15:53:12 INFO - ##### 15:53:12 INFO - ##### Running create-virtualenv step. 15:53:12 INFO - ##### 15:53:12 INFO - Running pre-action listener: _resource_record_pre_action 15:53:12 INFO - Running main action method: create_virtualenv 15:53:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:12 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 15:53:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:12 INFO - Using real prefix '/usr' 15:53:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:14 INFO - Installing pip.................done. 15:53:14 INFO - Return code: 0 15:53:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15: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', 'pip>=1.5'] in /builds/slave/test/build 15: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 pip>=1.5 15:53:14 INFO - Using env: {'DISPLAY': ':0', 15:53:14 INFO - 'HOME': '/home/cltbld', 15:53:14 INFO - 'LANG': 'en_US.UTF-8', 15:53:14 INFO - 'LANGUAGE': 'en_US:en', 15:53:14 INFO - 'LOGNAME': 'cltbld', 15:53:14 INFO - 'MAIL': '/var/mail/cltbld', 15:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:14 INFO - 'MOZ_NO_REMOTE': '1', 15:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:14 INFO - 'NO_EM_RESTART': '1', 15:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:14 INFO - 'PWD': '/builds/slave/test', 15:53:14 INFO - 'SHELL': '/bin/bash', 15:53:14 INFO - 'SHLVL': '1', 15:53:14 INFO - 'TERM': 'linux', 15:53:14 INFO - 'TMOUT': '86400', 15:53:14 INFO - 'USER': 'cltbld', 15:53:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:14 INFO - '_': '/tools/buildbot/bin/python'} 15:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:14 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 15:53:14 INFO - Cleaning up... 15:53:14 INFO - Return code: 0 15:53:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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', '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 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15: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 psutil>=3.1.1 15:53:14 INFO - Using env: {'DISPLAY': ':0', 15:53:14 INFO - 'HOME': '/home/cltbld', 15:53:14 INFO - 'LANG': 'en_US.UTF-8', 15:53:14 INFO - 'LANGUAGE': 'en_US:en', 15:53:14 INFO - 'LOGNAME': 'cltbld', 15:53:14 INFO - 'MAIL': '/var/mail/cltbld', 15:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:14 INFO - 'MOZ_NO_REMOTE': '1', 15:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:14 INFO - 'NO_EM_RESTART': '1', 15:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:14 INFO - 'PWD': '/builds/slave/test', 15:53:14 INFO - 'SHELL': '/bin/bash', 15:53:14 INFO - 'SHLVL': '1', 15:53:14 INFO - 'TERM': 'linux', 15:53:14 INFO - 'TMOUT': '86400', 15:53:14 INFO - 'USER': 'cltbld', 15:53:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:14 INFO - '_': '/tools/buildbot/bin/python'} 15:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:15 INFO - Downloading/unpacking psutil>=3.1.1 15:53:15 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 15:53:15 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 15:53:15 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 15:53:15 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 15:53:15 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 15:53:15 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 15:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:17 INFO - Installing collected packages: psutil 15:53:17 INFO - Running setup.py install for psutil 15:53:17 INFO - building 'psutil._psutil_linux' extension 15:53:17 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 15:53:17 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 15:53:17 INFO - building 'psutil._psutil_posix' extension 15:53:17 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 15:53:17 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 15:53:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:17 INFO - Successfully installed psutil 15:53:17 INFO - Cleaning up... 15:53:17 INFO - Return code: 0 15:53:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:53:17 INFO - Using env: {'DISPLAY': ':0', 15:53:17 INFO - 'HOME': '/home/cltbld', 15:53:17 INFO - 'LANG': 'en_US.UTF-8', 15:53:17 INFO - 'LANGUAGE': 'en_US:en', 15:53:17 INFO - 'LOGNAME': 'cltbld', 15:53:17 INFO - 'MAIL': '/var/mail/cltbld', 15:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:17 INFO - 'MOZ_NO_REMOTE': '1', 15:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:17 INFO - 'NO_EM_RESTART': '1', 15:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:17 INFO - 'PWD': '/builds/slave/test', 15:53:17 INFO - 'SHELL': '/bin/bash', 15:53:17 INFO - 'SHLVL': '1', 15:53:17 INFO - 'TERM': 'linux', 15:53:17 INFO - 'TMOUT': '86400', 15:53:17 INFO - 'USER': 'cltbld', 15:53:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:17 INFO - '_': '/tools/buildbot/bin/python'} 15:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:19 INFO - Installing collected packages: mozsystemmonitor 15:53:19 INFO - Running setup.py install for mozsystemmonitor 15:53:20 INFO - Successfully installed mozsystemmonitor 15:53:20 INFO - Cleaning up... 15:53:20 INFO - Return code: 0 15:53:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:20 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')]} 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:20 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')]} 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:20 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 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:20 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 15:53:20 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 15:53:20 INFO - Using env: {'DISPLAY': ':0', 15:53:20 INFO - 'HOME': '/home/cltbld', 15:53:20 INFO - 'LANG': 'en_US.UTF-8', 15:53:20 INFO - 'LANGUAGE': 'en_US:en', 15:53:20 INFO - 'LOGNAME': 'cltbld', 15:53:20 INFO - 'MAIL': '/var/mail/cltbld', 15:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:20 INFO - 'MOZ_NO_REMOTE': '1', 15:53:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:20 INFO - 'NO_EM_RESTART': '1', 15:53:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:20 INFO - 'PWD': '/builds/slave/test', 15:53:20 INFO - 'SHELL': '/bin/bash', 15:53:20 INFO - 'SHLVL': '1', 15:53:20 INFO - 'TERM': 'linux', 15:53:20 INFO - 'TMOUT': '86400', 15:53:20 INFO - 'USER': 'cltbld', 15:53:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:20 INFO - '_': '/tools/buildbot/bin/python'} 15:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:20 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15: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 15: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 15: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 15: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 15: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 15: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 15:53:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:22 INFO - warning: no files found matching '*.txt' 15:53:22 INFO - no previously-included directories found matching 'build' 15:53:22 INFO - no previously-included directories found matching 'dist' 15:53:22 INFO - no previously-included directories found matching '.git*' 15:53:22 INFO - Installing collected packages: jsonschema, functools32 15:53:22 INFO - Running setup.py install for functools32 15:53:22 INFO - warning: no files found matching '*.txt' 15:53:22 INFO - no previously-included directories found matching 'build' 15:53:22 INFO - no previously-included directories found matching 'dist' 15:53:22 INFO - no previously-included directories found matching '.git*' 15:53:22 INFO - Successfully installed jsonschema functools32 15:53:22 INFO - Cleaning up... 15:53:22 INFO - Return code: 0 15:53:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:22 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')]} 15:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:22 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')]} 15:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:22 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 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:22 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 15:53:22 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 15:53:22 INFO - Using env: {'DISPLAY': ':0', 15:53:22 INFO - 'HOME': '/home/cltbld', 15:53:22 INFO - 'LANG': 'en_US.UTF-8', 15:53:22 INFO - 'LANGUAGE': 'en_US:en', 15:53:22 INFO - 'LOGNAME': 'cltbld', 15:53:22 INFO - 'MAIL': '/var/mail/cltbld', 15:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:22 INFO - 'MOZ_NO_REMOTE': '1', 15:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:22 INFO - 'NO_EM_RESTART': '1', 15:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:22 INFO - 'PWD': '/builds/slave/test', 15:53:22 INFO - 'SHELL': '/bin/bash', 15:53:22 INFO - 'SHLVL': '1', 15:53:22 INFO - 'TERM': 'linux', 15:53:22 INFO - 'TMOUT': '86400', 15:53:22 INFO - 'USER': 'cltbld', 15:53:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:22 INFO - '_': '/tools/buildbot/bin/python'} 15:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:22 INFO - Downloading/unpacking blobuploader==1.2.4 15: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 15: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 15: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 15: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 15: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 15: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 15:53:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:25 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 15:53:25 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 15:53:25 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 15:53:25 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 15:53:25 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 15:53:25 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 15:53:25 INFO - Downloading docopt-0.6.1.tar.gz 15:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:25 INFO - Running setup.py install for blobuploader 15:53:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:25 INFO - Running setup.py install for requests 15:53:26 INFO - Running setup.py install for docopt 15:53:26 INFO - Successfully installed blobuploader requests docopt 15:53:26 INFO - Cleaning up... 15:53:26 INFO - Return code: 0 15:53:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:26 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 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:26 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 15:53:26 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 15:53:26 INFO - Using env: {'DISPLAY': ':0', 15:53:26 INFO - 'HOME': '/home/cltbld', 15:53:26 INFO - 'LANG': 'en_US.UTF-8', 15:53:26 INFO - 'LANGUAGE': 'en_US:en', 15:53:26 INFO - 'LOGNAME': 'cltbld', 15:53:26 INFO - 'MAIL': '/var/mail/cltbld', 15:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:26 INFO - 'MOZ_NO_REMOTE': '1', 15:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:26 INFO - 'NO_EM_RESTART': '1', 15:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:26 INFO - 'PWD': '/builds/slave/test', 15:53:26 INFO - 'SHELL': '/bin/bash', 15:53:26 INFO - 'SHLVL': '1', 15:53:26 INFO - 'TERM': 'linux', 15:53:26 INFO - 'TMOUT': '86400', 15:53:26 INFO - 'USER': 'cltbld', 15:53:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:26 INFO - '_': '/tools/buildbot/bin/python'} 15:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:26 INFO - Running setup.py (path:/tmp/pip-emzhuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:26 INFO - Running setup.py (path:/tmp/pip-8N7q7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:26 INFO - Running setup.py (path:/tmp/pip-Nemiag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:26 INFO - Running setup.py (path:/tmp/pip-2QRMie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:26 INFO - Running setup.py (path:/tmp/pip-6fZU3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:26 INFO - Running setup.py (path:/tmp/pip-yTr6n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:26 INFO - Running setup.py (path:/tmp/pip-Dzw_p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:26 INFO - Running setup.py (path:/tmp/pip-ym7qVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:26 INFO - Running setup.py (path:/tmp/pip-LaR63N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:27 INFO - Running setup.py (path:/tmp/pip-UGGIuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:27 INFO - Running setup.py (path:/tmp/pip-WPnTE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:27 INFO - Running setup.py (path:/tmp/pip-m2w_WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:27 INFO - Running setup.py (path:/tmp/pip-mkx96I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:27 INFO - Running setup.py (path:/tmp/pip-4nipip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:27 INFO - Running setup.py (path:/tmp/pip-BWB1Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:27 INFO - Running setup.py (path:/tmp/pip-hJKzd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:27 INFO - Running setup.py (path:/tmp/pip-PrfMjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:27 INFO - Running setup.py install for manifestparser 15:53:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:27 INFO - Running setup.py install for mozcrash 15:53:27 INFO - Running setup.py install for mozdebug 15:53:27 INFO - Running setup.py install for mozdevice 15:53:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for mozfile 15:53:28 INFO - Running setup.py install for mozhttpd 15:53:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for mozinfo 15:53:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for mozInstall 15:53:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for mozleak 15:53:28 INFO - Running setup.py install for mozlog 15:53:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for moznetwork 15:53:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for mozprocess 15:53:28 INFO - Running setup.py install for mozprofile 15:53:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for mozrunner 15:53:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Running setup.py install for mozscreenshot 15:53:29 INFO - Running setup.py install for moztest 15:53:29 INFO - Running setup.py install for mozversion 15:53:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:29 INFO - Cleaning up... 15:53:29 INFO - Return code: 0 15:53:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:29 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 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:29 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 15:53:29 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 15:53:29 INFO - Using env: {'DISPLAY': ':0', 15:53:29 INFO - 'HOME': '/home/cltbld', 15:53:29 INFO - 'LANG': 'en_US.UTF-8', 15:53:29 INFO - 'LANGUAGE': 'en_US:en', 15:53:29 INFO - 'LOGNAME': 'cltbld', 15:53:29 INFO - 'MAIL': '/var/mail/cltbld', 15:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:29 INFO - 'MOZ_NO_REMOTE': '1', 15:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:29 INFO - 'NO_EM_RESTART': '1', 15:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:29 INFO - 'PWD': '/builds/slave/test', 15:53:29 INFO - 'SHELL': '/bin/bash', 15:53:29 INFO - 'SHLVL': '1', 15:53:29 INFO - 'TERM': 'linux', 15:53:29 INFO - 'TMOUT': '86400', 15:53:29 INFO - 'USER': 'cltbld', 15:53:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:29 INFO - '_': '/tools/buildbot/bin/python'} 15:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:29 INFO - Running setup.py (path:/tmp/pip-faczkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:29 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)) 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:29 INFO - Running setup.py (path:/tmp/pip-mVfaUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:29 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)) 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:29 INFO - Running setup.py (path:/tmp/pip-nuJTbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:29 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)) 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:29 INFO - Running setup.py (path:/tmp/pip-Vi2KoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:29 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)) 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:29 INFO - Running setup.py (path:/tmp/pip-7gd0bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:30 INFO - Running setup.py (path:/tmp/pip-Z9IWSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:30 INFO - Running setup.py (path:/tmp/pip-gJZJzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:30 INFO - Running setup.py (path:/tmp/pip-dTcoGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:30 INFO - Running setup.py (path:/tmp/pip-06VbvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:30 INFO - Running setup.py (path:/tmp/pip-FawVGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:30 INFO - Running setup.py (path:/tmp/pip-PidcbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:30 INFO - Running setup.py (path:/tmp/pip-8JVMDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:30 INFO - Running setup.py (path:/tmp/pip-YkuCHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:30 INFO - Running setup.py (path:/tmp/pip-vx3dIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:30 INFO - Running setup.py (path:/tmp/pip-4SjbTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:30 INFO - Running setup.py (path:/tmp/pip-BKEExZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:30 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)) 15:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:30 INFO - Running setup.py (path:/tmp/pip-LLcolX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:30 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)) 15:53:30 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)) 15:53:30 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)) 15:53:30 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)) 15:53:30 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)) 15:53:30 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)) 15:53:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:30 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 15:53:30 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 15:53:30 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 15:53:30 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 15:53:30 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 15:53:30 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 15:53:32 INFO - Downloading blessings-1.6.tar.gz 15:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:32 INFO - Installing collected packages: blessings 15:53:32 INFO - Running setup.py install for blessings 15:53:32 INFO - Successfully installed blessings 15:53:32 INFO - Cleaning up... 15:53:33 INFO - Return code: 0 15:53:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:33 INFO - Reading from file tmpfile_stdout 15:53:33 INFO - Current package versions: 15:53:33 INFO - argparse == 1.2.1 15:53:33 INFO - blessings == 1.6 15:53:33 INFO - blobuploader == 1.2.4 15:53:33 INFO - docopt == 0.6.1 15:53:33 INFO - functools32 == 3.2.3-2 15:53:33 INFO - jsonschema == 2.5.1 15:53:33 INFO - manifestparser == 1.1 15:53:33 INFO - mozInstall == 1.12 15:53:33 INFO - mozcrash == 0.17 15:53:33 INFO - mozdebug == 0.1 15:53:33 INFO - mozdevice == 0.48 15:53:33 INFO - mozfile == 1.2 15:53:33 INFO - mozhttpd == 0.7 15:53:33 INFO - mozinfo == 0.9 15:53:33 INFO - mozleak == 0.1 15:53:33 INFO - mozlog == 3.2 15:53:33 INFO - moznetwork == 0.27 15:53:33 INFO - mozprocess == 0.23 15:53:33 INFO - mozprofile == 0.28 15:53:33 INFO - mozrunner == 6.12 15:53:33 INFO - mozscreenshot == 0.1 15:53:33 INFO - mozsystemmonitor == 0.3 15:53:33 INFO - moztest == 0.7 15:53:33 INFO - mozversion == 1.4 15:53:33 INFO - psutil == 3.1.1 15:53:33 INFO - requests == 1.2.3 15:53:33 INFO - wsgiref == 0.1.2 15:53:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:33 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 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:33 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 15:53:33 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 15:53:33 INFO - Using env: {'DISPLAY': ':0', 15:53:33 INFO - 'HOME': '/home/cltbld', 15:53:33 INFO - 'LANG': 'en_US.UTF-8', 15:53:33 INFO - 'LANGUAGE': 'en_US:en', 15:53:33 INFO - 'LOGNAME': 'cltbld', 15:53:33 INFO - 'MAIL': '/var/mail/cltbld', 15:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:33 INFO - 'MOZ_NO_REMOTE': '1', 15:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:33 INFO - 'NO_EM_RESTART': '1', 15:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:33 INFO - 'PWD': '/builds/slave/test', 15:53:33 INFO - 'SHELL': '/bin/bash', 15:53:33 INFO - 'SHLVL': '1', 15:53:33 INFO - 'TERM': 'linux', 15:53:33 INFO - 'TMOUT': '86400', 15:53:33 INFO - 'USER': 'cltbld', 15:53:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:33 INFO - '_': '/tools/buildbot/bin/python'} 15:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 INFO - Cleaning up... 15:53:33 INFO - Return code: 0 15:53:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:33 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 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:33 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 15:53:33 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 15:53:33 INFO - Using env: {'DISPLAY': ':0', 15:53:33 INFO - 'HOME': '/home/cltbld', 15:53:33 INFO - 'LANG': 'en_US.UTF-8', 15:53:33 INFO - 'LANGUAGE': 'en_US:en', 15:53:33 INFO - 'LOGNAME': 'cltbld', 15:53:33 INFO - 'MAIL': '/var/mail/cltbld', 15:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:33 INFO - 'MOZ_NO_REMOTE': '1', 15:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:33 INFO - 'NO_EM_RESTART': '1', 15:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:33 INFO - 'PWD': '/builds/slave/test', 15:53:33 INFO - 'SHELL': '/bin/bash', 15:53:33 INFO - 'SHLVL': '1', 15:53:33 INFO - 'TERM': 'linux', 15:53:33 INFO - 'TMOUT': '86400', 15:53:33 INFO - 'USER': 'cltbld', 15:53:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:33 INFO - '_': '/tools/buildbot/bin/python'} 15:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:33 INFO - Cleaning up... 15:53:33 INFO - Return code: 0 15:53:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a4b28af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', '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 15:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:53:33 INFO - Using env: {'DISPLAY': ':0', 15:53:33 INFO - 'HOME': '/home/cltbld', 15:53:33 INFO - 'LANG': 'en_US.UTF-8', 15:53:33 INFO - 'LANGUAGE': 'en_US:en', 15:53:33 INFO - 'LOGNAME': 'cltbld', 15:53:33 INFO - 'MAIL': '/var/mail/cltbld', 15:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:33 INFO - 'MOZ_NO_REMOTE': '1', 15:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:33 INFO - 'NO_EM_RESTART': '1', 15:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:33 INFO - 'PWD': '/builds/slave/test', 15:53:33 INFO - 'SHELL': '/bin/bash', 15:53:33 INFO - 'SHLVL': '1', 15:53:33 INFO - 'TERM': 'linux', 15:53:33 INFO - 'TMOUT': '86400', 15:53:33 INFO - 'USER': 'cltbld', 15:53:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:33 INFO - '_': '/tools/buildbot/bin/python'} 15:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:33 INFO - Downloading/unpacking flake8 15:53:33 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 15:53:33 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 15:53:33 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 15:53:33 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 15:53:33 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 15:53:33 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 15:53:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:53:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:53:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:53:36 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 15:53:36 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 15:53:36 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 15:53:36 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 15:53:36 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 15:53:36 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 15:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:53:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:36 INFO - no previously-included directories found matching 'docs/_build' 15:53:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:53:36 INFO - Running setup.py install for pep8 15:53:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:36 INFO - no previously-included directories found matching 'docs/_build' 15:53:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:53:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:53:36 INFO - Cleaning up... 15:53:36 INFO - Return code: 0 15:53:36 INFO - Running post-action listener: _resource_record_post_action 15:53:36 INFO - Running post-action listener: _start_resource_monitoring 15:53:36 INFO - Starting resource monitoring. 15:53:36 INFO - ##### 15:53:36 INFO - ##### Finished create-virtualenv step (success) 15:53:36 INFO - ##### 15:53:36 INFO - ##### 15:53:36 INFO - ##### Running install step. 15:53:36 INFO - ##### 15:53:36 INFO - Running pre-action listener: _resource_record_pre_action 15:53:36 INFO - Running main action method: install 15:53:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:37 INFO - Reading from file tmpfile_stdout 15:53:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:37 INFO - Reading from file tmpfile_stdout 15:53:37 INFO - Output received: 15:53:37 INFO - Usage: mozinstall [options] installer 15:53:37 INFO - Options: 15:53:37 INFO - -h, --help show this help message and exit 15:53:37 INFO - -d DEST, --destination=DEST 15:53:37 INFO - Directory to install application into. [default: 15:53:37 INFO - "/builds/slave/test"] 15:53:37 INFO - --app=APP Application being installed. [default: firefox] 15:53:37 INFO - mkdir: /builds/slave/test/build/application 15:53:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:53:53 INFO - Reading from file tmpfile_stdout 15:53:53 INFO - Output received: 15:53:53 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:53 INFO - Running post-action listener: _resource_record_post_action 15:53:53 INFO - ##### 15:53:53 INFO - ##### Finished install step (success) 15:53:53 INFO - ##### 15:53:53 INFO - ##### 15:53:53 INFO - ##### Running run-tests step. 15:53:53 INFO - ##### 15:53:53 INFO - Running pre-action listener: _resource_record_pre_action 15:53:53 INFO - Running main action method: run_tests 15:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:53 INFO - Python 2.7.3 15:53:53 INFO - Return code: 0 15:53:53 INFO - grabbing minidump binary from tooltool 15:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:53 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 0x26952e0>, '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 0x2601140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26015d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:53 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 15:53:53 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 15:53:53 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 15:53:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:53 INFO - Return code: 0 15:53:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:53:54 INFO - Return code: 0 15:53:54 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/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:53:54 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/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 15:53:54 INFO - Using env: {'DISPLAY': ':0', 15:53:54 INFO - 'HOME': '/home/cltbld', 15:53:54 INFO - 'LANG': 'en_US.UTF-8', 15:53:54 INFO - 'LANGUAGE': 'en_US:en', 15:53:54 INFO - 'LOGNAME': 'cltbld', 15:53:54 INFO - 'MAIL': '/var/mail/cltbld', 15:53:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:54 INFO - 'MOZ_NO_REMOTE': '1', 15:53:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:54 INFO - 'NO_EM_RESTART': '1', 15:53:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:54 INFO - 'PWD': '/builds/slave/test', 15:53:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:54 INFO - 'SHELL': '/bin/bash', 15:53:54 INFO - 'SHLVL': '1', 15:53:54 INFO - 'TERM': 'linux', 15:53:54 INFO - 'TMOUT': '86400', 15:53:54 INFO - 'USER': 'cltbld', 15:53:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887', 15:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:54 INFO - '_': '/tools/buildbot/bin/python'} 15:53:54 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/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:53:54 INFO - mozversion application_buildid: 20160727131625 15:53:54 INFO - mozversion application_changeset: f430f9a12c98a00bfb0edce37947614e0a2b83cc 15:53:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:53:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:54 INFO - mozversion application_name: Firefox 15:53:54 INFO - mozversion application_remotingname: firefox-dev 15:53:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:53:54 INFO - mozversion application_vendor: Mozilla 15:53:54 INFO - mozversion application_version: 49.0a2 15:53:54 INFO - mozversion platform_buildid: 20160727131625 15:53:54 INFO - mozversion platform_changeset: f430f9a12c98a00bfb0edce37947614e0a2b83cc 15:53:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:53:54 INFO - mozversion platform_version: 49.0a2 15:53:54 INFO - using testdate: 1469660034 15:53:54 INFO - actual date: 1469660034 15:53:54 INFO - starting webserver on 'localhost:33316' 15:53:54 INFO - SUITE-START | Running 2 tests 15:53:54 INFO - TEST-START | dromaeo_css 15:53:54 INFO - operating with platform_type : linux_ 15:53:54 INFO - Initialising browser for dromaeo_css test... 15:53:54 INFO - TEST-INFO | started process 3251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppW1Omv/profile http://localhost:33316/getInfo.html) 15:53:58 INFO - PROCESS | 3251 | __metrics Screen width/height:1600/1200 15:53:58 INFO - PROCESS | 3251 | colorDepth:24 15:53:58 INFO - PROCESS | 3251 | Browser inner width/height: 1024/697 15:53:58 INFO - PROCESS | 3251 | __metrics 15:53:59 INFO - PROCESS | 3251 | 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" 15:53:59 ERROR - PROCESS | 3251 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:54:00 INFO - TEST-INFO | 3251: exit 0 15:54:00 INFO - Browser initialized. 15:54:00 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:00 INFO - TEST-INFO | started process 3343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppW1Omv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:11 INFO - PROCESS | 3343 | RSS: Main: 145506304 15:54:11 INFO - PROCESS | 3343 | 15:55:03 INFO - PROCESS | 3343 | 1469660103174 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] 15:57:11 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:33316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33316/tests/dromaeo/cssquery-ext.html) 15:57:12 INFO - PROCESS | 3343 | RSS: Main: 257290240 15:57:12 INFO - PROCESS | 3343 | 16:00:14 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:33316/tests/dromaeo/cssquery-ext.html (next: http://localhost:33316/tests/dromaeo/cssquery-jquery.html) 16:00:15 INFO - PROCESS | 3343 | RSS: Main: 225341440 16:00:15 INFO - PROCESS | 3343 | 16:03:17 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:33316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33316/tests/dromaeo/cssquery-mootools.html) 16:03:17 INFO - PROCESS | 3343 | RSS: Main: 219963392 16:03:17 INFO - PROCESS | 3343 | 16:06:19 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:33316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33316/tests/dromaeo/cssquery-prototype.html) 16:06:20 INFO - PROCESS | 3343 | RSS: Main: 220286976 16:06:20 INFO - PROCESS | 3343 | 16:09:22 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:33316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33316/tests/dromaeo/cssquery-yui.html) 16:09:23 INFO - PROCESS | 3343 | RSS: Main: 215949312 16:09:23 INFO - PROCESS | 3343 | 16:12:25 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:33316/tests/dromaeo/cssquery-yui.html (next: http://localhost:33316/tests/dromaeo/cssquery-dojo.html) 16:12:26 INFO - PROCESS | 3343 | RSS: Main: 255270912 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | __start_tp_report 16:12:26 INFO - PROCESS | 3343 | _x_x_mozilla_page_load 16:12:26 INFO - PROCESS | 3343 | _x_x_mozilla_page_load_details 16:12:26 INFO - PROCESS | 3343 | |i|pagename|runs| 16:12:26 INFO - PROCESS | 3343 | |0;dojo.html;3338.5492958450604;3340.0814775936624;3358.613759417666;3374.7806392584494;3404.931901361973;5479.863003424912;5579.776808927643;5580.107182850745;5583.832485025446;5592.804251851186;5507.586930980173;5569.303837020372;5581.190727344532;5581.832545023656;5614.9438505614935;4933.161362568354;4973.6518443708865;5028.069807085682;5059.342285502879;5106.4382917879;4880.829170979016;5014.623903207255;5051.797928082872;5059.367579052619;5070.391553013644;5003.974980125095;5035;5055.494450554952;5076.568491678212;5084.491550844905;5155.767990440401;5179.326687530634;5179.715115668637;5180.04169228692;5197.116490196676;4896.730679812609;4914.852554423373;4954.43024052235;5072.492750724935;5101.948980510185;5404.5676345892625;5406.270153529302;5452.672839629635;5455.781768729246;5465.480779325958;6027.487663548603;6035.034394496859;6037.426444487811;6041.546883983675;6041.607295525777;5919.1417244499735;5955.553333500005;5960.135780311831;6015.939840601625;6067.998780201261;5599.888002239933;5608.551315894719;5643.463870932255;5648.999999999959;5652.74562644682;5980.461758441761;6123.835112917808;6126.081087836771;6130.807181375102;6132.50939924805;5813.04084825999;5836.88326233473;5847.035239185487;5938.317093534299;5950.8809823803285;6003.519718422515;6005.249343832021;6014;6033.879322413527;6038.516918646497;5727.713614319267;5908.025175845937;5978.342382337939;5993.640381577032;5997.910031349533;5953.166556682068;6035.185249991195;6042.305134909454;6042.395760423922;6079.148919151322;4613;4624.398828152319;4625.375574297427;4630.236011058205;4650.116477869194;4010.21800748857;4032.213718324957;4044.4135600338373;4113.568075352105;4136.772477513706;5611.80358687444;5629.943700563023;5631.211630371751;5633.63381380209;5642.125470552071;5949.286085669747;5952.613080149777;5958.731857066442;5962.493188079062;5971.134185543072;5427.6472029317965;5587.27365442498;5599.216109744639;5610.523105535994;5720.485156335866;5125.538701516882;5156.278121063054;5156.871078223075;5158.432572417031;5162.45794191612;6127.754889804358;6254.343293954069;6265.686715664198;6268.059791031382;6281.214848143982;5905.734241959208;5961.493273071837;5964.105384192406;6008.279006519246;6010.699465026819;6268.942415058172;6294.4964402846745;6298.496120310456;6300.338464461165;6307.400796924285;5702.201691763239;5860.765569377178;5907.3797251288;5914.704264786657;5953.345132035559;5935.109733540004;6013.909791353046;6049.425304596057;6053.4551890330085;6093.512518998381;5867.647941123546;5896.410358964069;5911.733971971185;5915.201447804491;5921.5854890159;5670.943290567042;5724.771009159587;5735.971320143372;5846.356900741001;5896;5672.659640421588;5687.516561092353;5694.544436444991;5694.800681976277;5717.885642287214;5814.186013957965;5818.883622327445;5859.179714839841;5868.589198756046;5875.353711091862;5604.775808967595;5672.5745569081655;5689.573282003784;5736.311642602747;5764.913526297193 16:12:26 INFO - PROCESS | 3343 | |1;ext.html;600.7206648908259;645.6094063091829;646.1503123392738;657.1818086482328;666.4967949198355;34090.14774630632;45814.54185458145;47460.288095678596;47487.287690684665;47494.2875856862;49472;49572.50427495733;50008.749956250256;50013;50021.24968125472;8404.453710508827;9149.130832570896;9286.860697089516;9295.674651387202;9319.068093190694;11025.283356581836;11266.774664506705;11326.20716549842;11332.093432525378;11677.357745324003;10985.340879547213;11103.333799971988;11428.257163284401;11440.71398215043;11446.713832154179;8487.618057187441;11032.22774405792;11257.324560526353;11335.206535542515;11367.033802126829;10989.725256868562;11028.724281892937;11079.778404431947;11081.72295692606;11096.05683516902;46145;46297.30554041692;46519;46625.76687116577;46765.29852052222;3663.157473781019;3734.533183352081;3764.247150569897;3837.501124853779;4174;35632.821835890914;36187.27625447476;36480.452793208126;36655.633443665756;36940.63059369399;4745.69153005057;4756.476787553401;4760.6429517785955;4871.14754917888;4966.776495057695;387807;392253;392801;392820.99999999715;393616;39074.21851562953;40222;70739.2926070743;71427;71544.28455715481;41711;41820.16359672789;41957.79021104936;41970.37044444336;41971.790141049096;17829.7325540117;17992.820071799113;18013.7297940531;18014.5496362592;18018.90990545065;13473.865261347457;14761.40954361835;14934.103953762591;15235.466758663393;15237.542873713806;9275.72172834816;9291.581878815334;9300.627974881065;9361;9361.672341468153;3551.3252482028847;3565.2156525564333;3592.1378869071236;3612.7471077024356;3665.52348194733;1060.3372891942536;1148.1733152130619;1148.592249751343;1238.158052524292;1242.8570714367784;35038;35149.64850351515;35388.469172962425;35683.12902855963;35871.82064089715;1188.2098404561043;1192.773373059116;1224.5407972010496;1233.747081848219;1267.6830792301926;18171.72742408865;18534.629307413776;18578.628427431377;18599.628007440046;18833.34083307105;581710;643224;654744;655431;1023691;66779.33220667829;67277;67454.66272668606;67499;67597.66201169061;1358.341204515809;1466.552701426054;1502.5942995391401;1525.80927384077;1542.8225754038206;34108.31783364269;35619.10952226215;35696;36809.447858282685;36924.630753692116;56762;57359.426405737075;57572.424275758385;57649.423505764404;57669.711651443155;461604;466045;466362;466434;467746;31049.223769405944;31904.564294606334;32134.839325803223;32232.516512252805;32436.189095272806;51947.48052519427;53415;54033.18950215671;54412.72793636007;54727;44665;44692.77653611711;44891.42788777938;45120.32319515144;45634.54365456436;43865;44352;44525.33212001887;44560.77719611511;45401.772991134836;44307.33538996982;45515.31727024031;45530;45689.543104568525;46157;38670.419943700304;39128.608713913636;39439.60560394359;39534.40698389584;40393;29980.250493737833;30149.849250753607;30281.848590756905;30301.393972119993;30570.541441877944 16:12:26 INFO - PROCESS | 3343 | |2;jquery.html;407.65756764317985;410.79254976236996;413.243763912041;418.62323908482364;433.73542139295023;17774.64450710985;19096.140673669684;19446.222151113958;19454.416367508962;19775.307864224756;19045.7143142853;19407.32074377397;19840.40478785635;19917.90041049793;19956;5320.255164277004;5906.852328691795;5917.437843404869;5923.111533270023;5929.051351783715;5611.971940140294;5739.827805165831;5801.622894511865;5801.7389217485315;5803.129530570406;5769.278840144982;5794.043982742843;5796.333421656522;5802.53579713624;5804.361520232771;5583.274174357308;5752.856178595527;5782.710864456761;5790.102534107199;5832.766689332421;5241.004209200278;5252.212168174766;5271.262023316739;5275.657082289639;5277.261183434322;22521.887390563104;23379.649305260435;24172.39569010771;24211.7578824213;24464.26607201769;2288.6681431192383;2452.8773561321864;2476.6656501372445;2504.373906523369;2587.9648140743666;15017.399304027826;15147.394104235816;15256.38974441021;15527.146006969611;15600.843991560052;1914.818092281231;2002.1914533320023;2018.0817727933902;2021.888796116213;2085.7392825896763;79017;79454.60272698657;79772;80317.59841200816;81154.59422702849;10919.617813376653;11014.284071535325;11203.943980280046;11279.266847654877;11452.427378631035;15930.92034539843;15966.36134554628;16012.119333436773;16033.919830401006;16041.59896002586;8644.438111522732;9016.143466370684;9022.323325750594;9138.954305228564;9156.084391560791;8574.271186949054;8705;8716.651333946698;8814.955925220333;8850.159234872677;7024.1571011478945;7157.141143062761;7173.6413179340825;7187.712491500281;7199.2080871104135;1797.173300281885;1958.2460752610348;1986.7284937639922;2010.6179825833044;2037.113855472874;890.3055616619048;1057.7937302225992;1130.5308297056795;1135.8239472881717;1197.3474456421272;19341.51646208856;20231.696524552142;20281.188752449736;20290;20328;1065.2862582070031;1092.6066616018227;1112.7285779807341;1123.017359810166;1153.4982282707049;11392.25950313227;11538.423078846025;11641.301521908712;11765.176437649283;11860.822087668692;399208;475486;519682;528658;537758;60418;63583.68208158929;78881;104331;107036.46481767541;1067.77576708892;1070.8554345163304;1086.6577028236081;1108.9944550277196;1119.2948442481186;18253.45239642813;18340.44978650589;18566.721499177795;18695.158717857455;18821.811781882006;43448.56551434445;44185;44252.77873610611;44425.11149776922;45394.31908521441;61496.69251653713;62263.22104016028;62705.49178032827;62731.37268627255;62979;8853.73438796837;8863.290936725176;9008.369414140947;9043.864342034743;9175.31185161129;9930.503474826375;13437.664058398619;13441.663958400726;13625.182489050689;14001.089929154572;11687.539057617798;11712.355820429959;11816.40917954116;11903;12251.08116891219;11766.705832354259;11882.881171188177;12004.797121727242;12108;12317.44571494267;11654.125940554322;11908.940455297668;11963.624183218693;12042.337671427806;12191.451384687532;8521.403501754818;8579.442336248125;8703.303735701254;8738.25724813398;8871.379003469696;10789.824246896229;11902.821457677968;11905.761884762429;11924.761504769682;12155.57455489089 16:12:26 INFO - PROCESS | 3343 | |3;mootools.html;1408.7745960646298;1611.6132128289214;1617.4824056301982;1858.6004009138032;1984.1468168687468;8387.664493420263;9308.674196403128;9505.80988380232;9525.857112143314;9860.654877079303;9525.618975240983;9686.70939871805;9691.660791872286;9692.66075687351;9692.66075687351;2475.7524247575234;2499.8125140614434;2499.9250022499355;2502.5745623244093;2503.4492411669403;2427.3810178404483;2476;2480.4419005723657;2482.888270027853;2483.081259933827;2394.1859767678984;2427.0655797517993;2473.5794914864427;2475.121331927167;2478.467129567143;2373.3829204406807;2385.71371435428;2399.3521749127726;2436.2569416328015;2437.8659173745436;2353.51752890657;2393.0308225168833;2410.8794560271917;2417.3231495181203;2419.27421773469;8963.417377870417;9517.143457088896;9598.472084035375;9601.327907046509;9609;5446.591505637093;5598.2442370280305;5600.1599760035915;5616.831495055155;5616.859578510529;3571.982140089283;3596.4425514045365;3630.8729194478065;3635.1457407509215;3684.207895302496;1133.2747041893194;1135.9318440893574;1139.5327915554583;1150.4592841364629;1158.206628459508;13847.792283115761;13976.790348144787;13998.860011399858;14029.158250504901;14071.859281407158;4740.312654665055;4745.217039188564;4815.446223684251;4847.781849816696;4857.149998750205;10415.218858585486;10445.216608754221;10455.059044686015;10456.477176141163;10466.058054775107;5594.412586678422;5597.468240517144;5598.692071936001;5600.831975040755;5602.859928501739;4466.39703640011;4552.226121559343;4682.765861706901;4987.376577927759;5192.714400707997;4095.7747323896874;4143.544210136883;4159.91680166395;4164.8334066637;4293.971101145989;1096.2107282756403;1151.8560179977503;1152.7002979225294;1163.8952494275557;1168.480026388266;1004.9799004019878;1022.325265324882;1037.408677054087;1039;1039.9808187975675;6603.471722262208;6610.933890661128;6657.866842663119;6708;6738.898916516257;442.9069895321954;447.83653966302063;449.2049073140588;452.579101435668;458.43154488434766;4577.404937358188;4648.7443190624845;4651.697639653412;4655.371524844103;4786.0667169902235;12093.939530302468;12175.208611440228;12565.560205392767;12599;12608;12314.445849936774;12409.131360804657;12477.625671229696;12486.625401237796;12500.812487812691;8980.550972451481;9343.486108263975;9343.766405839908;9345.252379809599;9346;6437.227532696106;6463.224413070274;6463.547551671338;6487.837804054936;6539.313372095861;11183.72040698989;11191.2725672831;11365.204435689753;11455.65633030977;11473.713157171138;11479.139064570023;11636.534538618698;11667.766644667228;11738.94130529342;11843;7014.68433920485;7236.674349654383;7340.889886651811;7542.924570754222;7570.05374328209;9460.148586627236;9518.476483793182;9531.475768832503;9569.3779904306;9606.183474404754;8136.308413784895;8343.833123337377;8689.044205137556;8694.17405346491;8755.343349248958;8140.389470789833;8180.590970451334;8257.133001034805;8328.042275138194;8341.749747507585;7510.737124200846;7533.39732821362;7558.659860306409;7576.659050342858;7594.202608726005;5362.981033603603;5432.864178395572;5542.889142217214;5555.138953462219;5592.552595792408;5506.752196151263;5571;5659.349174844946;5673.149027645886;5691.288588926384 16:12:26 INFO - PROCESS | 3343 | |4;prototype.html;351.89443167049876;352.6244549554724;354.47537644286456;357.9726185846621;358.0761634981747;5412.891742165154;5428.511433970942;5438.15708565172;5467.535259502937;5479.506844384005;5345;5378.731063446822;5385.138377859544;5399;5418.647787893794;3873.6707379872605;4092.5266903914567;4315.956840431602;4324.178406102847;4335.6748243881675;4261.126469073833;4287.20686672965;4289.356596510517;4327.502337231227;4335.739855608658;4088.5690008497086;4275.102228532012;4285.44289242398;4285.849995250167;4305.870823875289;4192.379762648345;4214.641755450791;4278.080212754242;4285.742855428669;4296.312589985588;3788.204477059821;3799.2401519696173;3817.0075780297043;3840.2127563849344;3871.5547712012917;5117.385913690344;5228.032813929397;5266.683998960075;5266.7629956652045;5271.86820329491;4862.41651001882;4875.219964805614;4883.095592718842;4890.926636100461;4923.030787684919;5612.663240205601;5636.351819540723;5637.8590535236535;5641.435856414367;5656.236408084938;4199.643030342425;4210.200061988213;4235.1529694061;4253.085586598865;4259.16946195492;5552.305961754781;5562.221289019541;5727.369989301132;5906.468417842372;5929.644221346733;4202.85290014848;4213.662906967435;4245.195791788477;4259.148170365939;4268.466441694788;4294.36814010674;4300.075483770942;4316.892077698019;4316.935245971313;4317.158154159909;4608.147492713859;4865.83220027191;4879.4876537963;4886.413630364308;4922.72924989129;5686.175504551899;5690.430956904276;5692.800751973661;5736.483716465455;5739.397363276796;1455.5415044261024;1466.889983251239;1468.6635162002526;1469.5958611381955;1475.4172102019643;928.6888892221182;936.3492372800838;941.4868896451451;958.5782255807422;973.73709098543;4940.950590494121;4970.627202959792;5006.122703986005;5034.823781167642;5045.41977672565;5146.25379320004;5154.768035438415;5185.818496352609;5214.227162764678;5246.868828279324;4973.4085092769965;4984.526469985418;5042.873928151826;5265.3944796348915;5715.9997000524745;3108.3161704424992;3115.5326700995033;3154.6056742907135;3154.7160755531654;3168.7781855270373;6033.426824451758;6107.908381374283;6125.203723516003;6137.570370074052;6169.629822210682;5685.289338832646;6002;6028.879422411527;6052.364501727343;6059.515238780887;6179.598326108879;6182.474489668339;6200.255969283715;6245.750169993331;6248.812725582125;5618.410066942912;5912.551424900755;5919.31927828288;5958.1658567801405;5986.191864098291;5780.219670344618;5834.824955251349;5839.364977806221;5846.239988801599;5846.327672317738;5890.175375447355;5911.467967882912;6207.479167603966;6258.280297765815;6258.499320054476;4006.49756341372;4071.572484889044;4079.0618157823274;4102.179564087135;4120.866761640573;5798.652080875161;5918.970405147947;5924.229850119629;5974.641521508724;5981.7607295707685;5656.490915817596;5713.400092990176;5736.225609542658;5796.478316951495;5804.970975145097;5673;5685.943140568541;5696.715164241688;5718.51392631631;5727.971360143172;5382.865428364322;5548.861278468071;5616.017196990429;5626.943730562642;5628.380878103487;5769.68266745333;5789.189513468202;5851.268591426072;5861.472467477947;5891.38140495259;5474.8905021898545;5739.757037274094;5740.483356497935;5771.7979870706;5794.7682092717505 16:12:26 INFO - PROCESS | 3343 | |5;yui.html;695.391532409142;747.4842358772447;777.1024466740913;791.0072858562502;829.7635173975418;15115.395384184632;15263.923680381611;15403.614909627266;15587.298571564279;15878.444254451082;13629.522966696168;13698.589042328722;13728.244946527937;13729.725405491885;13732.176069435816;731.7841236835146;864.0927026622053;887.3965703321722;896.9103089691044;905.5608030105394;887.201518633232;891.1979218703186;893.2675206330812;893.9463632182058;894.1192924968933;942.8679984802098;945.4469135555673;946.7491114854569;946.7964387656652;947.6114792934898;755.9395248380143;891.3671293381707;921.2491819167357;921.3826736086838;927.3137877970254;678.2268214235775;681.0839420978775;682.3585829320473;683.1767719897512;683.4498228925713;15237.238138093162;15250.23748812555;15284.617884552865;15285;15292.770608440882;14789.40842366304;14817.259137043106;15029.924850375788;15097;15183.62040948974;12023.63929082129;12045.759084818343;12213.389330533439;12215.511379544807;12255.69360765979;4410.426644536222;4540.772961351952;4574.931376029363;4601.4248218972625;4675.18184317743;78039;78772.60613696894;79007;79592.60203699002;79598.60200699017;11907.464164112636;11937.641870743892;11962.58130965412;11991.400429978466;12010.099242556844;23130.7686923132;23134.42163945915;23138.074477021066;23165.76834231636;23174.304770856903;8548.316134709208;8582.957085214533;8645.524496152771;8685.91314086851;8768.430052046597;4797.784099715521;4808.3027960945465;4854.05345957542;4868.902621947541;4891.241857512091;3512.5258090157504;3646.6717995380013;3648.7081033517256;3652.2330310635066;3652.945205821915;586.2291087220292;598.3059650805045;600.7056542294245;603.3242768099757;631.5582048376785;652.6280020388333;754.1327473405628;762.8512440074132;792.7859477941039;793.1909452358562;10368.274220804471;10750.354978701303;10863.945680271549;10907.781844363068;10960.177986651033;606.8513214262446;674.2818897873749;684.5618803965466;716.4769718105708;733.2044731466418;4384.6273066789045;4705.364775755298;4850.199717046718;4925.729084900293;5010.774515146827;77117;77193;77301.22698773052;121354.3932280333;121401;100720;104011.4799425998;104162.47918760509;104204;105668.47165764122;76214.9999999989;77761.8895244184;78364.21635783568;80023;80250;10018.1985441166;10515.871047122002;10548.578056877639;10599.523021464207;10671.733206669895;37332;37817.920014399475;39620.405693914036;46191;53160.73419632877;58083.709581451825;71377.64311178411;73772.63113684398;75789.6210518966;76903;14176.149431034171;14303.427862885368;14331.211783352015;14602.926985365006;14726.779098313747;14524.273786310854;14992.023938094026;15042.774358384851;15109.54671359861;15264;14224.857751422353;14244.928775356057;14262;14275;14408.354281967053;14237.928810355881;14528.491502797351;14652.413903443743;14688.55934321972;14712;12751.107422480338;12877.742445150858;13001;13198.538051168163;13307.600771976857;11381.374024428736;11425.485853136463;11448;11521.251118677259;11606.70983225426;10618.52216650268;10667.89332106669;10795.838062429228;10839.458027098772;10884 16:12:26 INFO - PROCESS | 3343 | __end_tp_report 16:12:26 INFO - PROCESS | 3343 | __start_cc_report 16:12:26 INFO - PROCESS | 3343 | _x_x_mozilla_cycle_collect,922 16:12:26 INFO - PROCESS | 3343 | __end_cc_report 16:12:26 INFO - PROCESS | 3343 | __startTimestamp1469661146077__endTimestamp 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | ------- Summary: start ------- 16:12:26 INFO - PROCESS | 3343 | Number of tests: 6 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | [#0] dojo.html Cycles:165 Average:5549.18 Median:5702.20 stddev:624.55 (11.0%) stddev-sans-first:601.91 16:12:26 INFO - PROCESS | 3343 | Values: 3338.5 3340.1 3358.6 3374.8 3404.9 5479.9 5579.8 5580.1 5583.8 5592.8 5507.6 5569.3 5581.2 5581.8 5614.9 4933.2 4973.7 5028.1 5059.3 5106.4 4880.8 5014.6 5051.8 5059.4 5070.4 5004.0 5035.0 5055.5 5076.6 5084.5 5155.8 5179.3 5179.7 5180.0 5197.1 4896.7 4914.9 4954.4 5072.5 5101.9 5404.6 5406.3 5452.7 5455.8 5465.5 6027.5 6035.0 6037.4 6041.5 6041.6 5919.1 5955.6 5960.1 6015.9 6068.0 5599.9 5608.6 5643.5 5649.0 5652.7 5980.5 6123.8 6126.1 6130.8 6132.5 5813.0 5836.9 5847.0 5938.3 5950.9 6003.5 6005.2 6014.0 6033.9 6038.5 5727.7 5908.0 5978.3 5993.6 5997.9 5953.2 6035.2 6042.3 6042.4 6079.1 4613.0 4624.4 4625.4 4630.2 4650.1 4010.2 4032.2 4044.4 4113.6 4136.8 5611.8 5629.9 5631.2 5633.6 5642.1 5949.3 5952.6 5958.7 5962.5 5971.1 5427.6 5587.3 5599.2 5610.5 5720.5 5125.5 5156.3 5156.9 5158.4 5162.5 6127.8 6254.3 6265.7 6268.1 6281.2 5905.7 5961.5 5964.1 6008.3 6010.7 6268.9 6294.5 6298.5 6300.3 6307.4 5702.2 5860.8 5907.4 5914.7 5953.3 5935.1 6013.9 6049.4 6053.5 6093.5 5867.6 5896.4 5911.7 5915.2 5921.6 5670.9 5724.8 5736.0 5846.4 5896.0 5672.7 5687.5 5694.5 5694.8 5717.9 5814.2 5818.9 5859.2 5868.6 5875.4 5604.8 5672.6 5689.6 5736.3 5764.9 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | [#1] ext.html Cycles:180 Average:68443.62 Median:392811.00 stddev:146774.36 (37.4%) stddev-sans-first:147097.71 16:12:26 INFO - PROCESS | 3343 | Values: 600.7 645.6 646.2 657.2 666.5 34090.1 45814.5 47460.3 47487.3 47494.3 49472.0 49572.5 50008.7 50013.0 50021.2 8404.5 9149.1 9286.9 9295.7 9319.1 11025.3 11266.8 11326.2 11332.1 11677.4 10985.3 11103.3 11428.3 11440.7 11446.7 8487.6 11032.2 11257.3 11335.2 11367.0 10989.7 11028.7 11079.8 11081.7 11096.1 46145.0 46297.3 46519.0 46625.8 46765.3 3663.2 3734.5 3764.2 3837.5 4174.0 35632.8 36187.3 36480.5 36655.6 36940.6 4745.7 4756.5 4760.6 4871.1 4966.8 387807.0 392253.0 392801.0 392821.0 393616.0 39074.2 40222.0 70739.3 71427.0 71544.3 41711.0 41820.2 41957.8 41970.4 41971.8 17829.7 17992.8 18013.7 18014.5 18018.9 13473.9 14761.4 14934.1 15235.5 15237.5 9275.7 9291.6 9300.6 9361.0 9361.7 3551.3 3565.2 3592.1 3612.7 3665.5 1060.3 1148.2 1148.6 1238.2 1242.9 35038.0 35149.6 35388.5 35683.1 35871.8 1188.2 1192.8 1224.5 1233.7 1267.7 18171.7 18534.6 18578.6 18599.6 18833.3 581710.0 643224.0 654744.0 655431.0 1023691.0 66779.3 67277.0 67454.7 67499.0 67597.7 1358.3 1466.6 1502.6 1525.8 1542.8 34108.3 35619.1 35696.0 36809.4 36924.6 56762.0 57359.4 57572.4 57649.4 57669.7 461604.0 466045.0 466362.0 466434.0 467746.0 31049.2 31904.6 32134.8 32232.5 32436.2 51947.5 53415.0 54033.2 54412.7 54727.0 44665.0 44692.8 44891.4 45120.3 45634.5 43865.0 44352.0 44525.3 44560.8 45401.8 44307.3 45515.3 45530.0 45689.5 46157.0 38670.4 39128.6 39439.6 39534.4 40393.0 29980.3 30149.8 30281.8 30301.4 30570.5 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | [#2] jquery.html Cycles:180 Average:29401.89 Median:12405.28 stddev:81418.33 (656.3%) stddev-sans-first:81617.63 16:12:26 INFO - PROCESS | 3343 | Values: 407.7 410.8 413.2 418.6 433.7 17774.6 19096.1 19446.2 19454.4 19775.3 19045.7 19407.3 19840.4 19917.9 19956.0 5320.3 5906.9 5917.4 5923.1 5929.1 5612.0 5739.8 5801.6 5801.7 5803.1 5769.3 5794.0 5796.3 5802.5 5804.4 5583.3 5752.9 5782.7 5790.1 5832.8 5241.0 5252.2 5271.3 5275.7 5277.3 22521.9 23379.6 24172.4 24211.8 24464.3 2288.7 2452.9 2476.7 2504.4 2588.0 15017.4 15147.4 15256.4 15527.1 15600.8 1914.8 2002.2 2018.1 2021.9 2085.7 79017.0 79454.6 79772.0 80317.6 81154.6 10919.6 11014.3 11203.9 11279.3 11452.4 15930.9 15966.4 16012.1 16033.9 16041.6 8644.4 9016.1 9022.3 9139.0 9156.1 8574.3 8705.0 8716.7 8815.0 8850.2 7024.2 7157.1 7173.6 7187.7 7199.2 1797.2 1958.2 1986.7 2010.6 2037.1 890.3 1057.8 1130.5 1135.8 1197.3 19341.5 20231.7 20281.2 20290.0 20328.0 1065.3 1092.6 1112.7 1123.0 1153.5 11392.3 11538.4 11641.3 11765.2 11860.8 399208.0 475486.0 519682.0 528658.0 537758.0 60418.0 63583.7 78881.0 104331.0 107036.5 1067.8 1070.9 1086.7 1109.0 1119.3 18253.5 18340.4 18566.7 18695.2 18821.8 43448.6 44185.0 44252.8 44425.1 45394.3 61496.7 62263.2 62705.5 62731.4 62979.0 8853.7 8863.3 9008.4 9043.9 9175.3 9930.5 13437.7 13441.7 13625.2 14001.1 11687.5 11712.4 11816.4 11903.0 12251.1 11766.7 11882.9 12004.8 12108.0 12317.4 11654.1 11908.9 11963.6 12042.3 12191.5 8521.4 8579.4 8703.3 8738.3 8871.4 10789.8 11902.8 11905.8 11924.8 12155.6 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | [#3] mootools.html Cycles:180 Average:6287.62 Median:4564.82 stddev:3733.89 (81.8%) stddev-sans-first:3726.37 16:12:26 INFO - PROCESS | 3343 | Values: 1408.8 1611.6 1617.5 1858.6 1984.1 8387.7 9308.7 9505.8 9525.9 9860.7 9525.6 9686.7 9691.7 9692.7 9692.7 2475.8 2499.8 2499.9 2502.6 2503.4 2427.4 2476.0 2480.4 2482.9 2483.1 2394.2 2427.1 2473.6 2475.1 2478.5 2373.4 2385.7 2399.4 2436.3 2437.9 2353.5 2393.0 2410.9 2417.3 2419.3 8963.4 9517.1 9598.5 9601.3 9609.0 5446.6 5598.2 5600.2 5616.8 5616.9 3572.0 3596.4 3630.9 3635.1 3684.2 1133.3 1135.9 1139.5 1150.5 1158.2 13847.8 13976.8 13998.9 14029.2 14071.9 4740.3 4745.2 4815.4 4847.8 4857.1 10415.2 10445.2 10455.1 10456.5 10466.1 5594.4 5597.5 5598.7 5600.8 5602.9 4466.4 4552.2 4682.8 4987.4 5192.7 4095.8 4143.5 4159.9 4164.8 4294.0 1096.2 1151.9 1152.7 1163.9 1168.5 1005.0 1022.3 1037.4 1039.0 1040.0 6603.5 6610.9 6657.9 6708.0 6738.9 442.9 447.8 449.2 452.6 458.4 4577.4 4648.7 4651.7 4655.4 4786.1 12093.9 12175.2 12565.6 12599.0 12608.0 12314.4 12409.1 12477.6 12486.6 12500.8 8980.6 9343.5 9343.8 9345.3 9346.0 6437.2 6463.2 6463.5 6487.8 6539.3 11183.7 11191.3 11365.2 11455.7 11473.7 11479.1 11636.5 11667.8 11738.9 11843.0 7014.7 7236.7 7340.9 7542.9 7570.1 9460.1 9518.5 9531.5 9569.4 9606.2 8136.3 8343.8 8689.0 8694.2 8755.3 8140.4 8180.6 8257.1 8328.0 8341.7 7510.7 7533.4 7558.7 7576.7 7594.2 5363.0 5432.9 5542.9 5555.1 5592.6 5506.8 5571.0 5659.3 5673.1 5691.3 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | [#4] prototype.html Cycles:180 Average:4788.61 Median:5380.80 stddev:1402.69 (26.1%) stddev-sans-first:1366.53 16:12:26 INFO - PROCESS | 3343 | Values: 351.9 352.6 354.5 358.0 358.1 5412.9 5428.5 5438.2 5467.5 5479.5 5345.0 5378.7 5385.1 5399.0 5418.6 3873.7 4092.5 4316.0 4324.2 4335.7 4261.1 4287.2 4289.4 4327.5 4335.7 4088.6 4275.1 4285.4 4285.8 4305.9 4192.4 4214.6 4278.1 4285.7 4296.3 3788.2 3799.2 3817.0 3840.2 3871.6 5117.4 5228.0 5266.7 5266.8 5271.9 4862.4 4875.2 4883.1 4890.9 4923.0 5612.7 5636.4 5637.9 5641.4 5656.2 4199.6 4210.2 4235.2 4253.1 4259.2 5552.3 5562.2 5727.4 5906.5 5929.6 4202.9 4213.7 4245.2 4259.1 4268.5 4294.4 4300.1 4316.9 4316.9 4317.2 4608.1 4865.8 4879.5 4886.4 4922.7 5686.2 5690.4 5692.8 5736.5 5739.4 1455.5 1466.9 1468.7 1469.6 1475.4 928.7 936.3 941.5 958.6 973.7 4941.0 4970.6 5006.1 5034.8 5045.4 5146.3 5154.8 5185.8 5214.2 5246.9 4973.4 4984.5 5042.9 5265.4 5716.0 3108.3 3115.5 3154.6 3154.7 3168.8 6033.4 6107.9 6125.2 6137.6 6169.6 5685.3 6002.0 6028.9 6052.4 6059.5 6179.6 6182.5 6200.3 6245.8 6248.8 5618.4 5912.6 5919.3 5958.2 5986.2 5780.2 5834.8 5839.4 5846.2 5846.3 5890.2 5911.5 6207.5 6258.3 6258.5 4006.5 4071.6 4079.1 4102.2 4120.9 5798.7 5919.0 5924.2 5974.6 5981.8 5656.5 5713.4 5736.2 5796.5 5805.0 5673.0 5685.9 5696.7 5718.5 5728.0 5382.9 5548.9 5616.0 5626.9 5628.4 5769.7 5789.2 5851.3 5861.5 5891.4 5474.9 5739.8 5740.5 5771.8 5794.8 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - PROCESS | 3343 | [#5] yui.html Cycles:180 Average:20141.99 Median:3652.59 stddev:28160.17 (771.0%) stddev-sans-first:28201.31 16:12:26 INFO - PROCESS | 3343 | Values: 695.4 747.5 777.1 791.0 829.8 15115.4 15263.9 15403.6 15587.3 15878.4 13629.5 13698.6 13728.2 13729.7 13732.2 731.8 864.1 887.4 896.9 905.6 887.2 891.2 893.3 893.9 894.1 942.9 945.4 946.7 946.8 947.6 755.9 891.4 921.2 921.4 927.3 678.2 681.1 682.4 683.2 683.4 15237.2 15250.2 15284.6 15285.0 15292.8 14789.4 14817.3 15029.9 15097.0 15183.6 12023.6 12045.8 12213.4 12215.5 12255.7 4410.4 4540.8 4574.9 4601.4 4675.2 78039.0 78772.6 79007.0 79592.6 79598.6 11907.5 11937.6 11962.6 11991.4 12010.1 23130.8 23134.4 23138.1 23165.8 23174.3 8548.3 8583.0 8645.5 8685.9 8768.4 4797.8 4808.3 4854.1 4868.9 4891.2 3512.5 3646.7 3648.7 3652.2 3652.9 586.2 598.3 600.7 603.3 631.6 652.6 754.1 762.9 792.8 793.2 10368.3 10750.4 10863.9 10907.8 10960.2 606.9 674.3 684.6 716.5 733.2 4384.6 4705.4 4850.2 4925.7 5010.8 77117.0 77193.0 77301.2 121354.4 121401.0 100720.0 104011.5 104162.5 104204.0 105668.5 76215.0 77761.9 78364.2 80023.0 80250.0 10018.2 10515.9 10548.6 10599.5 10671.7 37332.0 37817.9 39620.4 46191.0 53160.7 58083.7 71377.6 73772.6 75789.6 76903.0 14176.1 14303.4 14331.2 14602.9 14726.8 14524.3 14992.0 15042.8 15109.5 15264.0 14224.9 14244.9 14262.0 14275.0 14408.4 14237.9 14528.5 14652.4 14688.6 14712.0 12751.1 12877.7 13001.0 13198.5 13307.6 11381.4 11425.5 11448.0 11521.3 11606.7 10618.5 10667.9 10795.8 10839.5 10884.0 16:12:26 INFO - PROCESS | 3343 | -------- Summary: end -------- 16:12:26 INFO - PROCESS | 3343 | 16:12:26 INFO - TEST-INFO | 3343: exit 0 16:12:26 INFO - TEST-OK | dromaeo_css | took 1112477ms 16:12:26 INFO - TEST-START | kraken 16:12:26 INFO - operating with platform_type : linux_ 16:12:26 INFO - Initialising browser for kraken test... 16:12:26 INFO - TEST-INFO | started process 3536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsQ7vQR/profile http://localhost:33316/getInfo.html) 16:12:30 INFO - PROCESS | 3536 | __metrics Screen width/height:1600/1200 16:12:30 INFO - PROCESS | 3536 | colorDepth:24 16:12:30 INFO - PROCESS | 3536 | Browser inner width/height: 1024/697 16:12:30 INFO - PROCESS | 3536 | __metrics 16:12:31 INFO - PROCESS | 3536 | 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:12:31 ERROR - PROCESS | 3536 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:12:32 INFO - TEST-INFO | 3536: exit 0 16:12:32 INFO - Browser initialized. 16:12:32 INFO - Running cycle 1/1 for kraken test... 16:12:32 INFO - TEST-INFO | started process 3631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsQ7vQR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:43 INFO - PROCESS | 3631 | RSS: Main: 145629184 16:12:43 INFO - PROCESS | 3631 | 16:12:46 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33316/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:47 INFO - PROCESS | 3631 | RSS: Main: 195047424 16:12:47 INFO - PROCESS | 3631 | 16:12:49 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33316/tests/kraken/driver.html?testName=audio-dft) 16:12:50 INFO - PROCESS | 3631 | RSS: Main: 193097728 16:12:50 INFO - PROCESS | 3631 | 16:12:53 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33316/tests/kraken/driver.html?testName=audio-fft) 16:12:53 INFO - PROCESS | 3631 | RSS: Main: 279318528 16:12:53 INFO - PROCESS | 3631 | 16:12:55 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33316/tests/kraken/driver.html?testName=audio-oscillator) 16:12:56 INFO - PROCESS | 3631 | RSS: Main: 187936768 16:12:56 INFO - PROCESS | 3631 | 16:12:58 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:59 INFO - PROCESS | 3631 | RSS: Main: 188280832 16:12:59 INFO - PROCESS | 3631 | 16:13:02 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33316/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:02 INFO - PROCESS | 3631 | RSS: Main: 223006720 16:13:02 INFO - PROCESS | 3631 | 16:13:06 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33316/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:06 INFO - PROCESS | 3631 | RSS: Main: 223207424 16:13:06 INFO - PROCESS | 3631 | 16:13:09 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33316/tests/kraken/driver.html?testName=json-parse-financial) 16:13:10 INFO - PROCESS | 3631 | RSS: Main: 223064064 16:13:10 INFO - PROCESS | 3631 | 16:13:11 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:12 INFO - PROCESS | 3631 | RSS: Main: 201101312 16:13:12 INFO - PROCESS | 3631 | 16:13:14 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:14 INFO - PROCESS | 3631 | RSS: Main: 201957376 16:13:14 INFO - PROCESS | 3631 | 16:13:16 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:17 INFO - PROCESS | 3631 | RSS: Main: 209907712 16:13:17 INFO - PROCESS | 3631 | 16:13:19 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:20 INFO - PROCESS | 3631 | RSS: Main: 215429120 16:13:20 INFO - PROCESS | 3631 | 16:13:23 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:23 INFO - PROCESS | 3631 | RSS: Main: 214536192 16:13:23 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:33316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33316/tests/kraken/driver.html?testName=ai-astar) 16:13:25 INFO - PROCESS | 3631 | RSS: Main: 256925696 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | __start_tp_report 16:13:25 INFO - PROCESS | 3631 | _x_x_mozilla_page_load 16:13:25 INFO - PROCESS | 3631 | _x_x_mozilla_page_load_details 16:13:25 INFO - PROCESS | 3631 | |i|pagename|runs| 16:13:25 INFO - PROCESS | 3631 | |0;ai-astar;110;104;109;110;111;109;110;110;109;109 16:13:25 INFO - PROCESS | 3631 | |1;audio-beat-detection;157;122;139;164;129;124;155;126;190;127 16:13:25 INFO - PROCESS | 3631 | |2;audio-dft;161;160;162;161;160;162;160;160;160;161 16:13:25 INFO - PROCESS | 3631 | |3;audio-fft;76;75;75;121;75;75;74;75;99;74 16:13:25 INFO - PROCESS | 3631 | |4;audio-oscillator;84;84;117;84;85;84;117;84;84;132 16:13:25 INFO - PROCESS | 3631 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;117;117 16:13:25 INFO - PROCESS | 3631 | |6;imaging-darkroom;145;146;145;146;146;145;146;146;149;148 16:13:25 INFO - PROCESS | 3631 | |7;imaging-desaturate;95;95;95;94;94;94;96;94;94;94 16:13:25 INFO - PROCESS | 3631 | |8;json-parse-financial;49;55;50;50;50;50;52;51;50;50 16:13:25 INFO - PROCESS | 3631 | |9;json-stringify-tinderbox;62;60;60;61;61;60;61;62;62;61 16:13:25 INFO - PROCESS | 3631 | |10;stanford-crypto-aes;78;77;77;78;78;79;79;78;108;78 16:13:25 INFO - PROCESS | 3631 | |11;stanford-crypto-ccm;119;127;121;132;114;115;121;126;135;128 16:13:25 INFO - PROCESS | 3631 | |12;stanford-crypto-pbkdf2;155;155;156;155;155;155;160;153;152;152 16:13:25 INFO - PROCESS | 3631 | |13;stanford-crypto-sha256-iterative;64;62;62;65;60;62;62;60;60;60 16:13:25 INFO - PROCESS | 3631 | __end_tp_report 16:13:25 INFO - PROCESS | 3631 | __start_cc_report 16:13:25 INFO - PROCESS | 3631 | _x_x_mozilla_cycle_collect,1570 16:13:25 INFO - PROCESS | 3631 | __end_cc_report 16:13:25 INFO - PROCESS | 3631 | __startTimestamp1469661205527__endTimestamp 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | ------- Summary: start ------- 16:13:25 INFO - PROCESS | 3631 | Number of tests: 14 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 16:13:25 INFO - PROCESS | 3631 | Values: 110.0 104.0 109.0 110.0 111.0 109.0 110.0 110.0 109.0 109.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:147.00 stddev:22.48 (15.3%) stddev-sans-first:23.29 16:13:25 INFO - PROCESS | 3631 | Values: 157.0 122.0 139.0 164.0 129.0 124.0 155.0 126.0 190.0 127.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 16:13:25 INFO - PROCESS | 3631 | Values: 161.0 160.0 162.0 161.0 160.0 162.0 160.0 160.0 160.0 161.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:15.70 (20.9%) stddev-sans-first:16.51 16:13:25 INFO - PROCESS | 3631 | Values: 76.0 75.0 75.0 121.0 75.0 75.0 74.0 75.0 99.0 74.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:18.74 (22.3%) stddev-sans-first:19.41 16:13:25 INFO - PROCESS | 3631 | Values: 84.0 84.0 117.0 84.0 85.0 84.0 117.0 84.0 84.0 132.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:13:25 INFO - PROCESS | 3631 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:1.32 (0.9%) stddev-sans-first:1.32 16:13:25 INFO - PROCESS | 3631 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 149.0 148.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:13:25 INFO - PROCESS | 3631 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 96.0 94.0 94.0 94.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:50.00 stddev:1.70 (3.4%) stddev-sans-first:1.69 16:13:25 INFO - PROCESS | 3631 | Values: 49.0 55.0 50.0 50.0 50.0 50.0 52.0 51.0 50.0 50.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 16:13:25 INFO - PROCESS | 3631 | Values: 62.0 60.0 60.0 61.0 61.0 60.0 61.0 62.0 62.0 61.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:78.00 stddev:9.51 (12.2%) stddev-sans-first:10.02 16:13:25 INFO - PROCESS | 3631 | Values: 78.0 77.0 77.0 78.0 78.0 79.0 79.0 78.0 108.0 78.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:126.50 stddev:6.97 (5.5%) stddev-sans-first:7.18 16:13:25 INFO - PROCESS | 3631 | Values: 119.0 127.0 121.0 132.0 114.0 115.0 121.0 126.0 135.0 128.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:2.30 (1.5%) stddev-sans-first:2.44 16:13:25 INFO - PROCESS | 3631 | Values: 155.0 155.0 156.0 155.0 155.0 155.0 160.0 153.0 152.0 152.0 16:13:25 INFO - PROCESS | 3631 | 16:13:25 INFO - PROCESS | 3631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.77 (2.8%) stddev-sans-first:1.67 16:13:25 INFO - PROCESS | 3631 | Values: 64.0 62.0 62.0 65.0 60.0 62.0 62.0 60.0 60.0 60.0 16:13:25 INFO - PROCESS | 3631 | -------- Summary: end -------- 16:13:25 INFO - PROCESS | 3631 | 16:13:26 INFO - TEST-INFO | 3631: exit 0 16:13:26 INFO - TEST-OK | kraken | took 59941ms 16:13:26 INFO - SUITE-END | took 1172s 16:13:26 INFO - Completed test suite (00:19:32) 16:13:26 INFO - javascript benchmark 16:13:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.5492958450604, 3340.0814775936624, 3358.613759417666, 3374.7806392584494, 3404.931901361973, 5479.863003424912, 5579.776808927643, 5580.107182850745, 5583.832485025446, 5592.804251851186, 5507.586930980173, 5569.303837020372, 5581.190727344532, 5581.832545023656, 5614.9438505614935, 4933.161362568354, 4973.6518443708865, 5028.069807085682, 5059.342285502879, 5106.4382917879, 4880.829170979016, 5014.623903207255, 5051.797928082872, 5059.367579052619, 5070.391553013644, 5003.974980125095, 5035.0, 5055.494450554952, 5076.568491678212, 5084.491550844905, 5155.767990440401, 5179.326687530634, 5179.715115668637, 5180.04169228692, 5197.116490196676, 4896.730679812609, 4914.852554423373, 4954.43024052235, 5072.492750724935, 5101.948980510185, 5404.5676345892625, 5406.270153529302, 5452.672839629635, 5455.781768729246, 5465.480779325958, 6027.487663548603, 6035.034394496859, 6037.426444487811, 6041.546883983675, 6041.607295525777, 5919.1417244499735, 5955.553333500005, 5960.135780311831, 6015.939840601625, 6067.998780201261, 5599.888002239933, 5608.551315894719, 5643.463870932255, 5648.999999999959, 5652.74562644682, 5980.461758441761, 6123.835112917808, 6126.081087836771, 6130.807181375102, 6132.50939924805, 5813.04084825999, 5836.88326233473, 5847.035239185487, 5938.317093534299, 5950.8809823803285, 6003.519718422515, 6005.249343832021, 6014.0, 6033.879322413527, 6038.516918646497, 5727.713614319267, 5908.025175845937, 5978.342382337939, 5993.640381577032, 5997.910031349533, 5953.166556682068, 6035.185249991195, 6042.305134909454, 6042.395760423922, 6079.148919151322, 4613.0, 4624.398828152319, 4625.375574297427, 4630.236011058205, 4650.116477869194, 4010.21800748857, 4032.213718324957, 4044.4135600338373, 4113.568075352105, 4136.772477513706, 5611.80358687444, 5629.943700563023, 5631.211630371751, 5633.63381380209, 5642.125470552071, 5949.286085669747, 5952.613080149777, 5958.731857066442, 5962.493188079062, 5971.134185543072, 5427.6472029317965, 5587.27365442498, 5599.216109744639, 5610.523105535994, 5720.485156335866, 5125.538701516882, 5156.278121063054, 5156.871078223075, 5158.432572417031, 5162.45794191612, 6127.754889804358, 6254.343293954069, 6265.686715664198, 6268.059791031382, 6281.214848143982, 5905.734241959208, 5961.493273071837, 5964.105384192406, 6008.279006519246, 6010.699465026819, 6268.942415058172, 6294.4964402846745, 6298.496120310456, 6300.338464461165, 6307.400796924285, 5702.201691763239, 5860.765569377178, 5907.3797251288, 5914.704264786657, 5953.345132035559, 5935.109733540004, 6013.909791353046, 6049.425304596057, 6053.4551890330085, 6093.512518998381, 5867.647941123546, 5896.410358964069, 5911.733971971185, 5915.201447804491, 5921.5854890159, 5670.943290567042, 5724.771009159587, 5735.971320143372, 5846.356900741001, 5896.0, 5672.659640421588, 5687.516561092353, 5694.544436444991, 5694.800681976277, 5717.885642287214, 5814.186013957965, 5818.883622327445, 5859.179714839841, 5868.589198756046, 5875.353711091862, 5604.775808967595, 5672.5745569081655, 5689.573282003784, 5736.311642602747, 5764.913526297193], "value": 5508.370656423573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.7206648908259, 645.6094063091829, 646.1503123392738, 657.1818086482328, 666.4967949198355, 34090.14774630632, 45814.54185458145, 47460.288095678596, 47487.287690684665, 47494.2875856862, 49472.0, 49572.50427495733, 50008.749956250256, 50013.0, 50021.24968125472, 8404.453710508827, 9149.130832570896, 9286.860697089516, 9295.674651387202, 9319.068093190694, 11025.283356581836, 11266.774664506705, 11326.20716549842, 11332.093432525378, 11677.357745324003, 10985.340879547213, 11103.333799971988, 11428.257163284401, 11440.71398215043, 11446.713832154179, 8487.618057187441, 11032.22774405792, 11257.324560526353, 11335.206535542515, 11367.033802126829, 10989.725256868562, 11028.724281892937, 11079.778404431947, 11081.72295692606, 11096.05683516902, 46145.0, 46297.30554041692, 46519.0, 46625.76687116577, 46765.29852052222, 3663.157473781019, 3734.533183352081, 3764.247150569897, 3837.501124853779, 4174.0, 35632.821835890914, 36187.27625447476, 36480.452793208126, 36655.633443665756, 36940.63059369399, 4745.69153005057, 4756.476787553401, 4760.6429517785955, 4871.14754917888, 4966.776495057695, 387807.0, 392253.0, 392801.0, 392820.99999999715, 393616.0, 39074.21851562953, 40222.0, 70739.2926070743, 71427.0, 71544.28455715481, 41711.0, 41820.16359672789, 41957.79021104936, 41970.37044444336, 41971.790141049096, 17829.7325540117, 17992.820071799113, 18013.7297940531, 18014.5496362592, 18018.90990545065, 13473.865261347457, 14761.40954361835, 14934.103953762591, 15235.466758663393, 15237.542873713806, 9275.72172834816, 9291.581878815334, 9300.627974881065, 9361.0, 9361.672341468153, 3551.3252482028847, 3565.2156525564333, 3592.1378869071236, 3612.7471077024356, 3665.52348194733, 1060.3372891942536, 1148.1733152130619, 1148.592249751343, 1238.158052524292, 1242.8570714367784, 35038.0, 35149.64850351515, 35388.469172962425, 35683.12902855963, 35871.82064089715, 1188.2098404561043, 1192.773373059116, 1224.5407972010496, 1233.747081848219, 1267.6830792301926, 18171.72742408865, 18534.629307413776, 18578.628427431377, 18599.628007440046, 18833.34083307105, 581710.0, 643224.0, 654744.0, 655431.0, 1023691.0, 66779.33220667829, 67277.0, 67454.66272668606, 67499.0, 67597.66201169061, 1358.341204515809, 1466.552701426054, 1502.5942995391401, 1525.80927384077, 1542.8225754038206, 34108.31783364269, 35619.10952226215, 35696.0, 36809.447858282685, 36924.630753692116, 56762.0, 57359.426405737075, 57572.424275758385, 57649.423505764404, 57669.711651443155, 461604.0, 466045.0, 466362.0, 466434.0, 467746.0, 31049.223769405944, 31904.564294606334, 32134.839325803223, 32232.516512252805, 32436.189095272806, 51947.48052519427, 53415.0, 54033.18950215671, 54412.72793636007, 54727.0, 44665.0, 44692.77653611711, 44891.42788777938, 45120.32319515144, 45634.54365456436, 43865.0, 44352.0, 44525.33212001887, 44560.77719611511, 45401.772991134836, 44307.33538996982, 45515.31727024031, 45530.0, 45689.543104568525, 46157.0, 38670.419943700304, 39128.608713913636, 39439.60560394359, 39534.40698389584, 40393.0, 29980.250493737833, 30149.849250753607, 30281.848590756905, 30301.393972119993, 30570.541441877944], "value": 21261.677478423928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.65756764317985, 410.79254976236996, 413.243763912041, 418.62323908482364, 433.73542139295023, 17774.64450710985, 19096.140673669684, 19446.222151113958, 19454.416367508962, 19775.307864224756, 19045.7143142853, 19407.32074377397, 19840.40478785635, 19917.90041049793, 19956.0, 5320.255164277004, 5906.852328691795, 5917.437843404869, 5923.111533270023, 5929.051351783715, 5611.971940140294, 5739.827805165831, 5801.622894511865, 5801.7389217485315, 5803.129530570406, 5769.278840144982, 5794.043982742843, 5796.333421656522, 5802.53579713624, 5804.361520232771, 5583.274174357308, 5752.856178595527, 5782.710864456761, 5790.102534107199, 5832.766689332421, 5241.004209200278, 5252.212168174766, 5271.262023316739, 5275.657082289639, 5277.261183434322, 22521.887390563104, 23379.649305260435, 24172.39569010771, 24211.7578824213, 24464.26607201769, 2288.6681431192383, 2452.8773561321864, 2476.6656501372445, 2504.373906523369, 2587.9648140743666, 15017.399304027826, 15147.394104235816, 15256.38974441021, 15527.146006969611, 15600.843991560052, 1914.818092281231, 2002.1914533320023, 2018.0817727933902, 2021.888796116213, 2085.7392825896763, 79017.0, 79454.60272698657, 79772.0, 80317.59841200816, 81154.59422702849, 10919.617813376653, 11014.284071535325, 11203.943980280046, 11279.266847654877, 11452.427378631035, 15930.92034539843, 15966.36134554628, 16012.119333436773, 16033.919830401006, 16041.59896002586, 8644.438111522732, 9016.143466370684, 9022.323325750594, 9138.954305228564, 9156.084391560791, 8574.271186949054, 8705.0, 8716.651333946698, 8814.955925220333, 8850.159234872677, 7024.1571011478945, 7157.141143062761, 7173.6413179340825, 7187.712491500281, 7199.2080871104135, 1797.173300281885, 1958.2460752610348, 1986.7284937639922, 2010.6179825833044, 2037.113855472874, 890.3055616619048, 1057.7937302225992, 1130.5308297056795, 1135.8239472881717, 1197.3474456421272, 19341.51646208856, 20231.696524552142, 20281.188752449736, 20290.0, 20328.0, 1065.2862582070031, 1092.6066616018227, 1112.7285779807341, 1123.017359810166, 1153.4982282707049, 11392.25950313227, 11538.423078846025, 11641.301521908712, 11765.176437649283, 11860.822087668692, 399208.0, 475486.0, 519682.0, 528658.0, 537758.0, 60418.0, 63583.68208158929, 78881.0, 104331.0, 107036.46481767541, 1067.77576708892, 1070.8554345163304, 1086.6577028236081, 1108.9944550277196, 1119.2948442481186, 18253.45239642813, 18340.44978650589, 18566.721499177795, 18695.158717857455, 18821.811781882006, 43448.56551434445, 44185.0, 44252.77873610611, 44425.11149776922, 45394.31908521441, 61496.69251653713, 62263.22104016028, 62705.49178032827, 62731.37268627255, 62979.0, 8853.73438796837, 8863.290936725176, 9008.369414140947, 9043.864342034743, 9175.31185161129, 9930.503474826375, 13437.664058398619, 13441.663958400726, 13625.182489050689, 14001.089929154572, 11687.539057617798, 11712.355820429959, 11816.40917954116, 11903.0, 12251.08116891219, 11766.705832354259, 11882.881171188177, 12004.797121727242, 12108.0, 12317.44571494267, 11654.125940554322, 11908.940455297668, 11963.624183218693, 12042.337671427806, 12191.451384687532, 8521.403501754818, 8579.442336248125, 8703.303735701254, 8738.25724813398, 8871.379003469696, 10789.824246896229, 11902.821457677968, 11905.761884762429, 11924.761504769682, 12155.57455489089], "value": 9700.821325244733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.7745960646298, 1611.6132128289214, 1617.4824056301982, 1858.6004009138032, 1984.1468168687468, 8387.664493420263, 9308.674196403128, 9505.80988380232, 9525.857112143314, 9860.654877079303, 9525.618975240983, 9686.70939871805, 9691.660791872286, 9692.66075687351, 9692.66075687351, 2475.7524247575234, 2499.8125140614434, 2499.9250022499355, 2502.5745623244093, 2503.4492411669403, 2427.3810178404483, 2476.0, 2480.4419005723657, 2482.888270027853, 2483.081259933827, 2394.1859767678984, 2427.0655797517993, 2473.5794914864427, 2475.121331927167, 2478.467129567143, 2373.3829204406807, 2385.71371435428, 2399.3521749127726, 2436.2569416328015, 2437.8659173745436, 2353.51752890657, 2393.0308225168833, 2410.8794560271917, 2417.3231495181203, 2419.27421773469, 8963.417377870417, 9517.143457088896, 9598.472084035375, 9601.327907046509, 9609.0, 5446.591505637093, 5598.2442370280305, 5600.1599760035915, 5616.831495055155, 5616.859578510529, 3571.982140089283, 3596.4425514045365, 3630.8729194478065, 3635.1457407509215, 3684.207895302496, 1133.2747041893194, 1135.9318440893574, 1139.5327915554583, 1150.4592841364629, 1158.206628459508, 13847.792283115761, 13976.790348144787, 13998.860011399858, 14029.158250504901, 14071.859281407158, 4740.312654665055, 4745.217039188564, 4815.446223684251, 4847.781849816696, 4857.149998750205, 10415.218858585486, 10445.216608754221, 10455.059044686015, 10456.477176141163, 10466.058054775107, 5594.412586678422, 5597.468240517144, 5598.692071936001, 5600.831975040755, 5602.859928501739, 4466.39703640011, 4552.226121559343, 4682.765861706901, 4987.376577927759, 5192.714400707997, 4095.7747323896874, 4143.544210136883, 4159.91680166395, 4164.8334066637, 4293.971101145989, 1096.2107282756403, 1151.8560179977503, 1152.7002979225294, 1163.8952494275557, 1168.480026388266, 1004.9799004019878, 1022.325265324882, 1037.408677054087, 1039.0, 1039.9808187975675, 6603.471722262208, 6610.933890661128, 6657.866842663119, 6708.0, 6738.898916516257, 442.9069895321954, 447.83653966302063, 449.2049073140588, 452.579101435668, 458.43154488434766, 4577.404937358188, 4648.7443190624845, 4651.697639653412, 4655.371524844103, 4786.0667169902235, 12093.939530302468, 12175.208611440228, 12565.560205392767, 12599.0, 12608.0, 12314.445849936774, 12409.131360804657, 12477.625671229696, 12486.625401237796, 12500.812487812691, 8980.550972451481, 9343.486108263975, 9343.766405839908, 9345.252379809599, 9346.0, 6437.227532696106, 6463.224413070274, 6463.547551671338, 6487.837804054936, 6539.313372095861, 11183.72040698989, 11191.2725672831, 11365.204435689753, 11455.65633030977, 11473.713157171138, 11479.139064570023, 11636.534538618698, 11667.766644667228, 11738.94130529342, 11843.0, 7014.68433920485, 7236.674349654383, 7340.889886651811, 7542.924570754222, 7570.05374328209, 9460.148586627236, 9518.476483793182, 9531.475768832503, 9569.3779904306, 9606.183474404754, 8136.308413784895, 8343.833123337377, 8689.044205137556, 8694.17405346491, 8755.343349248958, 8140.389470789833, 8180.590970451334, 8257.133001034805, 8328.042275138194, 8341.749747507585, 7510.737124200846, 7533.39732821362, 7558.659860306409, 7576.659050342858, 7594.202608726005, 5362.981033603603, 5432.864178395572, 5542.889142217214, 5555.138953462219, 5592.552595792408, 5506.752196151263, 5571.0, 5659.349174844946, 5673.149027645886, 5691.288588926384], "value": 4862.022862889124, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.89443167049876, 352.6244549554724, 354.47537644286456, 357.9726185846621, 358.0761634981747, 5412.891742165154, 5428.511433970942, 5438.15708565172, 5467.535259502937, 5479.506844384005, 5345.0, 5378.731063446822, 5385.138377859544, 5399.0, 5418.647787893794, 3873.6707379872605, 4092.5266903914567, 4315.956840431602, 4324.178406102847, 4335.6748243881675, 4261.126469073833, 4287.20686672965, 4289.356596510517, 4327.502337231227, 4335.739855608658, 4088.5690008497086, 4275.102228532012, 4285.44289242398, 4285.849995250167, 4305.870823875289, 4192.379762648345, 4214.641755450791, 4278.080212754242, 4285.742855428669, 4296.312589985588, 3788.204477059821, 3799.2401519696173, 3817.0075780297043, 3840.2127563849344, 3871.5547712012917, 5117.385913690344, 5228.032813929397, 5266.683998960075, 5266.7629956652045, 5271.86820329491, 4862.41651001882, 4875.219964805614, 4883.095592718842, 4890.926636100461, 4923.030787684919, 5612.663240205601, 5636.351819540723, 5637.8590535236535, 5641.435856414367, 5656.236408084938, 4199.643030342425, 4210.200061988213, 4235.1529694061, 4253.085586598865, 4259.16946195492, 5552.305961754781, 5562.221289019541, 5727.369989301132, 5906.468417842372, 5929.644221346733, 4202.85290014848, 4213.662906967435, 4245.195791788477, 4259.148170365939, 4268.466441694788, 4294.36814010674, 4300.075483770942, 4316.892077698019, 4316.935245971313, 4317.158154159909, 4608.147492713859, 4865.83220027191, 4879.4876537963, 4886.413630364308, 4922.72924989129, 5686.175504551899, 5690.430956904276, 5692.800751973661, 5736.483716465455, 5739.397363276796, 1455.5415044261024, 1466.889983251239, 1468.6635162002526, 1469.5958611381955, 1475.4172102019643, 928.6888892221182, 936.3492372800838, 941.4868896451451, 958.5782255807422, 973.73709098543, 4940.950590494121, 4970.627202959792, 5006.122703986005, 5034.823781167642, 5045.41977672565, 5146.25379320004, 5154.768035438415, 5185.818496352609, 5214.227162764678, 5246.868828279324, 4973.4085092769965, 4984.526469985418, 5042.873928151826, 5265.3944796348915, 5715.9997000524745, 3108.3161704424992, 3115.5326700995033, 3154.6056742907135, 3154.7160755531654, 3168.7781855270373, 6033.426824451758, 6107.908381374283, 6125.203723516003, 6137.570370074052, 6169.629822210682, 5685.289338832646, 6002.0, 6028.879422411527, 6052.364501727343, 6059.515238780887, 6179.598326108879, 6182.474489668339, 6200.255969283715, 6245.750169993331, 6248.812725582125, 5618.410066942912, 5912.551424900755, 5919.31927828288, 5958.1658567801405, 5986.191864098291, 5780.219670344618, 5834.824955251349, 5839.364977806221, 5846.239988801599, 5846.327672317738, 5890.175375447355, 5911.467967882912, 6207.479167603966, 6258.280297765815, 6258.499320054476, 4006.49756341372, 4071.572484889044, 4079.0618157823274, 4102.179564087135, 4120.866761640573, 5798.652080875161, 5918.970405147947, 5924.229850119629, 5974.641521508724, 5981.7607295707685, 5656.490915817596, 5713.400092990176, 5736.225609542658, 5796.478316951495, 5804.970975145097, 5673.0, 5685.943140568541, 5696.715164241688, 5718.51392631631, 5727.971360143172, 5382.865428364322, 5548.861278468071, 5616.017196990429, 5626.943730562642, 5628.380878103487, 5769.68266745333, 5789.189513468202, 5851.268591426072, 5861.472467477947, 5891.38140495259, 5474.8905021898545, 5739.757037274094, 5740.483356497935, 5771.7979870706, 5794.7682092717505], "value": 4345.660679069298, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.391532409142, 747.4842358772447, 777.1024466740913, 791.0072858562502, 829.7635173975418, 15115.395384184632, 15263.923680381611, 15403.614909627266, 15587.298571564279, 15878.444254451082, 13629.522966696168, 13698.589042328722, 13728.244946527937, 13729.725405491885, 13732.176069435816, 731.7841236835146, 864.0927026622053, 887.3965703321722, 896.9103089691044, 905.5608030105394, 887.201518633232, 891.1979218703186, 893.2675206330812, 893.9463632182058, 894.1192924968933, 942.8679984802098, 945.4469135555673, 946.7491114854569, 946.7964387656652, 947.6114792934898, 755.9395248380143, 891.3671293381707, 921.2491819167357, 921.3826736086838, 927.3137877970254, 678.2268214235775, 681.0839420978775, 682.3585829320473, 683.1767719897512, 683.4498228925713, 15237.238138093162, 15250.23748812555, 15284.617884552865, 15285.0, 15292.770608440882, 14789.40842366304, 14817.259137043106, 15029.924850375788, 15097.0, 15183.62040948974, 12023.63929082129, 12045.759084818343, 12213.389330533439, 12215.511379544807, 12255.69360765979, 4410.426644536222, 4540.772961351952, 4574.931376029363, 4601.4248218972625, 4675.18184317743, 78039.0, 78772.60613696894, 79007.0, 79592.60203699002, 79598.60200699017, 11907.464164112636, 11937.641870743892, 11962.58130965412, 11991.400429978466, 12010.099242556844, 23130.7686923132, 23134.42163945915, 23138.074477021066, 23165.76834231636, 23174.304770856903, 8548.316134709208, 8582.957085214533, 8645.524496152771, 8685.91314086851, 8768.430052046597, 4797.784099715521, 4808.3027960945465, 4854.05345957542, 4868.902621947541, 4891.241857512091, 3512.5258090157504, 3646.6717995380013, 3648.7081033517256, 3652.2330310635066, 3652.945205821915, 586.2291087220292, 598.3059650805045, 600.7056542294245, 603.3242768099757, 631.5582048376785, 652.6280020388333, 754.1327473405628, 762.8512440074132, 792.7859477941039, 793.1909452358562, 10368.274220804471, 10750.354978701303, 10863.945680271549, 10907.781844363068, 10960.177986651033, 606.8513214262446, 674.2818897873749, 684.5618803965466, 716.4769718105708, 733.2044731466418, 4384.6273066789045, 4705.364775755298, 4850.199717046718, 4925.729084900293, 5010.774515146827, 77117.0, 77193.0, 77301.22698773052, 121354.3932280333, 121401.0, 100720.0, 104011.4799425998, 104162.47918760509, 104204.0, 105668.47165764122, 76214.9999999989, 77761.8895244184, 78364.21635783568, 80023.0, 80250.0, 10018.1985441166, 10515.871047122002, 10548.578056877639, 10599.523021464207, 10671.733206669895, 37332.0, 37817.920014399475, 39620.405693914036, 46191.0, 53160.73419632877, 58083.709581451825, 71377.64311178411, 73772.63113684398, 75789.6210518966, 76903.0, 14176.149431034171, 14303.427862885368, 14331.211783352015, 14602.926985365006, 14726.779098313747, 14524.273786310854, 14992.023938094026, 15042.774358384851, 15109.54671359861, 15264.0, 14224.857751422353, 14244.928775356057, 14262.0, 14275.0, 14408.354281967053, 14237.928810355881, 14528.491502797351, 14652.413903443743, 14688.55934321972, 14712.0, 12751.107422480338, 12877.742445150858, 13001.0, 13198.538051168163, 13307.600771976857, 11381.374024428736, 11425.485853136463, 11448.0, 11521.251118677259, 11606.70983225426, 10618.52216650268, 10667.89332106669, 10795.838062429228, 10839.458027098772, 10884.0], "value": 7709.291270853336, "unit": "score"}], "name": "dromaeo_css", "value": 7549.070523646761, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 110.0, 111.0, 109.0, 110.0, 110.0, 109.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 139.0, 164.0, 129.0, 124.0, 155.0, 126.0, 190.0, 127.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 121.0, 75.0, 75.0, 74.0, 75.0, 99.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 85.0, 84.0, 117.0, 84.0, 84.0, 132.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 149.0, 148.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 55.0, 50.0, 50.0, 50.0, 50.0, 52.0, 51.0, 50.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 62.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 78.0, 78.0, 79.0, 79.0, 78.0, 108.0, 78.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 127.0, 121.0, 132.0, 114.0, 115.0, 121.0, 126.0, 135.0, 128.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 156.0, 155.0, 155.0, 155.0, 160.0, 153.0, 152.0, 152.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 65.0, 60.0, 62.0, 62.0, 60.0, 60.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1480.9, "alertThreshold": 2.0}]} 16:13:26 INFO - Return code: 0 16:13:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:26 ERROR - # TBPL SUCCESS # 16:13:26 INFO - Running post-action listener: _resource_record_post_action 16:13:26 INFO - ##### 16:13:26 INFO - ##### Finished run-tests step (success) 16:13:26 INFO - ##### 16:13:26 INFO - Running post-run listener: _resource_record_post_run 16:13:26 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 286720; Write bytes: 503808000; Read time: 28; Write time: 427896 16:13:26 INFO - TinderboxPrint: CPU usage
13.1% 16:13:26 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 28 16:13:26 INFO - TinderboxPrint: I/O write bytes / time
503,808,000 / 427,896 16:13:26 INFO - TinderboxPrint: CPU idle
8,249.6 (86.9%) 16:13:26 INFO - TinderboxPrint: CPU user
1,196.7 (12.6%) 16:13:26 INFO - TinderboxPrint: Swap in / out
0 / 0 16:13:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252375040; Read time: 0; Write time: 276400 16:13:26 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250847232; Read time: 16; Write time: 151476 16:13:27 INFO - Running post-run listener: _upload_blobber_files 16:13:27 INFO - Blob upload gear active. 16:13:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:27 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 16:13:27 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'] 16:13:27 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 16:13:27 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:28 INFO - (blobuploader) - INFO - Done attempting. 16:13:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:29 INFO - (blobuploader) - INFO - Done attempting. 16:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:33 INFO - (blobuploader) - INFO - Done attempting. 16:13:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:33 INFO - Return code: 0 16:13:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf3d47439208f13006835bc56dab9f7f819d722b7a2a109e67106c2398b7fb0556d067bde22ba76ba2e87892bb56c631ab0c8a8160cf4d75ff1683981dc2bd12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94380ab730371cd45a485b626f0c9c3ec7976dbbd857940e333d16256e0f08770140b0c87c39a880d9433ecab3794ab21961c79fe45628926ac72c5a613b5de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b091757815770a4bbda4d7382ca97a134941b1d13f52b8553fa69cf622e1c9fcf38d32d1e29f92674804f7886b64b04dca6e0d89332a3f907927bbe247850f28"} 16:13:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:33 INFO - Contents: 16:13:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf3d47439208f13006835bc56dab9f7f819d722b7a2a109e67106c2398b7fb0556d067bde22ba76ba2e87892bb56c631ab0c8a8160cf4d75ff1683981dc2bd12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94380ab730371cd45a485b626f0c9c3ec7976dbbd857940e333d16256e0f08770140b0c87c39a880d9433ecab3794ab21961c79fe45628926ac72c5a613b5de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b091757815770a4bbda4d7382ca97a134941b1d13f52b8553fa69cf622e1c9fcf38d32d1e29f92674804f7886b64b04dca6e0d89332a3f907927bbe247850f28"} 16:13:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:33 INFO - Copying logs to upload dir... 16:13:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.250626 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-27 16:13:33.685046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:33.688964) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887 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/bf3d47439208f13006835bc56dab9f7f819d722b7a2a109e67106c2398b7fb0556d067bde22ba76ba2e87892bb56c631ab0c8a8160cf4d75ff1683981dc2bd12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94380ab730371cd45a485b626f0c9c3ec7976dbbd857940e333d16256e0f08770140b0c87c39a880d9433ecab3794ab21961c79fe45628926ac72c5a613b5de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b091757815770a4bbda4d7382ca97a134941b1d13f52b8553fa69cf622e1c9fcf38d32d1e29f92674804f7886b64b04dca6e0d89332a3f907927bbe247850f28"} build_url:https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf3d47439208f13006835bc56dab9f7f819d722b7a2a109e67106c2398b7fb0556d067bde22ba76ba2e87892bb56c631ab0c8a8160cf4d75ff1683981dc2bd12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94380ab730371cd45a485b626f0c9c3ec7976dbbd857940e333d16256e0f08770140b0c87c39a880d9433ecab3794ab21961c79fe45628926ac72c5a613b5de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b091757815770a4bbda4d7382ca97a134941b1d13f52b8553fa69cf622e1c9fcf38d32d1e29f92674804f7886b64b04dca6e0d89332a3f907927bbe247850f28"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:33.714821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:33.715189) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469659949.707795-455282887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:33.800591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 16:13:33.800957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 16:13:33.801357) ========= ========= Total master_lag: 0.27 =========