builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1467363361.07 results: success (0) buildid: 20160630231321 builduid: 27d512291f7c4de5a206bd61e405aa25 revision: 19de2d70cf3ff501837ea13a3803e31d8e54b259 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.065434) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.065991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.066318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.104825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.105372) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 01:56:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.0M=0s 2016-07-01 01:56:01 (24.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103151 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.227607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.228188) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018572 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.281016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:01.281364) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 19de2d70cf3ff501837ea13a3803e31d8e54b259 --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 19de2d70cf3ff501837ea13a3803e31d8e54b259 --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=a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 01:56:01,395 truncating revision to first 12 chars 2016-07-01 01:56:01,395 Setting DEBUG logging. 2016-07-01 01:56:01,395 attempt 1/10 2016-07-01 01:56:01,395 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/19de2d70cf3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 01:56:01,979 unpacking tar archive at: mozilla-aurora-19de2d70cf3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:02.195025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:02.195428) ========= script_repo_revision: 19de2d70cf3ff501837ea13a3803e31d8e54b259 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:02.195896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:02.196206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:56:02.208736) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-01 01:56:02.209056) ========= /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=a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:56:02 INFO - MultiFileLogger online at 20160701 01:56:02 in /builds/slave/test 01:56:02 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 01:56:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:56:02 INFO - {'append_to_log': False, 01:56:02 INFO - 'base_work_dir': '/builds/slave/test', 01:56:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:56:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:56:02 INFO - 'branch': 'Mozilla-Aurora', 01:56:02 INFO - 'buildbot_json_path': 'buildprops.json', 01:56:02 INFO - 'config_files': ('talos/linux_config.py',), 01:56:02 INFO - 'default_actions': ('clobber', 01:56:02 INFO - 'read-buildbot-config', 01:56:02 INFO - 'download-and-extract', 01:56:02 INFO - 'populate-webroot', 01:56:02 INFO - 'create-virtualenv', 01:56:02 INFO - 'install', 01:56:02 INFO - 'run-tests'), 01:56:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:56:02 INFO - 'download_minidump_stackwalk': True, 01:56:02 INFO - 'download_symbols': 'ondemand', 01:56:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:56:02 INFO - 'tooltool.py': '/tools/tooltool.py', 01:56:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:56:02 INFO - '/tools/misc-python/virtualenv.py')}, 01:56:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:56:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:56:02 INFO - 'installer_path': 'installer.exe', 01:56:02 INFO - 'log_level': 'info', 01:56:02 INFO - 'log_name': 'talos', 01:56:02 INFO - 'log_to_console': True, 01:56:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:56:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:56:02 INFO - 'opt_config_files': (), 01:56:02 INFO - 'pip_index': False, 01:56:02 INFO - 'sps_profile': False, 01:56:02 INFO - 'sps_profile_interval': 0, 01:56:02 INFO - 'suite': 'dromaeojs', 01:56:02 INFO - 'system_bits': '32', 01:56:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:56:02 INFO - 'title': 'talos-linux64-ix-002', 01:56:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:56:02 INFO - 'use_talos_json': True, 01:56:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:56:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:56:02 INFO - 'work_dir': 'build'} 01:56:02 INFO - ##### 01:56:02 INFO - ##### Running clobber step. 01:56:02 INFO - ##### 01:56:02 INFO - Running pre-action listener: _resource_record_pre_action 01:56:02 INFO - Running main action method: clobber 01:56:02 INFO - rmtree: /builds/slave/test/build 01:56:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:56:03 INFO - Running post-action listener: _resource_record_post_action 01:56:03 INFO - ##### 01:56:03 INFO - ##### Finished clobber step (success) 01:56:03 INFO - ##### 01:56:03 INFO - ##### 01:56:03 INFO - ##### Running read-buildbot-config step. 01:56:03 INFO - ##### 01:56:03 INFO - Running pre-action listener: _resource_record_pre_action 01:56:03 INFO - Running main action method: read_buildbot_config 01:56:03 INFO - Using buildbot properties: 01:56:03 INFO - { 01:56:03 INFO - "project": "", 01:56:03 INFO - "product": "firefox", 01:56:03 INFO - "script_repo_revision": "production", 01:56:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:56:03 INFO - "repository": "", 01:56:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:56:03 INFO - "buildid": "20160630231321", 01:56:03 INFO - "pgo_build": "True", 01:56:03 INFO - "basedir": "/builds/slave/test", 01:56:03 INFO - "buildnumber": 329, 01:56:03 INFO - "slavename": "talos-linux64-ix-002", 01:56:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:56:03 INFO - "platform": "ubuntu64_hw", 01:56:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:56:03 INFO - "branch": "mozilla-aurora", 01:56:03 INFO - "repo_path": "releases/mozilla-aurora", 01:56:03 INFO - "revision": "19de2d70cf3ff501837ea13a3803e31d8e54b259", 01:56:03 INFO - "stage_platform": "linux64-pgo", 01:56:03 INFO - "builduid": "27d512291f7c4de5a206bd61e405aa25", 01:56:03 INFO - "slavebuilddir": "test" 01:56:03 INFO - } 01:56:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 01:56:03 INFO - Running post-action listener: _resource_record_post_action 01:56:03 INFO - ##### 01:56:03 INFO - ##### Finished read-buildbot-config step (success) 01:56:03 INFO - ##### 01:56:03 INFO - ##### 01:56:03 INFO - ##### Running download-and-extract step. 01:56:03 INFO - ##### 01:56:03 INFO - Running pre-action listener: _resource_record_pre_action 01:56:03 INFO - Running main action method: download_and_extract 01:56:03 INFO - mkdir: /builds/slave/test/build/tests 01:56: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')]} 01:56:03 INFO - https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:04 INFO - Downloaded 1361 bytes. 01:56:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:56:04 INFO - Using the following test package requirements: 01:56:04 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:56:04 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:56:04 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:56:04 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'jsshell-linux-x86_64.zip'], 01:56:04 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:56:04 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:56:04 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:56:04 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:56:04 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:56:04 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:56:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:56:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:04 INFO - https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:56:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:56:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:56:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:07 INFO - Downloaded 24525259 bytes. 01:56:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:56:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:56:09 INFO - Return code: 0 01:56:09 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 01:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:09 INFO - https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:10 INFO - Downloaded 24525259 bytes. 01:56:10 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'] 01:56:10 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 01:56:12 INFO - Return code: 0 01:56:12 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')]} 01:56:12 INFO - https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:13 INFO - Downloaded 10833369 bytes. 01:56:13 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'] 01:56:13 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 01:56:13 INFO - Return code: 0 01:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:13 INFO - https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:56:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:56:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:56:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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 01:56:16 INFO - Downloaded 63633643 bytes. 01:56:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:56:16 INFO - mkdir: /builds/slave/test/properties 01:56:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:56:16 INFO - Writing to file /builds/slave/test/properties/build_url 01:56:16 INFO - Contents: 01:56:16 INFO - build_url:https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:56:16 INFO - Running post-action listener: _resource_record_post_action 01:56:16 INFO - Running post-action listener: set_extra_try_arguments 01:56:16 INFO - ##### 01:56:16 INFO - ##### Finished download-and-extract step (success) 01:56:16 INFO - ##### 01:56:16 INFO - ##### 01:56:16 INFO - ##### Running populate-webroot step. 01:56:16 INFO - ##### 01:56:16 INFO - Running pre-action listener: _resource_record_pre_action 01:56:16 INFO - Running main action method: populate_webroot 01:56:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:56:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:56:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:56:16 INFO - '--tppagecycles', 01:56:16 INFO - '7'], 01:56:16 INFO - 'tests': ['tsvgm']}}, 01:56:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:56:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:56:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:56:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:56:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['damp', 'tps']}, 01:56:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'tests': ['damp', 'tps']}, 01:56:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['dromaeo_dom']}, 01:56:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:56:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['a11yr', 01:56:16 INFO - 'ts_paint', 01:56:16 INFO - 'tpaint', 01:56:16 INFO - 'sessionrestore', 01:56:16 INFO - 'sessionrestore_no_auto_restore', 01:56:16 INFO - 'tabpaint']}, 01:56:16 INFO - 'other-e10s': {'tests': ['a11yr', 01:56:16 INFO - 'ts_paint', 01:56:16 INFO - 'tpaint', 01:56:16 INFO - 'sessionrestore', 01:56:16 INFO - 'sessionrestore_no_auto_restore', 01:56:16 INFO - 'tabpaint']}, 01:56:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:56:16 INFO - 'ts_paint', 01:56:16 INFO - 'tpaint', 01:56:16 INFO - 'sessionrestore', 01:56:16 INFO - 'sessionrestore_no_auto_restore', 01:56:16 INFO - 'tabpaint']}, 01:56:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:56:16 INFO - 'ts_paint', 01:56:16 INFO - 'tpaint', 01:56:16 INFO - 'sessionrestore', 01:56:16 INFO - 'sessionrestore_no_auto_restore', 01:56:16 INFO - 'tabpaint']}, 01:56:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['a11yr', 01:56:16 INFO - 'ts_paint', 01:56:16 INFO - 'tpaint', 01:56:16 INFO - 'sessionrestore', 01:56:16 INFO - 'sessionrestore_no_auto_restore', 01:56:16 INFO - 'tabpaint']}, 01:56:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['a11yr', 01:56:16 INFO - 'ts_paint', 01:56:16 INFO - 'tpaint', 01:56:16 INFO - 'sessionrestore', 01:56:16 INFO - 'sessionrestore_no_auto_restore', 01:56:16 INFO - 'tabpaint']}, 01:56:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['tsvgx', 01:56:16 INFO - 'tsvgr_opacity', 01:56:16 INFO - 'tart', 01:56:16 INFO - 'tscrollx', 01:56:16 INFO - 'cart']}, 01:56:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:56:16 INFO - 'tsvgr_opacity', 01:56:16 INFO - 'tart', 01:56:16 INFO - 'tscrollx', 01:56:16 INFO - 'cart']}, 01:56:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'talos_options': ['--disable-e10s'], 01:56:16 INFO - 'tests': ['tp5o']}, 01:56:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'tests': ['tp5o']}, 01:56:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'talos_options': ['--disable-e10s', 01:56:16 INFO - '--xperf_path', 01:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:16 INFO - 'tests': ['tp5n']}, 01:56:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:56:16 INFO - 'talos_options': ['--xperf_path', 01:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:16 INFO - 'tests': ['tp5n']}}, 01:56:16 INFO - 'talos.zip': {'path': '', 01:56:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:56:16 INFO - Running post-action listener: _resource_record_post_action 01:56:16 INFO - ##### 01:56:16 INFO - ##### Finished populate-webroot step (success) 01:56:16 INFO - ##### 01:56:16 INFO - ##### 01:56:16 INFO - ##### Running create-virtualenv step. 01:56:16 INFO - ##### 01:56:16 INFO - Running pre-action listener: _resource_record_pre_action 01:56:16 INFO - Running main action method: create_virtualenv 01:56:16 INFO - Creating virtualenv /builds/slave/test/build/venv 01:56:16 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 01:56:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:56:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:56:16 INFO - Using real prefix '/usr' 01:56:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:56:17 INFO - Installing distribute.............................................................................................................................................................................................done. 01:56:19 INFO - Installing pip.................done. 01:56:19 INFO - Return code: 0 01:56:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:56:19 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')]} 01:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:19 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')]} 01:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:19 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:19 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 01:56:19 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 01:56:19 INFO - Using env: {'DISPLAY': ':0', 01:56:19 INFO - 'HOME': '/home/cltbld', 01:56:19 INFO - 'LANG': 'en_US.UTF-8', 01:56:19 INFO - 'LANGUAGE': 'en_US:en', 01:56:19 INFO - 'LOGNAME': 'cltbld', 01:56:19 INFO - 'MAIL': '/var/mail/cltbld', 01:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:19 INFO - 'MOZ_NO_REMOTE': '1', 01:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:19 INFO - 'NO_EM_RESTART': '1', 01:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:19 INFO - 'PWD': '/builds/slave/test', 01:56:19 INFO - 'SHELL': '/bin/bash', 01:56:19 INFO - 'SHLVL': '1', 01:56:19 INFO - 'TERM': 'linux', 01:56:19 INFO - 'TMOUT': '86400', 01:56:19 INFO - 'USER': 'cltbld', 01:56:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:19 INFO - '_': '/tools/buildbot/bin/python'} 01:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:19 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 01:56:19 INFO - Cleaning up... 01:56:19 INFO - Return code: 0 01:56:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:56:19 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')]} 01:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:19 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')]} 01:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:19 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:19 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 01:56:19 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 01:56:19 INFO - Using env: {'DISPLAY': ':0', 01:56:19 INFO - 'HOME': '/home/cltbld', 01:56:19 INFO - 'LANG': 'en_US.UTF-8', 01:56:19 INFO - 'LANGUAGE': 'en_US:en', 01:56:19 INFO - 'LOGNAME': 'cltbld', 01:56:19 INFO - 'MAIL': '/var/mail/cltbld', 01:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:19 INFO - 'MOZ_NO_REMOTE': '1', 01:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:19 INFO - 'NO_EM_RESTART': '1', 01:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:19 INFO - 'PWD': '/builds/slave/test', 01:56:19 INFO - 'SHELL': '/bin/bash', 01:56:19 INFO - 'SHLVL': '1', 01:56:19 INFO - 'TERM': 'linux', 01:56:19 INFO - 'TMOUT': '86400', 01:56:19 INFO - 'USER': 'cltbld', 01:56:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:19 INFO - '_': '/tools/buildbot/bin/python'} 01:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:19 INFO - Downloading/unpacking psutil>=3.1.1 01:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:56:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:21 INFO - Installing collected packages: psutil 01:56:21 INFO - Running setup.py install for psutil 01:56:21 INFO - building 'psutil._psutil_linux' extension 01:56:21 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 01:56:22 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 01:56:22 INFO - building 'psutil._psutil_posix' extension 01:56:22 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 01:56:22 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 01:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:22 INFO - Successfully installed psutil 01:56:22 INFO - Cleaning up... 01:56:23 INFO - Return code: 0 01:56:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56: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 01:56: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 01:56:23 INFO - Using env: {'DISPLAY': ':0', 01:56:23 INFO - 'HOME': '/home/cltbld', 01:56:23 INFO - 'LANG': 'en_US.UTF-8', 01:56:23 INFO - 'LANGUAGE': 'en_US:en', 01:56:23 INFO - 'LOGNAME': 'cltbld', 01:56:23 INFO - 'MAIL': '/var/mail/cltbld', 01:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:23 INFO - 'MOZ_NO_REMOTE': '1', 01:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:23 INFO - 'NO_EM_RESTART': '1', 01:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:23 INFO - 'PWD': '/builds/slave/test', 01:56:23 INFO - 'SHELL': '/bin/bash', 01:56:23 INFO - 'SHLVL': '1', 01:56:23 INFO - 'TERM': 'linux', 01:56:23 INFO - 'TMOUT': '86400', 01:56:23 INFO - 'USER': 'cltbld', 01:56:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:23 INFO - '_': '/tools/buildbot/bin/python'} 01:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:56:26 INFO - Installing collected packages: mozsystemmonitor 01:56:26 INFO - Running setup.py install for mozsystemmonitor 01:56:26 INFO - Successfully installed mozsystemmonitor 01:56:26 INFO - Cleaning up... 01:56:26 INFO - Return code: 0 01:56:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:26 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:26 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 01:56:26 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 01:56:26 INFO - Using env: {'DISPLAY': ':0', 01:56:26 INFO - 'HOME': '/home/cltbld', 01:56:26 INFO - 'LANG': 'en_US.UTF-8', 01:56:26 INFO - 'LANGUAGE': 'en_US:en', 01:56:26 INFO - 'LOGNAME': 'cltbld', 01:56:26 INFO - 'MAIL': '/var/mail/cltbld', 01:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:26 INFO - 'MOZ_NO_REMOTE': '1', 01:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:26 INFO - 'NO_EM_RESTART': '1', 01:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:26 INFO - 'PWD': '/builds/slave/test', 01:56:26 INFO - 'SHELL': '/bin/bash', 01:56:26 INFO - 'SHLVL': '1', 01:56:26 INFO - 'TERM': 'linux', 01:56:26 INFO - 'TMOUT': '86400', 01:56:26 INFO - 'USER': 'cltbld', 01:56:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:26 INFO - '_': '/tools/buildbot/bin/python'} 01:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:27 INFO - Downloading/unpacking jsonschema==2.5.1 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:56:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:56:29 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 01:56:29 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 01:56:29 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 01:56:29 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 01:56:29 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 01:56:29 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 01:56:29 INFO - Downloading functools32-3.2.3-2.tar.gz 01:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:56:29 INFO - warning: no files found matching '*.txt' 01:56:29 INFO - no previously-included directories found matching 'build' 01:56:29 INFO - no previously-included directories found matching 'dist' 01:56:29 INFO - no previously-included directories found matching '.git*' 01:56:29 INFO - Installing collected packages: jsonschema, functools32 01:56:29 INFO - Running setup.py install for functools32 01:56:29 INFO - warning: no files found matching '*.txt' 01:56:29 INFO - no previously-included directories found matching 'build' 01:56:29 INFO - no previously-included directories found matching 'dist' 01:56:29 INFO - no previously-included directories found matching '.git*' 01:56:29 INFO - Successfully installed jsonschema functools32 01:56:29 INFO - Cleaning up... 01:56:29 INFO - Return code: 0 01:56:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:29 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:29 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 01:56:29 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 01:56:29 INFO - Using env: {'DISPLAY': ':0', 01:56:29 INFO - 'HOME': '/home/cltbld', 01:56:29 INFO - 'LANG': 'en_US.UTF-8', 01:56:29 INFO - 'LANGUAGE': 'en_US:en', 01:56:29 INFO - 'LOGNAME': 'cltbld', 01:56:29 INFO - 'MAIL': '/var/mail/cltbld', 01:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:29 INFO - 'MOZ_NO_REMOTE': '1', 01:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:29 INFO - 'NO_EM_RESTART': '1', 01:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:29 INFO - 'PWD': '/builds/slave/test', 01:56:29 INFO - 'SHELL': '/bin/bash', 01:56:29 INFO - 'SHLVL': '1', 01:56:29 INFO - 'TERM': 'linux', 01:56:29 INFO - 'TMOUT': '86400', 01:56:29 INFO - 'USER': 'cltbld', 01:56:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:29 INFO - '_': '/tools/buildbot/bin/python'} 01:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:29 INFO - Downloading/unpacking blobuploader==1.2.4 01:56:29 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 01:56:29 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 01:56:29 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 01:56:29 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 01:56:29 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 01:56:29 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 01:56:31 INFO - Downloading blobuploader-1.2.4.tar.gz 01:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:56:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:56:31 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 01:56:31 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 01:56:31 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 01:56:31 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 01:56:31 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 01:56:31 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 01:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:56:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 INFO - Downloading docopt-0.6.1.tar.gz 01:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:56:32 INFO - Installing collected packages: blobuploader, requests, docopt 01:56:32 INFO - Running setup.py install for blobuploader 01:56:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:56:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:56:32 INFO - Running setup.py install for requests 01:56:33 INFO - Running setup.py install for docopt 01:56:33 INFO - Successfully installed blobuploader requests docopt 01:56:33 INFO - Cleaning up... 01:56:33 INFO - Return code: 0 01:56:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:33 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:33 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 01:56:33 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 01:56:33 INFO - Using env: {'DISPLAY': ':0', 01:56:33 INFO - 'HOME': '/home/cltbld', 01:56:33 INFO - 'LANG': 'en_US.UTF-8', 01:56:33 INFO - 'LANGUAGE': 'en_US:en', 01:56:33 INFO - 'LOGNAME': 'cltbld', 01:56:33 INFO - 'MAIL': '/var/mail/cltbld', 01:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:33 INFO - 'MOZ_NO_REMOTE': '1', 01:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:33 INFO - 'NO_EM_RESTART': '1', 01:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:33 INFO - 'PWD': '/builds/slave/test', 01:56:33 INFO - 'SHELL': '/bin/bash', 01:56:33 INFO - 'SHLVL': '1', 01:56:33 INFO - 'TERM': 'linux', 01:56:33 INFO - 'TMOUT': '86400', 01:56:33 INFO - 'USER': 'cltbld', 01:56:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:33 INFO - '_': '/tools/buildbot/bin/python'} 01:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:33 INFO - Running setup.py (path:/tmp/pip-elmh5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:33 INFO - Running setup.py (path:/tmp/pip-j9gKl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:33 INFO - Running setup.py (path:/tmp/pip-rsGhAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:33 INFO - Running setup.py (path:/tmp/pip-aSj_RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:33 INFO - Running setup.py (path:/tmp/pip-HkNfSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:33 INFO - Running setup.py (path:/tmp/pip-gQdnbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:33 INFO - Running setup.py (path:/tmp/pip-Z7n9VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:33 INFO - Running setup.py (path:/tmp/pip-1KiEpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:33 INFO - Running setup.py (path:/tmp/pip-Yo6UcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:34 INFO - Running setup.py (path:/tmp/pip-7zG3cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:34 INFO - Running setup.py (path:/tmp/pip-DRXsmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:34 INFO - Running setup.py (path:/tmp/pip-dbTI9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:34 INFO - Running setup.py (path:/tmp/pip-h8it7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:34 INFO - Running setup.py (path:/tmp/pip-KL8RD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:34 INFO - Running setup.py (path:/tmp/pip-6eLYr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:34 INFO - Running setup.py (path:/tmp/pip-nLZWqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:34 INFO - Running setup.py (path:/tmp/pip-fjWjr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:56:34 INFO - Running setup.py install for manifestparser 01:56:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:56:34 INFO - Running setup.py install for mozcrash 01:56:34 INFO - Running setup.py install for mozdebug 01:56:34 INFO - Running setup.py install for mozdevice 01:56:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Running setup.py install for mozfile 01:56:35 INFO - Running setup.py install for mozhttpd 01:56:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Running setup.py install for mozinfo 01:56:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Running setup.py install for mozInstall 01:56:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Running setup.py install for mozleak 01:56:35 INFO - Running setup.py install for mozlog 01:56:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Running setup.py install for moznetwork 01:56:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Running setup.py install for mozprocess 01:56:35 INFO - Running setup.py install for mozprofile 01:56:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:56:35 INFO - Running setup.py install for mozrunner 01:56:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:56:36 INFO - Running setup.py install for mozscreenshot 01:56:36 INFO - Running setup.py install for moztest 01:56:36 INFO - Running setup.py install for mozversion 01:56:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:56:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:56:36 INFO - Cleaning up... 01:56:36 INFO - Return code: 0 01:56:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:36 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')]} 01:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:36 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')]} 01:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:36 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:36 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 01:56:36 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 01:56:36 INFO - Using env: {'DISPLAY': ':0', 01:56:36 INFO - 'HOME': '/home/cltbld', 01:56:36 INFO - 'LANG': 'en_US.UTF-8', 01:56:36 INFO - 'LANGUAGE': 'en_US:en', 01:56:36 INFO - 'LOGNAME': 'cltbld', 01:56:36 INFO - 'MAIL': '/var/mail/cltbld', 01:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:36 INFO - 'MOZ_NO_REMOTE': '1', 01:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:36 INFO - 'NO_EM_RESTART': '1', 01:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:36 INFO - 'PWD': '/builds/slave/test', 01:56:36 INFO - 'SHELL': '/bin/bash', 01:56:36 INFO - 'SHLVL': '1', 01:56:36 INFO - 'TERM': 'linux', 01:56:36 INFO - 'TMOUT': '86400', 01:56:36 INFO - 'USER': 'cltbld', 01:56:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:36 INFO - '_': '/tools/buildbot/bin/python'} 01:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:36 INFO - Running setup.py (path:/tmp/pip-mciVkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:36 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)) 01:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:36 INFO - Running setup.py (path:/tmp/pip-2IlqqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:36 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)) 01:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:36 INFO - Running setup.py (path:/tmp/pip-LNet0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:36 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)) 01:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:36 INFO - Running setup.py (path:/tmp/pip-bzOlRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:36 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)) 01:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:36 INFO - Running setup.py (path:/tmp/pip-9zi26h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:37 INFO - Running setup.py (path:/tmp/pip-af7GA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:37 INFO - Running setup.py (path:/tmp/pip-hVI37g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:37 INFO - Running setup.py (path:/tmp/pip-kLxZbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:37 INFO - Running setup.py (path:/tmp/pip-WQo6Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:37 INFO - Running setup.py (path:/tmp/pip-EYy2P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:37 INFO - Running setup.py (path:/tmp/pip-IZBUq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:37 INFO - Running setup.py (path:/tmp/pip-Kvcd3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:37 INFO - Running setup.py (path:/tmp/pip-x1SHLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:37 INFO - Running setup.py (path:/tmp/pip-tEVewA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:37 INFO - Running setup.py (path:/tmp/pip-NRUvAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:37 INFO - Running setup.py (path:/tmp/pip-XtDJDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:37 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)) 01:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:37 INFO - Running setup.py (path:/tmp/pip-xr1FCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:37 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)) 01:56:37 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)) 01:56:37 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)) 01:56:37 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)) 01:56:37 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)) 01:56:37 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)) 01:56:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 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 01:56:39 INFO - Downloading blessings-1.6.tar.gz 01:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:56:39 INFO - Installing collected packages: blessings 01:56:39 INFO - Running setup.py install for blessings 01:56:40 INFO - Successfully installed blessings 01:56:40 INFO - Cleaning up... 01:56:40 INFO - Return code: 0 01:56:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:56:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:40 INFO - Reading from file tmpfile_stdout 01:56:40 INFO - Current package versions: 01:56:40 INFO - argparse == 1.2.1 01:56:40 INFO - blessings == 1.6 01:56:40 INFO - blobuploader == 1.2.4 01:56:40 INFO - docopt == 0.6.1 01:56:40 INFO - functools32 == 3.2.3-2 01:56:40 INFO - jsonschema == 2.5.1 01:56:40 INFO - manifestparser == 1.1 01:56:40 INFO - mozInstall == 1.12 01:56:40 INFO - mozcrash == 0.17 01:56:40 INFO - mozdebug == 0.1 01:56:40 INFO - mozdevice == 0.48 01:56:40 INFO - mozfile == 1.2 01:56:40 INFO - mozhttpd == 0.7 01:56:40 INFO - mozinfo == 0.9 01:56:40 INFO - mozleak == 0.1 01:56:40 INFO - mozlog == 3.2 01:56:40 INFO - moznetwork == 0.27 01:56:40 INFO - mozprocess == 0.22 01:56:40 INFO - mozprofile == 0.28 01:56:40 INFO - mozrunner == 6.11 01:56:40 INFO - mozscreenshot == 0.1 01:56:40 INFO - mozsystemmonitor == 0.3 01:56:40 INFO - moztest == 0.7 01:56:40 INFO - mozversion == 1.4 01:56:40 INFO - psutil == 3.1.1 01:56:40 INFO - requests == 1.2.3 01:56:40 INFO - wsgiref == 0.1.2 01:56:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:40 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')]} 01:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 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')]} 01:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:40 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 01:56:40 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 01:56:40 INFO - Using env: {'DISPLAY': ':0', 01:56:40 INFO - 'HOME': '/home/cltbld', 01:56:40 INFO - 'LANG': 'en_US.UTF-8', 01:56:40 INFO - 'LANGUAGE': 'en_US:en', 01:56:40 INFO - 'LOGNAME': 'cltbld', 01:56:40 INFO - 'MAIL': '/var/mail/cltbld', 01:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:40 INFO - 'MOZ_NO_REMOTE': '1', 01:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:40 INFO - 'NO_EM_RESTART': '1', 01:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:40 INFO - 'PWD': '/builds/slave/test', 01:56:40 INFO - 'SHELL': '/bin/bash', 01:56:40 INFO - 'SHLVL': '1', 01:56:40 INFO - 'TERM': 'linux', 01:56:40 INFO - 'TMOUT': '86400', 01:56:40 INFO - 'USER': 'cltbld', 01:56:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:40 INFO - '_': '/tools/buildbot/bin/python'} 01:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 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)) 01:56:40 INFO - Cleaning up... 01:56:40 INFO - Return code: 0 01:56:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:56:40 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')]} 01:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 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')]} 01:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:40 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 01:56:40 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 01:56:40 INFO - Using env: {'DISPLAY': ':0', 01:56:40 INFO - 'HOME': '/home/cltbld', 01:56:40 INFO - 'LANG': 'en_US.UTF-8', 01:56:40 INFO - 'LANGUAGE': 'en_US:en', 01:56:40 INFO - 'LOGNAME': 'cltbld', 01:56:40 INFO - 'MAIL': '/var/mail/cltbld', 01:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:40 INFO - 'MOZ_NO_REMOTE': '1', 01:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:40 INFO - 'NO_EM_RESTART': '1', 01:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:40 INFO - 'PWD': '/builds/slave/test', 01:56:40 INFO - 'SHELL': '/bin/bash', 01:56:40 INFO - 'SHLVL': '1', 01:56:40 INFO - 'TERM': 'linux', 01:56:40 INFO - 'TMOUT': '86400', 01:56:40 INFO - 'USER': 'cltbld', 01:56:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:40 INFO - '_': '/tools/buildbot/bin/python'} 01:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:56:40 INFO - Cleaning up... 01:56:40 INFO - Return code: 0 01:56:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:56:40 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')]} 01:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 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')]} 01:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 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 0x7fc64f679f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', '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 01:56:40 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 01:56:40 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 01:56:40 INFO - Using env: {'DISPLAY': ':0', 01:56:40 INFO - 'HOME': '/home/cltbld', 01:56:40 INFO - 'LANG': 'en_US.UTF-8', 01:56:40 INFO - 'LANGUAGE': 'en_US:en', 01:56:40 INFO - 'LOGNAME': 'cltbld', 01:56:40 INFO - 'MAIL': '/var/mail/cltbld', 01:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:40 INFO - 'MOZ_NO_REMOTE': '1', 01:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:40 INFO - 'NO_EM_RESTART': '1', 01:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:40 INFO - 'PWD': '/builds/slave/test', 01:56:40 INFO - 'SHELL': '/bin/bash', 01:56:40 INFO - 'SHLVL': '1', 01:56:40 INFO - 'TERM': 'linux', 01:56:40 INFO - 'TMOUT': '86400', 01:56:40 INFO - 'USER': 'cltbld', 01:56:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:40 INFO - '_': '/tools/buildbot/bin/python'} 01:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:40 INFO - Downloading/unpacking flake8 01:56:40 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 01:56:40 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 01:56:40 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 01:56:40 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 01:56:40 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 01:56:40 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 01:56:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:56:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:56:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 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 01:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:56:43 INFO - no previously-included directories found matching 'docs/_build' 01:56:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:56:43 INFO - Running setup.py install for pep8 01:56:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:56:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:56:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:56:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:56:44 INFO - no previously-included directories found matching 'docs/_build' 01:56:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:56:44 INFO - Cleaning up... 01:56:44 INFO - Return code: 0 01:56:44 INFO - Running post-action listener: _resource_record_post_action 01:56:44 INFO - Running post-action listener: _start_resource_monitoring 01:56:44 INFO - Starting resource monitoring. 01:56:44 INFO - ##### 01:56:44 INFO - ##### Finished create-virtualenv step (success) 01:56:44 INFO - ##### 01:56:44 INFO - ##### 01:56:44 INFO - ##### Running install step. 01:56:44 INFO - ##### 01:56:44 INFO - Running pre-action listener: _resource_record_pre_action 01:56:44 INFO - Running main action method: install 01:56:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:44 INFO - Reading from file tmpfile_stdout 01:56:44 INFO - Detecting whether we're running mozinstall >=1.0... 01:56:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:56:44 INFO - Reading from file tmpfile_stdout 01:56:44 INFO - Output received: 01:56:44 INFO - Usage: mozinstall [options] installer 01:56:44 INFO - Options: 01:56:44 INFO - -h, --help show this help message and exit 01:56:44 INFO - -d DEST, --destination=DEST 01:56:44 INFO - Directory to install application into. [default: 01:56:44 INFO - "/builds/slave/test"] 01:56:44 INFO - --app=APP Application being installed. [default: firefox] 01:56:44 INFO - mkdir: /builds/slave/test/build/application 01:56:44 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'] 01:56:44 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 01:57:00 INFO - Reading from file tmpfile_stdout 01:57:00 INFO - Output received: 01:57:00 INFO - /builds/slave/test/build/application/firefox/firefox 01:57:00 INFO - Running post-action listener: _resource_record_post_action 01:57:00 INFO - ##### 01:57:00 INFO - ##### Finished install step (success) 01:57:00 INFO - ##### 01:57:00 INFO - ##### 01:57:00 INFO - ##### Running run-tests step. 01:57:00 INFO - ##### 01:57:00 INFO - Running pre-action listener: _resource_record_pre_action 01:57:00 INFO - Running main action method: run_tests 01:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:57:00 INFO - Python 2.7.3 01:57:00 INFO - Return code: 0 01:57:00 INFO - grabbing minidump binary from tooltool 01:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:00 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 0x225b1c0>, '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 0x225c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:57:00 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 01:57:00 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 01:57:00 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 01:57:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:57:00 INFO - Return code: 0 01:57:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:57:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:57:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:57:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:57:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:57:01 INFO - Return code: 0 01:57:01 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/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 01:57:01 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/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 01:57:01 INFO - Using env: {'DISPLAY': ':0', 01:57:01 INFO - 'HOME': '/home/cltbld', 01:57:01 INFO - 'LANG': 'en_US.UTF-8', 01:57:01 INFO - 'LANGUAGE': 'en_US:en', 01:57:01 INFO - 'LOGNAME': 'cltbld', 01:57:01 INFO - 'MAIL': '/var/mail/cltbld', 01:57:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:57:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:01 INFO - 'MOZ_NO_REMOTE': '1', 01:57:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:01 INFO - 'NO_EM_RESTART': '1', 01:57:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:01 INFO - 'PWD': '/builds/slave/test', 01:57:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:57:01 INFO - 'SHELL': '/bin/bash', 01:57:01 INFO - 'SHLVL': '1', 01:57:01 INFO - 'TERM': 'linux', 01:57:01 INFO - 'TMOUT': '86400', 01:57:01 INFO - 'USER': 'cltbld', 01:57:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452', 01:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:01 INFO - '_': '/tools/buildbot/bin/python'} 01:57:01 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/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 01:57:01 INFO - mozversion application_buildid: 20160630231321 01:57:01 INFO - mozversion application_changeset: 19de2d70cf3ff501837ea13a3803e31d8e54b259 01:57:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:57:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:57:01 INFO - mozversion application_name: Firefox 01:57:01 INFO - mozversion application_remotingname: firefox-dev 01:57:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:57:01 INFO - mozversion application_vendor: Mozilla 01:57:01 INFO - mozversion application_version: 49.0a2 01:57:01 INFO - mozversion platform_buildid: 20160630231321 01:57:01 INFO - mozversion platform_changeset: 19de2d70cf3ff501837ea13a3803e31d8e54b259 01:57:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:57:01 INFO - mozversion platform_version: 49.0a2 01:57:01 INFO - using testdate: 1467363421 01:57:01 INFO - actual date: 1467363421 01:57:01 INFO - starting webserver on 'localhost:58197' 01:57:01 INFO - SUITE-START | Running 2 tests 01:57:01 INFO - TEST-START | dromaeo_css 01:57:01 INFO - operating with platform_type : linux_ 01:57:01 INFO - Initialising browser for dromaeo_css test... 01:57:01 INFO - TEST-INFO | started process 23212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIJ43m/profile http://localhost:58197/getInfo.html) 01:57:05 INFO - PROCESS | 23212 | __metrics Screen width/height:1600/1200 01:57:05 INFO - PROCESS | 23212 | colorDepth:24 01:57:05 INFO - PROCESS | 23212 | Browser inner width/height: 1024/697 01:57:05 INFO - PROCESS | 23212 | __metrics 01:57:06 ERROR - PROCESS | 23212 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:57:07 INFO - TEST-INFO | 23212: exit 0 01:57:07 INFO - Browser initialized. 01:57:07 INFO - Running cycle 1/1 for dromaeo_css test... 01:57:07 INFO - TEST-INFO | started process 23303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIJ43m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:19 INFO - PROCESS | 23303 | RSS: Main: 145346560 01:57:19 INFO - PROCESS | 23303 | 01:58:11 INFO - PROCESS | 23303 | 1467363491008 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] 02:00:19 INFO - PROCESS | 23303 | Cycle 1(1): loaded http://localhost:58197/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58197/tests/dromaeo/cssquery-ext.html) 02:00:20 INFO - PROCESS | 23303 | RSS: Main: 258371584 02:00:20 INFO - PROCESS | 23303 | 02:03:22 INFO - PROCESS | 23303 | Cycle 1(1): loaded http://localhost:58197/tests/dromaeo/cssquery-ext.html (next: http://localhost:58197/tests/dromaeo/cssquery-jquery.html) 02:03:23 INFO - PROCESS | 23303 | RSS: Main: 228614144 02:03:23 INFO - PROCESS | 23303 | 02:06:25 INFO - PROCESS | 23303 | Cycle 1(1): loaded http://localhost:58197/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58197/tests/dromaeo/cssquery-mootools.html) 02:06:25 INFO - PROCESS | 23303 | RSS: Main: 224690176 02:06:25 INFO - PROCESS | 23303 | 02:09:27 INFO - PROCESS | 23303 | Cycle 1(1): loaded http://localhost:58197/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58197/tests/dromaeo/cssquery-prototype.html) 02:09:28 INFO - PROCESS | 23303 | RSS: Main: 222425088 02:09:28 INFO - PROCESS | 23303 | 02:12:30 INFO - PROCESS | 23303 | Cycle 1(1): loaded http://localhost:58197/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58197/tests/dromaeo/cssquery-yui.html) 02:12:31 INFO - PROCESS | 23303 | RSS: Main: 220192768 02:12:31 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | Cycle 1(1): loaded http://localhost:58197/tests/dromaeo/cssquery-yui.html (next: http://localhost:58197/tests/dromaeo/cssquery-dojo.html) 02:15:34 INFO - PROCESS | 23303 | RSS: Main: 262017024 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | __start_tp_report 02:15:34 INFO - PROCESS | 23303 | _x_x_mozilla_page_load 02:15:34 INFO - PROCESS | 23303 | _x_x_mozilla_page_load_details 02:15:34 INFO - PROCESS | 23303 | |i|pagename|runs| 02:15:34 INFO - PROCESS | 23303 | |0;dojo.html;3412.368711788319;3451.7411194160427;3454.7754395964275;3473.0101920952534;3504.018874715079;5702.657840529566;5778.133280008001;5796.913046304298;5817.243758311419;5825.5048320892665;5785.16115163301;5883.235179426669;5883.882322353561;5887.116932460133;5891.410858914106;5057.0897238497055;5143.948560514403;5263.184206447988;5285.154375299952;5341.0920143575495;5224.555912747421;5264.210368444726;5267.920981185285;5268.130758424855;5269.341332333458;5239.161734122541;5245.055889939809;5266.710330931797;5273.1826566882;5273.683578985254;5362.758675859576;5379.946200537984;5386.434424385422;5386.515213630772;5386.8383948481605;5027.170516864713;5110.71891045996;5159.819406320798;5247.632665713401;5263.105272103751;5579.38626751057;5593.74828132735;5594.888102237973;5612.298462692163;5634.126710359901;6222.222222222223;6228;6228.626282423023;6229.470495007885;6235.781747638856;6073.544484163705;6081.270247570275;6137.11011903276;6161.6303021818385;6219.968900155515;5763.538916886639;5774.105013722879;5790.652560846363;5792.999999999958;5798.043322851724;6106.267247930276;6246.46905013079;6247.344028876993;6268.59254148488;6270.6864656766975;6052.502075328169;6062.696865156725;6121.571489995657;6170.568060235741;6181.81454556364;6253.249610046823;6253.499720022387;6253.843653908689;6254.655993920378;6255.6872156392;6038;6132.727681134083;6235.563510554218;6241.625502469867;6248.5313601480075;6184.5980011299125;6276.592021518587;6298.08677741734;6317.5893566918;6319.273283572448;4694.647901407408;4694.718316900997;4734.763261836894;4756.762161891892;4791.808327666854;4119.361498967664;4154.293770059097;4185.539590645027;4256.659467242614;4283.378910058024;5974.880502389928;5981.641101533834;5982.461578457873;5986.982213023796;6005.249343832021;6269.96865015672;6273.404026617464;6273.686315684197;6274.686265686697;6278.905816412757;5790.594658373873;5877.764889404376;5913.674747888821;5918.526517878559;5970.940290597126;5187.559057480156;5191.6884986900905;5193.272941788153;5197.714125723046;5214.191800270964;6463.095166676669;6468.870622587522;6469.288378278386;6478.352164783578;6479.870402591921;6091.451769340781;6115.788007244199;6132.661461321697;6155.0151975683675;6265.937340626718;6437.839054023687;6450.387213214737;6455.7740479083;6459.160309159779;6463.806085817433;5928.347881733092;6088.330283668882;6127.479164270909;6133.785317514044;6134.846628834136;6114.936124487681;6151.3541078186145;6197.194364732556;6256.655883926428;6276.497880169667;6071.939280607137;6072.939270607238;6074.028155495276;6074.301455332693;6110.480609148094;5939.1982082420045;5982.312034116132;6079.240094988127;6097;6100.908486372619;5912.556558258062;5938.554608404474;5955.166276721349;5981.0729336952845;6012.977793775156;6130.570860039755;6132.824595223688;6136.29432615255;6140.499915048379;6147.815565533041;5736.082226843685;5960.284765828128;5976.163337132892;6004.819855404345;6028.698565071817 02:15:34 INFO - PROCESS | 23303 | |1;ext.html;598.5480961873785;650.0931200974637;653.8398092467346;667.4493542827167;670.9127813384265;33605.83197084014;46551;47021.0595788084;47315;47383.28925066127;48888.51111488884;49339.50660493394;49364.259536106896;49432;49500;8435.283000944897;8999.59501822418;9150.222231110363;9157.404768690014;11232.539769829911;10877.129829613652;10999.725006874813;11336.603218887341;11363.715907102305;11373.033292170134;11315.151363647718;11415.31508109512;11415.657530274106;11419.143564232674;11430.771384572303;8309.95845020777;11100.777984440267;11307.830382544269;11330.150238732129;11337.206395552315;11168.385738784364;11236.550537978472;11250.324980501196;11258.887411125866;11259.099272058216;46928;47356.763216184045;47390.28914566284;47445.288320675216;47491.76254118742;3801.068738159169;3836.8848934532007;3950.071733142709;3957.861474848395;4117.3618089196225;35761.46357804635;36312.45531317032;36491.4526282106;36578.63421365806;37315.44026839599;4598.425196850394;4626.8149274029;4645.744484053375;4676.50896655853;4800.711957282574;424409.87795061135;428559;430906;430913;433684;38896.80551597224;70833.64583177051;71550.64224678843;71639.28360716431;71687.28312716911;40427.39358909619;42124.368134478005;42175.78912105481;42197.78901105536;42202.15595688069;17604.735928961076;17663.55841103957;17729.379471718687;17743.290268389377;17744.112794360488;11766.529338826522;13993.30033498321;14121.364538595788;14135.08121972089;14473.638159045897;9402.858957115648;9404.106609872051;9428.528573571293;9428.858567121499;9484.620615175316;3560.145565064366;3568.8572457101945;3606.4590311452966;3670.4127339625534;3670.7981061041364;1110.2894147745287;1114.4427786106946;1129.2998341028615;1152.9942350288363;1170.2276497511602;33945.66054339474;34553.82723086369;34995.475067874;35192.47211291832;35206.82396588052;1130.2314426190105;1133.863936327646;1171.6250799744;1205.7889869272842;1268.308771719415;17140.40008599693;17412.47762567125;17443.215055322285;17455;17516.91241543784;675549;683976;684813;689688;691379;63277.36722632715;64314.35685643084;64642.67678661577;64822.675886620265;64897.351026490076;1394.9442022319197;1476.343027352839;1484.799552060458;1536.285627183365;1541.7070756556218;33537.664623353456;34252.82873585716;34462.13844653904;35026.299474010884;35256;55231.72384138054;56135;56139.438605613424;56187.438125619854;56269.71865140648;451916;452098;455647;456621;502885;30073;30793.538096929013;30983;31822;32095.35809283848;51127.74436127795;51517.742411287705;52083.479165207864;52515;53006.204906927196;43342.43040738251;43531;43785.78107109571;43825.34261986137;44106.77946610247;43151.568484314754;43455.348169776844;44250.114997699224;44561.77719111383;44770.77614612036;43586;43802.78098609614;43967.78016109899;44665.33002005037;44767.328490072025;37940.43089353607;38827.2234555313;38887.22225555417;38942;39151.608483914795;29131.85434072816;29198.854005730685;29575.704242958156;29639.40721185521;30027.249318767204 02:15:34 INFO - PROCESS | 23303 | |2;jquery.html;422.9238737027334;434.57676110737333;435.86052463211774;438.5548668101877;449.4494244550426;18656.533586660342;19608.31370902017;20243.59512809743;20256.291029813958;20449.795502044974;18065.36771213008;18917.337893173706;18920.62158756824;19237;19532.02339883004;5298.761555729991;5463.726813659321;5507.4767897049915;5509.283793106891;5510.91733623996;4110.095778928646;4638.768061596924;5409.864753381157;5414.7834086636485;6697.19633643961;6480.4491618212505;6640.900386494206;6673.299303573128;6675.866482670343;6680.331966803329;5948.672822994734;6085.330613632497;6093.421124993119;6196.721147548348;6635;3976.5426975897853;4166.895827604304;4179.6029377209115;5865.912011319833;5880.764769409261;13996.580102596938;14735.70528589433;14745.336459859225;16867.493975180765;24325.87837060821;2517.6698162339003;2553.4254792671686;2646.563317052684;2661.4810112028163;2864.2266588021116;10271.38371697693;10293.279470437072;10448.529816158216;10535.578576856993;11170.832437513443;2012.0945574491536;2018.1523760020827;2042.1729199674155;2083.3020937985793;2126.075157306577;81994;83184.58407707923;83605.16394835974;85714.57142714247;85788;11690.766184676258;11722.472488738027;11789.115816313812;11914.88085119155;12619.116661833767;16702.832971670126;16787.412440564767;16834.158292085347;16836.74744878828;16877;8747.387682862265;8790.824183516293;8822.117788221127;8907.777305567413;9085.318601104944;8537.701180458655;8615.181557752003;8709.346798990102;8739.21347078766;8813.867791983126;5050.595952323805;5051.166557518042;5068.113080211022;5077.8730531737;5115.437301896788;2040.1125510403022;2042.8570000100146;2080.9063592138086;2099.643060679688;2151.752548456916;1016.364772017489;1064.6060957445795;1076.9515371808288;1122.320995797547;1125.6004118537965;18364;18907.527311817314;19293.131809068625;19360;19458.318958836655;1038.1746511523356;1041.354360296621;1050.207093644309;1059.1473863539925;1065.7708592652616;10112;10684;10692.121254348378;10769.730756730987;10896.196968562066;474205;478854;486552;488130;488159;76960.61519692365;91980;92403.537982311;93397.5330123345;95749;1051.432226597644;1062.9946850265699;1064.6965614799744;1070.2668671959732;1071.3464786480397;17099;17357.392491262744;17593.912030439766;17811.821881781016;17823.554411139827;39645.207095857346;40917.79541102275;42577.787111064245;43244;43843.342349865416;59524.40475595189;60355.396446034974;60371.69814150901;61001;61131;7853.685852566062;8355.498670079814;8373.916260837314;8562.828743424972;8784.560771961249;13490.730185396042;13717.382717777524;13743;13779.586612401243;14070.859291406954;11754.412279386168;11996.280223186637;12141.514339426678;12407.93796031014;12475.75048499043;11582.536698532302;11856.881431185579;12097.57658481984;12112.576059837864;12527.49890004426;12297.631071067883;12567.93716031414;12584.907068746807;12730.23618582888;12901.419436125208;8498.575071246289;8553.272971797218;8588.699395521127;8654.524001179743;8814.162654547808;12108.818367724314;12449.190802597803;12640.55758048464;12649.304288264233;12695.492180312684 02:15:34 INFO - PROCESS | 23303 | |3;mootools.html;1390.1103293891904;1495.932683029264;1575.3462313140049;1773.6098058427149;1940.2239104358255;9299.860502092473;9690.176335011523;9736;9929.453880036595;10026.94986525068;9603.711888643335;9803.803923921518;9886.456244906527;9900.25748068894;9905.603775848975;2229.6098182818023;2293.6444851048113;2489.253224032783;2559.846409215453;2594.8313359631657;2589.948201035978;2597.870106494677;2599.2851965709488;2601.557735185023;2615.8168928175037;2531.6708827852353;2569.177863083814;2574.4979728952862;2575.2789219018705;2576.9742302577015;2157.492989147549;2374.536965291769;2446.082718980382;2448.828581999243;2460.2496238647204;2440.804735621146;2445.205308274818;2463.458039231384;2467.259822053377;2483.019207413062;9756.219502439859;9832.557534910875;9838.950805245999;9855.35940163887;9889;5774.971125144348;5928.258967629046;5933.821985340447;5937.2578427696535;5940.495057920082;3552.307300076486;3646.106703857545;3674.8346324415465;3675.1363429594026;3715.071232191952;1089.2865173311493;1104.536094840169;1118.89929906308;1133.7675776465805;1133.8696049954278;14294.714105717827;14310.499132530416;14372.928135359361;14388.64028399288;14406.351714172888;5029.547340739277;5073.289739436482;5098.694078355311;5109.926915347744;5171.069207542603;11186.32882027081;11234.887651123548;11236.550537978554;11240.49417776202;11242.606508772154;5705.115707065412;5720.856978575569;5722.628029178173;5724.427557244242;5726.141078838207;4667.416572928384;5261.605379596545;5349.679019258857;5401.837944861661;5474.452554744494;4416.889577760582;4432.268675668543;4487;4493.662975276868;4520.276755719069;1358.959231223065;1422.6301161697827;1427.2649585463494;1435.7702767557141;1456.0681164055013;872.228078150841;1037.7509397744639;1040.427764729396;1047.471027131309;1055.076807793181;6609.603423794588;6652.96673516639;6797.898031529531;6819.965900170567;6886.8622627548175;955.9617615295449;979.4906648542718;1002.644061358222;1010;1013.1641395848454;4465.531119232499;4615.007773328751;4688.320193571913;4815.3017812417;4853.781579828917;11736.823947640793;12239.20445171061;12418.875811241773;12656.17734847232;12822.487100516062;12402.81395779064;12409.565665201675;12448.937755311346;12456.564020259248;12458.937705311415;8883.555822208864;9122.452652840851;9125.634974601075;9131.406458580304;9144.268458523302;6720.529562930548;6821.147356580427;6919.135108111486;6934.375906168469;6960.686769095301;11002.559897604006;11280.830787538029;11575.536978521102;11577.189596728149;11778.411079446165;11427.942860285646;11576.36330001858;11648.184627076362;11671.533138674358;12003.219790713925;7734.265244801735;8362.414630975773;8579.571021449028;8592.484450932963;8733.214010739064;9662;9672.274579406432;9694.175995040501;9757.853632195382;9763.121319081316;8565.700200493202;8581.65673373083;8636.136386361564;8687.695930642398;8702.564871756513;8387.790305242417;8438.367122465963;8610.569471526524;8629.137086291572;8719.084496127814;7883.526988380716;7987.201279871966;7995.880061799194;8004.399670024655;8011.919880801117;5375.973120134531;5637.182608521824;5712.457316554921;5727.742251598771;5770.711464426846;5783.450572195635;5847.239858818326;5850.912236316373;5960.850978725566;6034.577579569388 02:15:34 INFO - PROCESS | 23303 | |4;prototype.html;354.1588726773912;358.44083230160953;359.97120230381574;362.52690239237796;368.13855577947606;5524.834254972352;5605.887882242358;5642.774289028439;5656.1798539211895;5684.317881854173;5340.973295133528;5507.063799154143;5554.3059366893085;5565.860853478665;5589.385167631567;4282.764447955361;4371.4972778130605;4382.649388048964;4413.514513403523;4427.225235583768;4343.370211319357;4355.303151495746;4379.518252992184;4381.518033016366;4384.298512238042;4301.075268817203;4323.832565207392;4357.956420435787;4377.146456440995;4378.9562104378865;4126.31915733905;4314.913701725948;4337.804798784062;4338;4345.587169218919;3724.7020238381137;3751.531058617673;3754.793486358249;3769.133099387156;3808.257389808988;5365.946340536622;5367.785288588452;5371.973140134274;5391.487808658171;5446.7276636168035;4737.763111844429;4956.3804524434445;4968.652194346397;4993.375828021497;5003.624728145403;5806.303243610793;5823.2138661280605;5835.912461313083;5845.574086753992;5849.64902105875;4183.657151994893;4185.2885009548145;4220.155968806251;4224.514180869178;4239.91520169598;5811.4479124483105;5883.9376583983485;5886.7939622113445;6081.756729730805;6091;4240.279152544075;4253.9365158710325;4271.508776490743;4289.7640629765665;4315.115401342718;4367.978160109243;4388.802503887333;4391.275439552438;4394.538573449806;4396.956030439718;4808.519148085234;4897.534734200245;4904.705717656952;4920.901581968341;4931.408231012301;5882.735276912549;5892.852678683067;5913.379095195029;5916.408359164136;5917.46742793142;1440.4598275646633;1474.9896321020135;1477.8226612806532;1478.9499455386797;1487.1300289330645;958.6357184270072;960.519740129935;983.6114734679761;988.9011098890054;996.6113215845826;5046.924296135561;5092;5104.310918026019;5129.204973229155;5142.817152054973;5358.705271210043;5371.4628537146755;5387.4073851876265;5394.352677678625;5434.347878254634;4834.018852179797;5120.718360490208;5126.513311139803;5168.689878607295;5174.353205849269;2822.717728227202;2848.800583959144;2852.543593025106;2892.6693720888206;2894.8407837568716;5540.418256083053;5593.266087512884;5604.131359639263;5616.146671598444;5630.85922851932;5279.947200528022;5412.810551630674;5422.213779002022;5460.31746031746;5486.0125177468435;5479.287692599936;5483.862903427446;5513.3108361454815;5535.529479994246;5552.250446189712;5162.251473536241;5305.867353316198;5340.572754179579;5370.677759334452;5397.433269506645;5268.604854635841;5316.973415132899;5340.706261155674;5745.482906538432;5841.649501029951;6175.536834737323;6191.19514463117;6239.251289845066;6284.968575157095;6288.245410550763;4305.784710764387;4311.676624253131;4326.545712700247;4333.133373325284;4346.630536404441;5793.204106726928;6017.488513476404;6027.764308316872;6032.577719559764;6081.452669259788;5871.735771890189;5888.381719919346;5888.499477544457;5927.170196172453;5928.970355148197;5626.1842032905815;5858;5905.291365036223;5915.467607915309;5938.168656388023;5771.884562308815;5786.479216870333;5796.681327469046;5805.419458054161;5817.127430885232;5914.911276330772;5939.792107276225;5946.821595352147;5952.910706339495;6001.279846418458;5673.8297851064535;5695.577093918203;5755.453231942959;5756.453136951983;5757.913631295618 02:15:34 INFO - PROCESS | 23303 | |5;yui.html;767.317087791865;789.5617932047711;794.9324307433868;836.289154218914;860.3891237221573;14172.50396236132;14216.715665686681;14642.853571464282;15355.078695278291;15394.153321567337;14242.216678082701;14417.567472975801;14430.783538246935;14442.205678687667;14463.78304325436;724.5109551053044;743.8809790433531;747.3498056690687;854.3421565394658;875.2341701011615;736.1093077376381;837.9078301386843;862.5385418800943;864.2092485375873;866.5580553917484;911.895132059815;913.6436789652041;915.1123410292006;915.3683958068945;916.2257892081215;767.1637914673033;910.6448485090787;910.7586489580267;912.3613470570594;912.6212621761961;661.153723234261;677.8136012596526;678.352173674145;679.6499802601664;679.8470344172571;13262.270575118364;13356;13360.86639133606;13380.531681391105;13387.665308367272;15061;15473.767893481607;15477.5356739298;15512.61218469536;15721.68556628861;13859;13900.960886726933;13946.790798138036;13989.440422383092;14240.786388204186;4731.455882573514;4764.880877978044;4806.639502037327;4833.516648335173;4942.678725882806;71449.64275178642;71604;72138;72515;76201.61899190524;11267.718307042389;11375.31748095117;11396;11401.543938242377;11500.539978400937;19723.50691232702;19768.209271628974;19804;19885;19950.102245398994;8948.821023579492;8954.328425368123;9017.729468115967;9218.354715170008;9443.575039123256;4488.102379524108;4522.163399771053;4558.8632341029825;4619.976900115478;4665.066986602693;3546.184377593168;3595.1551385424405;3635.0730563706084;4338.219120558267;4508.616767574793;756.5158298688843;763.2596381509926;769.5190505933791;776.1268572855538;776.5107981971322;752.3830459023549;767.8464307138595;778.4200770426069;790.4111436979487;791.976240712768;9814.852777208347;9940.950295248622;10070.546825392876;10092.646757363604;10172.440515771556;726.6947881889619;751.812046988253;761.3756719489965;764.2433990349514;769.8845173223949;4561.817527298871;4811.855644330676;4828.324034635154;4829.468758436569;4855.36880205571;124854.37572812078;128516;128599.35700321439;129723;131600;67399.66300168468;82825.17174828296;112730.43634781774;113548.43225783818;113945;70750.938735919;71620.64189679018;73401;88981;92048.53975730212;9512.809743804946;9544.236461083236;9779.217662586834;9824.852627210741;9859.852102218329;38526.80736596299;45302.773486132355;48667.5133248663;50146;53135.73432132815;52239.73880130575;73712.63143684248;75859.24140758743;76324;76883.23116768984;13724.862751372759;13745.862541374458;13890.30548472552;14238.928805355907;14391.28043597837;14934;15212.619684507534;15425.305861236497;16008.759868602214;17030.744538832176;10018.699439016842;11742.471588778355;13276.60170194857;13516.324183790575;13744.793828092386;14488.565343039725;14890.776638350217;15102.018368805993;15381.769273460683;15485.380584776933;13587.796183057064;13734.725305493634;13792.517261895786;13942.093763905314;14149.504767333094;11926.522939082339;11946.283223006647;11946.641600751991;12055.336956467478;12281.263124212219;11066.446677665923;11163.832542511705;11184.664460066211;11195.944020279847;11267.774644507228 02:15:34 INFO - PROCESS | 23303 | __end_tp_report 02:15:34 INFO - PROCESS | 23303 | __start_cc_report 02:15:34 INFO - PROCESS | 23303 | _x_x_mozilla_cycle_collect,921 02:15:34 INFO - PROCESS | 23303 | __end_cc_report 02:15:34 INFO - PROCESS | 23303 | __startTimestamp1467364534286__endTimestamp 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | ------- Summary: start ------- 02:15:34 INFO - PROCESS | 23303 | Number of tests: 6 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | [#0] dojo.html Cycles:165 Average:5757.62 Median:5982.46 stddev:655.15 (11.0%) stddev-sans-first:630.80 02:15:34 INFO - PROCESS | 23303 | Values: 3412.4 3451.7 3454.8 3473.0 3504.0 5702.7 5778.1 5796.9 5817.2 5825.5 5785.2 5883.2 5883.9 5887.1 5891.4 5057.1 5143.9 5263.2 5285.2 5341.1 5224.6 5264.2 5267.9 5268.1 5269.3 5239.2 5245.1 5266.7 5273.2 5273.7 5362.8 5379.9 5386.4 5386.5 5386.8 5027.2 5110.7 5159.8 5247.6 5263.1 5579.4 5593.7 5594.9 5612.3 5634.1 6222.2 6228.0 6228.6 6229.5 6235.8 6073.5 6081.3 6137.1 6161.6 6220.0 5763.5 5774.1 5790.7 5793.0 5798.0 6106.3 6246.5 6247.3 6268.6 6270.7 6052.5 6062.7 6121.6 6170.6 6181.8 6253.2 6253.5 6253.8 6254.7 6255.7 6038.0 6132.7 6235.6 6241.6 6248.5 6184.6 6276.6 6298.1 6317.6 6319.3 4694.6 4694.7 4734.8 4756.8 4791.8 4119.4 4154.3 4185.5 4256.7 4283.4 5974.9 5981.6 5982.5 5987.0 6005.2 6270.0 6273.4 6273.7 6274.7 6278.9 5790.6 5877.8 5913.7 5918.5 5970.9 5187.6 5191.7 5193.3 5197.7 5214.2 6463.1 6468.9 6469.3 6478.4 6479.9 6091.5 6115.8 6132.7 6155.0 6265.9 6437.8 6450.4 6455.8 6459.2 6463.8 5928.3 6088.3 6127.5 6133.8 6134.8 6114.9 6151.4 6197.2 6256.7 6276.5 6071.9 6072.9 6074.0 6074.3 6110.5 5939.2 5982.3 6079.2 6097.0 6100.9 5912.6 5938.6 5955.2 5981.1 6013.0 6130.6 6132.8 6136.3 6140.5 6147.8 5736.1 5960.3 5976.2 6004.8 6028.7 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | [#1] ext.html Cycles:180 Average:68463.50 Median:22192.63 stddev:143578.17 (647.0%) stddev-sans-first:143890.53 02:15:34 INFO - PROCESS | 23303 | Values: 598.5 650.1 653.8 667.4 670.9 33605.8 46551.0 47021.1 47315.0 47383.3 48888.5 49339.5 49364.3 49432.0 49500.0 8435.3 8999.6 9150.2 9157.4 11232.5 10877.1 10999.7 11336.6 11363.7 11373.0 11315.2 11415.3 11415.7 11419.1 11430.8 8310.0 11100.8 11307.8 11330.2 11337.2 11168.4 11236.6 11250.3 11258.9 11259.1 46928.0 47356.8 47390.3 47445.3 47491.8 3801.1 3836.9 3950.1 3957.9 4117.4 35761.5 36312.5 36491.5 36578.6 37315.4 4598.4 4626.8 4645.7 4676.5 4800.7 424409.9 428559.0 430906.0 430913.0 433684.0 38896.8 70833.6 71550.6 71639.3 71687.3 40427.4 42124.4 42175.8 42197.8 42202.2 17604.7 17663.6 17729.4 17743.3 17744.1 11766.5 13993.3 14121.4 14135.1 14473.6 9402.9 9404.1 9428.5 9428.9 9484.6 3560.1 3568.9 3606.5 3670.4 3670.8 1110.3 1114.4 1129.3 1153.0 1170.2 33945.7 34553.8 34995.5 35192.5 35206.8 1130.2 1133.9 1171.6 1205.8 1268.3 17140.4 17412.5 17443.2 17455.0 17516.9 675549.0 683976.0 684813.0 689688.0 691379.0 63277.4 64314.4 64642.7 64822.7 64897.4 1394.9 1476.3 1484.8 1536.3 1541.7 33537.7 34252.8 34462.1 35026.3 35256.0 55231.7 56135.0 56139.4 56187.4 56269.7 451916.0 452098.0 455647.0 456621.0 502885.0 30073.0 30793.5 30983.0 31822.0 32095.4 51127.7 51517.7 52083.5 52515.0 53006.2 43342.4 43531.0 43785.8 43825.3 44106.8 43151.6 43455.3 44250.1 44561.8 44770.8 43586.0 43802.8 43967.8 44665.3 44767.3 37940.4 38827.2 38887.2 38942.0 39151.6 29131.9 29198.9 29575.7 29639.4 30027.2 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | [#2] jquery.html Cycles:180 Average:28988.66 Median:2091.47 stddev:79731.17 (3812.2%) stddev-sans-first:79925.99 02:15:34 INFO - PROCESS | 23303 | Values: 422.9 434.6 435.9 438.6 449.4 18656.5 19608.3 20243.6 20256.3 20449.8 18065.4 18917.3 18920.6 19237.0 19532.0 5298.8 5463.7 5507.5 5509.3 5510.9 4110.1 4638.8 5409.9 5414.8 6697.2 6480.4 6640.9 6673.3 6675.9 6680.3 5948.7 6085.3 6093.4 6196.7 6635.0 3976.5 4166.9 4179.6 5865.9 5880.8 13996.6 14735.7 14745.3 16867.5 24325.9 2517.7 2553.4 2646.6 2661.5 2864.2 10271.4 10293.3 10448.5 10535.6 11170.8 2012.1 2018.2 2042.2 2083.3 2126.1 81994.0 83184.6 83605.2 85714.6 85788.0 11690.8 11722.5 11789.1 11914.9 12619.1 16702.8 16787.4 16834.2 16836.7 16877.0 8747.4 8790.8 8822.1 8907.8 9085.3 8537.7 8615.2 8709.3 8739.2 8813.9 5050.6 5051.2 5068.1 5077.9 5115.4 2040.1 2042.9 2080.9 2099.6 2151.8 1016.4 1064.6 1077.0 1122.3 1125.6 18364.0 18907.5 19293.1 19360.0 19458.3 1038.2 1041.4 1050.2 1059.1 1065.8 10112.0 10684.0 10692.1 10769.7 10896.2 474205.0 478854.0 486552.0 488130.0 488159.0 76960.6 91980.0 92403.5 93397.5 95749.0 1051.4 1063.0 1064.7 1070.3 1071.3 17099.0 17357.4 17593.9 17811.8 17823.6 39645.2 40917.8 42577.8 43244.0 43843.3 59524.4 60355.4 60371.7 61001.0 61131.0 7853.7 8355.5 8373.9 8562.8 8784.6 13490.7 13717.4 13743.0 13779.6 14070.9 11754.4 11996.3 12141.5 12407.9 12475.8 11582.5 11856.9 12097.6 12112.6 12527.5 12297.6 12567.9 12584.9 12730.2 12901.4 8498.6 8553.3 8588.7 8654.5 8814.2 12108.8 12449.2 12640.6 12649.3 12695.5 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | [#3] mootools.html Cycles:180 Average:6494.14 Median:4677.87 stddev:3776.66 (80.7%) stddev-sans-first:3767.78 02:15:34 INFO - PROCESS | 23303 | Values: 1390.1 1495.9 1575.3 1773.6 1940.2 9299.9 9690.2 9736.0 9929.5 10026.9 9603.7 9803.8 9886.5 9900.3 9905.6 2229.6 2293.6 2489.3 2559.8 2594.8 2589.9 2597.9 2599.3 2601.6 2615.8 2531.7 2569.2 2574.5 2575.3 2577.0 2157.5 2374.5 2446.1 2448.8 2460.2 2440.8 2445.2 2463.5 2467.3 2483.0 9756.2 9832.6 9839.0 9855.4 9889.0 5775.0 5928.3 5933.8 5937.3 5940.5 3552.3 3646.1 3674.8 3675.1 3715.1 1089.3 1104.5 1118.9 1133.8 1133.9 14294.7 14310.5 14372.9 14388.6 14406.4 5029.5 5073.3 5098.7 5109.9 5171.1 11186.3 11234.9 11236.6 11240.5 11242.6 5705.1 5720.9 5722.6 5724.4 5726.1 4667.4 5261.6 5349.7 5401.8 5474.5 4416.9 4432.3 4487.0 4493.7 4520.3 1359.0 1422.6 1427.3 1435.8 1456.1 872.2 1037.8 1040.4 1047.5 1055.1 6609.6 6653.0 6797.9 6820.0 6886.9 956.0 979.5 1002.6 1010.0 1013.2 4465.5 4615.0 4688.3 4815.3 4853.8 11736.8 12239.2 12418.9 12656.2 12822.5 12402.8 12409.6 12448.9 12456.6 12458.9 8883.6 9122.5 9125.6 9131.4 9144.3 6720.5 6821.1 6919.1 6934.4 6960.7 11002.6 11280.8 11575.5 11577.2 11778.4 11427.9 11576.4 11648.2 11671.5 12003.2 7734.3 8362.4 8579.6 8592.5 8733.2 9662.0 9672.3 9694.2 9757.9 9763.1 8565.7 8581.7 8636.1 8687.7 8702.6 8387.8 8438.4 8610.6 8629.1 8719.1 7883.5 7987.2 7995.9 8004.4 8011.9 5376.0 5637.2 5712.5 5727.7 5770.7 5783.5 5847.2 5850.9 5960.9 6034.6 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | [#4] prototype.html Cycles:180 Average:4789.43 Median:5369.23 stddev:1390.02 (25.9%) stddev-sans-first:1353.47 02:15:34 INFO - PROCESS | 23303 | Values: 354.2 358.4 360.0 362.5 368.1 5524.8 5605.9 5642.8 5656.2 5684.3 5341.0 5507.1 5554.3 5565.9 5589.4 4282.8 4371.5 4382.6 4413.5 4427.2 4343.4 4355.3 4379.5 4381.5 4384.3 4301.1 4323.8 4358.0 4377.1 4379.0 4126.3 4314.9 4337.8 4338.0 4345.6 3724.7 3751.5 3754.8 3769.1 3808.3 5365.9 5367.8 5372.0 5391.5 5446.7 4737.8 4956.4 4968.7 4993.4 5003.6 5806.3 5823.2 5835.9 5845.6 5849.6 4183.7 4185.3 4220.2 4224.5 4239.9 5811.4 5883.9 5886.8 6081.8 6091.0 4240.3 4253.9 4271.5 4289.8 4315.1 4368.0 4388.8 4391.3 4394.5 4397.0 4808.5 4897.5 4904.7 4920.9 4931.4 5882.7 5892.9 5913.4 5916.4 5917.5 1440.5 1475.0 1477.8 1478.9 1487.1 958.6 960.5 983.6 988.9 996.6 5046.9 5092.0 5104.3 5129.2 5142.8 5358.7 5371.5 5387.4 5394.4 5434.3 4834.0 5120.7 5126.5 5168.7 5174.4 2822.7 2848.8 2852.5 2892.7 2894.8 5540.4 5593.3 5604.1 5616.1 5630.9 5279.9 5412.8 5422.2 5460.3 5486.0 5479.3 5483.9 5513.3 5535.5 5552.3 5162.3 5305.9 5340.6 5370.7 5397.4 5268.6 5317.0 5340.7 5745.5 5841.6 6175.5 6191.2 6239.3 6285.0 6288.2 4305.8 4311.7 4326.5 4333.1 4346.6 5793.2 6017.5 6027.8 6032.6 6081.5 5871.7 5888.4 5888.5 5927.2 5929.0 5626.2 5858.0 5905.3 5915.5 5938.2 5771.9 5786.5 5796.7 5805.4 5817.1 5914.9 5939.8 5946.8 5952.9 6001.3 5673.8 5695.6 5755.5 5756.5 5757.9 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - PROCESS | 23303 | [#5] yui.html Cycles:180 Average:20795.45 Median:4560.34 stddev:30482.97 (668.4%) stddev-sans-first:30531.38 02:15:34 INFO - PROCESS | 23303 | Values: 767.3 789.6 794.9 836.3 860.4 14172.5 14216.7 14642.9 15355.1 15394.2 14242.2 14417.6 14430.8 14442.2 14463.8 724.5 743.9 747.3 854.3 875.2 736.1 837.9 862.5 864.2 866.6 911.9 913.6 915.1 915.4 916.2 767.2 910.6 910.8 912.4 912.6 661.2 677.8 678.4 679.6 679.8 13262.3 13356.0 13360.9 13380.5 13387.7 15061.0 15473.8 15477.5 15512.6 15721.7 13859.0 13901.0 13946.8 13989.4 14240.8 4731.5 4764.9 4806.6 4833.5 4942.7 71449.6 71604.0 72138.0 72515.0 76201.6 11267.7 11375.3 11396.0 11401.5 11500.5 19723.5 19768.2 19804.0 19885.0 19950.1 8948.8 8954.3 9017.7 9218.4 9443.6 4488.1 4522.2 4558.9 4620.0 4665.1 3546.2 3595.2 3635.1 4338.2 4508.6 756.5 763.3 769.5 776.1 776.5 752.4 767.8 778.4 790.4 792.0 9814.9 9941.0 10070.5 10092.6 10172.4 726.7 751.8 761.4 764.2 769.9 4561.8 4811.9 4828.3 4829.5 4855.4 124854.4 128516.0 128599.4 129723.0 131600.0 67399.7 82825.2 112730.4 113548.4 113945.0 70750.9 71620.6 73401.0 88981.0 92048.5 9512.8 9544.2 9779.2 9824.9 9859.9 38526.8 45302.8 48667.5 50146.0 53135.7 52239.7 73712.6 75859.2 76324.0 76883.2 13724.9 13745.9 13890.3 14238.9 14391.3 14934.0 15212.6 15425.3 16008.8 17030.7 10018.7 11742.5 13276.6 13516.3 13744.8 14488.6 14890.8 15102.0 15381.8 15485.4 13587.8 13734.7 13792.5 13942.1 14149.5 11926.5 11946.3 11946.6 12055.3 12281.3 11066.4 11163.8 11184.7 11195.9 11267.8 02:15:34 INFO - PROCESS | 23303 | -------- Summary: end -------- 02:15:34 INFO - PROCESS | 23303 | 02:15:34 INFO - TEST-INFO | 23303: exit 0 02:15:34 INFO - TEST-OK | dromaeo_css | took 1113442ms 02:15:34 INFO - TEST-START | kraken 02:15:34 INFO - operating with platform_type : linux_ 02:15:34 INFO - Initialising browser for kraken test... 02:15:34 INFO - TEST-INFO | started process 23492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGBeI8p/profile http://localhost:58197/getInfo.html) 02:15:38 INFO - PROCESS | 23492 | __metrics Screen width/height:1600/1200 02:15:38 INFO - PROCESS | 23492 | colorDepth:24 02:15:38 INFO - PROCESS | 23492 | Browser inner width/height: 1024/697 02:15:38 INFO - PROCESS | 23492 | __metrics 02:15:39 ERROR - PROCESS | 23492 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:15:40 INFO - TEST-INFO | 23492: exit 0 02:15:40 INFO - Browser initialized. 02:15:40 INFO - Running cycle 1/1 for kraken test... 02:15:40 INFO - TEST-INFO | started process 23583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGBeI8p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:52 INFO - PROCESS | 23583 | RSS: Main: 145502208 02:15:52 INFO - PROCESS | 23583 | 02:15:54 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58197/tests/kraken/driver.html?testName=audio-beat-detection) 02:15:55 INFO - PROCESS | 23583 | RSS: Main: 195059712 02:15:55 INFO - PROCESS | 23583 | 02:15:58 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58197/tests/kraken/driver.html?testName=audio-dft) 02:15:59 INFO - PROCESS | 23583 | RSS: Main: 192806912 02:15:59 INFO - PROCESS | 23583 | 02:16:01 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58197/tests/kraken/driver.html?testName=audio-fft) 02:16:02 INFO - PROCESS | 23583 | RSS: Main: 279097344 02:16:02 INFO - PROCESS | 23583 | 02:16:04 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58197/tests/kraken/driver.html?testName=audio-oscillator) 02:16:05 INFO - PROCESS | 23583 | RSS: Main: 187203584 02:16:05 INFO - PROCESS | 23583 | 02:16:07 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58197/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:16:07 INFO - PROCESS | 23583 | RSS: Main: 188055552 02:16:07 INFO - PROCESS | 23583 | 02:16:10 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58197/tests/kraken/driver.html?testName=imaging-darkroom) 02:16:11 INFO - PROCESS | 23583 | RSS: Main: 222552064 02:16:11 INFO - PROCESS | 23583 | 02:16:14 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58197/tests/kraken/driver.html?testName=imaging-desaturate) 02:16:15 INFO - PROCESS | 23583 | RSS: Main: 222740480 02:16:15 INFO - PROCESS | 23583 | 02:16:18 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58197/tests/kraken/driver.html?testName=json-parse-financial) 02:16:18 INFO - PROCESS | 23583 | RSS: Main: 222883840 02:16:18 INFO - PROCESS | 23583 | 02:16:20 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58197/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:16:20 INFO - PROCESS | 23583 | RSS: Main: 201674752 02:16:20 INFO - PROCESS | 23583 | 02:16:22 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:16:23 INFO - PROCESS | 23583 | RSS: Main: 201768960 02:16:23 INFO - PROCESS | 23583 | 02:16:25 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:16:25 INFO - PROCESS | 23583 | RSS: Main: 207667200 02:16:25 INFO - PROCESS | 23583 | 02:16:28 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:16:28 INFO - PROCESS | 23583 | RSS: Main: 213934080 02:16:28 INFO - PROCESS | 23583 | 02:16:31 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:16:32 INFO - PROCESS | 23583 | RSS: Main: 213659648 02:16:32 INFO - PROCESS | 23583 | 02:16:33 INFO - PROCESS | 23583 | Cycle 1(1): loaded http://localhost:58197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58197/tests/kraken/driver.html?testName=ai-astar) 02:16:34 INFO - PROCESS | 23583 | RSS: Main: 256155648 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | __start_tp_report 02:16:34 INFO - PROCESS | 23583 | _x_x_mozilla_page_load 02:16:34 INFO - PROCESS | 23583 | _x_x_mozilla_page_load_details 02:16:34 INFO - PROCESS | 23583 | |i|pagename|runs| 02:16:34 INFO - PROCESS | 23583 | |0;ai-astar;110;103;108;109;108;108;108;109;109;108 02:16:34 INFO - PROCESS | 23583 | |1;audio-beat-detection;159;122;124;171;125;157;154;124;174;124 02:16:34 INFO - PROCESS | 23583 | |2;audio-dft;161;163;158;160;160;162;160;160;160;160 02:16:34 INFO - PROCESS | 23583 | |3;audio-fft;75;74;75;108;74;75;74;74;101;75 02:16:34 INFO - PROCESS | 23583 | |4;audio-oscillator;84;84;115;85;84;84;118;83;84;141 02:16:34 INFO - PROCESS | 23583 | |5;imaging-gaussian-blur;117;118;117;116;116;117;117;117;117;116 02:16:34 INFO - PROCESS | 23583 | |6;imaging-darkroom;146;145;146;145;147;145;145;146;147;145 02:16:34 INFO - PROCESS | 23583 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;94 02:16:34 INFO - PROCESS | 23583 | |8;json-parse-financial;50;50;50;52;51;52;50;50;52;53 02:16:34 INFO - PROCESS | 23583 | |9;json-stringify-tinderbox;60;61;60;60;61;59;60;60;60;61 02:16:34 INFO - PROCESS | 23583 | |10;stanford-crypto-aes;76;76;76;76;76;78;77;77;107;76 02:16:34 INFO - PROCESS | 23583 | |11;stanford-crypto-ccm;129;121;118;117;119;115;118;117;134;119 02:16:34 INFO - PROCESS | 23583 | |12;stanford-crypto-pbkdf2;153;154;156;155;160;157;151;155;151;150 02:16:34 INFO - PROCESS | 23583 | |13;stanford-crypto-sha256-iterative;62;62;62;61;60;60;60;60;59;59 02:16:34 INFO - PROCESS | 23583 | __end_tp_report 02:16:34 INFO - PROCESS | 23583 | __start_cc_report 02:16:34 INFO - PROCESS | 23583 | _x_x_mozilla_cycle_collect,1559 02:16:34 INFO - PROCESS | 23583 | __end_cc_report 02:16:34 INFO - PROCESS | 23583 | __startTimestamp1467364594108__endTimestamp 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | ------- Summary: start ------- 02:16:34 INFO - PROCESS | 23583 | Number of tests: 14 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:1.89 (1.7%) stddev-sans-first:1.86 02:16:34 INFO - PROCESS | 23583 | Values: 110.0 103.0 108.0 109.0 108.0 108.0 108.0 109.0 109.0 108.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:155.50 stddev:21.51 (13.8%) stddev-sans-first:22.06 02:16:34 INFO - PROCESS | 23583 | Values: 159.0 122.0 124.0 171.0 125.0 157.0 154.0 124.0 174.0 124.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 02:16:34 INFO - PROCESS | 23583 | Values: 161.0 163.0 158.0 160.0 160.0 162.0 160.0 160.0 160.0 160.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.50 stddev:12.76 (17.1%) stddev-sans-first:13.38 02:16:34 INFO - PROCESS | 23583 | Values: 75.0 74.0 75.0 108.0 74.0 75.0 74.0 74.0 101.0 75.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.00 stddev:20.76 (24.7%) stddev-sans-first:21.55 02:16:34 INFO - PROCESS | 23583 | Values: 84.0 84.0 115.0 85.0 84.0 84.0 118.0 83.0 84.0 141.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:16:34 INFO - PROCESS | 23583 | Values: 117.0 118.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 02:16:34 INFO - PROCESS | 23583 | Values: 146.0 145.0 146.0 145.0 147.0 145.0 145.0 146.0 147.0 145.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:16:34 INFO - PROCESS | 23583 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.50 stddev:1.15 (2.2%) stddev-sans-first:1.17 02:16:34 INFO - PROCESS | 23583 | Values: 50.0 50.0 50.0 52.0 51.0 52.0 50.0 50.0 52.0 53.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 02:16:34 INFO - PROCESS | 23583 | Values: 60.0 61.0 60.0 60.0 61.0 59.0 60.0 60.0 60.0 61.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:76.00 stddev:9.69 (12.7%) stddev-sans-first:10.19 02:16:34 INFO - PROCESS | 23583 | Values: 76.0 76.0 76.0 76.0 76.0 78.0 77.0 77.0 107.0 76.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:119.00 stddev:6.02 (5.1%) stddev-sans-first:5.59 02:16:34 INFO - PROCESS | 23583 | Values: 129.0 121.0 118.0 117.0 119.0 115.0 118.0 117.0 134.0 119.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:155.00 stddev:3.08 (2.0%) stddev-sans-first:3.24 02:16:34 INFO - PROCESS | 23583 | Values: 153.0 154.0 156.0 155.0 160.0 157.0 151.0 155.0 151.0 150.0 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - PROCESS | 23583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.50 stddev:1.18 (1.9%) stddev-sans-first:1.12 02:16:34 INFO - PROCESS | 23583 | Values: 62.0 62.0 62.0 61.0 60.0 60.0 60.0 60.0 59.0 59.0 02:16:34 INFO - PROCESS | 23583 | -------- Summary: end -------- 02:16:34 INFO - PROCESS | 23583 | 02:16:34 INFO - TEST-INFO | 23583: exit 0 02:16:35 INFO - TEST-OK | kraken | took 60040ms 02:16:35 INFO - SUITE-END | took 1173s 02:16:35 INFO - Completed test suite (00:19:33) 02:16:35 INFO - javascript benchmark 02:16:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.368711788319, 3451.7411194160427, 3454.7754395964275, 3473.0101920952534, 3504.018874715079, 5702.657840529566, 5778.133280008001, 5796.913046304298, 5817.243758311419, 5825.5048320892665, 5785.16115163301, 5883.235179426669, 5883.882322353561, 5887.116932460133, 5891.410858914106, 5057.0897238497055, 5143.948560514403, 5263.184206447988, 5285.154375299952, 5341.0920143575495, 5224.555912747421, 5264.210368444726, 5267.920981185285, 5268.130758424855, 5269.341332333458, 5239.161734122541, 5245.055889939809, 5266.710330931797, 5273.1826566882, 5273.683578985254, 5362.758675859576, 5379.946200537984, 5386.434424385422, 5386.515213630772, 5386.8383948481605, 5027.170516864713, 5110.71891045996, 5159.819406320798, 5247.632665713401, 5263.105272103751, 5579.38626751057, 5593.74828132735, 5594.888102237973, 5612.298462692163, 5634.126710359901, 6222.222222222223, 6228.0, 6228.626282423023, 6229.470495007885, 6235.781747638856, 6073.544484163705, 6081.270247570275, 6137.11011903276, 6161.6303021818385, 6219.968900155515, 5763.538916886639, 5774.105013722879, 5790.652560846363, 5792.999999999958, 5798.043322851724, 6106.267247930276, 6246.46905013079, 6247.344028876993, 6268.59254148488, 6270.6864656766975, 6052.502075328169, 6062.696865156725, 6121.571489995657, 6170.568060235741, 6181.81454556364, 6253.249610046823, 6253.499720022387, 6253.843653908689, 6254.655993920378, 6255.6872156392, 6038.0, 6132.727681134083, 6235.563510554218, 6241.625502469867, 6248.5313601480075, 6184.5980011299125, 6276.592021518587, 6298.08677741734, 6317.5893566918, 6319.273283572448, 4694.647901407408, 4694.718316900997, 4734.763261836894, 4756.762161891892, 4791.808327666854, 4119.361498967664, 4154.293770059097, 4185.539590645027, 4256.659467242614, 4283.378910058024, 5974.880502389928, 5981.641101533834, 5982.461578457873, 5986.982213023796, 6005.249343832021, 6269.96865015672, 6273.404026617464, 6273.686315684197, 6274.686265686697, 6278.905816412757, 5790.594658373873, 5877.764889404376, 5913.674747888821, 5918.526517878559, 5970.940290597126, 5187.559057480156, 5191.6884986900905, 5193.272941788153, 5197.714125723046, 5214.191800270964, 6463.095166676669, 6468.870622587522, 6469.288378278386, 6478.352164783578, 6479.870402591921, 6091.451769340781, 6115.788007244199, 6132.661461321697, 6155.0151975683675, 6265.937340626718, 6437.839054023687, 6450.387213214737, 6455.7740479083, 6459.160309159779, 6463.806085817433, 5928.347881733092, 6088.330283668882, 6127.479164270909, 6133.785317514044, 6134.846628834136, 6114.936124487681, 6151.3541078186145, 6197.194364732556, 6256.655883926428, 6276.497880169667, 6071.939280607137, 6072.939270607238, 6074.028155495276, 6074.301455332693, 6110.480609148094, 5939.1982082420045, 5982.312034116132, 6079.240094988127, 6097.0, 6100.908486372619, 5912.556558258062, 5938.554608404474, 5955.166276721349, 5981.0729336952845, 6012.977793775156, 6130.570860039755, 6132.824595223688, 6136.29432615255, 6140.499915048379, 6147.815565533041, 5736.082226843685, 5960.284765828128, 5976.163337132892, 6004.819855404345, 6028.698565071817], "value": 5714.0308222441, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5480961873785, 650.0931200974637, 653.8398092467346, 667.4493542827167, 670.9127813384265, 33605.83197084014, 46551.0, 47021.0595788084, 47315.0, 47383.28925066127, 48888.51111488884, 49339.50660493394, 49364.259536106896, 49432.0, 49500.0, 8435.283000944897, 8999.59501822418, 9150.222231110363, 9157.404768690014, 11232.539769829911, 10877.129829613652, 10999.725006874813, 11336.603218887341, 11363.715907102305, 11373.033292170134, 11315.151363647718, 11415.31508109512, 11415.657530274106, 11419.143564232674, 11430.771384572303, 8309.95845020777, 11100.777984440267, 11307.830382544269, 11330.150238732129, 11337.206395552315, 11168.385738784364, 11236.550537978472, 11250.324980501196, 11258.887411125866, 11259.099272058216, 46928.0, 47356.763216184045, 47390.28914566284, 47445.288320675216, 47491.76254118742, 3801.068738159169, 3836.8848934532007, 3950.071733142709, 3957.861474848395, 4117.3618089196225, 35761.46357804635, 36312.45531317032, 36491.4526282106, 36578.63421365806, 37315.44026839599, 4598.425196850394, 4626.8149274029, 4645.744484053375, 4676.50896655853, 4800.711957282574, 424409.87795061135, 428559.0, 430906.0, 430913.0, 433684.0, 38896.80551597224, 70833.64583177051, 71550.64224678843, 71639.28360716431, 71687.28312716911, 40427.39358909619, 42124.368134478005, 42175.78912105481, 42197.78901105536, 42202.15595688069, 17604.735928961076, 17663.55841103957, 17729.379471718687, 17743.290268389377, 17744.112794360488, 11766.529338826522, 13993.30033498321, 14121.364538595788, 14135.08121972089, 14473.638159045897, 9402.858957115648, 9404.106609872051, 9428.528573571293, 9428.858567121499, 9484.620615175316, 3560.145565064366, 3568.8572457101945, 3606.4590311452966, 3670.4127339625534, 3670.7981061041364, 1110.2894147745287, 1114.4427786106946, 1129.2998341028615, 1152.9942350288363, 1170.2276497511602, 33945.66054339474, 34553.82723086369, 34995.475067874, 35192.47211291832, 35206.82396588052, 1130.2314426190105, 1133.863936327646, 1171.6250799744, 1205.7889869272842, 1268.308771719415, 17140.40008599693, 17412.47762567125, 17443.215055322285, 17455.0, 17516.91241543784, 675549.0, 683976.0, 684813.0, 689688.0, 691379.0, 63277.36722632715, 64314.35685643084, 64642.67678661577, 64822.675886620265, 64897.351026490076, 1394.9442022319197, 1476.343027352839, 1484.799552060458, 1536.285627183365, 1541.7070756556218, 33537.664623353456, 34252.82873585716, 34462.13844653904, 35026.299474010884, 35256.0, 55231.72384138054, 56135.0, 56139.438605613424, 56187.438125619854, 56269.71865140648, 451916.0, 452098.0, 455647.0, 456621.0, 502885.0, 30073.0, 30793.538096929013, 30983.0, 31822.0, 32095.35809283848, 51127.74436127795, 51517.742411287705, 52083.479165207864, 52515.0, 53006.204906927196, 43342.43040738251, 43531.0, 43785.78107109571, 43825.34261986137, 44106.77946610247, 43151.568484314754, 43455.348169776844, 44250.114997699224, 44561.77719111383, 44770.77614612036, 43586.0, 43802.78098609614, 43967.78016109899, 44665.33002005037, 44767.328490072025, 37940.43089353607, 38827.2234555313, 38887.22225555417, 38942.0, 39151.608483914795, 29131.85434072816, 29198.854005730685, 29575.704242958156, 29639.40721185521, 30027.249318767204], "value": 21098.419642300087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.9238737027334, 434.57676110737333, 435.86052463211774, 438.5548668101877, 449.4494244550426, 18656.533586660342, 19608.31370902017, 20243.59512809743, 20256.291029813958, 20449.795502044974, 18065.36771213008, 18917.337893173706, 18920.62158756824, 19237.0, 19532.02339883004, 5298.761555729991, 5463.726813659321, 5507.4767897049915, 5509.283793106891, 5510.91733623996, 4110.095778928646, 4638.768061596924, 5409.864753381157, 5414.7834086636485, 6697.19633643961, 6480.4491618212505, 6640.900386494206, 6673.299303573128, 6675.866482670343, 6680.331966803329, 5948.672822994734, 6085.330613632497, 6093.421124993119, 6196.721147548348, 6635.0, 3976.5426975897853, 4166.895827604304, 4179.6029377209115, 5865.912011319833, 5880.764769409261, 13996.580102596938, 14735.70528589433, 14745.336459859225, 16867.493975180765, 24325.87837060821, 2517.6698162339003, 2553.4254792671686, 2646.563317052684, 2661.4810112028163, 2864.2266588021116, 10271.38371697693, 10293.279470437072, 10448.529816158216, 10535.578576856993, 11170.832437513443, 2012.0945574491536, 2018.1523760020827, 2042.1729199674155, 2083.3020937985793, 2126.075157306577, 81994.0, 83184.58407707923, 83605.16394835974, 85714.57142714247, 85788.0, 11690.766184676258, 11722.472488738027, 11789.115816313812, 11914.88085119155, 12619.116661833767, 16702.832971670126, 16787.412440564767, 16834.158292085347, 16836.74744878828, 16877.0, 8747.387682862265, 8790.824183516293, 8822.117788221127, 8907.777305567413, 9085.318601104944, 8537.701180458655, 8615.181557752003, 8709.346798990102, 8739.21347078766, 8813.867791983126, 5050.595952323805, 5051.166557518042, 5068.113080211022, 5077.8730531737, 5115.437301896788, 2040.1125510403022, 2042.8570000100146, 2080.9063592138086, 2099.643060679688, 2151.752548456916, 1016.364772017489, 1064.6060957445795, 1076.9515371808288, 1122.320995797547, 1125.6004118537965, 18364.0, 18907.527311817314, 19293.131809068625, 19360.0, 19458.318958836655, 1038.1746511523356, 1041.354360296621, 1050.207093644309, 1059.1473863539925, 1065.7708592652616, 10112.0, 10684.0, 10692.121254348378, 10769.730756730987, 10896.196968562066, 474205.0, 478854.0, 486552.0, 488130.0, 488159.0, 76960.61519692365, 91980.0, 92403.537982311, 93397.5330123345, 95749.0, 1051.432226597644, 1062.9946850265699, 1064.6965614799744, 1070.2668671959732, 1071.3464786480397, 17099.0, 17357.392491262744, 17593.912030439766, 17811.821881781016, 17823.554411139827, 39645.207095857346, 40917.79541102275, 42577.787111064245, 43244.0, 43843.342349865416, 59524.40475595189, 60355.396446034974, 60371.69814150901, 61001.0, 61131.0, 7853.685852566062, 8355.498670079814, 8373.916260837314, 8562.828743424972, 8784.560771961249, 13490.730185396042, 13717.382717777524, 13743.0, 13779.586612401243, 14070.859291406954, 11754.412279386168, 11996.280223186637, 12141.514339426678, 12407.93796031014, 12475.75048499043, 11582.536698532302, 11856.881431185579, 12097.57658481984, 12112.576059837864, 12527.49890004426, 12297.631071067883, 12567.93716031414, 12584.907068746807, 12730.23618582888, 12901.419436125208, 8498.575071246289, 8553.272971797218, 8588.699395521127, 8654.524001179743, 8814.162654547808, 12108.818367724314, 12449.190802597803, 12640.55758048464, 12649.304288264233, 12695.492180312684], "value": 9461.694923920053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.1103293891904, 1495.932683029264, 1575.3462313140049, 1773.6098058427149, 1940.2239104358255, 9299.860502092473, 9690.176335011523, 9736.0, 9929.453880036595, 10026.94986525068, 9603.711888643335, 9803.803923921518, 9886.456244906527, 9900.25748068894, 9905.603775848975, 2229.6098182818023, 2293.6444851048113, 2489.253224032783, 2559.846409215453, 2594.8313359631657, 2589.948201035978, 2597.870106494677, 2599.2851965709488, 2601.557735185023, 2615.8168928175037, 2531.6708827852353, 2569.177863083814, 2574.4979728952862, 2575.2789219018705, 2576.9742302577015, 2157.492989147549, 2374.536965291769, 2446.082718980382, 2448.828581999243, 2460.2496238647204, 2440.804735621146, 2445.205308274818, 2463.458039231384, 2467.259822053377, 2483.019207413062, 9756.219502439859, 9832.557534910875, 9838.950805245999, 9855.35940163887, 9889.0, 5774.971125144348, 5928.258967629046, 5933.821985340447, 5937.2578427696535, 5940.495057920082, 3552.307300076486, 3646.106703857545, 3674.8346324415465, 3675.1363429594026, 3715.071232191952, 1089.2865173311493, 1104.536094840169, 1118.89929906308, 1133.7675776465805, 1133.8696049954278, 14294.714105717827, 14310.499132530416, 14372.928135359361, 14388.64028399288, 14406.351714172888, 5029.547340739277, 5073.289739436482, 5098.694078355311, 5109.926915347744, 5171.069207542603, 11186.32882027081, 11234.887651123548, 11236.550537978554, 11240.49417776202, 11242.606508772154, 5705.115707065412, 5720.856978575569, 5722.628029178173, 5724.427557244242, 5726.141078838207, 4667.416572928384, 5261.605379596545, 5349.679019258857, 5401.837944861661, 5474.452554744494, 4416.889577760582, 4432.268675668543, 4487.0, 4493.662975276868, 4520.276755719069, 1358.959231223065, 1422.6301161697827, 1427.2649585463494, 1435.7702767557141, 1456.0681164055013, 872.228078150841, 1037.7509397744639, 1040.427764729396, 1047.471027131309, 1055.076807793181, 6609.603423794588, 6652.96673516639, 6797.898031529531, 6819.965900170567, 6886.8622627548175, 955.9617615295449, 979.4906648542718, 1002.644061358222, 1010.0, 1013.1641395848454, 4465.531119232499, 4615.007773328751, 4688.320193571913, 4815.3017812417, 4853.781579828917, 11736.823947640793, 12239.20445171061, 12418.875811241773, 12656.17734847232, 12822.487100516062, 12402.81395779064, 12409.565665201675, 12448.937755311346, 12456.564020259248, 12458.937705311415, 8883.555822208864, 9122.452652840851, 9125.634974601075, 9131.406458580304, 9144.268458523302, 6720.529562930548, 6821.147356580427, 6919.135108111486, 6934.375906168469, 6960.686769095301, 11002.559897604006, 11280.830787538029, 11575.536978521102, 11577.189596728149, 11778.411079446165, 11427.942860285646, 11576.36330001858, 11648.184627076362, 11671.533138674358, 12003.219790713925, 7734.265244801735, 8362.414630975773, 8579.571021449028, 8592.484450932963, 8733.214010739064, 9662.0, 9672.274579406432, 9694.175995040501, 9757.853632195382, 9763.121319081316, 8565.700200493202, 8581.65673373083, 8636.136386361564, 8687.695930642398, 8702.564871756513, 8387.790305242417, 8438.367122465963, 8610.569471526524, 8629.137086291572, 8719.084496127814, 7883.526988380716, 7987.201279871966, 7995.880061799194, 8004.399670024655, 8011.919880801117, 5375.973120134531, 5637.182608521824, 5712.457316554921, 5727.742251598771, 5770.711464426846, 5783.450572195635, 5847.239858818326, 5850.912236316373, 5960.850978725566, 6034.577579569388], "value": 5126.534589761861, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.1588726773912, 358.44083230160953, 359.97120230381574, 362.52690239237796, 368.13855577947606, 5524.834254972352, 5605.887882242358, 5642.774289028439, 5656.1798539211895, 5684.317881854173, 5340.973295133528, 5507.063799154143, 5554.3059366893085, 5565.860853478665, 5589.385167631567, 4282.764447955361, 4371.4972778130605, 4382.649388048964, 4413.514513403523, 4427.225235583768, 4343.370211319357, 4355.303151495746, 4379.518252992184, 4381.518033016366, 4384.298512238042, 4301.075268817203, 4323.832565207392, 4357.956420435787, 4377.146456440995, 4378.9562104378865, 4126.31915733905, 4314.913701725948, 4337.804798784062, 4338.0, 4345.587169218919, 3724.7020238381137, 3751.531058617673, 3754.793486358249, 3769.133099387156, 3808.257389808988, 5365.946340536622, 5367.785288588452, 5371.973140134274, 5391.487808658171, 5446.7276636168035, 4737.763111844429, 4956.3804524434445, 4968.652194346397, 4993.375828021497, 5003.624728145403, 5806.303243610793, 5823.2138661280605, 5835.912461313083, 5845.574086753992, 5849.64902105875, 4183.657151994893, 4185.2885009548145, 4220.155968806251, 4224.514180869178, 4239.91520169598, 5811.4479124483105, 5883.9376583983485, 5886.7939622113445, 6081.756729730805, 6091.0, 4240.279152544075, 4253.9365158710325, 4271.508776490743, 4289.7640629765665, 4315.115401342718, 4367.978160109243, 4388.802503887333, 4391.275439552438, 4394.538573449806, 4396.956030439718, 4808.519148085234, 4897.534734200245, 4904.705717656952, 4920.901581968341, 4931.408231012301, 5882.735276912549, 5892.852678683067, 5913.379095195029, 5916.408359164136, 5917.46742793142, 1440.4598275646633, 1474.9896321020135, 1477.8226612806532, 1478.9499455386797, 1487.1300289330645, 958.6357184270072, 960.519740129935, 983.6114734679761, 988.9011098890054, 996.6113215845826, 5046.924296135561, 5092.0, 5104.310918026019, 5129.204973229155, 5142.817152054973, 5358.705271210043, 5371.4628537146755, 5387.4073851876265, 5394.352677678625, 5434.347878254634, 4834.018852179797, 5120.718360490208, 5126.513311139803, 5168.689878607295, 5174.353205849269, 2822.717728227202, 2848.800583959144, 2852.543593025106, 2892.6693720888206, 2894.8407837568716, 5540.418256083053, 5593.266087512884, 5604.131359639263, 5616.146671598444, 5630.85922851932, 5279.947200528022, 5412.810551630674, 5422.213779002022, 5460.31746031746, 5486.0125177468435, 5479.287692599936, 5483.862903427446, 5513.3108361454815, 5535.529479994246, 5552.250446189712, 5162.251473536241, 5305.867353316198, 5340.572754179579, 5370.677759334452, 5397.433269506645, 5268.604854635841, 5316.973415132899, 5340.706261155674, 5745.482906538432, 5841.649501029951, 6175.536834737323, 6191.19514463117, 6239.251289845066, 6284.968575157095, 6288.245410550763, 4305.784710764387, 4311.676624253131, 4326.545712700247, 4333.133373325284, 4346.630536404441, 5793.204106726928, 6017.488513476404, 6027.764308316872, 6032.577719559764, 6081.452669259788, 5871.735771890189, 5888.381719919346, 5888.499477544457, 5927.170196172453, 5928.970355148197, 5626.1842032905815, 5858.0, 5905.291365036223, 5915.467607915309, 5938.168656388023, 5771.884562308815, 5786.479216870333, 5796.681327469046, 5805.419458054161, 5817.127430885232, 5914.911276330772, 5939.792107276225, 5946.821595352147, 5952.910706339495, 6001.279846418458, 5673.8297851064535, 5695.577093918203, 5755.453231942959, 5756.453136951983, 5757.913631295618], "value": 4351.66565627558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.317087791865, 789.5617932047711, 794.9324307433868, 836.289154218914, 860.3891237221573, 14172.50396236132, 14216.715665686681, 14642.853571464282, 15355.078695278291, 15394.153321567337, 14242.216678082701, 14417.567472975801, 14430.783538246935, 14442.205678687667, 14463.78304325436, 724.5109551053044, 743.8809790433531, 747.3498056690687, 854.3421565394658, 875.2341701011615, 736.1093077376381, 837.9078301386843, 862.5385418800943, 864.2092485375873, 866.5580553917484, 911.895132059815, 913.6436789652041, 915.1123410292006, 915.3683958068945, 916.2257892081215, 767.1637914673033, 910.6448485090787, 910.7586489580267, 912.3613470570594, 912.6212621761961, 661.153723234261, 677.8136012596526, 678.352173674145, 679.6499802601664, 679.8470344172571, 13262.270575118364, 13356.0, 13360.86639133606, 13380.531681391105, 13387.665308367272, 15061.0, 15473.767893481607, 15477.5356739298, 15512.61218469536, 15721.68556628861, 13859.0, 13900.960886726933, 13946.790798138036, 13989.440422383092, 14240.786388204186, 4731.455882573514, 4764.880877978044, 4806.639502037327, 4833.516648335173, 4942.678725882806, 71449.64275178642, 71604.0, 72138.0, 72515.0, 76201.61899190524, 11267.718307042389, 11375.31748095117, 11396.0, 11401.543938242377, 11500.539978400937, 19723.50691232702, 19768.209271628974, 19804.0, 19885.0, 19950.102245398994, 8948.821023579492, 8954.328425368123, 9017.729468115967, 9218.354715170008, 9443.575039123256, 4488.102379524108, 4522.163399771053, 4558.8632341029825, 4619.976900115478, 4665.066986602693, 3546.184377593168, 3595.1551385424405, 3635.0730563706084, 4338.219120558267, 4508.616767574793, 756.5158298688843, 763.2596381509926, 769.5190505933791, 776.1268572855538, 776.5107981971322, 752.3830459023549, 767.8464307138595, 778.4200770426069, 790.4111436979487, 791.976240712768, 9814.852777208347, 9940.950295248622, 10070.546825392876, 10092.646757363604, 10172.440515771556, 726.6947881889619, 751.812046988253, 761.3756719489965, 764.2433990349514, 769.8845173223949, 4561.817527298871, 4811.855644330676, 4828.324034635154, 4829.468758436569, 4855.36880205571, 124854.37572812078, 128516.0, 128599.35700321439, 129723.0, 131600.0, 67399.66300168468, 82825.17174828296, 112730.43634781774, 113548.43225783818, 113945.0, 70750.938735919, 71620.64189679018, 73401.0, 88981.0, 92048.53975730212, 9512.809743804946, 9544.236461083236, 9779.217662586834, 9824.852627210741, 9859.852102218329, 38526.80736596299, 45302.773486132355, 48667.5133248663, 50146.0, 53135.73432132815, 52239.73880130575, 73712.63143684248, 75859.24140758743, 76324.0, 76883.23116768984, 13724.862751372759, 13745.862541374458, 13890.30548472552, 14238.928805355907, 14391.28043597837, 14934.0, 15212.619684507534, 15425.305861236497, 16008.759868602214, 17030.744538832176, 10018.699439016842, 11742.471588778355, 13276.60170194857, 13516.324183790575, 13744.793828092386, 14488.565343039725, 14890.776638350217, 15102.018368805993, 15381.769273460683, 15485.380584776933, 13587.796183057064, 13734.725305493634, 13792.517261895786, 13942.093763905314, 14149.504767333094, 11926.522939082339, 11946.283223006647, 11946.641600751991, 12055.336956467478, 12281.263124212219, 11066.446677665923, 11163.832542511705, 11184.664460066211, 11195.944020279847, 11267.774644507228], "value": 7791.305369886647, "unit": "score"}], "name": "dromaeo_css", "value": 7636.284448895929, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 108.0, 109.0, 108.0, 108.0, 108.0, 109.0, 109.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 124.0, 171.0, 125.0, 157.0, 154.0, 124.0, 174.0, 124.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 158.0, 160.0, 160.0, 162.0, 160.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 108.0, 74.0, 75.0, 74.0, 74.0, 101.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 85.0, 84.0, 84.0, 118.0, 83.0, 84.0, 141.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 146.0, 147.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, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 52.0, 51.0, 52.0, 50.0, 50.0, 52.0, 53.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 76.0, 78.0, 77.0, 77.0, 107.0, 76.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 118.0, 117.0, 119.0, 115.0, 118.0, 117.0, 134.0, 119.0], "value": 120.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 156.0, 155.0, 160.0, 157.0, 151.0, 155.0, 151.0, 150.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0], "value": 60.5, "unit": "score"}], "name": "kraken", "value": 1471.8000000000002, "alertThreshold": 2.0}]} 02:16:35 INFO - Return code: 0 02:16:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:16:35 ERROR - # TBPL SUCCESS # 02:16:35 INFO - Running post-action listener: _resource_record_post_action 02:16:35 INFO - ##### 02:16:35 INFO - ##### Finished run-tests step (success) 02:16:35 INFO - ##### 02:16:35 INFO - Running post-run listener: _resource_record_post_run 02:16:35 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 290816; Write bytes: 266285056; Read time: 48; Write time: 168984 02:16:35 INFO - TinderboxPrint: CPU usage
13.1% 02:16:35 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 48 02:16:35 INFO - TinderboxPrint: I/O write bytes / time
266,285,056 / 168,984 02:16:35 INFO - TinderboxPrint: CPU idle
8,257.8 (86.9%) 02:16:35 INFO - TinderboxPrint: CPU user
1,204.2 (12.7%) 02:16:35 INFO - TinderboxPrint: Swap in / out
0 / 0 02:16:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17719296; Read time: 0; Write time: 3812 02:16:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248565760; Read time: 32; Write time: 165172 02:16:36 INFO - Running post-run listener: _upload_blobber_files 02:16:36 INFO - Blob upload gear active. 02:16:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:16:36 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 02:16:36 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'] 02:16:36 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 02:16:36 INFO - (blobuploader) - INFO - Open directory for files ... 02:16:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:16:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:37 INFO - (blobuploader) - INFO - Done attempting. 02:16:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:16:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:16:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:40 INFO - (blobuploader) - INFO - Done attempting. 02:16:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:16:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:16:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:41 INFO - (blobuploader) - INFO - Done attempting. 02:16:41 INFO - (blobuploader) - INFO - Iteration through files over. 02:16:41 INFO - Return code: 0 02:16:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:16:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:16:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6e345cc3e67432d936dc2f7089f62140832f2d7b3a30925edff558997d2d9cb494e92834c118e0de9641cba2168b5855cd32411fd98cc48cda10f53726ad531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9312016addb186064594266141e2dcffc855b2c45c0ed72a668661a80a56c90a758abc3adade9ca7e4cf5b016206e4362580209e08c5b2a1710eb834491e6207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9151cec4d18d20ca6e7f3d8faee1238ef05b616bba377eda3948eac25f4a912e1ff255929d21b7c66e25fb7eb9320f36b5b5c37e3b568d698267c6244a9787c"} 02:16:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:16:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:16:41 INFO - Contents: 02:16:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6e345cc3e67432d936dc2f7089f62140832f2d7b3a30925edff558997d2d9cb494e92834c118e0de9641cba2168b5855cd32411fd98cc48cda10f53726ad531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9312016addb186064594266141e2dcffc855b2c45c0ed72a668661a80a56c90a758abc3adade9ca7e4cf5b016206e4362580209e08c5b2a1710eb834491e6207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9151cec4d18d20ca6e7f3d8faee1238ef05b616bba377eda3948eac25f4a912e1ff255929d21b7c66e25fb7eb9320f36b5b5c37e3b568d698267c6244a9787c"} 02:16:41 INFO - Running post-run listener: copy_logs_to_upload_dir 02:16:41 INFO - Copying logs to upload dir... 02:16:41 INFO - mkdir: /builds/slave/test/build/upload/logs 02:16:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.165564 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-01 02:16:41.393652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 02:16:41.397151) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452 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/c6e345cc3e67432d936dc2f7089f62140832f2d7b3a30925edff558997d2d9cb494e92834c118e0de9641cba2168b5855cd32411fd98cc48cda10f53726ad531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9312016addb186064594266141e2dcffc855b2c45c0ed72a668661a80a56c90a758abc3adade9ca7e4cf5b016206e4362580209e08c5b2a1710eb834491e6207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9151cec4d18d20ca6e7f3d8faee1238ef05b616bba377eda3948eac25f4a912e1ff255929d21b7c66e25fb7eb9320f36b5b5c37e3b568d698267c6244a9787c"} build_url:https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/WqjGTlA4Rj2xAovmBf3pIg/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/c6e345cc3e67432d936dc2f7089f62140832f2d7b3a30925edff558997d2d9cb494e92834c118e0de9641cba2168b5855cd32411fd98cc48cda10f53726ad531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9312016addb186064594266141e2dcffc855b2c45c0ed72a668661a80a56c90a758abc3adade9ca7e4cf5b016206e4362580209e08c5b2a1710eb834491e6207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9151cec4d18d20ca6e7f3d8faee1238ef05b616bba377eda3948eac25f4a912e1ff255929d21b7c66e25fb7eb9320f36b5b5c37e3b568d698267c6244a9787c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 02:16:41.423482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:16:41.423901) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467362214.491368-1776750452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004359 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:16:41.506520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 02:16:41.506928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 02:16:41.507252) ========= ========= Total master_lag: 0.18 =========