builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1465593039.3 results: success (0) buildid: 20160610133026 builduid: a3c2758764de4ad0881d3df5c6f00f9b revision: 9545df18ca9eaa35915df14e23543c02363ff83e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.295383) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.295852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.296153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.330319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.330594) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 14:10:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.8M=0.001s 2016-06-10 14:10:39 (17.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163524 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.509377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.509696) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022806 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.563698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:39.564120) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9545df18ca9eaa35915df14e23543c02363ff83e --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 9545df18ca9eaa35915df14e23543c02363ff83e --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=6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 14:10:39,715 truncating revision to first 12 chars 2016-06-10 14:10:39,715 Setting DEBUG logging. 2016-06-10 14:10:39,715 attempt 1/10 2016-06-10 14:10:39,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9545df18ca9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 14:10:40,100 unpacking tar archive at: fx-team-9545df18ca9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712105 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:40.290025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:40.290353) ========= script_repo_revision: 9545df18ca9eaa35915df14e23543c02363ff83e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:40.290795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:40.291059) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 14:10:40.301121) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-10 14:10:40.301547) ========= /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=6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:40 INFO - MultiFileLogger online at 20160610 14:10:40 in /builds/slave/test 14:10:40 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 14:10:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:40 INFO - {'append_to_log': False, 14:10:40 INFO - 'base_work_dir': '/builds/slave/test', 14:10:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:10:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:40 INFO - 'branch': 'Fx-Team-Non-PGO', 14:10:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:40 INFO - 'config_files': ('talos/linux_config.py',), 14:10:40 INFO - 'default_actions': ('clobber', 14:10:40 INFO - 'read-buildbot-config', 14:10:40 INFO - 'download-and-extract', 14:10:40 INFO - 'populate-webroot', 14:10:40 INFO - 'create-virtualenv', 14:10:40 INFO - 'install', 14:10:40 INFO - 'run-tests'), 14:10:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:40 INFO - 'download_minidump_stackwalk': True, 14:10:40 INFO - 'download_symbols': 'ondemand', 14:10:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:40 INFO - 'installer_path': 'installer.exe', 14:10:40 INFO - 'log_level': 'info', 14:10:40 INFO - 'log_name': 'talos', 14:10:40 INFO - 'log_to_console': True, 14:10:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:40 INFO - 'opt_config_files': (), 14:10:40 INFO - 'pip_index': False, 14:10:40 INFO - 'sps_profile': False, 14:10:40 INFO - 'sps_profile_interval': 0, 14:10:40 INFO - 'suite': 'dromaeojs-e10s', 14:10:40 INFO - 'system_bits': '32', 14:10:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:40 INFO - 'title': 'talos-linux64-ix-023', 14:10:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:40 INFO - 'use_talos_json': True, 14:10:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:40 INFO - 'work_dir': 'build'} 14:10:40 INFO - ##### 14:10:40 INFO - ##### Running clobber step. 14:10:40 INFO - ##### 14:10:40 INFO - Running pre-action listener: _resource_record_pre_action 14:10:40 INFO - Running main action method: clobber 14:10:40 INFO - rmtree: /builds/slave/test/build 14:10:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:41 INFO - Running post-action listener: _resource_record_post_action 14:10:41 INFO - ##### 14:10:41 INFO - ##### Finished clobber step (success) 14:10:41 INFO - ##### 14:10:41 INFO - ##### 14:10:41 INFO - ##### Running read-buildbot-config step. 14:10:41 INFO - ##### 14:10:41 INFO - Running pre-action listener: _resource_record_pre_action 14:10:41 INFO - Running main action method: read_buildbot_config 14:10:41 INFO - Using buildbot properties: 14:10:41 INFO - { 14:10:41 INFO - "project": "", 14:10:41 INFO - "product": "firefox", 14:10:41 INFO - "script_repo_revision": "production", 14:10:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:10:41 INFO - "repository": "", 14:10:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:10:41 INFO - "buildid": "20160610133026", 14:10:41 INFO - "pgo_build": "False", 14:10:41 INFO - "basedir": "/builds/slave/test", 14:10:41 INFO - "buildnumber": 1581, 14:10:41 INFO - "slavename": "talos-linux64-ix-023", 14:10:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:10:41 INFO - "platform": "ubuntu64_hw", 14:10:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:10:41 INFO - "branch": "fx-team", 14:10:41 INFO - "repo_path": "integration/fx-team", 14:10:41 INFO - "revision": "9545df18ca9eaa35915df14e23543c02363ff83e", 14:10:41 INFO - "stage_platform": "linux64", 14:10:41 INFO - "builduid": "a3c2758764de4ad0881d3df5c6f00f9b", 14:10:41 INFO - "slavebuilddir": "test" 14:10:41 INFO - } 14:10:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:10:41 INFO - Running post-action listener: _resource_record_post_action 14:10:41 INFO - ##### 14:10:41 INFO - ##### Finished read-buildbot-config step (success) 14:10:41 INFO - ##### 14:10:41 INFO - ##### 14:10:41 INFO - ##### Running download-and-extract step. 14:10:41 INFO - ##### 14:10:41 INFO - Running pre-action listener: _resource_record_pre_action 14:10:41 INFO - Running main action method: download_and_extract 14:10:41 INFO - mkdir: /builds/slave/test/build/tests 14:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:41 INFO - https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:47 INFO - Downloaded 1361 bytes. 14:10:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:10:47 INFO - Using the following test package requirements: 14:10:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:10:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'jsshell-linux-x86_64.zip'], 14:10:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:10:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:10:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:47 INFO - https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:50 INFO - Downloaded 22891347 bytes. 14:10:50 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'] 14:10:50 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 14:10:51 INFO - Return code: 0 14:10:51 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 14:10: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')]} 14:10:51 INFO - https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:56 INFO - Downloaded 22891347 bytes. 14:10:56 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'] 14:10:56 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 14:10:57 INFO - Return code: 0 14:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:57 INFO - https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:58 INFO - Downloaded 10833377 bytes. 14:10:58 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'] 14:10:58 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 14:10:58 INFO - Return code: 0 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:58 INFO - https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:10:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:10:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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 14:10:59 INFO - Downloaded 55394468 bytes. 14:10:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:10:59 INFO - mkdir: /builds/slave/test/properties 14:10:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:59 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:59 INFO - Contents: 14:10:59 INFO - build_url:https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:00 INFO - Running post-action listener: _resource_record_post_action 14:11:00 INFO - Running post-action listener: set_extra_try_arguments 14:11:00 INFO - ##### 14:11:00 INFO - ##### Finished download-and-extract step (success) 14:11:00 INFO - ##### 14:11:00 INFO - ##### 14:11:00 INFO - ##### Running populate-webroot step. 14:11:00 INFO - ##### 14:11:00 INFO - Running pre-action listener: _resource_record_pre_action 14:11:00 INFO - Running main action method: populate_webroot 14:11:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:00 INFO - '--tppagecycles', 14:11:00 INFO - '7'], 14:11:00 INFO - 'tests': ['tsvgm']}}, 14:11:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['damp', 'tps']}, 14:11:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'tests': ['damp', 'tps']}, 14:11:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['dromaeo_dom']}, 14:11:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['a11yr', 14:11:00 INFO - 'ts_paint', 14:11:00 INFO - 'tpaint', 14:11:00 INFO - 'sessionrestore', 14:11:00 INFO - 'sessionrestore_no_auto_restore', 14:11:00 INFO - 'tabpaint']}, 14:11:00 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:00 INFO - 'ts_paint', 14:11:00 INFO - 'tpaint', 14:11:00 INFO - 'sessionrestore', 14:11:00 INFO - 'sessionrestore_no_auto_restore', 14:11:00 INFO - 'tabpaint']}, 14:11:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:00 INFO - 'ts_paint', 14:11:00 INFO - 'tpaint', 14:11:00 INFO - 'sessionrestore', 14:11:00 INFO - 'sessionrestore_no_auto_restore', 14:11:00 INFO - 'tabpaint']}, 14:11:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:00 INFO - 'ts_paint', 14:11:00 INFO - 'tpaint', 14:11:00 INFO - 'sessionrestore', 14:11:00 INFO - 'sessionrestore_no_auto_restore', 14:11:00 INFO - 'tabpaint']}, 14:11:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['a11yr', 14:11:00 INFO - 'ts_paint', 14:11:00 INFO - 'tpaint', 14:11:00 INFO - 'sessionrestore', 14:11:00 INFO - 'sessionrestore_no_auto_restore', 14:11:00 INFO - 'tabpaint']}, 14:11:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['a11yr', 14:11:00 INFO - 'ts_paint', 14:11:00 INFO - 'tpaint', 14:11:00 INFO - 'sessionrestore', 14:11:00 INFO - 'sessionrestore_no_auto_restore', 14:11:00 INFO - 'tabpaint']}, 14:11:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['tsvgx', 14:11:00 INFO - 'tsvgr_opacity', 14:11:00 INFO - 'tart', 14:11:00 INFO - 'tscrollx', 14:11:00 INFO - 'cart']}, 14:11:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:00 INFO - 'tsvgr_opacity', 14:11:00 INFO - 'tart', 14:11:00 INFO - 'tscrollx', 14:11:00 INFO - 'cart']}, 14:11:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'talos_options': ['--disable-e10s'], 14:11:00 INFO - 'tests': ['tp5o']}, 14:11:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'tests': ['tp5o']}, 14:11:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'talos_options': ['--disable-e10s', 14:11:00 INFO - '--xperf_path', 14:11:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:00 INFO - 'tests': ['tp5n']}, 14:11:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:00 INFO - 'talos_options': ['--xperf_path', 14:11:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:00 INFO - 'tests': ['tp5n']}}, 14:11:00 INFO - 'talos.zip': {'path': '', 14:11:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:00 INFO - Running post-action listener: _resource_record_post_action 14:11:00 INFO - ##### 14:11:00 INFO - ##### Finished populate-webroot step (success) 14:11:00 INFO - ##### 14:11:00 INFO - ##### 14:11:00 INFO - ##### Running create-virtualenv step. 14:11:00 INFO - ##### 14:11:00 INFO - Running pre-action listener: _resource_record_pre_action 14:11:00 INFO - Running main action method: create_virtualenv 14:11:00 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:11:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:00 INFO - Using real prefix '/usr' 14:11:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:03 INFO - Installing pip.................done. 14:11:03 INFO - Return code: 0 14:11:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:03 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:11:03 INFO - Using env: {'DISPLAY': ':0', 14:11:03 INFO - 'HOME': '/home/cltbld', 14:11:03 INFO - 'LANG': 'en_US.UTF-8', 14:11:03 INFO - 'LANGUAGE': 'en_US:en', 14:11:03 INFO - 'LOGNAME': 'cltbld', 14:11:03 INFO - 'MAIL': '/var/mail/cltbld', 14:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:03 INFO - 'MOZ_NO_REMOTE': '1', 14:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:03 INFO - 'NO_EM_RESTART': '1', 14:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:03 INFO - 'PWD': '/builds/slave/test', 14:11:03 INFO - 'SHELL': '/bin/bash', 14:11:03 INFO - 'SHLVL': '1', 14:11:03 INFO - 'TERM': 'linux', 14:11:03 INFO - 'TMOUT': '86400', 14:11:03 INFO - 'USER': 'cltbld', 14:11:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:03 INFO - '_': '/tools/buildbot/bin/python'} 14:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:11:03 INFO - Cleaning up... 14:11:03 INFO - Return code: 0 14:11:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:03 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:11:03 INFO - Using env: {'DISPLAY': ':0', 14:11:03 INFO - 'HOME': '/home/cltbld', 14:11:03 INFO - 'LANG': 'en_US.UTF-8', 14:11:03 INFO - 'LANGUAGE': 'en_US:en', 14:11:03 INFO - 'LOGNAME': 'cltbld', 14:11:03 INFO - 'MAIL': '/var/mail/cltbld', 14:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:03 INFO - 'MOZ_NO_REMOTE': '1', 14:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:03 INFO - 'NO_EM_RESTART': '1', 14:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:03 INFO - 'PWD': '/builds/slave/test', 14:11:03 INFO - 'SHELL': '/bin/bash', 14:11:03 INFO - 'SHLVL': '1', 14:11:03 INFO - 'TERM': 'linux', 14:11:03 INFO - 'TMOUT': '86400', 14:11:03 INFO - 'USER': 'cltbld', 14:11:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:03 INFO - '_': '/tools/buildbot/bin/python'} 14:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:03 INFO - Downloading/unpacking psutil>=3.1.1 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:05 INFO - Installing collected packages: psutil 14:11:05 INFO - Running setup.py install for psutil 14:11:05 INFO - building 'psutil._psutil_linux' extension 14:11:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:11:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:11:05 INFO - building 'psutil._psutil_posix' extension 14:11:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:11:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:11:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:06 INFO - Successfully installed psutil 14:11:06 INFO - Cleaning up... 14:11:06 INFO - Return code: 0 14:11:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:11:06 INFO - Using env: {'DISPLAY': ':0', 14:11:06 INFO - 'HOME': '/home/cltbld', 14:11:06 INFO - 'LANG': 'en_US.UTF-8', 14:11:06 INFO - 'LANGUAGE': 'en_US:en', 14:11:06 INFO - 'LOGNAME': 'cltbld', 14:11:06 INFO - 'MAIL': '/var/mail/cltbld', 14:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:06 INFO - 'MOZ_NO_REMOTE': '1', 14:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:06 INFO - 'NO_EM_RESTART': '1', 14:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:06 INFO - 'PWD': '/builds/slave/test', 14:11:06 INFO - 'SHELL': '/bin/bash', 14:11:06 INFO - 'SHLVL': '1', 14:11:06 INFO - 'TERM': 'linux', 14:11:06 INFO - 'TMOUT': '86400', 14:11:06 INFO - 'USER': 'cltbld', 14:11:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:06 INFO - '_': '/tools/buildbot/bin/python'} 14:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:08 INFO - Installing collected packages: mozsystemmonitor 14:11:08 INFO - Running setup.py install for mozsystemmonitor 14:11:08 INFO - Successfully installed mozsystemmonitor 14:11:08 INFO - Cleaning up... 14:11:08 INFO - Return code: 0 14:11:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:08 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:08 INFO - Using env: {'DISPLAY': ':0', 14:11:08 INFO - 'HOME': '/home/cltbld', 14:11:08 INFO - 'LANG': 'en_US.UTF-8', 14:11:08 INFO - 'LANGUAGE': 'en_US:en', 14:11:08 INFO - 'LOGNAME': 'cltbld', 14:11:08 INFO - 'MAIL': '/var/mail/cltbld', 14:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:08 INFO - 'MOZ_NO_REMOTE': '1', 14:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:08 INFO - 'NO_EM_RESTART': '1', 14:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:08 INFO - 'PWD': '/builds/slave/test', 14:11:08 INFO - 'SHELL': '/bin/bash', 14:11:08 INFO - 'SHLVL': '1', 14:11:08 INFO - 'TERM': 'linux', 14:11:08 INFO - 'TMOUT': '86400', 14:11:08 INFO - 'USER': 'cltbld', 14:11:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:08 INFO - '_': '/tools/buildbot/bin/python'} 14:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:08 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:11 INFO - warning: no files found matching '*.txt' 14:11:11 INFO - no previously-included directories found matching 'build' 14:11:11 INFO - no previously-included directories found matching 'dist' 14:11:11 INFO - no previously-included directories found matching '.git*' 14:11:11 INFO - Installing collected packages: jsonschema, functools32 14:11:11 INFO - Running setup.py install for functools32 14:11:11 INFO - warning: no files found matching '*.txt' 14:11:11 INFO - no previously-included directories found matching 'build' 14:11:11 INFO - no previously-included directories found matching 'dist' 14:11:11 INFO - no previously-included directories found matching '.git*' 14:11:11 INFO - Successfully installed jsonschema functools32 14:11:11 INFO - Cleaning up... 14:11:11 INFO - Return code: 0 14:11:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:12 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:11:12 INFO - Using env: {'DISPLAY': ':0', 14:11:12 INFO - 'HOME': '/home/cltbld', 14:11:12 INFO - 'LANG': 'en_US.UTF-8', 14:11:12 INFO - 'LANGUAGE': 'en_US:en', 14:11:12 INFO - 'LOGNAME': 'cltbld', 14:11:12 INFO - 'MAIL': '/var/mail/cltbld', 14:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:12 INFO - 'MOZ_NO_REMOTE': '1', 14:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:12 INFO - 'NO_EM_RESTART': '1', 14:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:12 INFO - 'PWD': '/builds/slave/test', 14:11:12 INFO - 'SHELL': '/bin/bash', 14:11:12 INFO - 'SHLVL': '1', 14:11:12 INFO - 'TERM': 'linux', 14:11:12 INFO - 'TMOUT': '86400', 14:11:12 INFO - 'USER': 'cltbld', 14:11:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:12 INFO - '_': '/tools/buildbot/bin/python'} 14:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - Downloading docopt-0.6.1.tar.gz 14:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:14 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:14 INFO - Running setup.py install for blobuploader 14:11:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:14 INFO - Running setup.py install for requests 14:11:15 INFO - Running setup.py install for docopt 14:11:15 INFO - Successfully installed blobuploader requests docopt 14:11:15 INFO - Cleaning up... 14:11:15 INFO - Return code: 0 14:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:15 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:15 INFO - Using env: {'DISPLAY': ':0', 14:11:15 INFO - 'HOME': '/home/cltbld', 14:11:15 INFO - 'LANG': 'en_US.UTF-8', 14:11:15 INFO - 'LANGUAGE': 'en_US:en', 14:11:15 INFO - 'LOGNAME': 'cltbld', 14:11:15 INFO - 'MAIL': '/var/mail/cltbld', 14:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:15 INFO - 'MOZ_NO_REMOTE': '1', 14:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:15 INFO - 'NO_EM_RESTART': '1', 14:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:15 INFO - 'PWD': '/builds/slave/test', 14:11:15 INFO - 'SHELL': '/bin/bash', 14:11:15 INFO - 'SHLVL': '1', 14:11:15 INFO - 'TERM': 'linux', 14:11:15 INFO - 'TMOUT': '86400', 14:11:15 INFO - 'USER': 'cltbld', 14:11:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:15 INFO - '_': '/tools/buildbot/bin/python'} 14:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:15 INFO - Running setup.py (path:/tmp/pip-hWXgDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:15 INFO - Running setup.py (path:/tmp/pip-FqDsrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:15 INFO - Running setup.py (path:/tmp/pip-ySus1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:15 INFO - Running setup.py (path:/tmp/pip-zhs251-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:15 INFO - Running setup.py (path:/tmp/pip-Nnlk7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:16 INFO - Running setup.py (path:/tmp/pip-FcNZ9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:16 INFO - Running setup.py (path:/tmp/pip-hJHD4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:16 INFO - Running setup.py (path:/tmp/pip-fUk_qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:16 INFO - Running setup.py (path:/tmp/pip-Z_UBz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:16 INFO - Running setup.py (path:/tmp/pip-w3RtrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:16 INFO - Running setup.py (path:/tmp/pip-HZcE8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:16 INFO - Running setup.py (path:/tmp/pip-JfHOFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:16 INFO - Running setup.py (path:/tmp/pip-5nQ_MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:16 INFO - Running setup.py (path:/tmp/pip-CYXoUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:16 INFO - Running setup.py (path:/tmp/pip-D69cPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:16 INFO - Running setup.py (path:/tmp/pip-Am5gm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:16 INFO - Running setup.py (path:/tmp/pip-ITazGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:16 INFO - Running setup.py install for manifestparser 14:11:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:16 INFO - Running setup.py install for mozcrash 14:11:17 INFO - Running setup.py install for mozdebug 14:11:17 INFO - Running setup.py install for mozdevice 14:11:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Running setup.py install for mozfile 14:11:17 INFO - Running setup.py install for mozhttpd 14:11:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Running setup.py install for mozinfo 14:11:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Running setup.py install for mozInstall 14:11:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Running setup.py install for mozleak 14:11:17 INFO - Running setup.py install for mozlog 14:11:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:17 INFO - Running setup.py install for moznetwork 14:11:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:18 INFO - Running setup.py install for mozprocess 14:11:18 INFO - Running setup.py install for mozprofile 14:11:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:18 INFO - Running setup.py install for mozrunner 14:11:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:18 INFO - Running setup.py install for mozscreenshot 14:11:18 INFO - Running setup.py install for moztest 14:11:18 INFO - Running setup.py install for mozversion 14:11:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:18 INFO - Cleaning up... 14:11:18 INFO - Return code: 0 14:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:18 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:18 INFO - Using env: {'DISPLAY': ':0', 14:11:18 INFO - 'HOME': '/home/cltbld', 14:11:18 INFO - 'LANG': 'en_US.UTF-8', 14:11:18 INFO - 'LANGUAGE': 'en_US:en', 14:11:18 INFO - 'LOGNAME': 'cltbld', 14:11:18 INFO - 'MAIL': '/var/mail/cltbld', 14:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:18 INFO - 'MOZ_NO_REMOTE': '1', 14:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:18 INFO - 'NO_EM_RESTART': '1', 14:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:18 INFO - 'PWD': '/builds/slave/test', 14:11:18 INFO - 'SHELL': '/bin/bash', 14:11:18 INFO - 'SHLVL': '1', 14:11:18 INFO - 'TERM': 'linux', 14:11:18 INFO - 'TMOUT': '86400', 14:11:18 INFO - 'USER': 'cltbld', 14:11:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:18 INFO - '_': '/tools/buildbot/bin/python'} 14:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:18 INFO - Running setup.py (path:/tmp/pip-oP6qEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:18 INFO - Running setup.py (path:/tmp/pip-3jzGVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:19 INFO - Running setup.py (path:/tmp/pip-TeBZTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:19 INFO - Running setup.py (path:/tmp/pip-D19YBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:19 INFO - Running setup.py (path:/tmp/pip-mDhtOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:19 INFO - Running setup.py (path:/tmp/pip-w0tgGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:19 INFO - Running setup.py (path:/tmp/pip-0LyWf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:19 INFO - Running setup.py (path:/tmp/pip-0POl4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:19 INFO - Running setup.py (path:/tmp/pip-Yx4xL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:19 INFO - Running setup.py (path:/tmp/pip-77evuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:19 INFO - Running setup.py (path:/tmp/pip-M7VHGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:19 INFO - Running setup.py (path:/tmp/pip-wD6BM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:19 INFO - Running setup.py (path:/tmp/pip-4U0MK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:19 INFO - Running setup.py (path:/tmp/pip-78KVNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:19 INFO - Running setup.py (path:/tmp/pip-Iu2yEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:19 INFO - Running setup.py (path:/tmp/pip-cVIFfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:20 INFO - Running setup.py (path:/tmp/pip-REHPBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:22 INFO - Downloading blessings-1.6.tar.gz 14:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:22 INFO - Installing collected packages: blessings 14:11:22 INFO - Running setup.py install for blessings 14:11:22 INFO - Successfully installed blessings 14:11:22 INFO - Cleaning up... 14:11:22 INFO - Return code: 0 14:11:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:22 INFO - Reading from file tmpfile_stdout 14:11:22 INFO - Current package versions: 14:11:22 INFO - argparse == 1.2.1 14:11:22 INFO - blessings == 1.6 14:11:22 INFO - blobuploader == 1.2.4 14:11:22 INFO - docopt == 0.6.1 14:11:22 INFO - functools32 == 3.2.3-2 14:11:22 INFO - jsonschema == 2.5.1 14:11:22 INFO - manifestparser == 1.1 14:11:22 INFO - mozInstall == 1.12 14:11:22 INFO - mozcrash == 0.17 14:11:22 INFO - mozdebug == 0.1 14:11:22 INFO - mozdevice == 0.48 14:11:22 INFO - mozfile == 1.2 14:11:22 INFO - mozhttpd == 0.7 14:11:22 INFO - mozinfo == 0.9 14:11:22 INFO - mozleak == 0.1 14:11:22 INFO - mozlog == 3.2 14:11:22 INFO - moznetwork == 0.27 14:11:22 INFO - mozprocess == 0.22 14:11:22 INFO - mozprofile == 0.28 14:11:22 INFO - mozrunner == 6.11 14:11:22 INFO - mozscreenshot == 0.1 14:11:22 INFO - mozsystemmonitor == 0.3 14:11:22 INFO - moztest == 0.7 14:11:22 INFO - mozversion == 1.4 14:11:22 INFO - psutil == 3.1.1 14:11:22 INFO - requests == 1.2.3 14:11:22 INFO - wsgiref == 0.1.2 14:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:22 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:22 INFO - Using env: {'DISPLAY': ':0', 14:11:22 INFO - 'HOME': '/home/cltbld', 14:11:22 INFO - 'LANG': 'en_US.UTF-8', 14:11:22 INFO - 'LANGUAGE': 'en_US:en', 14:11:22 INFO - 'LOGNAME': 'cltbld', 14:11:22 INFO - 'MAIL': '/var/mail/cltbld', 14:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:22 INFO - 'MOZ_NO_REMOTE': '1', 14:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:22 INFO - 'NO_EM_RESTART': '1', 14:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:22 INFO - 'PWD': '/builds/slave/test', 14:11:22 INFO - 'SHELL': '/bin/bash', 14:11:22 INFO - 'SHLVL': '1', 14:11:22 INFO - 'TERM': 'linux', 14:11:22 INFO - 'TMOUT': '86400', 14:11:22 INFO - 'USER': 'cltbld', 14:11:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:22 INFO - '_': '/tools/buildbot/bin/python'} 14:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:11:22 INFO - Cleaning up... 14:11:22 INFO - Return code: 0 14:11:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:22 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:11:22 INFO - Using env: {'DISPLAY': ':0', 14:11:22 INFO - 'HOME': '/home/cltbld', 14:11:22 INFO - 'LANG': 'en_US.UTF-8', 14:11:22 INFO - 'LANGUAGE': 'en_US:en', 14:11:22 INFO - 'LOGNAME': 'cltbld', 14:11:22 INFO - 'MAIL': '/var/mail/cltbld', 14:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:22 INFO - 'MOZ_NO_REMOTE': '1', 14:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:22 INFO - 'NO_EM_RESTART': '1', 14:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:22 INFO - 'PWD': '/builds/slave/test', 14:11:22 INFO - 'SHELL': '/bin/bash', 14:11:22 INFO - 'SHLVL': '1', 14:11:22 INFO - 'TERM': 'linux', 14:11:22 INFO - 'TMOUT': '86400', 14:11:22 INFO - 'USER': 'cltbld', 14:11:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:22 INFO - '_': '/tools/buildbot/bin/python'} 14:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:22 INFO - Cleaning up... 14:11:22 INFO - Return code: 0 14:11:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:22 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 0x7f859062cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:11:22 INFO - Using env: {'DISPLAY': ':0', 14:11:22 INFO - 'HOME': '/home/cltbld', 14:11:22 INFO - 'LANG': 'en_US.UTF-8', 14:11:22 INFO - 'LANGUAGE': 'en_US:en', 14:11:22 INFO - 'LOGNAME': 'cltbld', 14:11:22 INFO - 'MAIL': '/var/mail/cltbld', 14:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:22 INFO - 'MOZ_NO_REMOTE': '1', 14:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:22 INFO - 'NO_EM_RESTART': '1', 14:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:22 INFO - 'PWD': '/builds/slave/test', 14:11:22 INFO - 'SHELL': '/bin/bash', 14:11:22 INFO - 'SHLVL': '1', 14:11:22 INFO - 'TERM': 'linux', 14:11:22 INFO - 'TMOUT': '86400', 14:11:22 INFO - 'USER': 'cltbld', 14:11:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:22 INFO - '_': '/tools/buildbot/bin/python'} 14:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:23 INFO - Downloading/unpacking flake8 14:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:11:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:11:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:25 INFO - no previously-included directories found matching 'docs/_build' 14:11:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:11:25 INFO - Running setup.py install for pep8 14:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:25 INFO - no previously-included directories found matching 'docs/_build' 14:11:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:11:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:11:25 INFO - Cleaning up... 14:11:26 INFO - Return code: 0 14:11:26 INFO - Running post-action listener: _resource_record_post_action 14:11:26 INFO - Running post-action listener: _start_resource_monitoring 14:11:26 INFO - Starting resource monitoring. 14:11:26 INFO - ##### 14:11:26 INFO - ##### Finished create-virtualenv step (success) 14:11:26 INFO - ##### 14:11:26 INFO - ##### 14:11:26 INFO - ##### Running install step. 14:11:26 INFO - ##### 14:11:26 INFO - Running pre-action listener: _resource_record_pre_action 14:11:26 INFO - Running main action method: install 14:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:26 INFO - Reading from file tmpfile_stdout 14:11:26 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:26 INFO - Reading from file tmpfile_stdout 14:11:26 INFO - Output received: 14:11:26 INFO - Usage: mozinstall [options] installer 14:11:26 INFO - Options: 14:11:26 INFO - -h, --help show this help message and exit 14:11:26 INFO - -d DEST, --destination=DEST 14:11:26 INFO - Directory to install application into. [default: 14:11:26 INFO - "/builds/slave/test"] 14:11:26 INFO - --app=APP Application being installed. [default: firefox] 14:11:26 INFO - mkdir: /builds/slave/test/build/application 14:11:26 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'] 14:11:26 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 14:11:42 INFO - Reading from file tmpfile_stdout 14:11:42 INFO - Output received: 14:11:42 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:42 INFO - Running post-action listener: _resource_record_post_action 14:11:42 INFO - ##### 14:11:42 INFO - ##### Finished install step (success) 14:11:42 INFO - ##### 14:11:42 INFO - ##### 14:11:42 INFO - ##### Running run-tests step. 14:11:42 INFO - ##### 14:11:42 INFO - Running pre-action listener: _resource_record_pre_action 14:11:42 INFO - Running main action method: run_tests 14:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:42 INFO - Python 2.7.3 14:11:42 INFO - Return code: 0 14:11:42 INFO - grabbing minidump binary from tooltool 14:11: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')]} 14:11:42 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 0x1cd22e0>, '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 0x1c3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:11:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:11:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:11:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:42 INFO - Return code: 0 14:11:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:11:43 INFO - Return code: 0 14:11:43 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/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:11:43 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/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:11:43 INFO - Using env: {'DISPLAY': ':0', 14:11:43 INFO - 'HOME': '/home/cltbld', 14:11:43 INFO - 'LANG': 'en_US.UTF-8', 14:11:43 INFO - 'LANGUAGE': 'en_US:en', 14:11:43 INFO - 'LOGNAME': 'cltbld', 14:11:43 INFO - 'MAIL': '/var/mail/cltbld', 14:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:43 INFO - 'MOZ_NO_REMOTE': '1', 14:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:43 INFO - 'NO_EM_RESTART': '1', 14:11:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:43 INFO - 'PWD': '/builds/slave/test', 14:11:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:43 INFO - 'SHELL': '/bin/bash', 14:11:43 INFO - 'SHLVL': '1', 14:11:43 INFO - 'TERM': 'linux', 14:11:43 INFO - 'TMOUT': '86400', 14:11:43 INFO - 'USER': 'cltbld', 14:11:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905', 14:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:43 INFO - '_': '/tools/buildbot/bin/python'} 14:11:43 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/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:11:43 INFO - mozversion application_buildid: 20160610133026 14:11:43 INFO - mozversion application_changeset: 9545df18ca9eaa35915df14e23543c02363ff83e 14:11:43 INFO - mozversion application_display_name: Nightly 14:11:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:43 INFO - mozversion application_name: Firefox 14:11:43 INFO - mozversion application_remotingname: firefox 14:11:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:11:43 INFO - mozversion application_vendor: Mozilla 14:11:43 INFO - mozversion application_version: 50.0a1 14:11:43 INFO - mozversion platform_buildid: 20160610133026 14:11:43 INFO - mozversion platform_changeset: 9545df18ca9eaa35915df14e23543c02363ff83e 14:11:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:11:43 INFO - mozversion platform_version: 50.0a1 14:11:43 INFO - using testdate: 1465593103 14:11:43 INFO - actual date: 1465593103 14:11:43 INFO - starting webserver on 'localhost:46297' 14:11:43 INFO - SUITE-START | Running 2 tests 14:11:43 INFO - TEST-START | dromaeo_css 14:11:43 INFO - operating with platform_type : linux_ 14:11:43 INFO - Initialising browser for dromaeo_css test... 14:11:43 INFO - TEST-INFO | started process 6561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiAKRnF/profile http://localhost:46297/getInfo.html) 14:11:48 INFO - PROCESS | 6561 | __metrics Screen width/height:1600/1200 14:11:48 INFO - PROCESS | 6561 | colorDepth:24 14:11:48 INFO - PROCESS | 6561 | Browser inner width/height: 1024/697 14:11:48 INFO - PROCESS | 6561 | __metrics 14:11:49 ERROR - PROCESS | 6561 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:11:50 INFO - TEST-INFO | 6561: exit 0 14:11:50 INFO - Browser initialized. 14:11:50 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:50 INFO - TEST-INFO | started process 6681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiAKRnF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:02 INFO - PROCESS | 6681 | RSS: Main: 186249216 14:12:02 INFO - PROCESS | 6681 | 14:12:51 INFO - PROCESS | 6681 | 1465593171977 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:15:04 INFO - PROCESS | 6681 | Cycle 1(1): loaded http://localhost:46297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46297/tests/dromaeo/cssquery-ext.html) 14:15:05 INFO - PROCESS | 6681 | RSS: Main: 188903424 14:15:05 INFO - PROCESS | 6681 | 14:18:07 INFO - PROCESS | 6681 | Cycle 1(1): loaded http://localhost:46297/tests/dromaeo/cssquery-ext.html (next: http://localhost:46297/tests/dromaeo/cssquery-jquery.html) 14:18:07 INFO - PROCESS | 6681 | RSS: Main: 187707392 14:18:07 INFO - PROCESS | 6681 | 14:21:09 INFO - PROCESS | 6681 | Cycle 1(1): loaded http://localhost:46297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46297/tests/dromaeo/cssquery-mootools.html) 14:21:10 INFO - PROCESS | 6681 | RSS: Main: 189227008 14:21:10 INFO - PROCESS | 6681 | 14:24:12 INFO - PROCESS | 6681 | Cycle 1(1): loaded http://localhost:46297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46297/tests/dromaeo/cssquery-prototype.html) 14:24:12 INFO - PROCESS | 6681 | RSS: Main: 186589184 14:24:12 INFO - PROCESS | 6681 | 14:27:15 INFO - PROCESS | 6681 | Cycle 1(1): loaded http://localhost:46297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46297/tests/dromaeo/cssquery-yui.html) 14:27:16 INFO - PROCESS | 6681 | RSS: Main: 188489728 14:27:16 INFO - PROCESS | 6681 | 14:30:18 INFO - PROCESS | 6681 | Cycle 1(1): loaded http://localhost:46297/tests/dromaeo/cssquery-yui.html (next: http://localhost:46297/tests/dromaeo/cssquery-dojo.html) 14:30:19 INFO - PROCESS | 6681 | RSS: Main: 190042112 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | __start_tp_report 14:30:19 INFO - PROCESS | 6681 | _x_x_mozilla_page_load 14:30:19 INFO - PROCESS | 6681 | _x_x_mozilla_page_load_details 14:30:19 INFO - PROCESS | 6681 | |i|pagename|runs| 14:30:19 INFO - PROCESS | 6681 | |0;dojo.html;2590.572555528338;2591.663083799107;2601.9609705854405;2608.921732348029;2628.39546904212;4668.836590719326;4750;4794.448638406584;4837.733924634153;4844.103840789457;4694.17851875922;4697.953020469794;4736.834210802623;4740.644451666121;4829.034193161364;4400.075984043347;4417.646588272946;4433.401490798749;4480.887977800565;4482.03636218213;4185.476815398075;4434.113177364524;4436.689431739779;4524.095180963804;4524.773761311938;4309.159713855799;4343.500497442803;4371.0820727646915;4383.211022016036;4436.268015777409;4345.50026746925;4356.765712802805;4423.4912985006495;4437.977810110961;4454.242778727624;4396.098799746044;4410.735355878657;4430.689851710382;4448.1770872388715;4461.732296062214;4739.549742774431;4802;4818.301346304801;4819.4939531349055;4824.035192961422;5183.61122915779;5189;5194.792208311663;5199.376074871002;5261.5790736741355;4973.303737476756;5087.23691446286;5207.427183009866;5228.764705588258;5229.529342359206;4792.880177995543;4802.991371811959;4814.735189564538;4815.036992601494;4856.805727770849;5263.00065725272;5264.78940842362;5271.551918086929;5271.551918086929;5299.072662284085;5028.698278103326;5047.470015648304;5072.847814565569;5103.18349064148;5126.948730512721;4998.375203099613;5251;5253.527182553588;5257.737113144404;5268.315119034578;5045.495450454925;5050.621203409759;5103.795848166106;5108.361454818148;5120.18077107661;4975;4975.651704380659;4992.301077849104;5053.36832895888;5069.493050694901;4251.681123915719;4255.404243405926;4260.936085958713;4265.957340426618;4310;3755.080005398695;3759.9096262084236;3768.7550309229814;3795.4876091727265;3816.0459885028745;4405.977970110129;4460.397846290774;4466.888327791767;4505;4521.773911304422;5106.514881086291;5123.333966584395;5163.561097306696;5205.401378841406;5207.817726379559;4406.294992801137;4498.167838949805;4503.482099558527;4506.098780243899;4554.772261386917;4577.542245775462;4593.058423023273;4615.053913947632;4628.097520983443;4650.604698600657;4888.9755551222015;4929.802807887788;4942.209246520683;4949.6287778416045;4997.150484417585;5046.268291097844;5131.640785145004;5258.8948221036135;5273.558354458118;5326.866828329168;4780.211265141213;4810.230363141881;4826.975865120652;4896.167651499182;4934.333864928332;5077.543021128116;5078.136716758234;5079.187330027178;5093.083245015932;5130.640855140105;5147.9227811582105;5196.064708352533;5244.580433565382;5258.290130832289;5269.710165940756;4789;4792.305115758126;4806.639502037291;4848.151573474698;5129.563987061141;4861.319415281792;4868.318435419115;4868.513148685103;4999.475055119306;5048.7475626219275;4909.4354149273295;4926.827561035347;4964.751762411937;4974.527419895104;5010.799568017239;4872.951270487391;4958.082754690394;5019.121653710513;5068.062408454301;5078.390593128848;4852.684575502581;4912.656114072123;4915.508449155056;4920.458749537476;4961.776720047535 14:30:19 INFO - PROCESS | 6681 | |1;ext.html;521.5111337344712;586.6831910768185;591.4026832898771;609.3236507476698;610.1366566308674;34559.48160777587;40000.599994000055;40046.59953400465;40068;40080.398794018074;38005;38848;38882.611173888254;39052.41421378682;39053.609463905355;7801.102873169587;7924.207579242087;7936.404769642271;7949;7951.125376208613;7833.882491762628;7896.960515197416;7900.446968712193;7944.126146123922;7953.562554059525;7892.171322011192;7947.165547617504;7994.280514753671;7999.280064794168;8014.358851291882;7881.684732610689;7892.526448413085;7925.0093738283;7929.365650747926;7956.124826269106;7883.132855385903;7910.683572657087;7912.723054693058;7945.841083178362;7960.522368657841;38119;38406.23187536262;38707.8064609678;38733.61266387328;38751.418728719094;2933.6919623439658;2951.050276598622;2971.390864872696;3290.7367410607094;3812.0850995760816;29405;29902.70097299021;29940.251493712833;30162.547561786592;30290.091297260897;3369.663033696611;3369.915752106217;3416.062465142214;3437.329720704464;3467.861285548575;244853;245029;245726;245864;246443;51692.74153629208;52350.47649523532;52485.737571311896;52516.73741631344;52581;33270.16824579405;34582.308353832785;34620.82689586536;56892;57105.71447142821;14986.175760333286;15092.39630414771;15155.393784248507;15160.545183644508;15181.316840742193;11059.834102488468;11117.499712512956;11135.888641113484;11262.211645184922;11275.943620281847;18300.725489117674;18417.907910460362;18466.630667386577;18498.630027399646;18551.44345669632;6918.135233095863;6935.861282774417;6943.652817359213;6958.190870373739;7063.964680176567;767.2251026463313;840.6133178737849;848.8429640516524;853.9103394143525;935.1163150822543;28237.294067648472;28418.147455576367;28823;28959.565606515498;29092;901.3465237702744;942.4675058591873;963.5375019990304;994.5325696922434;1048.2609760119099;14383.137011779327;14677.192754398397;14855.182964936816;14871.256437178314;15056;188763;192950;193008;193729;376958;49507;49851;49893.75053124711;49916;50151;1161.7502237019082;1189.1141099880645;1198.766240583078;1200.1658847101355;1210.2617403383929;26003.609945851207;27139.86430067916;27415.862920685267;27692.307692307855;27799.58300625533;42061;42327.57672423236;42469.787651061546;42567.148657027305;42611.7869410651;244429;249909;326877;327330;328399;25461.745382545938;26003.609945851207;26205.868970655025;26243;26266.343341416617;43364.56635433605;43540.56459435365;43639;43832;43988.78005609952;35790.9927842747;36984.26031479409;37084.25831483409;37413.438798417505;37475.625243747214;36588.451173232956;36754.8162259187;36847.815760921025;36923.26153476969;36995.63004369922;35639.41508476107;35988.82005589955;36186.27627447489;36620.26759464849;36784.81607591945;32154.83922580372;32671.509927351584;33000;33159.668403315656;33485.83257083699;25025.374365641004;25155.87422062878;25191.11831085903;25264;25524.744752552237 14:30:19 INFO - PROCESS | 6681 | |2;jquery.html;363.11581299535635;368.37560335231774;373.0766353275643;380.9333366660834;397.9323515002451;15578.766318505217;15977.360905563777;17014.87314085739;17054.317827286908;17085.48743537696;15839.524814255561;16273.430429934955;16880;16929.83070169298;16968.74546881798;5086.135356989321;5242.292290540767;5253.6322457428;5279;5305.602079844027;5118.795248190087;5123.5388815006645;5145.945081258352;5200.167973124301;5219.843404697846;5180.8704782380555;5216.191490319006;5223;5241.2400201970695;5244.423113457517;5010.72441015744;5080.339555857715;5144.125498665236;5162.561182299491;5191.4548972357925;4469.3296005599095;4534.38785763921;4541.8410355637725;4544.341070544786;4545.681802273843;19608.80391196084;19956.800431995784;20699.17203311866;20718.378448646567;20739.481512962146;1749.361483058687;1864.6177533605578;2024.433158715562;2075.9481012974647;2311.5261371418987;8632.611532481053;9003.054679258714;9293.907060929372;9294.349395542315;9383.624655013791;1663.5674724571697;1730.0225372664404;1790.1049475262369;1825.3246298869371;1836.4307064809952;47549.76225118887;60329.39670603326;60771;64095.67952160256;68212.31787682159;9651.276154288456;9807.656732014346;9945.01099780047;10133.442660653734;10173.338732982333;13866.306684665726;13897.444102235999;13983.091099078527;14023.719525609431;14042.85957140436;7194.2014496375905;7215.422766178693;7257.987935006913;7294.124705035323;7369.115706115301;6855.862882742417;6893.896591551131;6960.37356637905;7012.824679382954;7021.859562808818;4326.13799367655;4344.804483798237;4356.411884395629;4364.759938203366;4375.956240437555;1737.6177241006958;1781.768370111903;1798.5683435975272;1801.2974939773499;1810.8822926509736;876.3996662286354;887.0685779931047;895.6462197432108;895.892492900856;933.3979583168954;16060.919695401448;16574.6685066298;16669;16690.248938797784;17063.317467301167;822.2280984478458;835.8453686068096;839.995800020996;861.9439736417113;912.0924679943498;9242.76893077665;9246.26029917605;9246.676366327147;9471.47906865129;9471.573779179953;404790;412286;414114;414670;416833;61224.693876530335;79882.60058699785;84752.57623711965;88407.55796220977;88430.55784721035;912.7444315591645;914.8673442350822;931.189864817613;940.7977284883783;957.5260246178186;15443.382264709286;15483;15586;15595.220238987778;15953.840461595235;34655.65344346524;36359.636403635624;36818;37405.43891841679;37754.8112259437;49734.25398619096;50884;50977;52210.47789522208;52418;6594.868102638016;7087.362137407658;7196.136463624399;7205.891911621225;7597.6581053851605;11806.409679515818;11946.98450631706;12057.57798477049;12260.570880019157;12262.632121036384;9836.311458197857;10086.495675216063;10124.69625911224;10263.332883362558;10269.845952310572;10641.733956651145;10868.130549556176;10946.39794811293;11026.50380732885;11148.721281968015;10510.369377837354;10808.243422960632;10898.182636302468;10995.285306455055;11015.284006539548;7794.103678077094;7830.647620856961;7971.282584567417;7979.321757650432;8004.359651228005;9140.862887056832;10345.534450949575;10476.580936762444;10531.526081326512;10556.524956377136 14:30:19 INFO - PROCESS | 6681 | |3;mootools.html;1350.2168742129566;1371.4856928651755;1451.8838492920568;1646.3908353909042;1667.2414051606513;6750.966245168767;7402.296781805733;7507.62461876906;7998.7600371988865;8001.279884810366;7460;7551.848963020736;7613.162552119263;7710.807229819257;7740.767776966686;2204.6803213534026;2233.4528040630066;2234.3520379090046;2234.497238121426;2237.0157130862367;2132.8507004509693;2199.0544066051593;2204.217502786512;2207.1612787140866;2209.149477451185;2140.9357719268446;2166.306781829815;2175.651895696689;2183.1158380855777;2188.9233876814314;2106.241752968938;2167.219800871685;2201.933941981735;2218.0905828610353;2218.7559368469456;2165.1339464214284;2198.1427243375097;2203.5262418580082;2218.7559368469456;2225.2100504321056;7710.884336734954;7805.765827025199;7829.686812527549;7846.843063138763;7874.936883520709;4631.374764406795;4745.715257084586;4755.35802666639;4762.119007983534;4768.3085952536685;2832.660080790298;2910.8544572771275;2934.8092373995837;2978.851057447119;3027.969720302791;869.699953516036;880.7842078690697;893.5398269891011;897.0131159481779;912.1380295620642;10719.571217151304;10726.088282495997;10734.141268698564;10767.892321076768;10792.406417647026;4263.083437061046;4335.154644844225;4426.402435671143;4461.754603496839;4477.865664030084;9160.129787670161;9168;9204.861927071099;9208.447493150432;9211.585478653476;4671.556202160789;4713.858584242478;4726.787294571753;4735.384400027974;4737.95262047382;3732.309522738302;4097.774622395737;4220.894477638084;4323.7621930793475;4399.054203346296;3725.180460298784;3751.362268414376;3774.339490589136;3849.230153969161;3863.613638636114;1239.659093749208;1249.94375253112;1259.71026663866;1265.1649911058657;1267.5880338889897;832.8167803083312;852.0882655558493;858.9828203435897;867.2368315881984;878.8813510176172;5172.818951336685;5300.09898317287;5322.2548843161985;5323.334583177103;5331.1470164773455;409.93031184698674;410.14484799194014;411.1653343712269;412.4267268496792;430.8987387963826;3541.8760343387858;3645.0887278180453;3663.2673465307043;3666.7799932004164;3682.9447558286647;9271.119243671841;9524.380915240487;9642.276829237695;9844.50777461124;9876.555555000043;9677.129058384779;9733.707988760349;9742.074502922353;9747.463889486145;9764.902350976541;7179.389751871045;7300.6349682515665;7325.706971721072;7328.120625524971;7371.668274927534;5069.543741063322;5309.123994540858;5351.438098999549;5519;5519.558435325244;8843.336749743923;8933.865992010255;9046.909530904606;9053.049429810038;9062.50156241413;8817.911820881965;8831.779205519913;8904.732858014011;8960.462372257685;9012.81974360496;6000.5799594028;6629.5359324846795;6759.797206083826;6815.42068924147;6846.657667116525;7523;7561.7731468056045;7574.091109066947;7599.050118735158;7605.391568674603;6706.798796036127;6771.28901465339;6941.097657304518;7017.473689473412;7048.577085374894;6615.867682646416;6631.237407698177;6711.026901099216;6729.730810767514;6869.690863911036;6205.565610407409;6238.875222495615;6291.056341548804;6305.558610897193;6327.525435592441;4653.953460465487;4656.301554766812;4702.27114797207;4708.717476951394;4750.12122757291;4614.215583350771;4624.28323609841;4638.62890968715;4642.698224615389;4743.335932969456 14:30:19 INFO - PROCESS | 6681 | |4;prototype.html;290.31485693762716;306.1443266071331;310.92693217093984;311.0528440897468;313.28102005896466;4832.685875418096;4913.707815763438;4978.55193032627;5051.570616497597;5074.7208903510245;4956.752162391875;4966.428860681022;4982.352294201749;4995.700257984524;5004.474530174334;3904.882853514392;3937.1416012307814;3939.704522160835;3946.3291240489184;3950.170464202521;3847.6537111659945;3876.2218203022258;3949.9210015799667;3959.5248570171475;3962.8811135665833;3862.1310205203745;3881.7476864003893;3885.941710874325;3892.4355968384566;3897.8051097445154;3907.902302442433;3909.198614284065;3944.9013774655577;3950.4271880577444;3952.5454572724216;3295.340931813647;3418.7265018798435;3423.6576342365815;3488.4767284907466;3494.755367124302;4863.124637565237;4870.099031679115;4879.536444037811;4881;4881;4453.55464453552;4462.776861156929;4477.6417886569;4479.3281007848755;4525.615322697542;5022.59819214462;5309.840704778863;5315.601329900234;5334.813281535166;5336.38631557372;3755.2301778135416;3758.586555478895;3762.1347090169143;3769.41574056019;3777.490038844776;5454.91817622736;5465.836024919259;5543.861403464905;5546.4453554644615;5560.193771903092;3698.4637227601847;3827.827747751358;3829.1767270037076;3851.383778595411;3882.456456096149;3868.361720316116;3881.3595756700392;3887.231309754055;3888.7666739995125;3890.358090915024;4428.734275943454;4431.670498850332;4444.222261104358;4448.644108471314;4458.242098843204;5266.92099618506;5268.9736551317;5279.260903473517;5283.392409872914;5336.7865285388925;1248.843894513186;1308.685915380321;1344.919304841693;1348.9730205396033;1357.7080927600614;849.3799526345803;857.8461968652152;865.3639574912435;869.8086420987372;884.8451520983803;4217.662586993033;4220.451341325669;4236.491621005499;4240.957590424118;4246.893827654333;4795.664303498722;4814.325994360793;4826.638002149783;4832.371791667131;4834.709917404967;4199.559046300155;4213.831446742157;4216.599423054805;4220.8051813057655;4224.162489317096;2431.598786200257;2591.287395966124;2595.545779488582;2601.388673661688;2611.764941155305;4553.453585569753;4559.361689363492;4560.224761790503;4579.931301030487;4615.215413379734;4892.9235568174945;4931.753412329369;4935.728534930541;4938.25926111079;4968.6025117990475;4332.4801023877335;4528.298113792367;4539;4563.657725670521;4571.26859702446;4784.6889952153;4801.855944321676;4848.660593758403;4861.440934292602;4864.708117512961;4588.944542755118;4704.694194877322;4705.106029854317;4712.929306060343;4746.477887432448;4316;4489.438820147481;4504.594586487232;4539.319102134574;4543.227651299221;3490.4938783876705;3511.805985964784;3517.1886478464126;3533.9646603533633;3553.9466907996916;4806.951930480651;4829.830955916526;4835.694362522029;4869.9026019480125;5123.001014802227;5003.099442100457;5163.509466600667;5170.802408976246;5216.956608678203;5219.582433405394;5202.843914682566;5260.973695131653;5272.920906186487;5308.973455132699;5322.148456246982;5033.445397347113;5137.974310128426;5191.546367017241;5207.583393328448;5208.583313335;5297.152455607084;5299.178627312773;5322.308099946982;5324.733763311897;5331.466853314792;5200.791968321225;5211.9478805212975;5240.266362709148;5255.816046438356;5262.210668399771 14:30:19 INFO - PROCESS | 6681 | |5;yui.html;606.1059936593525;637.837351475374;659.5844617890729;735.7314580178235;736.5212611802327;12566.748665026706;13627.795583066261;13658.38537265823;13719.93140034301;13747.381367838447;11575.942120289386;11580.884191158086;12228.20516666416;12617.936910315459;13011.284379359131;627.3444250757968;780.449782903052;786.394476253286;793.2979313307735;796.9362451003934;789.569684521934;796.7211475983388;797.5254723439544;797.9441439099265;799.1169757418028;833.1044127562864;837.857564214082;838.5890913452395;846.0904527632789;848.2704873808519;831.6881169561415;832.0556168748484;833.0544831616098;833.2126140796919;835.1314632781899;606.5814587934311;607.7417097733489;608.3399511529996;609.3662590905453;610.8320211941707;13934.93032534841;13971.09187902783;14112.223827689473;14114.788278175836;14155.221462819542;13425;13972.51096211638;13981.930090349584;14031;14262.144271343752;10065.295429319951;10198.541065652063;10426.739331516697;10494.52774625136;10569.577216911315;4223.598758118004;4239.6396306314;4260.254455470311;4334.4798624165305;4423.955760442419;56497;56944.145837812466;57044;57163;57600.13599796007;9431.575579098957;9855.507224638739;9864.358816676893;9873.555689993967;9905.851412228822;16872.240749166318;16872.746908796376;16950.406735764434;16985.405510807308;17016.659666806594;6731.225909020427;6735.326467353323;6750.223724271674;6773.830654233585;6973.232944376216;3949.2101579683604;3962.306596345628;3986.22268657609;4009.67922566194;4025.818838152232;2787.8606069696434;2829.915102546927;2844.459552684983;2854.072426461408;2864.4557534068877;515.062586093314;524.8792777661159;530.9681419114788;531.2509361799844;535.6785928442903;530.8938212357544;534.3267482971484;551.4623242338768;553.1923391847866;561.1862798941551;7306.9404936285;7482.8877566836545;7590.203028681909;7591.620418979029;7650.617469126521;494.70070607282076;564.4834975996916;570.5492660797923;575.1602660116278;575.3785911215876;3574.303010912847;3633.1462106404974;3641.690456311243;3646.6353364663323;3716.479692843004;54028.45971540234;54205.72877666953;88531.55734221288;90006.09993900108;92725.5363723177;73975;77022.61488692633;79216;79479.60260198778;81647;68405.3159468399;70734.2926570738;71461.64269178621;71581;72223.27776722271;7053.188883278489;7060.964695176492;7132.536385134949;7177.174624917992;7283.927160728324;39648;43698.159619624625;43996.780016099714;44347.11305773802;45157.77421112874;54579.454205457434;61288.08067879074;61520;61849.38150618436;62164.37835621586;9432.434053956784;9452.196563291922;9570.95214523923;9726.46504442234;9799.804003920024;10148.54331555067;10194.694159175237;10226.488675566341;10265.640702575374;10444.268901176845;8798.296136308953;9022.639094436148;9392.624295028123;9484.905150948678;9529.904700952902;9053.868736726008;9118.361714679908;9319.86020209684;9418.199453046567;9842.950785246028;9067.319951003568;9324.347295689236;9429.764255893657;9455.858162127435;9570.138687518156;8313.168683131638;8419.410641255054;8743.650253989768;8759.12408759119;8831.02858685557;8003.541213860294;8029.478083924526;8111;8155.79610509742;8275.255227029356 14:30:19 INFO - PROCESS | 6681 | __end_tp_report 14:30:19 INFO - PROCESS | 6681 | __start_cc_report 14:30:19 INFO - PROCESS | 6681 | _x_x_mozilla_cycle_collect,384 14:30:19 INFO - PROCESS | 6681 | __end_cc_report 14:30:19 INFO - PROCESS | 6681 | __startTimestamp1465594219237__endTimestamp 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | ------- Summary: start ------- 14:30:19 INFO - PROCESS | 6681 | Number of tests: 6 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | [#0] dojo.html Cycles:165 Average:4744.98 Median:4856.81 stddev:515.26 (10.6%) stddev-sans-first:488.33 14:30:19 INFO - PROCESS | 6681 | Values: 2590.6 2591.7 2602.0 2608.9 2628.4 4668.8 4750.0 4794.4 4837.7 4844.1 4694.2 4698.0 4736.8 4740.6 4829.0 4400.1 4417.6 4433.4 4480.9 4482.0 4185.5 4434.1 4436.7 4524.1 4524.8 4309.2 4343.5 4371.1 4383.2 4436.3 4345.5 4356.8 4423.5 4438.0 4454.2 4396.1 4410.7 4430.7 4448.2 4461.7 4739.5 4802.0 4818.3 4819.5 4824.0 5183.6 5189.0 5194.8 5199.4 5261.6 4973.3 5087.2 5207.4 5228.8 5229.5 4792.9 4803.0 4814.7 4815.0 4856.8 5263.0 5264.8 5271.6 5271.6 5299.1 5028.7 5047.5 5072.8 5103.2 5126.9 4998.4 5251.0 5253.5 5257.7 5268.3 5045.5 5050.6 5103.8 5108.4 5120.2 4975.0 4975.7 4992.3 5053.4 5069.5 4251.7 4255.4 4260.9 4266.0 4310.0 3755.1 3759.9 3768.8 3795.5 3816.0 4406.0 4460.4 4466.9 4505.0 4521.8 5106.5 5123.3 5163.6 5205.4 5207.8 4406.3 4498.2 4503.5 4506.1 4554.8 4577.5 4593.1 4615.1 4628.1 4650.6 4889.0 4929.8 4942.2 4949.6 4997.2 5046.3 5131.6 5258.9 5273.6 5326.9 4780.2 4810.2 4827.0 4896.2 4934.3 5077.5 5078.1 5079.2 5093.1 5130.6 5147.9 5196.1 5244.6 5258.3 5269.7 4789.0 4792.3 4806.6 4848.2 5129.6 4861.3 4868.3 4868.5 4999.5 5048.7 4909.4 4926.8 4964.8 4974.5 5010.8 4873.0 4958.1 5019.1 5068.1 5078.4 4852.7 4912.7 4915.5 4920.5 4961.8 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | [#1] ext.html Cycles:180 Average:42061.28 Median:36816.32 stddev:68709.66 (186.6%) stddev-sans-first:68831.62 14:30:19 INFO - PROCESS | 6681 | Values: 521.5 586.7 591.4 609.3 610.1 34559.5 40000.6 40046.6 40068.0 40080.4 38005.0 38848.0 38882.6 39052.4 39053.6 7801.1 7924.2 7936.4 7949.0 7951.1 7833.9 7897.0 7900.4 7944.1 7953.6 7892.2 7947.2 7994.3 7999.3 8014.4 7881.7 7892.5 7925.0 7929.4 7956.1 7883.1 7910.7 7912.7 7945.8 7960.5 38119.0 38406.2 38707.8 38733.6 38751.4 2933.7 2951.1 2971.4 3290.7 3812.1 29405.0 29902.7 29940.3 30162.5 30290.1 3369.7 3369.9 3416.1 3437.3 3467.9 244853.0 245029.0 245726.0 245864.0 246443.0 51692.7 52350.5 52485.7 52516.7 52581.0 33270.2 34582.3 34620.8 56892.0 57105.7 14986.2 15092.4 15155.4 15160.5 15181.3 11059.8 11117.5 11135.9 11262.2 11275.9 18300.7 18417.9 18466.6 18498.6 18551.4 6918.1 6935.9 6943.7 6958.2 7064.0 767.2 840.6 848.8 853.9 935.1 28237.3 28418.1 28823.0 28959.6 29092.0 901.3 942.5 963.5 994.5 1048.3 14383.1 14677.2 14855.2 14871.3 15056.0 188763.0 192950.0 193008.0 193729.0 376958.0 49507.0 49851.0 49893.8 49916.0 50151.0 1161.8 1189.1 1198.8 1200.2 1210.3 26003.6 27139.9 27415.9 27692.3 27799.6 42061.0 42327.6 42469.8 42567.1 42611.8 244429.0 249909.0 326877.0 327330.0 328399.0 25461.7 26003.6 26205.9 26243.0 26266.3 43364.6 43540.6 43639.0 43832.0 43988.8 35791.0 36984.3 37084.3 37413.4 37475.6 36588.5 36754.8 36847.8 36923.3 36995.6 35639.4 35988.8 36186.3 36620.3 36784.8 32154.8 32671.5 33000.0 33159.7 33485.8 25025.4 25155.9 25191.1 25264.0 25524.7 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | [#2] jquery.html Cycles:180 Average:24745.33 Median:4501.86 stddev:67951.10 (1509.4%) stddev-sans-first:68117.06 14:30:19 INFO - PROCESS | 6681 | Values: 363.1 368.4 373.1 380.9 397.9 15578.8 15977.4 17014.9 17054.3 17085.5 15839.5 16273.4 16880.0 16929.8 16968.7 5086.1 5242.3 5253.6 5279.0 5305.6 5118.8 5123.5 5145.9 5200.2 5219.8 5180.9 5216.2 5223.0 5241.2 5244.4 5010.7 5080.3 5144.1 5162.6 5191.5 4469.3 4534.4 4541.8 4544.3 4545.7 19608.8 19956.8 20699.2 20718.4 20739.5 1749.4 1864.6 2024.4 2075.9 2311.5 8632.6 9003.1 9293.9 9294.3 9383.6 1663.6 1730.0 1790.1 1825.3 1836.4 47549.8 60329.4 60771.0 64095.7 68212.3 9651.3 9807.7 9945.0 10133.4 10173.3 13866.3 13897.4 13983.1 14023.7 14042.9 7194.2 7215.4 7258.0 7294.1 7369.1 6855.9 6893.9 6960.4 7012.8 7021.9 4326.1 4344.8 4356.4 4364.8 4376.0 1737.6 1781.8 1798.6 1801.3 1810.9 876.4 887.1 895.6 895.9 933.4 16060.9 16574.7 16669.0 16690.2 17063.3 822.2 835.8 840.0 861.9 912.1 9242.8 9246.3 9246.7 9471.5 9471.6 404790.0 412286.0 414114.0 414670.0 416833.0 61224.7 79882.6 84752.6 88407.6 88430.6 912.7 914.9 931.2 940.8 957.5 15443.4 15483.0 15586.0 15595.2 15953.8 34655.7 36359.6 36818.0 37405.4 37754.8 49734.3 50884.0 50977.0 52210.5 52418.0 6594.9 7087.4 7196.1 7205.9 7597.7 11806.4 11947.0 12057.6 12260.6 12262.6 9836.3 10086.5 10124.7 10263.3 10269.8 10641.7 10868.1 10946.4 11026.5 11148.7 10510.4 10808.2 10898.2 10995.3 11015.3 7794.1 7830.6 7971.3 7979.3 8004.4 9140.9 10345.5 10476.6 10531.5 10556.5 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | [#3] mootools.html Cycles:180 Average:5160.40 Median:5121.18 stddev:2889.87 (56.4%) stddev-sans-first:2883.80 14:30:19 INFO - PROCESS | 6681 | Values: 1350.2 1371.5 1451.9 1646.4 1667.2 6751.0 7402.3 7507.6 7998.8 8001.3 7460.0 7551.8 7613.2 7710.8 7740.8 2204.7 2233.5 2234.4 2234.5 2237.0 2132.9 2199.1 2204.2 2207.2 2209.1 2140.9 2166.3 2175.7 2183.1 2188.9 2106.2 2167.2 2201.9 2218.1 2218.8 2165.1 2198.1 2203.5 2218.8 2225.2 7710.9 7805.8 7829.7 7846.8 7874.9 4631.4 4745.7 4755.4 4762.1 4768.3 2832.7 2910.9 2934.8 2978.9 3028.0 869.7 880.8 893.5 897.0 912.1 10719.6 10726.1 10734.1 10767.9 10792.4 4263.1 4335.2 4426.4 4461.8 4477.9 9160.1 9168.0 9204.9 9208.4 9211.6 4671.6 4713.9 4726.8 4735.4 4738.0 3732.3 4097.8 4220.9 4323.8 4399.1 3725.2 3751.4 3774.3 3849.2 3863.6 1239.7 1249.9 1259.7 1265.2 1267.6 832.8 852.1 859.0 867.2 878.9 5172.8 5300.1 5322.3 5323.3 5331.1 409.9 410.1 411.2 412.4 430.9 3541.9 3645.1 3663.3 3666.8 3682.9 9271.1 9524.4 9642.3 9844.5 9876.6 9677.1 9733.7 9742.1 9747.5 9764.9 7179.4 7300.6 7325.7 7328.1 7371.7 5069.5 5309.1 5351.4 5519.0 5519.6 8843.3 8933.9 9046.9 9053.0 9062.5 8817.9 8831.8 8904.7 8960.5 9012.8 6000.6 6629.5 6759.8 6815.4 6846.7 7523.0 7561.8 7574.1 7599.1 7605.4 6706.8 6771.3 6941.1 7017.5 7048.6 6615.9 6631.2 6711.0 6729.7 6869.7 6205.6 6238.9 6291.1 6305.6 6327.5 4654.0 4656.3 4702.3 4708.7 4750.1 4614.2 4624.3 4638.6 4642.7 4743.3 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | [#4] prototype.html Cycles:180 Average:4201.88 Median:4561.94 stddev:1212.46 (26.6%) stddev-sans-first:1179.78 14:30:19 INFO - PROCESS | 6681 | Values: 290.3 306.1 310.9 311.1 313.3 4832.7 4913.7 4978.6 5051.6 5074.7 4956.8 4966.4 4982.4 4995.7 5004.5 3904.9 3937.1 3939.7 3946.3 3950.2 3847.7 3876.2 3949.9 3959.5 3962.9 3862.1 3881.7 3885.9 3892.4 3897.8 3907.9 3909.2 3944.9 3950.4 3952.5 3295.3 3418.7 3423.7 3488.5 3494.8 4863.1 4870.1 4879.5 4881.0 4881.0 4453.6 4462.8 4477.6 4479.3 4525.6 5022.6 5309.8 5315.6 5334.8 5336.4 3755.2 3758.6 3762.1 3769.4 3777.5 5454.9 5465.8 5543.9 5546.4 5560.2 3698.5 3827.8 3829.2 3851.4 3882.5 3868.4 3881.4 3887.2 3888.8 3890.4 4428.7 4431.7 4444.2 4448.6 4458.2 5266.9 5269.0 5279.3 5283.4 5336.8 1248.8 1308.7 1344.9 1349.0 1357.7 849.4 857.8 865.4 869.8 884.8 4217.7 4220.5 4236.5 4241.0 4246.9 4795.7 4814.3 4826.6 4832.4 4834.7 4199.6 4213.8 4216.6 4220.8 4224.2 2431.6 2591.3 2595.5 2601.4 2611.8 4553.5 4559.4 4560.2 4579.9 4615.2 4892.9 4931.8 4935.7 4938.3 4968.6 4332.5 4528.3 4539.0 4563.7 4571.3 4784.7 4801.9 4848.7 4861.4 4864.7 4588.9 4704.7 4705.1 4712.9 4746.5 4316.0 4489.4 4504.6 4539.3 4543.2 3490.5 3511.8 3517.2 3534.0 3553.9 4807.0 4829.8 4835.7 4869.9 5123.0 5003.1 5163.5 5170.8 5217.0 5219.6 5202.8 5261.0 5272.9 5309.0 5322.1 5033.4 5138.0 5191.5 5207.6 5208.6 5297.2 5299.2 5322.3 5324.7 5331.5 5200.8 5211.9 5240.3 5255.8 5262.2 14:30:19 INFO - PROCESS | 6681 | 14:30:19 INFO - PROCESS | 6681 | [#5] yui.html Cycles:180 Average:16205.31 Median:61684.69 stddev:22787.14 (36.9%) stddev-sans-first:22820.96 14:30:19 INFO - PROCESS | 6681 | Values: 606.1 637.8 659.6 735.7 736.5 12566.7 13627.8 13658.4 13719.9 13747.4 11575.9 11580.9 12228.2 12617.9 13011.3 627.3 780.4 786.4 793.3 796.9 789.6 796.7 797.5 797.9 799.1 833.1 837.9 838.6 846.1 848.3 831.7 832.1 833.1 833.2 835.1 606.6 607.7 608.3 609.4 610.8 13934.9 13971.1 14112.2 14114.8 14155.2 13425.0 13972.5 13981.9 14031.0 14262.1 10065.3 10198.5 10426.7 10494.5 10569.6 4223.6 4239.6 4260.3 4334.5 4424.0 56497.0 56944.1 57044.0 57163.0 57600.1 9431.6 9855.5 9864.4 9873.6 9905.9 16872.2 16872.7 16950.4 16985.4 17016.7 6731.2 6735.3 6750.2 6773.8 6973.2 3949.2 3962.3 3986.2 4009.7 4025.8 2787.9 2829.9 2844.5 2854.1 2864.5 515.1 524.9 531.0 531.3 535.7 530.9 534.3 551.5 553.2 561.2 7306.9 7482.9 7590.2 7591.6 7650.6 494.7 564.5 570.5 575.2 575.4 3574.3 3633.1 3641.7 3646.6 3716.5 54028.5 54205.7 88531.6 90006.1 92725.5 73975.0 77022.6 79216.0 79479.6 81647.0 68405.3 70734.3 71461.6 71581.0 72223.3 7053.2 7061.0 7132.5 7177.2 7283.9 39648.0 43698.2 43996.8 44347.1 45157.8 54579.5 61288.1 61520.0 61849.4 62164.4 9432.4 9452.2 9571.0 9726.5 9799.8 10148.5 10194.7 10226.5 10265.6 10444.3 8798.3 9022.6 9392.6 9484.9 9529.9 9053.9 9118.4 9319.9 9418.2 9843.0 9067.3 9324.3 9429.8 9455.9 9570.1 8313.2 8419.4 8743.7 8759.1 8831.0 8003.5 8029.5 8111.0 8155.8 8275.3 14:30:19 INFO - PROCESS | 6681 | -------- Summary: end -------- 14:30:19 INFO - PROCESS | 6681 | 14:30:20 INFO - TEST-INFO | 6681: exit 0 14:30:20 INFO - TEST-OK | dromaeo_css | took 1116640ms 14:30:20 INFO - TEST-START | kraken 14:30:20 INFO - operating with platform_type : linux_ 14:30:20 INFO - Initialising browser for kraken test... 14:30:20 INFO - TEST-INFO | started process 6920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1fyIe/profile http://localhost:46297/getInfo.html) 14:30:25 INFO - PROCESS | 6920 | __metrics Screen width/height:1600/1200 14:30:25 INFO - PROCESS | 6920 | colorDepth:24 14:30:25 INFO - PROCESS | 6920 | Browser inner width/height: 1024/697 14:30:25 INFO - PROCESS | 6920 | __metrics 14:30:25 ERROR - PROCESS | 6920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:30:26 INFO - TEST-INFO | 6920: exit 0 14:30:26 INFO - Browser initialized. 14:30:26 INFO - Running cycle 1/1 for kraken test... 14:30:26 INFO - TEST-INFO | started process 7037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1fyIe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:38 INFO - PROCESS | 7037 | RSS: Main: 186392576 14:30:38 INFO - PROCESS | 7037 | 14:30:41 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46297/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:42 INFO - PROCESS | 7037 | RSS: Main: 190935040 14:30:42 INFO - PROCESS | 7037 | 14:30:45 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46297/tests/kraken/driver.html?testName=audio-dft) 14:30:45 INFO - PROCESS | 7037 | RSS: Main: 190468096 14:30:45 INFO - PROCESS | 7037 | 14:30:48 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46297/tests/kraken/driver.html?testName=audio-fft) 14:30:49 INFO - PROCESS | 7037 | RSS: Main: 186138624 14:30:49 INFO - PROCESS | 7037 | 14:30:51 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46297/tests/kraken/driver.html?testName=audio-oscillator) 14:30:52 INFO - PROCESS | 7037 | RSS: Main: 186781696 14:30:52 INFO - PROCESS | 7037 | 14:30:54 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:54 INFO - PROCESS | 7037 | RSS: Main: 187473920 14:30:54 INFO - PROCESS | 7037 | 14:30:58 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46297/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:58 INFO - PROCESS | 7037 | RSS: Main: 187187200 14:30:58 INFO - PROCESS | 7037 | 14:31:02 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46297/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:02 INFO - PROCESS | 7037 | RSS: Main: 184516608 14:31:02 INFO - PROCESS | 7037 | 14:31:05 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46297/tests/kraken/driver.html?testName=json-parse-financial) 14:31:06 INFO - PROCESS | 7037 | RSS: Main: 186114048 14:31:06 INFO - PROCESS | 7037 | 14:31:08 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:08 INFO - PROCESS | 7037 | RSS: Main: 186576896 14:31:08 INFO - PROCESS | 7037 | 14:31:10 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:11 INFO - PROCESS | 7037 | RSS: Main: 186699776 14:31:11 INFO - PROCESS | 7037 | 14:31:13 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:14 INFO - PROCESS | 7037 | RSS: Main: 186933248 14:31:14 INFO - PROCESS | 7037 | 14:31:17 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:17 INFO - PROCESS | 7037 | RSS: Main: 187318272 14:31:17 INFO - PROCESS | 7037 | 14:31:20 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:21 INFO - PROCESS | 7037 | RSS: Main: 186929152 14:31:21 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | Cycle 1(1): loaded http://localhost:46297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46297/tests/kraken/driver.html?testName=ai-astar) 14:31:23 INFO - PROCESS | 7037 | RSS: Main: 187527168 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | __start_tp_report 14:31:23 INFO - PROCESS | 7037 | _x_x_mozilla_page_load 14:31:23 INFO - PROCESS | 7037 | _x_x_mozilla_page_load_details 14:31:23 INFO - PROCESS | 7037 | |i|pagename|runs| 14:31:23 INFO - PROCESS | 7037 | |0;ai-astar;114;108;115;118;113;114;114;113;113;113 14:31:23 INFO - PROCESS | 7037 | |1;audio-beat-detection;161;139;162;194;133;159;160;145;196;131 14:31:23 INFO - PROCESS | 7037 | |2;audio-dft;170;165;176;163;162;163;163;162;161;161 14:31:23 INFO - PROCESS | 7037 | |3;audio-fft;76;75;74;165;77;77;77;76;155;76 14:31:23 INFO - PROCESS | 7037 | |4;audio-oscillator;87;87;142;86;87;87;132;87;87;135 14:31:23 INFO - PROCESS | 7037 | |5;imaging-gaussian-blur;118;118;119;118;117;118;118;118;117;118 14:31:23 INFO - PROCESS | 7037 | |6;imaging-darkroom;149;150;149;150;148;147;149;147;148;147 14:31:23 INFO - PROCESS | 7037 | |7;imaging-desaturate;96;95;96;95;96;97;96;96;95;96 14:31:23 INFO - PROCESS | 7037 | |8;json-parse-financial;63;62;65;64;65;65;65;64;65;64 14:31:23 INFO - PROCESS | 7037 | |9;json-stringify-tinderbox;65;65;66;66;66;65;65;69;65;65 14:31:23 INFO - PROCESS | 7037 | |10;stanford-crypto-aes;84;83;84;86;85;84;85;90;111;87 14:31:23 INFO - PROCESS | 7037 | |11;stanford-crypto-ccm;151;136;137;140;139;133;132;136;142;138 14:31:23 INFO - PROCESS | 7037 | |12;stanford-crypto-pbkdf2;170;171;173;171;173;174;169;174;179;168 14:31:23 INFO - PROCESS | 7037 | |13;stanford-crypto-sha256-iterative;69;70;68;71;73;69;67;67;69;67 14:31:23 INFO - PROCESS | 7037 | __end_tp_report 14:31:23 INFO - PROCESS | 7037 | __start_cc_report 14:31:23 INFO - PROCESS | 7037 | _x_x_mozilla_cycle_collect,990 14:31:23 INFO - PROCESS | 7037 | __end_cc_report 14:31:23 INFO - PROCESS | 7037 | __startTimestamp1465594283337__endTimestamp 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | ------- Summary: start ------- 14:31:23 INFO - PROCESS | 7037 | Number of tests: 14 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.46 (2.2%) stddev-sans-first:2.60 14:31:23 INFO - PROCESS | 7037 | Values: 114.0 108.0 115.0 118.0 113.0 114.0 114.0 113.0 113.0 113.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#1] audio-beat-detection Cycles:10 Average:158.00 Median:160.50 stddev:22.74 (14.2%) stddev-sans-first:24.09 14:31:23 INFO - PROCESS | 7037 | Values: 161.0 139.0 162.0 194.0 133.0 159.0 160.0 145.0 196.0 131.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.00 stddev:4.79 (2.9%) stddev-sans-first:4.66 14:31:23 INFO - PROCESS | 7037 | Values: 170.0 165.0 176.0 163.0 162.0 163.0 163.0 162.0 161.0 161.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:35.51 (46.7%) stddev-sans-first:37.14 14:31:23 INFO - PROCESS | 7037 | Values: 76.0 75.0 74.0 165.0 77.0 77.0 77.0 76.0 155.0 76.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:87.00 stddev:24.02 (27.6%) stddev-sans-first:24.88 14:31:23 INFO - PROCESS | 7037 | Values: 87.0 87.0 142.0 86.0 87.0 87.0 132.0 87.0 87.0 135.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:31:23 INFO - PROCESS | 7037 | Values: 118.0 118.0 119.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:1.17 (0.8%) stddev-sans-first:1.22 14:31:23 INFO - PROCESS | 7037 | Values: 149.0 150.0 149.0 150.0 148.0 147.0 149.0 147.0 148.0 147.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:31:23 INFO - PROCESS | 7037 | Values: 96.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 95.0 96.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 14:31:23 INFO - PROCESS | 7037 | Values: 63.0 62.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 14:31:23 INFO - PROCESS | 7037 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 65.0 69.0 65.0 65.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:85.00 stddev:8.36 (9.8%) stddev-sans-first:8.75 14:31:23 INFO - PROCESS | 7037 | Values: 84.0 83.0 84.0 86.0 85.0 84.0 85.0 90.0 111.0 87.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:138.50 stddev:5.36 (3.9%) stddev-sans-first:3.20 14:31:23 INFO - PROCESS | 7037 | Values: 151.0 136.0 137.0 140.0 139.0 133.0 132.0 136.0 142.0 138.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:3.16 (1.8%) stddev-sans-first:3.24 14:31:23 INFO - PROCESS | 7037 | Values: 170.0 171.0 173.0 171.0 173.0 174.0 169.0 174.0 179.0 168.0 14:31:23 INFO - PROCESS | 7037 | 14:31:23 INFO - PROCESS | 7037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.94 (2.8%) stddev-sans-first:2.06 14:31:23 INFO - PROCESS | 7037 | Values: 69.0 70.0 68.0 71.0 73.0 69.0 67.0 67.0 69.0 67.0 14:31:23 INFO - PROCESS | 7037 | -------- Summary: end -------- 14:31:23 INFO - PROCESS | 7037 | 14:31:24 INFO - TEST-INFO | 7037: exit 0 14:31:24 INFO - TEST-OK | kraken | took 64293ms 14:31:24 INFO - SUITE-END | took 1180s 14:31:24 INFO - Completed test suite (00:19:41) 14:31:24 INFO - javascript benchmark 14:31:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6329.098269451289, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.572555528338, 2591.663083799107, 2601.9609705854405, 2608.921732348029, 2628.39546904212, 4668.836590719326, 4750.0, 4794.448638406584, 4837.733924634153, 4844.103840789457, 4694.17851875922, 4697.953020469794, 4736.834210802623, 4740.644451666121, 4829.034193161364, 4400.075984043347, 4417.646588272946, 4433.401490798749, 4480.887977800565, 4482.03636218213, 4185.476815398075, 4434.113177364524, 4436.689431739779, 4524.095180963804, 4524.773761311938, 4309.159713855799, 4343.500497442803, 4371.0820727646915, 4383.211022016036, 4436.268015777409, 4345.50026746925, 4356.765712802805, 4423.4912985006495, 4437.977810110961, 4454.242778727624, 4396.098799746044, 4410.735355878657, 4430.689851710382, 4448.1770872388715, 4461.732296062214, 4739.549742774431, 4802.0, 4818.301346304801, 4819.4939531349055, 4824.035192961422, 5183.61122915779, 5189.0, 5194.792208311663, 5199.376074871002, 5261.5790736741355, 4973.303737476756, 5087.23691446286, 5207.427183009866, 5228.764705588258, 5229.529342359206, 4792.880177995543, 4802.991371811959, 4814.735189564538, 4815.036992601494, 4856.805727770849, 5263.00065725272, 5264.78940842362, 5271.551918086929, 5271.551918086929, 5299.072662284085, 5028.698278103326, 5047.470015648304, 5072.847814565569, 5103.18349064148, 5126.948730512721, 4998.375203099613, 5251.0, 5253.527182553588, 5257.737113144404, 5268.315119034578, 5045.495450454925, 5050.621203409759, 5103.795848166106, 5108.361454818148, 5120.18077107661, 4975.0, 4975.651704380659, 4992.301077849104, 5053.36832895888, 5069.493050694901, 4251.681123915719, 4255.404243405926, 4260.936085958713, 4265.957340426618, 4310.0, 3755.080005398695, 3759.9096262084236, 3768.7550309229814, 3795.4876091727265, 3816.0459885028745, 4405.977970110129, 4460.397846290774, 4466.888327791767, 4505.0, 4521.773911304422, 5106.514881086291, 5123.333966584395, 5163.561097306696, 5205.401378841406, 5207.817726379559, 4406.294992801137, 4498.167838949805, 4503.482099558527, 4506.098780243899, 4554.772261386917, 4577.542245775462, 4593.058423023273, 4615.053913947632, 4628.097520983443, 4650.604698600657, 4888.9755551222015, 4929.802807887788, 4942.209246520683, 4949.6287778416045, 4997.150484417585, 5046.268291097844, 5131.640785145004, 5258.8948221036135, 5273.558354458118, 5326.866828329168, 4780.211265141213, 4810.230363141881, 4826.975865120652, 4896.167651499182, 4934.333864928332, 5077.543021128116, 5078.136716758234, 5079.187330027178, 5093.083245015932, 5130.640855140105, 5147.9227811582105, 5196.064708352533, 5244.580433565382, 5258.290130832289, 5269.710165940756, 4789.0, 4792.305115758126, 4806.639502037291, 4848.151573474698, 5129.563987061141, 4861.319415281792, 4868.318435419115, 4868.513148685103, 4999.475055119306, 5048.7475626219275, 4909.4354149273295, 4926.827561035347, 4964.751762411937, 4974.527419895104, 5010.799568017239, 4872.951270487391, 4958.082754690394, 5019.121653710513, 5068.062408454301, 5078.390593128848, 4852.684575502581, 4912.656114072123, 4915.508449155056, 4920.458749537476, 4961.776720047535], "value": 4710.6304407010175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.5111337344712, 586.6831910768185, 591.4026832898771, 609.3236507476698, 610.1366566308674, 34559.48160777587, 40000.599994000055, 40046.59953400465, 40068.0, 40080.398794018074, 38005.0, 38848.0, 38882.611173888254, 39052.41421378682, 39053.609463905355, 7801.102873169587, 7924.207579242087, 7936.404769642271, 7949.0, 7951.125376208613, 7833.882491762628, 7896.960515197416, 7900.446968712193, 7944.126146123922, 7953.562554059525, 7892.171322011192, 7947.165547617504, 7994.280514753671, 7999.280064794168, 8014.358851291882, 7881.684732610689, 7892.526448413085, 7925.0093738283, 7929.365650747926, 7956.124826269106, 7883.132855385903, 7910.683572657087, 7912.723054693058, 7945.841083178362, 7960.522368657841, 38119.0, 38406.23187536262, 38707.8064609678, 38733.61266387328, 38751.418728719094, 2933.6919623439658, 2951.050276598622, 2971.390864872696, 3290.7367410607094, 3812.0850995760816, 29405.0, 29902.70097299021, 29940.251493712833, 30162.547561786592, 30290.091297260897, 3369.663033696611, 3369.915752106217, 3416.062465142214, 3437.329720704464, 3467.861285548575, 244853.0, 245029.0, 245726.0, 245864.0, 246443.0, 51692.74153629208, 52350.47649523532, 52485.737571311896, 52516.73741631344, 52581.0, 33270.16824579405, 34582.308353832785, 34620.82689586536, 56892.0, 57105.71447142821, 14986.175760333286, 15092.39630414771, 15155.393784248507, 15160.545183644508, 15181.316840742193, 11059.834102488468, 11117.499712512956, 11135.888641113484, 11262.211645184922, 11275.943620281847, 18300.725489117674, 18417.907910460362, 18466.630667386577, 18498.630027399646, 18551.44345669632, 6918.135233095863, 6935.861282774417, 6943.652817359213, 6958.190870373739, 7063.964680176567, 767.2251026463313, 840.6133178737849, 848.8429640516524, 853.9103394143525, 935.1163150822543, 28237.294067648472, 28418.147455576367, 28823.0, 28959.565606515498, 29092.0, 901.3465237702744, 942.4675058591873, 963.5375019990304, 994.5325696922434, 1048.2609760119099, 14383.137011779327, 14677.192754398397, 14855.182964936816, 14871.256437178314, 15056.0, 188763.0, 192950.0, 193008.0, 193729.0, 376958.0, 49507.0, 49851.0, 49893.75053124711, 49916.0, 50151.0, 1161.7502237019082, 1189.1141099880645, 1198.766240583078, 1200.1658847101355, 1210.2617403383929, 26003.609945851207, 27139.86430067916, 27415.862920685267, 27692.307692307855, 27799.58300625533, 42061.0, 42327.57672423236, 42469.787651061546, 42567.148657027305, 42611.7869410651, 244429.0, 249909.0, 326877.0, 327330.0, 328399.0, 25461.745382545938, 26003.609945851207, 26205.868970655025, 26243.0, 26266.343341416617, 43364.56635433605, 43540.56459435365, 43639.0, 43832.0, 43988.78005609952, 35790.9927842747, 36984.26031479409, 37084.25831483409, 37413.438798417505, 37475.625243747214, 36588.451173232956, 36754.8162259187, 36847.815760921025, 36923.26153476969, 36995.63004369922, 35639.41508476107, 35988.82005589955, 36186.27627447489, 36620.26759464849, 36784.81607591945, 32154.83922580372, 32671.509927351584, 33000.0, 33159.668403315656, 33485.83257083699, 25025.374365641004, 25155.87422062878, 25191.11831085903, 25264.0, 25524.744752552237], "value": 17224.035228730358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.11581299535635, 368.37560335231774, 373.0766353275643, 380.9333366660834, 397.9323515002451, 15578.766318505217, 15977.360905563777, 17014.87314085739, 17054.317827286908, 17085.48743537696, 15839.524814255561, 16273.430429934955, 16880.0, 16929.83070169298, 16968.74546881798, 5086.135356989321, 5242.292290540767, 5253.6322457428, 5279.0, 5305.602079844027, 5118.795248190087, 5123.5388815006645, 5145.945081258352, 5200.167973124301, 5219.843404697846, 5180.8704782380555, 5216.191490319006, 5223.0, 5241.2400201970695, 5244.423113457517, 5010.72441015744, 5080.339555857715, 5144.125498665236, 5162.561182299491, 5191.4548972357925, 4469.3296005599095, 4534.38785763921, 4541.8410355637725, 4544.341070544786, 4545.681802273843, 19608.80391196084, 19956.800431995784, 20699.17203311866, 20718.378448646567, 20739.481512962146, 1749.361483058687, 1864.6177533605578, 2024.433158715562, 2075.9481012974647, 2311.5261371418987, 8632.611532481053, 9003.054679258714, 9293.907060929372, 9294.349395542315, 9383.624655013791, 1663.5674724571697, 1730.0225372664404, 1790.1049475262369, 1825.3246298869371, 1836.4307064809952, 47549.76225118887, 60329.39670603326, 60771.0, 64095.67952160256, 68212.31787682159, 9651.276154288456, 9807.656732014346, 9945.01099780047, 10133.442660653734, 10173.338732982333, 13866.306684665726, 13897.444102235999, 13983.091099078527, 14023.719525609431, 14042.85957140436, 7194.2014496375905, 7215.422766178693, 7257.987935006913, 7294.124705035323, 7369.115706115301, 6855.862882742417, 6893.896591551131, 6960.37356637905, 7012.824679382954, 7021.859562808818, 4326.13799367655, 4344.804483798237, 4356.411884395629, 4364.759938203366, 4375.956240437555, 1737.6177241006958, 1781.768370111903, 1798.5683435975272, 1801.2974939773499, 1810.8822926509736, 876.3996662286354, 887.0685779931047, 895.6462197432108, 895.892492900856, 933.3979583168954, 16060.919695401448, 16574.6685066298, 16669.0, 16690.248938797784, 17063.317467301167, 822.2280984478458, 835.8453686068096, 839.995800020996, 861.9439736417113, 912.0924679943498, 9242.76893077665, 9246.26029917605, 9246.676366327147, 9471.47906865129, 9471.573779179953, 404790.0, 412286.0, 414114.0, 414670.0, 416833.0, 61224.693876530335, 79882.60058699785, 84752.57623711965, 88407.55796220977, 88430.55784721035, 912.7444315591645, 914.8673442350822, 931.189864817613, 940.7977284883783, 957.5260246178186, 15443.382264709286, 15483.0, 15586.0, 15595.220238987778, 15953.840461595235, 34655.65344346524, 36359.636403635624, 36818.0, 37405.43891841679, 37754.8112259437, 49734.25398619096, 50884.0, 50977.0, 52210.47789522208, 52418.0, 6594.868102638016, 7087.362137407658, 7196.136463624399, 7205.891911621225, 7597.6581053851605, 11806.409679515818, 11946.98450631706, 12057.57798477049, 12260.570880019157, 12262.632121036384, 9836.311458197857, 10086.495675216063, 10124.69625911224, 10263.332883362558, 10269.845952310572, 10641.733956651145, 10868.130549556176, 10946.39794811293, 11026.50380732885, 11148.721281968015, 10510.369377837354, 10808.243422960632, 10898.182636302468, 10995.285306455055, 11015.284006539548, 7794.103678077094, 7830.647620856961, 7971.282584567417, 7979.321757650432, 8004.359651228005, 9140.862887056832, 10345.534450949575, 10476.580936762444, 10531.526081326512, 10556.524956377136], "value": 8159.205258414105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.2168742129566, 1371.4856928651755, 1451.8838492920568, 1646.3908353909042, 1667.2414051606513, 6750.966245168767, 7402.296781805733, 7507.62461876906, 7998.7600371988865, 8001.279884810366, 7460.0, 7551.848963020736, 7613.162552119263, 7710.807229819257, 7740.767776966686, 2204.6803213534026, 2233.4528040630066, 2234.3520379090046, 2234.497238121426, 2237.0157130862367, 2132.8507004509693, 2199.0544066051593, 2204.217502786512, 2207.1612787140866, 2209.149477451185, 2140.9357719268446, 2166.306781829815, 2175.651895696689, 2183.1158380855777, 2188.9233876814314, 2106.241752968938, 2167.219800871685, 2201.933941981735, 2218.0905828610353, 2218.7559368469456, 2165.1339464214284, 2198.1427243375097, 2203.5262418580082, 2218.7559368469456, 2225.2100504321056, 7710.884336734954, 7805.765827025199, 7829.686812527549, 7846.843063138763, 7874.936883520709, 4631.374764406795, 4745.715257084586, 4755.35802666639, 4762.119007983534, 4768.3085952536685, 2832.660080790298, 2910.8544572771275, 2934.8092373995837, 2978.851057447119, 3027.969720302791, 869.699953516036, 880.7842078690697, 893.5398269891011, 897.0131159481779, 912.1380295620642, 10719.571217151304, 10726.088282495997, 10734.141268698564, 10767.892321076768, 10792.406417647026, 4263.083437061046, 4335.154644844225, 4426.402435671143, 4461.754603496839, 4477.865664030084, 9160.129787670161, 9168.0, 9204.861927071099, 9208.447493150432, 9211.585478653476, 4671.556202160789, 4713.858584242478, 4726.787294571753, 4735.384400027974, 4737.95262047382, 3732.309522738302, 4097.774622395737, 4220.894477638084, 4323.7621930793475, 4399.054203346296, 3725.180460298784, 3751.362268414376, 3774.339490589136, 3849.230153969161, 3863.613638636114, 1239.659093749208, 1249.94375253112, 1259.71026663866, 1265.1649911058657, 1267.5880338889897, 832.8167803083312, 852.0882655558493, 858.9828203435897, 867.2368315881984, 878.8813510176172, 5172.818951336685, 5300.09898317287, 5322.2548843161985, 5323.334583177103, 5331.1470164773455, 409.93031184698674, 410.14484799194014, 411.1653343712269, 412.4267268496792, 430.8987387963826, 3541.8760343387858, 3645.0887278180453, 3663.2673465307043, 3666.7799932004164, 3682.9447558286647, 9271.119243671841, 9524.380915240487, 9642.276829237695, 9844.50777461124, 9876.555555000043, 9677.129058384779, 9733.707988760349, 9742.074502922353, 9747.463889486145, 9764.902350976541, 7179.389751871045, 7300.6349682515665, 7325.706971721072, 7328.120625524971, 7371.668274927534, 5069.543741063322, 5309.123994540858, 5351.438098999549, 5519.0, 5519.558435325244, 8843.336749743923, 8933.865992010255, 9046.909530904606, 9053.049429810038, 9062.50156241413, 8817.911820881965, 8831.779205519913, 8904.732858014011, 8960.462372257685, 9012.81974360496, 6000.5799594028, 6629.5359324846795, 6759.797206083826, 6815.42068924147, 6846.657667116525, 7523.0, 7561.7731468056045, 7574.091109066947, 7599.050118735158, 7605.391568674603, 6706.798796036127, 6771.28901465339, 6941.097657304518, 7017.473689473412, 7048.577085374894, 6615.867682646416, 6631.237407698177, 6711.026901099216, 6729.730810767514, 6869.690863911036, 6205.565610407409, 6238.875222495615, 6291.056341548804, 6305.558610897193, 6327.525435592441, 4653.953460465487, 4656.301554766812, 4702.27114797207, 4708.717476951394, 4750.12122757291, 4614.215583350771, 4624.28323609841, 4638.62890968715, 4642.698224615389, 4743.335932969456], "value": 4095.0051588770593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.31485693762716, 306.1443266071331, 310.92693217093984, 311.0528440897468, 313.28102005896466, 4832.685875418096, 4913.707815763438, 4978.55193032627, 5051.570616497597, 5074.7208903510245, 4956.752162391875, 4966.428860681022, 4982.352294201749, 4995.700257984524, 5004.474530174334, 3904.882853514392, 3937.1416012307814, 3939.704522160835, 3946.3291240489184, 3950.170464202521, 3847.6537111659945, 3876.2218203022258, 3949.9210015799667, 3959.5248570171475, 3962.8811135665833, 3862.1310205203745, 3881.7476864003893, 3885.941710874325, 3892.4355968384566, 3897.8051097445154, 3907.902302442433, 3909.198614284065, 3944.9013774655577, 3950.4271880577444, 3952.5454572724216, 3295.340931813647, 3418.7265018798435, 3423.6576342365815, 3488.4767284907466, 3494.755367124302, 4863.124637565237, 4870.099031679115, 4879.536444037811, 4881.0, 4881.0, 4453.55464453552, 4462.776861156929, 4477.6417886569, 4479.3281007848755, 4525.615322697542, 5022.59819214462, 5309.840704778863, 5315.601329900234, 5334.813281535166, 5336.38631557372, 3755.2301778135416, 3758.586555478895, 3762.1347090169143, 3769.41574056019, 3777.490038844776, 5454.91817622736, 5465.836024919259, 5543.861403464905, 5546.4453554644615, 5560.193771903092, 3698.4637227601847, 3827.827747751358, 3829.1767270037076, 3851.383778595411, 3882.456456096149, 3868.361720316116, 3881.3595756700392, 3887.231309754055, 3888.7666739995125, 3890.358090915024, 4428.734275943454, 4431.670498850332, 4444.222261104358, 4448.644108471314, 4458.242098843204, 5266.92099618506, 5268.9736551317, 5279.260903473517, 5283.392409872914, 5336.7865285388925, 1248.843894513186, 1308.685915380321, 1344.919304841693, 1348.9730205396033, 1357.7080927600614, 849.3799526345803, 857.8461968652152, 865.3639574912435, 869.8086420987372, 884.8451520983803, 4217.662586993033, 4220.451341325669, 4236.491621005499, 4240.957590424118, 4246.893827654333, 4795.664303498722, 4814.325994360793, 4826.638002149783, 4832.371791667131, 4834.709917404967, 4199.559046300155, 4213.831446742157, 4216.599423054805, 4220.8051813057655, 4224.162489317096, 2431.598786200257, 2591.287395966124, 2595.545779488582, 2601.388673661688, 2611.764941155305, 4553.453585569753, 4559.361689363492, 4560.224761790503, 4579.931301030487, 4615.215413379734, 4892.9235568174945, 4931.753412329369, 4935.728534930541, 4938.25926111079, 4968.6025117990475, 4332.4801023877335, 4528.298113792367, 4539.0, 4563.657725670521, 4571.26859702446, 4784.6889952153, 4801.855944321676, 4848.660593758403, 4861.440934292602, 4864.708117512961, 4588.944542755118, 4704.694194877322, 4705.106029854317, 4712.929306060343, 4746.477887432448, 4316.0, 4489.438820147481, 4504.594586487232, 4539.319102134574, 4543.227651299221, 3490.4938783876705, 3511.805985964784, 3517.1886478464126, 3533.9646603533633, 3553.9466907996916, 4806.951930480651, 4829.830955916526, 4835.694362522029, 4869.9026019480125, 5123.001014802227, 5003.099442100457, 5163.509466600667, 5170.802408976246, 5216.956608678203, 5219.582433405394, 5202.843914682566, 5260.973695131653, 5272.920906186487, 5308.973455132699, 5322.148456246982, 5033.445397347113, 5137.974310128426, 5191.546367017241, 5207.583393328448, 5208.583313335, 5297.152455607084, 5299.178627312773, 5322.308099946982, 5324.733763311897, 5331.466853314792, 5200.791968321225, 5211.9478805212975, 5240.266362709148, 5255.816046438356, 5262.210668399771], "value": 3819.220177698716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1059936593525, 637.837351475374, 659.5844617890729, 735.7314580178235, 736.5212611802327, 12566.748665026706, 13627.795583066261, 13658.38537265823, 13719.93140034301, 13747.381367838447, 11575.942120289386, 11580.884191158086, 12228.20516666416, 12617.936910315459, 13011.284379359131, 627.3444250757968, 780.449782903052, 786.394476253286, 793.2979313307735, 796.9362451003934, 789.569684521934, 796.7211475983388, 797.5254723439544, 797.9441439099265, 799.1169757418028, 833.1044127562864, 837.857564214082, 838.5890913452395, 846.0904527632789, 848.2704873808519, 831.6881169561415, 832.0556168748484, 833.0544831616098, 833.2126140796919, 835.1314632781899, 606.5814587934311, 607.7417097733489, 608.3399511529996, 609.3662590905453, 610.8320211941707, 13934.93032534841, 13971.09187902783, 14112.223827689473, 14114.788278175836, 14155.221462819542, 13425.0, 13972.51096211638, 13981.930090349584, 14031.0, 14262.144271343752, 10065.295429319951, 10198.541065652063, 10426.739331516697, 10494.52774625136, 10569.577216911315, 4223.598758118004, 4239.6396306314, 4260.254455470311, 4334.4798624165305, 4423.955760442419, 56497.0, 56944.145837812466, 57044.0, 57163.0, 57600.13599796007, 9431.575579098957, 9855.507224638739, 9864.358816676893, 9873.555689993967, 9905.851412228822, 16872.240749166318, 16872.746908796376, 16950.406735764434, 16985.405510807308, 17016.659666806594, 6731.225909020427, 6735.326467353323, 6750.223724271674, 6773.830654233585, 6973.232944376216, 3949.2101579683604, 3962.306596345628, 3986.22268657609, 4009.67922566194, 4025.818838152232, 2787.8606069696434, 2829.915102546927, 2844.459552684983, 2854.072426461408, 2864.4557534068877, 515.062586093314, 524.8792777661159, 530.9681419114788, 531.2509361799844, 535.6785928442903, 530.8938212357544, 534.3267482971484, 551.4623242338768, 553.1923391847866, 561.1862798941551, 7306.9404936285, 7482.8877566836545, 7590.203028681909, 7591.620418979029, 7650.617469126521, 494.70070607282076, 564.4834975996916, 570.5492660797923, 575.1602660116278, 575.3785911215876, 3574.303010912847, 3633.1462106404974, 3641.690456311243, 3646.6353364663323, 3716.479692843004, 54028.45971540234, 54205.72877666953, 88531.55734221288, 90006.09993900108, 92725.5363723177, 73975.0, 77022.61488692633, 79216.0, 79479.60260198778, 81647.0, 68405.3159468399, 70734.2926570738, 71461.64269178621, 71581.0, 72223.27776722271, 7053.188883278489, 7060.964695176492, 7132.536385134949, 7177.174624917992, 7283.927160728324, 39648.0, 43698.159619624625, 43996.780016099714, 44347.11305773802, 45157.77421112874, 54579.454205457434, 61288.08067879074, 61520.0, 61849.38150618436, 62164.37835621586, 9432.434053956784, 9452.196563291922, 9570.95214523923, 9726.46504442234, 9799.804003920024, 10148.54331555067, 10194.694159175237, 10226.488675566341, 10265.640702575374, 10444.268901176845, 8798.296136308953, 9022.639094436148, 9392.624295028123, 9484.905150948678, 9529.904700952902, 9053.868736726008, 9118.361714679908, 9319.86020209684, 9418.199453046567, 9842.950785246028, 9067.319951003568, 9324.347295689236, 9429.764255893657, 9455.858162127435, 9570.138687518156, 8313.168683131638, 8419.410641255054, 8743.650253989768, 8759.12408759119, 8831.02858685557, 8003.541213860294, 8029.478083924526, 8111.0, 8155.79610509742, 8275.255227029356], "value": 6207.424483661078, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 115.0, 118.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 139.0, 162.0, 194.0, 133.0, 159.0, 160.0, 145.0, 196.0, 131.0], "value": 158.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 176.0, 163.0, 162.0, 163.0, 163.0, 162.0, 161.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 165.0, 77.0, 77.0, 77.0, 76.0, 155.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 142.0, 86.0, 87.0, 87.0, 132.0, 87.0, 87.0, 135.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 148.0, 147.0, 149.0, 147.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 69.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 86.0, 85.0, 84.0, 85.0, 90.0, 111.0, 87.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 136.0, 137.0, 140.0, 139.0, 133.0, 132.0, 136.0, 142.0, 138.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 173.0, 171.0, 173.0, 174.0, 169.0, 174.0, 179.0, 168.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 71.0, 73.0, 69.0, 67.0, 67.0, 69.0, 67.0], "value": 69.0, "unit": "score"}]}]} 14:31:24 INFO - Return code: 0 14:31:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:24 ERROR - # TBPL SUCCESS # 14:31:24 INFO - Running post-action listener: _resource_record_post_action 14:31:24 INFO - ##### 14:31:24 INFO - ##### Finished run-tests step (success) 14:31:24 INFO - ##### 14:31:24 INFO - Running post-run listener: _resource_record_post_run 14:31:24 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 208896; Write bytes: 298115072; Read time: 328; Write time: 232052 14:31:24 INFO - TinderboxPrint: CPU usage
13.5% 14:31:24 INFO - TinderboxPrint: I/O read bytes / time
208,896 / 328 14:31:24 INFO - TinderboxPrint: I/O write bytes / time
298,115,072 / 232,052 14:31:24 INFO - TinderboxPrint: CPU idle
8,263.9 (86.5%) 14:31:24 INFO - TinderboxPrint: CPU user
1,237.6 (13.0%) 14:31:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1417216; Read time: 0; Write time: 80 14:31:24 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 208896; Write bytes: 296697856; Read time: 328; Write time: 231972 14:31:25 INFO - Running post-run listener: _upload_blobber_files 14:31:25 INFO - Blob upload gear active. 14:31:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:25 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 14:31:25 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'] 14:31:25 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 14:31:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:26 INFO - (blobuploader) - INFO - Done attempting. 14:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:27 INFO - (blobuploader) - INFO - Done attempting. 14:31:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:31 INFO - (blobuploader) - INFO - Done attempting. 14:31:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:31 INFO - Return code: 0 14:31:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/faeaeb0aa5e328a3c9aeb6f049fd19cde81f0afd355a56897a2bf2573c3cc38b6e30213e3ab3e24f5462cbaf909dc0d84882e8cc74bf12674741b66379910fdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c51ad3dd34c993e7e37982017a396909dadeacdbe34b2505d47227527bd14b5e7820e7404ff273e006fc5c21b897256df576b4661f234b43c155b53eb5f4369", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38b2f26e0f43228a1ac004b38a7f7227c0c05e416654cae7034b2a75bd72164b0328221c9d76641ca42683dcc2ab084fac29404e5cced460936e05fab079c591"} 14:31:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:31 INFO - Contents: 14:31:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/faeaeb0aa5e328a3c9aeb6f049fd19cde81f0afd355a56897a2bf2573c3cc38b6e30213e3ab3e24f5462cbaf909dc0d84882e8cc74bf12674741b66379910fdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c51ad3dd34c993e7e37982017a396909dadeacdbe34b2505d47227527bd14b5e7820e7404ff273e006fc5c21b897256df576b4661f234b43c155b53eb5f4369", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38b2f26e0f43228a1ac004b38a7f7227c0c05e416654cae7034b2a75bd72164b0328221c9d76641ca42683dcc2ab084fac29404e5cced460936e05fab079c591"} 14:31:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:31 INFO - Copying logs to upload dir... 14:31:31 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.392202 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-10 14:31:31.709805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 14:31:31.712973) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905 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/faeaeb0aa5e328a3c9aeb6f049fd19cde81f0afd355a56897a2bf2573c3cc38b6e30213e3ab3e24f5462cbaf909dc0d84882e8cc74bf12674741b66379910fdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c51ad3dd34c993e7e37982017a396909dadeacdbe34b2505d47227527bd14b5e7820e7404ff273e006fc5c21b897256df576b4661f234b43c155b53eb5f4369", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38b2f26e0f43228a1ac004b38a7f7227c0c05e416654cae7034b2a75bd72164b0328221c9d76641ca42683dcc2ab084fac29404e5cced460936e05fab079c591"} build_url:https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/OX1l6C9aSWKPLnYmOfQ6QQ/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/faeaeb0aa5e328a3c9aeb6f049fd19cde81f0afd355a56897a2bf2573c3cc38b6e30213e3ab3e24f5462cbaf909dc0d84882e8cc74bf12674741b66379910fdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c51ad3dd34c993e7e37982017a396909dadeacdbe34b2505d47227527bd14b5e7820e7404ff273e006fc5c21b897256df576b4661f234b43c155b53eb5f4369", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38b2f26e0f43228a1ac004b38a7f7227c0c05e416654cae7034b2a75bd72164b0328221c9d76641ca42683dcc2ab084fac29404e5cced460936e05fab079c591"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 14:31:31.739761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:31:31.740128) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465590381.205797-451300905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 14:31:31.825367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 14:31:31.825760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 14:31:31.826188) ========= ========= Total master_lag: 0.17 =========