builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1467729659.95 results: success (0) buildid: 20160705051223 builduid: 059a60e25cf749c2807e671a1c772c44 revision: c6b972226566ca6230a11b58577178f5992c1064 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 07:40:59.948207) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 07:40:59.948682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 07:40:59.949001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 07:40:59.988225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:40:59.988517) ========= 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=af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 07:41:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.5M=0.001s 2016-07-05 07:41:00 (17.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086779 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.091025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.091397) ========= 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=af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013840 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.142497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.142881) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c6b972226566ca6230a11b58577178f5992c1064 --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 c6b972226566ca6230a11b58577178f5992c1064 --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=af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 07:41:01,032 truncating revision to first 12 chars 2016-07-05 07:41:01,032 Setting DEBUG logging. 2016-07-05 07:41:01,033 attempt 1/10 2016-07-05 07:41:01,033 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c6b972226566?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 07:41:01,317 unpacking tar archive at: mozilla-aurora-c6b972226566/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.763294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.763585) ========= script_repo_revision: c6b972226566ca6230a11b58577178f5992c1064 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.763951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.764213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 07:41:00.785105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-05 07:41:00.785466) ========= /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=af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:41:01 INFO - MultiFileLogger online at 20160705 07:41:01 in /builds/slave/test 07:41:01 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 07:41:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:01 INFO - {'append_to_log': False, 07:41:01 INFO - 'base_work_dir': '/builds/slave/test', 07:41:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:41:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:01 INFO - 'branch': 'Mozilla-Aurora', 07:41:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:01 INFO - 'config_files': ('talos/linux_config.py',), 07:41:01 INFO - 'default_actions': ('clobber', 07:41:01 INFO - 'read-buildbot-config', 07:41:01 INFO - 'download-and-extract', 07:41:01 INFO - 'populate-webroot', 07:41:01 INFO - 'create-virtualenv', 07:41:01 INFO - 'install', 07:41:01 INFO - 'run-tests'), 07:41:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:01 INFO - 'download_minidump_stackwalk': True, 07:41:01 INFO - 'download_symbols': 'ondemand', 07:41:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:01 INFO - 'installer_path': 'installer.exe', 07:41:01 INFO - 'log_level': 'info', 07:41:01 INFO - 'log_name': 'talos', 07:41:01 INFO - 'log_to_console': True, 07:41:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:41:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:41:01 INFO - 'opt_config_files': (), 07:41:01 INFO - 'pip_index': False, 07:41:01 INFO - 'sps_profile': False, 07:41:01 INFO - 'sps_profile_interval': 0, 07:41:01 INFO - 'suite': 'dromaeojs', 07:41:01 INFO - 'system_bits': '32', 07:41:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:01 INFO - 'title': 'talos-linux64-ix-020', 07:41:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:01 INFO - 'use_talos_json': True, 07:41:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:01 INFO - 'work_dir': 'build'} 07:41:01 INFO - ##### 07:41:01 INFO - ##### Running clobber step. 07:41:01 INFO - ##### 07:41:01 INFO - Running pre-action listener: _resource_record_pre_action 07:41:01 INFO - Running main action method: clobber 07:41:01 INFO - rmtree: /builds/slave/test/build 07:41:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:02 INFO - Running post-action listener: _resource_record_post_action 07:41:02 INFO - ##### 07:41:02 INFO - ##### Finished clobber step (success) 07:41:02 INFO - ##### 07:41:02 INFO - ##### 07:41:02 INFO - ##### Running read-buildbot-config step. 07:41:02 INFO - ##### 07:41:02 INFO - Running pre-action listener: _resource_record_pre_action 07:41:02 INFO - Running main action method: read_buildbot_config 07:41:02 INFO - Using buildbot properties: 07:41:02 INFO - { 07:41:02 INFO - "project": "", 07:41:02 INFO - "product": "firefox", 07:41:02 INFO - "script_repo_revision": "production", 07:41:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:41:02 INFO - "repository": "", 07:41:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:41:02 INFO - "buildid": "20160705051223", 07:41:02 INFO - "pgo_build": "True", 07:41:02 INFO - "basedir": "/builds/slave/test", 07:41:02 INFO - "buildnumber": 347, 07:41:02 INFO - "slavename": "talos-linux64-ix-020", 07:41:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:41:02 INFO - "platform": "ubuntu64_hw", 07:41:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:41:02 INFO - "branch": "mozilla-aurora", 07:41:02 INFO - "repo_path": "releases/mozilla-aurora", 07:41:02 INFO - "revision": "c6b972226566ca6230a11b58577178f5992c1064", 07:41:02 INFO - "stage_platform": "linux64-pgo", 07:41:02 INFO - "builduid": "059a60e25cf749c2807e671a1c772c44", 07:41:02 INFO - "slavebuilddir": "test" 07:41:02 INFO - } 07:41:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 07:41:02 INFO - Running post-action listener: _resource_record_post_action 07:41:02 INFO - ##### 07:41:02 INFO - ##### Finished read-buildbot-config step (success) 07:41:02 INFO - ##### 07:41:02 INFO - ##### 07:41:02 INFO - ##### Running download-and-extract step. 07:41:02 INFO - ##### 07:41:02 INFO - Running pre-action listener: _resource_record_pre_action 07:41:02 INFO - Running main action method: download_and_extract 07:41:02 INFO - mkdir: /builds/slave/test/build/tests 07:41: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')]} 07:41:02 INFO - https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:41:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:41:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:41:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:03 INFO - Downloaded 1361 bytes. 07:41:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:41:03 INFO - Using the following test package requirements: 07:41:03 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:41:03 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:41:03 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:41:03 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'jsshell-linux-x86_64.zip'], 07:41:03 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:41:03 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:41:03 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:41:03 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:41:03 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:41:03 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:41:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:03 INFO - https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:05 INFO - Downloaded 24526310 bytes. 07:41:05 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'] 07:41:05 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 07:41:06 INFO - Return code: 0 07:41:06 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 07:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:06 INFO - https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:13 INFO - Downloaded 24526310 bytes. 07:41:13 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'] 07:41:13 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 07:41:14 INFO - Return code: 0 07:41: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')]} 07:41:14 INFO - https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:41:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:41:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:41:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:15 INFO - Downloaded 10833369 bytes. 07:41:15 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'] 07:41:15 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 07:41:15 INFO - Return code: 0 07:41:15 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')]} 07:41:15 INFO - https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:41:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kma-pjxJSyeN-udbWWjSCw/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 07:41:17 INFO - Downloaded 63623570 bytes. 07:41:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:17 INFO - mkdir: /builds/slave/test/properties 07:41:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:17 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:17 INFO - Contents: 07:41:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:17 INFO - Running post-action listener: _resource_record_post_action 07:41:17 INFO - Running post-action listener: set_extra_try_arguments 07:41:17 INFO - ##### 07:41:17 INFO - ##### Finished download-and-extract step (success) 07:41:17 INFO - ##### 07:41:17 INFO - ##### 07:41:17 INFO - ##### Running populate-webroot step. 07:41:17 INFO - ##### 07:41:17 INFO - Running pre-action listener: _resource_record_pre_action 07:41:17 INFO - Running main action method: populate_webroot 07:41:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:17 INFO - '--tppagecycles', 07:41:17 INFO - '7'], 07:41:17 INFO - 'tests': ['tsvgm']}}, 07:41:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['damp', 'tps']}, 07:41:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'tests': ['damp', 'tps']}, 07:41:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['dromaeo_dom']}, 07:41:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['a11yr', 07:41:17 INFO - 'ts_paint', 07:41:17 INFO - 'tpaint', 07:41:17 INFO - 'sessionrestore', 07:41:17 INFO - 'sessionrestore_no_auto_restore', 07:41:17 INFO - 'tabpaint']}, 07:41:17 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:17 INFO - 'ts_paint', 07:41:17 INFO - 'tpaint', 07:41:17 INFO - 'sessionrestore', 07:41:17 INFO - 'sessionrestore_no_auto_restore', 07:41:17 INFO - 'tabpaint']}, 07:41:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:17 INFO - 'ts_paint', 07:41:17 INFO - 'tpaint', 07:41:17 INFO - 'sessionrestore', 07:41:17 INFO - 'sessionrestore_no_auto_restore', 07:41:17 INFO - 'tabpaint']}, 07:41:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:17 INFO - 'ts_paint', 07:41:17 INFO - 'tpaint', 07:41:17 INFO - 'sessionrestore', 07:41:17 INFO - 'sessionrestore_no_auto_restore', 07:41:17 INFO - 'tabpaint']}, 07:41:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['a11yr', 07:41:17 INFO - 'ts_paint', 07:41:17 INFO - 'tpaint', 07:41:17 INFO - 'sessionrestore', 07:41:17 INFO - 'sessionrestore_no_auto_restore', 07:41:17 INFO - 'tabpaint']}, 07:41:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['a11yr', 07:41:17 INFO - 'ts_paint', 07:41:17 INFO - 'tpaint', 07:41:17 INFO - 'sessionrestore', 07:41:17 INFO - 'sessionrestore_no_auto_restore', 07:41:17 INFO - 'tabpaint']}, 07:41:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['tsvgx', 07:41:17 INFO - 'tsvgr_opacity', 07:41:17 INFO - 'tart', 07:41:17 INFO - 'tscrollx', 07:41:17 INFO - 'cart']}, 07:41:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:17 INFO - 'tsvgr_opacity', 07:41:17 INFO - 'tart', 07:41:17 INFO - 'tscrollx', 07:41:17 INFO - 'cart']}, 07:41:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'talos_options': ['--disable-e10s'], 07:41:17 INFO - 'tests': ['tp5o']}, 07:41:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'tests': ['tp5o']}, 07:41:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'talos_options': ['--disable-e10s', 07:41:17 INFO - '--xperf_path', 07:41:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:17 INFO - 'tests': ['tp5n']}, 07:41:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:17 INFO - 'talos_options': ['--xperf_path', 07:41:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:17 INFO - 'tests': ['tp5n']}}, 07:41:17 INFO - 'talos.zip': {'path': '', 07:41:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:17 INFO - Running post-action listener: _resource_record_post_action 07:41:17 INFO - ##### 07:41:17 INFO - ##### Finished populate-webroot step (success) 07:41:17 INFO - ##### 07:41:17 INFO - ##### 07:41:17 INFO - ##### Running create-virtualenv step. 07:41:17 INFO - ##### 07:41:17 INFO - Running pre-action listener: _resource_record_pre_action 07:41:17 INFO - Running main action method: create_virtualenv 07:41:17 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:17 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 07:41:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:18 INFO - Using real prefix '/usr' 07:41:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:18 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:20 INFO - Installing pip.................done. 07:41:20 INFO - Return code: 0 07:41:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41: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', 'pip>=1.5'] in /builds/slave/test/build 07:41: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 pip>=1.5 07:41:20 INFO - Using env: {'DISPLAY': ':0', 07:41:20 INFO - 'HOME': '/home/cltbld', 07:41:20 INFO - 'LANG': 'en_US.UTF-8', 07:41:20 INFO - 'LANGUAGE': 'en_US:en', 07:41:20 INFO - 'LOGNAME': 'cltbld', 07:41:20 INFO - 'MAIL': '/var/mail/cltbld', 07:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:20 INFO - 'MOZ_NO_REMOTE': '1', 07:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:20 INFO - 'NO_EM_RESTART': '1', 07:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:20 INFO - 'PWD': '/builds/slave/test', 07:41:20 INFO - 'SHELL': '/bin/bash', 07:41:20 INFO - 'SHLVL': '1', 07:41:20 INFO - 'TERM': 'linux', 07:41:20 INFO - 'TMOUT': '86400', 07:41:20 INFO - 'USER': 'cltbld', 07:41:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:20 INFO - '_': '/tools/buildbot/bin/python'} 07:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:20 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 07:41:20 INFO - Cleaning up... 07:41:20 INFO - Return code: 0 07:41:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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', '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 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:41: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 psutil>=3.1.1 07:41:20 INFO - Using env: {'DISPLAY': ':0', 07:41:20 INFO - 'HOME': '/home/cltbld', 07:41:20 INFO - 'LANG': 'en_US.UTF-8', 07:41:20 INFO - 'LANGUAGE': 'en_US:en', 07:41:20 INFO - 'LOGNAME': 'cltbld', 07:41:20 INFO - 'MAIL': '/var/mail/cltbld', 07:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:20 INFO - 'MOZ_NO_REMOTE': '1', 07:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:20 INFO - 'NO_EM_RESTART': '1', 07:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:20 INFO - 'PWD': '/builds/slave/test', 07:41:20 INFO - 'SHELL': '/bin/bash', 07:41:20 INFO - 'SHLVL': '1', 07:41:20 INFO - 'TERM': 'linux', 07:41:20 INFO - 'TMOUT': '86400', 07:41:20 INFO - 'USER': 'cltbld', 07:41:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:20 INFO - '_': '/tools/buildbot/bin/python'} 07:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:20 INFO - Downloading/unpacking psutil>=3.1.1 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:22 INFO - Installing collected packages: psutil 07:41:22 INFO - Running setup.py install for psutil 07:41:23 INFO - building 'psutil._psutil_linux' extension 07:41:23 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 07:41:23 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 07:41:23 INFO - building 'psutil._psutil_posix' extension 07:41:23 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 07:41:23 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 07:41:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:23 INFO - Successfully installed psutil 07:41:23 INFO - Cleaning up... 07:41:23 INFO - Return code: 0 07:41:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:41:23 INFO - Using env: {'DISPLAY': ':0', 07:41:23 INFO - 'HOME': '/home/cltbld', 07:41:23 INFO - 'LANG': 'en_US.UTF-8', 07:41:23 INFO - 'LANGUAGE': 'en_US:en', 07:41:23 INFO - 'LOGNAME': 'cltbld', 07:41:23 INFO - 'MAIL': '/var/mail/cltbld', 07:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:23 INFO - 'MOZ_NO_REMOTE': '1', 07:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:23 INFO - 'NO_EM_RESTART': '1', 07:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:23 INFO - 'PWD': '/builds/slave/test', 07:41:23 INFO - 'SHELL': '/bin/bash', 07:41:23 INFO - 'SHLVL': '1', 07:41:23 INFO - 'TERM': 'linux', 07:41:23 INFO - 'TMOUT': '86400', 07:41:23 INFO - 'USER': 'cltbld', 07:41:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:23 INFO - '_': '/tools/buildbot/bin/python'} 07:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:41:25 INFO - Installing collected packages: mozsystemmonitor 07:41:25 INFO - Running setup.py install for mozsystemmonitor 07:41:25 INFO - Successfully installed mozsystemmonitor 07:41:25 INFO - Cleaning up... 07:41:25 INFO - Return code: 0 07:41:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:41:25 INFO - Using env: {'DISPLAY': ':0', 07:41:25 INFO - 'HOME': '/home/cltbld', 07:41:25 INFO - 'LANG': 'en_US.UTF-8', 07:41:25 INFO - 'LANGUAGE': 'en_US:en', 07:41:25 INFO - 'LOGNAME': 'cltbld', 07:41:25 INFO - 'MAIL': '/var/mail/cltbld', 07:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:25 INFO - 'MOZ_NO_REMOTE': '1', 07:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:25 INFO - 'NO_EM_RESTART': '1', 07:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:25 INFO - 'PWD': '/builds/slave/test', 07:41:25 INFO - 'SHELL': '/bin/bash', 07:41:25 INFO - 'SHLVL': '1', 07:41:25 INFO - 'TERM': 'linux', 07:41:25 INFO - 'TMOUT': '86400', 07:41:25 INFO - 'USER': 'cltbld', 07:41:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:25 INFO - '_': '/tools/buildbot/bin/python'} 07:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:26 INFO - Downloading/unpacking jsonschema==2.5.1 07:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:41:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:41:27 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 07:41:27 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 07:41:27 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 07:41:27 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 07:41:27 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 07:41:27 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 07:41:28 INFO - Downloading functools32-3.2.3-2.tar.gz 07:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:41:28 INFO - warning: no files found matching '*.txt' 07:41:28 INFO - no previously-included directories found matching 'build' 07:41:28 INFO - no previously-included directories found matching 'dist' 07:41:28 INFO - no previously-included directories found matching '.git*' 07:41:28 INFO - Installing collected packages: jsonschema, functools32 07:41:28 INFO - Running setup.py install for functools32 07:41:28 INFO - warning: no files found matching '*.txt' 07:41:28 INFO - no previously-included directories found matching 'build' 07:41:28 INFO - no previously-included directories found matching 'dist' 07:41:28 INFO - no previously-included directories found matching '.git*' 07:41:28 INFO - Successfully installed jsonschema functools32 07:41:28 INFO - Cleaning up... 07:41:28 INFO - Return code: 0 07:41:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:28 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 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:28 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 07:41:28 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 07:41:28 INFO - Using env: {'DISPLAY': ':0', 07:41:28 INFO - 'HOME': '/home/cltbld', 07:41:28 INFO - 'LANG': 'en_US.UTF-8', 07:41:28 INFO - 'LANGUAGE': 'en_US:en', 07:41:28 INFO - 'LOGNAME': 'cltbld', 07:41:28 INFO - 'MAIL': '/var/mail/cltbld', 07:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:28 INFO - 'MOZ_NO_REMOTE': '1', 07:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:28 INFO - 'NO_EM_RESTART': '1', 07:41:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:28 INFO - 'PWD': '/builds/slave/test', 07:41:28 INFO - 'SHELL': '/bin/bash', 07:41:28 INFO - 'SHLVL': '1', 07:41:28 INFO - 'TERM': 'linux', 07:41:28 INFO - 'TMOUT': '86400', 07:41:28 INFO - 'USER': 'cltbld', 07:41:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:28 INFO - '_': '/tools/buildbot/bin/python'} 07:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:31 INFO - Downloading docopt-0.6.1.tar.gz 07:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:31 INFO - Running setup.py install for blobuploader 07:41:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:31 INFO - Running setup.py install for requests 07:41:31 INFO - Running setup.py install for docopt 07:41:31 INFO - Successfully installed blobuploader requests docopt 07:41:31 INFO - Cleaning up... 07:41:31 INFO - Return code: 0 07:41:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:31 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')]} 07:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:31 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')]} 07:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:31 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 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:31 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 07:41:31 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 07:41:31 INFO - Using env: {'DISPLAY': ':0', 07:41:31 INFO - 'HOME': '/home/cltbld', 07:41:31 INFO - 'LANG': 'en_US.UTF-8', 07:41:31 INFO - 'LANGUAGE': 'en_US:en', 07:41:31 INFO - 'LOGNAME': 'cltbld', 07:41:31 INFO - 'MAIL': '/var/mail/cltbld', 07:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:31 INFO - 'MOZ_NO_REMOTE': '1', 07:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:31 INFO - 'NO_EM_RESTART': '1', 07:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:31 INFO - 'PWD': '/builds/slave/test', 07:41:31 INFO - 'SHELL': '/bin/bash', 07:41:31 INFO - 'SHLVL': '1', 07:41:31 INFO - 'TERM': 'linux', 07:41:31 INFO - 'TMOUT': '86400', 07:41:31 INFO - 'USER': 'cltbld', 07:41:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:31 INFO - '_': '/tools/buildbot/bin/python'} 07:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:32 INFO - Running setup.py (path:/tmp/pip-Qy66RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:32 INFO - Running setup.py (path:/tmp/pip-x1PLTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:32 INFO - Running setup.py (path:/tmp/pip-oLX4pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:32 INFO - Running setup.py (path:/tmp/pip-tLRkm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:32 INFO - Running setup.py (path:/tmp/pip-wUPgKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:32 INFO - Running setup.py (path:/tmp/pip-LW3QU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:32 INFO - Running setup.py (path:/tmp/pip-nIM0cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:32 INFO - Running setup.py (path:/tmp/pip-owifJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:32 INFO - Running setup.py (path:/tmp/pip-POenei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:32 INFO - Running setup.py (path:/tmp/pip-Akj2dO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:32 INFO - Running setup.py (path:/tmp/pip-ZA4ngT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:32 INFO - Running setup.py (path:/tmp/pip-FthAvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:32 INFO - Running setup.py (path:/tmp/pip-dntJFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:33 INFO - Running setup.py (path:/tmp/pip-c76d1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:33 INFO - Running setup.py (path:/tmp/pip-jADH4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:33 INFO - Running setup.py (path:/tmp/pip-nkBgGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:33 INFO - Running setup.py (path:/tmp/pip-CHmnzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:41:33 INFO - Running setup.py install for manifestparser 07:41:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:41:33 INFO - Running setup.py install for mozcrash 07:41:33 INFO - Running setup.py install for mozdebug 07:41:33 INFO - Running setup.py install for mozdevice 07:41:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:41:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:41:33 INFO - Running setup.py install for mozfile 07:41:33 INFO - Running setup.py install for mozhttpd 07:41:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:41:33 INFO - Running setup.py install for mozinfo 07:41:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Running setup.py install for mozInstall 07:41:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Running setup.py install for mozleak 07:41:34 INFO - Running setup.py install for mozlog 07:41:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Running setup.py install for moznetwork 07:41:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Running setup.py install for mozprocess 07:41:34 INFO - Running setup.py install for mozprofile 07:41:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Running setup.py install for mozrunner 07:41:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:41:34 INFO - Running setup.py install for mozscreenshot 07:41:34 INFO - Running setup.py install for moztest 07:41:34 INFO - Running setup.py install for mozversion 07:41:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:41:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:41:35 INFO - Cleaning up... 07:41:35 INFO - Return code: 0 07:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:35 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')]} 07:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:35 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')]} 07:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:35 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 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:35 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 07:41:35 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 07:41:35 INFO - Using env: {'DISPLAY': ':0', 07:41:35 INFO - 'HOME': '/home/cltbld', 07:41:35 INFO - 'LANG': 'en_US.UTF-8', 07:41:35 INFO - 'LANGUAGE': 'en_US:en', 07:41:35 INFO - 'LOGNAME': 'cltbld', 07:41:35 INFO - 'MAIL': '/var/mail/cltbld', 07:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:35 INFO - 'MOZ_NO_REMOTE': '1', 07:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:35 INFO - 'NO_EM_RESTART': '1', 07:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:35 INFO - 'PWD': '/builds/slave/test', 07:41:35 INFO - 'SHELL': '/bin/bash', 07:41:35 INFO - 'SHLVL': '1', 07:41:35 INFO - 'TERM': 'linux', 07:41:35 INFO - 'TMOUT': '86400', 07:41:35 INFO - 'USER': 'cltbld', 07:41:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:35 INFO - '_': '/tools/buildbot/bin/python'} 07:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:35 INFO - Running setup.py (path:/tmp/pip-VCqG1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:35 INFO - Running setup.py (path:/tmp/pip-ccIDuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:35 INFO - Running setup.py (path:/tmp/pip-adKV9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:35 INFO - Running setup.py (path:/tmp/pip-EVyUz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:35 INFO - Running setup.py (path:/tmp/pip-E2p_gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:35 INFO - Running setup.py (path:/tmp/pip-F5WQGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:35 INFO - Running setup.py (path:/tmp/pip-S6iMxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:35 INFO - Running setup.py (path:/tmp/pip-5ph87h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:35 INFO - Running setup.py (path:/tmp/pip-U9RhH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:35 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)) 07:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:35 INFO - Running setup.py (path:/tmp/pip-Jpcmu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:36 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)) 07:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:36 INFO - Running setup.py (path:/tmp/pip-byYpQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:36 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)) 07:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:36 INFO - Running setup.py (path:/tmp/pip-J7fUxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:36 INFO - Running setup.py (path:/tmp/pip-SEOmvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:36 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)) 07:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:36 INFO - Running setup.py (path:/tmp/pip-t7yhtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:36 INFO - Running setup.py (path:/tmp/pip-0BgNFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:36 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)) 07:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:36 INFO - Running setup.py (path:/tmp/pip-d7bqaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:36 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)) 07:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:36 INFO - Running setup.py (path:/tmp/pip-IWUilu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:38 INFO - Downloading blessings-1.6.tar.gz 07:41:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:41:38 INFO - Installing collected packages: blessings 07:41:38 INFO - Running setup.py install for blessings 07:41:38 INFO - Successfully installed blessings 07:41:38 INFO - Cleaning up... 07:41:38 INFO - Return code: 0 07:41:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:41:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:38 INFO - Reading from file tmpfile_stdout 07:41:38 INFO - Current package versions: 07:41:38 INFO - argparse == 1.2.1 07:41:38 INFO - blessings == 1.6 07:41:38 INFO - blobuploader == 1.2.4 07:41:38 INFO - docopt == 0.6.1 07:41:38 INFO - functools32 == 3.2.3-2 07:41:38 INFO - jsonschema == 2.5.1 07:41:38 INFO - manifestparser == 1.1 07:41:38 INFO - mozInstall == 1.12 07:41:38 INFO - mozcrash == 0.17 07:41:38 INFO - mozdebug == 0.1 07:41:38 INFO - mozdevice == 0.48 07:41:38 INFO - mozfile == 1.2 07:41:38 INFO - mozhttpd == 0.7 07:41:38 INFO - mozinfo == 0.9 07:41:38 INFO - mozleak == 0.1 07:41:38 INFO - mozlog == 3.2 07:41:38 INFO - moznetwork == 0.27 07:41:38 INFO - mozprocess == 0.22 07:41:38 INFO - mozprofile == 0.28 07:41:38 INFO - mozrunner == 6.11 07:41:38 INFO - mozscreenshot == 0.1 07:41:38 INFO - mozsystemmonitor == 0.3 07:41:38 INFO - moztest == 0.7 07:41:38 INFO - mozversion == 1.4 07:41:38 INFO - psutil == 3.1.1 07:41:38 INFO - requests == 1.2.3 07:41:38 INFO - wsgiref == 0.1.2 07:41:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:38 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 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:38 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 07:41:38 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 07:41:38 INFO - Using env: {'DISPLAY': ':0', 07:41:38 INFO - 'HOME': '/home/cltbld', 07:41:38 INFO - 'LANG': 'en_US.UTF-8', 07:41:38 INFO - 'LANGUAGE': 'en_US:en', 07:41:38 INFO - 'LOGNAME': 'cltbld', 07:41:38 INFO - 'MAIL': '/var/mail/cltbld', 07:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:38 INFO - 'MOZ_NO_REMOTE': '1', 07:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:38 INFO - 'NO_EM_RESTART': '1', 07:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:38 INFO - 'PWD': '/builds/slave/test', 07:41:38 INFO - 'SHELL': '/bin/bash', 07:41:38 INFO - 'SHLVL': '1', 07:41:38 INFO - 'TERM': 'linux', 07:41:38 INFO - 'TMOUT': '86400', 07:41:38 INFO - 'USER': 'cltbld', 07:41:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:38 INFO - '_': '/tools/buildbot/bin/python'} 07:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 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)) 07:41:39 INFO - Cleaning up... 07:41:39 INFO - Return code: 0 07:41:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 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 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:39 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 07:41:39 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 07:41:39 INFO - Using env: {'DISPLAY': ':0', 07:41:39 INFO - 'HOME': '/home/cltbld', 07:41:39 INFO - 'LANG': 'en_US.UTF-8', 07:41:39 INFO - 'LANGUAGE': 'en_US:en', 07:41:39 INFO - 'LOGNAME': 'cltbld', 07:41:39 INFO - 'MAIL': '/var/mail/cltbld', 07:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:39 INFO - 'MOZ_NO_REMOTE': '1', 07:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:39 INFO - 'NO_EM_RESTART': '1', 07:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:39 INFO - 'PWD': '/builds/slave/test', 07:41:39 INFO - 'SHELL': '/bin/bash', 07:41:39 INFO - 'SHLVL': '1', 07:41:39 INFO - 'TERM': 'linux', 07:41:39 INFO - 'TMOUT': '86400', 07:41:39 INFO - 'USER': 'cltbld', 07:41:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:39 INFO - '_': '/tools/buildbot/bin/python'} 07:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:41:39 INFO - Cleaning up... 07:41:39 INFO - Return code: 0 07:41:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 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 0x7f0a76253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1344020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', '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 07:41:39 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 07:41:39 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 07:41:39 INFO - Using env: {'DISPLAY': ':0', 07:41:39 INFO - 'HOME': '/home/cltbld', 07:41:39 INFO - 'LANG': 'en_US.UTF-8', 07:41:39 INFO - 'LANGUAGE': 'en_US:en', 07:41:39 INFO - 'LOGNAME': 'cltbld', 07:41:39 INFO - 'MAIL': '/var/mail/cltbld', 07:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:39 INFO - 'MOZ_NO_REMOTE': '1', 07:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:39 INFO - 'NO_EM_RESTART': '1', 07:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:39 INFO - 'PWD': '/builds/slave/test', 07:41:39 INFO - 'SHELL': '/bin/bash', 07:41:39 INFO - 'SHLVL': '1', 07:41:39 INFO - 'TERM': 'linux', 07:41:39 INFO - 'TMOUT': '86400', 07:41:39 INFO - 'USER': 'cltbld', 07:41:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:39 INFO - '_': '/tools/buildbot/bin/python'} 07:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:39 INFO - Downloading/unpacking flake8 07:41:39 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 07:41:39 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 07:41:39 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 07:41:39 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 07:41:39 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 07:41:39 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 07:41:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:41:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:41:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:41:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:41:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:41:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:41:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:41:42 INFO - no previously-included directories found matching 'docs/_build' 07:41:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:41:42 INFO - Running setup.py install for pep8 07:41:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:41:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:41:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:41:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:41:42 INFO - no previously-included directories found matching 'docs/_build' 07:41:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:41:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:41:42 INFO - Cleaning up... 07:41:42 INFO - Return code: 0 07:41:42 INFO - Running post-action listener: _resource_record_post_action 07:41:42 INFO - Running post-action listener: _start_resource_monitoring 07:41:42 INFO - Starting resource monitoring. 07:41:42 INFO - ##### 07:41:42 INFO - ##### Finished create-virtualenv step (success) 07:41:42 INFO - ##### 07:41:42 INFO - ##### 07:41:42 INFO - ##### Running install step. 07:41:42 INFO - ##### 07:41:42 INFO - Running pre-action listener: _resource_record_pre_action 07:41:42 INFO - Running main action method: install 07:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:42 INFO - Reading from file tmpfile_stdout 07:41:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:41:42 INFO - Reading from file tmpfile_stdout 07:41:42 INFO - Output received: 07:41:42 INFO - Usage: mozinstall [options] installer 07:41:42 INFO - Options: 07:41:42 INFO - -h, --help show this help message and exit 07:41:42 INFO - -d DEST, --destination=DEST 07:41:42 INFO - Directory to install application into. [default: 07:41:42 INFO - "/builds/slave/test"] 07:41:42 INFO - --app=APP Application being installed. [default: firefox] 07:41:42 INFO - mkdir: /builds/slave/test/build/application 07:41:42 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'] 07:41:42 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 07:41:58 INFO - Reading from file tmpfile_stdout 07:41:58 INFO - Output received: 07:41:58 INFO - /builds/slave/test/build/application/firefox/firefox 07:41:58 INFO - Running post-action listener: _resource_record_post_action 07:41:58 INFO - ##### 07:41:58 INFO - ##### Finished install step (success) 07:41:58 INFO - ##### 07:41:58 INFO - ##### 07:41:58 INFO - ##### Running run-tests step. 07:41:58 INFO - ##### 07:41:58 INFO - Running pre-action listener: _resource_record_pre_action 07:41:58 INFO - Running main action method: run_tests 07:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:41:58 INFO - Python 2.7.3 07:41:58 INFO - Return code: 0 07:41:58 INFO - grabbing minidump binary from tooltool 07:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:58 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 0x13d62e0>, '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 0x1342140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13425d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:41:58 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 07:41:58 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 07:41:58 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 07:41:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:41:59 INFO - Return code: 0 07:41:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:41:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:41:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:41:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:41:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:42:00 INFO - Return code: 0 07:42:00 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/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 07:42:00 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/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 07:42:00 INFO - Using env: {'DISPLAY': ':0', 07:42:00 INFO - 'HOME': '/home/cltbld', 07:42:00 INFO - 'LANG': 'en_US.UTF-8', 07:42:00 INFO - 'LANGUAGE': 'en_US:en', 07:42:00 INFO - 'LOGNAME': 'cltbld', 07:42:00 INFO - 'MAIL': '/var/mail/cltbld', 07:42:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:00 INFO - 'MOZ_NO_REMOTE': '1', 07:42:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:00 INFO - 'NO_EM_RESTART': '1', 07:42:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:00 INFO - 'PWD': '/builds/slave/test', 07:42:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:00 INFO - 'SHELL': '/bin/bash', 07:42:00 INFO - 'SHLVL': '1', 07:42:00 INFO - 'TERM': 'linux', 07:42:00 INFO - 'TMOUT': '86400', 07:42:00 INFO - 'USER': 'cltbld', 07:42:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338', 07:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:00 INFO - '_': '/tools/buildbot/bin/python'} 07:42:00 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/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 07:42:00 INFO - mozversion application_buildid: 20160705051223 07:42:00 INFO - mozversion application_changeset: c6b972226566ca6230a11b58577178f5992c1064 07:42:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:42:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:00 INFO - mozversion application_name: Firefox 07:42:00 INFO - mozversion application_remotingname: firefox-dev 07:42:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:00 INFO - mozversion application_vendor: Mozilla 07:42:00 INFO - mozversion application_version: 49.0a2 07:42:00 INFO - mozversion platform_buildid: 20160705051223 07:42:00 INFO - mozversion platform_changeset: c6b972226566ca6230a11b58577178f5992c1064 07:42:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:00 INFO - mozversion platform_version: 49.0a2 07:42:00 INFO - using testdate: 1467729720 07:42:00 INFO - actual date: 1467729720 07:42:00 INFO - starting webserver on 'localhost:46021' 07:42:00 INFO - SUITE-START | Running 2 tests 07:42:00 INFO - TEST-START | dromaeo_css 07:42:00 INFO - operating with platform_type : linux_ 07:42:00 INFO - Initialising browser for dromaeo_css test... 07:42:00 INFO - TEST-INFO | started process 14859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUT7vex/profile http://localhost:46021/getInfo.html) 07:42:04 INFO - PROCESS | 14859 | __metrics Screen width/height:1600/1200 07:42:04 INFO - PROCESS | 14859 | colorDepth:24 07:42:04 INFO - PROCESS | 14859 | Browser inner width/height: 1024/697 07:42:04 INFO - PROCESS | 14859 | __metrics 07:42:06 ERROR - PROCESS | 14859 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:42:07 INFO - TEST-INFO | 14859: exit 0 07:42:07 INFO - Browser initialized. 07:42:07 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:07 INFO - TEST-INFO | started process 14952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUT7vex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:18 INFO - PROCESS | 14952 | RSS: Main: 148795392 07:42:18 INFO - PROCESS | 14952 | 07:43:09 INFO - PROCESS | 14952 | 1467729789971 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] 07:45:18 INFO - PROCESS | 14952 | Cycle 1(1): loaded http://localhost:46021/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46021/tests/dromaeo/cssquery-ext.html) 07:45:19 INFO - PROCESS | 14952 | RSS: Main: 253743104 07:45:19 INFO - PROCESS | 14952 | 07:48:21 INFO - PROCESS | 14952 | Cycle 1(1): loaded http://localhost:46021/tests/dromaeo/cssquery-ext.html (next: http://localhost:46021/tests/dromaeo/cssquery-jquery.html) 07:48:22 INFO - PROCESS | 14952 | RSS: Main: 227762176 07:48:22 INFO - PROCESS | 14952 | 07:51:24 INFO - PROCESS | 14952 | Cycle 1(1): loaded http://localhost:46021/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46021/tests/dromaeo/cssquery-mootools.html) 07:51:24 INFO - PROCESS | 14952 | RSS: Main: 221564928 07:51:24 INFO - PROCESS | 14952 | 07:54:26 INFO - PROCESS | 14952 | Cycle 1(1): loaded http://localhost:46021/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46021/tests/dromaeo/cssquery-prototype.html) 07:54:27 INFO - PROCESS | 14952 | RSS: Main: 224460800 07:54:27 INFO - PROCESS | 14952 | 07:57:29 INFO - PROCESS | 14952 | Cycle 1(1): loaded http://localhost:46021/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46021/tests/dromaeo/cssquery-yui.html) 07:57:30 INFO - PROCESS | 14952 | RSS: Main: 215252992 07:57:30 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | Cycle 1(1): loaded http://localhost:46021/tests/dromaeo/cssquery-yui.html (next: http://localhost:46021/tests/dromaeo/cssquery-dojo.html) 08:00:32 INFO - PROCESS | 14952 | RSS: Main: 258682880 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | __start_tp_report 08:00:32 INFO - PROCESS | 14952 | _x_x_mozilla_page_load 08:00:32 INFO - PROCESS | 14952 | _x_x_mozilla_page_load_details 08:00:32 INFO - PROCESS | 14952 | |i|pagename|runs| 08:00:32 INFO - PROCESS | 14952 | |0;dojo.html;3319.3029463812595;3345.7825241359296;3346.9497957530643;3350.51417544456;3393.609734880488;5459.617826752124;5532.0318944184755;5550.139728342103;5554.472325129116;5563.721813909298;5554.91667624986;5616.382197958232;5619.269494965659;5622.381538030813;5656.377798442168;4982;5083.771230294646;5094.312267843849;5133.255677926699;5176.50823171798;4946.826861059863;5080.974595127019;5120.129577971754;5123.948760512403;5126.5642420394315;5025.572826309768;5069.290299358093;5101.285819985186;5103.974480127594;5140.151874940649;5142.305788718512;5200.6619569727845;5206.661566998133;5207.297014902978;5228.372595288571;4945.67853089548;5013.799448022075;5049.015441988814;5094.923576146361;5104.821331253388;5396.10964190908;5400.513953744182;5412.783488660449;5447.918281225785;5454.809081682161;6003.759849606011;6012.278526576795;6012.518998480155;6017.368176341465;6022.036474164112;5893.58744887858;5921.052631578969;5964.910526342108;6036.396360363972;6067.332593414721;5609.411011843738;5657;5658.405867383906;5658.97170514153;5659.377468478464;5911.083782013795;6115.388461153849;6125.1731016313115;6127.754889804447;6129.49238426781;5775.711214439261;5816;5832.825015249549;5885.411458854166;5911.822645320647;5962.493188078975;5963.4334738199805;5971.28344598651;5996.70016499182;6000.3999600040515;5794;5907.527397808165;5937.821865344046;5945.940540594539;5948.613340132878;5961.344252132262;6031.24609423822;6034.39656034393;6039.8490037748525;6073.665948372882;4613.446386433649;4615.353850460938;4622.4684161321875;4623.976880115578;4643.117807616542;4035.2333056719717;4075.0627355708352;4082.265192265421;4142.5857414258335;4155.605217504332;5776.306843178845;5790.218320526759;5798.449147330997;5800.651960882361;5823.330317013598;6070.726817293233;6086.482648974887;6088.178095957078;6089.969550152221;6123.112148738408;5544;5620.775168993277;5652.604317697804;5682.346530149086;5720.799772007959;5133.358330208724;5133.820316288987;5135.4094279157625;5136.357955255593;5139.254808052886;6100.0544915537275;6104.4505994460715;6107.45032947028;6107.450329470369;6108.297545782203;5798.1302804579655;5968.22413086296;6015.849603759941;6026.246719160105;6105.206323177958;6129.988551888889;6136.545381847118;6142.8521664701275;6152.138700581832;6159.014557670751;5946.672932988554;5951.077582974646;5952.761889524544;5953.821385358447;5957.165996760544;5768.913466298093;5891;5926.881462370815;5955.612885162451;6009.609375390585;5849.210356601804;5865.5600829937075;5872.148538461985;5881.617694849821;5882.382349853204;5718.628289161191;5823.330317013429;5867.911981320198;5874.647521148745;5888.882222355443;5724.856878578069;5770.422957704196;5793.304803423616;5830.5627077968475;5839.970800145972;5924.11138329254;5954.07711804671;5958.791442299499;5986.790462333797;5994.040953447602;5593.384727679871;5740.311162660508;5845.678487683218;5846.064629659234;5867.765289388377 08:00:32 INFO - PROCESS | 14952 | |1;ext.html;587.9353271140174;630.319255204379;639.8464368551547;654.7119267522293;655.2824657000585;33190.66809331906;45507.54492455075;45858.312125318145;45904;46007.30989035167;47245.52754472463;47479.287810682865;47564.52435475644;47585.286220706716;47605.28592071122;8080.595970201496;8937.597808098652;9083.863742043875;9090.454572725625;10676.199285053613;10512.159027277838;10632.362058276489;10882.347059176434;10908.072813810835;10909;10924.399158046344;10988.890111098906;11002.284851484668;11013.83479247812;11014.284071535365;8208.425410221287;10651.360918344924;10872.347659140476;11011.229213955026;11021.283616564897;10778.676639700821;10841.13270938323;10851.294665846695;10856.891431085745;10858;45360.54639453596;45765;45838.31242531365;45838.31242531365;45916.540834591564;3925.0776067624083;4076.2458945095254;4194.790260486994;4335.978320108411;4532.501424843264;34827.477587836205;35285;35510.64489355099;35556.64443355559;35819.925402237976;4625.301774558856;4695.354416141585;4763.3807605011125;4824.541668541483;4886.902261954741;370479;370693;371495;372778;373043.99999999726;37947.723136611894;68505.65747171332;68676;69151.65424172947;69301;39299.41050884239;41329.793351033055;41341.58658413377;41375.7931210342;41394.586054139676;17392.130393480275;17710.91144544269;17718.379856704953;17725.379611713528;17728.91135544314;13250.337483125804;14438.133711977314;14692.41230350774;14731.116133032052;15082.849171508364;9210.355275130676;9266.07339266068;9307.20888724466;9315.906840931504;9368.625254989724;3522.7357948153476;3533.2403533240476;3536.381133301662;3597.784132952031;3620.6190509483295;1044.7074819050679;1057.9206559508068;1084.8318510630866;1096.2052511928948;1128.7065363005677;33521.66478335185;33798.831005845306;33886.66113338835;34121.31757364839;34366.48450273248;1203.7231436769416;1209.6854817747449;1217.403472298585;1221.8045112781913;1261.5710658376197;17000.234989425506;17334.739978900325;17525.386611468537;17569.297228110987;17726.379576714753;658648;660440;662135;662680;663309;61338;61890;61902.380976190565;61932.38067619356;61956.07065894015;1343.7312537492542;1452.1504919621927;1479.977800332996;1483.3547406878042;1486.1306135910613;33113.17217069593;33353;34279.48580771241;34506.13734656654;34660.30679386348;52322.73838630935;52788.20817687814;52944.73527632337;52959.73520132375;52966;430491;431121;431388;432127;432348;26156;26736.866315668296;26787.598186026837;26869.193924182306;26975.46049079047;50139.74930125326;51640;52506.86030730099;52807;53243.201351978976;42541.574584255;42906.57093429151;43150;43410.131797364505;44160.77919610382;42165.57834421616;43086.94443341075;43150.568494315914;43652.781736091114;44065.77967110144;38330.80834595809;38600.227995440495;42597;44116.33825492556;44532;37308.6269137316;39557.2088558233;39646.207075858896;39834.800825995684;40240.59759402368;29617.703822962358;29692.851535742182;29694;30117.849410753683;30186.698133018388 08:00:32 INFO - PROCESS | 14952 | |2;jquery.html;416.54596489826105;417.3614370013876;428.22277566217304;433.99566004339954;438.3074741907786;18551.35070272541;19565.902170489164;20367.796322036775;21034.789652103475;21048.684269735928;19601;19949;20191.798082019177;20261.189552417887;20291.28980485683;5693.402192769761;5900.704964751767;5938.168656388109;5947.167396564484;5950.5834591578605;4225.302825033866;5833.504152147051;5884.117382392633;6196.597221180631;6512.153420055386;6520.93479065208;6581;6582.341765823403;6594.3075977022445;6595.010748387732;6368.42684158428;6430.807075787734;6533.216014078317;6539;6541.705623246918;3935.5474120476224;5382.165764306539;5650;5660.462256085665;5791.0734282514595;22793;23345.182918597937;23756.524869502686;24281.150159744324;24287.392815179584;2325.232673217851;2654.8008899332435;2799.4261176458776;3024.4102400032;3037.893673721409;10727.35635861843;10982.780344393148;11068.889311106866;11211.66365009051;11627.825582616268;2043.2439997200981;2055.629986602411;2062.278202629083;2167.6640120781303;2200.6368949123375;81616;86573.99999999937;87799.56100219458;88468;88571.55714221451;11283.435828208556;11329.603463878724;11490;11638;11754.88245117555;16522.0912849792;16547.586310342096;16660.33358665664;16691.41580044717;16698;8452.788680283042;8560.143985601515;8637.654493820177;8644.567771611395;8717.30261579072;8433.072362040171;8450.19723126302;8504.428140181139;8599.26906212979;8699.260562852101;4989.5758860496535;5075.898482030412;5076.416212135578;5110.233464980282;5157.277981082651;1766.8454945919727;1937.3316205908939;1977.5451646121473;2042.805933436321;2056.0747663551165;930.9348345615742;991.3605724307781;998.336106489191;1011.3729487717662;1031.0771859185986;19116.2353505861;19245.13396897143;19418.223271069;19448.22207111728;19784.90107549453;1027.4708525109575;1031.097789434245;1052.736815796051;1081.1404933078065;1098.3464838421128;10231.181505479544;10901.563937442414;10956.945215274032;10961.506732197071;10964.451777411097;483268;512010;521129;532218;537550;98567.50716246373;101640.49179754054;101884;102782;103101;1027.3322340478599;1045.785613949154;1047.5024363427463;1049.5539395756773;1057.3391630231106;16974.151292435083;17122.74315885238;17323.307067717655;17476.388326409022;17596.20817063261;40454;40629.90410843637;40746.32885675483;41104;42045.78977105217;55738;57164.1425378628;59009.40990590211;59074.40925590689;59139.40860591339;8695.521746304014;8782.429142105742;8791.956040219759;8873.378863479495;9061.546922653974;8947.686830961145;9362.95318523403;13181.934090329487;13527.797083043959;13689.31553422305;11979.820302695292;12112;12456.813147802972;12530.122891397516;12576.87423125757;11696.473658685209;11818.231814932002;11993.220440671677;12015.399230038638;12027.75944481123;11553.075753939833;11753.83239335132;11818.940905295418;12519.436625351698;13072.411741471466;9006.909930900869;9063.818723625622;9206.401583897024;9333.673321433716;9363;9383.014783447912;10375.221858360805;12368.75262494763;12524.749505009666;12534.937325313314 08:00:32 INFO - PROCESS | 14952 | |3;mootools.html;1379.4413262628627;1531.816182058153;1567.3103834312903;1706.2066139245248;1844.2715127524637;8919.777005574855;9248.121428464301;9256.305777066722;9347.532623368821;9392.154706076451;9147.17675409213;9354.204892584139;9355.485448300358;9357.391769534992;9360.71917842464;2397.5324811661735;2419.4314336130997;2422.0553983946274;2424.9757502425014;2428.574999375111;2388.4864754077958;2430.829841911067;2441.7436169202247;2442.2673198040607;2443.450223699671;2403.2790162951133;2433.9634905476432;2436.0986435019067;2468.728439871613;2472.208893154191;2334.9066037358484;2343.297010896733;2349.2834685421026;2375.3586531636533;2424.200013995395;2346.953060938789;2377.072941552796;2382.1424287256573;2387.8328517003815;2387.877697482181;7798.571078590675;7924;9261.490618016007;9311.255099592016;9314.767130821716;4726.172919739032;4890.5109489051165;4893.951060489385;5396.460353964611;5538.113901775697;3417.9145521361916;3479.3215323012023;3524.823758812049;3580.6061333253583;3600.4059330210484;1224.8285240066398;1228.12189284661;1251.0992085698283;1263.425141560597;1265.7848165811743;11967.401629918557;11990.220635658741;12037.037037037016;12044.277343359427;12045.518179272818;4785.880352991203;4887.462379138363;4895.339129217581;4903.509649035068;4952.603791696655;9732.854007189897;9760.463174525326;9787.36382135159;9811;9815.803683926282;5458.808941687022;5476.726163691799;5477.123660214346;5481.342238931354;5481.616286859881;4791.832285870048;4907.68100073494;4946.0355230729665;4956.231784073474;4975.950240497621;4080.4695389599756;4152.974900370586;4176.479356088872;4194.496660400771;4201.138766552849;1324.9536266230637;1358.4634069542476;1364.6383708317303;1370.9314534273246;1381.6131483184724;885.1369914333474;986.2947992185622;1000.4897502273748;1062.8671416072991;1079.63292480557;6503.6097834130105;6550.737970481127;6608.471322294205;6643.169603799525;6643.335666433318;487.3712910345685;487.4443134826301;488.655497873998;518.6602775182262;518.6784193799792;4339.435873336509;4339.479262488521;4376.496702879146;4393.956060439418;4437.290033594674;11306.434678266054;11626.593069242535;11675.124365672438;11687.766244675058;11689.707757305965;11120.777584448428;11566.42167891602;11599.710007249887;11647.6505704829;11652.76694466106;8463.449875758179;8581.65673373058;8627.827443451095;8636.093210212963;8636.790849281106;6298.685065746786;6569.883119869538;6601.9669901652105;6636.966815165893;6648.135742353463;10668.733281668021;10917.727056823644;10941.070009049;10978.945105274743;11051.778964420828;11076.778464430827;11080.889191107986;11190.216684831983;11192.944035279772;11239.831402529133;8081.717139900075;8137.877931830909;8138.633761480629;8243.670253189804;8259.793505162419;9030.729078127666;9032.23226025769;9072.95463522678;9117.5441227937;9121.726348209564;8093.231143041402;8093.312068474245;8109.39179561547;8256.215659512336;8321.292690121407;8120.390970677105;8166.714165004197;8215.383846211438;8280.171982801672;8282.378821588285;7157.212706602374;7329.963350183429;7330.780076597711;7331.193568707331;7335.449841262033;5483.341998960151;5580.414056524169;5631.493165615114;5635.549156067423;5821.476067153976;5436.238926550207;5488.4237155098135;5534.861628459321;5543.861403464784;5624.184493248538 08:00:32 INFO - PROCESS | 14952 | |4;prototype.html;359.41236079010815;364.09703934243083;365.1182394517241;366.5345011834971;371.61166580922935;5399.622026458154;5454.127339625661;5487.862803429911;5537.390887002432;5560.443955604437;5326.360836699591;5434.510894019538;5477.808276710316;5508.834734957948;5524.972375138119;4325.545817689144;4338.1540599583095;4340.263894442217;4376.496702879178;4376.606105450509;4310.892227694317;4347.760873151976;4348.847790327339;4379.583939525756;4384.824607015731;4291.570842915699;4307.892302692427;4332.545082766312;4332.610065094141;4371.431713877191;4084.81618327176;4268.871933841959;4293.22721910056;4309.383981007122;4352.586504282088;3750.362438385481;3754.699624030098;3775.9056023599355;3779.7732136071922;3785.470034195215;5322.946770532284;5325.973370133124;5331.840044798662;5351.759170837322;5353.491418315254;4718.976405117986;4895;4911.803527858881;4911.803527858881;4925.926111108336;5692.345380281279;5704.800331988402;5715.485606295453;5723.912456633227;5742.626729262584;4150.771707556083;4173.457450531411;4173.9582604173875;4188.267053265697;4190.120074784299;5591.434398368423;5723.542116630618;5784.739686714066;5877.735501902424;5929.673867937262;4223.640990515841;4226.852060177879;4237.279662457389;4239.173361194537;4239.448871646666;4302.462192225972;4306.76048454808;4320.719153255029;4328.523862375137;4344.500382455994;4671.672982891165;4707.270373092176;4790.568848803555;4808.27875818623;4938.950610493921;5771.509421699118;5796.797112101141;5807.738651760681;5822.563307751935;5834.387389324144;1490.1729540105346;1506.9074920682417;1512.2438780609696;1516.4616561120863;1518.1346632419636;932.1424289653535;945.432740355781;949.6913503111516;960.7838236396755;962.2254085461271;5085.398099598615;5090.821821236239;5115.212209345916;5119.462456442095;5124.513890971651;5246.895062098813;5259.815906443256;5268.578513718893;5285.735713214324;5298.337707786527;4758.500357462486;4924.482929292444;5010.369555983138;5075.071472840371;5098.439171691111;2781.3185769486604;2786.7352601502826;2794.776417886564;2798.398344355973;2800.6219160413084;5258.317338451735;5275.736213189325;5323.787048518016;5353.357597088297;5387.326584176978;5564.553216163827;6040.244969378828;6040.728167232485;6056.727447264883;6077;5939.346671866091;5964.8807023860145;6023.488003519662;6032.547558933097;6065.787697430569;5704.828855134353;5879.73541190656;5892.587518873809;5898.085796701518;5941.821745347646;5796.652200867961;5844.181814545882;5851.420116568417;5866.67733274674;5891.260563837836;5757.309122905278;5885.47030767233;6005.459508644243;6026.427489388501;6030.849228769316;4242.363645453207;4248.385613466987;4288.871333859989;4290.206311832321;4291.849785257501;5724.084146536534;5830.912536311874;5885.999380105478;5903.468687818117;5944.197533332945;5695.174199741097;5734.770609175586;5735.684537350486;5749.367569567428;5756.3380211276235;5730.828075157752;5735.397783232867;5736.541076713769;5742.36833948257;5742.913856292075;5439.864003399946;5661.603687741983;5679.460451257124;5685.403032681509;5699.435254135573;5757.006356694412;5785.247917770663;5790.768369265183;5819.388964158872;5819.621724587888;5463.617546771847;5721.141828725725;5734.426557344233;5746.741396637245;5754.625949313281 08:00:32 INFO - PROCESS | 14952 | |5;yui.html;799.8960135182425;818.447547905164;833.1834801894144;882.351471668324;936.1013427109972;14859.108453492785;15525.922370388133;15569.37722491099;15637.530874073767;15810.13044282564;15157.92421037896;15224.771628425555;15260.465883694073;15263.618409539768;15268.312925918333;704.7639040921298;816.6855760532178;830.7466222802043;833.0378412933042;855.3200205836343;828.6312590897053;832.3258160889668;832.9125441828612;834.9707760228393;836.3142223376803;881.9559022048904;885.9557022148899;886.2865393358376;886.7871710789397;886.9334799890034;730.4558104212342;861.96983105591;879.6085741844881;881.9647214111428;882.3162049411693;648.9188851393576;651.6448535548137;652;652.1196384880421;652.2433976587183;16236.350545978265;16240.918795406065;16276.918615406847;16291.429799956944;16295.103769292684;15025.173615451145;15274.541763747106;15438.45965391206;15570.455034073753;15829.525114246591;12492;12580.245185288912;12674.9028386501;14084.647883802987;14624.561263162122;4895.2923770467205;4930.654854160211;4939;4978.2034874419915;5074.340335756328;83436;86245.70631440596;86977;87869;88160;12810.80783788244;12907.677308067374;12959.611211663665;13027.47890084405;13246.867531324757;23868.283951481484;23940.640890386658;23944.7605523946;23957.28128156158;23988.88005559996;9510.28672849539;9512.239020878313;9557.61769529211;9610.95194524023;9717.22262219035;4983.07813054586;5039.924401133986;5050.065737838511;5128.435872054071;5134.024535338349;3511.455724362728;3603.94594081089;3605.0266428064274;3611.368010598135;3642.1987162824134;575.2320651929637;584.4418580255846;588.5232961301359;594.4412252482653;598.5630489742425;658.7891874600082;659.947204223661;722.3246264742482;726.2954933714288;726.614894106114;10138.03688649577;10146.391216527032;10300.484975751182;10457.529411176516;10464.00591943764;683.3917813146304;686.9381755642016;750.1785544828405;753.2505157368454;756.8637645223913;4703.294505824154;4808;4924.162892308316;4966.602671786249;4984.2025275955675;68908.31091689119;115836;118371.40814295874;119351.40324298496;119455.40272298583;97576;103074.48462757638;103117.48441257895;103482.48258758809;103509.48245258877;81871;87943.56028219817;87995.56002220076;88522;88772;9960.850587241051;10205.38767673942;10818.513166907665;11232.943835280772;11298.887011130113;45449;47617.761911190224;48160.795980100775;52684.47315526949;55026.724866377015;50744.49255507398;75481;76253.61873190598;77568.2243177561;77865;13125.73748525005;13194.736105278032;13343.733125337632;13379.799303010268;14402;15200.847991519944;15260.542183734506;15534.61163470877;15601.415152853253;16444.177791110636;14377.281135942952;14404.351804169048;14781.704365912836;15050.548483545512;15567.143807090719;13846.723065538834;14056.578302650936;14184.290785460893;15254.466093686668;15705.921470392575;14422.423103076178;14558.927205363905;14948.177850218342;15083;15665.216739163225;11411.60059397917;11665.825012624648;12267.202631828903;12837.101402901708;13124.540641077898;12172.208806427554;12440.875591243972;12621.873781262437;12696.6825829355;12823.230606163661 08:00:32 INFO - PROCESS | 14952 | __end_tp_report 08:00:32 INFO - PROCESS | 14952 | __start_cc_report 08:00:32 INFO - PROCESS | 14952 | _x_x_mozilla_cycle_collect,872 08:00:32 INFO - PROCESS | 14952 | __end_cc_report 08:00:32 INFO - PROCESS | 14952 | __startTimestamp1467730832909__endTimestamp 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | ------- Summary: start ------- 08:00:32 INFO - PROCESS | 14952 | Number of tests: 6 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | [#0] dojo.html Cycles:165 Average:5564.36 Median:5798.45 stddev:614.24 (10.6%) stddev-sans-first:590.34 08:00:32 INFO - PROCESS | 14952 | Values: 3319.3 3345.8 3346.9 3350.5 3393.6 5459.6 5532.0 5550.1 5554.5 5563.7 5554.9 5616.4 5619.3 5622.4 5656.4 4982.0 5083.8 5094.3 5133.3 5176.5 4946.8 5081.0 5120.1 5123.9 5126.6 5025.6 5069.3 5101.3 5104.0 5140.2 5142.3 5200.7 5206.7 5207.3 5228.4 4945.7 5013.8 5049.0 5094.9 5104.8 5396.1 5400.5 5412.8 5447.9 5454.8 6003.8 6012.3 6012.5 6017.4 6022.0 5893.6 5921.1 5964.9 6036.4 6067.3 5609.4 5657.0 5658.4 5659.0 5659.4 5911.1 6115.4 6125.2 6127.8 6129.5 5775.7 5816.0 5832.8 5885.4 5911.8 5962.5 5963.4 5971.3 5996.7 6000.4 5794.0 5907.5 5937.8 5945.9 5948.6 5961.3 6031.2 6034.4 6039.8 6073.7 4613.4 4615.4 4622.5 4624.0 4643.1 4035.2 4075.1 4082.3 4142.6 4155.6 5776.3 5790.2 5798.4 5800.7 5823.3 6070.7 6086.5 6088.2 6090.0 6123.1 5544.0 5620.8 5652.6 5682.3 5720.8 5133.4 5133.8 5135.4 5136.4 5139.3 6100.1 6104.5 6107.5 6107.5 6108.3 5798.1 5968.2 6015.8 6026.2 6105.2 6130.0 6136.5 6142.9 6152.1 6159.0 5946.7 5951.1 5952.8 5953.8 5957.2 5768.9 5891.0 5926.9 5955.6 6009.6 5849.2 5865.6 5872.1 5881.6 5882.4 5718.6 5823.3 5867.9 5874.6 5888.9 5724.9 5770.4 5793.3 5830.6 5840.0 5924.1 5954.1 5958.8 5986.8 5994.0 5593.4 5740.3 5845.7 5846.1 5867.8 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | [#1] ext.html Cycles:180 Average:64629.50 Median:21612.24 stddev:134385.26 (621.8%) stddev-sans-first:134676.22 08:00:32 INFO - PROCESS | 14952 | Values: 587.9 630.3 639.8 654.7 655.3 33190.7 45507.5 45858.3 45904.0 46007.3 47245.5 47479.3 47564.5 47585.3 47605.3 8080.6 8937.6 9083.9 9090.5 10676.2 10512.2 10632.4 10882.3 10908.1 10909.0 10924.4 10988.9 11002.3 11013.8 11014.3 8208.4 10651.4 10872.3 11011.2 11021.3 10778.7 10841.1 10851.3 10856.9 10858.0 45360.5 45765.0 45838.3 45838.3 45916.5 3925.1 4076.2 4194.8 4336.0 4532.5 34827.5 35285.0 35510.6 35556.6 35819.9 4625.3 4695.4 4763.4 4824.5 4886.9 370479.0 370693.0 371495.0 372778.0 373044.0 37947.7 68505.7 68676.0 69151.7 69301.0 39299.4 41329.8 41341.6 41375.8 41394.6 17392.1 17710.9 17718.4 17725.4 17728.9 13250.3 14438.1 14692.4 14731.1 15082.8 9210.4 9266.1 9307.2 9315.9 9368.6 3522.7 3533.2 3536.4 3597.8 3620.6 1044.7 1057.9 1084.8 1096.2 1128.7 33521.7 33798.8 33886.7 34121.3 34366.5 1203.7 1209.7 1217.4 1221.8 1261.6 17000.2 17334.7 17525.4 17569.3 17726.4 658648.0 660440.0 662135.0 662680.0 663309.0 61338.0 61890.0 61902.4 61932.4 61956.1 1343.7 1452.2 1480.0 1483.4 1486.1 33113.2 33353.0 34279.5 34506.1 34660.3 52322.7 52788.2 52944.7 52959.7 52966.0 430491.0 431121.0 431388.0 432127.0 432348.0 26156.0 26736.9 26787.6 26869.2 26975.5 50139.7 51640.0 52506.9 52807.0 53243.2 42541.6 42906.6 43150.0 43410.1 44160.8 42165.6 43086.9 43150.6 43652.8 44065.8 38330.8 38600.2 42597.0 44116.3 44532.0 37308.6 39557.2 39646.2 39834.8 40240.6 29617.7 29692.9 29694.0 30117.8 30186.7 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | [#2] jquery.html Cycles:180 Average:30422.38 Median:23550.85 stddev:85451.33 (362.8%) stddev-sans-first:85661.34 08:00:32 INFO - PROCESS | 14952 | Values: 416.5 417.4 428.2 434.0 438.3 18551.4 19565.9 20367.8 21034.8 21048.7 19601.0 19949.0 20191.8 20261.2 20291.3 5693.4 5900.7 5938.2 5947.2 5950.6 4225.3 5833.5 5884.1 6196.6 6512.2 6520.9 6581.0 6582.3 6594.3 6595.0 6368.4 6430.8 6533.2 6539.0 6541.7 3935.5 5382.2 5650.0 5660.5 5791.1 22793.0 23345.2 23756.5 24281.2 24287.4 2325.2 2654.8 2799.4 3024.4 3037.9 10727.4 10982.8 11068.9 11211.7 11627.8 2043.2 2055.6 2062.3 2167.7 2200.6 81616.0 86574.0 87799.6 88468.0 88571.6 11283.4 11329.6 11490.0 11638.0 11754.9 16522.1 16547.6 16660.3 16691.4 16698.0 8452.8 8560.1 8637.7 8644.6 8717.3 8433.1 8450.2 8504.4 8599.3 8699.3 4989.6 5075.9 5076.4 5110.2 5157.3 1766.8 1937.3 1977.5 2042.8 2056.1 930.9 991.4 998.3 1011.4 1031.1 19116.2 19245.1 19418.2 19448.2 19784.9 1027.5 1031.1 1052.7 1081.1 1098.3 10231.2 10901.6 10956.9 10961.5 10964.5 483268.0 512010.0 521129.0 532218.0 537550.0 98567.5 101640.5 101884.0 102782.0 103101.0 1027.3 1045.8 1047.5 1049.6 1057.3 16974.2 17122.7 17323.3 17476.4 17596.2 40454.0 40629.9 40746.3 41104.0 42045.8 55738.0 57164.1 59009.4 59074.4 59139.4 8695.5 8782.4 8792.0 8873.4 9061.5 8947.7 9363.0 13181.9 13527.8 13689.3 11979.8 12112.0 12456.8 12530.1 12576.9 11696.5 11818.2 11993.2 12015.4 12027.8 11553.1 11753.8 11818.9 12519.4 13072.4 9006.9 9063.8 9206.4 9333.7 9363.0 9383.0 10375.2 12368.8 12524.7 12534.9 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | [#3] mootools.html Cycles:180 Average:6062.24 Median:4892.23 stddev:3444.01 (70.4%) stddev-sans-first:3435.69 08:00:32 INFO - PROCESS | 14952 | Values: 1379.4 1531.8 1567.3 1706.2 1844.3 8919.8 9248.1 9256.3 9347.5 9392.2 9147.2 9354.2 9355.5 9357.4 9360.7 2397.5 2419.4 2422.1 2425.0 2428.6 2388.5 2430.8 2441.7 2442.3 2443.5 2403.3 2434.0 2436.1 2468.7 2472.2 2334.9 2343.3 2349.3 2375.4 2424.2 2347.0 2377.1 2382.1 2387.8 2387.9 7798.6 7924.0 9261.5 9311.3 9314.8 4726.2 4890.5 4894.0 5396.5 5538.1 3417.9 3479.3 3524.8 3580.6 3600.4 1224.8 1228.1 1251.1 1263.4 1265.8 11967.4 11990.2 12037.0 12044.3 12045.5 4785.9 4887.5 4895.3 4903.5 4952.6 9732.9 9760.5 9787.4 9811.0 9815.8 5458.8 5476.7 5477.1 5481.3 5481.6 4791.8 4907.7 4946.0 4956.2 4976.0 4080.5 4153.0 4176.5 4194.5 4201.1 1325.0 1358.5 1364.6 1370.9 1381.6 885.1 986.3 1000.5 1062.9 1079.6 6503.6 6550.7 6608.5 6643.2 6643.3 487.4 487.4 488.7 518.7 518.7 4339.4 4339.5 4376.5 4394.0 4437.3 11306.4 11626.6 11675.1 11687.8 11689.7 11120.8 11566.4 11599.7 11647.7 11652.8 8463.4 8581.7 8627.8 8636.1 8636.8 6298.7 6569.9 6602.0 6637.0 6648.1 10668.7 10917.7 10941.1 10978.9 11051.8 11076.8 11080.9 11190.2 11192.9 11239.8 8081.7 8137.9 8138.6 8243.7 8259.8 9030.7 9032.2 9073.0 9117.5 9121.7 8093.2 8093.3 8109.4 8256.2 8321.3 8120.4 8166.7 8215.4 8280.2 8282.4 7157.2 7330.0 7330.8 7331.2 7335.4 5483.3 5580.4 5631.5 5635.5 5821.5 5436.2 5488.4 5534.9 5543.9 5624.2 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | [#4] prototype.html Cycles:180 Average:4768.07 Median:5329.10 stddev:1387.83 (26.0%) stddev-sans-first:1351.69 08:00:32 INFO - PROCESS | 14952 | Values: 359.4 364.1 365.1 366.5 371.6 5399.6 5454.1 5487.9 5537.4 5560.4 5326.4 5434.5 5477.8 5508.8 5525.0 4325.5 4338.2 4340.3 4376.5 4376.6 4310.9 4347.8 4348.8 4379.6 4384.8 4291.6 4307.9 4332.5 4332.6 4371.4 4084.8 4268.9 4293.2 4309.4 4352.6 3750.4 3754.7 3775.9 3779.8 3785.5 5322.9 5326.0 5331.8 5351.8 5353.5 4719.0 4895.0 4911.8 4911.8 4925.9 5692.3 5704.8 5715.5 5723.9 5742.6 4150.8 4173.5 4174.0 4188.3 4190.1 5591.4 5723.5 5784.7 5877.7 5929.7 4223.6 4226.9 4237.3 4239.2 4239.4 4302.5 4306.8 4320.7 4328.5 4344.5 4671.7 4707.3 4790.6 4808.3 4939.0 5771.5 5796.8 5807.7 5822.6 5834.4 1490.2 1506.9 1512.2 1516.5 1518.1 932.1 945.4 949.7 960.8 962.2 5085.4 5090.8 5115.2 5119.5 5124.5 5246.9 5259.8 5268.6 5285.7 5298.3 4758.5 4924.5 5010.4 5075.1 5098.4 2781.3 2786.7 2794.8 2798.4 2800.6 5258.3 5275.7 5323.8 5353.4 5387.3 5564.6 6040.2 6040.7 6056.7 6077.0 5939.3 5964.9 6023.5 6032.5 6065.8 5704.8 5879.7 5892.6 5898.1 5941.8 5796.7 5844.2 5851.4 5866.7 5891.3 5757.3 5885.5 6005.5 6026.4 6030.8 4242.4 4248.4 4288.9 4290.2 4291.8 5724.1 5830.9 5886.0 5903.5 5944.2 5695.2 5734.8 5735.7 5749.4 5756.3 5730.8 5735.4 5736.5 5742.4 5742.9 5439.9 5661.6 5679.5 5685.4 5699.4 5757.0 5785.2 5790.8 5819.4 5819.6 5463.6 5721.1 5734.4 5746.7 5754.6 08:00:32 INFO - PROCESS | 14952 | 08:00:32 INFO - PROCESS | 14952 | [#5] yui.html Cycles:180 Average:21454.74 Median:3626.78 stddev:30127.46 (830.7%) stddev-sans-first:30172.06 08:00:32 INFO - PROCESS | 14952 | Values: 799.9 818.4 833.2 882.4 936.1 14859.1 15525.9 15569.4 15637.5 15810.1 15157.9 15224.8 15260.5 15263.6 15268.3 704.8 816.7 830.7 833.0 855.3 828.6 832.3 832.9 835.0 836.3 882.0 886.0 886.3 886.8 886.9 730.5 862.0 879.6 882.0 882.3 648.9 651.6 652.0 652.1 652.2 16236.4 16240.9 16276.9 16291.4 16295.1 15025.2 15274.5 15438.5 15570.5 15829.5 12492.0 12580.2 12674.9 14084.6 14624.6 4895.3 4930.7 4939.0 4978.2 5074.3 83436.0 86245.7 86977.0 87869.0 88160.0 12810.8 12907.7 12959.6 13027.5 13246.9 23868.3 23940.6 23944.8 23957.3 23988.9 9510.3 9512.2 9557.6 9611.0 9717.2 4983.1 5039.9 5050.1 5128.4 5134.0 3511.5 3603.9 3605.0 3611.4 3642.2 575.2 584.4 588.5 594.4 598.6 658.8 659.9 722.3 726.3 726.6 10138.0 10146.4 10300.5 10457.5 10464.0 683.4 686.9 750.2 753.3 756.9 4703.3 4808.0 4924.2 4966.6 4984.2 68908.3 115836.0 118371.4 119351.4 119455.4 97576.0 103074.5 103117.5 103482.5 103509.5 81871.0 87943.6 87995.6 88522.0 88772.0 9960.9 10205.4 10818.5 11232.9 11298.9 45449.0 47617.8 48160.8 52684.5 55026.7 50744.5 75481.0 76253.6 77568.2 77865.0 13125.7 13194.7 13343.7 13379.8 14402.0 15200.8 15260.5 15534.6 15601.4 16444.2 14377.3 14404.4 14781.7 15050.5 15567.1 13846.7 14056.6 14184.3 15254.5 15705.9 14422.4 14558.9 14948.2 15083.0 15665.2 11411.6 11665.8 12267.2 12837.1 13124.5 12172.2 12440.9 12621.9 12696.7 12823.2 08:00:32 INFO - PROCESS | 14952 | -------- Summary: end -------- 08:00:32 INFO - PROCESS | 14952 | 08:00:33 INFO - TEST-INFO | 14952: exit 0 08:00:33 INFO - TEST-OK | dromaeo_css | took 1113409ms 08:00:33 INFO - TEST-START | kraken 08:00:33 INFO - operating with platform_type : linux_ 08:00:33 INFO - Initialising browser for kraken test... 08:00:33 INFO - TEST-INFO | started process 15136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj9hYT3/profile http://localhost:46021/getInfo.html) 08:00:38 INFO - PROCESS | 15136 | __metrics Screen width/height:1600/1200 08:00:38 INFO - PROCESS | 15136 | colorDepth:24 08:00:38 INFO - PROCESS | 15136 | Browser inner width/height: 1024/697 08:00:38 INFO - PROCESS | 15136 | __metrics 08:00:39 ERROR - PROCESS | 15136 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:00:40 INFO - TEST-INFO | 15136: exit 0 08:00:40 INFO - Browser initialized. 08:00:40 INFO - Running cycle 1/1 for kraken test... 08:00:40 INFO - TEST-INFO | started process 15229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj9hYT3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:51 INFO - PROCESS | 15229 | RSS: Main: 145072128 08:00:51 INFO - PROCESS | 15229 | 08:00:54 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46021/tests/kraken/driver.html?testName=audio-beat-detection) 08:00:55 INFO - PROCESS | 15229 | RSS: Main: 194871296 08:00:55 INFO - PROCESS | 15229 | 08:00:57 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46021/tests/kraken/driver.html?testName=audio-dft) 08:00:58 INFO - PROCESS | 15229 | RSS: Main: 189063168 08:00:58 INFO - PROCESS | 15229 | 08:01:01 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46021/tests/kraken/driver.html?testName=audio-fft) 08:01:01 INFO - PROCESS | 15229 | RSS: Main: 279130112 08:01:01 INFO - PROCESS | 15229 | 08:01:03 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46021/tests/kraken/driver.html?testName=audio-oscillator) 08:01:04 INFO - PROCESS | 15229 | RSS: Main: 187113472 08:01:04 INFO - PROCESS | 15229 | 08:01:06 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46021/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:07 INFO - PROCESS | 15229 | RSS: Main: 187568128 08:01:07 INFO - PROCESS | 15229 | 08:01:10 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46021/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:10 INFO - PROCESS | 15229 | RSS: Main: 223064064 08:01:10 INFO - PROCESS | 15229 | 08:01:14 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46021/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:14 INFO - PROCESS | 15229 | RSS: Main: 223731712 08:01:14 INFO - PROCESS | 15229 | 08:01:17 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46021/tests/kraken/driver.html?testName=json-parse-financial) 08:01:18 INFO - PROCESS | 15229 | RSS: Main: 223444992 08:01:18 INFO - PROCESS | 15229 | 08:01:19 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46021/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:20 INFO - PROCESS | 15229 | RSS: Main: 201228288 08:01:20 INFO - PROCESS | 15229 | 08:01:22 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:22 INFO - PROCESS | 15229 | RSS: Main: 202735616 08:01:22 INFO - PROCESS | 15229 | 08:01:24 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:25 INFO - PROCESS | 15229 | RSS: Main: 209461248 08:01:25 INFO - PROCESS | 15229 | 08:01:27 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:28 INFO - PROCESS | 15229 | RSS: Main: 214892544 08:01:28 INFO - PROCESS | 15229 | 08:01:31 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:31 INFO - PROCESS | 15229 | RSS: Main: 214331392 08:01:31 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | Cycle 1(1): loaded http://localhost:46021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46021/tests/kraken/driver.html?testName=ai-astar) 08:01:33 INFO - PROCESS | 15229 | RSS: Main: 256909312 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | __start_tp_report 08:01:33 INFO - PROCESS | 15229 | _x_x_mozilla_page_load 08:01:33 INFO - PROCESS | 15229 | _x_x_mozilla_page_load_details 08:01:33 INFO - PROCESS | 15229 | |i|pagename|runs| 08:01:33 INFO - PROCESS | 15229 | |0;ai-astar;111;106;110;110;112;110;111;115;112;110 08:01:33 INFO - PROCESS | 15229 | |1;audio-beat-detection;147;124;133;188;122;130;158;124;161;124 08:01:33 INFO - PROCESS | 15229 | |2;audio-dft;159;161;160;160;161;161;160;161;160;161 08:01:33 INFO - PROCESS | 15229 | |3;audio-fft;76;76;75;128;76;75;75;75;99;75 08:01:33 INFO - PROCESS | 15229 | |4;audio-oscillator;84;85;121;85;86;85;118;85;86;121 08:01:33 INFO - PROCESS | 15229 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;116;117;116 08:01:33 INFO - PROCESS | 15229 | |6;imaging-darkroom;146;145;146;148;145;145;146;146;145;145 08:01:33 INFO - PROCESS | 15229 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 08:01:33 INFO - PROCESS | 15229 | |8;json-parse-financial;52;50;54;50;51;51;51;50;49;51 08:01:33 INFO - PROCESS | 15229 | |9;json-stringify-tinderbox;60;60;59;59;60;59;60;60;60;59 08:01:33 INFO - PROCESS | 15229 | |10;stanford-crypto-aes;83;77;77;76;90;79;79;77;133;77 08:01:33 INFO - PROCESS | 15229 | |11;stanford-crypto-ccm;127;122;121;130;118;119;124;120;139;125 08:01:33 INFO - PROCESS | 15229 | |12;stanford-crypto-pbkdf2;158;161;156;158;156;156;159;159;154;166 08:01:33 INFO - PROCESS | 15229 | |13;stanford-crypto-sha256-iterative;63;62;65;63;64;68;62;61;59;60 08:01:33 INFO - PROCESS | 15229 | __end_tp_report 08:01:33 INFO - PROCESS | 15229 | __start_cc_report 08:01:33 INFO - PROCESS | 15229 | _x_x_mozilla_cycle_collect,1577 08:01:33 INFO - PROCESS | 15229 | __end_cc_report 08:01:33 INFO - PROCESS | 15229 | __startTimestamp1467730893680__endTimestamp 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | ------- Summary: start ------- 08:01:33 INFO - PROCESS | 15229 | Number of tests: 14 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.40 08:01:33 INFO - PROCESS | 15229 | Values: 111.0 106.0 110.0 110.0 112.0 110.0 111.0 115.0 112.0 110.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:140.00 stddev:21.98 (15.7%) stddev-sans-first:23.21 08:01:33 INFO - PROCESS | 15229 | Values: 147.0 124.0 133.0 188.0 122.0 130.0 158.0 124.0 161.0 124.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.53 08:01:33 INFO - PROCESS | 15229 | Values: 159.0 161.0 160.0 160.0 161.0 161.0 160.0 161.0 160.0 161.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.50 stddev:17.47 (23.1%) stddev-sans-first:18.35 08:01:33 INFO - PROCESS | 15229 | Values: 76.0 76.0 75.0 128.0 76.0 75.0 75.0 75.0 99.0 75.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.00 stddev:16.87 (19.8%) stddev-sans-first:17.36 08:01:33 INFO - PROCESS | 15229 | Values: 84.0 85.0 121.0 85.0 86.0 85.0 118.0 85.0 86.0 121.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:01:33 INFO - PROCESS | 15229 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 08:01:33 INFO - PROCESS | 15229 | Values: 146.0 145.0 146.0 148.0 145.0 145.0 146.0 146.0 145.0 145.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:01:33 INFO - PROCESS | 15229 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.37 (2.7%) stddev-sans-first:1.39 08:01:33 INFO - PROCESS | 15229 | Values: 52.0 50.0 54.0 50.0 51.0 51.0 51.0 50.0 49.0 51.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:01:33 INFO - PROCESS | 15229 | Values: 60.0 60.0 59.0 59.0 60.0 59.0 60.0 60.0 60.0 59.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:78.00 stddev:17.45 (22.4%) stddev-sans-first:18.50 08:01:33 INFO - PROCESS | 15229 | Values: 83.0 77.0 77.0 76.0 90.0 79.0 79.0 77.0 133.0 77.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:124.50 stddev:6.31 (5.1%) stddev-sans-first:6.63 08:01:33 INFO - PROCESS | 15229 | Values: 127.0 122.0 121.0 130.0 118.0 119.0 124.0 120.0 139.0 125.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:158.50 stddev:3.37 (2.1%) stddev-sans-first:3.57 08:01:33 INFO - PROCESS | 15229 | Values: 158.0 161.0 156.0 158.0 156.0 156.0 159.0 159.0 154.0 166.0 08:01:33 INFO - PROCESS | 15229 | 08:01:33 INFO - PROCESS | 15229 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:2.58 (4.1%) stddev-sans-first:2.74 08:01:33 INFO - PROCESS | 15229 | Values: 63.0 62.0 65.0 63.0 64.0 68.0 62.0 61.0 59.0 60.0 08:01:33 INFO - PROCESS | 15229 | -------- Summary: end -------- 08:01:33 INFO - PROCESS | 15229 | 08:01:34 INFO - TEST-INFO | 15229: exit 0 08:01:34 INFO - TEST-OK | kraken | took 60983ms 08:01:34 INFO - SUITE-END | took 1174s 08:01:34 INFO - Completed test suite (00:19:34) 08:01:34 INFO - javascript benchmark 08:01:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.3029463812595, 3345.7825241359296, 3346.9497957530643, 3350.51417544456, 3393.609734880488, 5459.617826752124, 5532.0318944184755, 5550.139728342103, 5554.472325129116, 5563.721813909298, 5554.91667624986, 5616.382197958232, 5619.269494965659, 5622.381538030813, 5656.377798442168, 4982.0, 5083.771230294646, 5094.312267843849, 5133.255677926699, 5176.50823171798, 4946.826861059863, 5080.974595127019, 5120.129577971754, 5123.948760512403, 5126.5642420394315, 5025.572826309768, 5069.290299358093, 5101.285819985186, 5103.974480127594, 5140.151874940649, 5142.305788718512, 5200.6619569727845, 5206.661566998133, 5207.297014902978, 5228.372595288571, 4945.67853089548, 5013.799448022075, 5049.015441988814, 5094.923576146361, 5104.821331253388, 5396.10964190908, 5400.513953744182, 5412.783488660449, 5447.918281225785, 5454.809081682161, 6003.759849606011, 6012.278526576795, 6012.518998480155, 6017.368176341465, 6022.036474164112, 5893.58744887858, 5921.052631578969, 5964.910526342108, 6036.396360363972, 6067.332593414721, 5609.411011843738, 5657.0, 5658.405867383906, 5658.97170514153, 5659.377468478464, 5911.083782013795, 6115.388461153849, 6125.1731016313115, 6127.754889804447, 6129.49238426781, 5775.711214439261, 5816.0, 5832.825015249549, 5885.411458854166, 5911.822645320647, 5962.493188078975, 5963.4334738199805, 5971.28344598651, 5996.70016499182, 6000.3999600040515, 5794.0, 5907.527397808165, 5937.821865344046, 5945.940540594539, 5948.613340132878, 5961.344252132262, 6031.24609423822, 6034.39656034393, 6039.8490037748525, 6073.665948372882, 4613.446386433649, 4615.353850460938, 4622.4684161321875, 4623.976880115578, 4643.117807616542, 4035.2333056719717, 4075.0627355708352, 4082.265192265421, 4142.5857414258335, 4155.605217504332, 5776.306843178845, 5790.218320526759, 5798.449147330997, 5800.651960882361, 5823.330317013598, 6070.726817293233, 6086.482648974887, 6088.178095957078, 6089.969550152221, 6123.112148738408, 5544.0, 5620.775168993277, 5652.604317697804, 5682.346530149086, 5720.799772007959, 5133.358330208724, 5133.820316288987, 5135.4094279157625, 5136.357955255593, 5139.254808052886, 6100.0544915537275, 6104.4505994460715, 6107.45032947028, 6107.450329470369, 6108.297545782203, 5798.1302804579655, 5968.22413086296, 6015.849603759941, 6026.246719160105, 6105.206323177958, 6129.988551888889, 6136.545381847118, 6142.8521664701275, 6152.138700581832, 6159.014557670751, 5946.672932988554, 5951.077582974646, 5952.761889524544, 5953.821385358447, 5957.165996760544, 5768.913466298093, 5891.0, 5926.881462370815, 5955.612885162451, 6009.609375390585, 5849.210356601804, 5865.5600829937075, 5872.148538461985, 5881.617694849821, 5882.382349853204, 5718.628289161191, 5823.330317013429, 5867.911981320198, 5874.647521148745, 5888.882222355443, 5724.856878578069, 5770.422957704196, 5793.304803423616, 5830.5627077968475, 5839.970800145972, 5924.11138329254, 5954.07711804671, 5958.791442299499, 5986.790462333797, 5994.040953447602, 5593.384727679871, 5740.311162660508, 5845.678487683218, 5846.064629659234, 5867.765289388377], "value": 5524.534622418946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9353271140174, 630.319255204379, 639.8464368551547, 654.7119267522293, 655.2824657000585, 33190.66809331906, 45507.54492455075, 45858.312125318145, 45904.0, 46007.30989035167, 47245.52754472463, 47479.287810682865, 47564.52435475644, 47585.286220706716, 47605.28592071122, 8080.595970201496, 8937.597808098652, 9083.863742043875, 9090.454572725625, 10676.199285053613, 10512.159027277838, 10632.362058276489, 10882.347059176434, 10908.072813810835, 10909.0, 10924.399158046344, 10988.890111098906, 11002.284851484668, 11013.83479247812, 11014.284071535365, 8208.425410221287, 10651.360918344924, 10872.347659140476, 11011.229213955026, 11021.283616564897, 10778.676639700821, 10841.13270938323, 10851.294665846695, 10856.891431085745, 10858.0, 45360.54639453596, 45765.0, 45838.31242531365, 45838.31242531365, 45916.540834591564, 3925.0776067624083, 4076.2458945095254, 4194.790260486994, 4335.978320108411, 4532.501424843264, 34827.477587836205, 35285.0, 35510.64489355099, 35556.64443355559, 35819.925402237976, 4625.301774558856, 4695.354416141585, 4763.3807605011125, 4824.541668541483, 4886.902261954741, 370479.0, 370693.0, 371495.0, 372778.0, 373043.99999999726, 37947.723136611894, 68505.65747171332, 68676.0, 69151.65424172947, 69301.0, 39299.41050884239, 41329.793351033055, 41341.58658413377, 41375.7931210342, 41394.586054139676, 17392.130393480275, 17710.91144544269, 17718.379856704953, 17725.379611713528, 17728.91135544314, 13250.337483125804, 14438.133711977314, 14692.41230350774, 14731.116133032052, 15082.849171508364, 9210.355275130676, 9266.07339266068, 9307.20888724466, 9315.906840931504, 9368.625254989724, 3522.7357948153476, 3533.2403533240476, 3536.381133301662, 3597.784132952031, 3620.6190509483295, 1044.7074819050679, 1057.9206559508068, 1084.8318510630866, 1096.2052511928948, 1128.7065363005677, 33521.66478335185, 33798.831005845306, 33886.66113338835, 34121.31757364839, 34366.48450273248, 1203.7231436769416, 1209.6854817747449, 1217.403472298585, 1221.8045112781913, 1261.5710658376197, 17000.234989425506, 17334.739978900325, 17525.386611468537, 17569.297228110987, 17726.379576714753, 658648.0, 660440.0, 662135.0, 662680.0, 663309.0, 61338.0, 61890.0, 61902.380976190565, 61932.38067619356, 61956.07065894015, 1343.7312537492542, 1452.1504919621927, 1479.977800332996, 1483.3547406878042, 1486.1306135910613, 33113.17217069593, 33353.0, 34279.48580771241, 34506.13734656654, 34660.30679386348, 52322.73838630935, 52788.20817687814, 52944.73527632337, 52959.73520132375, 52966.0, 430491.0, 431121.0, 431388.0, 432127.0, 432348.0, 26156.0, 26736.866315668296, 26787.598186026837, 26869.193924182306, 26975.46049079047, 50139.74930125326, 51640.0, 52506.86030730099, 52807.0, 53243.201351978976, 42541.574584255, 42906.57093429151, 43150.0, 43410.131797364505, 44160.77919610382, 42165.57834421616, 43086.94443341075, 43150.568494315914, 43652.781736091114, 44065.77967110144, 38330.80834595809, 38600.227995440495, 42597.0, 44116.33825492556, 44532.0, 37308.6269137316, 39557.2088558233, 39646.207075858896, 39834.800825995684, 40240.59759402368, 29617.703822962358, 29692.851535742182, 29694.0, 30117.849410753683, 30186.698133018388], "value": 20573.421438603287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.54596489826105, 417.3614370013876, 428.22277566217304, 433.99566004339954, 438.3074741907786, 18551.35070272541, 19565.902170489164, 20367.796322036775, 21034.789652103475, 21048.684269735928, 19601.0, 19949.0, 20191.798082019177, 20261.189552417887, 20291.28980485683, 5693.402192769761, 5900.704964751767, 5938.168656388109, 5947.167396564484, 5950.5834591578605, 4225.302825033866, 5833.504152147051, 5884.117382392633, 6196.597221180631, 6512.153420055386, 6520.93479065208, 6581.0, 6582.341765823403, 6594.3075977022445, 6595.010748387732, 6368.42684158428, 6430.807075787734, 6533.216014078317, 6539.0, 6541.705623246918, 3935.5474120476224, 5382.165764306539, 5650.0, 5660.462256085665, 5791.0734282514595, 22793.0, 23345.182918597937, 23756.524869502686, 24281.150159744324, 24287.392815179584, 2325.232673217851, 2654.8008899332435, 2799.4261176458776, 3024.4102400032, 3037.893673721409, 10727.35635861843, 10982.780344393148, 11068.889311106866, 11211.66365009051, 11627.825582616268, 2043.2439997200981, 2055.629986602411, 2062.278202629083, 2167.6640120781303, 2200.6368949123375, 81616.0, 86573.99999999937, 87799.56100219458, 88468.0, 88571.55714221451, 11283.435828208556, 11329.603463878724, 11490.0, 11638.0, 11754.88245117555, 16522.0912849792, 16547.586310342096, 16660.33358665664, 16691.41580044717, 16698.0, 8452.788680283042, 8560.143985601515, 8637.654493820177, 8644.567771611395, 8717.30261579072, 8433.072362040171, 8450.19723126302, 8504.428140181139, 8599.26906212979, 8699.260562852101, 4989.5758860496535, 5075.898482030412, 5076.416212135578, 5110.233464980282, 5157.277981082651, 1766.8454945919727, 1937.3316205908939, 1977.5451646121473, 2042.805933436321, 2056.0747663551165, 930.9348345615742, 991.3605724307781, 998.336106489191, 1011.3729487717662, 1031.0771859185986, 19116.2353505861, 19245.13396897143, 19418.223271069, 19448.22207111728, 19784.90107549453, 1027.4708525109575, 1031.097789434245, 1052.736815796051, 1081.1404933078065, 1098.3464838421128, 10231.181505479544, 10901.563937442414, 10956.945215274032, 10961.506732197071, 10964.451777411097, 483268.0, 512010.0, 521129.0, 532218.0, 537550.0, 98567.50716246373, 101640.49179754054, 101884.0, 102782.0, 103101.0, 1027.3322340478599, 1045.785613949154, 1047.5024363427463, 1049.5539395756773, 1057.3391630231106, 16974.151292435083, 17122.74315885238, 17323.307067717655, 17476.388326409022, 17596.20817063261, 40454.0, 40629.90410843637, 40746.32885675483, 41104.0, 42045.78977105217, 55738.0, 57164.1425378628, 59009.40990590211, 59074.40925590689, 59139.40860591339, 8695.521746304014, 8782.429142105742, 8791.956040219759, 8873.378863479495, 9061.546922653974, 8947.686830961145, 9362.95318523403, 13181.934090329487, 13527.797083043959, 13689.31553422305, 11979.820302695292, 12112.0, 12456.813147802972, 12530.122891397516, 12576.87423125757, 11696.473658685209, 11818.231814932002, 11993.220440671677, 12015.399230038638, 12027.75944481123, 11553.075753939833, 11753.83239335132, 11818.940905295418, 12519.436625351698, 13072.411741471466, 9006.909930900869, 9063.818723625622, 9206.401583897024, 9333.673321433716, 9363.0, 9383.014783447912, 10375.221858360805, 12368.75262494763, 12524.749505009666, 12534.937325313314], "value": 9607.658623053867, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.4413262628627, 1531.816182058153, 1567.3103834312903, 1706.2066139245248, 1844.2715127524637, 8919.777005574855, 9248.121428464301, 9256.305777066722, 9347.532623368821, 9392.154706076451, 9147.17675409213, 9354.204892584139, 9355.485448300358, 9357.391769534992, 9360.71917842464, 2397.5324811661735, 2419.4314336130997, 2422.0553983946274, 2424.9757502425014, 2428.574999375111, 2388.4864754077958, 2430.829841911067, 2441.7436169202247, 2442.2673198040607, 2443.450223699671, 2403.2790162951133, 2433.9634905476432, 2436.0986435019067, 2468.728439871613, 2472.208893154191, 2334.9066037358484, 2343.297010896733, 2349.2834685421026, 2375.3586531636533, 2424.200013995395, 2346.953060938789, 2377.072941552796, 2382.1424287256573, 2387.8328517003815, 2387.877697482181, 7798.571078590675, 7924.0, 9261.490618016007, 9311.255099592016, 9314.767130821716, 4726.172919739032, 4890.5109489051165, 4893.951060489385, 5396.460353964611, 5538.113901775697, 3417.9145521361916, 3479.3215323012023, 3524.823758812049, 3580.6061333253583, 3600.4059330210484, 1224.8285240066398, 1228.12189284661, 1251.0992085698283, 1263.425141560597, 1265.7848165811743, 11967.401629918557, 11990.220635658741, 12037.037037037016, 12044.277343359427, 12045.518179272818, 4785.880352991203, 4887.462379138363, 4895.339129217581, 4903.509649035068, 4952.603791696655, 9732.854007189897, 9760.463174525326, 9787.36382135159, 9811.0, 9815.803683926282, 5458.808941687022, 5476.726163691799, 5477.123660214346, 5481.342238931354, 5481.616286859881, 4791.832285870048, 4907.68100073494, 4946.0355230729665, 4956.231784073474, 4975.950240497621, 4080.4695389599756, 4152.974900370586, 4176.479356088872, 4194.496660400771, 4201.138766552849, 1324.9536266230637, 1358.4634069542476, 1364.6383708317303, 1370.9314534273246, 1381.6131483184724, 885.1369914333474, 986.2947992185622, 1000.4897502273748, 1062.8671416072991, 1079.63292480557, 6503.6097834130105, 6550.737970481127, 6608.471322294205, 6643.169603799525, 6643.335666433318, 487.3712910345685, 487.4443134826301, 488.655497873998, 518.6602775182262, 518.6784193799792, 4339.435873336509, 4339.479262488521, 4376.496702879146, 4393.956060439418, 4437.290033594674, 11306.434678266054, 11626.593069242535, 11675.124365672438, 11687.766244675058, 11689.707757305965, 11120.777584448428, 11566.42167891602, 11599.710007249887, 11647.6505704829, 11652.76694466106, 8463.449875758179, 8581.65673373058, 8627.827443451095, 8636.093210212963, 8636.790849281106, 6298.685065746786, 6569.883119869538, 6601.9669901652105, 6636.966815165893, 6648.135742353463, 10668.733281668021, 10917.727056823644, 10941.070009049, 10978.945105274743, 11051.778964420828, 11076.778464430827, 11080.889191107986, 11190.216684831983, 11192.944035279772, 11239.831402529133, 8081.717139900075, 8137.877931830909, 8138.633761480629, 8243.670253189804, 8259.793505162419, 9030.729078127666, 9032.23226025769, 9072.95463522678, 9117.5441227937, 9121.726348209564, 8093.231143041402, 8093.312068474245, 8109.39179561547, 8256.215659512336, 8321.292690121407, 8120.390970677105, 8166.714165004197, 8215.383846211438, 8280.171982801672, 8282.378821588285, 7157.212706602374, 7329.963350183429, 7330.780076597711, 7331.193568707331, 7335.449841262033, 5483.341998960151, 5580.414056524169, 5631.493165615114, 5635.549156067423, 5821.476067153976, 5436.238926550207, 5488.4237155098135, 5534.861628459321, 5543.861403464784, 5624.184493248538], "value": 4778.643100629079, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.41236079010815, 364.09703934243083, 365.1182394517241, 366.5345011834971, 371.61166580922935, 5399.622026458154, 5454.127339625661, 5487.862803429911, 5537.390887002432, 5560.443955604437, 5326.360836699591, 5434.510894019538, 5477.808276710316, 5508.834734957948, 5524.972375138119, 4325.545817689144, 4338.1540599583095, 4340.263894442217, 4376.496702879178, 4376.606105450509, 4310.892227694317, 4347.760873151976, 4348.847790327339, 4379.583939525756, 4384.824607015731, 4291.570842915699, 4307.892302692427, 4332.545082766312, 4332.610065094141, 4371.431713877191, 4084.81618327176, 4268.871933841959, 4293.22721910056, 4309.383981007122, 4352.586504282088, 3750.362438385481, 3754.699624030098, 3775.9056023599355, 3779.7732136071922, 3785.470034195215, 5322.946770532284, 5325.973370133124, 5331.840044798662, 5351.759170837322, 5353.491418315254, 4718.976405117986, 4895.0, 4911.803527858881, 4911.803527858881, 4925.926111108336, 5692.345380281279, 5704.800331988402, 5715.485606295453, 5723.912456633227, 5742.626729262584, 4150.771707556083, 4173.457450531411, 4173.9582604173875, 4188.267053265697, 4190.120074784299, 5591.434398368423, 5723.542116630618, 5784.739686714066, 5877.735501902424, 5929.673867937262, 4223.640990515841, 4226.852060177879, 4237.279662457389, 4239.173361194537, 4239.448871646666, 4302.462192225972, 4306.76048454808, 4320.719153255029, 4328.523862375137, 4344.500382455994, 4671.672982891165, 4707.270373092176, 4790.568848803555, 4808.27875818623, 4938.950610493921, 5771.509421699118, 5796.797112101141, 5807.738651760681, 5822.563307751935, 5834.387389324144, 1490.1729540105346, 1506.9074920682417, 1512.2438780609696, 1516.4616561120863, 1518.1346632419636, 932.1424289653535, 945.432740355781, 949.6913503111516, 960.7838236396755, 962.2254085461271, 5085.398099598615, 5090.821821236239, 5115.212209345916, 5119.462456442095, 5124.513890971651, 5246.895062098813, 5259.815906443256, 5268.578513718893, 5285.735713214324, 5298.337707786527, 4758.500357462486, 4924.482929292444, 5010.369555983138, 5075.071472840371, 5098.439171691111, 2781.3185769486604, 2786.7352601502826, 2794.776417886564, 2798.398344355973, 2800.6219160413084, 5258.317338451735, 5275.736213189325, 5323.787048518016, 5353.357597088297, 5387.326584176978, 5564.553216163827, 6040.244969378828, 6040.728167232485, 6056.727447264883, 6077.0, 5939.346671866091, 5964.8807023860145, 6023.488003519662, 6032.547558933097, 6065.787697430569, 5704.828855134353, 5879.73541190656, 5892.587518873809, 5898.085796701518, 5941.821745347646, 5796.652200867961, 5844.181814545882, 5851.420116568417, 5866.67733274674, 5891.260563837836, 5757.309122905278, 5885.47030767233, 6005.459508644243, 6026.427489388501, 6030.849228769316, 4242.363645453207, 4248.385613466987, 4288.871333859989, 4290.206311832321, 4291.849785257501, 5724.084146536534, 5830.912536311874, 5885.999380105478, 5903.468687818117, 5944.197533332945, 5695.174199741097, 5734.770609175586, 5735.684537350486, 5749.367569567428, 5756.3380211276235, 5730.828075157752, 5735.397783232867, 5736.541076713769, 5742.36833948257, 5742.913856292075, 5439.864003399946, 5661.603687741983, 5679.460451257124, 5685.403032681509, 5699.435254135573, 5757.006356694412, 5785.247917770663, 5790.768369265183, 5819.388964158872, 5819.621724587888, 5463.617546771847, 5721.141828725725, 5734.426557344233, 5746.741396637245, 5754.625949313281], "value": 4332.379426288323, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.8960135182425, 818.447547905164, 833.1834801894144, 882.351471668324, 936.1013427109972, 14859.108453492785, 15525.922370388133, 15569.37722491099, 15637.530874073767, 15810.13044282564, 15157.92421037896, 15224.771628425555, 15260.465883694073, 15263.618409539768, 15268.312925918333, 704.7639040921298, 816.6855760532178, 830.7466222802043, 833.0378412933042, 855.3200205836343, 828.6312590897053, 832.3258160889668, 832.9125441828612, 834.9707760228393, 836.3142223376803, 881.9559022048904, 885.9557022148899, 886.2865393358376, 886.7871710789397, 886.9334799890034, 730.4558104212342, 861.96983105591, 879.6085741844881, 881.9647214111428, 882.3162049411693, 648.9188851393576, 651.6448535548137, 652.0, 652.1196384880421, 652.2433976587183, 16236.350545978265, 16240.918795406065, 16276.918615406847, 16291.429799956944, 16295.103769292684, 15025.173615451145, 15274.541763747106, 15438.45965391206, 15570.455034073753, 15829.525114246591, 12492.0, 12580.245185288912, 12674.9028386501, 14084.647883802987, 14624.561263162122, 4895.2923770467205, 4930.654854160211, 4939.0, 4978.2034874419915, 5074.340335756328, 83436.0, 86245.70631440596, 86977.0, 87869.0, 88160.0, 12810.80783788244, 12907.677308067374, 12959.611211663665, 13027.47890084405, 13246.867531324757, 23868.283951481484, 23940.640890386658, 23944.7605523946, 23957.28128156158, 23988.88005559996, 9510.28672849539, 9512.239020878313, 9557.61769529211, 9610.95194524023, 9717.22262219035, 4983.07813054586, 5039.924401133986, 5050.065737838511, 5128.435872054071, 5134.024535338349, 3511.455724362728, 3603.94594081089, 3605.0266428064274, 3611.368010598135, 3642.1987162824134, 575.2320651929637, 584.4418580255846, 588.5232961301359, 594.4412252482653, 598.5630489742425, 658.7891874600082, 659.947204223661, 722.3246264742482, 726.2954933714288, 726.614894106114, 10138.03688649577, 10146.391216527032, 10300.484975751182, 10457.529411176516, 10464.00591943764, 683.3917813146304, 686.9381755642016, 750.1785544828405, 753.2505157368454, 756.8637645223913, 4703.294505824154, 4808.0, 4924.162892308316, 4966.602671786249, 4984.2025275955675, 68908.31091689119, 115836.0, 118371.40814295874, 119351.40324298496, 119455.40272298583, 97576.0, 103074.48462757638, 103117.48441257895, 103482.48258758809, 103509.48245258877, 81871.0, 87943.56028219817, 87995.56002220076, 88522.0, 88772.0, 9960.850587241051, 10205.38767673942, 10818.513166907665, 11232.943835280772, 11298.887011130113, 45449.0, 47617.761911190224, 48160.795980100775, 52684.47315526949, 55026.724866377015, 50744.49255507398, 75481.0, 76253.61873190598, 77568.2243177561, 77865.0, 13125.73748525005, 13194.736105278032, 13343.733125337632, 13379.799303010268, 14402.0, 15200.847991519944, 15260.542183734506, 15534.61163470877, 15601.415152853253, 16444.177791110636, 14377.281135942952, 14404.351804169048, 14781.704365912836, 15050.548483545512, 15567.143807090719, 13846.723065538834, 14056.578302650936, 14184.290785460893, 15254.466093686668, 15705.921470392575, 14422.423103076178, 14558.927205363905, 14948.177850218342, 15083.0, 15665.216739163225, 11411.60059397917, 11665.825012624648, 12267.202631828903, 12837.101402901708, 13124.540641077898, 12172.208806427554, 12440.875591243972, 12621.873781262437, 12696.6825829355, 12823.230606163661], "value": 7983.170622480157, "unit": "score"}], "name": "dromaeo_css", "value": 7517.585033423796, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 110.0, 112.0, 110.0, 111.0, 115.0, 112.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 133.0, 188.0, 122.0, 130.0, 158.0, 124.0, 161.0, 124.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 128.0, 76.0, 75.0, 75.0, 75.0, 99.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 121.0, 85.0, 86.0, 85.0, 118.0, 85.0, 86.0, 121.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 148.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 54.0, 50.0, 51.0, 51.0, 51.0, 50.0, 49.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 77.0, 76.0, 90.0, 79.0, 79.0, 77.0, 133.0, 77.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 121.0, 130.0, 118.0, 119.0, 124.0, 120.0, 139.0, 125.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 156.0, 158.0, 156.0, 156.0, 159.0, 159.0, 154.0, 166.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 63.0, 64.0, 68.0, 62.0, 61.0, 59.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1488.8, "alertThreshold": 2.0}]} 08:01:34 INFO - Return code: 0 08:01:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:01:34 ERROR - # TBPL SUCCESS # 08:01:34 INFO - Running post-action listener: _resource_record_post_action 08:01:34 INFO - ##### 08:01:34 INFO - ##### Finished run-tests step (success) 08:01:34 INFO - ##### 08:01:34 INFO - Running post-run listener: _resource_record_post_run 08:01:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 294912; Write bytes: 502812672; Read time: 80; Write time: 942144 08:01:35 INFO - TinderboxPrint: CPU usage
13.1% 08:01:35 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 80 08:01:35 INFO - TinderboxPrint: I/O write bytes / time
502,812,672 / 942,144 08:01:35 INFO - TinderboxPrint: CPU idle
8,263.1 (86.8%) 08:01:35 INFO - TinderboxPrint: CPU user
1,198.9 (12.6%) 08:01:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:01:35 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 252698624; Read time: 0; Write time: 626624 08:01:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 270336; Write bytes: 250114048; Read time: 44; Write time: 315520 08:01:35 INFO - Running post-run listener: _upload_blobber_files 08:01:35 INFO - Blob upload gear active. 08:01:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:35 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 08:01:35 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'] 08:01:35 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 08:01:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:01:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:40 INFO - (blobuploader) - INFO - Done attempting. 08:01:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:01:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:41 INFO - (blobuploader) - INFO - Done attempting. 08:01:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:01:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:01:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:42 INFO - (blobuploader) - INFO - Done attempting. 08:01:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:42 INFO - Return code: 0 08:01:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f772fd65bab330ddb50513a4d17a2069909342546aa697101022db7e37af3d5d494cb093653c5c38b1dead0b2bc95c18b82e6d2eac70fafabff3774489ecbbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be91a668a68f535bf52c5bed3fda6be5331b8c8bae5e8eef66c19b96b13b16ce517e27aeff861bfc22383471eda14384e9369f135d3f600f49a71ef597b9c05b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/926739f92301fb5209160d221c42901a767e74317c2f7ef58ccbe830bd0a2cc361d2d668369fb206804d0d3a9185c5799b886d724e9b28b0f298ba6632370298"} 08:01:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:42 INFO - Contents: 08:01:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f772fd65bab330ddb50513a4d17a2069909342546aa697101022db7e37af3d5d494cb093653c5c38b1dead0b2bc95c18b82e6d2eac70fafabff3774489ecbbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be91a668a68f535bf52c5bed3fda6be5331b8c8bae5e8eef66c19b96b13b16ce517e27aeff861bfc22383471eda14384e9369f135d3f600f49a71ef597b9c05b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/926739f92301fb5209160d221c42901a767e74317c2f7ef58ccbe830bd0a2cc361d2d668369fb206804d0d3a9185c5799b886d724e9b28b0f298ba6632370298"} 08:01:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:42 INFO - Copying logs to upload dir... 08:01:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.414730 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-05 08:01:41.218045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:01:41.222117) ========= 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=af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338 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/f772fd65bab330ddb50513a4d17a2069909342546aa697101022db7e37af3d5d494cb093653c5c38b1dead0b2bc95c18b82e6d2eac70fafabff3774489ecbbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be91a668a68f535bf52c5bed3fda6be5331b8c8bae5e8eef66c19b96b13b16ce517e27aeff861bfc22383471eda14384e9369f135d3f600f49a71ef597b9c05b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/926739f92301fb5209160d221c42901a767e74317c2f7ef58ccbe830bd0a2cc361d2d668369fb206804d0d3a9185c5799b886d724e9b28b0f298ba6632370298"} build_url:https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/Kma-pjxJSyeN-udbWWjSCw/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/f772fd65bab330ddb50513a4d17a2069909342546aa697101022db7e37af3d5d494cb093653c5c38b1dead0b2bc95c18b82e6d2eac70fafabff3774489ecbbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be91a668a68f535bf52c5bed3fda6be5331b8c8bae5e8eef66c19b96b13b16ce517e27aeff861bfc22383471eda14384e9369f135d3f600f49a71ef597b9c05b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/926739f92301fb5209160d221c42901a767e74317c2f7ef58ccbe830bd0a2cc361d2d668369fb206804d0d3a9185c5799b886d724e9b28b0f298ba6632370298"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:01:41.249935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:01:41.250353) ========= 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=af724c981e2a0f424dbabf99000001e7-1467729363.693584-1367040338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:01:41.332620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:01:41.332980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:01:41.333292) ========= ========= Total master_lag: 0.18 =========