builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1465500805.66 results: success (0) buildid: 20160609120133 builduid: 2ee9e6e2ee704bd18a1095cd340c0d5a revision: 4d03f2c0d7175b2f37f21b02d14316439dbc56e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:25.658370) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:25.658759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:25.659029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:25.715825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:25.716125) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 12:33:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-09 12:33:26 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.341015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.071146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.074505) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017644 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.124200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.124559) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d03f2c0d7175b2f37f21b02d14316439dbc56e6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4d03f2c0d7175b2f37f21b02d14316439dbc56e6 --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=74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 12:33:26,710 truncating revision to first 12 chars 2016-06-09 12:33:26,711 Setting DEBUG logging. 2016-06-09 12:33:26,711 attempt 1/10 2016-06-09 12:33:26,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d03f2c0d717?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 12:33:27,008 unpacking tar archive at: fx-team-4d03f2c0d717/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.807096) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.807448) ========= script_repo_revision: 4d03f2c0d7175b2f37f21b02d14316439dbc56e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.807961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.808235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:33:26.820255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-06-09 12:33:26.820564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:33:27 INFO - MultiFileLogger online at 20160609 12:33:27 in /builds/slave/test 12:33:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:33:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:33:27 INFO - {'append_to_log': False, 12:33:27 INFO - 'base_work_dir': '/builds/slave/test', 12:33:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:33:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:33:27 INFO - 'branch': 'Fx-Team-Non-PGO', 12:33:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:33:27 INFO - 'config_files': ('talos/linux_config.py',), 12:33:27 INFO - 'default_actions': ('clobber', 12:33:27 INFO - 'read-buildbot-config', 12:33:27 INFO - 'download-and-extract', 12:33:27 INFO - 'populate-webroot', 12:33:27 INFO - 'create-virtualenv', 12:33:27 INFO - 'install', 12:33:27 INFO - 'run-tests'), 12:33:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:33:27 INFO - 'download_minidump_stackwalk': True, 12:33:27 INFO - 'download_symbols': 'ondemand', 12:33:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:33:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:33:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:33:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:33:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:33:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:33:27 INFO - 'installer_path': 'installer.exe', 12:33:27 INFO - 'log_level': 'info', 12:33:27 INFO - 'log_name': 'talos', 12:33:27 INFO - 'log_to_console': True, 12:33:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:33:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:33:27 INFO - 'opt_config_files': (), 12:33:27 INFO - 'pip_index': False, 12:33:27 INFO - 'sps_profile': False, 12:33:27 INFO - 'sps_profile_interval': 0, 12:33:27 INFO - 'suite': 'dromaeojs-e10s', 12:33:27 INFO - 'system_bits': '32', 12:33:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:33:27 INFO - 'title': 'talos-linux64-ix-042', 12:33:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:33:27 INFO - 'use_talos_json': True, 12:33:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:33:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:33:27 INFO - 'work_dir': 'build'} 12:33:27 INFO - ##### 12:33:27 INFO - ##### Running clobber step. 12:33:27 INFO - ##### 12:33:27 INFO - Running pre-action listener: _resource_record_pre_action 12:33:27 INFO - Running main action method: clobber 12:33:27 INFO - rmtree: /builds/slave/test/build 12:33:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:33:27 INFO - Running post-action listener: _resource_record_post_action 12:33:27 INFO - ##### 12:33:27 INFO - ##### Finished clobber step (success) 12:33:27 INFO - ##### 12:33:27 INFO - ##### 12:33:27 INFO - ##### Running read-buildbot-config step. 12:33:27 INFO - ##### 12:33:27 INFO - Running pre-action listener: _resource_record_pre_action 12:33:27 INFO - Running main action method: read_buildbot_config 12:33:27 INFO - Using buildbot properties: 12:33:27 INFO - { 12:33:27 INFO - "project": "", 12:33:27 INFO - "product": "firefox", 12:33:27 INFO - "script_repo_revision": "production", 12:33:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:33:27 INFO - "repository": "", 12:33:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:33:27 INFO - "buildid": "20160609120133", 12:33:27 INFO - "pgo_build": "False", 12:33:27 INFO - "basedir": "/builds/slave/test", 12:33:27 INFO - "buildnumber": 1578, 12:33:27 INFO - "slavename": "talos-linux64-ix-042", 12:33:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:33:27 INFO - "platform": "ubuntu64_hw", 12:33:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:33:27 INFO - "branch": "fx-team", 12:33:27 INFO - "repo_path": "integration/fx-team", 12:33:27 INFO - "revision": "4d03f2c0d7175b2f37f21b02d14316439dbc56e6", 12:33:27 INFO - "stage_platform": "linux64", 12:33:27 INFO - "builduid": "2ee9e6e2ee704bd18a1095cd340c0d5a", 12:33:27 INFO - "slavebuilddir": "test" 12:33:27 INFO - } 12:33:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:33:27 INFO - Running post-action listener: _resource_record_post_action 12:33:27 INFO - ##### 12:33:27 INFO - ##### Finished read-buildbot-config step (success) 12:33:27 INFO - ##### 12:33:27 INFO - ##### 12:33:27 INFO - ##### Running download-and-extract step. 12:33:27 INFO - ##### 12:33:27 INFO - Running pre-action listener: _resource_record_pre_action 12:33:27 INFO - Running main action method: download_and_extract 12:33:27 INFO - mkdir: /builds/slave/test/build/tests 12:33:27 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')]} 12:33:27 INFO - https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:33:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:33:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:33:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:33:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:33:30 INFO - Downloaded 1361 bytes. 12:33:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:33:30 INFO - Using the following test package requirements: 12:33:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:33:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:33:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:33:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'jsshell-linux-x86_64.zip'], 12:33:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:33:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:33:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:33:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:33:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:33:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:33:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:33:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:33:30 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')]} 12:33:30 INFO - https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:33:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:33:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:33:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:33:36 INFO - Downloaded 22879604 bytes. 12:33:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:33:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:33:37 INFO - Return code: 0 12:33:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:33: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')]} 12:33:37 INFO - https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:33:38 INFO - Downloaded 22879604 bytes. 12:33:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:33:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:33:40 INFO - Return code: 0 12:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:40 INFO - https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:33:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:33:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:33:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:33:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:33:41 INFO - Downloaded 10833377 bytes. 12:33:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:33:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:33:42 INFO - Return code: 0 12:33: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')]} 12:33:42 INFO - https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:33:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:33:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:33:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:34:06 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:34:06 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 12:34:06 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 12:34:06 INFO - Server: 10.26.75.40 12:34:06 INFO - Address: 10.26.75.40#53 12:34:06 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 12:34:06 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 12:34:06 INFO - Address: 10.26.48.46 12:34:06 INFO - Return code: 0 12:34:06 INFO - retry: attempt #1 caught exception: 12:34:06 INFO - retry: Failed, sleeping 30 seconds before retrying 12:34:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 12:34:48 INFO - Downloaded 55367236 bytes. 12:34:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:34:48 INFO - mkdir: /builds/slave/test/properties 12:34:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:48 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:48 INFO - Contents: 12:34:48 INFO - build_url:https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:34:49 INFO - Running post-action listener: _resource_record_post_action 12:34:49 INFO - Running post-action listener: set_extra_try_arguments 12:34:49 INFO - ##### 12:34:49 INFO - ##### Finished download-and-extract step (success) 12:34:49 INFO - ##### 12:34:49 INFO - ##### 12:34:49 INFO - ##### Running populate-webroot step. 12:34:49 INFO - ##### 12:34:49 INFO - Running pre-action listener: _resource_record_pre_action 12:34:49 INFO - Running main action method: populate_webroot 12:34:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:49 INFO - '--tppagecycles', 12:34:49 INFO - '7'], 12:34:49 INFO - 'tests': ['tsvgm']}}, 12:34:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:34:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:34:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['damp', 'tps']}, 12:34:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'tests': ['damp', 'tps']}, 12:34:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['dromaeo_dom']}, 12:34:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['a11yr', 12:34:49 INFO - 'ts_paint', 12:34:49 INFO - 'tpaint', 12:34:49 INFO - 'sessionrestore', 12:34:49 INFO - 'sessionrestore_no_auto_restore', 12:34:49 INFO - 'tabpaint']}, 12:34:49 INFO - 'other-e10s': {'tests': ['a11yr', 12:34:49 INFO - 'ts_paint', 12:34:49 INFO - 'tpaint', 12:34:49 INFO - 'sessionrestore', 12:34:49 INFO - 'sessionrestore_no_auto_restore', 12:34:49 INFO - 'tabpaint']}, 12:34:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:34:49 INFO - 'ts_paint', 12:34:49 INFO - 'tpaint', 12:34:49 INFO - 'sessionrestore', 12:34:49 INFO - 'sessionrestore_no_auto_restore', 12:34:49 INFO - 'tabpaint']}, 12:34:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:34:49 INFO - 'ts_paint', 12:34:49 INFO - 'tpaint', 12:34:49 INFO - 'sessionrestore', 12:34:49 INFO - 'sessionrestore_no_auto_restore', 12:34:49 INFO - 'tabpaint']}, 12:34:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['a11yr', 12:34:49 INFO - 'ts_paint', 12:34:49 INFO - 'tpaint', 12:34:49 INFO - 'sessionrestore', 12:34:49 INFO - 'sessionrestore_no_auto_restore', 12:34:49 INFO - 'tabpaint']}, 12:34:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['a11yr', 12:34:49 INFO - 'ts_paint', 12:34:49 INFO - 'tpaint', 12:34:49 INFO - 'sessionrestore', 12:34:49 INFO - 'sessionrestore_no_auto_restore', 12:34:49 INFO - 'tabpaint']}, 12:34:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['tsvgx', 12:34:49 INFO - 'tsvgr_opacity', 12:34:49 INFO - 'tart', 12:34:49 INFO - 'tscrollx', 12:34:49 INFO - 'cart']}, 12:34:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:34:49 INFO - 'tsvgr_opacity', 12:34:49 INFO - 'tart', 12:34:49 INFO - 'tscrollx', 12:34:49 INFO - 'cart']}, 12:34:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'talos_options': ['--disable-e10s'], 12:34:49 INFO - 'tests': ['tp5o']}, 12:34:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'tests': ['tp5o']}, 12:34:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'talos_options': ['--disable-e10s', 12:34:49 INFO - '--xperf_path', 12:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:49 INFO - 'tests': ['tp5n']}, 12:34:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:49 INFO - 'talos_options': ['--xperf_path', 12:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:49 INFO - 'tests': ['tp5n']}}, 12:34:49 INFO - 'talos.zip': {'path': '', 12:34:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:49 INFO - Running post-action listener: _resource_record_post_action 12:34:49 INFO - ##### 12:34:49 INFO - ##### Finished populate-webroot step (success) 12:34:49 INFO - ##### 12:34:49 INFO - ##### 12:34:49 INFO - ##### Running create-virtualenv step. 12:34:49 INFO - ##### 12:34:49 INFO - Running pre-action listener: _resource_record_pre_action 12:34:49 INFO - Running main action method: create_virtualenv 12:34:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:49 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 12:34:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:49 INFO - Using real prefix '/usr' 12:34:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:34:51 INFO - Installing pip.................done. 12:34:51 INFO - Return code: 0 12:34:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:34:51 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')]} 12:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:51 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')]} 12:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:51 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:34:51 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 12:34:51 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 12:34:51 INFO - Using env: {'DISPLAY': ':0', 12:34:51 INFO - 'HOME': '/home/cltbld', 12:34:51 INFO - 'LANG': 'en_US.UTF-8', 12:34:51 INFO - 'LANGUAGE': 'en_US:en', 12:34:51 INFO - 'LOGNAME': 'cltbld', 12:34:51 INFO - 'MAIL': '/var/mail/cltbld', 12:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:51 INFO - 'MOZ_NO_REMOTE': '1', 12:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:51 INFO - 'NO_EM_RESTART': '1', 12:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:51 INFO - 'PWD': '/builds/slave/test', 12:34:51 INFO - 'SHELL': '/bin/bash', 12:34:51 INFO - 'SHLVL': '1', 12:34:51 INFO - 'TERM': 'linux', 12:34:51 INFO - 'TMOUT': '86400', 12:34:51 INFO - 'USER': 'cltbld', 12:34:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:51 INFO - '_': '/tools/buildbot/bin/python'} 12:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:51 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 12:34:51 INFO - Cleaning up... 12:34:51 INFO - Return code: 0 12:34:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:34:51 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')]} 12:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:51 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')]} 12:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:51 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:34:51 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 12:34:51 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 12:34:51 INFO - Using env: {'DISPLAY': ':0', 12:34:51 INFO - 'HOME': '/home/cltbld', 12:34:51 INFO - 'LANG': 'en_US.UTF-8', 12:34:51 INFO - 'LANGUAGE': 'en_US:en', 12:34:51 INFO - 'LOGNAME': 'cltbld', 12:34:51 INFO - 'MAIL': '/var/mail/cltbld', 12:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:51 INFO - 'MOZ_NO_REMOTE': '1', 12:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:51 INFO - 'NO_EM_RESTART': '1', 12:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:51 INFO - 'PWD': '/builds/slave/test', 12:34:51 INFO - 'SHELL': '/bin/bash', 12:34:51 INFO - 'SHLVL': '1', 12:34:51 INFO - 'TERM': 'linux', 12:34:51 INFO - 'TMOUT': '86400', 12:34:51 INFO - 'USER': 'cltbld', 12:34:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:51 INFO - '_': '/tools/buildbot/bin/python'} 12:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:52 INFO - Downloading/unpacking psutil>=3.1.1 12:34:52 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 12:34:52 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 12:34:52 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 12:34:52 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 12:34:52 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 12:34:52 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 12:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:54 INFO - Installing collected packages: psutil 12:34:54 INFO - Running setup.py install for psutil 12:34:54 INFO - building 'psutil._psutil_linux' extension 12:34:54 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 12:34:54 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 12:34:54 INFO - building 'psutil._psutil_posix' extension 12:34:54 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 12:34:54 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 12:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:54 INFO - Successfully installed psutil 12:34:54 INFO - Cleaning up... 12:34:54 INFO - Return code: 0 12:34:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:34:54 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')]} 12:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:54 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')]} 12:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:54 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:34:54 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 12:34:54 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 12:34:54 INFO - Using env: {'DISPLAY': ':0', 12:34:54 INFO - 'HOME': '/home/cltbld', 12:34:54 INFO - 'LANG': 'en_US.UTF-8', 12:34:54 INFO - 'LANGUAGE': 'en_US:en', 12:34:54 INFO - 'LOGNAME': 'cltbld', 12:34:54 INFO - 'MAIL': '/var/mail/cltbld', 12:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:54 INFO - 'MOZ_NO_REMOTE': '1', 12:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:54 INFO - 'NO_EM_RESTART': '1', 12:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:54 INFO - 'PWD': '/builds/slave/test', 12:34:54 INFO - 'SHELL': '/bin/bash', 12:34:54 INFO - 'SHLVL': '1', 12:34:54 INFO - 'TERM': 'linux', 12:34:54 INFO - 'TMOUT': '86400', 12:34:54 INFO - 'USER': 'cltbld', 12:34:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:54 INFO - '_': '/tools/buildbot/bin/python'} 12:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:34:54 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 12:34:54 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 12:34:54 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 12:34:54 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 12:34:54 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 12:34:54 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 12:34:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:34:56 INFO - Installing collected packages: mozsystemmonitor 12:34:56 INFO - Running setup.py install for mozsystemmonitor 12:34:56 INFO - Successfully installed mozsystemmonitor 12:34:56 INFO - Cleaning up... 12:34:56 INFO - Return code: 0 12:34:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:34:56 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')]} 12:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:56 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')]} 12:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:56 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:34:56 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 12:34:56 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 12:34:56 INFO - Using env: {'DISPLAY': ':0', 12:34:56 INFO - 'HOME': '/home/cltbld', 12:34:56 INFO - 'LANG': 'en_US.UTF-8', 12:34:56 INFO - 'LANGUAGE': 'en_US:en', 12:34:56 INFO - 'LOGNAME': 'cltbld', 12:34:56 INFO - 'MAIL': '/var/mail/cltbld', 12:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:56 INFO - 'MOZ_NO_REMOTE': '1', 12:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:56 INFO - 'NO_EM_RESTART': '1', 12:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:56 INFO - 'PWD': '/builds/slave/test', 12:34:56 INFO - 'SHELL': '/bin/bash', 12:34:56 INFO - 'SHLVL': '1', 12:34:56 INFO - 'TERM': 'linux', 12:34:56 INFO - 'TMOUT': '86400', 12:34:56 INFO - 'USER': 'cltbld', 12:34:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:56 INFO - '_': '/tools/buildbot/bin/python'} 12:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:57 INFO - Downloading/unpacking jsonschema==2.5.1 12:34:57 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 12:34:57 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 12:34:57 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 12:34:57 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 12:34:57 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 12:34:57 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 12:34:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:34:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:34:58 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 12:34:58 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 12:34:58 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 12:34:58 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 12:34:58 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 12:34:58 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 12:34:59 INFO - Downloading functools32-3.2.3-2.tar.gz 12:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:34:59 INFO - warning: no files found matching '*.txt' 12:34:59 INFO - no previously-included directories found matching 'build' 12:34:59 INFO - no previously-included directories found matching 'dist' 12:34:59 INFO - no previously-included directories found matching '.git*' 12:34:59 INFO - Installing collected packages: jsonschema, functools32 12:34:59 INFO - Running setup.py install for functools32 12:34:59 INFO - warning: no files found matching '*.txt' 12:34:59 INFO - no previously-included directories found matching 'build' 12:34:59 INFO - no previously-included directories found matching 'dist' 12:34:59 INFO - no previously-included directories found matching '.git*' 12:34:59 INFO - Successfully installed jsonschema functools32 12:34:59 INFO - Cleaning up... 12:34:59 INFO - Return code: 0 12:34:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:59 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:34:59 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 12:34:59 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 12:34:59 INFO - Using env: {'DISPLAY': ':0', 12:34:59 INFO - 'HOME': '/home/cltbld', 12:34:59 INFO - 'LANG': 'en_US.UTF-8', 12:34:59 INFO - 'LANGUAGE': 'en_US:en', 12:34:59 INFO - 'LOGNAME': 'cltbld', 12:34:59 INFO - 'MAIL': '/var/mail/cltbld', 12:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:59 INFO - 'MOZ_NO_REMOTE': '1', 12:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:59 INFO - 'NO_EM_RESTART': '1', 12:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:59 INFO - 'PWD': '/builds/slave/test', 12:34:59 INFO - 'SHELL': '/bin/bash', 12:34:59 INFO - 'SHLVL': '1', 12:34:59 INFO - 'TERM': 'linux', 12:34:59 INFO - 'TMOUT': '86400', 12:34:59 INFO - 'USER': 'cltbld', 12:34:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:59 INFO - '_': '/tools/buildbot/bin/python'} 12:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:59 INFO - Downloading/unpacking blobuploader==1.2.4 12:34:59 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 12:34:59 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 12:34:59 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 12:34:59 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 12:34:59 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 12:34:59 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 12:35:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:35:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:35:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:02 INFO - Downloading docopt-0.6.1.tar.gz 12:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:35:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:35:02 INFO - Running setup.py install for blobuploader 12:35:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:35:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:35:02 INFO - Running setup.py install for requests 12:35:02 INFO - Running setup.py install for docopt 12:35:02 INFO - Successfully installed blobuploader requests docopt 12:35:02 INFO - Cleaning up... 12:35:02 INFO - Return code: 0 12:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:35:02 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 12:35:02 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 12:35:02 INFO - Using env: {'DISPLAY': ':0', 12:35:02 INFO - 'HOME': '/home/cltbld', 12:35:02 INFO - 'LANG': 'en_US.UTF-8', 12:35:02 INFO - 'LANGUAGE': 'en_US:en', 12:35:02 INFO - 'LOGNAME': 'cltbld', 12:35:02 INFO - 'MAIL': '/var/mail/cltbld', 12:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:02 INFO - 'MOZ_NO_REMOTE': '1', 12:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:02 INFO - 'NO_EM_RESTART': '1', 12:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:02 INFO - 'PWD': '/builds/slave/test', 12:35:02 INFO - 'SHELL': '/bin/bash', 12:35:02 INFO - 'SHLVL': '1', 12:35:02 INFO - 'TERM': 'linux', 12:35:02 INFO - 'TMOUT': '86400', 12:35:02 INFO - 'USER': 'cltbld', 12:35:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:02 INFO - '_': '/tools/buildbot/bin/python'} 12:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:03 INFO - Running setup.py (path:/tmp/pip-WyVADP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:03 INFO - Running setup.py (path:/tmp/pip-EgINPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:03 INFO - Running setup.py (path:/tmp/pip-MXn7QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:03 INFO - Running setup.py (path:/tmp/pip-cDdxpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:03 INFO - Running setup.py (path:/tmp/pip-OZua74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:03 INFO - Running setup.py (path:/tmp/pip-VRCho2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:03 INFO - Running setup.py (path:/tmp/pip-VkcL2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:03 INFO - Running setup.py (path:/tmp/pip-usj2VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:03 INFO - Running setup.py (path:/tmp/pip-EL10FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:03 INFO - Running setup.py (path:/tmp/pip-dgEsJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:03 INFO - Running setup.py (path:/tmp/pip-H7RVsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:03 INFO - Running setup.py (path:/tmp/pip-b57oNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:03 INFO - Running setup.py (path:/tmp/pip-uI50DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:04 INFO - Running setup.py (path:/tmp/pip-7IL4vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:04 INFO - Running setup.py (path:/tmp/pip-_xhz8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:04 INFO - Running setup.py (path:/tmp/pip-4KsIWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:04 INFO - Running setup.py (path:/tmp/pip-re4_YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:35:04 INFO - Running setup.py install for manifestparser 12:35:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:35:04 INFO - Running setup.py install for mozcrash 12:35:04 INFO - Running setup.py install for mozdebug 12:35:04 INFO - Running setup.py install for mozdevice 12:35:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:35:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:35:04 INFO - Running setup.py install for mozfile 12:35:04 INFO - Running setup.py install for mozhttpd 12:35:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:35:04 INFO - Running setup.py install for mozinfo 12:35:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Running setup.py install for mozInstall 12:35:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Running setup.py install for mozleak 12:35:05 INFO - Running setup.py install for mozlog 12:35:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Running setup.py install for moznetwork 12:35:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Running setup.py install for mozprocess 12:35:05 INFO - Running setup.py install for mozprofile 12:35:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Running setup.py install for mozrunner 12:35:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:35:05 INFO - Running setup.py install for mozscreenshot 12:35:05 INFO - Running setup.py install for moztest 12:35:05 INFO - Running setup.py install for mozversion 12:35:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:35:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:35:06 INFO - Cleaning up... 12:35:06 INFO - Return code: 0 12:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:35:06 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 12:35:06 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 12:35:06 INFO - Using env: {'DISPLAY': ':0', 12:35:06 INFO - 'HOME': '/home/cltbld', 12:35:06 INFO - 'LANG': 'en_US.UTF-8', 12:35:06 INFO - 'LANGUAGE': 'en_US:en', 12:35:06 INFO - 'LOGNAME': 'cltbld', 12:35:06 INFO - 'MAIL': '/var/mail/cltbld', 12:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:06 INFO - 'MOZ_NO_REMOTE': '1', 12:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:06 INFO - 'NO_EM_RESTART': '1', 12:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:06 INFO - 'PWD': '/builds/slave/test', 12:35:06 INFO - 'SHELL': '/bin/bash', 12:35:06 INFO - 'SHLVL': '1', 12:35:06 INFO - 'TERM': 'linux', 12:35:06 INFO - 'TMOUT': '86400', 12:35:06 INFO - 'USER': 'cltbld', 12:35:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:06 INFO - '_': '/tools/buildbot/bin/python'} 12:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:06 INFO - Running setup.py (path:/tmp/pip-KisUkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:06 INFO - Running setup.py (path:/tmp/pip-8_frhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:06 INFO - Running setup.py (path:/tmp/pip-R3di6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:06 INFO - Running setup.py (path:/tmp/pip-Oa4zEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:06 INFO - Running setup.py (path:/tmp/pip-bT2aNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:06 INFO - Running setup.py (path:/tmp/pip-zTeLp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:06 INFO - Running setup.py (path:/tmp/pip-nmmgar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:06 INFO - Running setup.py (path:/tmp/pip-vRWpHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:06 INFO - Running setup.py (path:/tmp/pip-AtZrzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:06 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)) 12:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:06 INFO - Running setup.py (path:/tmp/pip-unaenC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:07 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)) 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:07 INFO - Running setup.py (path:/tmp/pip-OflnfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:07 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)) 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:07 INFO - Running setup.py (path:/tmp/pip-KCJ3yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:07 INFO - Running setup.py (path:/tmp/pip-qKOn52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:07 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)) 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:07 INFO - Running setup.py (path:/tmp/pip-9L5KZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:07 INFO - Running setup.py (path:/tmp/pip-CHWGXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:07 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)) 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:07 INFO - Running setup.py (path:/tmp/pip-PCOT9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:07 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)) 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:07 INFO - Running setup.py (path:/tmp/pip-IMcfG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:07 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)) 12:35:07 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)) 12:35:07 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)) 12:35:07 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)) 12:35:07 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)) 12:35:07 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)) 12:35:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:35:07 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 12:35:07 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 12:35:07 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 12:35:07 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 12:35:07 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 12:35:07 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 12:35:09 INFO - Downloading blessings-1.6.tar.gz 12:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:09 INFO - Installing collected packages: blessings 12:35:09 INFO - Running setup.py install for blessings 12:35:09 INFO - Successfully installed blessings 12:35:09 INFO - Cleaning up... 12:35:09 INFO - Return code: 0 12:35:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:09 INFO - Reading from file tmpfile_stdout 12:35:09 INFO - Current package versions: 12:35:09 INFO - argparse == 1.2.1 12:35:09 INFO - blessings == 1.6 12:35:09 INFO - blobuploader == 1.2.4 12:35:09 INFO - docopt == 0.6.1 12:35:09 INFO - functools32 == 3.2.3-2 12:35:09 INFO - jsonschema == 2.5.1 12:35:09 INFO - manifestparser == 1.1 12:35:09 INFO - mozInstall == 1.12 12:35:09 INFO - mozcrash == 0.17 12:35:09 INFO - mozdebug == 0.1 12:35:09 INFO - mozdevice == 0.48 12:35:09 INFO - mozfile == 1.2 12:35:09 INFO - mozhttpd == 0.7 12:35:09 INFO - mozinfo == 0.9 12:35:09 INFO - mozleak == 0.1 12:35:09 INFO - mozlog == 3.2 12:35:09 INFO - moznetwork == 0.27 12:35:09 INFO - mozprocess == 0.22 12:35:09 INFO - mozprofile == 0.28 12:35:09 INFO - mozrunner == 6.11 12:35:09 INFO - mozscreenshot == 0.1 12:35:09 INFO - mozsystemmonitor == 0.3 12:35:09 INFO - moztest == 0.7 12:35:09 INFO - mozversion == 1.4 12:35:09 INFO - psutil == 3.1.1 12:35:09 INFO - requests == 1.2.3 12:35:09 INFO - wsgiref == 0.1.2 12:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:09 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:35:09 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 12:35:09 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 12:35:09 INFO - Using env: {'DISPLAY': ':0', 12:35:09 INFO - 'HOME': '/home/cltbld', 12:35:09 INFO - 'LANG': 'en_US.UTF-8', 12:35:09 INFO - 'LANGUAGE': 'en_US:en', 12:35:09 INFO - 'LOGNAME': 'cltbld', 12:35:09 INFO - 'MAIL': '/var/mail/cltbld', 12:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:09 INFO - 'MOZ_NO_REMOTE': '1', 12:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:09 INFO - 'NO_EM_RESTART': '1', 12:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:09 INFO - 'PWD': '/builds/slave/test', 12:35:09 INFO - 'SHELL': '/bin/bash', 12:35:09 INFO - 'SHLVL': '1', 12:35:09 INFO - 'TERM': 'linux', 12:35:09 INFO - 'TMOUT': '86400', 12:35:09 INFO - 'USER': 'cltbld', 12:35:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:09 INFO - '_': '/tools/buildbot/bin/python'} 12:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 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)) 12:35:10 INFO - Cleaning up... 12:35:10 INFO - Return code: 0 12:35:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:10 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:35:10 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 12:35:10 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 12:35:10 INFO - Using env: {'DISPLAY': ':0', 12:35:10 INFO - 'HOME': '/home/cltbld', 12:35:10 INFO - 'LANG': 'en_US.UTF-8', 12:35:10 INFO - 'LANGUAGE': 'en_US:en', 12:35:10 INFO - 'LOGNAME': 'cltbld', 12:35:10 INFO - 'MAIL': '/var/mail/cltbld', 12:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:10 INFO - 'MOZ_NO_REMOTE': '1', 12:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:10 INFO - 'NO_EM_RESTART': '1', 12:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:10 INFO - 'PWD': '/builds/slave/test', 12:35:10 INFO - 'SHELL': '/bin/bash', 12:35:10 INFO - 'SHLVL': '1', 12:35:10 INFO - 'TERM': 'linux', 12:35:10 INFO - 'TMOUT': '86400', 12:35:10 INFO - 'USER': 'cltbld', 12:35:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:10 INFO - '_': '/tools/buildbot/bin/python'} 12:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:35:10 INFO - Cleaning up... 12:35:10 INFO - Return code: 0 12:35:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:10 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 0x7f85d11b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', '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 12:35:10 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 12:35:10 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 12:35:10 INFO - Using env: {'DISPLAY': ':0', 12:35:10 INFO - 'HOME': '/home/cltbld', 12:35:10 INFO - 'LANG': 'en_US.UTF-8', 12:35:10 INFO - 'LANGUAGE': 'en_US:en', 12:35:10 INFO - 'LOGNAME': 'cltbld', 12:35:10 INFO - 'MAIL': '/var/mail/cltbld', 12:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:10 INFO - 'MOZ_NO_REMOTE': '1', 12:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:10 INFO - 'NO_EM_RESTART': '1', 12:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:10 INFO - 'PWD': '/builds/slave/test', 12:35:10 INFO - 'SHELL': '/bin/bash', 12:35:10 INFO - 'SHLVL': '1', 12:35:10 INFO - 'TERM': 'linux', 12:35:10 INFO - 'TMOUT': '86400', 12:35:10 INFO - 'USER': 'cltbld', 12:35:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:10 INFO - '_': '/tools/buildbot/bin/python'} 12:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:10 INFO - Downloading/unpacking flake8 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:35:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:35:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:35:13 INFO - no previously-included directories found matching 'docs/_build' 12:35:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:35:13 INFO - Running setup.py install for pep8 12:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:35:13 INFO - no previously-included directories found matching 'docs/_build' 12:35:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:35:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:35:13 INFO - Cleaning up... 12:35:13 INFO - Return code: 0 12:35:13 INFO - Running post-action listener: _resource_record_post_action 12:35:13 INFO - Running post-action listener: _start_resource_monitoring 12:35:13 INFO - Starting resource monitoring. 12:35:13 INFO - ##### 12:35:13 INFO - ##### Finished create-virtualenv step (success) 12:35:13 INFO - ##### 12:35:13 INFO - ##### 12:35:13 INFO - ##### Running install step. 12:35:13 INFO - ##### 12:35:13 INFO - Running pre-action listener: _resource_record_pre_action 12:35:13 INFO - Running main action method: install 12:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:13 INFO - Reading from file tmpfile_stdout 12:35:13 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:13 INFO - Reading from file tmpfile_stdout 12:35:13 INFO - Output received: 12:35:13 INFO - Usage: mozinstall [options] installer 12:35:13 INFO - Options: 12:35:13 INFO - -h, --help show this help message and exit 12:35:13 INFO - -d DEST, --destination=DEST 12:35:13 INFO - Directory to install application into. [default: 12:35:13 INFO - "/builds/slave/test"] 12:35:13 INFO - --app=APP Application being installed. [default: firefox] 12:35:13 INFO - mkdir: /builds/slave/test/build/application 12:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:35:29 INFO - Reading from file tmpfile_stdout 12:35:29 INFO - Output received: 12:35:29 INFO - /builds/slave/test/build/application/firefox/firefox 12:35:29 INFO - Running post-action listener: _resource_record_post_action 12:35:29 INFO - ##### 12:35:29 INFO - ##### Finished install step (success) 12:35:29 INFO - ##### 12:35:29 INFO - ##### 12:35:29 INFO - ##### Running run-tests step. 12:35:29 INFO - ##### 12:35:29 INFO - Running pre-action listener: _resource_record_pre_action 12:35:29 INFO - Running main action method: run_tests 12:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:29 INFO - Python 2.7.3 12:35:29 INFO - Return code: 0 12:35:29 INFO - grabbing minidump binary from tooltool 12:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:29 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 0xf362e0>, '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 0xea2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:29 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 12:35:29 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 12:35:29 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 12:35:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:29 INFO - Return code: 0 12:35:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:35:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:35:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:35:30 INFO - Return code: 0 12:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 12:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 12:35:30 INFO - Using env: {'DISPLAY': ':0', 12:35:30 INFO - 'HOME': '/home/cltbld', 12:35:30 INFO - 'LANG': 'en_US.UTF-8', 12:35:30 INFO - 'LANGUAGE': 'en_US:en', 12:35:30 INFO - 'LOGNAME': 'cltbld', 12:35:30 INFO - 'MAIL': '/var/mail/cltbld', 12:35:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:30 INFO - 'MOZ_NO_REMOTE': '1', 12:35:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:30 INFO - 'NO_EM_RESTART': '1', 12:35:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:30 INFO - 'PWD': '/builds/slave/test', 12:35:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:30 INFO - 'SHELL': '/bin/bash', 12:35:30 INFO - 'SHLVL': '1', 12:35:30 INFO - 'TERM': 'linux', 12:35:30 INFO - 'TMOUT': '86400', 12:35:30 INFO - 'USER': 'cltbld', 12:35:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308', 12:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:30 INFO - '_': '/tools/buildbot/bin/python'} 12:35:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 12:35:30 INFO - mozversion application_buildid: 20160609120133 12:35:30 INFO - mozversion application_changeset: 4d03f2c0d7175b2f37f21b02d14316439dbc56e6 12:35:30 INFO - mozversion application_display_name: Nightly 12:35:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:30 INFO - mozversion application_name: Firefox 12:35:30 INFO - mozversion application_remotingname: firefox 12:35:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:35:30 INFO - mozversion application_vendor: Mozilla 12:35:30 INFO - mozversion application_version: 50.0a1 12:35:30 INFO - mozversion platform_buildid: 20160609120133 12:35:30 INFO - mozversion platform_changeset: 4d03f2c0d7175b2f37f21b02d14316439dbc56e6 12:35:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:35:30 INFO - mozversion platform_version: 50.0a1 12:35:30 INFO - using testdate: 1465500930 12:35:30 INFO - actual date: 1465500930 12:35:30 INFO - starting webserver on 'localhost:33481' 12:35:30 INFO - SUITE-START | Running 2 tests 12:35:30 INFO - TEST-START | dromaeo_css 12:35:30 INFO - operating with platform_type : linux_ 12:35:30 INFO - Initialising browser for dromaeo_css test... 12:35:31 INFO - TEST-INFO | started process 14005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gpVxZ/profile http://localhost:33481/getInfo.html) 12:35:36 INFO - PROCESS | 14005 | __metrics Screen width/height:1600/1200 12:35:36 INFO - PROCESS | 14005 | colorDepth:24 12:35:36 INFO - PROCESS | 14005 | Browser inner width/height: 1024/697 12:35:36 INFO - PROCESS | 14005 | __metrics 12:35:36 ERROR - PROCESS | 14005 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 12:35:37 INFO - TEST-INFO | 14005: exit 0 12:35:37 INFO - Browser initialized. 12:35:37 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:37 INFO - TEST-INFO | started process 14124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gpVxZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:50 INFO - PROCESS | 14124 | RSS: Main: 185868288 12:35:50 INFO - PROCESS | 14124 | 12:36:39 INFO - PROCESS | 14124 | 1465500999764 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] 12:38:51 INFO - PROCESS | 14124 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33481/tests/dromaeo/cssquery-ext.html) 12:38:52 INFO - PROCESS | 14124 | RSS: Main: 188047360 12:38:52 INFO - PROCESS | 14124 | 12:41:54 INFO - PROCESS | 14124 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-ext.html (next: http://localhost:33481/tests/dromaeo/cssquery-jquery.html) 12:41:55 INFO - PROCESS | 14124 | RSS: Main: 187273216 12:41:55 INFO - PROCESS | 14124 | 12:44:57 INFO - PROCESS | 14124 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33481/tests/dromaeo/cssquery-mootools.html) 12:44:57 INFO - PROCESS | 14124 | RSS: Main: 188473344 12:44:57 INFO - PROCESS | 14124 | 12:47:59 INFO - PROCESS | 14124 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33481/tests/dromaeo/cssquery-prototype.html) 12:48:00 INFO - PROCESS | 14124 | RSS: Main: 186482688 12:48:00 INFO - PROCESS | 14124 | 12:51:02 INFO - PROCESS | 14124 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33481/tests/dromaeo/cssquery-yui.html) 12:51:03 INFO - PROCESS | 14124 | RSS: Main: 187678720 12:51:03 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | Cycle 1(1): loaded http://localhost:33481/tests/dromaeo/cssquery-yui.html (next: http://localhost:33481/tests/dromaeo/cssquery-dojo.html) 12:54:06 INFO - PROCESS | 14124 | RSS: Main: 189190144 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | __start_tp_report 12:54:06 INFO - PROCESS | 14124 | _x_x_mozilla_page_load 12:54:06 INFO - PROCESS | 14124 | _x_x_mozilla_page_load_details 12:54:06 INFO - PROCESS | 14124 | |i|pagename|runs| 12:54:06 INFO - PROCESS | 14124 | |0;dojo.html;2588.4823035392924;2663.334166458385;2676.85277309748;2682.2623778460907;2693.003588672193;4715.009847931934;4727.52724727527;4739.478657347693;4829.396325459317;4857.951420485794;4582.0606775611;4779.115863565243;4798.4961579034225;4806.807727690888;4833.105875413051;4327.956720432795;4411.867643970686;4444.755538445384;4466.240739074366;4467.195904737146;599.3302678547618;4276.123394704094;4330.39374487572;4371.3661519079715;4430.091831174617;4364.214441400547;4392.846250381253;4394.1870753910625;4410.184115938529;4419.4033805436175;4249.3413520904305;4407.184670835905;4427.46870375557;4432.71187372823;4465.240909045438;4290.034742183015;4308.547602501755;4326.069894972596;4329.696921215516;4338.631216346615;4777.474477807438;4790.664653474259;4793.832215872428;4794.664373493857;4867.099586576494;5073.518015788494;5077.593792496591;5130.333056702642;5166.767495462713;5201.739913004372;5156.767945442464;5168.198929165947;5174.508421699932;5180.792768289264;5204.661696989683;4814.735189564538;4817.22359273379;4824.445188803263;4831.275308703723;4836.830710925101;5264.183466986481;5281.841544753664;5286.286351342596;5305.151175811929;5313.123334649817;5023.296738456619;5060.620453466005;5074.16276314404;5075.264086707407;5114.207297868837;4971.030649023406;5169.017886601534;5169.560587350042;5173.767180476888;5174.560162386164;5068.087744206078;5100.56645185156;5126.077306084866;5132.640715149978;5134.178531434953;4889.608831293488;5024.648274620741;5044.899102017939;5064.290999260106;5102.081625307406;4115.73247738896;4264.637505812041;4274.038341373166;4280.464941882265;4312.223799716018;3679.742418030712;3713.517242758478;3721.1999420124803;3748.212875296164;3777.0746167189213;4489.932651010237;4501.257292546693;4501.572350626685;4508.774561271924;4542.795574199103;5152.742362881841;5155.716435596003;5162;5162.92255616166;5199.896002080013;4541.227991241497;4544.772761361919;4548.931766023512;4558.794854231567;4562.726236425825;4573.451185857718;4584.243599806061;4584.816607335669;4602.309653551927;4630.953690463052;4758.904821903542;4859.514048595183;4866.440359358719;4896.706197628154;4930.6795058321095;5170.793168273227;5187.81842635521;5191.273221748883;5197.038547868657;5198.9740051299505;4906;4908.950910490992;4917.336159618406;4920.335754673073;4955.479674634255;5031.320771695774;5041.823536176216;5070.898582028265;5076.695398275968;5079.238114282739;5126.333576635014;5152.905578015298;5158.793648254028;5169.508896654812;5205.869853253699;4999.600031997505;5005.874853128701;5013.949860501349;5049.545540901337;5090.821821236239;4725.645576581839;5050.368703912011;5051.595872330278;5067.163917953497;5080.974595127149;4883.536064073907;4901.191303434894;4912.631552633496;4923.606111511142;4935.605151587936;4779.283107533898;5026.346574945233;5039.899202016012;5066.138756411493;5101.719405432588;4921.655484116078;4940.184869496493;4943.925841112458;4986.401631804207;5011.574016208518 12:54:06 INFO - PROCESS | 14124 | |1;ext.html;535.9656236309575;573.6328749600256;576.7519966414441;601.939806019398;617.9258488981322;34204;38178.61821381782;38610.22779544411;38696.613033869726;38762;38377.61622383775;38805;38881.41677874834;38908.416373754415;38967.22065558687;7799.142094369629;7893.329067029309;7909.920900791005;7922.564258965755;7928.286454219119;7668.501547399401;7714.074311082678;7758.495697779655;7830.647620857047;7838.804029899241;7807.219278072176;7835.059792824869;7852.371810255166;7882.881756773653;7892.210778922091;7814.531128132302;7859.528428294292;7873.094594121663;7877.330426913719;7883.054033516015;7709.7301594443925;7781.22187781223;7782;7796.376289896794;7822.413319001098;29771.10686679403;36959.260814783556;37425.25149496995;37431.625683743085;37522.81238593817;2668.7197844226466;2711.1188863619204;2857.5713642953724;2957.940841183186;3117.2986078132467;28174.577381339295;28651.283717907012;28898.27754306138;30111;30546.694533054608;3261.152100453899;3340.198352395432;3349.815760133192;3359.4925021964827;3363.697267245935;248176;250367;251217.7439112811;251271;252786;58250;59574.404255956884;59583;59716.40283597195;59730.40269597335;34193;34951.82524087363;35214.82392588072;37268.44097338542;60207.39792602018;15842.207889605705;15988.520344389686;16030.11834349122;16058.598535036717;16061.759073613905;11640.301581905112;11650.184487085991;11676;11696.473658685209;11696.47365868538;19400.5243921817;19406.417807465517;19459.7976848472;19467.33833107289;19637.90181049114;7255.709771609182;7430.517016393917;7513.436492263102;7525.285097915689;7725.922740772633;825.6532256452305;909.3997961345481;950.396498223633;977.4428575711918;1020.8979102089731;28274.434511309657;28929.132126036253;28940.27649308784;29013.56479652807;29630.703692962794;983.4492684096929;992.8808542974889;1032.4785983078498;1039.142707266493;1069.2408390043001;14913.478028268959;15397.692046159014;15438.298297798065;15585.922070389575;15592.92203538975;383412;386719;389756;390246;390402;50677.74661126671;51275;51646;51752.22371664428;51794.74102629463;1127.622246547416;1170.6546568762064;1197.6945878801025;1198.1253684810138;1216.5924415320967;27614;28256.576151357334;28317.71682283151;28548.714512854607;28938.855305723337;43392.56607433885;43822;43874;43912.780436097615;44011.11977760491;325444;325497;328096;328294;329105;26309.736902630728;26325.473490530465;26929.865350673907;26969.730302697506;26987.595186072616;43433;43588.56411435845;43627;44077.55922440735;44174.55825441705;36457.270854583294;38049;38061.2387752249;38174.23651526898;38368.77943426277;36181.638183617826;36900.81549592235;37667.81166094152;38144.61855381522;40214.396784047676;36251.81874090613;36736.448953265186;36833.44749828701;36933.81533092317;37377.6262237385;32738.345233095682;34746.82626586952;34875.953721388396;34981;35149.29701406009;25886.482270354863;26463.735362646126;26489;26589.867050664623;26612.201633951012 12:54:06 INFO - PROCESS | 14124 | |2;jquery.html;347.35565525949363;349.5089399393852;355.68699544400926;360.3675549410787;368.22121213633176;15718.371265149395;16366.181690915451;16901.323947042136;16923.3230670773;16938.999999999985;15351.616209594766;16346.918265408685;16400.097994610293;16465.588360291;16637;4300.311950087978;4621.19129152397;4634.37435946148;4668.066386722669;4676.508966558514;2907.636545431821;4596.402467679197;5114.28400023997;5438.91841622376;5440.700761458118;5464.972675136639;5502.422245664207;5505.201745746865;5523.420040895709;5540.889182216353;5369.5167434930845;5427.891442171154;5507.862303442406;5521.5306698930435;5526.47498487643;5311.097113490716;5313.203019547099;5314.97342513285;5335.359756829166;5340.839774806762;10671.35971841692;11286.943565282121;11341.886581134166;11841.763164736743;11885.584004559885;1856.7307740377705;1865.7387965684816;1966.99016504918;1979.4655443030301;2175.369142948543;8759.868601970975;8987.505687187202;8990.460572365613;9244;13408.061435699505;1512.9243537823174;1578.3765412661935;1602.6153723106488;1610.919454027294;1632.9755053674205;66189.33810661928;66691;68753;68790.65604671995;69024;9599.808003840024;9668.613255469843;9978.451185184884;10069.98444790045;10176.898231017743;13485.730285394236;13500.797488037688;13575;13585.252811095485;13592.456301748018;7162.641867906584;7306.561606303639;7366.742164024341;7374.815629609196;7435.665395057235;6822.351876571718;7063.39961103312;7103.147622285359;7253.673584688701;7457.2542745724995;4262.360645903139;4288.871333859926;4298.742075475481;4318.805653745526;4389.385486031958;1648.3077107614831;1682.7812384389952;1781.768370111903;1793.2020250988185;1830.1764206107305;835.6323217784155;841.7138173021202;887.658251573149;895.8029233568604;956.321012081416;15892.92053539748;16581.336746530003;16627.750583741254;16646.417375391804;17174.22715977784;808.0747544062016;825.6573521988307;830.6511265268481;850.1456036683218;898.874157617934;9014.63941442348;9563.713088607214;9639.759006024906;9650.855237171449;9764.755881102887;373188;381621;386722;388504;389325;77445.61277193691;77876;80825;81409.18590814016;81432;861.440063958432;871.5337294547387;880.6785523283955;882.4528792148909;885.7298523950128;14520.201388923711;15010.624734381729;15231.466898658493;15276.465323713617;15313.310901009258;34008.42911494357;34357.656423435445;34413.13967150841;35295.82352088223;35745.28509429849;47929.76035119802;48296.5170348292;48399.27401089057;49160.50839491702;49342.75328623477;7251.311125443074;7358.484906056525;7367.594782287026;7433.702651893864;7543.698252069856;9964.302498825302;11330.716732081764;11571.884281157081;11581.305121692725;11987;9639.518024098907;9897.406155630686;9956.452395118338;9992.900070999198;10101.090901818872;10211.7447063824;10356.948215258875;10410.427426491615;10541.262111652417;10573.841392378967;10091.495425228855;10225.846612300673;10366.896331036593;10394.688159355232;10441.164706823283;7182;7205.927940720526;7253.455990800606;7288.052553168266;7474.925250747423;7218.783436496913;8661.610227539903;9820.901790982;10467.424291664032;10574.788504230026 12:54:06 INFO - PROCESS | 14124 | |3;mootools.html;1366.7676494995853;1392.5543825975685;1445.8120444342235;1639.2049855819932;1649.2578339747117;6623.668816559177;7370.410367170627;7481.700731970728;7806.921930780691;7809.804754881124;7501.0998680158455;7668.769936901902;7681.116671582769;7723.073231212248;7747.380209583234;2084.041340983146;2133.8506304558687;2134;2138.17680193126;2138.8609740366905;2098.9790102099014;2124.915003399862;2173.71741673583;2180.029886700419;2180.978190218101;2149.215536329244;2161.6973623692697;2162.275637661385;2163.5132095278514;2186.5080356919643;2059.1351632314463;2063.66981282994;2064.6180456615575;2064.7109404683283;2067.989660051705;1986.8311193548566;2019.3437132931708;2023.0188358646044;2027.0067666843288;2113.17586141405;7797.610119494003;7826.8434631307055;7845.607719613997;7858.724944626968;7861.135275119789;4426.778661066934;4546.045330480603;4547.681662283641;4563.703359281636;4576.084783043405;2607.8304910180777;2675.0637276953107;2725.795565332588;2737.904173353943;2745.862706864669;862.4006315610653;864.3042350907517;873.3624454148508;874.5802015032756;894.6197865906963;10517.211209159344;10548.367097974146;10583;10589.36463812166;10612.575496980111;3990.182012687392;4022.718409711292;4089.5910408958866;4129.380592911028;4151.045259590311;8838.204561589488;8839.46963182211;8872.73381798547;8874.156955089256;8874.645014199488;4522.479914809774;4572.51988541205;4593.6095431888;4606.239970404913;4610.031893302377;3476.1830969722096;3970.1067259866877;4017.0760725033406;4215.241256573785;4223.809928553223;3513.3851575974104;3559.9110022249133;3620.25784714133;3622.7464077514846;3730.4963829882618;1162.7906976744098;1171.712930332057;1183.621241202824;1193.278066769592;1199.3583432863377;774.8256642255448;791.0665414810579;802.1617409806765;803.1286054630674;814.4421071565996;4970.627202959792;5016.197408414636;5027.296178535008;5045.419776725724;5121.897562048738;386.916812885231;389.5383969995564;399.4806751223456;400.3254516140313;407.0901535069118;3334.7165490933057;3494.178867966026;3529.0471572675233;3529.2059286660296;3549.94675079874;9203.125703058198;9497.810043799085;9576.23390128788;9583.712488625353;9599.088086631758;9419.24646028316;9487.715368538955;9541.570629321697;9583;9595.040495950489;6814.727410903607;7049.753258635923;7050.15398152225;7296.525725827804;7344.853102938018;4852.805887764591;4863.440704319049;4890.92663610039;4981.103401387785;5036.798528058836;8354.206350396702;8416;8542.871856922027;8578.485290882567;8610.397272190887;8345.082040975367;8566.443181193203;8616.956915215384;8651.740447786577;8728.563571821256;5649.576281778801;6213.937860621336;6215.564910456405;6361.173047503795;6364.459020983083;7099.82250443743;7157.85684286301;7169.139703235645;7199.172095208908;7228.31331023552;6310.778714441503;6319.431251187415;6329.778457753957;6477.222733272038;6605.141331626858;6269.3417191196095;6295.685215739286;6363.236411630634;6372.681365931778;6454.483641308778;5608.10270356741;5655.773769049192;5684.118961560965;5699.800506982236;5706.743196556248;4064.227796718614;4128.587141285848;4133.2973394522405;4191.392248124066;4265.5947684971115;4055.5538890721405;4090.1410703751353;4143.668506519411;4147.129102888427;4164.312888373384 12:54:06 INFO - PROCESS | 14124 | |4;prototype.html;287.28609405627014;289.7971420005996;290.0818908155687;292.36556672021715;292.9531274996001;5103.234514822774;5136.486351364862;5143.639945203838;5165.7158856262895;5180.093483640367;4998.950010499894;5004.549590536851;5025.145725226711;5036.722980236085;5052.317937078494;3692.353838078339;3817.7518461300065;3864.188520410717;3925;3931.410288456726;3889.2610404023144;3890.7471014384114;3907.5310962684516;3916.608339166089;3939.606039396066;3824.8470061197518;3887.8833634990856;3903.7657740535515;3910.7262491625456;3924.6271604197555;3793.639604237593;3857.3442514772555;3867.38121900496;3873.86441474547;3891.5135608049136;3379.5437615921783;3386.407378708741;3404.472306792451;3418;3431.605365382988;4883.19427294496;4899.7550122494085;4907.828226012072;4940;4958.404991401019;4353.825846966118;4456.331550267453;4459.843905463325;4468.75421851798;4478.731276123443;5218.920836706361;5233.790648374061;5264.6051546134195;5273.235380869753;5325.866853328659;3734.421164719473;3747.7001839852746;3757.9812100939594;3769.076576238839;3776.7922764247955;5434.402215756264;5465.966388654295;5479.232907392969;5492.857785463672;5506.834794956118;3480.3735327641266;3710.2023065040607;3712.294664013829;3717.1636381814415;3746.7002639788752;3738.831752571141;3757.384324740388;3763.5107436033686;3766.491523644273;3769.227308401771;4320.935185972213;4326.048269380732;4352.325389564622;4361.389405483234;4366.8908277292685;5154.098032844312;5207.6875387476875;5226.790928362823;5292;5318.388385335736;1281.1608396500308;1295.8574556798744;1296.2157894473708;1302.5896842494583;1304.9217046977212;790.9288164065262;809.9271065604124;826.9255766981;834.891464109674;839.6641343462542;4556.655786542978;4697.436307643105;4708.317293992352;4712.787924543404;4735.621150307967;5477.342718873681;5495.53287970519;5517.531009864127;5529.529989950899;5539.5014448699;4558.475775285819;4689.85930422081;4708.411448568929;4712.6229901607785;4742.620590352763;2919.5474701421313;2952.483315419793;2954.3943491584173;2960.481915664793;2965.4662160811263;5128.538431541179;5202.375714914235;5249.816256431007;5251;5251.632385732962;5293;5553.278073850373;5559.694216818033;5604.579656525777;5619.325680918316;5058.848234552969;5091.949080509147;5118.360204974379;5149;5185.781341384772;5469.371022332482;5479.150731636602;5504.339479262514;5505.642133261325;5525.364583072998;5047.369078865142;5302.549283310962;5326.6537675050995;5334.546563542142;5355.410904800547;5147.841735609458;5184.507471790174;5264.420913699567;5269;5302.125149350314;3788.8105594720705;3789.7915614640356;3797.905052373713;3799.1072098056384;3809.4666746654934;5131.2303154525625;5470.452954704498;5484.287042684585;5484.61607687458;5557.527610153183;5292.576593872558;5330.626856120034;5333.466653334635;5350.4382039886805;5350.545203657733;5184.9740751296;5208.270842082187;5277.366715993951;5309.283246761792;5348.679079255102;5190.506901844319;5240.868978275421;5243.711595862264;5256.4480729524375;5263.5525980292105;5123.5141808875005;5207.192885102815;5333.373306151699;5345.625806193685;5355.250264962986;5249.133892907627;5255.842324730264;5257.737113144404;5283.709395983258;5297.390800057889 12:54:06 INFO - PROCESS | 14124 | |5;yui.html;508.6134537751308;535.0502857428068;573.607079150782;597.8385835824328;615.1940957345877;10808.891911080897;11400.657980260585;11429.885701142986;11584.304941703504;11597.884021159785;11472.598459053936;12328.32194229317;12712.618621441372;12719.745605087892;12845.871541284585;620.1008537620446;760.954342739436;765.0704394161094;770.1682183242085;773.7794728502349;749.1833901047856;760.889670997705;762.8016715653943;765.2462324610254;770.7379490973068;805.5327909812295;809.9595020248994;811.8254575266317;811.8944537210184;816.2857499687773;804.2399932064202;805.0621026504116;805.2993895311088;806.5765473126597;807.229096213118;592.4460629311608;592.7836339736009;594.0910407077179;594.4976494861878;595.9582829201914;11987.160898737093;12020.879791202064;12044.096692748079;12048.975837053773;12078.27530348173;12695.74608507834;13355.532556360578;13479.932600337033;13595.456181752717;13789;9803.607855685765;10169.186465082776;10177.592896284139;10200.74498137545;10472.895271047344;3187.3943950649304;3231.96768032319;3310.966890331114;3328.473523956863;3361.1765117546115;56655;58517.99999999957;58844.705776470844;58865.41134588642;59009.704951475396;8307.8338433231;8851.247643950337;9279;9507.904920950841;9666.371685840399;17112.48662540126;18145.183466744027;18147.818521814876;18153.818461815477;18178.091095445176;6227.532935029891;6254.781082662176;6280.591761535486;6501.31736167705;6557.3442655735;3579.83890724918;3599.892003239907;3606.062423769786;3653.94519082214;3656.634336566322;2666.546687063204;2740.1505533284744;2747.6290700755544;2752.6696796384563;2902.680705122435;513.9691618502902;520.7031991764734;524.5855773938546;524.7638562646824;528.3052785586941;456.34058785055277;501.2105933155295;513.5352505982092;525.4377815737201;551.1347184919638;6516.674166291761;6754.45964322853;6796.422304104108;6866.210385805596;6878.828029299308;435.59054488780447;463.87011636741767;469.5633061253067;534.1480338859512;559.9640664770143;3392.118049307198;3402.6143986732864;3435.5362026126654;3514.8066856322635;3526.2594855080206;66634.66682666556;88439.55780221058;92692;93819.53090234505;94496.52751736334;50564.74717626462;57065.14402283969;71549.2845071553;76983.61508192423;78422;56089;72737;73904;74199.88700169502;74230.98839359816;6687.899681504684;6805.591664500146;6812.795616131524;6858.108445902001;6871.69582142768;31579;37631.81184094062;43629;43792.34311485394;45736.085278294915;56142.157867632835;56471.43528564662;57669.711651441474;63118.368816311246;63202;8830.911690883266;8835.69075082369;8854.557272136239;8873.112688731075;9064.320175986695;9473.47895865734;9940;9967.451790151612;10000.399976001463;10036.498175091363;8787.648494060166;8869.423487473294;9057.501837399006;9075.818483630159;9204.171624553823;8523.872141918;8527.275181609633;8538.445001075159;8709.216170544682;8777.692780752643;8313.584320783815;8352.832943340978;8394.286485648789;8410.789730256793;8413.495190288357;7309.963450182715;7448.366888814511;7495.812604684927;7522.134954480305;7523.811904702427;7208.783736487913;7528.924710752823;7586.582737949466;7601.163871973968;7613.6573854177805 12:54:06 INFO - PROCESS | 14124 | __end_tp_report 12:54:06 INFO - PROCESS | 14124 | __start_cc_report 12:54:06 INFO - PROCESS | 14124 | _x_x_mozilla_cycle_collect,395 12:54:06 INFO - PROCESS | 14124 | __end_cc_report 12:54:06 INFO - PROCESS | 14124 | __startTimestamp1465502046459__endTimestamp 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | ------- Summary: start ------- 12:54:06 INFO - PROCESS | 14124 | Number of tests: 6 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | [#0] dojo.html Cycles:165 Average:4721.00 Median:4901.19 stddev:604.55 (12.3%) stddev-sans-first:582.80 12:54:06 INFO - PROCESS | 14124 | Values: 2588.5 2663.3 2676.9 2682.3 2693.0 4715.0 4727.5 4739.5 4829.4 4858.0 4582.1 4779.1 4798.5 4806.8 4833.1 4328.0 4411.9 4444.8 4466.2 4467.2 599.3 4276.1 4330.4 4371.4 4430.1 4364.2 4392.8 4394.2 4410.2 4419.4 4249.3 4407.2 4427.5 4432.7 4465.2 4290.0 4308.5 4326.1 4329.7 4338.6 4777.5 4790.7 4793.8 4794.7 4867.1 5073.5 5077.6 5130.3 5166.8 5201.7 5156.8 5168.2 5174.5 5180.8 5204.7 4814.7 4817.2 4824.4 4831.3 4836.8 5264.2 5281.8 5286.3 5305.2 5313.1 5023.3 5060.6 5074.2 5075.3 5114.2 4971.0 5169.0 5169.6 5173.8 5174.6 5068.1 5100.6 5126.1 5132.6 5134.2 4889.6 5024.6 5044.9 5064.3 5102.1 4115.7 4264.6 4274.0 4280.5 4312.2 3679.7 3713.5 3721.2 3748.2 3777.1 4489.9 4501.3 4501.6 4508.8 4542.8 5152.7 5155.7 5162.0 5162.9 5199.9 4541.2 4544.8 4548.9 4558.8 4562.7 4573.5 4584.2 4584.8 4602.3 4631.0 4758.9 4859.5 4866.4 4896.7 4930.7 5170.8 5187.8 5191.3 5197.0 5199.0 4906.0 4909.0 4917.3 4920.3 4955.5 5031.3 5041.8 5070.9 5076.7 5079.2 5126.3 5152.9 5158.8 5169.5 5205.9 4999.6 5005.9 5013.9 5049.5 5090.8 4725.6 5050.4 5051.6 5067.2 5081.0 4883.5 4901.2 4912.6 4923.6 4935.6 4779.3 5026.3 5039.9 5066.1 5101.7 4921.7 4940.2 4943.9 4986.4 5011.6 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | [#1] ext.html Cycles:180 Average:47859.57 Median:36946.54 stddev:86011.73 (232.8%) stddev-sans-first:86179.63 12:54:06 INFO - PROCESS | 14124 | Values: 536.0 573.6 576.8 601.9 617.9 34204.0 38178.6 38610.2 38696.6 38762.0 38377.6 38805.0 38881.4 38908.4 38967.2 7799.1 7893.3 7909.9 7922.6 7928.3 7668.5 7714.1 7758.5 7830.6 7838.8 7807.2 7835.1 7852.4 7882.9 7892.2 7814.5 7859.5 7873.1 7877.3 7883.1 7709.7 7781.2 7782.0 7796.4 7822.4 29771.1 36959.3 37425.3 37431.6 37522.8 2668.7 2711.1 2857.6 2957.9 3117.3 28174.6 28651.3 28898.3 30111.0 30546.7 3261.2 3340.2 3349.8 3359.5 3363.7 248176.0 250367.0 251217.7 251271.0 252786.0 58250.0 59574.4 59583.0 59716.4 59730.4 34193.0 34951.8 35214.8 37268.4 60207.4 15842.2 15988.5 16030.1 16058.6 16061.8 11640.3 11650.2 11676.0 11696.5 11696.5 19400.5 19406.4 19459.8 19467.3 19637.9 7255.7 7430.5 7513.4 7525.3 7725.9 825.7 909.4 950.4 977.4 1020.9 28274.4 28929.1 28940.3 29013.6 29630.7 983.4 992.9 1032.5 1039.1 1069.2 14913.5 15397.7 15438.3 15585.9 15592.9 383412.0 386719.0 389756.0 390246.0 390402.0 50677.7 51275.0 51646.0 51752.2 51794.7 1127.6 1170.7 1197.7 1198.1 1216.6 27614.0 28256.6 28317.7 28548.7 28938.9 43392.6 43822.0 43874.0 43912.8 44011.1 325444.0 325497.0 328096.0 328294.0 329105.0 26309.7 26325.5 26929.9 26969.7 26987.6 43433.0 43588.6 43627.0 44077.6 44174.6 36457.3 38049.0 38061.2 38174.2 38368.8 36181.6 36900.8 37667.8 38144.6 40214.4 36251.8 36736.4 36833.4 36933.8 37377.6 32738.3 34746.8 34876.0 34981.0 35149.3 25886.5 26463.7 26489.0 26589.9 26612.2 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | [#2] jquery.html Cycles:180 Average:23673.41 Median:4672.29 stddev:63493.03 (1358.9%) stddev-sans-first:63646.99 12:54:06 INFO - PROCESS | 14124 | Values: 347.4 349.5 355.7 360.4 368.2 15718.4 16366.2 16901.3 16923.3 16939.0 15351.6 16346.9 16400.1 16465.6 16637.0 4300.3 4621.2 4634.4 4668.1 4676.5 2907.6 4596.4 5114.3 5438.9 5440.7 5465.0 5502.4 5505.2 5523.4 5540.9 5369.5 5427.9 5507.9 5521.5 5526.5 5311.1 5313.2 5315.0 5335.4 5340.8 10671.4 11286.9 11341.9 11841.8 11885.6 1856.7 1865.7 1967.0 1979.5 2175.4 8759.9 8987.5 8990.5 9244.0 13408.1 1512.9 1578.4 1602.6 1610.9 1633.0 66189.3 66691.0 68753.0 68790.7 69024.0 9599.8 9668.6 9978.5 10070.0 10176.9 13485.7 13500.8 13575.0 13585.3 13592.5 7162.6 7306.6 7366.7 7374.8 7435.7 6822.4 7063.4 7103.1 7253.7 7457.3 4262.4 4288.9 4298.7 4318.8 4389.4 1648.3 1682.8 1781.8 1793.2 1830.2 835.6 841.7 887.7 895.8 956.3 15892.9 16581.3 16627.8 16646.4 17174.2 808.1 825.7 830.7 850.1 898.9 9014.6 9563.7 9639.8 9650.9 9764.8 373188.0 381621.0 386722.0 388504.0 389325.0 77445.6 77876.0 80825.0 81409.2 81432.0 861.4 871.5 880.7 882.5 885.7 14520.2 15010.6 15231.5 15276.5 15313.3 34008.4 34357.7 34413.1 35295.8 35745.3 47929.8 48296.5 48399.3 49160.5 49342.8 7251.3 7358.5 7367.6 7433.7 7543.7 9964.3 11330.7 11571.9 11581.3 11987.0 9639.5 9897.4 9956.5 9992.9 10101.1 10211.7 10356.9 10410.4 10541.3 10573.8 10091.5 10225.8 10366.9 10394.7 10441.2 7182.0 7205.9 7253.5 7288.1 7474.9 7218.8 8661.6 9820.9 10467.4 10574.8 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | [#3] mootools.html Cycles:180 Average:4939.32 Median:4858.12 stddev:2824.76 (58.1%) stddev-sans-first:2819.93 12:54:06 INFO - PROCESS | 14124 | Values: 1366.8 1392.6 1445.8 1639.2 1649.3 6623.7 7370.4 7481.7 7806.9 7809.8 7501.1 7668.8 7681.1 7723.1 7747.4 2084.0 2133.9 2134.0 2138.2 2138.9 2099.0 2124.9 2173.7 2180.0 2181.0 2149.2 2161.7 2162.3 2163.5 2186.5 2059.1 2063.7 2064.6 2064.7 2068.0 1986.8 2019.3 2023.0 2027.0 2113.2 7797.6 7826.8 7845.6 7858.7 7861.1 4426.8 4546.0 4547.7 4563.7 4576.1 2607.8 2675.1 2725.8 2737.9 2745.9 862.4 864.3 873.4 874.6 894.6 10517.2 10548.4 10583.0 10589.4 10612.6 3990.2 4022.7 4089.6 4129.4 4151.0 8838.2 8839.5 8872.7 8874.2 8874.6 4522.5 4572.5 4593.6 4606.2 4610.0 3476.2 3970.1 4017.1 4215.2 4223.8 3513.4 3559.9 3620.3 3622.7 3730.5 1162.8 1171.7 1183.6 1193.3 1199.4 774.8 791.1 802.2 803.1 814.4 4970.6 5016.2 5027.3 5045.4 5121.9 386.9 389.5 399.5 400.3 407.1 3334.7 3494.2 3529.0 3529.2 3549.9 9203.1 9497.8 9576.2 9583.7 9599.1 9419.2 9487.7 9541.6 9583.0 9595.0 6814.7 7049.8 7050.2 7296.5 7344.9 4852.8 4863.4 4890.9 4981.1 5036.8 8354.2 8416.0 8542.9 8578.5 8610.4 8345.1 8566.4 8617.0 8651.7 8728.6 5649.6 6213.9 6215.6 6361.2 6364.5 7099.8 7157.9 7169.1 7199.2 7228.3 6310.8 6319.4 6329.8 6477.2 6605.1 6269.3 6295.7 6363.2 6372.7 6454.5 5608.1 5655.8 5684.1 5699.8 5706.7 4064.2 4128.6 4133.3 4191.4 4265.6 4055.6 4090.1 4143.7 4147.1 4164.3 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | [#4] prototype.html Cycles:180 Average:4379.24 Median:5055.58 stddev:1300.72 (25.7%) stddev-sans-first:1267.59 12:54:06 INFO - PROCESS | 14124 | Values: 287.3 289.8 290.1 292.4 293.0 5103.2 5136.5 5143.6 5165.7 5180.1 4999.0 5004.5 5025.1 5036.7 5052.3 3692.4 3817.8 3864.2 3925.0 3931.4 3889.3 3890.7 3907.5 3916.6 3939.6 3824.8 3887.9 3903.8 3910.7 3924.6 3793.6 3857.3 3867.4 3873.9 3891.5 3379.5 3386.4 3404.5 3418.0 3431.6 4883.2 4899.8 4907.8 4940.0 4958.4 4353.8 4456.3 4459.8 4468.8 4478.7 5218.9 5233.8 5264.6 5273.2 5325.9 3734.4 3747.7 3758.0 3769.1 3776.8 5434.4 5466.0 5479.2 5492.9 5506.8 3480.4 3710.2 3712.3 3717.2 3746.7 3738.8 3757.4 3763.5 3766.5 3769.2 4320.9 4326.0 4352.3 4361.4 4366.9 5154.1 5207.7 5226.8 5292.0 5318.4 1281.2 1295.9 1296.2 1302.6 1304.9 790.9 809.9 826.9 834.9 839.7 4556.7 4697.4 4708.3 4712.8 4735.6 5477.3 5495.5 5517.5 5529.5 5539.5 4558.5 4689.9 4708.4 4712.6 4742.6 2919.5 2952.5 2954.4 2960.5 2965.5 5128.5 5202.4 5249.8 5251.0 5251.6 5293.0 5553.3 5559.7 5604.6 5619.3 5058.8 5091.9 5118.4 5149.0 5185.8 5469.4 5479.2 5504.3 5505.6 5525.4 5047.4 5302.5 5326.7 5334.5 5355.4 5147.8 5184.5 5264.4 5269.0 5302.1 3788.8 3789.8 3797.9 3799.1 3809.5 5131.2 5470.5 5484.3 5484.6 5557.5 5292.6 5330.6 5333.5 5350.4 5350.5 5185.0 5208.3 5277.4 5309.3 5348.7 5190.5 5240.9 5243.7 5256.4 5263.6 5123.5 5207.2 5333.4 5345.6 5355.3 5249.1 5255.8 5257.7 5283.7 5297.4 12:54:06 INFO - PROCESS | 14124 | 12:54:06 INFO - PROCESS | 14124 | [#5] yui.html Cycles:180 Average:15765.60 Median:606.52 stddev:22896.41 (3775.1%) stddev-sans-first:22931.99 12:54:06 INFO - PROCESS | 14124 | Values: 508.6 535.1 573.6 597.8 615.2 10808.9 11400.7 11429.9 11584.3 11597.9 11472.6 12328.3 12712.6 12719.7 12845.9 620.1 761.0 765.1 770.2 773.8 749.2 760.9 762.8 765.2 770.7 805.5 810.0 811.8 811.9 816.3 804.2 805.1 805.3 806.6 807.2 592.4 592.8 594.1 594.5 596.0 11987.2 12020.9 12044.1 12049.0 12078.3 12695.7 13355.5 13479.9 13595.5 13789.0 9803.6 10169.2 10177.6 10200.7 10472.9 3187.4 3232.0 3311.0 3328.5 3361.2 56655.0 58518.0 58844.7 58865.4 59009.7 8307.8 8851.2 9279.0 9507.9 9666.4 17112.5 18145.2 18147.8 18153.8 18178.1 6227.5 6254.8 6280.6 6501.3 6557.3 3579.8 3599.9 3606.1 3653.9 3656.6 2666.5 2740.2 2747.6 2752.7 2902.7 514.0 520.7 524.6 524.8 528.3 456.3 501.2 513.5 525.4 551.1 6516.7 6754.5 6796.4 6866.2 6878.8 435.6 463.9 469.6 534.1 560.0 3392.1 3402.6 3435.5 3514.8 3526.3 66634.7 88439.6 92692.0 93819.5 94496.5 50564.7 57065.1 71549.3 76983.6 78422.0 56089.0 72737.0 73904.0 74199.9 74231.0 6687.9 6805.6 6812.8 6858.1 6871.7 31579.0 37631.8 43629.0 43792.3 45736.1 56142.2 56471.4 57669.7 63118.4 63202.0 8830.9 8835.7 8854.6 8873.1 9064.3 9473.5 9940.0 9967.5 10000.4 10036.5 8787.6 8869.4 9057.5 9075.8 9204.2 8523.9 8527.3 8538.4 8709.2 8777.7 8313.6 8352.8 8394.3 8410.8 8413.5 7310.0 7448.4 7495.8 7522.1 7523.8 7208.8 7528.9 7586.6 7601.2 7613.7 12:54:06 INFO - PROCESS | 14124 | -------- Summary: end -------- 12:54:06 INFO - PROCESS | 14124 | 12:54:07 INFO - TEST-INFO | 14124: exit 0 12:54:07 INFO - TEST-OK | dromaeo_css | took 1116265ms 12:54:07 INFO - TEST-START | kraken 12:54:07 INFO - operating with platform_type : linux_ 12:54:07 INFO - Initialising browser for kraken test... 12:54:07 INFO - TEST-INFO | started process 14359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKxREeU/profile http://localhost:33481/getInfo.html) 12:54:12 INFO - PROCESS | 14359 | __metrics Screen width/height:1600/1200 12:54:12 INFO - PROCESS | 14359 | colorDepth:24 12:54:12 INFO - PROCESS | 14359 | Browser inner width/height: 1024/697 12:54:12 INFO - PROCESS | 14359 | __metrics 12:54:13 ERROR - PROCESS | 14359 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 12:54:14 INFO - TEST-INFO | 14359: exit 0 12:54:14 INFO - Browser initialized. 12:54:14 INFO - Running cycle 1/1 for kraken test... 12:54:14 INFO - TEST-INFO | started process 14476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKxREeU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:26 INFO - PROCESS | 14476 | RSS: Main: 185942016 12:54:26 INFO - PROCESS | 14476 | 12:54:28 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:29 INFO - PROCESS | 14476 | RSS: Main: 189857792 12:54:29 INFO - PROCESS | 14476 | 12:54:32 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-dft) 12:54:33 INFO - PROCESS | 14476 | RSS: Main: 189587456 12:54:33 INFO - PROCESS | 14476 | 12:54:36 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-fft) 12:54:36 INFO - PROCESS | 14476 | RSS: Main: 185266176 12:54:36 INFO - PROCESS | 14476 | 12:54:39 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33481/tests/kraken/driver.html?testName=audio-oscillator) 12:54:39 INFO - PROCESS | 14476 | RSS: Main: 185655296 12:54:39 INFO - PROCESS | 14476 | 12:54:41 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:54:42 INFO - PROCESS | 14476 | RSS: Main: 185847808 12:54:42 INFO - PROCESS | 14476 | 12:54:45 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33481/tests/kraken/driver.html?testName=imaging-darkroom) 12:54:46 INFO - PROCESS | 14476 | RSS: Main: 186646528 12:54:46 INFO - PROCESS | 14476 | 12:54:49 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33481/tests/kraken/driver.html?testName=imaging-desaturate) 12:54:50 INFO - PROCESS | 14476 | RSS: Main: 184029184 12:54:50 INFO - PROCESS | 14476 | 12:54:53 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33481/tests/kraken/driver.html?testName=json-parse-financial) 12:54:54 INFO - PROCESS | 14476 | RSS: Main: 185667584 12:54:54 INFO - PROCESS | 14476 | 12:54:55 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:54:56 INFO - PROCESS | 14476 | RSS: Main: 185876480 12:54:56 INFO - PROCESS | 14476 | 12:54:58 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:54:59 INFO - PROCESS | 14476 | RSS: Main: 185856000 12:54:59 INFO - PROCESS | 14476 | 12:55:01 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:55:02 INFO - PROCESS | 14476 | RSS: Main: 186036224 12:55:02 INFO - PROCESS | 14476 | 12:55:04 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:55:05 INFO - PROCESS | 14476 | RSS: Main: 186232832 12:55:05 INFO - PROCESS | 14476 | 12:55:08 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:55:09 INFO - PROCESS | 14476 | RSS: Main: 185929728 12:55:09 INFO - PROCESS | 14476 | 12:55:10 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:33481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33481/tests/kraken/driver.html?testName=ai-astar) 12:55:11 INFO - PROCESS | 14476 | RSS: Main: 186683392 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | __start_tp_report 12:55:11 INFO - PROCESS | 14476 | _x_x_mozilla_page_load 12:55:11 INFO - PROCESS | 14476 | _x_x_mozilla_page_load_details 12:55:11 INFO - PROCESS | 14476 | |i|pagename|runs| 12:55:11 INFO - PROCESS | 14476 | |0;ai-astar;114;109;114;115;114;113;114;114;115;115 12:55:11 INFO - PROCESS | 14476 | |1;audio-beat-detection;159;139;158;179;132;162;160;133;193;132 12:55:11 INFO - PROCESS | 14476 | |2;audio-dft;172;179;171;165;162;163;165;167;163;164 12:55:11 INFO - PROCESS | 14476 | |3;audio-fft;78;75;78;151;77;75;78;78;163;76 12:55:11 INFO - PROCESS | 14476 | |4;audio-oscillator;87;88;138;87;87;88;129;87;89;137 12:55:11 INFO - PROCESS | 14476 | |5;imaging-gaussian-blur;118;118;118;117;118;118;118;119;117;117 12:55:11 INFO - PROCESS | 14476 | |6;imaging-darkroom;148;149;147;148;149;150;148;148;148;148 12:55:11 INFO - PROCESS | 14476 | |7;imaging-desaturate;96;95;96;96;95;95;96;95;97;96 12:55:11 INFO - PROCESS | 14476 | |8;json-parse-financial;65;64;64;65;65;64;63;65;65;65 12:55:11 INFO - PROCESS | 14476 | |9;json-stringify-tinderbox;65;65;69;66;66;65;65;66;65;66 12:55:11 INFO - PROCESS | 14476 | |10;stanford-crypto-aes;87;83;85;83;89;87;87;85;113;88 12:55:11 INFO - PROCESS | 14476 | |11;stanford-crypto-ccm;136;167;142;133;133;133;132;137;135;135 12:55:11 INFO - PROCESS | 14476 | |12;stanford-crypto-pbkdf2;171;168;168;167;169;173;168;171;167;166 12:55:11 INFO - PROCESS | 14476 | |13;stanford-crypto-sha256-iterative;68;69;69;68;69;66;66;69;69;68 12:55:11 INFO - PROCESS | 14476 | __end_tp_report 12:55:11 INFO - PROCESS | 14476 | __start_cc_report 12:55:11 INFO - PROCESS | 14476 | _x_x_mozilla_cycle_collect,970 12:55:11 INFO - PROCESS | 14476 | __end_cc_report 12:55:11 INFO - PROCESS | 14476 | __startTimestamp1465502111052__endTimestamp 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | ------- Summary: start ------- 12:55:11 INFO - PROCESS | 14476 | Number of tests: 14 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.77 (1.5%) stddev-sans-first:1.87 12:55:11 INFO - PROCESS | 14476 | Values: 114.0 109.0 114.0 115.0 114.0 113.0 114.0 114.0 115.0 115.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:159.50 stddev:20.86 (13.1%) stddev-sans-first:22.07 12:55:11 INFO - PROCESS | 14476 | Values: 159.0 139.0 158.0 179.0 132.0 162.0 160.0 133.0 193.0 132.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#2] audio-dft Cycles:10 Average:167.10 Median:166.00 stddev:5.36 (3.2%) stddev-sans-first:5.39 12:55:11 INFO - PROCESS | 14476 | Values: 172.0 179.0 171.0 165.0 162.0 163.0 165.0 167.0 163.0 164.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#3] audio-fft Cycles:10 Average:92.90 Median:77.50 stddev:33.92 (43.8%) stddev-sans-first:35.55 12:55:11 INFO - PROCESS | 14476 | Values: 78.0 75.0 78.0 151.0 77.0 75.0 78.0 78.0 163.0 76.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:87.00 stddev:22.88 (26.3%) stddev-sans-first:23.64 12:55:11 INFO - PROCESS | 14476 | Values: 87.0 88.0 138.0 87.0 87.0 88.0 129.0 87.0 89.0 137.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:55:11 INFO - PROCESS | 14476 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 118.0 119.0 117.0 117.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 12:55:11 INFO - PROCESS | 14476 | Values: 148.0 149.0 147.0 148.0 149.0 150.0 148.0 148.0 148.0 148.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:55:11 INFO - PROCESS | 14476 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 97.0 96.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 12:55:11 INFO - PROCESS | 14476 | Values: 65.0 64.0 64.0 65.0 65.0 64.0 63.0 65.0 65.0 65.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 12:55:11 INFO - PROCESS | 14476 | Values: 65.0 65.0 69.0 66.0 66.0 65.0 65.0 66.0 65.0 66.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:87.00 stddev:8.77 (10.1%) stddev-sans-first:9.28 12:55:11 INFO - PROCESS | 14476 | Values: 87.0 83.0 85.0 83.0 89.0 87.0 87.0 85.0 113.0 88.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:135.50 stddev:10.49 (7.7%) stddev-sans-first:11.09 12:55:11 INFO - PROCESS | 14476 | Values: 136.0 167.0 142.0 133.0 133.0 133.0 132.0 137.0 135.0 135.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:168.50 stddev:2.20 (1.3%) stddev-sans-first:2.19 12:55:11 INFO - PROCESS | 14476 | Values: 171.0 168.0 168.0 167.0 169.0 173.0 168.0 171.0 167.0 166.0 12:55:11 INFO - PROCESS | 14476 | 12:55:11 INFO - PROCESS | 14476 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 12:55:11 INFO - PROCESS | 14476 | Values: 68.0 69.0 69.0 68.0 69.0 66.0 66.0 69.0 69.0 68.0 12:55:11 INFO - PROCESS | 14476 | -------- Summary: end -------- 12:55:11 INFO - PROCESS | 14476 | 12:55:12 INFO - TEST-INFO | 14476: exit 0 12:55:12 INFO - TEST-OK | kraken | took 65063ms 12:55:12 INFO - SUITE-END | took 1181s 12:55:12 INFO - Completed test suite (00:19:41) 12:55:12 INFO - javascript benchmark 12:55:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6242.085915587213, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.4823035392924, 2663.334166458385, 2676.85277309748, 2682.2623778460907, 2693.003588672193, 4715.009847931934, 4727.52724727527, 4739.478657347693, 4829.396325459317, 4857.951420485794, 4582.0606775611, 4779.115863565243, 4798.4961579034225, 4806.807727690888, 4833.105875413051, 4327.956720432795, 4411.867643970686, 4444.755538445384, 4466.240739074366, 4467.195904737146, 599.3302678547618, 4276.123394704094, 4330.39374487572, 4371.3661519079715, 4430.091831174617, 4364.214441400547, 4392.846250381253, 4394.1870753910625, 4410.184115938529, 4419.4033805436175, 4249.3413520904305, 4407.184670835905, 4427.46870375557, 4432.71187372823, 4465.240909045438, 4290.034742183015, 4308.547602501755, 4326.069894972596, 4329.696921215516, 4338.631216346615, 4777.474477807438, 4790.664653474259, 4793.832215872428, 4794.664373493857, 4867.099586576494, 5073.518015788494, 5077.593792496591, 5130.333056702642, 5166.767495462713, 5201.739913004372, 5156.767945442464, 5168.198929165947, 5174.508421699932, 5180.792768289264, 5204.661696989683, 4814.735189564538, 4817.22359273379, 4824.445188803263, 4831.275308703723, 4836.830710925101, 5264.183466986481, 5281.841544753664, 5286.286351342596, 5305.151175811929, 5313.123334649817, 5023.296738456619, 5060.620453466005, 5074.16276314404, 5075.264086707407, 5114.207297868837, 4971.030649023406, 5169.017886601534, 5169.560587350042, 5173.767180476888, 5174.560162386164, 5068.087744206078, 5100.56645185156, 5126.077306084866, 5132.640715149978, 5134.178531434953, 4889.608831293488, 5024.648274620741, 5044.899102017939, 5064.290999260106, 5102.081625307406, 4115.73247738896, 4264.637505812041, 4274.038341373166, 4280.464941882265, 4312.223799716018, 3679.742418030712, 3713.517242758478, 3721.1999420124803, 3748.212875296164, 3777.0746167189213, 4489.932651010237, 4501.257292546693, 4501.572350626685, 4508.774561271924, 4542.795574199103, 5152.742362881841, 5155.716435596003, 5162.0, 5162.92255616166, 5199.896002080013, 4541.227991241497, 4544.772761361919, 4548.931766023512, 4558.794854231567, 4562.726236425825, 4573.451185857718, 4584.243599806061, 4584.816607335669, 4602.309653551927, 4630.953690463052, 4758.904821903542, 4859.514048595183, 4866.440359358719, 4896.706197628154, 4930.6795058321095, 5170.793168273227, 5187.81842635521, 5191.273221748883, 5197.038547868657, 5198.9740051299505, 4906.0, 4908.950910490992, 4917.336159618406, 4920.335754673073, 4955.479674634255, 5031.320771695774, 5041.823536176216, 5070.898582028265, 5076.695398275968, 5079.238114282739, 5126.333576635014, 5152.905578015298, 5158.793648254028, 5169.508896654812, 5205.869853253699, 4999.600031997505, 5005.874853128701, 5013.949860501349, 5049.545540901337, 5090.821821236239, 4725.645576581839, 5050.368703912011, 5051.595872330278, 5067.163917953497, 5080.974595127149, 4883.536064073907, 4901.191303434894, 4912.631552633496, 4923.606111511142, 4935.605151587936, 4779.283107533898, 5026.346574945233, 5039.899202016012, 5066.138756411493, 5101.719405432588, 4921.655484116078, 4940.184869496493, 4943.925841112458, 4986.401631804207, 5011.574016208518], "value": 4683.19984391927, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.9656236309575, 573.6328749600256, 576.7519966414441, 601.939806019398, 617.9258488981322, 34204.0, 38178.61821381782, 38610.22779544411, 38696.613033869726, 38762.0, 38377.61622383775, 38805.0, 38881.41677874834, 38908.416373754415, 38967.22065558687, 7799.142094369629, 7893.329067029309, 7909.920900791005, 7922.564258965755, 7928.286454219119, 7668.501547399401, 7714.074311082678, 7758.495697779655, 7830.647620857047, 7838.804029899241, 7807.219278072176, 7835.059792824869, 7852.371810255166, 7882.881756773653, 7892.210778922091, 7814.531128132302, 7859.528428294292, 7873.094594121663, 7877.330426913719, 7883.054033516015, 7709.7301594443925, 7781.22187781223, 7782.0, 7796.376289896794, 7822.413319001098, 29771.10686679403, 36959.260814783556, 37425.25149496995, 37431.625683743085, 37522.81238593817, 2668.7197844226466, 2711.1188863619204, 2857.5713642953724, 2957.940841183186, 3117.2986078132467, 28174.577381339295, 28651.283717907012, 28898.27754306138, 30111.0, 30546.694533054608, 3261.152100453899, 3340.198352395432, 3349.815760133192, 3359.4925021964827, 3363.697267245935, 248176.0, 250367.0, 251217.7439112811, 251271.0, 252786.0, 58250.0, 59574.404255956884, 59583.0, 59716.40283597195, 59730.40269597335, 34193.0, 34951.82524087363, 35214.82392588072, 37268.44097338542, 60207.39792602018, 15842.207889605705, 15988.520344389686, 16030.11834349122, 16058.598535036717, 16061.759073613905, 11640.301581905112, 11650.184487085991, 11676.0, 11696.473658685209, 11696.47365868538, 19400.5243921817, 19406.417807465517, 19459.7976848472, 19467.33833107289, 19637.90181049114, 7255.709771609182, 7430.517016393917, 7513.436492263102, 7525.285097915689, 7725.922740772633, 825.6532256452305, 909.3997961345481, 950.396498223633, 977.4428575711918, 1020.8979102089731, 28274.434511309657, 28929.132126036253, 28940.27649308784, 29013.56479652807, 29630.703692962794, 983.4492684096929, 992.8808542974889, 1032.4785983078498, 1039.142707266493, 1069.2408390043001, 14913.478028268959, 15397.692046159014, 15438.298297798065, 15585.922070389575, 15592.92203538975, 383412.0, 386719.0, 389756.0, 390246.0, 390402.0, 50677.74661126671, 51275.0, 51646.0, 51752.22371664428, 51794.74102629463, 1127.622246547416, 1170.6546568762064, 1197.6945878801025, 1198.1253684810138, 1216.5924415320967, 27614.0, 28256.576151357334, 28317.71682283151, 28548.714512854607, 28938.855305723337, 43392.56607433885, 43822.0, 43874.0, 43912.780436097615, 44011.11977760491, 325444.0, 325497.0, 328096.0, 328294.0, 329105.0, 26309.736902630728, 26325.473490530465, 26929.865350673907, 26969.730302697506, 26987.595186072616, 43433.0, 43588.56411435845, 43627.0, 44077.55922440735, 44174.55825441705, 36457.270854583294, 38049.0, 38061.2387752249, 38174.23651526898, 38368.77943426277, 36181.638183617826, 36900.81549592235, 37667.81166094152, 38144.61855381522, 40214.396784047676, 36251.81874090613, 36736.448953265186, 36833.44749828701, 36933.81533092317, 37377.6262237385, 32738.345233095682, 34746.82626586952, 34875.953721388396, 34981.0, 35149.29701406009, 25886.482270354863, 26463.735362646126, 26489.0, 26589.867050664623, 26612.201633951012], "value": 17755.059927999733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.35565525949363, 349.5089399393852, 355.68699544400926, 360.3675549410787, 368.22121213633176, 15718.371265149395, 16366.181690915451, 16901.323947042136, 16923.3230670773, 16938.999999999985, 15351.616209594766, 16346.918265408685, 16400.097994610293, 16465.588360291, 16637.0, 4300.311950087978, 4621.19129152397, 4634.37435946148, 4668.066386722669, 4676.508966558514, 2907.636545431821, 4596.402467679197, 5114.28400023997, 5438.91841622376, 5440.700761458118, 5464.972675136639, 5502.422245664207, 5505.201745746865, 5523.420040895709, 5540.889182216353, 5369.5167434930845, 5427.891442171154, 5507.862303442406, 5521.5306698930435, 5526.47498487643, 5311.097113490716, 5313.203019547099, 5314.97342513285, 5335.359756829166, 5340.839774806762, 10671.35971841692, 11286.943565282121, 11341.886581134166, 11841.763164736743, 11885.584004559885, 1856.7307740377705, 1865.7387965684816, 1966.99016504918, 1979.4655443030301, 2175.369142948543, 8759.868601970975, 8987.505687187202, 8990.460572365613, 9244.0, 13408.061435699505, 1512.9243537823174, 1578.3765412661935, 1602.6153723106488, 1610.919454027294, 1632.9755053674205, 66189.33810661928, 66691.0, 68753.0, 68790.65604671995, 69024.0, 9599.808003840024, 9668.613255469843, 9978.451185184884, 10069.98444790045, 10176.898231017743, 13485.730285394236, 13500.797488037688, 13575.0, 13585.252811095485, 13592.456301748018, 7162.641867906584, 7306.561606303639, 7366.742164024341, 7374.815629609196, 7435.665395057235, 6822.351876571718, 7063.39961103312, 7103.147622285359, 7253.673584688701, 7457.2542745724995, 4262.360645903139, 4288.871333859926, 4298.742075475481, 4318.805653745526, 4389.385486031958, 1648.3077107614831, 1682.7812384389952, 1781.768370111903, 1793.2020250988185, 1830.1764206107305, 835.6323217784155, 841.7138173021202, 887.658251573149, 895.8029233568604, 956.321012081416, 15892.92053539748, 16581.336746530003, 16627.750583741254, 16646.417375391804, 17174.22715977784, 808.0747544062016, 825.6573521988307, 830.6511265268481, 850.1456036683218, 898.874157617934, 9014.63941442348, 9563.713088607214, 9639.759006024906, 9650.855237171449, 9764.755881102887, 373188.0, 381621.0, 386722.0, 388504.0, 389325.0, 77445.61277193691, 77876.0, 80825.0, 81409.18590814016, 81432.0, 861.440063958432, 871.5337294547387, 880.6785523283955, 882.4528792148909, 885.7298523950128, 14520.201388923711, 15010.624734381729, 15231.466898658493, 15276.465323713617, 15313.310901009258, 34008.42911494357, 34357.656423435445, 34413.13967150841, 35295.82352088223, 35745.28509429849, 47929.76035119802, 48296.5170348292, 48399.27401089057, 49160.50839491702, 49342.75328623477, 7251.311125443074, 7358.484906056525, 7367.594782287026, 7433.702651893864, 7543.698252069856, 9964.302498825302, 11330.716732081764, 11571.884281157081, 11581.305121692725, 11987.0, 9639.518024098907, 9897.406155630686, 9956.452395118338, 9992.900070999198, 10101.090901818872, 10211.7447063824, 10356.948215258875, 10410.427426491615, 10541.262111652417, 10573.841392378967, 10091.495425228855, 10225.846612300673, 10366.896331036593, 10394.688159355232, 10441.164706823283, 7182.0, 7205.927940720526, 7253.455990800606, 7288.052553168266, 7474.925250747423, 7218.783436496913, 8661.610227539903, 9820.901790982, 10467.424291664032, 10574.788504230026], "value": 7898.277957965473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.7676494995853, 1392.5543825975685, 1445.8120444342235, 1639.2049855819932, 1649.2578339747117, 6623.668816559177, 7370.410367170627, 7481.700731970728, 7806.921930780691, 7809.804754881124, 7501.0998680158455, 7668.769936901902, 7681.116671582769, 7723.073231212248, 7747.380209583234, 2084.041340983146, 2133.8506304558687, 2134.0, 2138.17680193126, 2138.8609740366905, 2098.9790102099014, 2124.915003399862, 2173.71741673583, 2180.029886700419, 2180.978190218101, 2149.215536329244, 2161.6973623692697, 2162.275637661385, 2163.5132095278514, 2186.5080356919643, 2059.1351632314463, 2063.66981282994, 2064.6180456615575, 2064.7109404683283, 2067.989660051705, 1986.8311193548566, 2019.3437132931708, 2023.0188358646044, 2027.0067666843288, 2113.17586141405, 7797.610119494003, 7826.8434631307055, 7845.607719613997, 7858.724944626968, 7861.135275119789, 4426.778661066934, 4546.045330480603, 4547.681662283641, 4563.703359281636, 4576.084783043405, 2607.8304910180777, 2675.0637276953107, 2725.795565332588, 2737.904173353943, 2745.862706864669, 862.4006315610653, 864.3042350907517, 873.3624454148508, 874.5802015032756, 894.6197865906963, 10517.211209159344, 10548.367097974146, 10583.0, 10589.36463812166, 10612.575496980111, 3990.182012687392, 4022.718409711292, 4089.5910408958866, 4129.380592911028, 4151.045259590311, 8838.204561589488, 8839.46963182211, 8872.73381798547, 8874.156955089256, 8874.645014199488, 4522.479914809774, 4572.51988541205, 4593.6095431888, 4606.239970404913, 4610.031893302377, 3476.1830969722096, 3970.1067259866877, 4017.0760725033406, 4215.241256573785, 4223.809928553223, 3513.3851575974104, 3559.9110022249133, 3620.25784714133, 3622.7464077514846, 3730.4963829882618, 1162.7906976744098, 1171.712930332057, 1183.621241202824, 1193.278066769592, 1199.3583432863377, 774.8256642255448, 791.0665414810579, 802.1617409806765, 803.1286054630674, 814.4421071565996, 4970.627202959792, 5016.197408414636, 5027.296178535008, 5045.419776725724, 5121.897562048738, 386.916812885231, 389.5383969995564, 399.4806751223456, 400.3254516140313, 407.0901535069118, 3334.7165490933057, 3494.178867966026, 3529.0471572675233, 3529.2059286660296, 3549.94675079874, 9203.125703058198, 9497.810043799085, 9576.23390128788, 9583.712488625353, 9599.088086631758, 9419.24646028316, 9487.715368538955, 9541.570629321697, 9583.0, 9595.040495950489, 6814.727410903607, 7049.753258635923, 7050.15398152225, 7296.525725827804, 7344.853102938018, 4852.805887764591, 4863.440704319049, 4890.92663610039, 4981.103401387785, 5036.798528058836, 8354.206350396702, 8416.0, 8542.871856922027, 8578.485290882567, 8610.397272190887, 8345.082040975367, 8566.443181193203, 8616.956915215384, 8651.740447786577, 8728.563571821256, 5649.576281778801, 6213.937860621336, 6215.564910456405, 6361.173047503795, 6364.459020983083, 7099.82250443743, 7157.85684286301, 7169.139703235645, 7199.172095208908, 7228.31331023552, 6310.778714441503, 6319.431251187415, 6329.778457753957, 6477.222733272038, 6605.141331626858, 6269.3417191196095, 6295.685215739286, 6363.236411630634, 6372.681365931778, 6454.483641308778, 5608.10270356741, 5655.773769049192, 5684.118961560965, 5699.800506982236, 5706.743196556248, 4064.227796718614, 4128.587141285848, 4133.2973394522405, 4191.392248124066, 4265.5947684971115, 4055.5538890721405, 4090.1410703751353, 4143.668506519411, 4147.129102888427, 4164.312888373384], "value": 3904.7290962063516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.28609405627014, 289.7971420005996, 290.0818908155687, 292.36556672021715, 292.9531274996001, 5103.234514822774, 5136.486351364862, 5143.639945203838, 5165.7158856262895, 5180.093483640367, 4998.950010499894, 5004.549590536851, 5025.145725226711, 5036.722980236085, 5052.317937078494, 3692.353838078339, 3817.7518461300065, 3864.188520410717, 3925.0, 3931.410288456726, 3889.2610404023144, 3890.7471014384114, 3907.5310962684516, 3916.608339166089, 3939.606039396066, 3824.8470061197518, 3887.8833634990856, 3903.7657740535515, 3910.7262491625456, 3924.6271604197555, 3793.639604237593, 3857.3442514772555, 3867.38121900496, 3873.86441474547, 3891.5135608049136, 3379.5437615921783, 3386.407378708741, 3404.472306792451, 3418.0, 3431.605365382988, 4883.19427294496, 4899.7550122494085, 4907.828226012072, 4940.0, 4958.404991401019, 4353.825846966118, 4456.331550267453, 4459.843905463325, 4468.75421851798, 4478.731276123443, 5218.920836706361, 5233.790648374061, 5264.6051546134195, 5273.235380869753, 5325.866853328659, 3734.421164719473, 3747.7001839852746, 3757.9812100939594, 3769.076576238839, 3776.7922764247955, 5434.402215756264, 5465.966388654295, 5479.232907392969, 5492.857785463672, 5506.834794956118, 3480.3735327641266, 3710.2023065040607, 3712.294664013829, 3717.1636381814415, 3746.7002639788752, 3738.831752571141, 3757.384324740388, 3763.5107436033686, 3766.491523644273, 3769.227308401771, 4320.935185972213, 4326.048269380732, 4352.325389564622, 4361.389405483234, 4366.8908277292685, 5154.098032844312, 5207.6875387476875, 5226.790928362823, 5292.0, 5318.388385335736, 1281.1608396500308, 1295.8574556798744, 1296.2157894473708, 1302.5896842494583, 1304.9217046977212, 790.9288164065262, 809.9271065604124, 826.9255766981, 834.891464109674, 839.6641343462542, 4556.655786542978, 4697.436307643105, 4708.317293992352, 4712.787924543404, 4735.621150307967, 5477.342718873681, 5495.53287970519, 5517.531009864127, 5529.529989950899, 5539.5014448699, 4558.475775285819, 4689.85930422081, 4708.411448568929, 4712.6229901607785, 4742.620590352763, 2919.5474701421313, 2952.483315419793, 2954.3943491584173, 2960.481915664793, 2965.4662160811263, 5128.538431541179, 5202.375714914235, 5249.816256431007, 5251.0, 5251.632385732962, 5293.0, 5553.278073850373, 5559.694216818033, 5604.579656525777, 5619.325680918316, 5058.848234552969, 5091.949080509147, 5118.360204974379, 5149.0, 5185.781341384772, 5469.371022332482, 5479.150731636602, 5504.339479262514, 5505.642133261325, 5525.364583072998, 5047.369078865142, 5302.549283310962, 5326.6537675050995, 5334.546563542142, 5355.410904800547, 5147.841735609458, 5184.507471790174, 5264.420913699567, 5269.0, 5302.125149350314, 3788.8105594720705, 3789.7915614640356, 3797.905052373713, 3799.1072098056384, 3809.4666746654934, 5131.2303154525625, 5470.452954704498, 5484.287042684585, 5484.61607687458, 5557.527610153183, 5292.576593872558, 5330.626856120034, 5333.466653334635, 5350.4382039886805, 5350.545203657733, 5184.9740751296, 5208.270842082187, 5277.366715993951, 5309.283246761792, 5348.679079255102, 5190.506901844319, 5240.868978275421, 5243.711595862264, 5256.4480729524375, 5263.5525980292105, 5123.5141808875005, 5207.192885102815, 5333.373306151699, 5345.625806193685, 5355.250264962986, 5249.133892907627, 5255.842324730264, 5257.737113144404, 5283.709395983258, 5297.390800057889], "value": 3952.692711845429, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.6134537751308, 535.0502857428068, 573.607079150782, 597.8385835824328, 615.1940957345877, 10808.891911080897, 11400.657980260585, 11429.885701142986, 11584.304941703504, 11597.884021159785, 11472.598459053936, 12328.32194229317, 12712.618621441372, 12719.745605087892, 12845.871541284585, 620.1008537620446, 760.954342739436, 765.0704394161094, 770.1682183242085, 773.7794728502349, 749.1833901047856, 760.889670997705, 762.8016715653943, 765.2462324610254, 770.7379490973068, 805.5327909812295, 809.9595020248994, 811.8254575266317, 811.8944537210184, 816.2857499687773, 804.2399932064202, 805.0621026504116, 805.2993895311088, 806.5765473126597, 807.229096213118, 592.4460629311608, 592.7836339736009, 594.0910407077179, 594.4976494861878, 595.9582829201914, 11987.160898737093, 12020.879791202064, 12044.096692748079, 12048.975837053773, 12078.27530348173, 12695.74608507834, 13355.532556360578, 13479.932600337033, 13595.456181752717, 13789.0, 9803.607855685765, 10169.186465082776, 10177.592896284139, 10200.74498137545, 10472.895271047344, 3187.3943950649304, 3231.96768032319, 3310.966890331114, 3328.473523956863, 3361.1765117546115, 56655.0, 58517.99999999957, 58844.705776470844, 58865.41134588642, 59009.704951475396, 8307.8338433231, 8851.247643950337, 9279.0, 9507.904920950841, 9666.371685840399, 17112.48662540126, 18145.183466744027, 18147.818521814876, 18153.818461815477, 18178.091095445176, 6227.532935029891, 6254.781082662176, 6280.591761535486, 6501.31736167705, 6557.3442655735, 3579.83890724918, 3599.892003239907, 3606.062423769786, 3653.94519082214, 3656.634336566322, 2666.546687063204, 2740.1505533284744, 2747.6290700755544, 2752.6696796384563, 2902.680705122435, 513.9691618502902, 520.7031991764734, 524.5855773938546, 524.7638562646824, 528.3052785586941, 456.34058785055277, 501.2105933155295, 513.5352505982092, 525.4377815737201, 551.1347184919638, 6516.674166291761, 6754.45964322853, 6796.422304104108, 6866.210385805596, 6878.828029299308, 435.59054488780447, 463.87011636741767, 469.5633061253067, 534.1480338859512, 559.9640664770143, 3392.118049307198, 3402.6143986732864, 3435.5362026126654, 3514.8066856322635, 3526.2594855080206, 66634.66682666556, 88439.55780221058, 92692.0, 93819.53090234505, 94496.52751736334, 50564.74717626462, 57065.14402283969, 71549.2845071553, 76983.61508192423, 78422.0, 56089.0, 72737.0, 73904.0, 74199.88700169502, 74230.98839359816, 6687.899681504684, 6805.591664500146, 6812.795616131524, 6858.108445902001, 6871.69582142768, 31579.0, 37631.81184094062, 43629.0, 43792.34311485394, 45736.085278294915, 56142.157867632835, 56471.43528564662, 57669.711651441474, 63118.368816311246, 63202.0, 8830.911690883266, 8835.69075082369, 8854.557272136239, 8873.112688731075, 9064.320175986695, 9473.47895865734, 9940.0, 9967.451790151612, 10000.399976001463, 10036.498175091363, 8787.648494060166, 8869.423487473294, 9057.501837399006, 9075.818483630159, 9204.171624553823, 8523.872141918, 8527.275181609633, 8538.445001075159, 8709.216170544682, 8777.692780752643, 8313.584320783815, 8352.832943340978, 8394.286485648789, 8410.789730256793, 8413.495190288357, 7309.963450182715, 7448.366888814511, 7495.812604684927, 7522.134954480305, 7523.811904702427, 7208.783736487913, 7528.924710752823, 7586.582737949466, 7601.163871973968, 7613.6573854177805], "value": 5835.082561442224, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 139.0, 158.0, 179.0, 132.0, 162.0, 160.0, 133.0, 193.0, 132.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 179.0, 171.0, 165.0, 162.0, 163.0, 165.0, 167.0, 163.0, 164.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 78.0, 151.0, 77.0, 75.0, 78.0, 78.0, 163.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 138.0, 87.0, 87.0, 88.0, 129.0, 87.0, 89.0, 137.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 149.0, 150.0, 148.0, 148.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 63.0, 65.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 83.0, 89.0, 87.0, 87.0, 85.0, 113.0, 88.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 167.0, 142.0, 133.0, 133.0, 133.0, 132.0, 137.0, 135.0, 135.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 168.0, 167.0, 169.0, 173.0, 168.0, 171.0, 167.0, 166.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 66.0, 66.0, 69.0, 69.0, 68.0], "value": 68.1, "unit": "score"}]}]} 12:55:12 INFO - Return code: 0 12:55:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:55:12 ERROR - # TBPL SUCCESS # 12:55:12 INFO - Running post-action listener: _resource_record_post_action 12:55:12 INFO - ##### 12:55:12 INFO - ##### Finished run-tests step (success) 12:55:12 INFO - ##### 12:55:12 INFO - Running post-run listener: _resource_record_post_run 12:55:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 306180096; Read time: 20; Write time: 256240 12:55:12 INFO - TinderboxPrint: CPU usage
13.4% 12:55:12 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 12:55:12 INFO - TinderboxPrint: I/O write bytes / time
306,180,096 / 256,240 12:55:12 INFO - TinderboxPrint: CPU idle
8,278.9 (86.6%) 12:55:12 INFO - TinderboxPrint: CPU user
1,229.7 (12.9%) 12:55:12 INFO - TinderboxPrint: Swap in / out
0 / 0 12:55:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14114816; Read time: 0; Write time: 2444 12:55:12 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292065280; Read time: 20; Write time: 253796 12:55:13 INFO - Running post-run listener: _upload_blobber_files 12:55:13 INFO - Blob upload gear active. 12:55:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:55:13 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 12:55:13 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:55:13 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:55:13 INFO - (blobuploader) - INFO - Open directory for files ... 12:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:14 INFO - (blobuploader) - INFO - Done attempting. 12:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:15 INFO - (blobuploader) - INFO - Done attempting. 12:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:55:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:19 INFO - (blobuploader) - INFO - Done attempting. 12:55:19 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:19 INFO - Return code: 0 12:55:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3285a3eca5a0a618cf715d1a90f53ff65a477f0ca329da07d5444f4eb10ab516f5be4a74549d3a019d626ff98b60e4894321c35d75a9d6c1594399c6b879ecaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20d8c24ae6925b6b6955d7612ac9516ec6e6386ceb102170a7fbbfd12ca3b9d4f239d2088c1c70b42576cb5582a4471709e5237555482b5405f5264ef140354a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2c3ffbc390b85741bab733edb6679e80d6b093ea76b5db193412c1f37d47e325846c009e9ca90bf0584a2063ee1b5bee2e3fdc37d9dcc704ec1134c36da2e7"} 12:55:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:19 INFO - Contents: 12:55:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3285a3eca5a0a618cf715d1a90f53ff65a477f0ca329da07d5444f4eb10ab516f5be4a74549d3a019d626ff98b60e4894321c35d75a9d6c1594399c6b879ecaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20d8c24ae6925b6b6955d7612ac9516ec6e6386ceb102170a7fbbfd12ca3b9d4f239d2088c1c70b42576cb5582a4471709e5237555482b5405f5264ef140354a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2c3ffbc390b85741bab733edb6679e80d6b093ea76b5db193412c1f37d47e325846c009e9ca90bf0584a2063ee1b5bee2e3fdc37d9dcc704ec1134c36da2e7"} 12:55:19 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:19 INFO - Copying logs to upload dir... 12:55:19 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.513641 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-06-09 12:55:19.345653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 12:55:19.348931) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308 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/Fx-Team-Non-PGO/sha512/3285a3eca5a0a618cf715d1a90f53ff65a477f0ca329da07d5444f4eb10ab516f5be4a74549d3a019d626ff98b60e4894321c35d75a9d6c1594399c6b879ecaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20d8c24ae6925b6b6955d7612ac9516ec6e6386ceb102170a7fbbfd12ca3b9d4f239d2088c1c70b42576cb5582a4471709e5237555482b5405f5264ef140354a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2c3ffbc390b85741bab733edb6679e80d6b093ea76b5db193412c1f37d47e325846c009e9ca90bf0584a2063ee1b5bee2e3fdc37d9dcc704ec1134c36da2e7"} build_url:https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/e1EOlh7jTO6EmgIwA2QRQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3285a3eca5a0a618cf715d1a90f53ff65a477f0ca329da07d5444f4eb10ab516f5be4a74549d3a019d626ff98b60e4894321c35d75a9d6c1594399c6b879ecaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20d8c24ae6925b6b6955d7612ac9516ec6e6386ceb102170a7fbbfd12ca3b9d4f239d2088c1c70b42576cb5582a4471709e5237555482b5405f5264ef140354a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2c3ffbc390b85741bab733edb6679e80d6b093ea76b5db193412c1f37d47e325846c009e9ca90bf0584a2063ee1b5bee2e3fdc37d9dcc704ec1134c36da2e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 12:55:19.374207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:55:19.374553) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465500189.760102-280581308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:55:19.459469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 12:55:19.459810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 12:55:19.460145) ========= ========= Total master_lag: 0.17 =========