builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1467582360.57 results: success (0) buildid: 20160703120721 builduid: 13625e6040d54dd0b7fdf988296ed7cf revision: 98359ff36d9781257d297f4eeada5bbc99481015 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.574907) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.575376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.575885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.641664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.641941) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 14:46:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-07-03 14:46:00 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159524 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.858938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.859216) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019544 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.910955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:00.911264) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98359ff36d9781257d297f4eeada5bbc99481015 --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 98359ff36d9781257d297f4eeada5bbc99481015 --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=97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 14:46:01,020 truncating revision to first 12 chars 2016-07-03 14:46:01,020 Setting DEBUG logging. 2016-07-03 14:46:01,020 attempt 1/10 2016-07-03 14:46:01,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/98359ff36d97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 14:46:01,443 unpacking tar archive at: mozilla-aurora-98359ff36d97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.751494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:01.675972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:01.676298) ========= script_repo_revision: 98359ff36d9781257d297f4eeada5bbc99481015 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:01.676739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:01.677014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 14:46:01.703197) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-03 14:46:01.703476) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:46:02 INFO - MultiFileLogger online at 20160703 14:46:02 in /builds/slave/test 14:46:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:46:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:46:02 INFO - {'append_to_log': False, 14:46:02 INFO - 'base_work_dir': '/builds/slave/test', 14:46:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:46:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:46:02 INFO - 'branch': 'Mozilla-Aurora', 14:46:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:46:02 INFO - 'config_files': ('talos/linux_config.py',), 14:46:02 INFO - 'default_actions': ('clobber', 14:46:02 INFO - 'read-buildbot-config', 14:46:02 INFO - 'download-and-extract', 14:46:02 INFO - 'populate-webroot', 14:46:02 INFO - 'create-virtualenv', 14:46:02 INFO - 'install', 14:46:02 INFO - 'run-tests'), 14:46:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:46:02 INFO - 'download_minidump_stackwalk': True, 14:46:02 INFO - 'download_symbols': 'ondemand', 14:46:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:46:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:46:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:46:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:46:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:46:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:46:02 INFO - 'installer_path': 'installer.exe', 14:46:02 INFO - 'log_level': 'info', 14:46:02 INFO - 'log_name': 'talos', 14:46:02 INFO - 'log_to_console': True, 14:46:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:46:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:46:02 INFO - 'opt_config_files': (), 14:46:02 INFO - 'pip_index': False, 14:46:02 INFO - 'sps_profile': False, 14:46:02 INFO - 'sps_profile_interval': 0, 14:46:02 INFO - 'suite': 'dromaeojs-e10s', 14:46:02 INFO - 'system_bits': '32', 14:46:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:46:02 INFO - 'title': 'talos-linux64-ix-068', 14:46:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:46:02 INFO - 'use_talos_json': True, 14:46:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:46:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:46:02 INFO - 'work_dir': 'build'} 14:46:02 INFO - ##### 14:46:02 INFO - ##### Running clobber step. 14:46:02 INFO - ##### 14:46:02 INFO - Running pre-action listener: _resource_record_pre_action 14:46:02 INFO - Running main action method: clobber 14:46:02 INFO - rmtree: /builds/slave/test/build 14:46:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:46:02 INFO - Running post-action listener: _resource_record_post_action 14:46:02 INFO - ##### 14:46:02 INFO - ##### Finished clobber step (success) 14:46:02 INFO - ##### 14:46:02 INFO - ##### 14:46:02 INFO - ##### Running read-buildbot-config step. 14:46:02 INFO - ##### 14:46:02 INFO - Running pre-action listener: _resource_record_pre_action 14:46:02 INFO - Running main action method: read_buildbot_config 14:46:02 INFO - Using buildbot properties: 14:46:02 INFO - { 14:46:02 INFO - "project": "", 14:46:02 INFO - "product": "firefox", 14:46:02 INFO - "script_repo_revision": "production", 14:46:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:46:02 INFO - "repository": "", 14:46:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:46:02 INFO - "buildid": "20160703120721", 14:46:02 INFO - "pgo_build": "True", 14:46:02 INFO - "basedir": "/builds/slave/test", 14:46:02 INFO - "buildnumber": 395, 14:46:02 INFO - "slavename": "talos-linux64-ix-068", 14:46:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:46:02 INFO - "platform": "ubuntu64_hw", 14:46:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:46:02 INFO - "branch": "mozilla-aurora", 14:46:02 INFO - "repo_path": "releases/mozilla-aurora", 14:46:02 INFO - "revision": "98359ff36d9781257d297f4eeada5bbc99481015", 14:46:02 INFO - "stage_platform": "linux64-pgo", 14:46:02 INFO - "builduid": "13625e6040d54dd0b7fdf988296ed7cf", 14:46:02 INFO - "slavebuilddir": "test" 14:46:02 INFO - } 14:46:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:46:02 INFO - Running post-action listener: _resource_record_post_action 14:46:02 INFO - ##### 14:46:02 INFO - ##### Finished read-buildbot-config step (success) 14:46:02 INFO - ##### 14:46:02 INFO - ##### 14:46:02 INFO - ##### Running download-and-extract step. 14:46:02 INFO - ##### 14:46:02 INFO - Running pre-action listener: _resource_record_pre_action 14:46:02 INFO - Running main action method: download_and_extract 14:46:02 INFO - mkdir: /builds/slave/test/build/tests 14:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:02 INFO - https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:46:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:46:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:46:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:05 INFO - Downloaded 1361 bytes. 14:46:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:46:05 INFO - Using the following test package requirements: 14:46:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:46:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:46:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:46:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'jsshell-linux-x86_64.zip'], 14:46:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:46:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:46:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:46:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:46:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:46:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:46:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:46:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:46:05 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')]} 14:46:05 INFO - https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:46:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:46:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:46:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:06 INFO - Downloaded 24526305 bytes. 14:46:06 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'] 14:46:06 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 14:46:08 INFO - Return code: 0 14:46:08 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 14:46:08 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')]} 14:46:08 INFO - https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:46:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:46:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:46:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:09 INFO - Downloaded 24526305 bytes. 14:46:09 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'] 14:46:09 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 14:46:12 INFO - Return code: 0 14:46: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')]} 14:46:12 INFO - https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:46:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:46:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:46:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:14 INFO - Downloaded 10833369 bytes. 14:46:14 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'] 14:46:14 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 14:46:14 INFO - Return code: 0 14:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:14 INFO - https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:46:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/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 14:46:15 INFO - Downloaded 63647956 bytes. 14:46:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:46:15 INFO - mkdir: /builds/slave/test/properties 14:46:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:46:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:46:15 INFO - Contents: 14:46:15 INFO - build_url:https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:46:16 INFO - Running post-action listener: _resource_record_post_action 14:46:16 INFO - Running post-action listener: set_extra_try_arguments 14:46:16 INFO - ##### 14:46:16 INFO - ##### Finished download-and-extract step (success) 14:46:16 INFO - ##### 14:46:16 INFO - ##### 14:46:16 INFO - ##### Running populate-webroot step. 14:46:16 INFO - ##### 14:46:16 INFO - Running pre-action listener: _resource_record_pre_action 14:46:16 INFO - Running main action method: populate_webroot 14:46:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:46:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:46:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:46:16 INFO - '--tppagecycles', 14:46:16 INFO - '7'], 14:46:16 INFO - 'tests': ['tsvgm']}}, 14:46:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:46:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:46:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:46:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:46:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:46:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:46:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['damp', 'tps']}, 14:46:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'tests': ['damp', 'tps']}, 14:46:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['dromaeo_dom']}, 14:46:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:46:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['a11yr', 14:46:16 INFO - 'ts_paint', 14:46:16 INFO - 'tpaint', 14:46:16 INFO - 'sessionrestore', 14:46:16 INFO - 'sessionrestore_no_auto_restore', 14:46:16 INFO - 'tabpaint']}, 14:46:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:46:16 INFO - 'ts_paint', 14:46:16 INFO - 'tpaint', 14:46:16 INFO - 'sessionrestore', 14:46:16 INFO - 'sessionrestore_no_auto_restore', 14:46:16 INFO - 'tabpaint']}, 14:46:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:46:16 INFO - 'ts_paint', 14:46:16 INFO - 'tpaint', 14:46:16 INFO - 'sessionrestore', 14:46:16 INFO - 'sessionrestore_no_auto_restore', 14:46:16 INFO - 'tabpaint']}, 14:46:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:46:16 INFO - 'ts_paint', 14:46:16 INFO - 'tpaint', 14:46:16 INFO - 'sessionrestore', 14:46:16 INFO - 'sessionrestore_no_auto_restore', 14:46:16 INFO - 'tabpaint']}, 14:46:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['a11yr', 14:46:16 INFO - 'ts_paint', 14:46:16 INFO - 'tpaint', 14:46:16 INFO - 'sessionrestore', 14:46:16 INFO - 'sessionrestore_no_auto_restore', 14:46:16 INFO - 'tabpaint']}, 14:46:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['a11yr', 14:46:16 INFO - 'ts_paint', 14:46:16 INFO - 'tpaint', 14:46:16 INFO - 'sessionrestore', 14:46:16 INFO - 'sessionrestore_no_auto_restore', 14:46:16 INFO - 'tabpaint']}, 14:46:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['tsvgx', 14:46:16 INFO - 'tsvgr_opacity', 14:46:16 INFO - 'tart', 14:46:16 INFO - 'tscrollx', 14:46:16 INFO - 'cart']}, 14:46:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:46:16 INFO - 'tsvgr_opacity', 14:46:16 INFO - 'tart', 14:46:16 INFO - 'tscrollx', 14:46:16 INFO - 'cart']}, 14:46:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'talos_options': ['--disable-e10s'], 14:46:16 INFO - 'tests': ['tp5o']}, 14:46:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'tests': ['tp5o']}, 14:46:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'talos_options': ['--disable-e10s', 14:46:16 INFO - '--xperf_path', 14:46:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:46:16 INFO - 'tests': ['tp5n']}, 14:46:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:16 INFO - 'talos_options': ['--xperf_path', 14:46:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:46:16 INFO - 'tests': ['tp5n']}}, 14:46:16 INFO - 'talos.zip': {'path': '', 14:46:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:46:16 INFO - Running post-action listener: _resource_record_post_action 14:46:16 INFO - ##### 14:46:16 INFO - ##### Finished populate-webroot step (success) 14:46:16 INFO - ##### 14:46:16 INFO - ##### 14:46:16 INFO - ##### Running create-virtualenv step. 14:46:16 INFO - ##### 14:46:16 INFO - Running pre-action listener: _resource_record_pre_action 14:46:16 INFO - Running main action method: create_virtualenv 14:46:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:46: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 14:46:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:46:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:46:16 INFO - Using real prefix '/usr' 14:46:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:46:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:46:19 INFO - Installing pip.................done. 14:46:19 INFO - Return code: 0 14:46:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:46: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')]} 14:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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')]} 14:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46: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 14:46: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 14:46:19 INFO - Using env: {'DISPLAY': ':0', 14:46:19 INFO - 'HOME': '/home/cltbld', 14:46:19 INFO - 'LANG': 'en_US.UTF-8', 14:46:19 INFO - 'LANGUAGE': 'en_US:en', 14:46:19 INFO - 'LOGNAME': 'cltbld', 14:46:19 INFO - 'MAIL': '/var/mail/cltbld', 14:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:19 INFO - 'MOZ_NO_REMOTE': '1', 14:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:19 INFO - 'NO_EM_RESTART': '1', 14:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:19 INFO - 'PWD': '/builds/slave/test', 14:46:19 INFO - 'SHELL': '/bin/bash', 14:46:19 INFO - 'SHLVL': '1', 14:46:19 INFO - 'TERM': 'linux', 14:46:19 INFO - 'TMOUT': '86400', 14:46:19 INFO - 'USER': 'cltbld', 14:46:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:19 INFO - '_': '/tools/buildbot/bin/python'} 14:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46: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 14:46:19 INFO - Cleaning up... 14:46:19 INFO - Return code: 0 14:46:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:46: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')]} 14:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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')]} 14:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46: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 14:46: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 14:46:19 INFO - Using env: {'DISPLAY': ':0', 14:46:19 INFO - 'HOME': '/home/cltbld', 14:46:19 INFO - 'LANG': 'en_US.UTF-8', 14:46:19 INFO - 'LANGUAGE': 'en_US:en', 14:46:19 INFO - 'LOGNAME': 'cltbld', 14:46:19 INFO - 'MAIL': '/var/mail/cltbld', 14:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:19 INFO - 'MOZ_NO_REMOTE': '1', 14:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:19 INFO - 'NO_EM_RESTART': '1', 14:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:19 INFO - 'PWD': '/builds/slave/test', 14:46:19 INFO - 'SHELL': '/bin/bash', 14:46:19 INFO - 'SHLVL': '1', 14:46:19 INFO - 'TERM': 'linux', 14:46:19 INFO - 'TMOUT': '86400', 14:46:19 INFO - 'USER': 'cltbld', 14:46:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:19 INFO - '_': '/tools/buildbot/bin/python'} 14:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:20 INFO - Downloading/unpacking psutil>=3.1.1 14:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:46:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:46:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:46:22 INFO - Installing collected packages: psutil 14:46:22 INFO - Running setup.py install for psutil 14:46:22 INFO - building 'psutil._psutil_linux' extension 14:46:22 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 14:46:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:46:23 INFO - building 'psutil._psutil_posix' extension 14:46:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:46:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:46:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:46:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:46:23 INFO - Successfully installed psutil 14:46:23 INFO - Cleaning up... 14:46:24 INFO - Return code: 0 14:46:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:24 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 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46:24 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 14:46:24 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 14:46:24 INFO - Using env: {'DISPLAY': ':0', 14:46:24 INFO - 'HOME': '/home/cltbld', 14:46:24 INFO - 'LANG': 'en_US.UTF-8', 14:46:24 INFO - 'LANGUAGE': 'en_US:en', 14:46:24 INFO - 'LOGNAME': 'cltbld', 14:46:24 INFO - 'MAIL': '/var/mail/cltbld', 14:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:24 INFO - 'MOZ_NO_REMOTE': '1', 14:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:24 INFO - 'NO_EM_RESTART': '1', 14:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:24 INFO - 'PWD': '/builds/slave/test', 14:46:24 INFO - 'SHELL': '/bin/bash', 14:46:24 INFO - 'SHLVL': '1', 14:46:24 INFO - 'TERM': 'linux', 14:46:24 INFO - 'TMOUT': '86400', 14:46:24 INFO - 'USER': 'cltbld', 14:46:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:24 INFO - '_': '/tools/buildbot/bin/python'} 14:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:46:26 INFO - Installing collected packages: mozsystemmonitor 14:46:26 INFO - Running setup.py install for mozsystemmonitor 14:46:26 INFO - Successfully installed mozsystemmonitor 14:46:26 INFO - Cleaning up... 14:46:26 INFO - Return code: 0 14:46:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:46: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')]} 14:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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')]} 14:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46: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 14:46: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 14:46:26 INFO - Using env: {'DISPLAY': ':0', 14:46:26 INFO - 'HOME': '/home/cltbld', 14:46:26 INFO - 'LANG': 'en_US.UTF-8', 14:46:26 INFO - 'LANGUAGE': 'en_US:en', 14:46:26 INFO - 'LOGNAME': 'cltbld', 14:46:26 INFO - 'MAIL': '/var/mail/cltbld', 14:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:26 INFO - 'MOZ_NO_REMOTE': '1', 14:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:26 INFO - 'NO_EM_RESTART': '1', 14:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:26 INFO - 'PWD': '/builds/slave/test', 14:46:26 INFO - 'SHELL': '/bin/bash', 14:46:26 INFO - 'SHLVL': '1', 14:46:26 INFO - 'TERM': 'linux', 14:46:26 INFO - 'TMOUT': '86400', 14:46:26 INFO - 'USER': 'cltbld', 14:46:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:26 INFO - '_': '/tools/buildbot/bin/python'} 14:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:26 INFO - Downloading/unpacking jsonschema==2.5.1 14:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:46:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:46:28 INFO - warning: no files found matching '*.txt' 14:46:28 INFO - no previously-included directories found matching 'build' 14:46:28 INFO - no previously-included directories found matching 'dist' 14:46:28 INFO - no previously-included directories found matching '.git*' 14:46:28 INFO - Installing collected packages: jsonschema, functools32 14:46:28 INFO - Running setup.py install for functools32 14:46:28 INFO - warning: no files found matching '*.txt' 14:46:28 INFO - no previously-included directories found matching 'build' 14:46:28 INFO - no previously-included directories found matching 'dist' 14:46:28 INFO - no previously-included directories found matching '.git*' 14:46:28 INFO - Successfully installed jsonschema functools32 14:46:28 INFO - Cleaning up... 14:46:28 INFO - Return code: 0 14:46:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:46:28 INFO - Using env: {'DISPLAY': ':0', 14:46:28 INFO - 'HOME': '/home/cltbld', 14:46:28 INFO - 'LANG': 'en_US.UTF-8', 14:46:28 INFO - 'LANGUAGE': 'en_US:en', 14:46:28 INFO - 'LOGNAME': 'cltbld', 14:46:28 INFO - 'MAIL': '/var/mail/cltbld', 14:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:28 INFO - 'MOZ_NO_REMOTE': '1', 14:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:28 INFO - 'NO_EM_RESTART': '1', 14:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:28 INFO - 'PWD': '/builds/slave/test', 14:46:28 INFO - 'SHELL': '/bin/bash', 14:46:28 INFO - 'SHLVL': '1', 14:46:28 INFO - 'TERM': 'linux', 14:46:28 INFO - 'TMOUT': '86400', 14:46:28 INFO - 'USER': 'cltbld', 14:46:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:28 INFO - '_': '/tools/buildbot/bin/python'} 14:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:46:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:46:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46:31 INFO - Downloading docopt-0.6.1.tar.gz 14:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:46:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:46:31 INFO - Running setup.py install for blobuploader 14:46:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:46:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:46:31 INFO - Running setup.py install for requests 14:46:32 INFO - Running setup.py install for docopt 14:46:32 INFO - Successfully installed blobuploader requests docopt 14:46:32 INFO - Cleaning up... 14:46:32 INFO - Return code: 0 14:46:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46:32 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')]} 14:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:32 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')]} 14:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:32 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 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46:32 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 14:46:32 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 14:46:32 INFO - Using env: {'DISPLAY': ':0', 14:46:32 INFO - 'HOME': '/home/cltbld', 14:46:32 INFO - 'LANG': 'en_US.UTF-8', 14:46:32 INFO - 'LANGUAGE': 'en_US:en', 14:46:32 INFO - 'LOGNAME': 'cltbld', 14:46:32 INFO - 'MAIL': '/var/mail/cltbld', 14:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:32 INFO - 'MOZ_NO_REMOTE': '1', 14:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:32 INFO - 'NO_EM_RESTART': '1', 14:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:32 INFO - 'PWD': '/builds/slave/test', 14:46:32 INFO - 'SHELL': '/bin/bash', 14:46:32 INFO - 'SHLVL': '1', 14:46:32 INFO - 'TERM': 'linux', 14:46:32 INFO - 'TMOUT': '86400', 14:46:32 INFO - 'USER': 'cltbld', 14:46:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:32 INFO - '_': '/tools/buildbot/bin/python'} 14:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:46:32 INFO - Running setup.py (path:/tmp/pip-bCupYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:46:32 INFO - Running setup.py (path:/tmp/pip-_rjKb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:46:32 INFO - Running setup.py (path:/tmp/pip-E26Sqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:46:32 INFO - Running setup.py (path:/tmp/pip-rf9LIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:46:32 INFO - Running setup.py (path:/tmp/pip-kKt0gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:46:32 INFO - Running setup.py (path:/tmp/pip-8CxKlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:46:33 INFO - Running setup.py (path:/tmp/pip-J7aewh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:46:33 INFO - Running setup.py (path:/tmp/pip-Iiy0bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:46:33 INFO - Running setup.py (path:/tmp/pip-pedSf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:46:33 INFO - Running setup.py (path:/tmp/pip-1rTtIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:46:33 INFO - Running setup.py (path:/tmp/pip-3Yk5Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:46:33 INFO - Running setup.py (path:/tmp/pip-0lMZAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:46:33 INFO - Running setup.py (path:/tmp/pip-aV4fVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:46:33 INFO - Running setup.py (path:/tmp/pip-XiDB8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:33 INFO - Running setup.py (path:/tmp/pip-nsc33u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:46:33 INFO - Running setup.py (path:/tmp/pip-yYpYO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:46:33 INFO - Running setup.py (path:/tmp/pip-WgIvkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:46:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:46:33 INFO - Running setup.py install for manifestparser 14:46:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:46:33 INFO - Running setup.py install for mozcrash 14:46:34 INFO - Running setup.py install for mozdebug 14:46:34 INFO - Running setup.py install for mozdevice 14:46:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Running setup.py install for mozfile 14:46:34 INFO - Running setup.py install for mozhttpd 14:46:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Running setup.py install for mozinfo 14:46:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Running setup.py install for mozInstall 14:46:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Running setup.py install for mozleak 14:46:34 INFO - Running setup.py install for mozlog 14:46:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Running setup.py install for moznetwork 14:46:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:46:34 INFO - Running setup.py install for mozprocess 14:46:35 INFO - Running setup.py install for mozprofile 14:46:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:46:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:46:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:46:35 INFO - Running setup.py install for mozrunner 14:46:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:46:35 INFO - Running setup.py install for mozscreenshot 14:46:35 INFO - Running setup.py install for moztest 14:46:35 INFO - Running setup.py install for mozversion 14:46:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:46:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:46:35 INFO - Cleaning up... 14:46:35 INFO - Return code: 0 14:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:46:35 INFO - Using env: {'DISPLAY': ':0', 14:46:35 INFO - 'HOME': '/home/cltbld', 14:46:35 INFO - 'LANG': 'en_US.UTF-8', 14:46:35 INFO - 'LANGUAGE': 'en_US:en', 14:46:35 INFO - 'LOGNAME': 'cltbld', 14:46:35 INFO - 'MAIL': '/var/mail/cltbld', 14:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:35 INFO - 'MOZ_NO_REMOTE': '1', 14:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:35 INFO - 'NO_EM_RESTART': '1', 14:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:35 INFO - 'PWD': '/builds/slave/test', 14:46:35 INFO - 'SHELL': '/bin/bash', 14:46:35 INFO - 'SHLVL': '1', 14:46:35 INFO - 'TERM': 'linux', 14:46:35 INFO - 'TMOUT': '86400', 14:46:35 INFO - 'USER': 'cltbld', 14:46:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:35 INFO - '_': '/tools/buildbot/bin/python'} 14:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:46:35 INFO - Running setup.py (path:/tmp/pip-CrNDWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:46:35 INFO - Running setup.py (path:/tmp/pip-Qp4LJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:46:35 INFO - Running setup.py (path:/tmp/pip-UUEdzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:46: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)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:46:36 INFO - Running setup.py (path:/tmp/pip-UbYKX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:46: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)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:46:36 INFO - Running setup.py (path:/tmp/pip-0UOtAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:46:36 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)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:46:36 INFO - Running setup.py (path:/tmp/pip-KIdG4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:46:36 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)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:46:36 INFO - Running setup.py (path:/tmp/pip-xPy7x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:46:36 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)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:46:36 INFO - Running setup.py (path:/tmp/pip-mfbu78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:46:36 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)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:46:36 INFO - Running setup.py (path:/tmp/pip-i5zTbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:46:36 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)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:46:36 INFO - Running setup.py (path:/tmp/pip-VXNTlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:46:36 INFO - Running setup.py (path:/tmp/pip-3vV9ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:46:36 INFO - Running setup.py (path:/tmp/pip-KhvK1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:46:36 INFO - Running setup.py (path:/tmp/pip-MAjNtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:46:36 INFO - Running setup.py (path:/tmp/pip-I5nbSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:36 INFO - Running setup.py (path:/tmp/pip-L6SeE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:46:36 INFO - Running setup.py (path:/tmp/pip-0iTMqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:46:36 INFO - Running setup.py (path:/tmp/pip-1tZALz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:46: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)) 14:46: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)) 14:46: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)) 14:46: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)) 14:46: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)) 14:46: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)) 14:46:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46:38 INFO - Downloading blessings-1.6.tar.gz 14:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:46:39 INFO - Installing collected packages: blessings 14:46:39 INFO - Running setup.py install for blessings 14:46:39 INFO - Successfully installed blessings 14:46:39 INFO - Cleaning up... 14:46:39 INFO - Return code: 0 14:46:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:46:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:46:39 INFO - Reading from file tmpfile_stdout 14:46:39 INFO - Current package versions: 14:46:39 INFO - argparse == 1.2.1 14:46:39 INFO - blessings == 1.6 14:46:39 INFO - blobuploader == 1.2.4 14:46:39 INFO - docopt == 0.6.1 14:46:39 INFO - functools32 == 3.2.3-2 14:46:39 INFO - jsonschema == 2.5.1 14:46:39 INFO - manifestparser == 1.1 14:46:39 INFO - mozInstall == 1.12 14:46:39 INFO - mozcrash == 0.17 14:46:39 INFO - mozdebug == 0.1 14:46:39 INFO - mozdevice == 0.48 14:46:39 INFO - mozfile == 1.2 14:46:39 INFO - mozhttpd == 0.7 14:46:39 INFO - mozinfo == 0.9 14:46:39 INFO - mozleak == 0.1 14:46:39 INFO - mozlog == 3.2 14:46:39 INFO - moznetwork == 0.27 14:46:39 INFO - mozprocess == 0.22 14:46:39 INFO - mozprofile == 0.28 14:46:39 INFO - mozrunner == 6.11 14:46:39 INFO - mozscreenshot == 0.1 14:46:39 INFO - mozsystemmonitor == 0.3 14:46:39 INFO - moztest == 0.7 14:46:39 INFO - mozversion == 1.4 14:46:39 INFO - psutil == 3.1.1 14:46:39 INFO - requests == 1.2.3 14:46:39 INFO - wsgiref == 0.1.2 14:46:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:39 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 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46:39 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 14:46:39 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 14:46:39 INFO - Using env: {'DISPLAY': ':0', 14:46:39 INFO - 'HOME': '/home/cltbld', 14:46:39 INFO - 'LANG': 'en_US.UTF-8', 14:46:39 INFO - 'LANGUAGE': 'en_US:en', 14:46:39 INFO - 'LOGNAME': 'cltbld', 14:46:39 INFO - 'MAIL': '/var/mail/cltbld', 14:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:39 INFO - 'MOZ_NO_REMOTE': '1', 14:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:39 INFO - 'NO_EM_RESTART': '1', 14:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:39 INFO - 'PWD': '/builds/slave/test', 14:46:39 INFO - 'SHELL': '/bin/bash', 14:46:39 INFO - 'SHLVL': '1', 14:46:39 INFO - 'TERM': 'linux', 14:46:39 INFO - 'TMOUT': '86400', 14:46:39 INFO - 'USER': 'cltbld', 14:46:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:39 INFO - '_': '/tools/buildbot/bin/python'} 14:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:46:39 INFO - Cleaning up... 14:46:39 INFO - Return code: 0 14:46:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:46:39 INFO - Using env: {'DISPLAY': ':0', 14:46:39 INFO - 'HOME': '/home/cltbld', 14:46:39 INFO - 'LANG': 'en_US.UTF-8', 14:46:39 INFO - 'LANGUAGE': 'en_US:en', 14:46:39 INFO - 'LOGNAME': 'cltbld', 14:46:39 INFO - 'MAIL': '/var/mail/cltbld', 14:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:39 INFO - 'MOZ_NO_REMOTE': '1', 14:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:39 INFO - 'NO_EM_RESTART': '1', 14:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:39 INFO - 'PWD': '/builds/slave/test', 14:46:39 INFO - 'SHELL': '/bin/bash', 14:46:39 INFO - 'SHLVL': '1', 14:46:39 INFO - 'TERM': 'linux', 14:46:39 INFO - 'TMOUT': '86400', 14:46:39 INFO - 'USER': 'cltbld', 14:46:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:39 INFO - '_': '/tools/buildbot/bin/python'} 14:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:46:39 INFO - Cleaning up... 14:46:39 INFO - Return code: 0 14:46:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f414e355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', '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 14:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:46:39 INFO - Using env: {'DISPLAY': ':0', 14:46:39 INFO - 'HOME': '/home/cltbld', 14:46:39 INFO - 'LANG': 'en_US.UTF-8', 14:46:39 INFO - 'LANGUAGE': 'en_US:en', 14:46:39 INFO - 'LOGNAME': 'cltbld', 14:46:39 INFO - 'MAIL': '/var/mail/cltbld', 14:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:39 INFO - 'MOZ_NO_REMOTE': '1', 14:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:39 INFO - 'NO_EM_RESTART': '1', 14:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:39 INFO - 'PWD': '/builds/slave/test', 14:46:39 INFO - 'SHELL': '/bin/bash', 14:46:39 INFO - 'SHLVL': '1', 14:46:39 INFO - 'TERM': 'linux', 14:46:39 INFO - 'TMOUT': '86400', 14:46:39 INFO - 'USER': 'cltbld', 14:46:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:39 INFO - '_': '/tools/buildbot/bin/python'} 14:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:40 INFO - Downloading/unpacking flake8 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46: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 14:46:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:46:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:46:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:46:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:46:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:46:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:46:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:46:42 INFO - no previously-included directories found matching 'docs/_build' 14:46:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:46:42 INFO - Running setup.py install for pep8 14:46:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:46:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:46:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:46:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:46:42 INFO - no previously-included directories found matching 'docs/_build' 14:46:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:46:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:46:42 INFO - Cleaning up... 14:46:43 INFO - Return code: 0 14:46:43 INFO - Running post-action listener: _resource_record_post_action 14:46:43 INFO - Running post-action listener: _start_resource_monitoring 14:46:43 INFO - Starting resource monitoring. 14:46:43 INFO - ##### 14:46:43 INFO - ##### Finished create-virtualenv step (success) 14:46:43 INFO - ##### 14:46:43 INFO - ##### 14:46:43 INFO - ##### Running install step. 14:46:43 INFO - ##### 14:46:43 INFO - Running pre-action listener: _resource_record_pre_action 14:46:43 INFO - Running main action method: install 14:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:46:43 INFO - Reading from file tmpfile_stdout 14:46:43 INFO - Detecting whether we're running mozinstall >=1.0... 14:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:46:43 INFO - Reading from file tmpfile_stdout 14:46:43 INFO - Output received: 14:46:43 INFO - Usage: mozinstall [options] installer 14:46:43 INFO - Options: 14:46:43 INFO - -h, --help show this help message and exit 14:46:43 INFO - -d DEST, --destination=DEST 14:46:43 INFO - Directory to install application into. [default: 14:46:43 INFO - "/builds/slave/test"] 14:46:43 INFO - --app=APP Application being installed. [default: firefox] 14:46:43 INFO - mkdir: /builds/slave/test/build/application 14:46:43 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'] 14:46:43 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 14:46:59 INFO - Reading from file tmpfile_stdout 14:46:59 INFO - Output received: 14:46:59 INFO - /builds/slave/test/build/application/firefox/firefox 14:46:59 INFO - Running post-action listener: _resource_record_post_action 14:46:59 INFO - ##### 14:46:59 INFO - ##### Finished install step (success) 14:46:59 INFO - ##### 14:46:59 INFO - ##### 14:46:59 INFO - ##### Running run-tests step. 14:46:59 INFO - ##### 14:46:59 INFO - Running pre-action listener: _resource_record_pre_action 14:46:59 INFO - Running main action method: run_tests 14:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:46:59 INFO - Python 2.7.3 14:46:59 INFO - Return code: 0 14:46:59 INFO - grabbing minidump binary from tooltool 14:46:59 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')]} 14:46:59 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 0x1bf72c0>, '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 0x1bf81c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:46:59 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 14:46:59 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 14:46:59 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 14:46:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:46:59 INFO - Return code: 0 14:46:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:46:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:46:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:46:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:46:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:47:00 INFO - Return code: 0 14:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:47:00 INFO - Using env: {'DISPLAY': ':0', 14:47:00 INFO - 'HOME': '/home/cltbld', 14:47:00 INFO - 'LANG': 'en_US.UTF-8', 14:47:00 INFO - 'LANGUAGE': 'en_US:en', 14:47:00 INFO - 'LOGNAME': 'cltbld', 14:47:00 INFO - 'MAIL': '/var/mail/cltbld', 14:47:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:47:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:00 INFO - 'MOZ_NO_REMOTE': '1', 14:47:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:00 INFO - 'NO_EM_RESTART': '1', 14:47:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:00 INFO - 'PWD': '/builds/slave/test', 14:47:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:47:00 INFO - 'SHELL': '/bin/bash', 14:47:00 INFO - 'SHLVL': '1', 14:47:00 INFO - 'TERM': 'linux', 14:47:00 INFO - 'TMOUT': '86400', 14:47:00 INFO - 'USER': 'cltbld', 14:47:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545', 14:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:00 INFO - '_': '/tools/buildbot/bin/python'} 14:47:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:47:00 INFO - mozversion application_buildid: 20160703120721 14:47:00 INFO - mozversion application_changeset: 98359ff36d9781257d297f4eeada5bbc99481015 14:47:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:47:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:47:00 INFO - mozversion application_name: Firefox 14:47:00 INFO - mozversion application_remotingname: firefox-dev 14:47:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:47:00 INFO - mozversion application_vendor: Mozilla 14:47:00 INFO - mozversion application_version: 49.0a2 14:47:00 INFO - mozversion platform_buildid: 20160703120721 14:47:00 INFO - mozversion platform_changeset: 98359ff36d9781257d297f4eeada5bbc99481015 14:47:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:47:00 INFO - mozversion platform_version: 49.0a2 14:47:00 INFO - using testdate: 1467582420 14:47:00 INFO - actual date: 1467582420 14:47:00 INFO - starting webserver on 'localhost:45414' 14:47:00 INFO - SUITE-START | Running 2 tests 14:47:00 INFO - TEST-START | dromaeo_css 14:47:00 INFO - operating with platform_type : linux_ 14:47:00 INFO - Initialising browser for dromaeo_css test... 14:47:00 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXdUpA/profile http://localhost:45414/getInfo.html) 14:47:06 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 14:47:06 INFO - PROCESS | 3340 | colorDepth:24 14:47:06 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 14:47:06 INFO - PROCESS | 3340 | __metrics 14:47:07 ERROR - PROCESS | 3340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:47:08 INFO - TEST-INFO | 3340: exit 0 14:47:08 INFO - Browser initialized. 14:47:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:47:08 INFO - TEST-INFO | started process 3470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXdUpA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:20 INFO - PROCESS | 3470 | RSS: Main: 156082176 14:47:20 INFO - PROCESS | 3470 | 14:48:09 INFO - PROCESS | 3470 | 1467582489614 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] 14:50:17 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:45414/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45414/tests/dromaeo/cssquery-ext.html) 14:50:18 INFO - PROCESS | 3470 | RSS: Main: 159215616 14:50:18 INFO - PROCESS | 3470 | 14:53:20 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:45414/tests/dromaeo/cssquery-ext.html (next: http://localhost:45414/tests/dromaeo/cssquery-jquery.html) 14:53:21 INFO - PROCESS | 3470 | RSS: Main: 157437952 14:53:21 INFO - PROCESS | 3470 | 14:56:23 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:45414/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45414/tests/dromaeo/cssquery-mootools.html) 14:56:23 INFO - PROCESS | 3470 | RSS: Main: 156921856 14:56:23 INFO - PROCESS | 3470 | 14:59:25 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:45414/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45414/tests/dromaeo/cssquery-prototype.html) 14:59:26 INFO - PROCESS | 3470 | RSS: Main: 156712960 14:59:26 INFO - PROCESS | 3470 | 15:02:28 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:45414/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45414/tests/dromaeo/cssquery-yui.html) 15:02:29 INFO - PROCESS | 3470 | RSS: Main: 159031296 15:02:29 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:45414/tests/dromaeo/cssquery-yui.html (next: http://localhost:45414/tests/dromaeo/cssquery-dojo.html) 15:05:31 INFO - PROCESS | 3470 | RSS: Main: 159531008 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | __start_tp_report 15:05:31 INFO - PROCESS | 3470 | _x_x_mozilla_page_load 15:05:31 INFO - PROCESS | 3470 | _x_x_mozilla_page_load_details 15:05:31 INFO - PROCESS | 3470 | |i|pagename|runs| 15:05:31 INFO - PROCESS | 3470 | |0;dojo.html;3366.057503898908;3413.4367829308158;3415.1803567143893;3442.0706409269496;3450.240946991661;5654.095344744842;5662.263905692259;5672.631278966865;5696.629719068258;5745.971270143654;5714.371419143901;5724.084146536555;5753.338366087901;5776.59563830532;5790.392008839074;5165.225216217569;5176.145935920568;5276.34045744282;5291.656042357254;5301.787928482856;5113.667611605234;5121.078205922932;5309.920351194735;5320;5336.9733151334185;5257.23770053342;5258.342707161605;5263.236830659552;5280.683159010472;5290.074237008527;5282.102042652739;5341.145416733343;5354.946450535484;5356.464353564613;5357.357117145967;5092;5189.481051894818;5247.107991641392;5315.415304316522;5317.9202311965355;5423.29497165366;5475.986942415666;5506.669599823983;5584.776608935637;5607.327120745536;6019.699015049274;6029.969850150765;6051.757929682807;6104.023356262976;6135.2024236849375;5977.462028417463;6040.939590604125;6158.261008678987;6160.722767475474;6182.103594978747;5707.086866101404;5759.827205183851;5816.331121920991;5830.591858569902;5852;6324.3043265240785;6334.556581039283;6337.873242535124;6339;6344.524160687967;5869.530437564985;5984.192134061933;6006.339302676702;6108.664023478663;6112.816615501542;6158.568900176944;6166;6177.876442471125;6187.195664563578;6195.938040619626;6121.724522396503;6146.108814221912;6151.9384806151365;6164.969175154096;6166.7224974876235;6003.039513677791;6075.301340345828;6104.694765261719;6139.263288405331;6174.073888916699;4652.302154676758;4654.208784506642;4665.790039448233;4677.251639737626;4685.789139488731;4169.249535083653;4180.6446452051305;4186.644135248538;4192.832286708558;4209.810558524874;5804.535637149018;5837.649741015468;5915.674637894871;5940;5981.880362392728;6076;6143.911070236141;6146.200993870768;6169.475594574512;6225.844353891189;5775.537956963432;5929;5937.614055086406;5938.673372964528;5968.895754285384;5104.9489505104475;5140.049090918192;5180.507851754077;5196.32447781786;5198.792048318101;6352.396522330371;6370.617762934146;6394.424501794861;6406.199225096863;6420.486361091102;6129.908988904127;6135.601185922901;6229.7508099676415;6235.251769787655;6248.781292654735;6318.494520438262;6442.645654489048;6452.709628066655;6459.095726598186;6462.321456247214;6111.419415155553;6114.052321889936;6129.724162412613;6144.109104179958;6147.262328520606;5976.701164941823;6143.047827586731;6193.287771906288;6208.50331973432;6236;5988.311344195473;6054.152418661479;6089.817305480843;6097.390260973867;6102.847428814315;5935.732892019783;5988.131720900532;6067.878642427215;6073.787417440369;6091.390860914051;5777.364489906191;5847.181394604844;5867.266591676041;5895.587308888508;5915.231019967377;6058.303295121117;6068.544859135494;6068.787592434243;6093.390660933871;6095.024796032613;5921.3190483094995;5932.733027013708;5941.881162376815;5947.791827286024;5948.256467941507 15:05:31 INFO - PROCESS | 3470 | |1;ext.html;597.2057163971917;620.8603064310533;627.2285089340112;642.48922106925;642.585532331646;44941.325880111784;45790.3131453028;46200.53799462004;46208;50115.24827127596;48129.278060829114;48951;49011.50988490114;49124.508754912444;49216;9032.593533290985;9181.357304988653;9199.862002069975;9236.815263694722;9270.860937085949;9021.639134434614;9097.363184577081;9139.086091390875;9139.72580822573;9145.314101442418;9138.406003609778;9178.449293042406;9189.08109189079;9206.401583897059;9245.16793488586;9079.137481939239;9090.363674542785;9118.772030699252;9136.58885350161;9151.67969121081;9080.364374493787;9179.311551633587;9199.218066464358;9202.171804537556;9220.262379009662;44516.3322550162;44524.554754452685;44957.55042449599;45010.32484512735;45100.54899451029;3909.9413508797393;3971.801409929521;4041.878743637666;4083.530394004698;4605.125026245003;34076.48885266723;34305.31389372223;34430.82784586086;34542;35631;4640.767961601907;4678.7426691531955;4722.291656251556;4736.052789442126;4750.216214324632;361578;363002;363103;363933;364338;60891.39108608946;60961;61543.6922815392;61550;61728.69135654293;38555.42166867499;39362.80318598446;39802.40296395557;42275.57724422778;65134.674326629014;16773.58066048334;16878.409255675993;16919;16996.745048824276;17066.829331706773;13572.524961626295;13653.590392288248;13698.38357273925;13750.793738093937;13807.51673691416;20511;20599.794002060087;20703.27538536174;20800.687989680166;20833;7559.1684914659345;7646;7690.961545192238;7752.651130699132;7774.378049756119;1078.5308390850005;1085.4898197846999;1133.580575187186;1182.2374568403332;1211.7939950208486;32575.837120814245;32965;33070.17324566857;33519.66480335214;34292.48561271583;1167.772284404533;1174.307158776326;1181.911356648255;1205.1021988618536;1266.5820279307807;17427.588857443843;17430.65138697219;17676.204570794343;17700.29198832058;17840.821591783915;620242;624425;657543;1005226;1024730;60147;60864.39135608676;60910.69544652337;61102.69448652728;61124.388756112756;1515.1893736850732;1527.694461107783;1533.7852700621922;1549.6280892585698;1567.8275389707123;30921.381572368875;31915;32011.679883200868;32081.839590801897;32828.67171328256;52277;52832;52878.471215287354;52971;53134.202986956;393920;398754;398823;400531;401987;30159;30240.607935387114;30251.697483024887;30350.696493034786;30548;49449.75275123601;49519;49594.25608615801;50354.748226258635;50906.745466272434;41020.384694230204;41040;41461.378079329435;41845;42636.78681606572;41266.58733412628;41411;41734.373984389655;42332;42565.93585160396;40987.7950610245;41539.37690934699;41709.58290417178;42080.57919420767;42484.5751542493;36033.639663603026;36249;36363;36822.63177368192;37248.62751372452;28250.2937426566;28606.713932860406;28640.713592863805;28761.637901054142;29091.7090829089 15:05:31 INFO - PROCESS | 3470 | |2;jquery.html;429.41385009462095;429.44241433313306;435.48177668574397;438.86833949815065;444.16718652526515;18358.816411835876;19705.704414433778;20196.69704954425;21150.153993840227;21155.365339039854;17197.22612482438;18593.81406185938;19463.124159412826;19544.120514576844;20020.0990955407;5206.531412172903;5341.252224688546;5362.892742145154;5363.222332761767;5373.516383525482;5248.895022099556;5333.253344531769;5361.115415956362;5372.677639341632;5394.352677678684;5696.715164241792;5756.136579513086;5762.423757624246;5781.306243250816;5793.797217097403;5615.634983726045;5983.341832398432;5992.2809262888295;6008.309044459899;6009.729562169669;5554;5783.971080144573;5819.156222347779;5833.970830145865;5837.532997360201;13860;14336.856631433657;14386.92806535971;14527.418903243857;14558.199299038548;2237.6196046672103;2370.3837002379505;2458.188797696756;2488.340589743719;2537.6827896512937;10130.037646423578;10606.628767993083;13701.588952331445;15020.324085416183;15408.537743867702;1952.3264473756674;1993.9700904486444;2056.609244243589;2084.1038353507984;2148.3232781673723;82469.17530824675;83044;83067.5846620769;83368.58315708443;87105;11781.469833857496;11793;11915.106367022508;11916.285022898654;11977.880221197851;16447.588810279838;16499.422520211974;16534.173291335625;16575.502734917973;16754.58113547171;8908.777280567909;8949.463032218087;8981.865272020925;9122.224610908015;9293.72118836436;8821.779455513664;9007.954960225157;9013.774655633662;9037.593308301142;9125.908740912639;4925.2119660854805;4964.379452568429;4978.452370239271;5093.363329583802;5123.077845987758;1993.9501512462014;2070.9378718638463;2088.9268875589282;2090.623687736222;2156.784321567831;934.3879758758025;982.5431174503747;998.3610489286863;1042.8227201375785;1046.4924511611862;18839.529011774543;19277.22891084341;19682.606347872963;19756.209751609775;19927.60144797125;1041.5677493840124;1066.6906597086913;1071.9410432426134;1113.1206346985791;1116.8715597706205;10727.409992450333;10747.193960452998;11463.885361146282;11832.467538960595;11967.940160299142;567231;569298;574802;584134;587872;95042;100053;101267.49366253121;103052;103338;1140.372794962767;1162.7500087481233;1168.67861338131;1173.9236949598248;1190.892819646236;16636.83363166353;16806.159692015593;16855.578610534343;17217.82782172162;17228.569285767957;43857.34213986857;44258.77870610626;44611.553884460736;45022.099558009315;45338.319925200485;62156.37843621506;62473.37526624675;62523.6873815628;64021;64142.35857641364;5747.4252574742195;8619.784505387415;8877.469921072463;8907.242884354902;9051.502167380857;11655.358955257543;13671.79492307636;13816.723665526833;13847.930760346537;13953.651158721113;5814.168352186249;9388.732521109563;11624.883751162719;11850.348230847041;12027.398630068637;11764.470598823245;11813.114016448973;11887.465064071965;12102.334371609293;12127.575534856238;12221.816672749737;12329.938350308192;12416.875831241572;12444.502219911103;12498.500059997861;8711.607977641148;8796.868046979429;9039.367244292836;9109.681161159328;9126.13301736334;10445.529951152064;11949.880501194877;12181.512739490321;12196.146269761031;12334.75330493367 15:05:31 INFO - PROCESS | 3470 | |3;mootools.html;1561.4144695739094;1561.4378823623495;1780.9821901780979;1917.5397904502925;1928.729977803107;9218.262538996882;9560.61757529698;9811.018898110195;9817.705468835928;9834.459104749236;9745.707628771148;9870.851937220947;9876.802463950717;9906.058924402188;9979.750506237348;2485.6768620079365;2505.3110394641526;2516.735742747013;2523.8864251108744;2525.684289463817;2461.249318957717;2496.8127390445698;2514.8365356251875;2516.811239157061;2519.8866051027658;2482.751724827521;2519.244226731982;2529.190658989124;2530.8228424010326;2531.1267612673596;2391.1391898916377;2401.0995876546294;2404.2546810488716;2449.106076282162;2456.238566044514;2347.3192774095664;2350.8001819845335;2382.1900553811615;2391.234804862445;2428.9434096168225;9642.517874106266;9650.95174524123;9691.563879625433;9772.12050915421;9812.558434870449;5729.1119876419225;5842.883142337129;5885.852853678693;5901.911471327933;5903;3560.501529785832;3694.8706795262037;3702.0929872181487;3715.758475699071;3764.8117594120185;1258.6161220827644;1284.5311461316553;1301.3818436242805;2280.771922807706;2350.776676215774;13096.738065238642;13109.147905386119;13119.47522099115;13210.075294729373;13223.272720000396;4778.629730398219;4779.450363208206;4870.342503761947;4888.828890988798;4907.87730306738;10289.382637041801;10385.896141038493;10445.738856528647;10457.790844183226;10507.737306567396;5445.618806683573;5465.180222966507;5529.972350138304;5532.889342213214;5546.057170280981;4667.6732628716345;5192.662476938987;5219.42586315505;5274.340707411574;5285.445028272053;4051.736637118578;4076.8873800160736;4093.9181216375505;4117.794110294473;4173.603507666767;1212.7695737809788;1255.209218192533;1268.1630124118037;1275.9681007974875;1286.9613911582667;919.8620206969008;954.6754103604808;965.3821554205314;972.9610815567439;997.6308765756717;5932.49573786233;6102.511799056154;6127.693615319216;6133.969330153321;6183.505319574423;479.37441638661187;481.1699817814312;485.04930336540775;1045.278757657214;1060.3849767135043;3559.1635965548076;3589.6051434342203;3600.3519366513756;3650.963490365062;3662.432322989941;11669.474873630706;11870.169088163919;11972.64082077539;11990.520379184734;12021.218620789621;11726.70683232909;11795.174337796272;11906.523739050514;11909;11926.284422934652;8526.87209691855;8741;8855.51294678786;8890.955545222361;8919.06349833271;5610.186522954067;5756.712164391847;5767.221425107557;5868.67722275279;5878.853028674317;10797.406142662228;10926.890731092588;10938.398388088413;10980.286281391684;10999.120070394189;10868.61959831402;11083.057940075183;11270.154738394489;11380.203385763249;11382.829257560978;6881.690323935535;7366.96316518414;7625.046869141357;7706.422018348534;7763.72826951054;9200.21798147165;9284.58219380143;9284.675036373694;9362.719118426457;9421.152096311365;8015.238552337519;8168.264856162974;8300.335973122015;8330.083690793886;8375.20435558621;7998.800029999296;8123.431359804993;8178.9591052046735;8193.83612327762;8234.629441675259;6913.51605387618;7105.964470177616;7127.216006239206;7128.536645118051;7257.637118144177;5119.616028797929;5134;5157.432682405008;5194.8961020780125;5242.816501422584;5322.121849894724;5382.784688612412;5401.459854014567;5406.324209473816;5420.620556561003 15:05:31 INFO - PROCESS | 3470 | |4;prototype.html;345.5663142755841;357.1286062008698;357.5834153211509;362.87480819117394;363.1937099638803;5629.958457685321;5652.269502128596;5809.651420914743;5886.617369870961;5918.260217472816;5713.285839270091;5736.741846616902;5738.56960727946;5742.2247996520455;5764.855878603026;4540.250858608326;4575.222212223914;4581.5647513486165;4589.885252868671;4593.816247350102;4504.256797628387;4511.954880451202;4537.137943790685;4584.816607335702;4586.954130458703;4445.222086134913;4480.865574032768;4491.461024677027;4496.303073023671;4502.549745025504;4497.64018878489;4518.638508919278;4530.074718244766;4541.977290113528;4543.954560454386;3911.5663202781643;3981.601839816024;3982.38273067675;4036.4752582164133;4052.5947405259535;5461.726913654302;5483.259759932398;5503.559715222813;5529.474699903543;5563.276774019392;5139.15203991341;5142.665726727788;5143.382794064699;5149.888545696246;5190.818321358772;5833.766649334021;5929.73316200772;5975.073863551156;5983.311919129313;6051.636901785907;4385.934210986838;4419.315006174048;4431.889202769924;4435.735815292626;4457.465104187486;6147.538934579924;6240.375962403768;6274.803818663431;6280.15217945576;6314.452959025069;4175.874723758292;4398.230309695854;4418.536053714313;4419.513853476115;4420.143539713328;4417.624501917373;4446.466424029137;4451.953790859146;4466.173757854807;4483.955160448354;5074.5686616637995;5087.931534377748;5111.131107711698;5133.768980395891;5144.356955380577;5911.527077833849;5968.76124954997;6084.817455476343;6125.754969801247;6141.416565426277;1520.8022957015517;1526.83960190254;1536.3240174323262;1542.997051916241;1546.445821948934;963.4075043847984;966.3664621024997;970.815545046439;970.898055704155;995.4723996281982;5220.269162317279;5234.371875374979;5241.659292145999;5255.816046438356;5286.127788914863;5429.267048948421;5495.241522712773;5539.421264939473;5577.358603760538;5629.662220266797;5091.567216786615;5358.303420555303;5359.517643412111;5376.634280916384;5402.486763757437;2914.2714321419644;2972.360942397395;2993.760499160062;3023.7580993520464;3067.2791893904914;5568.582356323292;5757.740901659436;5770.682612456355;5775.480206781326;5811.7214212873105;5585.58108141891;5606.859828504238;5607.504660426152;5615.578831587647;5697.214339954458;5593.664380137205;5702.429757024264;5717.799877004285;5756.654600723886;5780.468175933381;5380.408155103014;5526.364468086061;5593.496585307342;5639.715915054409;5656.773729050792;5357.357117145967;5433.8536278170695;5434.407925303112;5482.8081017165805;5503.651605356553;5655.971720141373;5708.942910570841;5785.727140029187;5791.08894064966;5798.710064496674;3812.8284227209288;4039.8788036358956;4051.351783714709;4084.7133153056693;4104.384342348671;5613.438656134354;5655.604107712421;5666.688332141772;6169.981952977709;6384;6201.751929922752;6206.689665516797;6207.34822843613;6229.3770622937345;6241.344658810759;5972.5520585955355;6003.339632640494;6088.4824789893355;6119.449249567382;6161.691915404302;5932.5550583705535;5945.721669841005;5948.970255148696;6015.578909476295;6071.392860713893;6104.389561044038;6149.692515374124;6151.446369826558;6188.226471691039;6257.2491301044165;5864.560157988253;5997.250343707036;6020.90968635462;6024.0662697282;6072.423119803611 15:05:31 INFO - PROCESS | 3470 | |5;yui.html;783.6865253898442;786.5005721366933;799.0810567846976;810.9918900810998;840.5293035899897;14405.495807646734;14421.92789036056;14440.277986100706;14752.188629625367;15220.543383698492;13706.383212755425;13776.03567750258;13801.585952421417;13803.930980345109;13890.79163812541;726.5640615630632;847.9618417171242;848.3976376772483;870.5690683111868;872.5855218771096;846.7459762071385;852.2372476633441;857.4340934982913;858.0947100808644;859.0164261920098;915.3729695158837;919.5080631861955;920.7559996600872;923.044648788504;924.5192499900048;896.560685264219;902.580300160422;911.6854685133618;912.9315301352392;914.3873604684877;670.7317073170722;673.249327000396;675.560885424478;676.577139287945;676.5906626491001;15896.205189740582;15901.76147357779;15993.360265589363;16035.118068506228;16118.75821862673;15840.340532430911;15949.681006379924;16089.91955040229;16348.264328105144;16461.176941153015;11992.580259690869;12120.030397568173;12331.568395106218;12489.75020499585;13221.471141154343;4081.285774989365;4165.687573432005;4183.1215444756335;4202.894927626803;4222.514410842762;76495.85256221217;77284.22715772827;77394.6130269345;77429.06427339306;77510.22489775087;12446.25322480654;12585.93707031459;12626.684332891751;12677.30274834893;12842.036847236495;23545.882270588536;23596.29211123669;24461.38846528851;24672.753272467406;24772.876135619208;8144.267015968591;8158.632861521246;8288.419810613319;8631.050584435707;8663.176998185163;4981.227909674007;5042.369703787027;5044.218146187347;5063.87340316495;5144.948550514447;3477.200243943907;3593.425051991721;3594.5506811648543;3607.4408466687705;3609.4044482660065;603.8007457539002;616.2420223125491;616.892043892317;624.3631495874183;627.4133685004535;692.1521136607615;719.7480881691366;761.6275302432882;809.1625167951142;851.7572491839796;10832.404217768099;11202.94398528002;11356;11445.427728613537;11741.119416043832;709.836737550356;752.7929819299736;798.7683571764123;815.4780940198278;818.1491249100868;5351.384590772111;5488.53347465462;5498.972505137449;5501.229827824108;5534.723263836792;71207.2879271211;76252;116440;119557.40221298838;122314;104176;104533.47733261285;104721;104881;106378;79462.6026869862;94646.52676736572;96128.51935740277;96574.51712741391;97948.51025744826;10200.591976320864;10271.7432064196;10409.323393979366;10558;10562.471876406302;55011;55443.72278138745;56410;56466;57392.42607573871;78999.21000789918;82728;84254.57872710597;84759;85568.57215713881;12463.626091216915;12695.93652031771;12983.156094853804;13406.798898016343;13516.86483135156;13574.796378054534;13894.930525347712;13917.234552099326;14521.419143234152;14574.489892853699;13544.525941591997;13797.655058623615;13855.237961912191;13876.861231387556;14062.929685351508;13029.209221037623;13040.869591303965;13365.799513007507;13684.794728079285;13787.724245514833;12733.745325093632;12776.61670149897;13140.07733566172;13398.330083495981;13415.530456433979;11421;11441.563351972884;11612.709682258012;11750.412479376168;11810.645680629596;11592.768144637228;11635.53457861676;11805.700123915738;11851.762964740485;12001 15:05:31 INFO - PROCESS | 3470 | __end_tp_report 15:05:31 INFO - PROCESS | 3470 | __start_cc_report 15:05:31 INFO - PROCESS | 3470 | _x_x_mozilla_cycle_collect,327 15:05:31 INFO - PROCESS | 3470 | __end_cc_report 15:05:31 INFO - PROCESS | 3470 | __startTimestamp1467583531814__endTimestamp 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | ------- Summary: start ------- 15:05:31 INFO - PROCESS | 3470 | Number of tests: 6 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | [#0] dojo.html Cycles:165 Average:5717.76 Median:5941.88 stddev:646.63 (10.9%) stddev-sans-first:621.73 15:05:31 INFO - PROCESS | 3470 | Values: 3366.1 3413.4 3415.2 3442.1 3450.2 5654.1 5662.3 5672.6 5696.6 5746.0 5714.4 5724.1 5753.3 5776.6 5790.4 5165.2 5176.1 5276.3 5291.7 5301.8 5113.7 5121.1 5309.9 5320.0 5337.0 5257.2 5258.3 5263.2 5280.7 5290.1 5282.1 5341.1 5354.9 5356.5 5357.4 5092.0 5189.5 5247.1 5315.4 5317.9 5423.3 5476.0 5506.7 5584.8 5607.3 6019.7 6030.0 6051.8 6104.0 6135.2 5977.5 6040.9 6158.3 6160.7 6182.1 5707.1 5759.8 5816.3 5830.6 5852.0 6324.3 6334.6 6337.9 6339.0 6344.5 5869.5 5984.2 6006.3 6108.7 6112.8 6158.6 6166.0 6177.9 6187.2 6195.9 6121.7 6146.1 6151.9 6165.0 6166.7 6003.0 6075.3 6104.7 6139.3 6174.1 4652.3 4654.2 4665.8 4677.3 4685.8 4169.2 4180.6 4186.6 4192.8 4209.8 5804.5 5837.6 5915.7 5940.0 5981.9 6076.0 6143.9 6146.2 6169.5 6225.8 5775.5 5929.0 5937.6 5938.7 5968.9 5104.9 5140.0 5180.5 5196.3 5198.8 6352.4 6370.6 6394.4 6406.2 6420.5 6129.9 6135.6 6229.8 6235.3 6248.8 6318.5 6442.6 6452.7 6459.1 6462.3 6111.4 6114.1 6129.7 6144.1 6147.3 5976.7 6143.0 6193.3 6208.5 6236.0 5988.3 6054.2 6089.8 6097.4 6102.8 5935.7 5988.1 6067.9 6073.8 6091.4 5777.4 5847.2 5867.3 5895.6 5915.2 6058.3 6068.5 6068.8 6093.4 6095.0 5921.3 5932.7 5941.9 5947.8 5948.3 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | [#1] ext.html Cycles:180 Average:67085.00 Median:41624.48 stddev:151092.26 (363.0%) stddev-sans-first:151433.65 15:05:31 INFO - PROCESS | 3470 | Values: 597.2 620.9 627.2 642.5 642.6 44941.3 45790.3 46200.5 46208.0 50115.2 48129.3 48951.0 49011.5 49124.5 49216.0 9032.6 9181.4 9199.9 9236.8 9270.9 9021.6 9097.4 9139.1 9139.7 9145.3 9138.4 9178.4 9189.1 9206.4 9245.2 9079.1 9090.4 9118.8 9136.6 9151.7 9080.4 9179.3 9199.2 9202.2 9220.3 44516.3 44524.6 44957.6 45010.3 45100.5 3909.9 3971.8 4041.9 4083.5 4605.1 34076.5 34305.3 34430.8 34542.0 35631.0 4640.8 4678.7 4722.3 4736.1 4750.2 361578.0 363002.0 363103.0 363933.0 364338.0 60891.4 60961.0 61543.7 61550.0 61728.7 38555.4 39362.8 39802.4 42275.6 65134.7 16773.6 16878.4 16919.0 16996.7 17066.8 13572.5 13653.6 13698.4 13750.8 13807.5 20511.0 20599.8 20703.3 20800.7 20833.0 7559.2 7646.0 7691.0 7752.7 7774.4 1078.5 1085.5 1133.6 1182.2 1211.8 32575.8 32965.0 33070.2 33519.7 34292.5 1167.8 1174.3 1181.9 1205.1 1266.6 17427.6 17430.7 17676.2 17700.3 17840.8 620242.0 624425.0 657543.0 1005226.0 1024730.0 60147.0 60864.4 60910.7 61102.7 61124.4 1515.2 1527.7 1533.8 1549.6 1567.8 30921.4 31915.0 32011.7 32081.8 32828.7 52277.0 52832.0 52878.5 52971.0 53134.2 393920.0 398754.0 398823.0 400531.0 401987.0 30159.0 30240.6 30251.7 30350.7 30548.0 49449.8 49519.0 49594.3 50354.7 50906.7 41020.4 41040.0 41461.4 41845.0 42636.8 41266.6 41411.0 41734.4 42332.0 42565.9 40987.8 41539.4 41709.6 42080.6 42484.6 36033.6 36249.0 36363.0 36822.6 37248.6 28250.3 28606.7 28640.7 28761.6 29091.7 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | [#2] jquery.html Cycles:180 Average:31933.76 Median:21152.76 stddev:94928.76 (448.8%) stddev-sans-first:95165.58 15:05:31 INFO - PROCESS | 3470 | Values: 429.4 429.4 435.5 438.9 444.2 18358.8 19705.7 20196.7 21150.2 21155.4 17197.2 18593.8 19463.1 19544.1 20020.1 5206.5 5341.3 5362.9 5363.2 5373.5 5248.9 5333.3 5361.1 5372.7 5394.4 5696.7 5756.1 5762.4 5781.3 5793.8 5615.6 5983.3 5992.3 6008.3 6009.7 5554.0 5784.0 5819.2 5834.0 5837.5 13860.0 14336.9 14386.9 14527.4 14558.2 2237.6 2370.4 2458.2 2488.3 2537.7 10130.0 10606.6 13701.6 15020.3 15408.5 1952.3 1994.0 2056.6 2084.1 2148.3 82469.2 83044.0 83067.6 83368.6 87105.0 11781.5 11793.0 11915.1 11916.3 11977.9 16447.6 16499.4 16534.2 16575.5 16754.6 8908.8 8949.5 8981.9 9122.2 9293.7 8821.8 9008.0 9013.8 9037.6 9125.9 4925.2 4964.4 4978.5 5093.4 5123.1 1994.0 2070.9 2088.9 2090.6 2156.8 934.4 982.5 998.4 1042.8 1046.5 18839.5 19277.2 19682.6 19756.2 19927.6 1041.6 1066.7 1071.9 1113.1 1116.9 10727.4 10747.2 11463.9 11832.5 11967.9 567231.0 569298.0 574802.0 584134.0 587872.0 95042.0 100053.0 101267.5 103052.0 103338.0 1140.4 1162.8 1168.7 1173.9 1190.9 16636.8 16806.2 16855.6 17217.8 17228.6 43857.3 44258.8 44611.6 45022.1 45338.3 62156.4 62473.4 62523.7 64021.0 64142.4 5747.4 8619.8 8877.5 8907.2 9051.5 11655.4 13671.8 13816.7 13847.9 13953.7 5814.2 9388.7 11624.9 11850.3 12027.4 11764.5 11813.1 11887.5 12102.3 12127.6 12221.8 12329.9 12416.9 12444.5 12498.5 8711.6 8796.9 9039.4 9109.7 9126.1 10445.5 11949.9 12181.5 12196.1 12334.8 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | [#3] mootools.html Cycles:180 Average:6156.04 Median:480.27 stddev:3576.06 (744.6%) stddev-sans-first:3569.42 15:05:31 INFO - PROCESS | 3470 | Values: 1561.4 1561.4 1781.0 1917.5 1928.7 9218.3 9560.6 9811.0 9817.7 9834.5 9745.7 9870.9 9876.8 9906.1 9979.8 2485.7 2505.3 2516.7 2523.9 2525.7 2461.2 2496.8 2514.8 2516.8 2519.9 2482.8 2519.2 2529.2 2530.8 2531.1 2391.1 2401.1 2404.3 2449.1 2456.2 2347.3 2350.8 2382.2 2391.2 2428.9 9642.5 9651.0 9691.6 9772.1 9812.6 5729.1 5842.9 5885.9 5901.9 5903.0 3560.5 3694.9 3702.1 3715.8 3764.8 1258.6 1284.5 1301.4 2280.8 2350.8 13096.7 13109.1 13119.5 13210.1 13223.3 4778.6 4779.5 4870.3 4888.8 4907.9 10289.4 10385.9 10445.7 10457.8 10507.7 5445.6 5465.2 5530.0 5532.9 5546.1 4667.7 5192.7 5219.4 5274.3 5285.4 4051.7 4076.9 4093.9 4117.8 4173.6 1212.8 1255.2 1268.2 1276.0 1287.0 919.9 954.7 965.4 973.0 997.6 5932.5 6102.5 6127.7 6134.0 6183.5 479.4 481.2 485.0 1045.3 1060.4 3559.2 3589.6 3600.4 3651.0 3662.4 11669.5 11870.2 11972.6 11990.5 12021.2 11726.7 11795.2 11906.5 11909.0 11926.3 8526.9 8741.0 8855.5 8891.0 8919.1 5610.2 5756.7 5767.2 5868.7 5878.9 10797.4 10926.9 10938.4 10980.3 10999.1 10868.6 11083.1 11270.2 11380.2 11382.8 6881.7 7367.0 7625.0 7706.4 7763.7 9200.2 9284.6 9284.7 9362.7 9421.2 8015.2 8168.3 8300.3 8330.1 8375.2 7998.8 8123.4 8179.0 8193.8 8234.6 6913.5 7106.0 7127.2 7128.5 7257.6 5119.6 5134.0 5157.4 5194.9 5242.8 5322.1 5382.8 5401.5 5406.3 5420.6 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | [#4] prototype.html Cycles:180 Average:4917.86 Median:5515.01 stddev:1422.06 (25.8%) stddev-sans-first:1384.02 15:05:31 INFO - PROCESS | 3470 | Values: 345.6 357.1 357.6 362.9 363.2 5630.0 5652.3 5809.7 5886.6 5918.3 5713.3 5736.7 5738.6 5742.2 5764.9 4540.3 4575.2 4581.6 4589.9 4593.8 4504.3 4512.0 4537.1 4584.8 4587.0 4445.2 4480.9 4491.5 4496.3 4502.5 4497.6 4518.6 4530.1 4542.0 4544.0 3911.6 3981.6 3982.4 4036.5 4052.6 5461.7 5483.3 5503.6 5529.5 5563.3 5139.2 5142.7 5143.4 5149.9 5190.8 5833.8 5929.7 5975.1 5983.3 6051.6 4385.9 4419.3 4431.9 4435.7 4457.5 6147.5 6240.4 6274.8 6280.2 6314.5 4175.9 4398.2 4418.5 4419.5 4420.1 4417.6 4446.5 4452.0 4466.2 4484.0 5074.6 5087.9 5111.1 5133.8 5144.4 5911.5 5968.8 6084.8 6125.8 6141.4 1520.8 1526.8 1536.3 1543.0 1546.4 963.4 966.4 970.8 970.9 995.5 5220.3 5234.4 5241.7 5255.8 5286.1 5429.3 5495.2 5539.4 5577.4 5629.7 5091.6 5358.3 5359.5 5376.6 5402.5 2914.3 2972.4 2993.8 3023.8 3067.3 5568.6 5757.7 5770.7 5775.5 5811.7 5585.6 5606.9 5607.5 5615.6 5697.2 5593.7 5702.4 5717.8 5756.7 5780.5 5380.4 5526.4 5593.5 5639.7 5656.8 5357.4 5433.9 5434.4 5482.8 5503.7 5656.0 5708.9 5785.7 5791.1 5798.7 3812.8 4039.9 4051.4 4084.7 4104.4 5613.4 5655.6 5666.7 6170.0 6384.0 6201.8 6206.7 6207.3 6229.4 6241.3 5972.6 6003.3 6088.5 6119.4 6161.7 5932.6 5945.7 5949.0 6015.6 6071.4 6104.4 6149.7 6151.4 6188.2 6257.2 5864.6 5997.3 6020.9 6024.1 6072.4 15:05:31 INFO - PROCESS | 3470 | 15:05:31 INFO - PROCESS | 3470 | [#5] yui.html Cycles:180 Average:21440.19 Median:3601.00 stddev:30520.79 (847.6%) stddev-sans-first:30567.00 15:05:31 INFO - PROCESS | 3470 | Values: 783.7 786.5 799.1 811.0 840.5 14405.5 14421.9 14440.3 14752.2 15220.5 13706.4 13776.0 13801.6 13803.9 13890.8 726.6 848.0 848.4 870.6 872.6 846.7 852.2 857.4 858.1 859.0 915.4 919.5 920.8 923.0 924.5 896.6 902.6 911.7 912.9 914.4 670.7 673.2 675.6 676.6 676.6 15896.2 15901.8 15993.4 16035.1 16118.8 15840.3 15949.7 16089.9 16348.3 16461.2 11992.6 12120.0 12331.6 12489.8 13221.5 4081.3 4165.7 4183.1 4202.9 4222.5 76495.9 77284.2 77394.6 77429.1 77510.2 12446.3 12585.9 12626.7 12677.3 12842.0 23545.9 23596.3 24461.4 24672.8 24772.9 8144.3 8158.6 8288.4 8631.1 8663.2 4981.2 5042.4 5044.2 5063.9 5144.9 3477.2 3593.4 3594.6 3607.4 3609.4 603.8 616.2 616.9 624.4 627.4 692.2 719.7 761.6 809.2 851.8 10832.4 11202.9 11356.0 11445.4 11741.1 709.8 752.8 798.8 815.5 818.1 5351.4 5488.5 5499.0 5501.2 5534.7 71207.3 76252.0 116440.0 119557.4 122314.0 104176.0 104533.5 104721.0 104881.0 106378.0 79462.6 94646.5 96128.5 96574.5 97948.5 10200.6 10271.7 10409.3 10558.0 10562.5 55011.0 55443.7 56410.0 56466.0 57392.4 78999.2 82728.0 84254.6 84759.0 85568.6 12463.6 12695.9 12983.2 13406.8 13516.9 13574.8 13894.9 13917.2 14521.4 14574.5 13544.5 13797.7 13855.2 13876.9 14062.9 13029.2 13040.9 13365.8 13684.8 13787.7 12733.7 12776.6 13140.1 13398.3 13415.5 11421.0 11441.6 11612.7 11750.4 11810.6 11592.8 11635.5 11805.7 11851.8 12001.0 15:05:31 INFO - PROCESS | 3470 | -------- Summary: end -------- 15:05:31 INFO - PROCESS | 3470 | 15:05:32 INFO - TEST-INFO | 3470: exit 0 15:05:32 INFO - TEST-OK | dromaeo_css | took 1111882ms 15:05:32 INFO - TEST-START | kraken 15:05:32 INFO - operating with platform_type : linux_ 15:05:32 INFO - Initialising browser for kraken test... 15:05:32 INFO - TEST-INFO | started process 3712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc3cFCB/profile http://localhost:45414/getInfo.html) 15:05:37 INFO - PROCESS | 3712 | __metrics Screen width/height:1600/1200 15:05:37 INFO - PROCESS | 3712 | colorDepth:24 15:05:37 INFO - PROCESS | 3712 | Browser inner width/height: 1024/697 15:05:37 INFO - PROCESS | 3712 | __metrics 15:05:38 ERROR - PROCESS | 3712 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:05:38 INFO - TEST-INFO | 3712: exit 0 15:05:38 INFO - Browser initialized. 15:05:38 INFO - Running cycle 1/1 for kraken test... 15:05:38 INFO - TEST-INFO | started process 3844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc3cFCB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:50 INFO - PROCESS | 3844 | RSS: Main: 156221440 15:05:50 INFO - PROCESS | 3844 | 15:05:53 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45414/tests/kraken/driver.html?testName=audio-beat-detection) 15:05:54 INFO - PROCESS | 3844 | RSS: Main: 162250752 15:05:54 INFO - PROCESS | 3844 | 15:05:56 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45414/tests/kraken/driver.html?testName=audio-dft) 15:05:57 INFO - PROCESS | 3844 | RSS: Main: 160878592 15:05:57 INFO - PROCESS | 3844 | 15:06:00 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45414/tests/kraken/driver.html?testName=audio-fft) 15:06:00 INFO - PROCESS | 3844 | RSS: Main: 161722368 15:06:00 INFO - PROCESS | 3844 | 15:06:03 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45414/tests/kraken/driver.html?testName=audio-oscillator) 15:06:03 INFO - PROCESS | 3844 | RSS: Main: 161837056 15:06:03 INFO - PROCESS | 3844 | 15:06:05 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45414/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:06:06 INFO - PROCESS | 3844 | RSS: Main: 161648640 15:06:06 INFO - PROCESS | 3844 | 15:06:09 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45414/tests/kraken/driver.html?testName=imaging-darkroom) 15:06:10 INFO - PROCESS | 3844 | RSS: Main: 161312768 15:06:10 INFO - PROCESS | 3844 | 15:06:13 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45414/tests/kraken/driver.html?testName=imaging-desaturate) 15:06:14 INFO - PROCESS | 3844 | RSS: Main: 161718272 15:06:14 INFO - PROCESS | 3844 | 15:06:17 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45414/tests/kraken/driver.html?testName=json-parse-financial) 15:06:17 INFO - PROCESS | 3844 | RSS: Main: 161484800 15:06:17 INFO - PROCESS | 3844 | 15:06:19 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45414/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:06:19 INFO - PROCESS | 3844 | RSS: Main: 160845824 15:06:19 INFO - PROCESS | 3844 | 15:06:21 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:06:22 INFO - PROCESS | 3844 | RSS: Main: 161296384 15:06:22 INFO - PROCESS | 3844 | 15:06:24 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:06:25 INFO - PROCESS | 3844 | RSS: Main: 161894400 15:06:25 INFO - PROCESS | 3844 | 15:06:27 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:06:28 INFO - PROCESS | 3844 | RSS: Main: 161972224 15:06:28 INFO - PROCESS | 3844 | 15:06:30 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:06:31 INFO - PROCESS | 3844 | RSS: Main: 161427456 15:06:31 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:45414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45414/tests/kraken/driver.html?testName=ai-astar) 15:06:33 INFO - PROCESS | 3844 | RSS: Main: 162631680 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | __start_tp_report 15:06:33 INFO - PROCESS | 3844 | _x_x_mozilla_page_load 15:06:33 INFO - PROCESS | 3844 | _x_x_mozilla_page_load_details 15:06:33 INFO - PROCESS | 3844 | |i|pagename|runs| 15:06:33 INFO - PROCESS | 3844 | |0;ai-astar;111;106;112;111;112;110;110;110;113;111 15:06:33 INFO - PROCESS | 3844 | |1;audio-beat-detection;162;130;154;178;127;154;162;129;181;126 15:06:33 INFO - PROCESS | 3844 | |2;audio-dft;166;163;162;164;162;160;163;163;163;162 15:06:33 INFO - PROCESS | 3844 | |3;audio-fft;75;76;75;173;77;75;76;79;180;76 15:06:33 INFO - PROCESS | 3844 | |4;audio-oscillator;85;87;144;84;84;84;137;84;84;154 15:06:33 INFO - PROCESS | 3844 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;117;119;118 15:06:33 INFO - PROCESS | 3844 | |6;imaging-darkroom;149;147;147;147;148;153;148;148;148;146 15:06:33 INFO - PROCESS | 3844 | |7;imaging-desaturate;96;95;105;96;96;96;96;97;96;95 15:06:33 INFO - PROCESS | 3844 | |8;json-parse-financial;54;52;53;52;63;59;53;52;53;53 15:06:33 INFO - PROCESS | 3844 | |9;json-stringify-tinderbox;59;59;59;59;61;60;60;60;67;59 15:06:33 INFO - PROCESS | 3844 | |10;stanford-crypto-aes;77;77;76;80;78;79;79;79;117;78 15:06:33 INFO - PROCESS | 3844 | |11;stanford-crypto-ccm;120;123;123;127;123;126;121;121;135;130 15:06:33 INFO - PROCESS | 3844 | |12;stanford-crypto-pbkdf2;156;156;154;158;158;157;157;155;152;153 15:06:33 INFO - PROCESS | 3844 | |13;stanford-crypto-sha256-iterative;65;62;63;61;62;62;68;60;62;62 15:06:33 INFO - PROCESS | 3844 | __end_tp_report 15:06:33 INFO - PROCESS | 3844 | __start_cc_report 15:06:33 INFO - PROCESS | 3844 | _x_x_mozilla_cycle_collect,855 15:06:33 INFO - PROCESS | 3844 | __end_cc_report 15:06:33 INFO - PROCESS | 3844 | __startTimestamp1467583593454__endTimestamp 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | ------- Summary: start ------- 15:06:33 INFO - PROCESS | 3844 | Number of tests: 14 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 15:06:33 INFO - PROCESS | 3844 | Values: 111.0 106.0 112.0 111.0 112.0 110.0 110.0 110.0 113.0 111.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:158.00 stddev:21.11 (13.4%) stddev-sans-first:21.96 15:06:33 INFO - PROCESS | 3844 | Values: 162.0 130.0 154.0 178.0 127.0 154.0 162.0 129.0 181.0 126.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.55 (1.0%) stddev-sans-first:1.13 15:06:33 INFO - PROCESS | 3844 | Values: 166.0 163.0 162.0 164.0 162.0 160.0 163.0 163.0 163.0 162.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#3] audio-fft Cycles:10 Average:96.20 Median:76.00 stddev:42.37 (55.8%) stddev-sans-first:44.24 15:06:33 INFO - PROCESS | 3844 | Values: 75.0 76.0 75.0 173.0 77.0 75.0 76.0 79.0 180.0 76.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.00 stddev:29.48 (35.1%) stddev-sans-first:30.57 15:06:33 INFO - PROCESS | 3844 | Values: 85.0 87.0 144.0 84.0 84.0 84.0 137.0 84.0 84.0 154.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 15:06:33 INFO - PROCESS | 3844 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 119.0 118.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.91 (1.3%) stddev-sans-first:2.00 15:06:33 INFO - PROCESS | 3844 | Values: 149.0 147.0 147.0 147.0 148.0 153.0 148.0 148.0 148.0 146.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:2.94 (3.1%) stddev-sans-first:3.10 15:06:33 INFO - PROCESS | 3844 | Values: 96.0 95.0 105.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.00 stddev:3.66 (6.9%) stddev-sans-first:3.88 15:06:33 INFO - PROCESS | 3844 | Values: 54.0 52.0 53.0 52.0 63.0 59.0 53.0 52.0 53.0 53.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:2.45 (4.1%) stddev-sans-first:2.55 15:06:33 INFO - PROCESS | 3844 | Values: 59.0 59.0 59.0 59.0 61.0 60.0 60.0 60.0 67.0 59.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:78.50 stddev:12.36 (15.7%) stddev-sans-first:12.97 15:06:33 INFO - PROCESS | 3844 | Values: 77.0 77.0 76.0 80.0 78.0 79.0 79.0 79.0 117.0 78.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:124.50 stddev:4.70 (3.8%) stddev-sans-first:4.64 15:06:33 INFO - PROCESS | 3844 | Values: 120.0 123.0 123.0 127.0 123.0 126.0 121.0 121.0 135.0 130.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 15:06:33 INFO - PROCESS | 3844 | Values: 156.0 156.0 154.0 158.0 158.0 157.0 157.0 155.0 152.0 153.0 15:06:33 INFO - PROCESS | 3844 | 15:06:33 INFO - PROCESS | 3844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:2.26 (3.7%) stddev-sans-first:2.24 15:06:33 INFO - PROCESS | 3844 | Values: 65.0 62.0 63.0 61.0 62.0 62.0 68.0 60.0 62.0 62.0 15:06:33 INFO - PROCESS | 3844 | -------- Summary: end -------- 15:06:33 INFO - PROCESS | 3844 | 15:06:34 INFO - TEST-INFO | 3844: exit 0 15:06:34 INFO - TEST-OK | kraken | took 61836ms 15:06:34 INFO - SUITE-END | took 1173s 15:06:34 INFO - Completed test suite (00:19:34) 15:06:34 INFO - javascript benchmark 15:06:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7623.719541459724, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.057503898908, 3413.4367829308158, 3415.1803567143893, 3442.0706409269496, 3450.240946991661, 5654.095344744842, 5662.263905692259, 5672.631278966865, 5696.629719068258, 5745.971270143654, 5714.371419143901, 5724.084146536555, 5753.338366087901, 5776.59563830532, 5790.392008839074, 5165.225216217569, 5176.145935920568, 5276.34045744282, 5291.656042357254, 5301.787928482856, 5113.667611605234, 5121.078205922932, 5309.920351194735, 5320.0, 5336.9733151334185, 5257.23770053342, 5258.342707161605, 5263.236830659552, 5280.683159010472, 5290.074237008527, 5282.102042652739, 5341.145416733343, 5354.946450535484, 5356.464353564613, 5357.357117145967, 5092.0, 5189.481051894818, 5247.107991641392, 5315.415304316522, 5317.9202311965355, 5423.29497165366, 5475.986942415666, 5506.669599823983, 5584.776608935637, 5607.327120745536, 6019.699015049274, 6029.969850150765, 6051.757929682807, 6104.023356262976, 6135.2024236849375, 5977.462028417463, 6040.939590604125, 6158.261008678987, 6160.722767475474, 6182.103594978747, 5707.086866101404, 5759.827205183851, 5816.331121920991, 5830.591858569902, 5852.0, 6324.3043265240785, 6334.556581039283, 6337.873242535124, 6339.0, 6344.524160687967, 5869.530437564985, 5984.192134061933, 6006.339302676702, 6108.664023478663, 6112.816615501542, 6158.568900176944, 6166.0, 6177.876442471125, 6187.195664563578, 6195.938040619626, 6121.724522396503, 6146.108814221912, 6151.9384806151365, 6164.969175154096, 6166.7224974876235, 6003.039513677791, 6075.301340345828, 6104.694765261719, 6139.263288405331, 6174.073888916699, 4652.302154676758, 4654.208784506642, 4665.790039448233, 4677.251639737626, 4685.789139488731, 4169.249535083653, 4180.6446452051305, 4186.644135248538, 4192.832286708558, 4209.810558524874, 5804.535637149018, 5837.649741015468, 5915.674637894871, 5940.0, 5981.880362392728, 6076.0, 6143.911070236141, 6146.200993870768, 6169.475594574512, 6225.844353891189, 5775.537956963432, 5929.0, 5937.614055086406, 5938.673372964528, 5968.895754285384, 5104.9489505104475, 5140.049090918192, 5180.507851754077, 5196.32447781786, 5198.792048318101, 6352.396522330371, 6370.617762934146, 6394.424501794861, 6406.199225096863, 6420.486361091102, 6129.908988904127, 6135.601185922901, 6229.7508099676415, 6235.251769787655, 6248.781292654735, 6318.494520438262, 6442.645654489048, 6452.709628066655, 6459.095726598186, 6462.321456247214, 6111.419415155553, 6114.052321889936, 6129.724162412613, 6144.109104179958, 6147.262328520606, 5976.701164941823, 6143.047827586731, 6193.287771906288, 6208.50331973432, 6236.0, 5988.311344195473, 6054.152418661479, 6089.817305480843, 6097.390260973867, 6102.847428814315, 5935.732892019783, 5988.131720900532, 6067.878642427215, 6073.787417440369, 6091.390860914051, 5777.364489906191, 5847.181394604844, 5867.266591676041, 5895.587308888508, 5915.231019967377, 6058.303295121117, 6068.544859135494, 6068.787592434243, 6093.390660933871, 6095.024796032613, 5921.3190483094995, 5932.733027013708, 5941.881162376815, 5947.791827286024, 5948.256467941507], "value": 5674.853542570258, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.2057163971917, 620.8603064310533, 627.2285089340112, 642.48922106925, 642.585532331646, 44941.325880111784, 45790.3131453028, 46200.53799462004, 46208.0, 50115.24827127596, 48129.278060829114, 48951.0, 49011.50988490114, 49124.508754912444, 49216.0, 9032.593533290985, 9181.357304988653, 9199.862002069975, 9236.815263694722, 9270.860937085949, 9021.639134434614, 9097.363184577081, 9139.086091390875, 9139.72580822573, 9145.314101442418, 9138.406003609778, 9178.449293042406, 9189.08109189079, 9206.401583897059, 9245.16793488586, 9079.137481939239, 9090.363674542785, 9118.772030699252, 9136.58885350161, 9151.67969121081, 9080.364374493787, 9179.311551633587, 9199.218066464358, 9202.171804537556, 9220.262379009662, 44516.3322550162, 44524.554754452685, 44957.55042449599, 45010.32484512735, 45100.54899451029, 3909.9413508797393, 3971.801409929521, 4041.878743637666, 4083.530394004698, 4605.125026245003, 34076.48885266723, 34305.31389372223, 34430.82784586086, 34542.0, 35631.0, 4640.767961601907, 4678.7426691531955, 4722.291656251556, 4736.052789442126, 4750.216214324632, 361578.0, 363002.0, 363103.0, 363933.0, 364338.0, 60891.39108608946, 60961.0, 61543.6922815392, 61550.0, 61728.69135654293, 38555.42166867499, 39362.80318598446, 39802.40296395557, 42275.57724422778, 65134.674326629014, 16773.58066048334, 16878.409255675993, 16919.0, 16996.745048824276, 17066.829331706773, 13572.524961626295, 13653.590392288248, 13698.38357273925, 13750.793738093937, 13807.51673691416, 20511.0, 20599.794002060087, 20703.27538536174, 20800.687989680166, 20833.0, 7559.1684914659345, 7646.0, 7690.961545192238, 7752.651130699132, 7774.378049756119, 1078.5308390850005, 1085.4898197846999, 1133.580575187186, 1182.2374568403332, 1211.7939950208486, 32575.837120814245, 32965.0, 33070.17324566857, 33519.66480335214, 34292.48561271583, 1167.772284404533, 1174.307158776326, 1181.911356648255, 1205.1021988618536, 1266.5820279307807, 17427.588857443843, 17430.65138697219, 17676.204570794343, 17700.29198832058, 17840.821591783915, 620242.0, 624425.0, 657543.0, 1005226.0, 1024730.0, 60147.0, 60864.39135608676, 60910.69544652337, 61102.69448652728, 61124.388756112756, 1515.1893736850732, 1527.694461107783, 1533.7852700621922, 1549.6280892585698, 1567.8275389707123, 30921.381572368875, 31915.0, 32011.679883200868, 32081.839590801897, 32828.67171328256, 52277.0, 52832.0, 52878.471215287354, 52971.0, 53134.202986956, 393920.0, 398754.0, 398823.0, 400531.0, 401987.0, 30159.0, 30240.607935387114, 30251.697483024887, 30350.696493034786, 30548.0, 49449.75275123601, 49519.0, 49594.25608615801, 50354.748226258635, 50906.745466272434, 41020.384694230204, 41040.0, 41461.378079329435, 41845.0, 42636.78681606572, 41266.58733412628, 41411.0, 41734.373984389655, 42332.0, 42565.93585160396, 40987.7950610245, 41539.37690934699, 41709.58290417178, 42080.57919420767, 42484.5751542493, 36033.639663603026, 36249.0, 36363.0, 36822.63177368192, 37248.62751372452, 28250.2937426566, 28606.713932860406, 28640.713592863805, 28761.637901054142, 29091.7090829089], "value": 21096.228501118207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.41385009462095, 429.44241433313306, 435.48177668574397, 438.86833949815065, 444.16718652526515, 18358.816411835876, 19705.704414433778, 20196.69704954425, 21150.153993840227, 21155.365339039854, 17197.22612482438, 18593.81406185938, 19463.124159412826, 19544.120514576844, 20020.0990955407, 5206.531412172903, 5341.252224688546, 5362.892742145154, 5363.222332761767, 5373.516383525482, 5248.895022099556, 5333.253344531769, 5361.115415956362, 5372.677639341632, 5394.352677678684, 5696.715164241792, 5756.136579513086, 5762.423757624246, 5781.306243250816, 5793.797217097403, 5615.634983726045, 5983.341832398432, 5992.2809262888295, 6008.309044459899, 6009.729562169669, 5554.0, 5783.971080144573, 5819.156222347779, 5833.970830145865, 5837.532997360201, 13860.0, 14336.856631433657, 14386.92806535971, 14527.418903243857, 14558.199299038548, 2237.6196046672103, 2370.3837002379505, 2458.188797696756, 2488.340589743719, 2537.6827896512937, 10130.037646423578, 10606.628767993083, 13701.588952331445, 15020.324085416183, 15408.537743867702, 1952.3264473756674, 1993.9700904486444, 2056.609244243589, 2084.1038353507984, 2148.3232781673723, 82469.17530824675, 83044.0, 83067.5846620769, 83368.58315708443, 87105.0, 11781.469833857496, 11793.0, 11915.106367022508, 11916.285022898654, 11977.880221197851, 16447.588810279838, 16499.422520211974, 16534.173291335625, 16575.502734917973, 16754.58113547171, 8908.777280567909, 8949.463032218087, 8981.865272020925, 9122.224610908015, 9293.72118836436, 8821.779455513664, 9007.954960225157, 9013.774655633662, 9037.593308301142, 9125.908740912639, 4925.2119660854805, 4964.379452568429, 4978.452370239271, 5093.363329583802, 5123.077845987758, 1993.9501512462014, 2070.9378718638463, 2088.9268875589282, 2090.623687736222, 2156.784321567831, 934.3879758758025, 982.5431174503747, 998.3610489286863, 1042.8227201375785, 1046.4924511611862, 18839.529011774543, 19277.22891084341, 19682.606347872963, 19756.209751609775, 19927.60144797125, 1041.5677493840124, 1066.6906597086913, 1071.9410432426134, 1113.1206346985791, 1116.8715597706205, 10727.409992450333, 10747.193960452998, 11463.885361146282, 11832.467538960595, 11967.940160299142, 567231.0, 569298.0, 574802.0, 584134.0, 587872.0, 95042.0, 100053.0, 101267.49366253121, 103052.0, 103338.0, 1140.372794962767, 1162.7500087481233, 1168.67861338131, 1173.9236949598248, 1190.892819646236, 16636.83363166353, 16806.159692015593, 16855.578610534343, 17217.82782172162, 17228.569285767957, 43857.34213986857, 44258.77870610626, 44611.553884460736, 45022.099558009315, 45338.319925200485, 62156.37843621506, 62473.37526624675, 62523.6873815628, 64021.0, 64142.35857641364, 5747.4252574742195, 8619.784505387415, 8877.469921072463, 8907.242884354902, 9051.502167380857, 11655.358955257543, 13671.79492307636, 13816.723665526833, 13847.930760346537, 13953.651158721113, 5814.168352186249, 9388.732521109563, 11624.883751162719, 11850.348230847041, 12027.398630068637, 11764.470598823245, 11813.114016448973, 11887.465064071965, 12102.334371609293, 12127.575534856238, 12221.816672749737, 12329.938350308192, 12416.875831241572, 12444.502219911103, 12498.500059997861, 8711.607977641148, 8796.868046979429, 9039.367244292836, 9109.681161159328, 9126.13301736334, 10445.529951152064, 11949.880501194877, 12181.512739490321, 12196.146269761031, 12334.75330493367], "value": 9509.244338464952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1561.4144695739094, 1561.4378823623495, 1780.9821901780979, 1917.5397904502925, 1928.729977803107, 9218.262538996882, 9560.61757529698, 9811.018898110195, 9817.705468835928, 9834.459104749236, 9745.707628771148, 9870.851937220947, 9876.802463950717, 9906.058924402188, 9979.750506237348, 2485.6768620079365, 2505.3110394641526, 2516.735742747013, 2523.8864251108744, 2525.684289463817, 2461.249318957717, 2496.8127390445698, 2514.8365356251875, 2516.811239157061, 2519.8866051027658, 2482.751724827521, 2519.244226731982, 2529.190658989124, 2530.8228424010326, 2531.1267612673596, 2391.1391898916377, 2401.0995876546294, 2404.2546810488716, 2449.106076282162, 2456.238566044514, 2347.3192774095664, 2350.8001819845335, 2382.1900553811615, 2391.234804862445, 2428.9434096168225, 9642.517874106266, 9650.95174524123, 9691.563879625433, 9772.12050915421, 9812.558434870449, 5729.1119876419225, 5842.883142337129, 5885.852853678693, 5901.911471327933, 5903.0, 3560.501529785832, 3694.8706795262037, 3702.0929872181487, 3715.758475699071, 3764.8117594120185, 1258.6161220827644, 1284.5311461316553, 1301.3818436242805, 2280.771922807706, 2350.776676215774, 13096.738065238642, 13109.147905386119, 13119.47522099115, 13210.075294729373, 13223.272720000396, 4778.629730398219, 4779.450363208206, 4870.342503761947, 4888.828890988798, 4907.87730306738, 10289.382637041801, 10385.896141038493, 10445.738856528647, 10457.790844183226, 10507.737306567396, 5445.618806683573, 5465.180222966507, 5529.972350138304, 5532.889342213214, 5546.057170280981, 4667.6732628716345, 5192.662476938987, 5219.42586315505, 5274.340707411574, 5285.445028272053, 4051.736637118578, 4076.8873800160736, 4093.9181216375505, 4117.794110294473, 4173.603507666767, 1212.7695737809788, 1255.209218192533, 1268.1630124118037, 1275.9681007974875, 1286.9613911582667, 919.8620206969008, 954.6754103604808, 965.3821554205314, 972.9610815567439, 997.6308765756717, 5932.49573786233, 6102.511799056154, 6127.693615319216, 6133.969330153321, 6183.505319574423, 479.37441638661187, 481.1699817814312, 485.04930336540775, 1045.278757657214, 1060.3849767135043, 3559.1635965548076, 3589.6051434342203, 3600.3519366513756, 3650.963490365062, 3662.432322989941, 11669.474873630706, 11870.169088163919, 11972.64082077539, 11990.520379184734, 12021.218620789621, 11726.70683232909, 11795.174337796272, 11906.523739050514, 11909.0, 11926.284422934652, 8526.87209691855, 8741.0, 8855.51294678786, 8890.955545222361, 8919.06349833271, 5610.186522954067, 5756.712164391847, 5767.221425107557, 5868.67722275279, 5878.853028674317, 10797.406142662228, 10926.890731092588, 10938.398388088413, 10980.286281391684, 10999.120070394189, 10868.61959831402, 11083.057940075183, 11270.154738394489, 11380.203385763249, 11382.829257560978, 6881.690323935535, 7366.96316518414, 7625.046869141357, 7706.422018348534, 7763.72826951054, 9200.21798147165, 9284.58219380143, 9284.675036373694, 9362.719118426457, 9421.152096311365, 8015.238552337519, 8168.264856162974, 8300.335973122015, 8330.083690793886, 8375.20435558621, 7998.800029999296, 8123.431359804993, 8178.9591052046735, 8193.83612327762, 8234.629441675259, 6913.51605387618, 7105.964470177616, 7127.216006239206, 7128.536645118051, 7257.637118144177, 5119.616028797929, 5134.0, 5157.432682405008, 5194.8961020780125, 5242.816501422584, 5322.121849894724, 5382.784688612412, 5401.459854014567, 5406.324209473816, 5420.620556561003], "value": 4886.996146179158, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.5663142755841, 357.1286062008698, 357.5834153211509, 362.87480819117394, 363.1937099638803, 5629.958457685321, 5652.269502128596, 5809.651420914743, 5886.617369870961, 5918.260217472816, 5713.285839270091, 5736.741846616902, 5738.56960727946, 5742.2247996520455, 5764.855878603026, 4540.250858608326, 4575.222212223914, 4581.5647513486165, 4589.885252868671, 4593.816247350102, 4504.256797628387, 4511.954880451202, 4537.137943790685, 4584.816607335702, 4586.954130458703, 4445.222086134913, 4480.865574032768, 4491.461024677027, 4496.303073023671, 4502.549745025504, 4497.64018878489, 4518.638508919278, 4530.074718244766, 4541.977290113528, 4543.954560454386, 3911.5663202781643, 3981.601839816024, 3982.38273067675, 4036.4752582164133, 4052.5947405259535, 5461.726913654302, 5483.259759932398, 5503.559715222813, 5529.474699903543, 5563.276774019392, 5139.15203991341, 5142.665726727788, 5143.382794064699, 5149.888545696246, 5190.818321358772, 5833.766649334021, 5929.73316200772, 5975.073863551156, 5983.311919129313, 6051.636901785907, 4385.934210986838, 4419.315006174048, 4431.889202769924, 4435.735815292626, 4457.465104187486, 6147.538934579924, 6240.375962403768, 6274.803818663431, 6280.15217945576, 6314.452959025069, 4175.874723758292, 4398.230309695854, 4418.536053714313, 4419.513853476115, 4420.143539713328, 4417.624501917373, 4446.466424029137, 4451.953790859146, 4466.173757854807, 4483.955160448354, 5074.5686616637995, 5087.931534377748, 5111.131107711698, 5133.768980395891, 5144.356955380577, 5911.527077833849, 5968.76124954997, 6084.817455476343, 6125.754969801247, 6141.416565426277, 1520.8022957015517, 1526.83960190254, 1536.3240174323262, 1542.997051916241, 1546.445821948934, 963.4075043847984, 966.3664621024997, 970.815545046439, 970.898055704155, 995.4723996281982, 5220.269162317279, 5234.371875374979, 5241.659292145999, 5255.816046438356, 5286.127788914863, 5429.267048948421, 5495.241522712773, 5539.421264939473, 5577.358603760538, 5629.662220266797, 5091.567216786615, 5358.303420555303, 5359.517643412111, 5376.634280916384, 5402.486763757437, 2914.2714321419644, 2972.360942397395, 2993.760499160062, 3023.7580993520464, 3067.2791893904914, 5568.582356323292, 5757.740901659436, 5770.682612456355, 5775.480206781326, 5811.7214212873105, 5585.58108141891, 5606.859828504238, 5607.504660426152, 5615.578831587647, 5697.214339954458, 5593.664380137205, 5702.429757024264, 5717.799877004285, 5756.654600723886, 5780.468175933381, 5380.408155103014, 5526.364468086061, 5593.496585307342, 5639.715915054409, 5656.773729050792, 5357.357117145967, 5433.8536278170695, 5434.407925303112, 5482.8081017165805, 5503.651605356553, 5655.971720141373, 5708.942910570841, 5785.727140029187, 5791.08894064966, 5798.710064496674, 3812.8284227209288, 4039.8788036358956, 4051.351783714709, 4084.7133153056693, 4104.384342348671, 5613.438656134354, 5655.604107712421, 5666.688332141772, 6169.981952977709, 6384.0, 6201.751929922752, 6206.689665516797, 6207.34822843613, 6229.3770622937345, 6241.344658810759, 5972.5520585955355, 6003.339632640494, 6088.4824789893355, 6119.449249567382, 6161.691915404302, 5932.5550583705535, 5945.721669841005, 5948.970255148696, 6015.578909476295, 6071.392860713893, 6104.389561044038, 6149.692515374124, 6151.446369826558, 6188.226471691039, 6257.2491301044165, 5864.560157988253, 5997.250343707036, 6020.90968635462, 6024.0662697282, 6072.423119803611], "value": 4464.505504579699, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.6865253898442, 786.5005721366933, 799.0810567846976, 810.9918900810998, 840.5293035899897, 14405.495807646734, 14421.92789036056, 14440.277986100706, 14752.188629625367, 15220.543383698492, 13706.383212755425, 13776.03567750258, 13801.585952421417, 13803.930980345109, 13890.79163812541, 726.5640615630632, 847.9618417171242, 848.3976376772483, 870.5690683111868, 872.5855218771096, 846.7459762071385, 852.2372476633441, 857.4340934982913, 858.0947100808644, 859.0164261920098, 915.3729695158837, 919.5080631861955, 920.7559996600872, 923.044648788504, 924.5192499900048, 896.560685264219, 902.580300160422, 911.6854685133618, 912.9315301352392, 914.3873604684877, 670.7317073170722, 673.249327000396, 675.560885424478, 676.577139287945, 676.5906626491001, 15896.205189740582, 15901.76147357779, 15993.360265589363, 16035.118068506228, 16118.75821862673, 15840.340532430911, 15949.681006379924, 16089.91955040229, 16348.264328105144, 16461.176941153015, 11992.580259690869, 12120.030397568173, 12331.568395106218, 12489.75020499585, 13221.471141154343, 4081.285774989365, 4165.687573432005, 4183.1215444756335, 4202.894927626803, 4222.514410842762, 76495.85256221217, 77284.22715772827, 77394.6130269345, 77429.06427339306, 77510.22489775087, 12446.25322480654, 12585.93707031459, 12626.684332891751, 12677.30274834893, 12842.036847236495, 23545.882270588536, 23596.29211123669, 24461.38846528851, 24672.753272467406, 24772.876135619208, 8144.267015968591, 8158.632861521246, 8288.419810613319, 8631.050584435707, 8663.176998185163, 4981.227909674007, 5042.369703787027, 5044.218146187347, 5063.87340316495, 5144.948550514447, 3477.200243943907, 3593.425051991721, 3594.5506811648543, 3607.4408466687705, 3609.4044482660065, 603.8007457539002, 616.2420223125491, 616.892043892317, 624.3631495874183, 627.4133685004535, 692.1521136607615, 719.7480881691366, 761.6275302432882, 809.1625167951142, 851.7572491839796, 10832.404217768099, 11202.94398528002, 11356.0, 11445.427728613537, 11741.119416043832, 709.836737550356, 752.7929819299736, 798.7683571764123, 815.4780940198278, 818.1491249100868, 5351.384590772111, 5488.53347465462, 5498.972505137449, 5501.229827824108, 5534.723263836792, 71207.2879271211, 76252.0, 116440.0, 119557.40221298838, 122314.0, 104176.0, 104533.47733261285, 104721.0, 104881.0, 106378.0, 79462.6026869862, 94646.52676736572, 96128.51935740277, 96574.51712741391, 97948.51025744826, 10200.591976320864, 10271.7432064196, 10409.323393979366, 10558.0, 10562.471876406302, 55011.0, 55443.72278138745, 56410.0, 56466.0, 57392.42607573871, 78999.21000789918, 82728.0, 84254.57872710597, 84759.0, 85568.57215713881, 12463.626091216915, 12695.93652031771, 12983.156094853804, 13406.798898016343, 13516.86483135156, 13574.796378054534, 13894.930525347712, 13917.234552099326, 14521.419143234152, 14574.489892853699, 13544.525941591997, 13797.655058623615, 13855.237961912191, 13876.861231387556, 14062.929685351508, 13029.209221037623, 13040.869591303965, 13365.799513007507, 13684.794728079285, 13787.724245514833, 12733.745325093632, 12776.61670149897, 13140.07733566172, 13398.330083495981, 13415.530456433979, 11421.0, 11441.563351972884, 11612.709682258012, 11750.412479376168, 11810.645680629596, 11592.768144637228, 11635.53457861676, 11805.700123915738, 11851.762964740485, 12001.0], "value": 7903.847506313604, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 111.0, 112.0, 110.0, 110.0, 110.0, 113.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 130.0, 154.0, 178.0, 127.0, 154.0, 162.0, 129.0, 181.0, 126.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 164.0, 162.0, 160.0, 163.0, 163.0, 163.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 173.0, 77.0, 75.0, 76.0, 79.0, 180.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 144.0, 84.0, 84.0, 84.0, 137.0, 84.0, 84.0, 154.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 153.0, 148.0, 148.0, 148.0, 146.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 105.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 63.0, 59.0, 53.0, 52.0, 53.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 61.0, 60.0, 60.0, 60.0, 67.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 80.0, 78.0, 79.0, 79.0, 79.0, 117.0, 78.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 123.0, 127.0, 123.0, 126.0, 121.0, 121.0, 135.0, 130.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 154.0, 158.0, 158.0, 157.0, 157.0, 155.0, 152.0, 153.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 61.0, 62.0, 62.0, 68.0, 60.0, 62.0, 62.0], "value": 62.7, "unit": "score"}]}]} 15:06:34 INFO - Return code: 0 15:06:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:06:34 ERROR - # TBPL SUCCESS # 15:06:34 INFO - Running post-action listener: _resource_record_post_action 15:06:34 INFO - ##### 15:06:34 INFO - ##### Finished run-tests step (success) 15:06:34 INFO - ##### 15:06:34 INFO - Running post-run listener: _resource_record_post_run 15:06:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7917568; Write bytes: 378134528; Read time: 1600; Write time: 344708 15:06:34 INFO - TinderboxPrint: CPU usage
13.5% 15:06:34 INFO - TinderboxPrint: I/O read bytes / time
7,917,568 / 1,600 15:06:34 INFO - TinderboxPrint: I/O write bytes / time
378,134,528 / 344,708 15:06:34 INFO - TinderboxPrint: CPU idle
8,221.2 (86.5%) 15:06:34 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 15:06:34 INFO - TinderboxPrint: Swap in / out
0 / 0 15:06:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 16797696; Read time: 92; Write time: 12724 15:06:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6152192; Write bytes: 317775872; Read time: 1380; Write time: 285396 15:06:35 INFO - Running post-run listener: _upload_blobber_files 15:06:35 INFO - Blob upload gear active. 15:06:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:06:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:06:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:06:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:06:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:06:36 INFO - (blobuploader) - INFO - Done attempting. 15:06:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:06:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:06:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:06:40 INFO - (blobuploader) - INFO - Done attempting. 15:06:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:06:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:06:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:06:40 INFO - (blobuploader) - INFO - Done attempting. 15:06:40 INFO - (blobuploader) - INFO - Iteration through files over. 15:06:40 INFO - Return code: 0 15:06:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:06:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:06:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24b2798e2de5aae4f0dcd105001199832699fb81e009f7966c58781ac7b0021aea37403cf48922704318eded67e2bd77ce48bf01b65d7820c61670265e570f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa149c7c8f1f78c1cfb2f52bfbdcdab9dfa27ecadb8448f62a880ef554c242cedf4ac49ee2254f994015d605c666a2a86438d44033a4ae71725fcfc7cec743b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e352ae894e3d536b27f4024f9bd30cbd8483a611012987b890f9cd65bf9a71b6fe5035da5eda8c27a380c28702683df732dff313ba8c6536636fd5fe0256a28a"} 15:06:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:06:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:06:40 INFO - Contents: 15:06:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24b2798e2de5aae4f0dcd105001199832699fb81e009f7966c58781ac7b0021aea37403cf48922704318eded67e2bd77ce48bf01b65d7820c61670265e570f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa149c7c8f1f78c1cfb2f52bfbdcdab9dfa27ecadb8448f62a880ef554c242cedf4ac49ee2254f994015d605c666a2a86438d44033a4ae71725fcfc7cec743b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e352ae894e3d536b27f4024f9bd30cbd8483a611012987b890f9cd65bf9a71b6fe5035da5eda8c27a380c28702683df732dff313ba8c6536636fd5fe0256a28a"} 15:06:40 INFO - Running post-run listener: copy_logs_to_upload_dir 15:06:40 INFO - Copying logs to upload dir... 15:06:40 INFO - mkdir: /builds/slave/test/build/upload/logs 15:06:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.009602 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-03 15:06:40.715743) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 15:06:40.718971) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24b2798e2de5aae4f0dcd105001199832699fb81e009f7966c58781ac7b0021aea37403cf48922704318eded67e2bd77ce48bf01b65d7820c61670265e570f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa149c7c8f1f78c1cfb2f52bfbdcdab9dfa27ecadb8448f62a880ef554c242cedf4ac49ee2254f994015d605c666a2a86438d44033a4ae71725fcfc7cec743b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e352ae894e3d536b27f4024f9bd30cbd8483a611012987b890f9cd65bf9a71b6fe5035da5eda8c27a380c28702683df732dff313ba8c6536636fd5fe0256a28a"} build_url:https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/VrSdFnhOTfG3-xGsK-y6Tg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24b2798e2de5aae4f0dcd105001199832699fb81e009f7966c58781ac7b0021aea37403cf48922704318eded67e2bd77ce48bf01b65d7820c61670265e570f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa149c7c8f1f78c1cfb2f52bfbdcdab9dfa27ecadb8448f62a880ef554c242cedf4ac49ee2254f994015d605c666a2a86438d44033a4ae71725fcfc7cec743b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e352ae894e3d536b27f4024f9bd30cbd8483a611012987b890f9cd65bf9a71b6fe5035da5eda8c27a380c28702683df732dff313ba8c6536636fd5fe0256a28a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 15:06:40.744717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 15:06:40.745058) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467580397.5497-848208545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 15:06:40.828572) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 15:06:40.828925) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 15:06:40.829223) ========= ========= Total master_lag: 0.20 =========