builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1469751600.24 results: success (0) buildid: 20160728144757 builduid: 42c78b59408f453eb256b249759aeda3 revision: 29dda3d9dfcb2ac4b7e84f69bb1649af99089f19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.240306) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.240926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.241216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.265351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.265703) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 17:20: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% 219M=0s 2016-07-28 17:20:00 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124296 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.404706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.405008) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019854 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.461366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:00.461665) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29dda3d9dfcb2ac4b7e84f69bb1649af99089f19 --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 29dda3d9dfcb2ac4b7e84f69bb1649af99089f19 --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=03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 17:20:00,703 truncating revision to first 12 chars 2016-07-28 17:20:00,703 Setting DEBUG logging. 2016-07-28 17:20:00,703 attempt 1/10 2016-07-28 17:20:00,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/29dda3d9dfcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 17:20:01,007 unpacking tar archive at: mozilla-aurora-29dda3d9dfcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:01.121212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:01.121512) ========= script_repo_revision: 29dda3d9dfcb2ac4b7e84f69bb1649af99089f19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:01.121895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:01.122171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 17:20:01.130745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-28 17:20:01.131038) ========= /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=03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:20:01 INFO - MultiFileLogger online at 20160728 17:20:01 in /builds/slave/test 17:20:01 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 17:20:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:20:01 INFO - {'append_to_log': False, 17:20:01 INFO - 'base_work_dir': '/builds/slave/test', 17:20:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:20:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:20:01 INFO - 'branch': 'Mozilla-Aurora', 17:20:01 INFO - 'buildbot_json_path': 'buildprops.json', 17:20:01 INFO - 'config_files': ('talos/linux_config.py',), 17:20:01 INFO - 'default_actions': ('clobber', 17:20:01 INFO - 'read-buildbot-config', 17:20:01 INFO - 'download-and-extract', 17:20:01 INFO - 'populate-webroot', 17:20:01 INFO - 'create-virtualenv', 17:20:01 INFO - 'install', 17:20:01 INFO - 'run-tests'), 17:20:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:20:01 INFO - 'download_minidump_stackwalk': True, 17:20:01 INFO - 'download_symbols': 'ondemand', 17:20:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:20:01 INFO - 'tooltool.py': '/tools/tooltool.py', 17:20:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:20:01 INFO - '/tools/misc-python/virtualenv.py')}, 17:20:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:20:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:20:01 INFO - 'installer_path': 'installer.exe', 17:20:01 INFO - 'log_level': 'info', 17:20:01 INFO - 'log_name': 'talos', 17:20:01 INFO - 'log_to_console': True, 17:20:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:20:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:20:01 INFO - 'opt_config_files': (), 17:20:01 INFO - 'pip_index': False, 17:20:01 INFO - 'sps_profile': False, 17:20:01 INFO - 'sps_profile_interval': 0, 17:20:01 INFO - 'suite': 'dromaeojs-e10s', 17:20:01 INFO - 'system_bits': '32', 17:20:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:20:01 INFO - 'title': 'talos-linux64-ix-047', 17:20:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:20:01 INFO - 'use_talos_json': True, 17:20:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:20:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:20:01 INFO - 'work_dir': 'build'} 17:20:01 INFO - ##### 17:20:01 INFO - ##### Running clobber step. 17:20:01 INFO - ##### 17:20:01 INFO - Running pre-action listener: _resource_record_pre_action 17:20:01 INFO - Running main action method: clobber 17:20:01 INFO - rmtree: /builds/slave/test/build 17:20:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:20:01 INFO - Running post-action listener: _resource_record_post_action 17:20:01 INFO - ##### 17:20:01 INFO - ##### Finished clobber step (success) 17:20:01 INFO - ##### 17:20:01 INFO - ##### 17:20:01 INFO - ##### Running read-buildbot-config step. 17:20:01 INFO - ##### 17:20:01 INFO - Running pre-action listener: _resource_record_pre_action 17:20:01 INFO - Running main action method: read_buildbot_config 17:20:01 INFO - Using buildbot properties: 17:20:01 INFO - { 17:20:01 INFO - "project": "", 17:20:01 INFO - "product": "firefox", 17:20:01 INFO - "script_repo_revision": "production", 17:20:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:20:01 INFO - "repository": "", 17:20:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 17:20:01 INFO - "buildid": "20160728144757", 17:20:01 INFO - "pgo_build": "True", 17:20:01 INFO - "basedir": "/builds/slave/test", 17:20:01 INFO - "buildnumber": 445, 17:20:01 INFO - "slavename": "talos-linux64-ix-047", 17:20:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:20:01 INFO - "platform": "ubuntu64_hw", 17:20:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:20:01 INFO - "branch": "mozilla-aurora", 17:20:01 INFO - "repo_path": "releases/mozilla-aurora", 17:20:01 INFO - "revision": "29dda3d9dfcb2ac4b7e84f69bb1649af99089f19", 17:20:01 INFO - "stage_platform": "linux64-pgo", 17:20:01 INFO - "builduid": "42c78b59408f453eb256b249759aeda3", 17:20:01 INFO - "slavebuilddir": "test" 17:20:01 INFO - } 17:20:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 17:20:01 INFO - Running post-action listener: _resource_record_post_action 17:20:01 INFO - ##### 17:20:01 INFO - ##### Finished read-buildbot-config step (success) 17:20:01 INFO - ##### 17:20:01 INFO - ##### 17:20:01 INFO - ##### Running download-and-extract step. 17:20:01 INFO - ##### 17:20:01 INFO - Running pre-action listener: _resource_record_pre_action 17:20:01 INFO - Running main action method: download_and_extract 17:20:01 INFO - mkdir: /builds/slave/test/build/tests 17:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:01 INFO - https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:20:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:20:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:20:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:03 INFO - Downloaded 1361 bytes. 17:20:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:20:03 INFO - Using the following test package requirements: 17:20:03 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:20:03 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:20:03 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:20:03 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'jsshell-linux-x86_64.zip'], 17:20:03 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:20:03 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:20:03 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:20:03 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:20:03 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:20:03 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:20:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:20:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:03 INFO - https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:20:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:20:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:20:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:04 INFO - Downloaded 24495051 bytes. 17:20:04 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'] 17:20:04 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 17:20:05 INFO - Return code: 0 17:20:05 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 17:20: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')]} 17:20:05 INFO - https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:20:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:20:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:20:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:16 INFO - Downloaded 24495051 bytes. 17:20:16 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'] 17:20:16 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 17:20:17 INFO - Return code: 0 17:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:17 INFO - https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:20:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:20:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:20:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:18 INFO - Downloaded 10833369 bytes. 17:20:18 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'] 17:20:18 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 17:20:18 INFO - Return code: 0 17:20:18 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')]} 17:20:18 INFO - https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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 17:20:20 INFO - Downloaded 63644606 bytes. 17:20:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:20:20 INFO - mkdir: /builds/slave/test/properties 17:20:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:20:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:20:20 INFO - Contents: 17:20:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:20:20 INFO - Running post-action listener: _resource_record_post_action 17:20:20 INFO - Running post-action listener: set_extra_try_arguments 17:20:20 INFO - ##### 17:20:20 INFO - ##### Finished download-and-extract step (success) 17:20:20 INFO - ##### 17:20:20 INFO - ##### 17:20:20 INFO - ##### Running populate-webroot step. 17:20:20 INFO - ##### 17:20:20 INFO - Running pre-action listener: _resource_record_pre_action 17:20:20 INFO - Running main action method: populate_webroot 17:20:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:20:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:20:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:20:20 INFO - '--tppagecycles', 17:20:20 INFO - '7'], 17:20:20 INFO - 'tests': ['tsvgm']}}, 17:20:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:20:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:20:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:20:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:20:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['damp', 'tps']}, 17:20:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'tests': ['damp', 'tps']}, 17:20:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['dromaeo_dom']}, 17:20:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:20:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['a11yr', 17:20:20 INFO - 'ts_paint', 17:20:20 INFO - 'tpaint', 17:20:20 INFO - 'sessionrestore', 17:20:20 INFO - 'sessionrestore_no_auto_restore', 17:20:20 INFO - 'tabpaint']}, 17:20:20 INFO - 'other-e10s': {'tests': ['a11yr', 17:20:20 INFO - 'ts_paint', 17:20:20 INFO - 'tpaint', 17:20:20 INFO - 'sessionrestore', 17:20:20 INFO - 'sessionrestore_no_auto_restore', 17:20:20 INFO - 'tabpaint']}, 17:20:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:20:20 INFO - 'ts_paint', 17:20:20 INFO - 'tpaint', 17:20:20 INFO - 'sessionrestore', 17:20:20 INFO - 'sessionrestore_no_auto_restore', 17:20:20 INFO - 'tabpaint']}, 17:20:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:20:20 INFO - 'ts_paint', 17:20:20 INFO - 'tpaint', 17:20:20 INFO - 'sessionrestore', 17:20:20 INFO - 'sessionrestore_no_auto_restore', 17:20:20 INFO - 'tabpaint']}, 17:20:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['a11yr', 17:20:20 INFO - 'ts_paint', 17:20:20 INFO - 'tpaint', 17:20:20 INFO - 'sessionrestore', 17:20:20 INFO - 'sessionrestore_no_auto_restore', 17:20:20 INFO - 'tabpaint']}, 17:20:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['a11yr', 17:20:20 INFO - 'ts_paint', 17:20:20 INFO - 'tpaint', 17:20:20 INFO - 'sessionrestore', 17:20:20 INFO - 'sessionrestore_no_auto_restore', 17:20:20 INFO - 'tabpaint']}, 17:20:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['tsvgx', 17:20:20 INFO - 'tsvgr_opacity', 17:20:20 INFO - 'tart', 17:20:20 INFO - 'tscrollx', 17:20:20 INFO - 'cart']}, 17:20:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:20:20 INFO - 'tsvgr_opacity', 17:20:20 INFO - 'tart', 17:20:20 INFO - 'tscrollx', 17:20:20 INFO - 'cart']}, 17:20:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'talos_options': ['--disable-e10s'], 17:20:20 INFO - 'tests': ['tp5o']}, 17:20:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'tests': ['tp5o']}, 17:20:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'talos_options': ['--disable-e10s', 17:20:20 INFO - '--xperf_path', 17:20:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:20 INFO - 'tests': ['tp5n']}, 17:20:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:20 INFO - 'talos_options': ['--xperf_path', 17:20:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:20 INFO - 'tests': ['tp5n']}}, 17:20:20 INFO - 'talos.zip': {'path': '', 17:20:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:20:20 INFO - Running post-action listener: _resource_record_post_action 17:20:20 INFO - ##### 17:20:20 INFO - ##### Finished populate-webroot step (success) 17:20:20 INFO - ##### 17:20:20 INFO - ##### 17:20:20 INFO - ##### Running create-virtualenv step. 17:20:20 INFO - ##### 17:20:20 INFO - Running pre-action listener: _resource_record_pre_action 17:20:20 INFO - Running main action method: create_virtualenv 17:20:20 INFO - Creating virtualenv /builds/slave/test/build/venv 17:20:20 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 17:20:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:20:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:20:20 INFO - Using real prefix '/usr' 17:20:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:20:21 INFO - Installing distribute.............................................................................................................................................................................................done. 17:20:23 INFO - Installing pip.................done. 17:20:23 INFO - Return code: 0 17:20:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:20:23 INFO - Using env: {'DISPLAY': ':0', 17:20:23 INFO - 'HOME': '/home/cltbld', 17:20:23 INFO - 'LANG': 'en_US.UTF-8', 17:20:23 INFO - 'LANGUAGE': 'en_US:en', 17:20:23 INFO - 'LOGNAME': 'cltbld', 17:20:23 INFO - 'MAIL': '/var/mail/cltbld', 17:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:23 INFO - 'MOZ_NO_REMOTE': '1', 17:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:23 INFO - 'NO_EM_RESTART': '1', 17:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:23 INFO - 'PWD': '/builds/slave/test', 17:20:23 INFO - 'SHELL': '/bin/bash', 17:20:23 INFO - 'SHLVL': '1', 17:20:23 INFO - 'TERM': 'linux', 17:20:23 INFO - 'TMOUT': '86400', 17:20:23 INFO - 'USER': 'cltbld', 17:20:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:23 INFO - '_': '/tools/buildbot/bin/python'} 17:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:23 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 17:20:23 INFO - Cleaning up... 17:20:23 INFO - Return code: 0 17:20:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:20:23 INFO - Using env: {'DISPLAY': ':0', 17:20:23 INFO - 'HOME': '/home/cltbld', 17:20:23 INFO - 'LANG': 'en_US.UTF-8', 17:20:23 INFO - 'LANGUAGE': 'en_US:en', 17:20:23 INFO - 'LOGNAME': 'cltbld', 17:20:23 INFO - 'MAIL': '/var/mail/cltbld', 17:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:23 INFO - 'MOZ_NO_REMOTE': '1', 17:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:23 INFO - 'NO_EM_RESTART': '1', 17:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:23 INFO - 'PWD': '/builds/slave/test', 17:20:23 INFO - 'SHELL': '/bin/bash', 17:20:23 INFO - 'SHLVL': '1', 17:20:23 INFO - 'TERM': 'linux', 17:20:23 INFO - 'TMOUT': '86400', 17:20:23 INFO - 'USER': 'cltbld', 17:20:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:23 INFO - '_': '/tools/buildbot/bin/python'} 17:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:23 INFO - Downloading/unpacking psutil>=3.1.1 17:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:20:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:25 INFO - Installing collected packages: psutil 17:20:25 INFO - Running setup.py install for psutil 17:20:25 INFO - building 'psutil._psutil_linux' extension 17:20:25 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 17:20:25 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 17:20:25 INFO - building 'psutil._psutil_posix' extension 17:20:25 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 17:20:26 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 17:20:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:26 INFO - Successfully installed psutil 17:20:26 INFO - Cleaning up... 17:20:26 INFO - Return code: 0 17:20:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:20: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 mozsystemmonitor==0.3 17:20:26 INFO - Using env: {'DISPLAY': ':0', 17:20:26 INFO - 'HOME': '/home/cltbld', 17:20:26 INFO - 'LANG': 'en_US.UTF-8', 17:20:26 INFO - 'LANGUAGE': 'en_US:en', 17:20:26 INFO - 'LOGNAME': 'cltbld', 17:20:26 INFO - 'MAIL': '/var/mail/cltbld', 17:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:26 INFO - 'MOZ_NO_REMOTE': '1', 17:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:26 INFO - 'NO_EM_RESTART': '1', 17:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:26 INFO - 'PWD': '/builds/slave/test', 17:20:26 INFO - 'SHELL': '/bin/bash', 17:20:26 INFO - 'SHLVL': '1', 17:20:26 INFO - 'TERM': 'linux', 17:20:26 INFO - 'TMOUT': '86400', 17:20:26 INFO - 'USER': 'cltbld', 17:20:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:26 INFO - '_': '/tools/buildbot/bin/python'} 17:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:20:28 INFO - Installing collected packages: mozsystemmonitor 17:20:28 INFO - Running setup.py install for mozsystemmonitor 17:20:28 INFO - Successfully installed mozsystemmonitor 17:20:28 INFO - Cleaning up... 17:20:28 INFO - Return code: 0 17:20:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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', '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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:20: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 jsonschema==2.5.1 17:20:28 INFO - Using env: {'DISPLAY': ':0', 17:20:28 INFO - 'HOME': '/home/cltbld', 17:20:28 INFO - 'LANG': 'en_US.UTF-8', 17:20:28 INFO - 'LANGUAGE': 'en_US:en', 17:20:28 INFO - 'LOGNAME': 'cltbld', 17:20:28 INFO - 'MAIL': '/var/mail/cltbld', 17:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:28 INFO - 'MOZ_NO_REMOTE': '1', 17:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:28 INFO - 'NO_EM_RESTART': '1', 17:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:28 INFO - 'PWD': '/builds/slave/test', 17:20:28 INFO - 'SHELL': '/bin/bash', 17:20:28 INFO - 'SHLVL': '1', 17:20:28 INFO - 'TERM': 'linux', 17:20:28 INFO - 'TMOUT': '86400', 17:20:28 INFO - 'USER': 'cltbld', 17:20:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:28 INFO - '_': '/tools/buildbot/bin/python'} 17:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:28 INFO - Downloading/unpacking jsonschema==2.5.1 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:20:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:30 INFO - Downloading functools32-3.2.3-2.tar.gz 17:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:20:30 INFO - warning: no files found matching '*.txt' 17:20:30 INFO - no previously-included directories found matching 'build' 17:20:30 INFO - no previously-included directories found matching 'dist' 17:20:30 INFO - no previously-included directories found matching '.git*' 17:20:30 INFO - Installing collected packages: jsonschema, functools32 17:20:30 INFO - Running setup.py install for functools32 17:20:30 INFO - warning: no files found matching '*.txt' 17:20:30 INFO - no previously-included directories found matching 'build' 17:20:30 INFO - no previously-included directories found matching 'dist' 17:20:30 INFO - no previously-included directories found matching '.git*' 17:20:31 INFO - Successfully installed jsonschema functools32 17:20:31 INFO - Cleaning up... 17:20:31 INFO - Return code: 0 17:20:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:31 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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:31 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 17:20:31 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 17:20:31 INFO - Using env: {'DISPLAY': ':0', 17:20:31 INFO - 'HOME': '/home/cltbld', 17:20:31 INFO - 'LANG': 'en_US.UTF-8', 17:20:31 INFO - 'LANGUAGE': 'en_US:en', 17:20:31 INFO - 'LOGNAME': 'cltbld', 17:20:31 INFO - 'MAIL': '/var/mail/cltbld', 17:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:31 INFO - 'MOZ_NO_REMOTE': '1', 17:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:31 INFO - 'NO_EM_RESTART': '1', 17:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:31 INFO - 'PWD': '/builds/slave/test', 17:20:31 INFO - 'SHELL': '/bin/bash', 17:20:31 INFO - 'SHLVL': '1', 17:20:31 INFO - 'TERM': 'linux', 17:20:31 INFO - 'TMOUT': '86400', 17:20:31 INFO - 'USER': 'cltbld', 17:20:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:31 INFO - '_': '/tools/buildbot/bin/python'} 17:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:31 INFO - Downloading/unpacking blobuploader==1.2.4 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:20:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:20:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:33 INFO - Downloading docopt-0.6.1.tar.gz 17:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:20:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:20:33 INFO - Running setup.py install for blobuploader 17:20:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:20:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:20:34 INFO - Running setup.py install for requests 17:20:34 INFO - Running setup.py install for docopt 17:20:34 INFO - Successfully installed blobuploader requests docopt 17:20:34 INFO - Cleaning up... 17:20:34 INFO - Return code: 0 17:20:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:34 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')]} 17:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:34 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')]} 17:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:34 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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:34 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 17:20:34 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 17:20:34 INFO - Using env: {'DISPLAY': ':0', 17:20:34 INFO - 'HOME': '/home/cltbld', 17:20:34 INFO - 'LANG': 'en_US.UTF-8', 17:20:34 INFO - 'LANGUAGE': 'en_US:en', 17:20:34 INFO - 'LOGNAME': 'cltbld', 17:20:34 INFO - 'MAIL': '/var/mail/cltbld', 17:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:34 INFO - 'MOZ_NO_REMOTE': '1', 17:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:34 INFO - 'NO_EM_RESTART': '1', 17:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:34 INFO - 'PWD': '/builds/slave/test', 17:20:34 INFO - 'SHELL': '/bin/bash', 17:20:34 INFO - 'SHLVL': '1', 17:20:34 INFO - 'TERM': 'linux', 17:20:34 INFO - 'TMOUT': '86400', 17:20:34 INFO - 'USER': 'cltbld', 17:20:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:34 INFO - '_': '/tools/buildbot/bin/python'} 17:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:34 INFO - Running setup.py (path:/tmp/pip-ZoE99P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:34 INFO - Running setup.py (path:/tmp/pip-8MAZYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:34 INFO - Running setup.py (path:/tmp/pip-p58nBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:34 INFO - Running setup.py (path:/tmp/pip-3RljYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:35 INFO - Running setup.py (path:/tmp/pip-X5O1nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:35 INFO - Running setup.py (path:/tmp/pip-OQjXo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:35 INFO - Running setup.py (path:/tmp/pip-axOxoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:35 INFO - Running setup.py (path:/tmp/pip-PGz9xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:35 INFO - Running setup.py (path:/tmp/pip-Iqpt3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:35 INFO - Running setup.py (path:/tmp/pip-UE6KXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:35 INFO - Running setup.py (path:/tmp/pip-Z3r8Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:35 INFO - Running setup.py (path:/tmp/pip-Ajb0q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:35 INFO - Running setup.py (path:/tmp/pip-vt__mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:35 INFO - Running setup.py (path:/tmp/pip-4JyuEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:35 INFO - Running setup.py (path:/tmp/pip-BIxYWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:35 INFO - Running setup.py (path:/tmp/pip-z5ToMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:35 INFO - Running setup.py (path:/tmp/pip-6pmTdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:20:35 INFO - Running setup.py install for manifestparser 17:20:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Running setup.py install for mozcrash 17:20:36 INFO - Running setup.py install for mozdebug 17:20:36 INFO - Running setup.py install for mozdevice 17:20:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Running setup.py install for mozfile 17:20:36 INFO - Running setup.py install for mozhttpd 17:20:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Running setup.py install for mozinfo 17:20:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Running setup.py install for mozInstall 17:20:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:20:36 INFO - Running setup.py install for mozleak 17:20:36 INFO - Running setup.py install for mozlog 17:20:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:20:37 INFO - Running setup.py install for moznetwork 17:20:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:20:37 INFO - Running setup.py install for mozprocess 17:20:37 INFO - Running setup.py install for mozprofile 17:20:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:20:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:20:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:20:37 INFO - Running setup.py install for mozrunner 17:20:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:20:37 INFO - Running setup.py install for mozscreenshot 17:20:37 INFO - Running setup.py install for moztest 17:20:37 INFO - Running setup.py install for mozversion 17:20:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:20:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:20:37 INFO - Cleaning up... 17:20:37 INFO - Return code: 0 17:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:37 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')]} 17:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:37 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')]} 17:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:37 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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:37 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 17:20:37 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 17:20:37 INFO - Using env: {'DISPLAY': ':0', 17:20:37 INFO - 'HOME': '/home/cltbld', 17:20:37 INFO - 'LANG': 'en_US.UTF-8', 17:20:37 INFO - 'LANGUAGE': 'en_US:en', 17:20:37 INFO - 'LOGNAME': 'cltbld', 17:20:37 INFO - 'MAIL': '/var/mail/cltbld', 17:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:37 INFO - 'MOZ_NO_REMOTE': '1', 17:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:37 INFO - 'NO_EM_RESTART': '1', 17:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:37 INFO - 'PWD': '/builds/slave/test', 17:20:37 INFO - 'SHELL': '/bin/bash', 17:20:37 INFO - 'SHLVL': '1', 17:20:37 INFO - 'TERM': 'linux', 17:20:37 INFO - 'TMOUT': '86400', 17:20:37 INFO - 'USER': 'cltbld', 17:20:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:37 INFO - '_': '/tools/buildbot/bin/python'} 17:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:37 INFO - Running setup.py (path:/tmp/pip-7r1I7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:38 INFO - Running setup.py (path:/tmp/pip-kWKoBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:38 INFO - Running setup.py (path:/tmp/pip-lrG26q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:38 INFO - Running setup.py (path:/tmp/pip-f4b80T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:38 INFO - Running setup.py (path:/tmp/pip-PFZ2i3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:38 INFO - Running setup.py (path:/tmp/pip-fh75ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:38 INFO - Running setup.py (path:/tmp/pip-vpcErt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:38 INFO - Running setup.py (path:/tmp/pip-erZBMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:38 INFO - Running setup.py (path:/tmp/pip-ochejt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:38 INFO - Running setup.py (path:/tmp/pip-vNk32K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:38 INFO - Running setup.py (path:/tmp/pip-ek6vwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:38 INFO - Running setup.py (path:/tmp/pip-AIc3jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:38 INFO - Running setup.py (path:/tmp/pip-pikKUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:38 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)) 17:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:38 INFO - Running setup.py (path:/tmp/pip-isJl3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:39 INFO - Running setup.py (path:/tmp/pip-sJsw0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:39 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)) 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:39 INFO - Running setup.py (path:/tmp/pip-6WZ3fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:39 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)) 17:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:39 INFO - Running setup.py (path:/tmp/pip-PnF4GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:39 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)) 17:20:39 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)) 17:20:39 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)) 17:20:39 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)) 17:20:39 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)) 17:20:39 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)) 17:20:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:41 INFO - Downloading blessings-1.6.tar.gz 17:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:41 INFO - Installing collected packages: blessings 17:20:41 INFO - Running setup.py install for blessings 17:20:41 INFO - Successfully installed blessings 17:20:41 INFO - Cleaning up... 17:20:41 INFO - Return code: 0 17:20:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:41 INFO - Reading from file tmpfile_stdout 17:20:41 INFO - Current package versions: 17:20:41 INFO - argparse == 1.2.1 17:20:41 INFO - blessings == 1.6 17:20:41 INFO - blobuploader == 1.2.4 17:20:41 INFO - docopt == 0.6.1 17:20:41 INFO - functools32 == 3.2.3-2 17:20:41 INFO - jsonschema == 2.5.1 17:20:41 INFO - manifestparser == 1.1 17:20:41 INFO - mozInstall == 1.12 17:20:41 INFO - mozcrash == 0.17 17:20:41 INFO - mozdebug == 0.1 17:20:41 INFO - mozdevice == 0.48 17:20:41 INFO - mozfile == 1.2 17:20:41 INFO - mozhttpd == 0.7 17:20:41 INFO - mozinfo == 0.9 17:20:41 INFO - mozleak == 0.1 17:20:41 INFO - mozlog == 3.2 17:20:41 INFO - moznetwork == 0.27 17:20:41 INFO - mozprocess == 0.23 17:20:41 INFO - mozprofile == 0.28 17:20:41 INFO - mozrunner == 6.12 17:20:41 INFO - mozscreenshot == 0.1 17:20:41 INFO - mozsystemmonitor == 0.3 17:20:41 INFO - moztest == 0.7 17:20:41 INFO - mozversion == 1.4 17:20:41 INFO - psutil == 3.1.1 17:20:41 INFO - requests == 1.2.3 17:20:41 INFO - wsgiref == 0.1.2 17:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:41 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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:41 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 17:20:41 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 17:20:41 INFO - Using env: {'DISPLAY': ':0', 17:20:41 INFO - 'HOME': '/home/cltbld', 17:20:41 INFO - 'LANG': 'en_US.UTF-8', 17:20:41 INFO - 'LANGUAGE': 'en_US:en', 17:20:41 INFO - 'LOGNAME': 'cltbld', 17:20:41 INFO - 'MAIL': '/var/mail/cltbld', 17:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:41 INFO - 'MOZ_NO_REMOTE': '1', 17:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:41 INFO - 'NO_EM_RESTART': '1', 17:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:41 INFO - 'PWD': '/builds/slave/test', 17:20:41 INFO - 'SHELL': '/bin/bash', 17:20:41 INFO - 'SHLVL': '1', 17:20:41 INFO - 'TERM': 'linux', 17:20:41 INFO - 'TMOUT': '86400', 17:20:41 INFO - 'USER': 'cltbld', 17:20:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:41 INFO - '_': '/tools/buildbot/bin/python'} 17:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 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)) 17:20:41 INFO - Cleaning up... 17:20:41 INFO - Return code: 0 17:20:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:41 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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:41 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 17:20:41 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 17:20:41 INFO - Using env: {'DISPLAY': ':0', 17:20:41 INFO - 'HOME': '/home/cltbld', 17:20:41 INFO - 'LANG': 'en_US.UTF-8', 17:20:41 INFO - 'LANGUAGE': 'en_US:en', 17:20:41 INFO - 'LOGNAME': 'cltbld', 17:20:41 INFO - 'MAIL': '/var/mail/cltbld', 17:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:41 INFO - 'MOZ_NO_REMOTE': '1', 17:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:41 INFO - 'NO_EM_RESTART': '1', 17:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:41 INFO - 'PWD': '/builds/slave/test', 17:20:41 INFO - 'SHELL': '/bin/bash', 17:20:41 INFO - 'SHLVL': '1', 17:20:41 INFO - 'TERM': 'linux', 17:20:41 INFO - 'TMOUT': '86400', 17:20:41 INFO - 'USER': 'cltbld', 17:20:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:41 INFO - '_': '/tools/buildbot/bin/python'} 17:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:20:42 INFO - Cleaning up... 17:20:42 INFO - Return code: 0 17:20:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:20:42 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')]} 17:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:42 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')]} 17:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:42 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 0x7f91b4376f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', '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 17:20:42 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 17:20:42 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 17:20:42 INFO - Using env: {'DISPLAY': ':0', 17:20:42 INFO - 'HOME': '/home/cltbld', 17:20:42 INFO - 'LANG': 'en_US.UTF-8', 17:20:42 INFO - 'LANGUAGE': 'en_US:en', 17:20:42 INFO - 'LOGNAME': 'cltbld', 17:20:42 INFO - 'MAIL': '/var/mail/cltbld', 17:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:42 INFO - 'MOZ_NO_REMOTE': '1', 17:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:42 INFO - 'NO_EM_RESTART': '1', 17:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:42 INFO - 'PWD': '/builds/slave/test', 17:20:42 INFO - 'SHELL': '/bin/bash', 17:20:42 INFO - 'SHLVL': '1', 17:20:42 INFO - 'TERM': 'linux', 17:20:42 INFO - 'TMOUT': '86400', 17:20:42 INFO - 'USER': 'cltbld', 17:20:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:42 INFO - '_': '/tools/buildbot/bin/python'} 17:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:42 INFO - Downloading/unpacking flake8 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:20:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:20:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 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 17:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:44 INFO - no previously-included directories found matching 'docs/_build' 17:20:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:20:44 INFO - Running setup.py install for pep8 17:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:44 INFO - no previously-included directories found matching 'docs/_build' 17:20:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:20:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:20:45 INFO - Cleaning up... 17:20:45 INFO - Return code: 0 17:20:45 INFO - Running post-action listener: _resource_record_post_action 17:20:45 INFO - Running post-action listener: _start_resource_monitoring 17:20:45 INFO - Starting resource monitoring. 17:20:45 INFO - ##### 17:20:45 INFO - ##### Finished create-virtualenv step (success) 17:20:45 INFO - ##### 17:20:45 INFO - ##### 17:20:45 INFO - ##### Running install step. 17:20:45 INFO - ##### 17:20:45 INFO - Running pre-action listener: _resource_record_pre_action 17:20:45 INFO - Running main action method: install 17:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:45 INFO - Reading from file tmpfile_stdout 17:20:45 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:45 INFO - Reading from file tmpfile_stdout 17:20:45 INFO - Output received: 17:20:45 INFO - Usage: mozinstall [options] installer 17:20:45 INFO - Options: 17:20:45 INFO - -h, --help show this help message and exit 17:20:45 INFO - -d DEST, --destination=DEST 17:20:45 INFO - Directory to install application into. [default: 17:20:45 INFO - "/builds/slave/test"] 17:20:45 INFO - --app=APP Application being installed. [default: firefox] 17:20:45 INFO - mkdir: /builds/slave/test/build/application 17:20:45 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'] 17:20:45 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 17:21:01 INFO - Reading from file tmpfile_stdout 17:21:01 INFO - Output received: 17:21:01 INFO - /builds/slave/test/build/application/firefox/firefox 17:21:01 INFO - Running post-action listener: _resource_record_post_action 17:21:01 INFO - ##### 17:21:01 INFO - ##### Finished install step (success) 17:21:01 INFO - ##### 17:21:01 INFO - ##### 17:21:01 INFO - ##### Running run-tests step. 17:21:01 INFO - ##### 17:21:01 INFO - Running pre-action listener: _resource_record_pre_action 17:21:01 INFO - Running main action method: run_tests 17:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:21:01 INFO - Python 2.7.3 17:21:01 INFO - Return code: 0 17:21:01 INFO - grabbing minidump binary from tooltool 17:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:01 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 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:21:01 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 17:21:01 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 17:21:01 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 17:21:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:21:01 INFO - Return code: 0 17:21:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:21:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:21:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:21:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:21:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:21:02 INFO - Return code: 0 17:21:02 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/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 17:21:02 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/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 17:21:02 INFO - Using env: {'DISPLAY': ':0', 17:21:02 INFO - 'HOME': '/home/cltbld', 17:21:02 INFO - 'LANG': 'en_US.UTF-8', 17:21:02 INFO - 'LANGUAGE': 'en_US:en', 17:21:02 INFO - 'LOGNAME': 'cltbld', 17:21:02 INFO - 'MAIL': '/var/mail/cltbld', 17:21:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:21:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:02 INFO - 'MOZ_NO_REMOTE': '1', 17:21:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:02 INFO - 'NO_EM_RESTART': '1', 17:21:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:02 INFO - 'PWD': '/builds/slave/test', 17:21:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:21:02 INFO - 'SHELL': '/bin/bash', 17:21:02 INFO - 'SHLVL': '1', 17:21:02 INFO - 'TERM': 'linux', 17:21:02 INFO - 'TMOUT': '86400', 17:21:02 INFO - 'USER': 'cltbld', 17:21:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922', 17:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:02 INFO - '_': '/tools/buildbot/bin/python'} 17:21:02 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/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 17:21:02 INFO - mozversion application_buildid: 20160728144757 17:21:02 INFO - mozversion application_changeset: 29dda3d9dfcb2ac4b7e84f69bb1649af99089f19 17:21:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:21:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:21:02 INFO - mozversion application_name: Firefox 17:21:02 INFO - mozversion application_remotingname: firefox-dev 17:21:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:21:02 INFO - mozversion application_vendor: Mozilla 17:21:02 INFO - mozversion application_version: 49.0a2 17:21:02 INFO - mozversion platform_buildid: 20160728144757 17:21:02 INFO - mozversion platform_changeset: 29dda3d9dfcb2ac4b7e84f69bb1649af99089f19 17:21:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:21:02 INFO - mozversion platform_version: 49.0a2 17:21:02 INFO - using testdate: 1469751662 17:21:02 INFO - actual date: 1469751662 17:21:02 INFO - starting webserver on 'localhost:60103' 17:21:02 INFO - SUITE-START | Running 2 tests 17:21:02 INFO - TEST-START | dromaeo_css 17:21:02 INFO - operating with platform_type : linux_ 17:21:02 INFO - Initialising browser for dromaeo_css test... 17:21:02 INFO - TEST-INFO | started process 20553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY02d8m/profile http://localhost:60103/getInfo.html) 17:21:06 INFO - PROCESS | 20553 | __metrics Screen width/height:1600/1200 17:21:06 INFO - PROCESS | 20553 | colorDepth:24 17:21:06 INFO - PROCESS | 20553 | Browser inner width/height: 1024/697 17:21:06 INFO - PROCESS | 20553 | __metrics 17:21:07 ERROR - PROCESS | 20553 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:21:08 INFO - TEST-INFO | 20553: exit 0 17:21:08 INFO - Browser initialized. 17:21:08 INFO - Running cycle 1/1 for dromaeo_css test... 17:21:08 INFO - TEST-INFO | started process 20680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY02d8m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:20 INFO - PROCESS | 20680 | RSS: Main: 155754496 17:21:20 INFO - PROCESS | 20680 | 17:22:09 INFO - PROCESS | 20680 | 1469751729809 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] 17:24:17 INFO - PROCESS | 20680 | Cycle 1(1): loaded http://localhost:60103/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60103/tests/dromaeo/cssquery-ext.html) 17:24:18 INFO - PROCESS | 20680 | RSS: Main: 159752192 17:24:18 INFO - PROCESS | 20680 | 17:27:20 INFO - PROCESS | 20680 | Cycle 1(1): loaded http://localhost:60103/tests/dromaeo/cssquery-ext.html (next: http://localhost:60103/tests/dromaeo/cssquery-jquery.html) 17:27:21 INFO - PROCESS | 20680 | RSS: Main: 157405184 17:27:21 INFO - PROCESS | 20680 | 17:30:23 INFO - PROCESS | 20680 | Cycle 1(1): loaded http://localhost:60103/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60103/tests/dromaeo/cssquery-mootools.html) 17:30:23 INFO - PROCESS | 20680 | RSS: Main: 157093888 17:30:23 INFO - PROCESS | 20680 | 17:33:25 INFO - PROCESS | 20680 | Cycle 1(1): loaded http://localhost:60103/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60103/tests/dromaeo/cssquery-prototype.html) 17:33:26 INFO - PROCESS | 20680 | RSS: Main: 156487680 17:33:26 INFO - PROCESS | 20680 | 17:36:28 INFO - PROCESS | 20680 | Cycle 1(1): loaded http://localhost:60103/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60103/tests/dromaeo/cssquery-yui.html) 17:36:29 INFO - PROCESS | 20680 | RSS: Main: 158691328 17:36:29 INFO - PROCESS | 20680 | 17:39:31 INFO - PROCESS | 20680 | Cycle 1(1): loaded http://localhost:60103/tests/dromaeo/cssquery-yui.html (next: http://localhost:60103/tests/dromaeo/cssquery-dojo.html) 17:39:32 INFO - PROCESS | 20680 | RSS: Main: 158806016 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | __start_tp_report 17:39:32 INFO - PROCESS | 20680 | _x_x_mozilla_page_load 17:39:32 INFO - PROCESS | 20680 | _x_x_mozilla_page_load_details 17:39:32 INFO - PROCESS | 20680 | |i|pagename|runs| 17:39:32 INFO - PROCESS | 20680 | |0;dojo.html;3346.9832650836747;3358.4290670586006;3377.8311084445772;3379.864805407784;3401.948970765439;5668.093105103179;5682.829515114543;5697.173909783084;5731.856703582413;5763.798267060653;5676.205331253628;5693.402192769751;5725.7995970141055;5727.828165155052;5802.506786923117;5115.846524604259;5182.637215394924;5234.92147617786;5243.2659427680155;5247.86880327991;5049.671771334852;5063.291139240491;5217.113090774577;5291.550218231455;5332.840014799563;5215;5221.034108689904;5223.608229382792;5231.136862417697;5231.163013917774;5251.527362537371;5274.182501712203;5276.868078298054;5280.419153893069;5289.656172348785;5050.292958985745;5064.215046667772;5096.745162741848;5167.224916262553;5179.119549676564;5500.312460942382;5505.834824955257;5537.418571050062;5541.196526503675;5555.805546805843;6018.127371531147;6082.209312789353;6088.11722300264;6100.816975490698;6105.32841387447;5881.735321910524;6057;6069.241344831896;6104.20645316106;6131.816045518642;5714.771409143629;5722.399148089474;5724.427557244284;5728.3126024876865;5765.7981970631245;6246.250449946036;6247.875042499125;6265.248170219603;6267.592606480564;6272.749090036347;5850.23946886902;5946.137810017523;5991.700414979321;6035;6099.969500152471;6163.445289923929;6189.288231853305;6190.102435146879;6199.3490683478485;6231.470325022424;5949.851253718605;6098.32918378978;6168.0439531872635;6179.443850053517;6190.380961903774;5982.4316689914385;6062.454379105901;6073;6073.119397687311;6108.8778224436155;4638.095571363552;4644.210484217691;4654.045920586272;4665.533446655375;4675.672702910763;4122.237386083584;4138.172365526907;4139.110091330378;4153.7300075495605;4202.2646036943415;5592.748326325325;5688.943110568841;5700.144978253213;5889.528837692974;5890.587658863838;6142.04798256271;6142.754289828446;6145.354737752561;6183.3816618337805;6190.938090619126;5670.121131224667;5707.0583353747;5708.942910570924;5762.88474230513;5790.507806836466;5171.379434467888;5212.582993360522;5214.191800270964;5215.426303106731;5230.424653288135;6148;6202.72087756052;6214.937850621526;6217;6226.159468471789;6106.725197366218;6120.020796672511;6123.081537769282;6197.318294987638;6232.5948813328805;6157.784477543264;6174.536909731698;6178.721957511832;6207.6275423474735;6208.689565521796;5860;5994.790182343597;6095.238095238095;6099.756009759737;6101.877962440638;6111.174991376108;6186.133941248138;6190.690465476799;6200.131981522681;6220.657863817352;6041.909371359346;6048.559842982584;6055.303640081271;6079.939200607937;6086.421789929949;5726.026575482095;5928.703564821655;5995.2206213192;6023.45788879003;6040.6677632730625;5894.764209431574;5927.2590926134235;5930.614510056833;5932.644041357532;5934.584579079423;5964.731587078505;6019.097135429721;6077.665728384981;6107.297660768891;6115.694215289307;5813.680247586254;5838.416158384128;5875.676837773793;5901.527877769854;5966.105084237399 17:39:32 INFO - PROCESS | 20680 | |1;ext.html;551.253052114385;630.5806638585341;648.2286079565317;665.3413121010199;679.3851564334273;40905.59094409055;45259;45281.32078018824;45420.41028564005;45513;45963.540364596425;46672.76663616686;46766.29850552244;46895.29657055147;46939.76530117353;8818.426802257849;8991.775205619879;8995.95502022489;8997.595108220146;9021.278297736199;8950.552472376388;8953.507557084358;8962.641494340218;8996.8650470243;9033.683821066264;9035.638574457014;9094.1360570746;9118.954405227965;9132.817343653123;9145.314101442385;9054.32092593055;9082.954585227099;9084.182423581877;9128.315376346734;9135.269178465707;8891.244244239248;8906.198442140174;8965.103489650983;8970.910290897073;8978.281737460988;41916.1616767666;42022.36966445506;42155.367669484986;42401.78799105985;42524.1495170098;3189.856456459465;3745.419459983707;3771;3810.2760475509563;3866.555346135174;33757.83121084404;34072.31855362903;34303.4854477183;34326.82836585826;34380.14049648754;4562.954370456286;4801.135795556798;4830.3237546743485;4991.975040124777;5038.470960549163;363805;364792;365299;366636;369728;67307.32692673011;67558.66220668865;67815;67884.6605766968;68079.3192068073;34491.31017379638;35088.64911350854;35155;35201.47197792035;71131;17568.121593920252;17725.113744312992;17727.73408398875;17773;17800.9109954452;13497.662558436117;13512.59462216135;13606.727865442635;13616.455341786217;13667.863321366858;21108.788912110682;21282.680759788615;21386.893065534572;21547.892260538596;21566.784332156793;7453.217412171753;7470.439717021137;7472.738454154079;7589.8861517077285;7740.303372696484;1082.8862969388101;1103.382344886652;1105.2926127278547;1128.1031579894004;1225.436299302331;32799.344013119604;32857.50713739296;33035.834820826225;33777.32445351128;33809.492857607154;1192.1714408486018;1198.1553005131536;1212.3029258176407;1265.3356987581594;1282.602393258093;17334.739978900325;17344.392946246822;17684.46946591604;17740.01445194707;17932.193051312723;564620;575825;578870;581628;624740;65943.67028164829;66290.33709662841;66705;66802.66598666976;66823.33176668268;1494.8206215254238;1499.430216517738;1501.06183635228;1507.2991059157544;1518.7038527487255;32654.183645409055;33133;33376.49935250924;33927.830360848035;34204.31591368208;55886.441135588124;56286.43713562812;56557.71721141368;56576;56631.43368566262;439365;443937;444059;448887;449349;30825.845870770503;30949.845250773604;31522.684773151974;31607.367852643278;31827.68172318247;51180.232296514834;51632.22551661803;51636.48363516467;51738.482615173365;52735.20897186622;43274;44012.11975760531;44081.55918440774;45254.32118518159;45386.77306613578;42503;43199.35200972051;43303.133937321705;44079.11841763211;44459.777701111285;42896;43509.12981740411;43693.78153109214;44020.11959760851;44240.77879610581;37019.25961480809;37260.254794903405;38229.4265586022;38720.80639596784;38784;29290;29504.262393440335;29685.85157074201;29839;30026.399472010875 17:39:32 INFO - PROCESS | 20680 | |2;jquery.html;406.5304573217932;412.97522148671084;416.0866897160731;416.591740094707;425.6828662646329;18441.631167376643;19451;20277;20281.08735106918;20378.592428151427;12373.319467429288;17067.91466042671;18854.71717924229;19754.40736777899;19831.702524462144;5086.669366491175;5220.347456567929;5231.686098834082;5259.237410575464;5281.471852814726;5125.077486052509;5180.870478238036;5189.247559103927;5189.299444574972;5198.220266959967;5202.453742357055;5229.633925625208;5236.136037553818;5252.868678283055;5268.209768534713;5082.567981721558;5144.459831717691;5166.4575219601775;5187.066328060948;5219.817306394258;4932.260160975882;4996.025774973881;5049.949500505021;5054.090263752523;5054.898902021976;13041;18282.634347313113;23502.059917603274;23971.640425393634;24067.39831504209;2455.5579995600783;2473.8763061847017;2547.9872600637063;2669.0258055809686;2881.726236007576;10066.748331291703;10143.746406339827;10458.424786636731;10939.56241750329;15685.92157039219;2007.5483016321211;2049.80526849949;2067;2095.371388583434;2134.3810295014428;81530;83009.75485367724;83059.16940830635;84583.57708211482;85709.86715090326;11121.666350009513;11161.553537858395;11282.774344513227;11418.314901105794;11449.484773185226;13175.60473185806;15640.765388519181;15655.608609784846;15829.129397882996;15858.52424427269;8183.95908020456;8441.788955276044;8659.04750477447;8874.511901845332;8964.238039766562;8744.737657870273;8775.956120219485;8808.779780505538;8821.911780882238;8829;4979.153543897473;5057.468965758542;5112.309838171874;5172.612054095883;5178.093833579109;1859.0890463672704;1881.9811801882079;2078.3349328214827;2099.433153048699;2109.4831766217067;980.3039841712464;1032.4837581209395;1044.4539495280087;1063.8935507072713;1075.5052675769077;19230.326938557082;19435.514112147026;19599.902000489907;19996.50008749764;20361.592768144554;1048.6120135549743;1091.6670415523342;1092.088106431123;1120.9047230985295;1152.8501294831617;10737.194710396752;11085.778284434266;11146.275492092987;11173.385463799406;11224.775504489864;505035;507398;514170;514879;518400;95505.52247238858;98445;99226.5038674802;100703;102125;1113.0872684398878;1135.7558125003163;1138.299945533491;1142.4516232208753;1162.1864694713734;18046.819531804515;18237.270509179485;18264.908675456536;18387.172577234323;18567.16447759881;33449.83275083609;42323.57676423319;42969.570304296554;43148.352774707775;43849;56501;57649;57977;59657.701711491165;60067;8447.690607955778;8587;8751.695728007824;8767.561621919007;8808.691695790616;12430.813537797121;13097.148685335804;13754.65613359674;13789;13816.723665526431;11478.655640330804;11496.88503114958;11497.48261328259;11912.047036237254;12006.519739210335;11865.288082715064;11902.345371004332;11992.76014479723;12010.09924255667;12232.388380581113;11822.34977076269;11849.466773995364;11900.166988310735;11967.940160299142;11975.341356225492;7588.241175882367;8666.393352465268;8740.388172827841;8771.254443372385;9296.39573427725;10816.837747433638;11577.7105572358;11887.524499020288;12451.75096498083;12604.495820167458 17:39:32 INFO - PROCESS | 20680 | |3;mootools.html;1554.4015554011705;1587.8650314723247;1801.882877612955;1871.8034606366339;1926.383557261676;8340.33277337813;9044.773880652987;9108.54457277136;9715.417074975498;9726.902730972688;9083.046280140588;9214.585343659535;9337;9345.345825792181;9452.66915657952;2423.151896836111;2449.1428000199876;2466.938326541833;2475.418276704973;2477.6283557466345;2431.4407686232175;2496.988719568578;2508.8745562721883;2517.5342561626067;2519.0427637497723;2424.2242482405636;2444.6577479152934;2471.283327834926;2479.85120892747;2481.5285095831823;2260.3445000949705;2261.3781210167335;2299.0792739644994;2309.7805708457668;2317;2322.1175953137868;2323.3262353917344;2343.285297984114;2344.2264052862515;2355.62310030396;9371.062893710643;9402.43585384879;9482.288828337902;9520.571574279174;9531.523423828781;5526.530244929186;5671.7731290748325;5677.858053548653;5679.801206957736;5689.943100568983;3396.218869659992;3478.3391155680592;3493.423585108454;3558.19940513385;3574.696150827157;1168.0830548019765;1173.0556901694133;1173.0791328806845;1183.0476466444509;1183.9822402663967;13529.526466573721;13546.525871594546;13589;13611.659708507268;13676.794848077287;4730.373689541835;4825.30033145192;4856.975715121402;4867.099586576494;4904.681195722266;10623.787524249472;10628.096611788085;10660.893391066145;10662.786744265071;10666.253362264722;5553.6390134641115;5649.0396632572565;5651.378348381675;5666.433356664301;5669.574781891375;4961.826336078292;5143.614228932845;5144.511271429208;5211.374635043743;5267.26258323835;4171.040660648068;4184.476940382452;4192.580741925844;4222.767747773902;4234.788260586958;1247.3700781105483;1253.786856234424;1260.9054320925784;1271.9682007949875;1278.3352656618506;1051.705522453699;1053.2942928238099;1058.6823952814125;1077.3482043363808;1102.779444111181;6434.74261029563;6541.542092053605;6595.769148079794;6673.499487538454;6772.423426120003;472.1878369204962;472.36466951949575;479.80567870012703;481.67727622493015;483.75570336980303;4467.218236808546;4553.772311384418;4555.886102847389;4557.749323787158;4560.771961401917;11871.88128118725;12159;12174.269543827222;12231.082668799876;12292.877071229352;11282.379469129113;11994.64016079519;12062.276263424223;12078.939605302094;12132.757344853053;8591.785205369792;8915.598798054232;8995.28037756978;9023.142801433853;9042.63829446828;6543.607383557001;6646.534742567974;6674.599524028574;6733.966330168318;6803.081583986296;10866.239363244496;10912.236143469881;11053.00522952938;11065.778684426428;11076.889231107909;11159;11172.329660220414;11243;11255;11306;8300.501969881827;8471.830563388574;8719.38964272495;8800.295976322006;8805.031446540746;9210.815783684422;9260.675876344565;9302.720918372459;9334.206592439446;9354.25165986733;8218.917810821815;8282.130376310643;8306.792330191553;8313.83372332562;8482.194191551793;8129.512229266263;8157.778120783258;8161.755147345589;8172.141925098017;8327.167283271625;7476.065491813523;7634.656440460081;7664.846703066019;7681.6543255552515;7683.692652293846;5663.377028526941;5726.198332233407;5828.94171058284;5835.7373918174635;5889.587728858939;5815.82552523425;5853.297604287342;5880.176775251382;5921.3782552831335;5936.465718085393 17:39:32 INFO - PROCESS | 20680 | |4;prototype.html;339.3704677822638;339.6128413608486;341.7539371652411;348.8569686428565;350.40256362901255;5715.57133215009;5726.255586773719;5760.89727249554;5776.913346299803;5807.303123625171;5600.355959064709;5637.436256374361;5640.210370548127;5670.773169073233;5705.942940570593;4067.837286508536;4150.875473735793;4354.08564201518;4378.737275763465;4386.583274588925;4345.283028300327;4358.2808836541935;4394.802233899482;4412.82348706053;4427.734335939837;4351.825926962933;4358.912821743564;4383.298672212447;4393.450818647669;4400.229959757045;4139.19285739281;4365.257906155961;4378.671599630041;4427.5572442755465;4433.534478879736;3905.7070719696135;3918.7256892017285;3923.98038009811;3934.9606503935165;3940.251352243093;5480.369757477902;5481.588880833953;5486.698231597261;5499.670019798825;5527.695976721278;4961.3798275215595;5068.518490743373;5086.745662716887;5114.846554603368;5128.282040514331;5876;5909.1976947031135;5916.319623243339;5945.732442040118;5965.582409231356;4342.869713908588;4350.456192975878;4351.477822661301;4352.89117772055;4361;5979.372165922559;6034.30605480371;6197.969010154966;6225.408586184305;6234.064890266451;4302.7848607569495;4317.892052698645;4320.265554855682;4324.805383757738;4337.609615134653;4341.37050127736;4376.299792033259;4390.1878152541885;4391.143726973273;4409.206342858316;4887.892376681614;4974.477679843637;5022.020705962375;5025.195968645073;5034.194528875362;5889.322727886262;5919.01712926166;5942.494887934487;5954.4045595440975;5958.76164953397;1535.5930678370019;1554.3704799556199;1563.7654351847314;1566.592685901651;1570.6701592665668;983.9803203935882;1011.5043628622069;1012.6733978488204;1018;1033.1992705653179;5032.72320022395;5039.899202015939;5068.873278168076;5075.3402057732255;5096.439391666913;5264.868378290574;5392.78428862849;5462.634341414647;5472.452754724575;5507.228987941691;4884.36244428012;4953.7275449849885;5036.597072234213;5057.620678449131;5139.743012849342;2821.39340041892;2870.0098466029185;2895.928506452626;2934.1637633274413;2940.5148150555347;5389.784408623611;5421.834305624309;5435;5447.428020057916;5462.317210348707;5256.474352564713;5372.167314066326;5453.191606322747;5474.315710536183;5487;5445.754941027663;5458.836234912959;5465.262189604432;5522.723863806794;5601.29983752031;5113.693178409308;5265.305310086752;5374.145919657712;5458.662627656091;5528.115501519737;5325.307709997831;5340.412554619066;5347.700488789857;5354.607801971438;5407.810726624549;6064.636121832704;6179.134921111138;6192.721327540362;6213.689315534296;6332.620042797447;4368.51946285902;4404.009097952935;4408.73547587133;4409.581089796464;4435.489918659267;5948.345681974893;6209.813705588839;6302.936970630235;6326.525510586633;6331.778387756406;6020.578559500793;6045.3073139521;6060.545459090674;6089.817305480843;6096.390360963868;6011.338752737108;6037.486813620892;6057.363976782374;6067.150598916243;6090.725917333642;5654.943450565442;5952.315483719254;5976.760929562769;5980.671063091571;5985.25184351956;6088.391160883876;6103.450689437972;6165.198524191826;6166.599171053867;6182.443580077815;5635.887282254414;5931.228940237742;5950.381831993909;5978.163057171912;5994.730237139426 17:39:32 INFO - PROCESS | 20680 | |5;yui.html;814.89406377171;821.9706523835664;895.171965931514;900.8378491871463;924.5423515359896;14197.290135493236;15063.472778452757;15164.620884477894;15235.695286094271;15339.923300383496;14153.22157281349;14156.575302740908;14242.928785356085;14264.358103885324;14335.498257560988;703.4864548879322;853.0318088969003;874.4010352908247;875.2604049578097;877.9604917778684;874.5321253129576;876.447837862146;882.0870399136894;882.629295695806;884.0938038510546;911.803962148138;912.9497877616728;917.7522069041355;920.8158368326328;924.5469719837265;920.6961702638114;921.0375157959948;921.2675922641482;921.4931787516839;921.6221349246777;673.2123415603755;674.5109795398297;676.458832933656;676.9187697476285;678.3352314731591;14250.287485625677;14302.14187148764;14316.785248221286;14349.713005739932;14350.354234059389;16425.26086326106;16447;16725.581860453465;16961.151942402954;16997.40509082176;12923.483060677561;13050.086493945428;13077.607671769862;13246.07277490576;13368.799468007988;4124.443200167969;4140.896477588054;4171.812268447927;4273.572642735733;4288.871333859989;75976;79354;79634;79721.60139199324;79820;12870.099093063583;12962.80555791664;13094.214347139012;13174.802377964339;13356.6660833478;24178.51642967131;24190;24192;24235.515289694107;24330.87834560816;9223.522865035706;9604.75988100289;9718.465484398426;9757.756056098655;9869.35849169816;5070.340855688737;5140.742962851842;5188.403333616607;5287.048331300402;5316.574674026068;3890;3967.722259441869;4014.8394064237687;4025.4163146343617;4054.1486287879284;655.1679367203625;662.9734810607522;666.9099671544376;682.3415404135034;689.290031267795;778.9961050194826;803.5700900018579;808.8301456694043;812.6546217857505;836.0176792269181;10313.48432578368;10492.4229167395;10517.368957862553;10541.367517948947;10621.256512044238;707.4623286302448;789.7117552093559;793.6111305460398;810.019875950107;825.9504429734235;4823.9517604824205;4873.829415970424;4892.877678058077;4894.608431325557;4908.852734417973;70783.2921670787;71317;97770.5111474438;99003;101471;99101;103130.48434757779;104197;105100.94899051065;105472;57408.71295643495;85009.57495212484;89352;90849.45752712338;91215.54392228129;10052.095311422006;10073.546690398804;10079.899201007896;10124.848127278245;10383.376997380181;53051;53169.734151328994;54505;54776.17835732547;56152;55843;79393;80418.19581804107;81716;82068.58965705372;14676.55970320892;15024.230224409068;15026.17356045428;15059.548213553611;15556.377744890078;15924.124173170587;16243.431479898147;16420.178991050638;17284.65430691354;17412;15188.544343669708;15611.08937952733;15902.204889755698;16273.511794645707;16359;13674.179549227078;14089;14488;14556.49052283165;15398.46105386306;13021.674458138623;14710.485133020293;15163.696726065196;15428.30572624212;15933.442329518411;11724.237924534878;12722.745545089232;12778.74442511126;12852.228866268053;13158.14472059313;11342.20604557673;11609.535618575163;11641.47613357384;11720.238184517979;11784.941075294568 17:39:32 INFO - PROCESS | 20680 | __end_tp_report 17:39:32 INFO - PROCESS | 20680 | __start_cc_report 17:39:32 INFO - PROCESS | 20680 | _x_x_mozilla_cycle_collect,330 17:39:32 INFO - PROCESS | 20680 | __end_cc_report 17:39:32 INFO - PROCESS | 20680 | __startTimestamp1469752772032__endTimestamp 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | ------- Summary: start ------- 17:39:32 INFO - PROCESS | 20680 | Number of tests: 6 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | [#0] dojo.html Cycles:165 Average:5669.51 Median:5894.76 stddev:638.35 (10.8%) stddev-sans-first:613.76 17:39:32 INFO - PROCESS | 20680 | Values: 3347.0 3358.4 3377.8 3379.9 3401.9 5668.1 5682.8 5697.2 5731.9 5763.8 5676.2 5693.4 5725.8 5727.8 5802.5 5115.8 5182.6 5234.9 5243.3 5247.9 5049.7 5063.3 5217.1 5291.6 5332.8 5215.0 5221.0 5223.6 5231.1 5231.2 5251.5 5274.2 5276.9 5280.4 5289.7 5050.3 5064.2 5096.7 5167.2 5179.1 5500.3 5505.8 5537.4 5541.2 5555.8 6018.1 6082.2 6088.1 6100.8 6105.3 5881.7 6057.0 6069.2 6104.2 6131.8 5714.8 5722.4 5724.4 5728.3 5765.8 6246.3 6247.9 6265.2 6267.6 6272.7 5850.2 5946.1 5991.7 6035.0 6100.0 6163.4 6189.3 6190.1 6199.3 6231.5 5949.9 6098.3 6168.0 6179.4 6190.4 5982.4 6062.5 6073.0 6073.1 6108.9 4638.1 4644.2 4654.0 4665.5 4675.7 4122.2 4138.2 4139.1 4153.7 4202.3 5592.7 5688.9 5700.1 5889.5 5890.6 6142.0 6142.8 6145.4 6183.4 6190.9 5670.1 5707.1 5708.9 5762.9 5790.5 5171.4 5212.6 5214.2 5215.4 5230.4 6148.0 6202.7 6214.9 6217.0 6226.2 6106.7 6120.0 6123.1 6197.3 6232.6 6157.8 6174.5 6178.7 6207.6 6208.7 5860.0 5994.8 6095.2 6099.8 6101.9 6111.2 6186.1 6190.7 6200.1 6220.7 6041.9 6048.6 6055.3 6079.9 6086.4 5726.0 5928.7 5995.2 6023.5 6040.7 5894.8 5927.3 5930.6 5932.6 5934.6 5964.7 6019.1 6077.7 6107.3 6115.7 5813.7 5838.4 5875.7 5901.5 5966.1 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | [#1] ext.html Cycles:180 Average:63380.19 Median:43601.46 stddev:125892.18 (288.7%) stddev-sans-first:126156.96 17:39:32 INFO - PROCESS | 20680 | Values: 551.3 630.6 648.2 665.3 679.4 40905.6 45259.0 45281.3 45420.4 45513.0 45963.5 46672.8 46766.3 46895.3 46939.8 8818.4 8991.8 8996.0 8997.6 9021.3 8950.6 8953.5 8962.6 8996.9 9033.7 9035.6 9094.1 9119.0 9132.8 9145.3 9054.3 9083.0 9084.2 9128.3 9135.3 8891.2 8906.2 8965.1 8970.9 8978.3 41916.2 42022.4 42155.4 42401.8 42524.1 3189.9 3745.4 3771.0 3810.3 3866.6 33757.8 34072.3 34303.5 34326.8 34380.1 4563.0 4801.1 4830.3 4992.0 5038.5 363805.0 364792.0 365299.0 366636.0 369728.0 67307.3 67558.7 67815.0 67884.7 68079.3 34491.3 35088.6 35155.0 35201.5 71131.0 17568.1 17725.1 17727.7 17773.0 17800.9 13497.7 13512.6 13606.7 13616.5 13667.9 21108.8 21282.7 21386.9 21547.9 21566.8 7453.2 7470.4 7472.7 7589.9 7740.3 1082.9 1103.4 1105.3 1128.1 1225.4 32799.3 32857.5 33035.8 33777.3 33809.5 1192.2 1198.2 1212.3 1265.3 1282.6 17334.7 17344.4 17684.5 17740.0 17932.2 564620.0 575825.0 578870.0 581628.0 624740.0 65943.7 66290.3 66705.0 66802.7 66823.3 1494.8 1499.4 1501.1 1507.3 1518.7 32654.2 33133.0 33376.5 33927.8 34204.3 55886.4 56286.4 56557.7 56576.0 56631.4 439365.0 443937.0 444059.0 448887.0 449349.0 30825.8 30949.8 31522.7 31607.4 31827.7 51180.2 51632.2 51636.5 51738.5 52735.2 43274.0 44012.1 44081.6 45254.3 45386.8 42503.0 43199.4 43303.1 44079.1 44459.8 42896.0 43509.1 43693.8 44020.1 44240.8 37019.3 37260.3 38229.4 38720.8 38784.0 29290.0 29504.3 29685.9 29839.0 30026.4 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | [#2] jquery.html Cycles:180 Average:29891.21 Median:2104.46 stddev:84503.99 (4015.5%) stddev-sans-first:84712.04 17:39:32 INFO - PROCESS | 20680 | Values: 406.5 413.0 416.1 416.6 425.7 18441.6 19451.0 20277.0 20281.1 20378.6 12373.3 17067.9 18854.7 19754.4 19831.7 5086.7 5220.3 5231.7 5259.2 5281.5 5125.1 5180.9 5189.2 5189.3 5198.2 5202.5 5229.6 5236.1 5252.9 5268.2 5082.6 5144.5 5166.5 5187.1 5219.8 4932.3 4996.0 5049.9 5054.1 5054.9 13041.0 18282.6 23502.1 23971.6 24067.4 2455.6 2473.9 2548.0 2669.0 2881.7 10066.7 10143.7 10458.4 10939.6 15685.9 2007.5 2049.8 2067.0 2095.4 2134.4 81530.0 83009.8 83059.2 84583.6 85709.9 11121.7 11161.6 11282.8 11418.3 11449.5 13175.6 15640.8 15655.6 15829.1 15858.5 8184.0 8441.8 8659.0 8874.5 8964.2 8744.7 8776.0 8808.8 8821.9 8829.0 4979.2 5057.5 5112.3 5172.6 5178.1 1859.1 1882.0 2078.3 2099.4 2109.5 980.3 1032.5 1044.5 1063.9 1075.5 19230.3 19435.5 19599.9 19996.5 20361.6 1048.6 1091.7 1092.1 1120.9 1152.9 10737.2 11085.8 11146.3 11173.4 11224.8 505035.0 507398.0 514170.0 514879.0 518400.0 95505.5 98445.0 99226.5 100703.0 102125.0 1113.1 1135.8 1138.3 1142.5 1162.2 18046.8 18237.3 18264.9 18387.2 18567.2 33449.8 42323.6 42969.6 43148.4 43849.0 56501.0 57649.0 57977.0 59657.7 60067.0 8447.7 8587.0 8751.7 8767.6 8808.7 12430.8 13097.1 13754.7 13789.0 13816.7 11478.7 11496.9 11497.5 11912.0 12006.5 11865.3 11902.3 11992.8 12010.1 12232.4 11822.3 11849.5 11900.2 11967.9 11975.3 7588.2 8666.4 8740.4 8771.3 9296.4 10816.8 11577.7 11887.5 12451.8 12604.5 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | [#3] mootools.html Cycles:180 Average:6268.21 Median:472.28 stddev:3631.57 (769.0%) stddev-sans-first:3624.48 17:39:32 INFO - PROCESS | 20680 | Values: 1554.4 1587.9 1801.9 1871.8 1926.4 8340.3 9044.8 9108.5 9715.4 9726.9 9083.0 9214.6 9337.0 9345.3 9452.7 2423.2 2449.1 2466.9 2475.4 2477.6 2431.4 2497.0 2508.9 2517.5 2519.0 2424.2 2444.7 2471.3 2479.9 2481.5 2260.3 2261.4 2299.1 2309.8 2317.0 2322.1 2323.3 2343.3 2344.2 2355.6 9371.1 9402.4 9482.3 9520.6 9531.5 5526.5 5671.8 5677.9 5679.8 5689.9 3396.2 3478.3 3493.4 3558.2 3574.7 1168.1 1173.1 1173.1 1183.0 1184.0 13529.5 13546.5 13589.0 13611.7 13676.8 4730.4 4825.3 4857.0 4867.1 4904.7 10623.8 10628.1 10660.9 10662.8 10666.3 5553.6 5649.0 5651.4 5666.4 5669.6 4961.8 5143.6 5144.5 5211.4 5267.3 4171.0 4184.5 4192.6 4222.8 4234.8 1247.4 1253.8 1260.9 1272.0 1278.3 1051.7 1053.3 1058.7 1077.3 1102.8 6434.7 6541.5 6595.8 6673.5 6772.4 472.2 472.4 479.8 481.7 483.8 4467.2 4553.8 4555.9 4557.7 4560.8 11871.9 12159.0 12174.3 12231.1 12292.9 11282.4 11994.6 12062.3 12078.9 12132.8 8591.8 8915.6 8995.3 9023.1 9042.6 6543.6 6646.5 6674.6 6734.0 6803.1 10866.2 10912.2 11053.0 11065.8 11076.9 11159.0 11172.3 11243.0 11255.0 11306.0 8300.5 8471.8 8719.4 8800.3 8805.0 9210.8 9260.7 9302.7 9334.2 9354.3 8218.9 8282.1 8306.8 8313.8 8482.2 8129.5 8157.8 8161.8 8172.1 8327.2 7476.1 7634.7 7664.8 7681.7 7683.7 5663.4 5726.2 5828.9 5835.7 5889.6 5815.8 5853.3 5880.2 5921.4 5936.5 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | [#4] prototype.html Cycles:180 Average:4848.61 Median:5351.15 stddev:1409.30 (26.3%) stddev-sans-first:1372.01 17:39:32 INFO - PROCESS | 20680 | Values: 339.4 339.6 341.8 348.9 350.4 5715.6 5726.3 5760.9 5776.9 5807.3 5600.4 5637.4 5640.2 5670.8 5705.9 4067.8 4150.9 4354.1 4378.7 4386.6 4345.3 4358.3 4394.8 4412.8 4427.7 4351.8 4358.9 4383.3 4393.5 4400.2 4139.2 4365.3 4378.7 4427.6 4433.5 3905.7 3918.7 3924.0 3935.0 3940.3 5480.4 5481.6 5486.7 5499.7 5527.7 4961.4 5068.5 5086.7 5114.8 5128.3 5876.0 5909.2 5916.3 5945.7 5965.6 4342.9 4350.5 4351.5 4352.9 4361.0 5979.4 6034.3 6198.0 6225.4 6234.1 4302.8 4317.9 4320.3 4324.8 4337.6 4341.4 4376.3 4390.2 4391.1 4409.2 4887.9 4974.5 5022.0 5025.2 5034.2 5889.3 5919.0 5942.5 5954.4 5958.8 1535.6 1554.4 1563.8 1566.6 1570.7 984.0 1011.5 1012.7 1018.0 1033.2 5032.7 5039.9 5068.9 5075.3 5096.4 5264.9 5392.8 5462.6 5472.5 5507.2 4884.4 4953.7 5036.6 5057.6 5139.7 2821.4 2870.0 2895.9 2934.2 2940.5 5389.8 5421.8 5435.0 5447.4 5462.3 5256.5 5372.2 5453.2 5474.3 5487.0 5445.8 5458.8 5465.3 5522.7 5601.3 5113.7 5265.3 5374.1 5458.7 5528.1 5325.3 5340.4 5347.7 5354.6 5407.8 6064.6 6179.1 6192.7 6213.7 6332.6 4368.5 4404.0 4408.7 4409.6 4435.5 5948.3 6209.8 6302.9 6326.5 6331.8 6020.6 6045.3 6060.5 6089.8 6096.4 6011.3 6037.5 6057.4 6067.2 6090.7 5654.9 5952.3 5976.8 5980.7 5985.3 6088.4 6103.5 6165.2 6166.6 6182.4 5635.9 5931.2 5950.4 5978.2 5994.7 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - PROCESS | 20680 | [#5] yui.html Cycles:180 Average:20864.62 Median:4132.67 stddev:28340.70 (685.8%) stddev-sans-first:28380.21 17:39:32 INFO - PROCESS | 20680 | Values: 814.9 822.0 895.2 900.8 924.5 14197.3 15063.5 15164.6 15235.7 15339.9 14153.2 14156.6 14242.9 14264.4 14335.5 703.5 853.0 874.4 875.3 878.0 874.5 876.4 882.1 882.6 884.1 911.8 912.9 917.8 920.8 924.5 920.7 921.0 921.3 921.5 921.6 673.2 674.5 676.5 676.9 678.3 14250.3 14302.1 14316.8 14349.7 14350.4 16425.3 16447.0 16725.6 16961.2 16997.4 12923.5 13050.1 13077.6 13246.1 13368.8 4124.4 4140.9 4171.8 4273.6 4288.9 75976.0 79354.0 79634.0 79721.6 79820.0 12870.1 12962.8 13094.2 13174.8 13356.7 24178.5 24190.0 24192.0 24235.5 24330.9 9223.5 9604.8 9718.5 9757.8 9869.4 5070.3 5140.7 5188.4 5287.0 5316.6 3890.0 3967.7 4014.8 4025.4 4054.1 655.2 663.0 666.9 682.3 689.3 779.0 803.6 808.8 812.7 836.0 10313.5 10492.4 10517.4 10541.4 10621.3 707.5 789.7 793.6 810.0 826.0 4824.0 4873.8 4892.9 4894.6 4908.9 70783.3 71317.0 97770.5 99003.0 101471.0 99101.0 103130.5 104197.0 105100.9 105472.0 57408.7 85009.6 89352.0 90849.5 91215.5 10052.1 10073.5 10079.9 10124.8 10383.4 53051.0 53169.7 54505.0 54776.2 56152.0 55843.0 79393.0 80418.2 81716.0 82068.6 14676.6 15024.2 15026.2 15059.5 15556.4 15924.1 16243.4 16420.2 17284.7 17412.0 15188.5 15611.1 15902.2 16273.5 16359.0 13674.2 14089.0 14488.0 14556.5 15398.5 13021.7 14710.5 15163.7 15428.3 15933.4 11724.2 12722.7 12778.7 12852.2 13158.1 11342.2 11609.5 11641.5 11720.2 11784.9 17:39:32 INFO - PROCESS | 20680 | -------- Summary: end -------- 17:39:32 INFO - PROCESS | 20680 | 17:39:32 INFO - TEST-INFO | 20680: exit 0 17:39:32 INFO - TEST-OK | dromaeo_css | took 1110280ms 17:39:32 INFO - TEST-START | kraken 17:39:32 INFO - operating with platform_type : linux_ 17:39:32 INFO - Initialising browser for kraken test... 17:39:32 INFO - TEST-INFO | started process 20922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTbSCCv/profile http://localhost:60103/getInfo.html) 17:39:37 INFO - PROCESS | 20922 | __metrics Screen width/height:1600/1200 17:39:37 INFO - PROCESS | 20922 | colorDepth:24 17:39:37 INFO - PROCESS | 20922 | Browser inner width/height: 1024/697 17:39:37 INFO - PROCESS | 20922 | __metrics 17:39:37 ERROR - PROCESS | 20922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:39:38 INFO - TEST-INFO | 20922: exit 0 17:39:38 INFO - Browser initialized. 17:39:38 INFO - Running cycle 1/1 for kraken test... 17:39:38 INFO - TEST-INFO | started process 21050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTbSCCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:50 INFO - PROCESS | 21050 | RSS: Main: 155893760 17:39:50 INFO - PROCESS | 21050 | 17:39:52 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60103/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:53 INFO - PROCESS | 21050 | RSS: Main: 161116160 17:39:53 INFO - PROCESS | 21050 | 17:39:56 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60103/tests/kraken/driver.html?testName=audio-dft) 17:39:56 INFO - PROCESS | 21050 | RSS: Main: 160739328 17:39:56 INFO - PROCESS | 21050 | 17:39:59 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60103/tests/kraken/driver.html?testName=audio-fft) 17:40:00 INFO - PROCESS | 21050 | RSS: Main: 161439744 17:40:00 INFO - PROCESS | 21050 | 17:40:02 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60103/tests/kraken/driver.html?testName=audio-oscillator) 17:40:03 INFO - PROCESS | 21050 | RSS: Main: 160854016 17:40:03 INFO - PROCESS | 21050 | 17:40:05 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60103/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:40:05 INFO - PROCESS | 21050 | RSS: Main: 161206272 17:40:05 INFO - PROCESS | 21050 | 17:40:09 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60103/tests/kraken/driver.html?testName=imaging-darkroom) 17:40:09 INFO - PROCESS | 21050 | RSS: Main: 160960512 17:40:09 INFO - PROCESS | 21050 | 17:40:13 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60103/tests/kraken/driver.html?testName=imaging-desaturate) 17:40:13 INFO - PROCESS | 21050 | RSS: Main: 157093888 17:40:13 INFO - PROCESS | 21050 | 17:40:16 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60103/tests/kraken/driver.html?testName=json-parse-financial) 17:40:17 INFO - PROCESS | 21050 | RSS: Main: 158756864 17:40:17 INFO - PROCESS | 21050 | 17:40:18 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60103/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:40:19 INFO - PROCESS | 21050 | RSS: Main: 159277056 17:40:19 INFO - PROCESS | 21050 | 17:40:21 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:40:21 INFO - PROCESS | 21050 | RSS: Main: 159338496 17:40:21 INFO - PROCESS | 21050 | 17:40:23 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:40:24 INFO - PROCESS | 21050 | RSS: Main: 159600640 17:40:24 INFO - PROCESS | 21050 | 17:40:27 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:40:27 INFO - PROCESS | 21050 | RSS: Main: 160567296 17:40:27 INFO - PROCESS | 21050 | 17:40:30 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:40:30 INFO - PROCESS | 21050 | RSS: Main: 160145408 17:40:30 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | Cycle 1(1): loaded http://localhost:60103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60103/tests/kraken/driver.html?testName=ai-astar) 17:40:32 INFO - PROCESS | 21050 | RSS: Main: 160686080 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | __start_tp_report 17:40:32 INFO - PROCESS | 21050 | _x_x_mozilla_page_load 17:40:32 INFO - PROCESS | 21050 | _x_x_mozilla_page_load_details 17:40:32 INFO - PROCESS | 21050 | |i|pagename|runs| 17:40:32 INFO - PROCESS | 21050 | |0;ai-astar;110;104;109;110;111;110;109;112;111;109 17:40:32 INFO - PROCESS | 21050 | |1;audio-beat-detection;154;127;153;182;131;166;150;131;180;124 17:40:32 INFO - PROCESS | 21050 | |2;audio-dft;164;164;163;162;166;164;164;166;164;161 17:40:32 INFO - PROCESS | 21050 | |3;audio-fft;75;77;74;177;76;75;74;77;159;85 17:40:32 INFO - PROCESS | 21050 | |4;audio-oscillator;84;85;152;87;86;84;141;84;85;137 17:40:32 INFO - PROCESS | 21050 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;118;117;118 17:40:32 INFO - PROCESS | 21050 | |6;imaging-darkroom;147;147;147;146;148;148;148;147;146;147 17:40:32 INFO - PROCESS | 21050 | |7;imaging-desaturate;96;95;95;95;95;99;95;95;95;96 17:40:32 INFO - PROCESS | 21050 | |8;json-parse-financial;52;54;53;52;55;53;54;52;52;51 17:40:32 INFO - PROCESS | 21050 | |9;json-stringify-tinderbox;60;60;59;60;59;61;60;60;60;61 17:40:32 INFO - PROCESS | 21050 | |10;stanford-crypto-aes;77;77;76;76;77;76;76;76;108;77 17:40:32 INFO - PROCESS | 21050 | |11;stanford-crypto-ccm;127;127;120;119;137;130;127;120;127;127 17:40:32 INFO - PROCESS | 21050 | |12;stanford-crypto-pbkdf2;155;153;156;152;158;149;152;152;150;152 17:40:32 INFO - PROCESS | 21050 | |13;stanford-crypto-sha256-iterative;63;64;62;62;62;62;61;61;61;64 17:40:32 INFO - PROCESS | 21050 | __end_tp_report 17:40:32 INFO - PROCESS | 21050 | __start_cc_report 17:40:32 INFO - PROCESS | 21050 | _x_x_mozilla_cycle_collect,851 17:40:32 INFO - PROCESS | 21050 | __end_cc_report 17:40:32 INFO - PROCESS | 21050 | __startTimestamp1469752832801__endTimestamp 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | ------- Summary: start ------- 17:40:32 INFO - PROCESS | 21050 | Number of tests: 14 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.17 (2.0%) stddev-sans-first:2.30 17:40:32 INFO - PROCESS | 21050 | Values: 110.0 104.0 109.0 110.0 111.0 110.0 109.0 112.0 111.0 109.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:153.50 stddev:21.43 (14.0%) stddev-sans-first:22.67 17:40:32 INFO - PROCESS | 21050 | Values: 154.0 127.0 153.0 182.0 131.0 166.0 150.0 131.0 180.0 124.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.55 (0.9%) stddev-sans-first:1.64 17:40:32 INFO - PROCESS | 21050 | Values: 164.0 164.0 163.0 162.0 166.0 164.0 164.0 166.0 164.0 161.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:38.89 (51.5%) stddev-sans-first:40.58 17:40:32 INFO - PROCESS | 21050 | Values: 75.0 77.0 74.0 177.0 76.0 75.0 74.0 77.0 159.0 85.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.50 stddev:28.43 (33.6%) stddev-sans-first:29.36 17:40:32 INFO - PROCESS | 21050 | Values: 84.0 85.0 152.0 87.0 86.0 84.0 141.0 84.0 85.0 137.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:40:32 INFO - PROCESS | 21050 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 17:40:32 INFO - PROCESS | 21050 | Values: 147.0 147.0 147.0 146.0 148.0 148.0 148.0 147.0 146.0 147.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 17:40:32 INFO - PROCESS | 21050 | Values: 96.0 95.0 95.0 95.0 95.0 99.0 95.0 95.0 95.0 96.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:1.27 17:40:32 INFO - PROCESS | 21050 | Values: 52.0 54.0 53.0 52.0 55.0 53.0 54.0 52.0 52.0 51.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 17:40:32 INFO - PROCESS | 21050 | Values: 60.0 60.0 59.0 60.0 59.0 61.0 60.0 60.0 60.0 61.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:76.50 stddev:9.99 (13.1%) stddev-sans-first:10.55 17:40:32 INFO - PROCESS | 21050 | Values: 77.0 77.0 76.0 76.0 77.0 76.0 76.0 76.0 108.0 77.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.00 stddev:5.40 (4.3%) stddev-sans-first:5.72 17:40:32 INFO - PROCESS | 21050 | Values: 127.0 127.0 120.0 119.0 137.0 130.0 127.0 120.0 127.0 127.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:152.50 stddev:2.73 (1.8%) stddev-sans-first:2.78 17:40:32 INFO - PROCESS | 21050 | Values: 155.0 153.0 156.0 152.0 158.0 149.0 152.0 152.0 150.0 152.0 17:40:32 INFO - PROCESS | 21050 | 17:40:32 INFO - PROCESS | 21050 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.14 (1.8%) stddev-sans-first:1.17 17:40:32 INFO - PROCESS | 21050 | Values: 63.0 64.0 62.0 62.0 62.0 62.0 61.0 61.0 61.0 64.0 17:40:32 INFO - PROCESS | 21050 | -------- Summary: end -------- 17:40:32 INFO - PROCESS | 21050 | 17:40:33 INFO - TEST-INFO | 21050: exit 0 17:40:33 INFO - TEST-OK | kraken | took 61030ms 17:40:33 INFO - SUITE-END | took 1171s 17:40:33 INFO - Completed test suite (00:19:31) 17:40:33 INFO - javascript benchmark 17:40:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7607.217448601936, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.9832650836747, 3358.4290670586006, 3377.8311084445772, 3379.864805407784, 3401.948970765439, 5668.093105103179, 5682.829515114543, 5697.173909783084, 5731.856703582413, 5763.798267060653, 5676.205331253628, 5693.402192769751, 5725.7995970141055, 5727.828165155052, 5802.506786923117, 5115.846524604259, 5182.637215394924, 5234.92147617786, 5243.2659427680155, 5247.86880327991, 5049.671771334852, 5063.291139240491, 5217.113090774577, 5291.550218231455, 5332.840014799563, 5215.0, 5221.034108689904, 5223.608229382792, 5231.136862417697, 5231.163013917774, 5251.527362537371, 5274.182501712203, 5276.868078298054, 5280.419153893069, 5289.656172348785, 5050.292958985745, 5064.215046667772, 5096.745162741848, 5167.224916262553, 5179.119549676564, 5500.312460942382, 5505.834824955257, 5537.418571050062, 5541.196526503675, 5555.805546805843, 6018.127371531147, 6082.209312789353, 6088.11722300264, 6100.816975490698, 6105.32841387447, 5881.735321910524, 6057.0, 6069.241344831896, 6104.20645316106, 6131.816045518642, 5714.771409143629, 5722.399148089474, 5724.427557244284, 5728.3126024876865, 5765.7981970631245, 6246.250449946036, 6247.875042499125, 6265.248170219603, 6267.592606480564, 6272.749090036347, 5850.23946886902, 5946.137810017523, 5991.700414979321, 6035.0, 6099.969500152471, 6163.445289923929, 6189.288231853305, 6190.102435146879, 6199.3490683478485, 6231.470325022424, 5949.851253718605, 6098.32918378978, 6168.0439531872635, 6179.443850053517, 6190.380961903774, 5982.4316689914385, 6062.454379105901, 6073.0, 6073.119397687311, 6108.8778224436155, 4638.095571363552, 4644.210484217691, 4654.045920586272, 4665.533446655375, 4675.672702910763, 4122.237386083584, 4138.172365526907, 4139.110091330378, 4153.7300075495605, 4202.2646036943415, 5592.748326325325, 5688.943110568841, 5700.144978253213, 5889.528837692974, 5890.587658863838, 6142.04798256271, 6142.754289828446, 6145.354737752561, 6183.3816618337805, 6190.938090619126, 5670.121131224667, 5707.0583353747, 5708.942910570924, 5762.88474230513, 5790.507806836466, 5171.379434467888, 5212.582993360522, 5214.191800270964, 5215.426303106731, 5230.424653288135, 6148.0, 6202.72087756052, 6214.937850621526, 6217.0, 6226.159468471789, 6106.725197366218, 6120.020796672511, 6123.081537769282, 6197.318294987638, 6232.5948813328805, 6157.784477543264, 6174.536909731698, 6178.721957511832, 6207.6275423474735, 6208.689565521796, 5860.0, 5994.790182343597, 6095.238095238095, 6099.756009759737, 6101.877962440638, 6111.174991376108, 6186.133941248138, 6190.690465476799, 6200.131981522681, 6220.657863817352, 6041.909371359346, 6048.559842982584, 6055.303640081271, 6079.939200607937, 6086.421789929949, 5726.026575482095, 5928.703564821655, 5995.2206213192, 6023.45788879003, 6040.6677632730625, 5894.764209431574, 5927.2590926134235, 5930.614510056833, 5932.644041357532, 5934.584579079423, 5964.731587078505, 6019.097135429721, 6077.665728384981, 6107.297660768891, 6115.694215289307, 5813.680247586254, 5838.416158384128, 5875.676837773793, 5901.527877769854, 5966.105084237399], "value": 5627.167367915194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.253052114385, 630.5806638585341, 648.2286079565317, 665.3413121010199, 679.3851564334273, 40905.59094409055, 45259.0, 45281.32078018824, 45420.41028564005, 45513.0, 45963.540364596425, 46672.76663616686, 46766.29850552244, 46895.29657055147, 46939.76530117353, 8818.426802257849, 8991.775205619879, 8995.95502022489, 8997.595108220146, 9021.278297736199, 8950.552472376388, 8953.507557084358, 8962.641494340218, 8996.8650470243, 9033.683821066264, 9035.638574457014, 9094.1360570746, 9118.954405227965, 9132.817343653123, 9145.314101442385, 9054.32092593055, 9082.954585227099, 9084.182423581877, 9128.315376346734, 9135.269178465707, 8891.244244239248, 8906.198442140174, 8965.103489650983, 8970.910290897073, 8978.281737460988, 41916.1616767666, 42022.36966445506, 42155.367669484986, 42401.78799105985, 42524.1495170098, 3189.856456459465, 3745.419459983707, 3771.0, 3810.2760475509563, 3866.555346135174, 33757.83121084404, 34072.31855362903, 34303.4854477183, 34326.82836585826, 34380.14049648754, 4562.954370456286, 4801.135795556798, 4830.3237546743485, 4991.975040124777, 5038.470960549163, 363805.0, 364792.0, 365299.0, 366636.0, 369728.0, 67307.32692673011, 67558.66220668865, 67815.0, 67884.6605766968, 68079.3192068073, 34491.31017379638, 35088.64911350854, 35155.0, 35201.47197792035, 71131.0, 17568.121593920252, 17725.113744312992, 17727.73408398875, 17773.0, 17800.9109954452, 13497.662558436117, 13512.59462216135, 13606.727865442635, 13616.455341786217, 13667.863321366858, 21108.788912110682, 21282.680759788615, 21386.893065534572, 21547.892260538596, 21566.784332156793, 7453.217412171753, 7470.439717021137, 7472.738454154079, 7589.8861517077285, 7740.303372696484, 1082.8862969388101, 1103.382344886652, 1105.2926127278547, 1128.1031579894004, 1225.436299302331, 32799.344013119604, 32857.50713739296, 33035.834820826225, 33777.32445351128, 33809.492857607154, 1192.1714408486018, 1198.1553005131536, 1212.3029258176407, 1265.3356987581594, 1282.602393258093, 17334.739978900325, 17344.392946246822, 17684.46946591604, 17740.01445194707, 17932.193051312723, 564620.0, 575825.0, 578870.0, 581628.0, 624740.0, 65943.67028164829, 66290.33709662841, 66705.0, 66802.66598666976, 66823.33176668268, 1494.8206215254238, 1499.430216517738, 1501.06183635228, 1507.2991059157544, 1518.7038527487255, 32654.183645409055, 33133.0, 33376.49935250924, 33927.830360848035, 34204.31591368208, 55886.441135588124, 56286.43713562812, 56557.71721141368, 56576.0, 56631.43368566262, 439365.0, 443937.0, 444059.0, 448887.0, 449349.0, 30825.845870770503, 30949.845250773604, 31522.684773151974, 31607.367852643278, 31827.68172318247, 51180.232296514834, 51632.22551661803, 51636.48363516467, 51738.482615173365, 52735.20897186622, 43274.0, 44012.11975760531, 44081.55918440774, 45254.32118518159, 45386.77306613578, 42503.0, 43199.35200972051, 43303.133937321705, 44079.11841763211, 44459.777701111285, 42896.0, 43509.12981740411, 43693.78153109214, 44020.11959760851, 44240.77879610581, 37019.25961480809, 37260.254794903405, 38229.4265586022, 38720.80639596784, 38784.0, 29290.0, 29504.262393440335, 29685.85157074201, 29839.0, 30026.399472010875], "value": 21142.935260712668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.5304573217932, 412.97522148671084, 416.0866897160731, 416.591740094707, 425.6828662646329, 18441.631167376643, 19451.0, 20277.0, 20281.08735106918, 20378.592428151427, 12373.319467429288, 17067.91466042671, 18854.71717924229, 19754.40736777899, 19831.702524462144, 5086.669366491175, 5220.347456567929, 5231.686098834082, 5259.237410575464, 5281.471852814726, 5125.077486052509, 5180.870478238036, 5189.247559103927, 5189.299444574972, 5198.220266959967, 5202.453742357055, 5229.633925625208, 5236.136037553818, 5252.868678283055, 5268.209768534713, 5082.567981721558, 5144.459831717691, 5166.4575219601775, 5187.066328060948, 5219.817306394258, 4932.260160975882, 4996.025774973881, 5049.949500505021, 5054.090263752523, 5054.898902021976, 13041.0, 18282.634347313113, 23502.059917603274, 23971.640425393634, 24067.39831504209, 2455.5579995600783, 2473.8763061847017, 2547.9872600637063, 2669.0258055809686, 2881.726236007576, 10066.748331291703, 10143.746406339827, 10458.424786636731, 10939.56241750329, 15685.92157039219, 2007.5483016321211, 2049.80526849949, 2067.0, 2095.371388583434, 2134.3810295014428, 81530.0, 83009.75485367724, 83059.16940830635, 84583.57708211482, 85709.86715090326, 11121.666350009513, 11161.553537858395, 11282.774344513227, 11418.314901105794, 11449.484773185226, 13175.60473185806, 15640.765388519181, 15655.608609784846, 15829.129397882996, 15858.52424427269, 8183.95908020456, 8441.788955276044, 8659.04750477447, 8874.511901845332, 8964.238039766562, 8744.737657870273, 8775.956120219485, 8808.779780505538, 8821.911780882238, 8829.0, 4979.153543897473, 5057.468965758542, 5112.309838171874, 5172.612054095883, 5178.093833579109, 1859.0890463672704, 1881.9811801882079, 2078.3349328214827, 2099.433153048699, 2109.4831766217067, 980.3039841712464, 1032.4837581209395, 1044.4539495280087, 1063.8935507072713, 1075.5052675769077, 19230.326938557082, 19435.514112147026, 19599.902000489907, 19996.50008749764, 20361.592768144554, 1048.6120135549743, 1091.6670415523342, 1092.088106431123, 1120.9047230985295, 1152.8501294831617, 10737.194710396752, 11085.778284434266, 11146.275492092987, 11173.385463799406, 11224.775504489864, 505035.0, 507398.0, 514170.0, 514879.0, 518400.0, 95505.52247238858, 98445.0, 99226.5038674802, 100703.0, 102125.0, 1113.0872684398878, 1135.7558125003163, 1138.299945533491, 1142.4516232208753, 1162.1864694713734, 18046.819531804515, 18237.270509179485, 18264.908675456536, 18387.172577234323, 18567.16447759881, 33449.83275083609, 42323.57676423319, 42969.570304296554, 43148.352774707775, 43849.0, 56501.0, 57649.0, 57977.0, 59657.701711491165, 60067.0, 8447.690607955778, 8587.0, 8751.695728007824, 8767.561621919007, 8808.691695790616, 12430.813537797121, 13097.148685335804, 13754.65613359674, 13789.0, 13816.723665526431, 11478.655640330804, 11496.88503114958, 11497.48261328259, 11912.047036237254, 12006.519739210335, 11865.288082715064, 11902.345371004332, 11992.76014479723, 12010.09924255667, 12232.388380581113, 11822.34977076269, 11849.466773995364, 11900.166988310735, 11967.940160299142, 11975.341356225492, 7588.241175882367, 8666.393352465268, 8740.388172827841, 8771.254443372385, 9296.39573427725, 10816.837747433638, 11577.7105572358, 11887.524499020288, 12451.75096498083, 12604.495820167458], "value": 9366.326838852214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.4015554011705, 1587.8650314723247, 1801.882877612955, 1871.8034606366339, 1926.383557261676, 8340.33277337813, 9044.773880652987, 9108.54457277136, 9715.417074975498, 9726.902730972688, 9083.046280140588, 9214.585343659535, 9337.0, 9345.345825792181, 9452.66915657952, 2423.151896836111, 2449.1428000199876, 2466.938326541833, 2475.418276704973, 2477.6283557466345, 2431.4407686232175, 2496.988719568578, 2508.8745562721883, 2517.5342561626067, 2519.0427637497723, 2424.2242482405636, 2444.6577479152934, 2471.283327834926, 2479.85120892747, 2481.5285095831823, 2260.3445000949705, 2261.3781210167335, 2299.0792739644994, 2309.7805708457668, 2317.0, 2322.1175953137868, 2323.3262353917344, 2343.285297984114, 2344.2264052862515, 2355.62310030396, 9371.062893710643, 9402.43585384879, 9482.288828337902, 9520.571574279174, 9531.523423828781, 5526.530244929186, 5671.7731290748325, 5677.858053548653, 5679.801206957736, 5689.943100568983, 3396.218869659992, 3478.3391155680592, 3493.423585108454, 3558.19940513385, 3574.696150827157, 1168.0830548019765, 1173.0556901694133, 1173.0791328806845, 1183.0476466444509, 1183.9822402663967, 13529.526466573721, 13546.525871594546, 13589.0, 13611.659708507268, 13676.794848077287, 4730.373689541835, 4825.30033145192, 4856.975715121402, 4867.099586576494, 4904.681195722266, 10623.787524249472, 10628.096611788085, 10660.893391066145, 10662.786744265071, 10666.253362264722, 5553.6390134641115, 5649.0396632572565, 5651.378348381675, 5666.433356664301, 5669.574781891375, 4961.826336078292, 5143.614228932845, 5144.511271429208, 5211.374635043743, 5267.26258323835, 4171.040660648068, 4184.476940382452, 4192.580741925844, 4222.767747773902, 4234.788260586958, 1247.3700781105483, 1253.786856234424, 1260.9054320925784, 1271.9682007949875, 1278.3352656618506, 1051.705522453699, 1053.2942928238099, 1058.6823952814125, 1077.3482043363808, 1102.779444111181, 6434.74261029563, 6541.542092053605, 6595.769148079794, 6673.499487538454, 6772.423426120003, 472.1878369204962, 472.36466951949575, 479.80567870012703, 481.67727622493015, 483.75570336980303, 4467.218236808546, 4553.772311384418, 4555.886102847389, 4557.749323787158, 4560.771961401917, 11871.88128118725, 12159.0, 12174.269543827222, 12231.082668799876, 12292.877071229352, 11282.379469129113, 11994.64016079519, 12062.276263424223, 12078.939605302094, 12132.757344853053, 8591.785205369792, 8915.598798054232, 8995.28037756978, 9023.142801433853, 9042.63829446828, 6543.607383557001, 6646.534742567974, 6674.599524028574, 6733.966330168318, 6803.081583986296, 10866.239363244496, 10912.236143469881, 11053.00522952938, 11065.778684426428, 11076.889231107909, 11159.0, 11172.329660220414, 11243.0, 11255.0, 11306.0, 8300.501969881827, 8471.830563388574, 8719.38964272495, 8800.295976322006, 8805.031446540746, 9210.815783684422, 9260.675876344565, 9302.720918372459, 9334.206592439446, 9354.25165986733, 8218.917810821815, 8282.130376310643, 8306.792330191553, 8313.83372332562, 8482.194191551793, 8129.512229266263, 8157.778120783258, 8161.755147345589, 8172.141925098017, 8327.167283271625, 7476.065491813523, 7634.656440460081, 7664.846703066019, 7681.6543255552515, 7683.692652293846, 5663.377028526941, 5726.198332233407, 5828.94171058284, 5835.7373918174635, 5889.587728858939, 5815.82552523425, 5853.297604287342, 5880.176775251382, 5921.3782552831335, 5936.465718085393], "value": 4891.681756837041, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.3704677822638, 339.6128413608486, 341.7539371652411, 348.8569686428565, 350.40256362901255, 5715.57133215009, 5726.255586773719, 5760.89727249554, 5776.913346299803, 5807.303123625171, 5600.355959064709, 5637.436256374361, 5640.210370548127, 5670.773169073233, 5705.942940570593, 4067.837286508536, 4150.875473735793, 4354.08564201518, 4378.737275763465, 4386.583274588925, 4345.283028300327, 4358.2808836541935, 4394.802233899482, 4412.82348706053, 4427.734335939837, 4351.825926962933, 4358.912821743564, 4383.298672212447, 4393.450818647669, 4400.229959757045, 4139.19285739281, 4365.257906155961, 4378.671599630041, 4427.5572442755465, 4433.534478879736, 3905.7070719696135, 3918.7256892017285, 3923.98038009811, 3934.9606503935165, 3940.251352243093, 5480.369757477902, 5481.588880833953, 5486.698231597261, 5499.670019798825, 5527.695976721278, 4961.3798275215595, 5068.518490743373, 5086.745662716887, 5114.846554603368, 5128.282040514331, 5876.0, 5909.1976947031135, 5916.319623243339, 5945.732442040118, 5965.582409231356, 4342.869713908588, 4350.456192975878, 4351.477822661301, 4352.89117772055, 4361.0, 5979.372165922559, 6034.30605480371, 6197.969010154966, 6225.408586184305, 6234.064890266451, 4302.7848607569495, 4317.892052698645, 4320.265554855682, 4324.805383757738, 4337.609615134653, 4341.37050127736, 4376.299792033259, 4390.1878152541885, 4391.143726973273, 4409.206342858316, 4887.892376681614, 4974.477679843637, 5022.020705962375, 5025.195968645073, 5034.194528875362, 5889.322727886262, 5919.01712926166, 5942.494887934487, 5954.4045595440975, 5958.76164953397, 1535.5930678370019, 1554.3704799556199, 1563.7654351847314, 1566.592685901651, 1570.6701592665668, 983.9803203935882, 1011.5043628622069, 1012.6733978488204, 1018.0, 1033.1992705653179, 5032.72320022395, 5039.899202015939, 5068.873278168076, 5075.3402057732255, 5096.439391666913, 5264.868378290574, 5392.78428862849, 5462.634341414647, 5472.452754724575, 5507.228987941691, 4884.36244428012, 4953.7275449849885, 5036.597072234213, 5057.620678449131, 5139.743012849342, 2821.39340041892, 2870.0098466029185, 2895.928506452626, 2934.1637633274413, 2940.5148150555347, 5389.784408623611, 5421.834305624309, 5435.0, 5447.428020057916, 5462.317210348707, 5256.474352564713, 5372.167314066326, 5453.191606322747, 5474.315710536183, 5487.0, 5445.754941027663, 5458.836234912959, 5465.262189604432, 5522.723863806794, 5601.29983752031, 5113.693178409308, 5265.305310086752, 5374.145919657712, 5458.662627656091, 5528.115501519737, 5325.307709997831, 5340.412554619066, 5347.700488789857, 5354.607801971438, 5407.810726624549, 6064.636121832704, 6179.134921111138, 6192.721327540362, 6213.689315534296, 6332.620042797447, 4368.51946285902, 4404.009097952935, 4408.73547587133, 4409.581089796464, 4435.489918659267, 5948.345681974893, 6209.813705588839, 6302.936970630235, 6326.525510586633, 6331.778387756406, 6020.578559500793, 6045.3073139521, 6060.545459090674, 6089.817305480843, 6096.390360963868, 6011.338752737108, 6037.486813620892, 6057.363976782374, 6067.150598916243, 6090.725917333642, 5654.943450565442, 5952.315483719254, 5976.760929562769, 5980.671063091571, 5985.25184351956, 6088.391160883876, 6103.450689437972, 6165.198524191826, 6166.599171053867, 6182.443580077815, 5635.887282254414, 5931.228940237742, 5950.381831993909, 5978.163057171912, 5994.730237139426], "value": 4403.492754857688, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.89406377171, 821.9706523835664, 895.171965931514, 900.8378491871463, 924.5423515359896, 14197.290135493236, 15063.472778452757, 15164.620884477894, 15235.695286094271, 15339.923300383496, 14153.22157281349, 14156.575302740908, 14242.928785356085, 14264.358103885324, 14335.498257560988, 703.4864548879322, 853.0318088969003, 874.4010352908247, 875.2604049578097, 877.9604917778684, 874.5321253129576, 876.447837862146, 882.0870399136894, 882.629295695806, 884.0938038510546, 911.803962148138, 912.9497877616728, 917.7522069041355, 920.8158368326328, 924.5469719837265, 920.6961702638114, 921.0375157959948, 921.2675922641482, 921.4931787516839, 921.6221349246777, 673.2123415603755, 674.5109795398297, 676.458832933656, 676.9187697476285, 678.3352314731591, 14250.287485625677, 14302.14187148764, 14316.785248221286, 14349.713005739932, 14350.354234059389, 16425.26086326106, 16447.0, 16725.581860453465, 16961.151942402954, 16997.40509082176, 12923.483060677561, 13050.086493945428, 13077.607671769862, 13246.07277490576, 13368.799468007988, 4124.443200167969, 4140.896477588054, 4171.812268447927, 4273.572642735733, 4288.871333859989, 75976.0, 79354.0, 79634.0, 79721.60139199324, 79820.0, 12870.099093063583, 12962.80555791664, 13094.214347139012, 13174.802377964339, 13356.6660833478, 24178.51642967131, 24190.0, 24192.0, 24235.515289694107, 24330.87834560816, 9223.522865035706, 9604.75988100289, 9718.465484398426, 9757.756056098655, 9869.35849169816, 5070.340855688737, 5140.742962851842, 5188.403333616607, 5287.048331300402, 5316.574674026068, 3890.0, 3967.722259441869, 4014.8394064237687, 4025.4163146343617, 4054.1486287879284, 655.1679367203625, 662.9734810607522, 666.9099671544376, 682.3415404135034, 689.290031267795, 778.9961050194826, 803.5700900018579, 808.8301456694043, 812.6546217857505, 836.0176792269181, 10313.48432578368, 10492.4229167395, 10517.368957862553, 10541.367517948947, 10621.256512044238, 707.4623286302448, 789.7117552093559, 793.6111305460398, 810.019875950107, 825.9504429734235, 4823.9517604824205, 4873.829415970424, 4892.877678058077, 4894.608431325557, 4908.852734417973, 70783.2921670787, 71317.0, 97770.5111474438, 99003.0, 101471.0, 99101.0, 103130.48434757779, 104197.0, 105100.94899051065, 105472.0, 57408.71295643495, 85009.57495212484, 89352.0, 90849.45752712338, 91215.54392228129, 10052.095311422006, 10073.546690398804, 10079.899201007896, 10124.848127278245, 10383.376997380181, 53051.0, 53169.734151328994, 54505.0, 54776.17835732547, 56152.0, 55843.0, 79393.0, 80418.19581804107, 81716.0, 82068.58965705372, 14676.55970320892, 15024.230224409068, 15026.17356045428, 15059.548213553611, 15556.377744890078, 15924.124173170587, 16243.431479898147, 16420.178991050638, 17284.65430691354, 17412.0, 15188.544343669708, 15611.08937952733, 15902.204889755698, 16273.511794645707, 16359.0, 13674.179549227078, 14089.0, 14488.0, 14556.49052283165, 15398.46105386306, 13021.674458138623, 14710.485133020293, 15163.696726065196, 15428.30572624212, 15933.442329518411, 11724.237924534878, 12722.745545089232, 12778.74442511126, 12852.228866268053, 13158.14472059313, 11342.20604557673, 11609.535618575163, 11641.47613357384, 11720.238184517979, 11784.941075294568], "value": 8072.951449357233, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 110.0, 111.0, 110.0, 109.0, 112.0, 111.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 153.0, 182.0, 131.0, 166.0, 150.0, 131.0, 180.0, 124.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 162.0, 166.0, 164.0, 164.0, 166.0, 164.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 177.0, 76.0, 75.0, 74.0, 77.0, 159.0, 85.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 152.0, 87.0, 86.0, 84.0, 141.0, 84.0, 85.0, 137.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 148.0, 148.0, 148.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 99.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 52.0, 55.0, 53.0, 54.0, 52.0, 52.0, 51.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 59.0, 61.0, 60.0, 60.0, 60.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 77.0, 76.0, 76.0, 76.0, 108.0, 77.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 120.0, 119.0, 137.0, 130.0, 127.0, 120.0, 127.0, 127.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 156.0, 152.0, 158.0, 149.0, 152.0, 152.0, 150.0, 152.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 64.0], "value": 62.2, "unit": "score"}]}]} 17:40:34 INFO - Return code: 0 17:40:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:40:34 ERROR - # TBPL SUCCESS # 17:40:34 INFO - Running post-action listener: _resource_record_post_action 17:40:34 INFO - ##### 17:40:34 INFO - ##### Finished run-tests step (success) 17:40:34 INFO - ##### 17:40:34 INFO - Running post-run listener: _resource_record_post_run 17:40:34 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 505442304; Read time: 212; Write time: 463200 17:40:34 INFO - TinderboxPrint: CPU usage
13.5% 17:40:34 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 212 17:40:34 INFO - TinderboxPrint: I/O write bytes / time
505,442,304 / 463,200 17:40:34 INFO - TinderboxPrint: CPU idle
8,202.6 (86.5%) 17:40:34 INFO - TinderboxPrint: CPU user
1,217.5 (12.8%) 17:40:34 INFO - TinderboxPrint: Swap in / out
0 / 0 17:40:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 252534784; Read time: 200; Write time: 275036 17:40:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252321792; Read time: 12; Write time: 188156 17:40:34 INFO - Running post-run listener: _upload_blobber_files 17:40:34 INFO - Blob upload gear active. 17:40:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:40:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:40:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:40:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:40:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:40:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:39 INFO - (blobuploader) - INFO - Done attempting. 17:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:40 INFO - (blobuploader) - INFO - Done attempting. 17:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:41 INFO - (blobuploader) - INFO - Done attempting. 17:40:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:41 INFO - Return code: 0 17:40:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fcbc61cda0214b5d24b2a2c209c9bd312114ca045ab9bfffc50fff697609c97b5c245ba77464a397421fca9037527168670c63383bd3b9f9f04620b0b781b74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f293fb208009cdfa13fe971fa33d5f3ab7138fcfe60079f112e7cc6459834fa02f669dfee587f9bc017f64e76ed7693d7079e007022eda670fda4cde395fc028", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/774fe6658381199cf71d19fe7629fcc701a600430ec51cf7fd62cad52d8ff2a5ae75ab77d3830f2f90622a06bfcb4a2d1bfb6518961fad1c463bcd4b03d12325"} 17:40:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:41 INFO - Contents: 17:40:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fcbc61cda0214b5d24b2a2c209c9bd312114ca045ab9bfffc50fff697609c97b5c245ba77464a397421fca9037527168670c63383bd3b9f9f04620b0b781b74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f293fb208009cdfa13fe971fa33d5f3ab7138fcfe60079f112e7cc6459834fa02f669dfee587f9bc017f64e76ed7693d7079e007022eda670fda4cde395fc028", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/774fe6658381199cf71d19fe7629fcc701a600430ec51cf7fd62cad52d8ff2a5ae75ab77d3830f2f90622a06bfcb4a2d1bfb6518961fad1c463bcd4b03d12325"} 17:40:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:41 INFO - Copying logs to upload dir... 17:40:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.570269 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-28 17:40:41.723423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 17:40:41.726590) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922 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/2fcbc61cda0214b5d24b2a2c209c9bd312114ca045ab9bfffc50fff697609c97b5c245ba77464a397421fca9037527168670c63383bd3b9f9f04620b0b781b74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f293fb208009cdfa13fe971fa33d5f3ab7138fcfe60079f112e7cc6459834fa02f669dfee587f9bc017f64e76ed7693d7079e007022eda670fda4cde395fc028", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/774fe6658381199cf71d19fe7629fcc701a600430ec51cf7fd62cad52d8ff2a5ae75ab77d3830f2f90622a06bfcb4a2d1bfb6518961fad1c463bcd4b03d12325"} build_url:https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/Hnl6SIdVSq-B2mbB9cFXGw/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/2fcbc61cda0214b5d24b2a2c209c9bd312114ca045ab9bfffc50fff697609c97b5c245ba77464a397421fca9037527168670c63383bd3b9f9f04620b0b781b74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f293fb208009cdfa13fe971fa33d5f3ab7138fcfe60079f112e7cc6459834fa02f669dfee587f9bc017f64e76ed7693d7079e007022eda670fda4cde395fc028", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/774fe6658381199cf71d19fe7629fcc701a600430ec51cf7fd62cad52d8ff2a5ae75ab77d3830f2f90622a06bfcb4a2d1bfb6518961fad1c463bcd4b03d12325"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 17:40:41.753674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:40:41.754296) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469749476.518088-1147469922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:40:41.838675) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 17:40:41.839339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 17:40:41.839739) ========= ========= Total master_lag: 0.18 =========