builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1466111185.44 results: success (0) buildid: 20160616113008 builduid: 4fbfb26cc7f447cba948c1363e460f65 revision: 942a42c22de790ca091f1e329250ef11217636bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.435743) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.436301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.436613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.503527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.503842) ========= 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=6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 14:06:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-06-16 14:06:26 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091694 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.621313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.621623) ========= 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=6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020771 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:25.688899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 14:06:25.689217) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 942a42c22de790ca091f1e329250ef11217636bc --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 942a42c22de790ca091f1e329250ef11217636bc --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=6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 14:06:27,144 truncating revision to first 12 chars 2016-06-16 14:06:27,144 Setting DEBUG logging. 2016-06-16 14:06:27,144 attempt 1/10 2016-06-16 14:06:27,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/942a42c22de7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 14:06:28,142 unpacking tar archive at: fx-team-942a42c22de7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.321748 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 14:06:27.025216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:27.025545) ========= script_repo_revision: 942a42c22de790ca091f1e329250ef11217636bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:27.025944) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:27.026228) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 14:06:27.036846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-16 14:06:27.037256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:06:28 INFO - MultiFileLogger online at 20160616 14:06:28 in /builds/slave/test 14:06:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:06:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:06:28 INFO - {'append_to_log': False, 14:06:28 INFO - 'base_work_dir': '/builds/slave/test', 14:06:28 INFO - 'blob_upload_branch': 'Fx-Team', 14:06:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:06:28 INFO - 'branch': 'Fx-Team', 14:06:28 INFO - 'buildbot_json_path': 'buildprops.json', 14:06:28 INFO - 'config_files': ('talos/linux_config.py',), 14:06:28 INFO - 'default_actions': ('clobber', 14:06:28 INFO - 'read-buildbot-config', 14:06:28 INFO - 'download-and-extract', 14:06:28 INFO - 'populate-webroot', 14:06:28 INFO - 'create-virtualenv', 14:06:28 INFO - 'install', 14:06:28 INFO - 'run-tests'), 14:06:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:06:28 INFO - 'download_minidump_stackwalk': True, 14:06:28 INFO - 'download_symbols': 'ondemand', 14:06:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:06:28 INFO - 'tooltool.py': '/tools/tooltool.py', 14:06:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:06:28 INFO - '/tools/misc-python/virtualenv.py')}, 14:06:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:06:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:06:28 INFO - 'installer_path': 'installer.exe', 14:06:28 INFO - 'log_level': 'info', 14:06:28 INFO - 'log_name': 'talos', 14:06:28 INFO - 'log_to_console': True, 14:06:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:06:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:06:28 INFO - 'opt_config_files': (), 14:06:28 INFO - 'pip_index': False, 14:06:28 INFO - 'sps_profile': False, 14:06:28 INFO - 'sps_profile_interval': 0, 14:06:28 INFO - 'suite': 'dromaeojs-e10s', 14:06:28 INFO - 'system_bits': '32', 14:06:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:06:28 INFO - 'title': 'talos-linux64-ix-050', 14:06:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:06:28 INFO - 'use_talos_json': True, 14:06:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:06:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:06:28 INFO - 'work_dir': 'build'} 14:06:28 INFO - ##### 14:06:28 INFO - ##### Running clobber step. 14:06:28 INFO - ##### 14:06:28 INFO - Running pre-action listener: _resource_record_pre_action 14:06:28 INFO - Running main action method: clobber 14:06:28 INFO - rmtree: /builds/slave/test/build 14:06:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:06:29 INFO - Running post-action listener: _resource_record_post_action 14:06:29 INFO - ##### 14:06:29 INFO - ##### Finished clobber step (success) 14:06:29 INFO - ##### 14:06:29 INFO - ##### 14:06:29 INFO - ##### Running read-buildbot-config step. 14:06:29 INFO - ##### 14:06:29 INFO - Running pre-action listener: _resource_record_pre_action 14:06:29 INFO - Running main action method: read_buildbot_config 14:06:29 INFO - Using buildbot properties: 14:06:29 INFO - { 14:06:29 INFO - "project": "", 14:06:29 INFO - "product": "firefox", 14:06:29 INFO - "script_repo_revision": "production", 14:06:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:06:29 INFO - "repository": "", 14:06:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:06:29 INFO - "buildid": "20160616113008", 14:06:29 INFO - "pgo_build": "True", 14:06:29 INFO - "basedir": "/builds/slave/test", 14:06:29 INFO - "buildnumber": 483, 14:06:29 INFO - "slavename": "talos-linux64-ix-050", 14:06:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:06:29 INFO - "platform": "ubuntu64_hw", 14:06:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:06:29 INFO - "branch": "fx-team", 14:06:29 INFO - "repo_path": "integration/fx-team", 14:06:29 INFO - "revision": "942a42c22de790ca091f1e329250ef11217636bc", 14:06:29 INFO - "stage_platform": "linux64-pgo", 14:06:29 INFO - "builduid": "4fbfb26cc7f447cba948c1363e460f65", 14:06:29 INFO - "slavebuilddir": "test" 14:06:29 INFO - } 14:06:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:06:29 INFO - Running post-action listener: _resource_record_post_action 14:06:29 INFO - ##### 14:06:29 INFO - ##### Finished read-buildbot-config step (success) 14:06:29 INFO - ##### 14:06:29 INFO - ##### 14:06:29 INFO - ##### Running download-and-extract step. 14:06:29 INFO - ##### 14:06:29 INFO - Running pre-action listener: _resource_record_pre_action 14:06:29 INFO - Running main action method: download_and_extract 14:06:29 INFO - mkdir: /builds/slave/test/build/tests 14:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:29 INFO - https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:31 INFO - Downloaded 1361 bytes. 14:06:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:06:31 INFO - Using the following test package requirements: 14:06:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:06:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:06:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'jsshell-linux-x86_64.zip'], 14:06:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:06:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:06:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:06:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:06:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:06:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:31 INFO - https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:33 INFO - Downloaded 24220689 bytes. 14:06:33 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:06:33 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:06:34 INFO - Return code: 0 14:06:34 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:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:34 INFO - https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:42 INFO - Downloaded 24220689 bytes. 14:06:42 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:06:42 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:06:44 INFO - Return code: 0 14:06:44 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:06:44 INFO - https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:45 INFO - Downloaded 14405384 bytes. 14:06:45 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:06:45 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:06:45 INFO - Return code: 0 14:06:45 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:06:45 INFO - https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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:06:47 INFO - Downloaded 59414236 bytes. 14:06:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:06:47 INFO - mkdir: /builds/slave/test/properties 14:06:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:06:47 INFO - Writing to file /builds/slave/test/properties/build_url 14:06:47 INFO - Contents: 14:06:47 INFO - build_url:https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:06:48 INFO - Running post-action listener: _resource_record_post_action 14:06:48 INFO - Running post-action listener: set_extra_try_arguments 14:06:48 INFO - ##### 14:06:48 INFO - ##### Finished download-and-extract step (success) 14:06:48 INFO - ##### 14:06:48 INFO - ##### 14:06:48 INFO - ##### Running populate-webroot step. 14:06:48 INFO - ##### 14:06:48 INFO - Running pre-action listener: _resource_record_pre_action 14:06:48 INFO - Running main action method: populate_webroot 14:06:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:06:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:06:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:06:48 INFO - '--tppagecycles', 14:06:48 INFO - '7'], 14:06:48 INFO - 'tests': ['tsvgm']}}, 14:06:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:06:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:06:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:06:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:06:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['damp', 'tps']}, 14:06:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'tests': ['damp', 'tps']}, 14:06:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['dromaeo_dom']}, 14:06:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:06:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['basic_compositor_video']}, 14:06:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:06:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['a11yr', 14:06:48 INFO - 'ts_paint', 14:06:48 INFO - 'tpaint', 14:06:48 INFO - 'sessionrestore', 14:06:48 INFO - 'sessionrestore_no_auto_restore', 14:06:48 INFO - 'tabpaint']}, 14:06:48 INFO - 'other-e10s': {'tests': ['a11yr', 14:06:48 INFO - 'ts_paint', 14:06:48 INFO - 'tpaint', 14:06:48 INFO - 'sessionrestore', 14:06:48 INFO - 'sessionrestore_no_auto_restore', 14:06:48 INFO - 'tabpaint']}, 14:06:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:06:48 INFO - 'ts_paint', 14:06:48 INFO - 'tpaint', 14:06:48 INFO - 'sessionrestore', 14:06:48 INFO - 'sessionrestore_no_auto_restore', 14:06:48 INFO - 'tabpaint']}, 14:06:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:06:48 INFO - 'ts_paint', 14:06:48 INFO - 'tpaint', 14:06:48 INFO - 'sessionrestore', 14:06:48 INFO - 'sessionrestore_no_auto_restore', 14:06:48 INFO - 'tabpaint']}, 14:06:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['a11yr', 14:06:48 INFO - 'ts_paint', 14:06:48 INFO - 'tpaint', 14:06:48 INFO - 'sessionrestore', 14:06:48 INFO - 'sessionrestore_no_auto_restore', 14:06:48 INFO - 'tabpaint']}, 14:06:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['a11yr', 14:06:48 INFO - 'ts_paint', 14:06:48 INFO - 'tpaint', 14:06:48 INFO - 'sessionrestore', 14:06:48 INFO - 'sessionrestore_no_auto_restore', 14:06:48 INFO - 'tabpaint']}, 14:06:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['tsvgx', 14:06:48 INFO - 'tsvgr_opacity', 14:06:48 INFO - 'tart', 14:06:48 INFO - 'tscrollx', 14:06:48 INFO - 'cart']}, 14:06:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:06:48 INFO - 'tsvgr_opacity', 14:06:48 INFO - 'tart', 14:06:48 INFO - 'tscrollx', 14:06:48 INFO - 'cart']}, 14:06:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'talos_options': ['--disable-e10s'], 14:06:48 INFO - 'tests': ['tp5o']}, 14:06:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'tests': ['tp5o']}, 14:06:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'talos_options': ['--disable-e10s', 14:06:48 INFO - '--xperf_path', 14:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:48 INFO - 'tests': ['tp5n']}, 14:06:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:48 INFO - 'talos_options': ['--xperf_path', 14:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:48 INFO - 'tests': ['tp5n']}}, 14:06:48 INFO - 'talos.zip': {'path': '', 14:06:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:06:48 INFO - Running post-action listener: _resource_record_post_action 14:06:48 INFO - ##### 14:06:48 INFO - ##### Finished populate-webroot step (success) 14:06:48 INFO - ##### 14:06:48 INFO - ##### 14:06:48 INFO - ##### Running create-virtualenv step. 14:06:48 INFO - ##### 14:06:48 INFO - Running pre-action listener: _resource_record_pre_action 14:06:48 INFO - Running main action method: create_virtualenv 14:06:48 INFO - Creating virtualenv /builds/slave/test/build/venv 14:06:48 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:06:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:06:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:06:48 INFO - Using real prefix '/usr' 14:06:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:06:48 INFO - Installing distribute.............................................................................................................................................................................................done. 14:06:50 INFO - Installing pip.................done. 14:06:50 INFO - Return code: 0 14:06:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:06:50 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:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:50 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:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:50 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 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:06:50 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:06:50 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:06:50 INFO - Using env: {'DISPLAY': ':0', 14:06:50 INFO - 'HOME': '/home/cltbld', 14:06:50 INFO - 'LANG': 'en_US.UTF-8', 14:06:50 INFO - 'LANGUAGE': 'en_US:en', 14:06:50 INFO - 'LOGNAME': 'cltbld', 14:06:50 INFO - 'MAIL': '/var/mail/cltbld', 14:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:50 INFO - 'MOZ_NO_REMOTE': '1', 14:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:50 INFO - 'NO_EM_RESTART': '1', 14:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:50 INFO - 'PWD': '/builds/slave/test', 14:06:50 INFO - 'SHELL': '/bin/bash', 14:06:50 INFO - 'SHLVL': '1', 14:06:50 INFO - 'TERM': 'linux', 14:06:50 INFO - 'TMOUT': '86400', 14:06:50 INFO - 'USER': 'cltbld', 14:06:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:50 INFO - '_': '/tools/buildbot/bin/python'} 14:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:06:51 INFO - Cleaning up... 14:06:51 INFO - Return code: 0 14:06:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:06: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:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:06:51 INFO - Using env: {'DISPLAY': ':0', 14:06:51 INFO - 'HOME': '/home/cltbld', 14:06:51 INFO - 'LANG': 'en_US.UTF-8', 14:06:51 INFO - 'LANGUAGE': 'en_US:en', 14:06:51 INFO - 'LOGNAME': 'cltbld', 14:06:51 INFO - 'MAIL': '/var/mail/cltbld', 14:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:51 INFO - 'MOZ_NO_REMOTE': '1', 14:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:51 INFO - 'NO_EM_RESTART': '1', 14:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:51 INFO - 'PWD': '/builds/slave/test', 14:06:51 INFO - 'SHELL': '/bin/bash', 14:06:51 INFO - 'SHLVL': '1', 14:06:51 INFO - 'TERM': 'linux', 14:06:51 INFO - 'TMOUT': '86400', 14:06:51 INFO - 'USER': 'cltbld', 14:06:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:51 INFO - '_': '/tools/buildbot/bin/python'} 14:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:51 INFO - Downloading/unpacking psutil>=3.1.1 14:06:51 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:06:51 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:06:51 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:06:51 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:06:51 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:06:51 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:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:53 INFO - Installing collected packages: psutil 14:06:53 INFO - Running setup.py install for psutil 14:06:53 INFO - building 'psutil._psutil_linux' extension 14:06:53 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:06:53 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:06:53 INFO - building 'psutil._psutil_posix' extension 14:06:53 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:06:53 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:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:53 INFO - Successfully installed psutil 14:06:53 INFO - Cleaning up... 14:06:53 INFO - Return code: 0 14:06:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:06:53 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:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:53 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:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:53 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 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:06:53 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:06:53 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:06:53 INFO - Using env: {'DISPLAY': ':0', 14:06:53 INFO - 'HOME': '/home/cltbld', 14:06:53 INFO - 'LANG': 'en_US.UTF-8', 14:06:53 INFO - 'LANGUAGE': 'en_US:en', 14:06:53 INFO - 'LOGNAME': 'cltbld', 14:06:53 INFO - 'MAIL': '/var/mail/cltbld', 14:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:53 INFO - 'MOZ_NO_REMOTE': '1', 14:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:53 INFO - 'NO_EM_RESTART': '1', 14:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:53 INFO - 'PWD': '/builds/slave/test', 14:06:53 INFO - 'SHELL': '/bin/bash', 14:06:53 INFO - 'SHLVL': '1', 14:06:53 INFO - 'TERM': 'linux', 14:06:53 INFO - 'TMOUT': '86400', 14:06:53 INFO - 'USER': 'cltbld', 14:06:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:53 INFO - '_': '/tools/buildbot/bin/python'} 14:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:06:56 INFO - Installing collected packages: mozsystemmonitor 14:06:56 INFO - Running setup.py install for mozsystemmonitor 14:06:56 INFO - Successfully installed mozsystemmonitor 14:06:56 INFO - Cleaning up... 14:06:56 INFO - Return code: 0 14:06:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:06:56 INFO - Using env: {'DISPLAY': ':0', 14:06:56 INFO - 'HOME': '/home/cltbld', 14:06:56 INFO - 'LANG': 'en_US.UTF-8', 14:06:56 INFO - 'LANGUAGE': 'en_US:en', 14:06:56 INFO - 'LOGNAME': 'cltbld', 14:06:56 INFO - 'MAIL': '/var/mail/cltbld', 14:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:56 INFO - 'MOZ_NO_REMOTE': '1', 14:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:56 INFO - 'NO_EM_RESTART': '1', 14:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:56 INFO - 'PWD': '/builds/slave/test', 14:06:56 INFO - 'SHELL': '/bin/bash', 14:06:56 INFO - 'SHLVL': '1', 14:06:56 INFO - 'TERM': 'linux', 14:06:56 INFO - 'TMOUT': '86400', 14:06:56 INFO - 'USER': 'cltbld', 14:06:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:56 INFO - '_': '/tools/buildbot/bin/python'} 14:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:56 INFO - Downloading/unpacking jsonschema==2.5.1 14:06:56 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:06:56 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:06:56 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:06:56 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:06:56 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:06:56 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:06:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:06:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 14:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:06:58 INFO - warning: no files found matching '*.txt' 14:06:58 INFO - no previously-included directories found matching 'build' 14:06:58 INFO - no previously-included directories found matching 'dist' 14:06:58 INFO - no previously-included directories found matching '.git*' 14:06:58 INFO - Installing collected packages: jsonschema, functools32 14:06:58 INFO - Running setup.py install for functools32 14:06:58 INFO - warning: no files found matching '*.txt' 14:06:58 INFO - no previously-included directories found matching 'build' 14:06:58 INFO - no previously-included directories found matching 'dist' 14:06:58 INFO - no previously-included directories found matching '.git*' 14:06:58 INFO - Successfully installed jsonschema functools32 14:06:58 INFO - Cleaning up... 14:06:58 INFO - Return code: 0 14:06:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:06: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:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:58 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 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:06:58 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:06:58 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:06:58 INFO - Using env: {'DISPLAY': ':0', 14:06:58 INFO - 'HOME': '/home/cltbld', 14:06:58 INFO - 'LANG': 'en_US.UTF-8', 14:06:58 INFO - 'LANGUAGE': 'en_US:en', 14:06:58 INFO - 'LOGNAME': 'cltbld', 14:06:58 INFO - 'MAIL': '/var/mail/cltbld', 14:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:58 INFO - 'MOZ_NO_REMOTE': '1', 14:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:58 INFO - 'NO_EM_RESTART': '1', 14:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:58 INFO - 'PWD': '/builds/slave/test', 14:06:58 INFO - 'SHELL': '/bin/bash', 14:06:58 INFO - 'SHLVL': '1', 14:06:58 INFO - 'TERM': 'linux', 14:06:58 INFO - 'TMOUT': '86400', 14:06:58 INFO - 'USER': 'cltbld', 14:06:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:58 INFO - '_': '/tools/buildbot/bin/python'} 14:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:58 INFO - Downloading/unpacking blobuploader==1.2.4 14:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:00 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:00 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:07:00 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:07:00 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:07:00 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:07:00 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:07:00 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:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:01 INFO - Downloading docopt-0.6.1.tar.gz 14:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:01 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:01 INFO - Running setup.py install for blobuploader 14:07:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:01 INFO - Running setup.py install for requests 14:07:02 INFO - Running setup.py install for docopt 14:07:02 INFO - Successfully installed blobuploader requests docopt 14:07:02 INFO - Cleaning up... 14:07:02 INFO - Return code: 0 14:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:02 INFO - Using env: {'DISPLAY': ':0', 14:07:02 INFO - 'HOME': '/home/cltbld', 14:07:02 INFO - 'LANG': 'en_US.UTF-8', 14:07:02 INFO - 'LANGUAGE': 'en_US:en', 14:07:02 INFO - 'LOGNAME': 'cltbld', 14:07:02 INFO - 'MAIL': '/var/mail/cltbld', 14:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:02 INFO - 'MOZ_NO_REMOTE': '1', 14:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:02 INFO - 'NO_EM_RESTART': '1', 14:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:02 INFO - 'PWD': '/builds/slave/test', 14:07:02 INFO - 'SHELL': '/bin/bash', 14:07:02 INFO - 'SHLVL': '1', 14:07:02 INFO - 'TERM': 'linux', 14:07:02 INFO - 'TMOUT': '86400', 14:07:02 INFO - 'USER': 'cltbld', 14:07:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:02 INFO - '_': '/tools/buildbot/bin/python'} 14:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:02 INFO - Running setup.py (path:/tmp/pip-0tcWSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:02 INFO - Running setup.py (path:/tmp/pip-9H_Cb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:02 INFO - Running setup.py (path:/tmp/pip-IWlNnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:02 INFO - Running setup.py (path:/tmp/pip-42BF0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:02 INFO - Running setup.py (path:/tmp/pip-hleV84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:02 INFO - Running setup.py (path:/tmp/pip-6538Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:02 INFO - Running setup.py (path:/tmp/pip-yVQ7gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:02 INFO - Running setup.py (path:/tmp/pip-_CXsh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:02 INFO - Running setup.py (path:/tmp/pip-ohCDp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:03 INFO - Running setup.py (path:/tmp/pip-zigA_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:03 INFO - Running setup.py (path:/tmp/pip-hyvPg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:03 INFO - Running setup.py (path:/tmp/pip-dBdX9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:03 INFO - Running setup.py (path:/tmp/pip-FgTRhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:03 INFO - Running setup.py (path:/tmp/pip-QVYLEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:03 INFO - Running setup.py (path:/tmp/pip-uaML6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:03 INFO - Running setup.py (path:/tmp/pip-pXIt_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:03 INFO - Running setup.py (path:/tmp/pip-UFJobT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:03 INFO - Running setup.py install for manifestparser 14:07:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:07:03 INFO - Running setup.py install for mozcrash 14:07:03 INFO - Running setup.py install for mozdebug 14:07:03 INFO - Running setup.py install for mozdevice 14:07:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Running setup.py install for mozfile 14:07:04 INFO - Running setup.py install for mozhttpd 14:07:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Running setup.py install for mozinfo 14:07:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Running setup.py install for mozInstall 14:07:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Running setup.py install for mozleak 14:07:04 INFO - Running setup.py install for mozlog 14:07:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Running setup.py install for moznetwork 14:07:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Running setup.py install for mozprocess 14:07:04 INFO - Running setup.py install for mozprofile 14:07:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:07:04 INFO - Running setup.py install for mozrunner 14:07:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:07:05 INFO - Running setup.py install for mozscreenshot 14:07:05 INFO - Running setup.py install for moztest 14:07:05 INFO - Running setup.py install for mozversion 14:07:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:07:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:05 INFO - Cleaning up... 14:07:05 INFO - Return code: 0 14:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:05 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 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:07:05 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:07:05 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:07:05 INFO - Using env: {'DISPLAY': ':0', 14:07:05 INFO - 'HOME': '/home/cltbld', 14:07:05 INFO - 'LANG': 'en_US.UTF-8', 14:07:05 INFO - 'LANGUAGE': 'en_US:en', 14:07:05 INFO - 'LOGNAME': 'cltbld', 14:07:05 INFO - 'MAIL': '/var/mail/cltbld', 14:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:05 INFO - 'MOZ_NO_REMOTE': '1', 14:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:05 INFO - 'NO_EM_RESTART': '1', 14:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:05 INFO - 'PWD': '/builds/slave/test', 14:07:05 INFO - 'SHELL': '/bin/bash', 14:07:05 INFO - 'SHLVL': '1', 14:07:05 INFO - 'TERM': 'linux', 14:07:05 INFO - 'TMOUT': '86400', 14:07:05 INFO - 'USER': 'cltbld', 14:07:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:05 INFO - '_': '/tools/buildbot/bin/python'} 14:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:05 INFO - Running setup.py (path:/tmp/pip-hvtwnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:05 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:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:05 INFO - Running setup.py (path:/tmp/pip-RcJXDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:05 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:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:05 INFO - Running setup.py (path:/tmp/pip-CpJCFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:05 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:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:05 INFO - Running setup.py (path:/tmp/pip-aBrgCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:05 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:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:05 INFO - Running setup.py (path:/tmp/pip-OUpF6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:06 INFO - Running setup.py (path:/tmp/pip-MrBkq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:06 INFO - Running setup.py (path:/tmp/pip-Qzv8sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:06 INFO - Running setup.py (path:/tmp/pip-6bXW_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:06 INFO - Running setup.py (path:/tmp/pip-YCYk4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:06 INFO - Running setup.py (path:/tmp/pip-V8kfAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:06 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:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:06 INFO - Running setup.py (path:/tmp/pip-OiyC0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:06 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:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:06 INFO - Running setup.py (path:/tmp/pip-9iznb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:06 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:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:06 INFO - Running setup.py (path:/tmp/pip-9rJPWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:06 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:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:06 INFO - Running setup.py (path:/tmp/pip-cTzGCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:06 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:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:06 INFO - Running setup.py (path:/tmp/pip-pG4SOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:06 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:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:06 INFO - Running setup.py (path:/tmp/pip-KUfsDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:06 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:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:06 INFO - Running setup.py (path:/tmp/pip-hzYn6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07: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:07: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:07: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:07: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:07: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:07: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:07:08 INFO - Downloading blessings-1.6.tar.gz 14:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:08 INFO - Installing collected packages: blessings 14:07:08 INFO - Running setup.py install for blessings 14:07:08 INFO - Successfully installed blessings 14:07:08 INFO - Cleaning up... 14:07:09 INFO - Return code: 0 14:07:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:09 INFO - Reading from file tmpfile_stdout 14:07:09 INFO - Current package versions: 14:07:09 INFO - argparse == 1.2.1 14:07:09 INFO - blessings == 1.6 14:07:09 INFO - blobuploader == 1.2.4 14:07:09 INFO - docopt == 0.6.1 14:07:09 INFO - functools32 == 3.2.3-2 14:07:09 INFO - jsonschema == 2.5.1 14:07:09 INFO - manifestparser == 1.1 14:07:09 INFO - mozInstall == 1.12 14:07:09 INFO - mozcrash == 0.17 14:07:09 INFO - mozdebug == 0.1 14:07:09 INFO - mozdevice == 0.48 14:07:09 INFO - mozfile == 1.2 14:07:09 INFO - mozhttpd == 0.7 14:07:09 INFO - mozinfo == 0.9 14:07:09 INFO - mozleak == 0.1 14:07:09 INFO - mozlog == 3.2 14:07:09 INFO - moznetwork == 0.27 14:07:09 INFO - mozprocess == 0.22 14:07:09 INFO - mozprofile == 0.28 14:07:09 INFO - mozrunner == 6.11 14:07:09 INFO - mozscreenshot == 0.1 14:07:09 INFO - mozsystemmonitor == 0.3 14:07:09 INFO - moztest == 0.7 14:07:09 INFO - mozversion == 1.4 14:07:09 INFO - psutil == 3.1.1 14:07:09 INFO - requests == 1.2.3 14:07:09 INFO - wsgiref == 0.1.2 14:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:09 INFO - Using env: {'DISPLAY': ':0', 14:07:09 INFO - 'HOME': '/home/cltbld', 14:07:09 INFO - 'LANG': 'en_US.UTF-8', 14:07:09 INFO - 'LANGUAGE': 'en_US:en', 14:07:09 INFO - 'LOGNAME': 'cltbld', 14:07:09 INFO - 'MAIL': '/var/mail/cltbld', 14:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:09 INFO - 'MOZ_NO_REMOTE': '1', 14:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:09 INFO - 'NO_EM_RESTART': '1', 14:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:09 INFO - 'PWD': '/builds/slave/test', 14:07:09 INFO - 'SHELL': '/bin/bash', 14:07:09 INFO - 'SHLVL': '1', 14:07:09 INFO - 'TERM': 'linux', 14:07:09 INFO - 'TMOUT': '86400', 14:07:09 INFO - 'USER': 'cltbld', 14:07:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:09 INFO - '_': '/tools/buildbot/bin/python'} 14:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 INFO - Cleaning up... 14:07:09 INFO - Return code: 0 14:07:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:09 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 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:07:09 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:07:09 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:07:09 INFO - Using env: {'DISPLAY': ':0', 14:07:09 INFO - 'HOME': '/home/cltbld', 14:07:09 INFO - 'LANG': 'en_US.UTF-8', 14:07:09 INFO - 'LANGUAGE': 'en_US:en', 14:07:09 INFO - 'LOGNAME': 'cltbld', 14:07:09 INFO - 'MAIL': '/var/mail/cltbld', 14:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:09 INFO - 'MOZ_NO_REMOTE': '1', 14:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:09 INFO - 'NO_EM_RESTART': '1', 14:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:09 INFO - 'PWD': '/builds/slave/test', 14:07:09 INFO - 'SHELL': '/bin/bash', 14:07:09 INFO - 'SHLVL': '1', 14:07:09 INFO - 'TERM': 'linux', 14:07:09 INFO - 'TMOUT': '86400', 14:07:09 INFO - 'USER': 'cltbld', 14:07:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:09 INFO - '_': '/tools/buildbot/bin/python'} 14:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:07:09 INFO - Cleaning up... 14:07:09 INFO - Return code: 0 14:07:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:09 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 0x7fe786c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, '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': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', '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:07:09 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:07:09 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:07:09 INFO - Using env: {'DISPLAY': ':0', 14:07:09 INFO - 'HOME': '/home/cltbld', 14:07:09 INFO - 'LANG': 'en_US.UTF-8', 14:07:09 INFO - 'LANGUAGE': 'en_US:en', 14:07:09 INFO - 'LOGNAME': 'cltbld', 14:07:09 INFO - 'MAIL': '/var/mail/cltbld', 14:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:09 INFO - 'MOZ_NO_REMOTE': '1', 14:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:09 INFO - 'NO_EM_RESTART': '1', 14:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:09 INFO - 'PWD': '/builds/slave/test', 14:07:09 INFO - 'SHELL': '/bin/bash', 14:07:09 INFO - 'SHLVL': '1', 14:07:09 INFO - 'TERM': 'linux', 14:07:09 INFO - 'TMOUT': '86400', 14:07:09 INFO - 'USER': 'cltbld', 14:07:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:09 INFO - '_': '/tools/buildbot/bin/python'} 14:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:09 INFO - Downloading/unpacking flake8 14:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:07:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:07:11 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:07:11 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:07:11 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:07:11 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:07:11 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:07:11 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:07:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:07:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:07: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:07: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:07: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:07: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:07: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:07: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:07:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:07: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:07: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:07: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:07: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:07: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:07: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:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:12 INFO - no previously-included directories found matching 'docs/_build' 14:07:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:07:12 INFO - Running setup.py install for pep8 14:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:12 INFO - no previously-included directories found matching 'docs/_build' 14:07:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:07:12 INFO - Cleaning up... 14:07:12 INFO - Return code: 0 14:07:12 INFO - Running post-action listener: _resource_record_post_action 14:07:12 INFO - Running post-action listener: _start_resource_monitoring 14:07:12 INFO - Starting resource monitoring. 14:07:12 INFO - ##### 14:07:12 INFO - ##### Finished create-virtualenv step (success) 14:07:12 INFO - ##### 14:07:12 INFO - ##### 14:07:12 INFO - ##### Running install step. 14:07:12 INFO - ##### 14:07:12 INFO - Running pre-action listener: _resource_record_pre_action 14:07:12 INFO - Running main action method: install 14:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:13 INFO - Reading from file tmpfile_stdout 14:07:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:13 INFO - Reading from file tmpfile_stdout 14:07:13 INFO - Output received: 14:07:13 INFO - Usage: mozinstall [options] installer 14:07:13 INFO - Options: 14:07:13 INFO - -h, --help show this help message and exit 14:07:13 INFO - -d DEST, --destination=DEST 14:07:13 INFO - Directory to install application into. [default: 14:07:13 INFO - "/builds/slave/test"] 14:07:13 INFO - --app=APP Application being installed. [default: firefox] 14:07:13 INFO - mkdir: /builds/slave/test/build/application 14:07:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:07:29 INFO - Reading from file tmpfile_stdout 14:07:29 INFO - Output received: 14:07:29 INFO - /builds/slave/test/build/application/firefox/firefox 14:07:29 INFO - Running post-action listener: _resource_record_post_action 14:07:29 INFO - ##### 14:07:29 INFO - ##### Finished install step (success) 14:07:29 INFO - ##### 14:07:29 INFO - ##### 14:07:29 INFO - ##### Running run-tests step. 14:07:29 INFO - ##### 14:07:29 INFO - Running pre-action listener: _resource_record_pre_action 14:07:29 INFO - Running main action method: run_tests 14:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:30 INFO - Python 2.7.3 14:07:30 INFO - Return code: 0 14:07:30 INFO - grabbing minidump binary from tooltool 14:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:30 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 0x1e75110>, '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 0x1de1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de16c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:30 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:07:30 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:07:30 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:07:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:30 INFO - Return code: 0 14:07:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:07:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:07:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:07:30 INFO - Return code: 0 14:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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:07:30 INFO - Using env: {'DISPLAY': ':0', 14:07:30 INFO - 'HOME': '/home/cltbld', 14:07:30 INFO - 'LANG': 'en_US.UTF-8', 14:07:30 INFO - 'LANGUAGE': 'en_US:en', 14:07:30 INFO - 'LOGNAME': 'cltbld', 14:07:30 INFO - 'MAIL': '/var/mail/cltbld', 14:07:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:30 INFO - 'MOZ_NO_REMOTE': '1', 14:07:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:30 INFO - 'NO_EM_RESTART': '1', 14:07:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:30 INFO - 'PWD': '/builds/slave/test', 14:07:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:30 INFO - 'SHELL': '/bin/bash', 14:07:30 INFO - 'SHLVL': '1', 14:07:30 INFO - 'TERM': 'linux', 14:07:30 INFO - 'TMOUT': '86400', 14:07:30 INFO - 'USER': 'cltbld', 14:07:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466', 14:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:30 INFO - '_': '/tools/buildbot/bin/python'} 14:07:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:07:31 INFO - mozversion application_buildid: 20160616113008 14:07:31 INFO - mozversion application_changeset: 942a42c22de790ca091f1e329250ef11217636bc 14:07:31 INFO - mozversion application_display_name: Nightly 14:07:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:31 INFO - mozversion application_name: Firefox 14:07:31 INFO - mozversion application_remotingname: firefox 14:07:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:07:31 INFO - mozversion application_vendor: Mozilla 14:07:31 INFO - mozversion application_version: 50.0a1 14:07:31 INFO - mozversion platform_buildid: 20160616113008 14:07:31 INFO - mozversion platform_changeset: 942a42c22de790ca091f1e329250ef11217636bc 14:07:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:07:31 INFO - mozversion platform_version: 50.0a1 14:07:31 INFO - using testdate: 1466111251 14:07:31 INFO - actual date: 1466111251 14:07:31 INFO - starting webserver on 'localhost:60012' 14:07:31 INFO - SUITE-START | Running 2 tests 14:07:31 INFO - TEST-START | dromaeo_css 14:07:31 INFO - operating with platform_type : linux_ 14:07:31 INFO - Initialising browser for dromaeo_css test... 14:07:31 INFO - TEST-INFO | started process 16965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdfyjc/profile http://localhost:60012/getInfo.html) 14:07:35 INFO - PROCESS | 16965 | __metrics Screen width/height:1600/1200 14:07:35 INFO - PROCESS | 16965 | colorDepth:24 14:07:35 INFO - PROCESS | 16965 | Browser inner width/height: 1024/697 14:07:35 INFO - PROCESS | 16965 | __metrics 14:07:36 ERROR - PROCESS | 16965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:07:37 INFO - TEST-INFO | 16965: exit 0 14:07:37 INFO - Browser initialized. 14:07:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:37 INFO - TEST-INFO | started process 17083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdfyjc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:49 INFO - PROCESS | 17083 | RSS: Main: 184643584 14:07:49 INFO - PROCESS | 17083 | 14:08:38 INFO - PROCESS | 17083 | 1466111318943 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:10:46 INFO - PROCESS | 17083 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60012/tests/dromaeo/cssquery-ext.html) 14:10:47 INFO - PROCESS | 17083 | RSS: Main: 188936192 14:10:47 INFO - PROCESS | 17083 | 14:13:50 INFO - PROCESS | 17083 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-ext.html (next: http://localhost:60012/tests/dromaeo/cssquery-jquery.html) 14:13:50 INFO - PROCESS | 17083 | RSS: Main: 187240448 14:13:50 INFO - PROCESS | 17083 | 14:16:52 INFO - PROCESS | 17083 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60012/tests/dromaeo/cssquery-mootools.html) 14:16:53 INFO - PROCESS | 17083 | RSS: Main: 188936192 14:16:53 INFO - PROCESS | 17083 | 14:19:54 INFO - PROCESS | 17083 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60012/tests/dromaeo/cssquery-prototype.html) 14:19:55 INFO - PROCESS | 17083 | RSS: Main: 186568704 14:19:55 INFO - PROCESS | 17083 | 14:22:57 INFO - PROCESS | 17083 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60012/tests/dromaeo/cssquery-yui.html) 14:22:58 INFO - PROCESS | 17083 | RSS: Main: 188596224 14:22:58 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-yui.html (next: http://localhost:60012/tests/dromaeo/cssquery-dojo.html) 14:26:01 INFO - PROCESS | 17083 | RSS: Main: 189239296 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | __start_tp_report 14:26:01 INFO - PROCESS | 17083 | _x_x_mozilla_page_load 14:26:01 INFO - PROCESS | 17083 | _x_x_mozilla_page_load_details 14:26:01 INFO - PROCESS | 17083 | |i|pagename|runs| 14:26:01 INFO - PROCESS | 17083 | |0;dojo.html;3057.37323848611;3132.592762940818;3141.9842900785493;3157.4790159623662;3157.731592814609;5433.673979561229;5458.7270636468165;5471.562275017999;5527.419620939793;5540.2243685884005;5298.12580924148;5399.352077750666;5451.918221226685;5469.343678758544;5537.695426751527;4895.31465594817;4938.555530002299;5032.094223039851;5080.390353157626;5126.538611524962;745.7973176874445;5031.622628302874;5037.093323201841;5047.041062198189;5054.7472626368535;4905.460399356104;4914.189158788796;4947.1342515059905;4950.678205916622;4983.152864013126;4882.389701287339;4953.23224900141;4962.379702537183;4976.377952755905;5013.323201367805;4851.151048566487;4853.538913803183;4868.634852386085;4879.780409881564;4889.3643826302705;5332.653377530487;5372.811951581676;5429.56563474921;5430.266913966603;5500.092484740013;5757.827265182052;5809.157672137559;5820.1269809528485;5841.357450680422;5844.678542680151;5841.094630332305;5862.560307976876;5880.558958078162;5883.088121341156;5924.763009479659;5423.186522021689;5458;5460.808871689512;5461.1262198048125;5505.119180931032;5795.420457954255;5906.557008224315;5933.436323549256;5957.582969192115;5965.821025369246;5732.7706891723865;5735.1970724098655;5739.2252045973255;5753.079507278815;5759.395263497357;5856.0630299151935;5857.121431785181;5858.062709966385;5858.8242352729485;5872.530197584183;5670.5747068969995;5740.13897915316;5749.597528173072;5790.710464476843;5798.5651076168615;5635.408282130399;5732.054211055212;5758.049921762946;5771.0477771168125;5810.1865738796605;4389.1660584488845;4401.25178719612;4404.691671583022;4405.0969551241915;4438.28987362027;3925.1168487090176;3965;3983.521977362735;4013.618706222904;4024.8931543825097;5601.859953501195;5613.073842815971;5613.298337707786;5615.9157612635845;5679.801206957736;5813.157092221604;5879.617824841372;5931.169636250928;5947.762089516371;5947.881042379215;5427.43011983744;5524.1989911463415;5533.916991245134;5552.083906155439;5554.416786237468;4878.536539028786;4878.634102442331;4879.365682461257;4887.095887260868;4944.381952255968;5828.970855145697;5994.0409534474275;5997.640141591519;6003.099535069775;6010.459058684652;5878.294604647384;5890.970545147246;5913.438223368773;5928.9407105928385;5966.0454327307425;6050.757969681164;6059.121427392915;6059.909101363572;6068.393160683896;6069.939300606938;5588.245586845724;5699.34457537372;5733.971330143323;5782.2194003808945;5810.070388737781;5783.8554036149435;5813.3895940925595;5820.476157145878;5829.067349224104;5873.148393482836;5664.85837854057;5665.886682266414;5668.858278543069;5677.51741102011;5691.914621280601;5544.944550554443;5563.109902415594;5605.943940560543;5626.971865140648;5650.802221922213;5405.78376864921;5443.918341224806;5496;5503.587230957614;5528.364238112507;5624.212610234488;5675.602707810413;5692.089265717465;5696.487316141567;5727.39862314451;5449.6730196188355;5458.536024437967;5493.09363954943;5516.200150978166;5561.833145005657 14:26:01 INFO - PROCESS | 17083 | |1;ext.html;570.8744076303215;614.9292831324397;615.4676205082604;626.2766504687087;637.3148864970156;43091.56908430919;43826.561734382645;43908.560914390844;43928;46883.29675054877;43892.56107438925;44565.777171114096;44636.776816115875;44671.55328446715;44698.329525057154;8915.643374265022;8988.865167022499;9004.00955894851;9004.729858104267;9047.230985366252;8867.556622168899;8949.105089491064;8950.776230594221;8956.686515971942;8960.238379737697;9017.278617710568;9023.819523609523;9070.27437804974;9090.590923408463;9122.908770912305;8939.418937769024;8982.461052336848;9006.694029365737;9013.324000699973;9026.23277021454;8920.197182253629;8967.506787126706;8968.46189228642;8988.955055224682;9020.323475739346;43372.783136084436;43379.56620433787;43498.782506087264;43539.12921741547;43564.128717425476;3481.3559491494157;3552.8934131976084;3552.987398591415;3620.4026335654585;4140.792960352001;32584.674153258402;32624.6737532624;33000.6699933;33022.17444563881;34299.48550771741;4260.637845783112;4366.192254432908;4366.585174408426;4469.061497085616;4495.078508905699;253335;254687;255869;256436;257560;33729.325413492086;58084.70957645269;58189.127163092584;58226;58529;33500.664993349754;35792.82103589518;36162.63837361645;36287;36383.636163638024;15723.292451839694;15936.123513206652;15939.601509962344;15947.362105515882;15951.44169954046;12071.637850864488;12080.335581543099;12099.57651482194;12127.332996685267;12206.450709718085;8210.425270231026;8221.958890205511;8297.875531867026;8313.210245026712;8360.038595561467;3300.6204286506877;3305.405027095098;3308.669133086672;3309.6028476582965;3346.2470944037395;933.7432206143229;1032.8980524632336;1049.1187402581868;1135.8182690769438;1194.9581764638197;31354.21614459611;31498.685013149574;31617.20956976048;32094.83952580269;32369.838150809566;1120.4005856866538;1124.8144056230794;1155.763068570941;1234.9814752778716;1279.4242590834162;16694.6661066778;16953;16957.830421695624;16960.15199240033;17167.57081072983;571297;574444;578791;581321;583510;58902.705486472296;59239.40760592425;59390.703046484494;59553;59654.10518842221;1309.8362704661918;1345.643404497809;1367.418846990045;1374.0381732787089;1387.9444822207201;30679.2330191747;31064.22339441532;31551.684483154873;31786.59381636536;31883.681163188998;49462.75268623634;49599.752001239765;49829.75085124551;49942.500574993785;50015;506685;507274;507460;511487;512178;27735.583966240927;27839.721602783713;27938.441231175668;28142.85928570426;28160.43679126365;47676.523234767206;48434.75782621064;48757.756211218715;49477.25784113169;49779.25331119964;41288;41630.16739665129;41748.16503669849;42558.148837023706;42665.786671066446;40623.39064913969;40853;41033.179336412504;41219.38170927498;41831;40791.59208407878;41092.58907410887;41330.586694132675;41346.1730765389;44367.556324436344;34401;36765.26469470649;37365.4395184067;37834.62165378421;37896;27727.30681732973;27872;27952;28035.083541691343;28314.59325957317 14:26:01 INFO - PROCESS | 17083 | |2;jquery.html;379.93731034379323;385.2122409672218;393.41381341800724;396.3440505962631;414.06008361020486;17832.821671783277;18689.62620747584;18724.812751872494;19304.227830886783;19445.611087778238;18163.545911352223;18549;18917.716234256462;19522;19535.511612209666;5644.096944488882;5664.915026274599;5780.161876527901;5811.157382179582;5864.76540938362;5716.914246286309;5737.684427356494;5747.195392645033;5756.02147634903;5773.249477567911;5634.295713035871;5707.77168913243;5742.167385729067;5760.654360738348;5760.942390576103;5551.195076713874;5598.1602759585985;5650.802221922254;5653.632513886605;5661.2357331760095;4794.736289504076;5061.16490779021;5084.3644544431945;5086.364204474441;5090.694558326475;22177.667334989987;22231.333060008226;23338.299851004496;23446.413839653975;23627.881860590758;2305.907763689467;2340.6372012338115;2484.2174714964726;2544.3766277262002;3124.7968882022597;14295.200903919034;14715.55853324402;14776.630584235372;14793.260336983109;14809.259537023107;1852.2776117314258;1962.7154062660977;1989.5921336126205;2012.6880333548177;2033.217211373617;79193;79615.78017194079;80199.19800801975;80337.19662803356;80448.59775701142;9845.360051596623;9857.950710246403;10065.4464004479;10288.845667314996;10514.684559463229;13933.442662293597;14038.719225615634;14057.85942140586;14096.154230746188;14099.85900141006;8080.424317258078;8160.591970401575;8235.95882020586;8392.79018024542;8500.65997360111;8280.337572994145;8335.208155225366;8373.665053397795;8459.703910363107;8491.19333663301;6358.459530939922;6398.456131228898;6456.451201647818;6496.123023391876;6611.23970743361;1865.682833918237;1932.120884997323;1932.3333449959741;1945.367755479475;1959.8726082804571;946.3091942881734;950.3917492804611;957.2676902169845;1038.4236748604596;1077.5635867473686;18974;19483.415497535098;19606;19660.410187694393;19804.70292945607;1018.9439580823126;1023.5701005577675;1035.9896401036044;1076.6662334676275;1093.191038631407;10977.451127443595;11447;11503.424828758529;11522.36626985507;11563.132765042656;434280;436393;438052;439252;441111;55922.16116758252;80763.19236807674;80813.19186808175;81159;82807;996.5166894056376;1028.5268776362807;1039.3192458939257;1048.4024106259512;1054.7310435838813;17159.28407159324;17343.479695609152;17519.299228031246;17737.113144342988;17797.911010444866;34497.137571559906;38356.232875342896;38749;43202.78398607987;44953.55046449494;57403;58815.41184588099;59206.703966479894;59498.70250648719;60317.39682603118;8437;8450.408471406943;8490.490570565786;8708.825823483368;8748.69379571712;12992.870071299167;13898.652533686738;13967.720645587235;14081.295935203403;14093.859061409255;6000.249968753906;10230.795384092426;11956.940215298868;12107.636770896886;12276.202046866925;11610.593629222936;11725.88274117282;11862.406879656155;11931.701707457383;12393.318367489876;12221.266723996589;12276.570320038756;12297.938510307391;12661.620151395473;12744.61766147017;8176.100628930932;8210.671573137008;8394.580270986304;8532.744017679479;8750.168733970262;8603.784905377415;11973.281603103842;12384.504619815107;12405.069619778373;12606.684832879251 14:26:01 INFO - PROCESS | 17083 | |3;mootools.html;1468.20716812921;1480.082348943655;1544.55207989683;1708.9401870934519;1709.2991873331944;7385.187629360766;8023.9598802005985;8209.712660056899;8592.183742544465;8630.007549131844;8260.710875119372;8364.619837726783;8394.076651568323;8472.534010629413;8475.957620211906;2242.4281808138903;2266.764613285763;2269.9432514187197;2273.068042102738;2277.52172043871;2274.2267629006133;2278.9658155127686;2347.5774360615083;2348.471593891378;2351.1065794997876;2251;2260.977390226093;2273.783990520898;2274.7042884425086;2287.794098531132;2215.5458131083087;2221.0671517962496;2223.5997520446313;2229.5317983223545;2244.80919121874;2188.0919418441486;2210.6794514795424;2211.6461366181334;2236.2508559632543;2236.2955668964223;8434.072252052269;8439.535825529594;8530.82938341236;8552.187542183483;8559.572021398968;4844.152273352184;4913.434954980187;4922.483139270396;4932;4951.579115775164;3018.5019471787127;3054.5570892220503;3226.451503244454;3233.4988076848126;3252.577164968539;1105.6461932181705;1115.5426275227198;1127.616610352484;1138.1520767028535;1146.9655910322704;11553.711157221052;11583.594574189947;11586;11596.826047609293;11634.47644855975;4447.243968525294;4520.683552151318;4569.725816451024;4614;4617;10035.498225088717;10052.095311422006;10059.044390782863;10060.0945914868;10071.69784906454;5021.422536408287;5088.363954505687;5104.821331253388;5163.741812909339;5181.922271165936;3962.8018599070506;4601.631869450436;4694.647901407408;4705.670603057753;4730.172219861579;3786.5456145262747;3804.2201348723447;3882.4176373544196;3927.253821773854;4007.519097708294;1260.0990291941123;1262.6401475579598;1273.4842388832537;1289.27156156773;1291.1026836348647;844.2654890245526;966.21253678252;973.245734555725;976.5654283843621;995.4674249276602;5877.177195192591;5881.088431293157;5897.144913987534;5966.591852543422;5993.61041532299;403.18355330456063;407.893947573633;409.61086967381107;409.81967934108894;412.6368795459976;4016.879493615196;4078.7144899856726;4082;4110.198511290329;4110.486189226347;9895.851562226573;10516.263861529773;10522.684319470429;10523.473826308655;10563.260571760056;10188.694339169837;10356.741081473023;10378.844317335246;10463.68608941733;10526.263161578616;7963.800904977306;8036.4374493786045;8072.636731347104;8077.27304542594;8090.919090809017;5676.631018983753;5686.203931449518;5762.0204565223175;5788.247527821356;5843.707814609167;9723.85414218773;9743.853842192231;9860.506974651382;9867.555959981675;9875.555599997873;9289.16397524226;9755.414675119231;9893.901060989298;10002.099811017044;10064.949675251577;6707.228668703162;7305.196428392979;7435.405167586472;7500.062492188476;7651.846963060596;8365.832683346178;8419.242268195892;8423.241908228043;8491.830163396575;8508.787280318042;7475.626218689153;7576.848463030598;7592.202818704178;7660.846783064419;7774.455788094779;7324.450666199949;7365.337119659256;7425.777226683208;7488.513246638951;7590.051243594551;6749.4600431964345;6884.277150899084;6902.137232845895;6915.792526224222;6926.341997510229;5038.345015148007;5102.438731739431;5262.552683021986;5318.335208098988;5341.65279256847;5213.661112027706;5293.788248470172;5319.175527793198;5339.46605339463;5426.403095659553 14:26:01 INFO - PROCESS | 17083 | |4;prototype.html;303.32056194125164;319.0508237991974;320.8668402612916;322.5661485302268;325.3444309715922;5376.301080859483;5448.645838020526;5611.887762244753;5741.224934633823;5778.8266352009505;5622.240997465351;5638.210650508932;5648.237487939127;5651.9152212716845;5657.377688454267;4252.87241382759;4333.15840767674;4347.456567929009;4349.673774466912;4353.956460435403;4244.87265382039;4327.567243275663;4331.090471001094;4383.145286669101;4387.539308372623;4247.299195632717;4263.339182426714;4265.829366825324;4266.338717498793;4275.315949448089;4263.211305908401;4267.978660106695;4273;4283.828646854122;4311.9784401078105;3765.8305376258136;3769.359208934488;3772.7170462215445;3780;3826.942595861064;5379;5457.481539253765;5504.311961004874;5522.116461366202;5536.100551012383;4860.708357498526;4873.8781530461665;4880.194767863299;4890.779914903802;4899.387576552931;5663.235463212496;5851.356350801409;5865.237519122529;5885.676287804169;5887.967696636236;4087.915163266726;4119.505659320901;4125.855595054189;4126.690498212616;4132.119885452112;5741.540676745851;6024.427679370453;6064.9689552776135;6093.299270583895;6148.385161483816;4263.978680106579;4272.081502476983;4273.55127711592;4293.205756934977;4293.6689626215975;4330.852324134107;4353.978230108829;4355.455568053993;4374.19077470669;4375.146846364992;4881.902361952741;4934.3338649282605;4964.3298154748645;4982.153033984159;4985.551300382983;5791.942080579224;5841.328247251536;5866.442687944638;5875.11873219012;5881.32364778056;1451.1800832529586;1455.9517147653673;1464.3630020940925;1469.6987117640858;1478.874295684879;903.846346121161;948.8007518421209;950.3537594435712;962.8603852441357;963.7012526116927;5021.363784013349;5110.770015349318;5114.772454610941;5158.143068495338;5178.482151784867;5276.34045744282;5319.414864364994;5321.281626980385;5351.331083614548;5389.2006135674255;4984.451710311862;5006.797009315889;5007.649464537448;5016.874578135503;5162.896742065138;2913.373624670706;2914.941701166007;2916.2709322669334;2918.4746745586;2920.7225313595172;5457.672539647634;5480.972595136999;5521.613487055948;5531;5567.832965011056;5311.353480421082;5416.566674666017;5419.458054194628;5453.263809385761;5472.753726082336;5440.238366628675;5454.236406903036;5454.799944012311;5466.8952453305765;5481.561475082063;5265.78936842522;5286.97356513215;5308.362996440452;5318.521333080042;5566.610337276514;5990.760369585168;6038.305594856648;6051.697415129314;6076.6961651916345;6086.908696369646;5991.700414979321;6114.755409783559;6163.660998645118;6209.2548894133;6235.220597425322;4178.373244013423;4192.140611174641;4212.073343864345;4213.47331583552;4226.731980405804;5701.515371193329;5979.162917191509;6009.549283803644;6010.819675409744;6021.819345419644;5808.738606762621;5880.029795083934;5913.6747478887355;5915.970420147872;5925.377835327228;5796.884062318814;5871.794487192928;5893.292804863444;5894.322152952293;5917.6745279010065;5662.433756624305;5731.312242530923;5821.301443826768;5823.563232757645;5866.67733274674;5947.699027040035;5972.940270597239;5983.910241346296;5993.340732519507;6005.909911351246;5543.279373681396;5768.1636162757;5801.882312955825;5868.530517558671;5878.823635290948 14:26:01 INFO - PROCESS | 17083 | |5;yui.html;705.6401235369959;768.1396835544188;778.1323823936311;805.2028491793119;829.0631586307471;15222.238888055594;16018.519444416657;16023.27895244714;16041;16064.19679016049;13833.93083034586;14055.508057218;14071.296435178227;14090.64773380666;14109.365078571464;655.9180102487189;779.2363483785894;799.188823344306;807.9151689072665;814.4380377539509;786.319833344159;788.3850596534712;790.1032328307384;792.0732742691065;794.8688466403065;853.5007020892754;855.0936007831688;855.2815634866711;856.4561503445295;858.9269912057482;846.8433339832089;847.1232274595794;849.5285116760195;850.1753299299731;851.7615067781031;614.5145335185198;618.1346115438422;620.0141774578397;620.9627422354673;621.4779585148452;14286.142831430043;14386.496472623512;14414.927925360305;14416.567502974927;14434.927825360912;14815.259237038104;14921.104733715903;14930.925345373313;14978.925105374512;15074.321655525528;12278;12297;12398.62804115878;12423.813642795365;12428.316442595653;3895.02624343914;3944.112574670705;3998.900027499336;4047.0691740899465;4062.370332598452;76307.23692763112;76377.23622763756;76382;76678;77087.61456192739;10487.94756026215;10926.617568385227;11075.280106793032;11452.94273528627;11476.4835582399;20591.4852128695;20696.379108626767;20857.374278771662;21012.789872101388;21336;8318.792030199293;8386.580670966427;8446.113158118433;8485.745427637181;8608.870866937;4532.443220649555;4541.72749635023;4545.929408253063;4582.69698582704;4683.578477937002;3409.215880347534;3490.6334834842482;3507.982460087683;3515.2969406118877;3522.7710198836994;570.6361001893813;583.233048541167;583.7839999200323;587.5182350472656;588.1941739816479;639.2424976402884;676.0894349823957;680.6358598149966;682.7064362324248;690.7996680962565;8987.820243595223;9046.185843274137;9183.357164998386;9298.95350523243;9403.858942115874;567.5204452237853;612.6507890502371;627.3663599764179;635.8092572228313;648.2998361769278;4253;4403.9559604404185;4412.823487060546;4425.137098265872;4532.116237333754;69086.309136909;69334;84119.57940210382;111022;111465;104223.47888260662;105116.47441762743;105336;105898;106461.46769266104;89855.55072224597;91028.5448572753;91217.54391228002;91673;93924.53037734768;8532.530710810717;8553.700620478254;8737.519436431057;8803.00750386142;9110.590023449093;51670.74164629153;51886.740566296925;52706;53144.4685553155;54190.458095418544;49313.50686493089;49487.25769113394;56309;65951.01073483998;71382;11015.173861960226;11065;11071.53649148704;11321.264117832314;11512.94243528777;12715;12893.29086900192;13262;13625.386857591235;13627.340043277263;11726.824097638371;12057.216280942062;12090.214136081127;12212.694682633006;12285.508579656713;12199.085068619712;12288.791051879929;12355.75288494243;12491;13321.13412628176;11606.129540284344;11667.6499705009;11678.6496405108;12758.362081896053;12827.679308017374;9269.304802139732;9819;9930.950345248228;10241.786729148891;10261.74345641365;9476.95261523688;9659.372140810825;9725.270604704818;9850.32544467428;9921 14:26:01 INFO - PROCESS | 17083 | __end_tp_report 14:26:01 INFO - PROCESS | 17083 | __start_cc_report 14:26:01 INFO - PROCESS | 17083 | _x_x_mozilla_cycle_collect,370 14:26:01 INFO - PROCESS | 17083 | __end_cc_report 14:26:01 INFO - PROCESS | 17083 | __startTimestamp1466112361448__endTimestamp 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | ------- Summary: start ------- 14:26:01 INFO - PROCESS | 17083 | Number of tests: 6 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | [#0] dojo.html Cycles:165 Average:5373.78 Median:5601.86 stddev:715.66 (12.8%) stddev-sans-first:694.40 14:26:01 INFO - PROCESS | 17083 | Values: 3057.4 3132.6 3142.0 3157.5 3157.7 5433.7 5458.7 5471.6 5527.4 5540.2 5298.1 5399.4 5451.9 5469.3 5537.7 4895.3 4938.6 5032.1 5080.4 5126.5 745.8 5031.6 5037.1 5047.0 5054.7 4905.5 4914.2 4947.1 4950.7 4983.2 4882.4 4953.2 4962.4 4976.4 5013.3 4851.2 4853.5 4868.6 4879.8 4889.4 5332.7 5372.8 5429.6 5430.3 5500.1 5757.8 5809.2 5820.1 5841.4 5844.7 5841.1 5862.6 5880.6 5883.1 5924.8 5423.2 5458.0 5460.8 5461.1 5505.1 5795.4 5906.6 5933.4 5957.6 5965.8 5732.8 5735.2 5739.2 5753.1 5759.4 5856.1 5857.1 5858.1 5858.8 5872.5 5670.6 5740.1 5749.6 5790.7 5798.6 5635.4 5732.1 5758.0 5771.0 5810.2 4389.2 4401.3 4404.7 4405.1 4438.3 3925.1 3965.0 3983.5 4013.6 4024.9 5601.9 5613.1 5613.3 5615.9 5679.8 5813.2 5879.6 5931.2 5947.8 5947.9 5427.4 5524.2 5533.9 5552.1 5554.4 4878.5 4878.6 4879.4 4887.1 4944.4 5829.0 5994.0 5997.6 6003.1 6010.5 5878.3 5891.0 5913.4 5928.9 5966.0 6050.8 6059.1 6059.9 6068.4 6069.9 5588.2 5699.3 5734.0 5782.2 5810.1 5783.9 5813.4 5820.5 5829.1 5873.1 5664.9 5665.9 5668.9 5677.5 5691.9 5544.9 5563.1 5605.9 5627.0 5650.8 5405.8 5443.9 5496.0 5503.6 5528.4 5624.2 5675.6 5692.1 5696.5 5727.4 5449.7 5458.5 5493.1 5516.2 5561.8 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | [#1] ext.html Cycles:180 Average:59706.63 Median:41789.58 stddev:125170.89 (299.5%) stddev-sans-first:125443.28 14:26:01 INFO - PROCESS | 17083 | Values: 570.9 614.9 615.5 626.3 637.3 43091.6 43826.6 43908.6 43928.0 46883.3 43892.6 44565.8 44636.8 44671.6 44698.3 8915.6 8988.9 9004.0 9004.7 9047.2 8867.6 8949.1 8950.8 8956.7 8960.2 9017.3 9023.8 9070.3 9090.6 9122.9 8939.4 8982.5 9006.7 9013.3 9026.2 8920.2 8967.5 8968.5 8989.0 9020.3 43372.8 43379.6 43498.8 43539.1 43564.1 3481.4 3552.9 3553.0 3620.4 4140.8 32584.7 32624.7 33000.7 33022.2 34299.5 4260.6 4366.2 4366.6 4469.1 4495.1 253335.0 254687.0 255869.0 256436.0 257560.0 33729.3 58084.7 58189.1 58226.0 58529.0 33500.7 35792.8 36162.6 36287.0 36383.6 15723.3 15936.1 15939.6 15947.4 15951.4 12071.6 12080.3 12099.6 12127.3 12206.5 8210.4 8222.0 8297.9 8313.2 8360.0 3300.6 3305.4 3308.7 3309.6 3346.2 933.7 1032.9 1049.1 1135.8 1195.0 31354.2 31498.7 31617.2 32094.8 32369.8 1120.4 1124.8 1155.8 1235.0 1279.4 16694.7 16953.0 16957.8 16960.2 17167.6 571297.0 574444.0 578791.0 581321.0 583510.0 58902.7 59239.4 59390.7 59553.0 59654.1 1309.8 1345.6 1367.4 1374.0 1387.9 30679.2 31064.2 31551.7 31786.6 31883.7 49462.8 49599.8 49829.8 49942.5 50015.0 506685.0 507274.0 507460.0 511487.0 512178.0 27735.6 27839.7 27938.4 28142.9 28160.4 47676.5 48434.8 48757.8 49477.3 49779.3 41288.0 41630.2 41748.2 42558.1 42665.8 40623.4 40853.0 41033.2 41219.4 41831.0 40791.6 41092.6 41330.6 41346.2 44367.6 34401.0 36765.3 37365.4 37834.6 37896.0 27727.3 27872.0 27952.0 28035.1 28314.6 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | [#2] jquery.html Cycles:180 Average:27199.73 Median:2834.59 stddev:72134.95 (2544.8%) stddev-sans-first:72309.20 14:26:01 INFO - PROCESS | 17083 | Values: 379.9 385.2 393.4 396.3 414.1 17832.8 18689.6 18724.8 19304.2 19445.6 18163.5 18549.0 18917.7 19522.0 19535.5 5644.1 5664.9 5780.2 5811.2 5864.8 5716.9 5737.7 5747.2 5756.0 5773.2 5634.3 5707.8 5742.2 5760.7 5760.9 5551.2 5598.2 5650.8 5653.6 5661.2 4794.7 5061.2 5084.4 5086.4 5090.7 22177.7 22231.3 23338.3 23446.4 23627.9 2305.9 2340.6 2484.2 2544.4 3124.8 14295.2 14715.6 14776.6 14793.3 14809.3 1852.3 1962.7 1989.6 2012.7 2033.2 79193.0 79615.8 80199.2 80337.2 80448.6 9845.4 9858.0 10065.4 10288.8 10514.7 13933.4 14038.7 14057.9 14096.2 14099.9 8080.4 8160.6 8236.0 8392.8 8500.7 8280.3 8335.2 8373.7 8459.7 8491.2 6358.5 6398.5 6456.5 6496.1 6611.2 1865.7 1932.1 1932.3 1945.4 1959.9 946.3 950.4 957.3 1038.4 1077.6 18974.0 19483.4 19606.0 19660.4 19804.7 1018.9 1023.6 1036.0 1076.7 1093.2 10977.5 11447.0 11503.4 11522.4 11563.1 434280.0 436393.0 438052.0 439252.0 441111.0 55922.2 80763.2 80813.2 81159.0 82807.0 996.5 1028.5 1039.3 1048.4 1054.7 17159.3 17343.5 17519.3 17737.1 17797.9 34497.1 38356.2 38749.0 43202.8 44953.6 57403.0 58815.4 59206.7 59498.7 60317.4 8437.0 8450.4 8490.5 8708.8 8748.7 12992.9 13898.7 13967.7 14081.3 14093.9 6000.2 10230.8 11956.9 12107.6 12276.2 11610.6 11725.9 11862.4 11931.7 12393.3 12221.3 12276.6 12297.9 12661.6 12744.6 8176.1 8210.7 8394.6 8532.7 8750.2 8603.8 11973.3 12384.5 12405.1 12606.7 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | [#3] mootools.html Cycles:180 Average:5609.43 Median:4787.16 stddev:3172.97 (66.3%) stddev-sans-first:3166.61 14:26:01 INFO - PROCESS | 17083 | Values: 1468.2 1480.1 1544.6 1708.9 1709.3 7385.2 8024.0 8209.7 8592.2 8630.0 8260.7 8364.6 8394.1 8472.5 8476.0 2242.4 2266.8 2269.9 2273.1 2277.5 2274.2 2279.0 2347.6 2348.5 2351.1 2251.0 2261.0 2273.8 2274.7 2287.8 2215.5 2221.1 2223.6 2229.5 2244.8 2188.1 2210.7 2211.6 2236.3 2236.3 8434.1 8439.5 8530.8 8552.2 8559.6 4844.2 4913.4 4922.5 4932.0 4951.6 3018.5 3054.6 3226.5 3233.5 3252.6 1105.6 1115.5 1127.6 1138.2 1147.0 11553.7 11583.6 11586.0 11596.8 11634.5 4447.2 4520.7 4569.7 4614.0 4617.0 10035.5 10052.1 10059.0 10060.1 10071.7 5021.4 5088.4 5104.8 5163.7 5181.9 3962.8 4601.6 4694.6 4705.7 4730.2 3786.5 3804.2 3882.4 3927.3 4007.5 1260.1 1262.6 1273.5 1289.3 1291.1 844.3 966.2 973.2 976.6 995.5 5877.2 5881.1 5897.1 5966.6 5993.6 403.2 407.9 409.6 409.8 412.6 4016.9 4078.7 4082.0 4110.2 4110.5 9895.9 10516.3 10522.7 10523.5 10563.3 10188.7 10356.7 10378.8 10463.7 10526.3 7963.8 8036.4 8072.6 8077.3 8090.9 5676.6 5686.2 5762.0 5788.2 5843.7 9723.9 9743.9 9860.5 9867.6 9875.6 9289.2 9755.4 9893.9 10002.1 10064.9 6707.2 7305.2 7435.4 7500.1 7651.8 8365.8 8419.2 8423.2 8491.8 8508.8 7475.6 7576.8 7592.2 7660.8 7774.5 7324.5 7365.3 7425.8 7488.5 7590.1 6749.5 6884.3 6902.1 6915.8 6926.3 5038.3 5102.4 5262.6 5318.3 5341.7 5213.7 5293.8 5319.2 5339.5 5426.4 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | [#4] prototype.html Cycles:180 Average:4791.36 Median:5384.10 stddev:1407.44 (26.1%) stddev-sans-first:1370.48 14:26:01 INFO - PROCESS | 17083 | Values: 303.3 319.1 320.9 322.6 325.3 5376.3 5448.6 5611.9 5741.2 5778.8 5622.2 5638.2 5648.2 5651.9 5657.4 4252.9 4333.2 4347.5 4349.7 4354.0 4244.9 4327.6 4331.1 4383.1 4387.5 4247.3 4263.3 4265.8 4266.3 4275.3 4263.2 4268.0 4273.0 4283.8 4312.0 3765.8 3769.4 3772.7 3780.0 3826.9 5379.0 5457.5 5504.3 5522.1 5536.1 4860.7 4873.9 4880.2 4890.8 4899.4 5663.2 5851.4 5865.2 5885.7 5888.0 4087.9 4119.5 4125.9 4126.7 4132.1 5741.5 6024.4 6065.0 6093.3 6148.4 4264.0 4272.1 4273.6 4293.2 4293.7 4330.9 4354.0 4355.5 4374.2 4375.1 4881.9 4934.3 4964.3 4982.2 4985.6 5791.9 5841.3 5866.4 5875.1 5881.3 1451.2 1456.0 1464.4 1469.7 1478.9 903.8 948.8 950.4 962.9 963.7 5021.4 5110.8 5114.8 5158.1 5178.5 5276.3 5319.4 5321.3 5351.3 5389.2 4984.5 5006.8 5007.6 5016.9 5162.9 2913.4 2914.9 2916.3 2918.5 2920.7 5457.7 5481.0 5521.6 5531.0 5567.8 5311.4 5416.6 5419.5 5453.3 5472.8 5440.2 5454.2 5454.8 5466.9 5481.6 5265.8 5287.0 5308.4 5318.5 5566.6 5990.8 6038.3 6051.7 6076.7 6086.9 5991.7 6114.8 6163.7 6209.3 6235.2 4178.4 4192.1 4212.1 4213.5 4226.7 5701.5 5979.2 6009.5 6010.8 6021.8 5808.7 5880.0 5913.7 5916.0 5925.4 5796.9 5871.8 5893.3 5894.3 5917.7 5662.4 5731.3 5821.3 5823.6 5866.7 5947.7 5972.9 5983.9 5993.3 6005.9 5543.3 5768.2 5801.9 5868.5 5878.8 14:26:01 INFO - PROCESS | 17083 | 14:26:01 INFO - PROCESS | 17083 | [#5] yui.html Cycles:180 Average:19651.63 Median:50579.00 stddev:28389.77 (56.1%) stddev-sans-first:28433.77 14:26:01 INFO - PROCESS | 17083 | Values: 705.6 768.1 778.1 805.2 829.1 15222.2 16018.5 16023.3 16041.0 16064.2 13833.9 14055.5 14071.3 14090.6 14109.4 655.9 779.2 799.2 807.9 814.4 786.3 788.4 790.1 792.1 794.9 853.5 855.1 855.3 856.5 858.9 846.8 847.1 849.5 850.2 851.8 614.5 618.1 620.0 621.0 621.5 14286.1 14386.5 14414.9 14416.6 14434.9 14815.3 14921.1 14930.9 14978.9 15074.3 12278.0 12297.0 12398.6 12423.8 12428.3 3895.0 3944.1 3998.9 4047.1 4062.4 76307.2 76377.2 76382.0 76678.0 77087.6 10487.9 10926.6 11075.3 11452.9 11476.5 20591.5 20696.4 20857.4 21012.8 21336.0 8318.8 8386.6 8446.1 8485.7 8608.9 4532.4 4541.7 4545.9 4582.7 4683.6 3409.2 3490.6 3508.0 3515.3 3522.8 570.6 583.2 583.8 587.5 588.2 639.2 676.1 680.6 682.7 690.8 8987.8 9046.2 9183.4 9299.0 9403.9 567.5 612.7 627.4 635.8 648.3 4253.0 4404.0 4412.8 4425.1 4532.1 69086.3 69334.0 84119.6 111022.0 111465.0 104223.5 105116.5 105336.0 105898.0 106461.5 89855.6 91028.5 91217.5 91673.0 93924.5 8532.5 8553.7 8737.5 8803.0 9110.6 51670.7 51886.7 52706.0 53144.5 54190.5 49313.5 49487.3 56309.0 65951.0 71382.0 11015.2 11065.0 11071.5 11321.3 11512.9 12715.0 12893.3 13262.0 13625.4 13627.3 11726.8 12057.2 12090.2 12212.7 12285.5 12199.1 12288.8 12355.8 12491.0 13321.1 11606.1 11667.6 11678.6 12758.4 12827.7 9269.3 9819.0 9931.0 10241.8 10261.7 9477.0 9659.4 9725.3 9850.3 9921.0 14:26:01 INFO - PROCESS | 17083 | -------- Summary: end -------- 14:26:01 INFO - PROCESS | 17083 | 14:26:02 INFO - TEST-INFO | 17083: exit 0 14:26:02 INFO - TEST-OK | dromaeo_css | took 1110989ms 14:26:02 INFO - TEST-START | kraken 14:26:02 INFO - operating with platform_type : linux_ 14:26:02 INFO - Initialising browser for kraken test... 14:26:02 INFO - TEST-INFO | started process 17321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxo8XO_/profile http://localhost:60012/getInfo.html) 14:26:06 INFO - PROCESS | 17321 | __metrics Screen width/height:1600/1200 14:26:06 INFO - PROCESS | 17321 | colorDepth:24 14:26:06 INFO - PROCESS | 17321 | Browser inner width/height: 1024/697 14:26:06 INFO - PROCESS | 17321 | __metrics 14:26:07 ERROR - PROCESS | 17321 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:26:08 INFO - TEST-INFO | 17321: exit 0 14:26:08 INFO - Browser initialized. 14:26:08 INFO - Running cycle 1/1 for kraken test... 14:26:08 INFO - TEST-INFO | started process 17438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxo8XO_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:20 INFO - PROCESS | 17438 | RSS: Main: 184758272 14:26:20 INFO - PROCESS | 17438 | 14:26:22 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:23 INFO - PROCESS | 17438 | RSS: Main: 190853120 14:26:23 INFO - PROCESS | 17438 | 14:26:26 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-dft) 14:26:26 INFO - PROCESS | 17438 | RSS: Main: 189792256 14:26:26 INFO - PROCESS | 17438 | 14:26:29 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-fft) 14:26:30 INFO - PROCESS | 17438 | RSS: Main: 184881152 14:26:30 INFO - PROCESS | 17438 | 14:26:32 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-oscillator) 14:26:33 INFO - PROCESS | 17438 | RSS: Main: 186015744 14:26:33 INFO - PROCESS | 17438 | 14:26:35 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:36 INFO - PROCESS | 17438 | RSS: Main: 186126336 14:26:36 INFO - PROCESS | 17438 | 14:26:39 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60012/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:39 INFO - PROCESS | 17438 | RSS: Main: 186294272 14:26:39 INFO - PROCESS | 17438 | 14:26:43 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60012/tests/kraken/driver.html?testName=imaging-desaturate) 14:26:43 INFO - PROCESS | 17438 | RSS: Main: 183791616 14:26:43 INFO - PROCESS | 17438 | 14:26:46 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60012/tests/kraken/driver.html?testName=json-parse-financial) 14:26:47 INFO - PROCESS | 17438 | RSS: Main: 185630720 14:26:47 INFO - PROCESS | 17438 | 14:26:48 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:26:49 INFO - PROCESS | 17438 | RSS: Main: 186126336 14:26:49 INFO - PROCESS | 17438 | 14:26:51 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:26:51 INFO - PROCESS | 17438 | RSS: Main: 186265600 14:26:52 INFO - PROCESS | 17438 | 14:26:54 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:54 INFO - PROCESS | 17438 | RSS: Main: 186400768 14:26:54 INFO - PROCESS | 17438 | 14:26:57 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:58 INFO - PROCESS | 17438 | RSS: Main: 186417152 14:26:58 INFO - PROCESS | 17438 | 14:27:00 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:01 INFO - PROCESS | 17438 | RSS: Main: 186232832 14:27:01 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60012/tests/kraken/driver.html?testName=ai-astar) 14:27:03 INFO - PROCESS | 17438 | RSS: Main: 186896384 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | __start_tp_report 14:27:03 INFO - PROCESS | 17438 | _x_x_mozilla_page_load 14:27:03 INFO - PROCESS | 17438 | _x_x_mozilla_page_load_details 14:27:03 INFO - PROCESS | 17438 | |i|pagename|runs| 14:27:03 INFO - PROCESS | 17438 | |0;ai-astar;110;108;113;113;111;111;110;118;111;110 14:27:03 INFO - PROCESS | 17438 | |1;audio-beat-detection;167;130;160;177;130;149;160;130;193;128 14:27:03 INFO - PROCESS | 17438 | |2;audio-dft;164;164;164;162;167;169;162;163;161;162 14:27:03 INFO - PROCESS | 17438 | |3;audio-fft;74;75;81;164;76;76;75;76;182;75 14:27:03 INFO - PROCESS | 17438 | |4;audio-oscillator;85;84;146;84;88;85;137;85;84;144 14:27:03 INFO - PROCESS | 17438 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;117;118;117 14:27:03 INFO - PROCESS | 17438 | |6;imaging-darkroom;148;147;149;146;147;147;147;147;149;147 14:27:03 INFO - PROCESS | 17438 | |7;imaging-desaturate;97;96;96;96;96;95;95;97;96;96 14:27:03 INFO - PROCESS | 17438 | |8;json-parse-financial;56;54;57;55;55;55;56;56;67;56 14:27:03 INFO - PROCESS | 17438 | |9;json-stringify-tinderbox;62;63;61;62;62;63;62;61;63;62 14:27:03 INFO - PROCESS | 17438 | |10;stanford-crypto-aes;87;78;79;80;81;81;84;86;108;79 14:27:03 INFO - PROCESS | 17438 | |11;stanford-crypto-ccm;128;133;135;130;126;130;143;128;139;138 14:27:03 INFO - PROCESS | 17438 | |12;stanford-crypto-pbkdf2;166;164;167;166;162;168;165;163;163;162 14:27:03 INFO - PROCESS | 17438 | |13;stanford-crypto-sha256-iterative;65;63;65;62;63;65;66;63;65;62 14:27:03 INFO - PROCESS | 17438 | __end_tp_report 14:27:03 INFO - PROCESS | 17438 | __start_cc_report 14:27:03 INFO - PROCESS | 17438 | _x_x_mozilla_cycle_collect,935 14:27:03 INFO - PROCESS | 17438 | __end_cc_report 14:27:03 INFO - PROCESS | 17438 | __startTimestamp1466112423352__endTimestamp 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | ------- Summary: start ------- 14:27:03 INFO - PROCESS | 17438 | Number of tests: 14 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:2.72 (2.4%) stddev-sans-first:2.83 14:27:03 INFO - PROCESS | 17438 | Values: 110.0 108.0 113.0 113.0 111.0 111.0 110.0 118.0 111.0 110.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:160.00 stddev:22.84 (14.3%) stddev-sans-first:23.60 14:27:03 INFO - PROCESS | 17438 | Values: 167.0 130.0 160.0 177.0 130.0 149.0 160.0 130.0 193.0 128.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.49 (1.5%) stddev-sans-first:2.64 14:27:03 INFO - PROCESS | 17438 | Values: 164.0 164.0 164.0 162.0 167.0 169.0 162.0 163.0 161.0 162.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:41.16 (54.5%) stddev-sans-first:42.92 14:27:03 INFO - PROCESS | 17438 | Values: 74.0 75.0 81.0 164.0 76.0 76.0 75.0 76.0 182.0 75.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:84.50 stddev:27.81 (32.9%) stddev-sans-first:28.79 14:27:03 INFO - PROCESS | 17438 | Values: 85.0 84.0 146.0 84.0 88.0 85.0 137.0 85.0 84.0 144.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:27:03 INFO - PROCESS | 17438 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 118.0 117.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 14:27:03 INFO - PROCESS | 17438 | Values: 148.0 147.0 149.0 146.0 147.0 147.0 147.0 147.0 149.0 147.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 14:27:03 INFO - PROCESS | 17438 | Values: 97.0 96.0 96.0 96.0 96.0 95.0 95.0 97.0 96.0 96.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.71 (6.6%) stddev-sans-first:3.93 14:27:03 INFO - PROCESS | 17438 | Values: 56.0 54.0 57.0 55.0 55.0 55.0 56.0 56.0 67.0 56.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 14:27:03 INFO - PROCESS | 17438 | Values: 62.0 63.0 61.0 62.0 62.0 63.0 62.0 61.0 63.0 62.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:8.87 (11.0%) stddev-sans-first:9.35 14:27:03 INFO - PROCESS | 17438 | Values: 87.0 78.0 79.0 80.0 81.0 81.0 84.0 86.0 108.0 79.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:134.00 stddev:5.60 (4.2%) stddev-sans-first:5.64 14:27:03 INFO - PROCESS | 17438 | Values: 128.0 133.0 135.0 130.0 126.0 130.0 143.0 128.0 139.0 138.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.50 stddev:2.12 (1.3%) stddev-sans-first:2.19 14:27:03 INFO - PROCESS | 17438 | Values: 166.0 164.0 167.0 166.0 162.0 168.0 165.0 163.0 163.0 162.0 14:27:03 INFO - PROCESS | 17438 | 14:27:03 INFO - PROCESS | 17438 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 14:27:03 INFO - PROCESS | 17438 | Values: 65.0 63.0 65.0 62.0 63.0 65.0 66.0 63.0 65.0 62.0 14:27:03 INFO - PROCESS | 17438 | -------- Summary: end -------- 14:27:03 INFO - PROCESS | 17438 | 14:27:04 INFO - TEST-INFO | 17438: exit 0 14:27:04 INFO - TEST-OK | kraken | took 62194ms 14:27:04 INFO - SUITE-END | took 1173s 14:27:04 INFO - Completed test suite (00:19:33) 14:27:04 INFO - javascript benchmark 14:27:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7117.0284376571435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.37323848611, 3132.592762940818, 3141.9842900785493, 3157.4790159623662, 3157.731592814609, 5433.673979561229, 5458.7270636468165, 5471.562275017999, 5527.419620939793, 5540.2243685884005, 5298.12580924148, 5399.352077750666, 5451.918221226685, 5469.343678758544, 5537.695426751527, 4895.31465594817, 4938.555530002299, 5032.094223039851, 5080.390353157626, 5126.538611524962, 745.7973176874445, 5031.622628302874, 5037.093323201841, 5047.041062198189, 5054.7472626368535, 4905.460399356104, 4914.189158788796, 4947.1342515059905, 4950.678205916622, 4983.152864013126, 4882.389701287339, 4953.23224900141, 4962.379702537183, 4976.377952755905, 5013.323201367805, 4851.151048566487, 4853.538913803183, 4868.634852386085, 4879.780409881564, 4889.3643826302705, 5332.653377530487, 5372.811951581676, 5429.56563474921, 5430.266913966603, 5500.092484740013, 5757.827265182052, 5809.157672137559, 5820.1269809528485, 5841.357450680422, 5844.678542680151, 5841.094630332305, 5862.560307976876, 5880.558958078162, 5883.088121341156, 5924.763009479659, 5423.186522021689, 5458.0, 5460.808871689512, 5461.1262198048125, 5505.119180931032, 5795.420457954255, 5906.557008224315, 5933.436323549256, 5957.582969192115, 5965.821025369246, 5732.7706891723865, 5735.1970724098655, 5739.2252045973255, 5753.079507278815, 5759.395263497357, 5856.0630299151935, 5857.121431785181, 5858.062709966385, 5858.8242352729485, 5872.530197584183, 5670.5747068969995, 5740.13897915316, 5749.597528173072, 5790.710464476843, 5798.5651076168615, 5635.408282130399, 5732.054211055212, 5758.049921762946, 5771.0477771168125, 5810.1865738796605, 4389.1660584488845, 4401.25178719612, 4404.691671583022, 4405.0969551241915, 4438.28987362027, 3925.1168487090176, 3965.0, 3983.521977362735, 4013.618706222904, 4024.8931543825097, 5601.859953501195, 5613.073842815971, 5613.298337707786, 5615.9157612635845, 5679.801206957736, 5813.157092221604, 5879.617824841372, 5931.169636250928, 5947.762089516371, 5947.881042379215, 5427.43011983744, 5524.1989911463415, 5533.916991245134, 5552.083906155439, 5554.416786237468, 4878.536539028786, 4878.634102442331, 4879.365682461257, 4887.095887260868, 4944.381952255968, 5828.970855145697, 5994.0409534474275, 5997.640141591519, 6003.099535069775, 6010.459058684652, 5878.294604647384, 5890.970545147246, 5913.438223368773, 5928.9407105928385, 5966.0454327307425, 6050.757969681164, 6059.121427392915, 6059.909101363572, 6068.393160683896, 6069.939300606938, 5588.245586845724, 5699.34457537372, 5733.971330143323, 5782.2194003808945, 5810.070388737781, 5783.8554036149435, 5813.3895940925595, 5820.476157145878, 5829.067349224104, 5873.148393482836, 5664.85837854057, 5665.886682266414, 5668.858278543069, 5677.51741102011, 5691.914621280601, 5544.944550554443, 5563.109902415594, 5605.943940560543, 5626.971865140648, 5650.802221922213, 5405.78376864921, 5443.918341224806, 5496.0, 5503.587230957614, 5528.364238112507, 5624.212610234488, 5675.602707810413, 5692.089265717465, 5696.487316141567, 5727.39862314451, 5449.6730196188355, 5458.536024437967, 5493.09363954943, 5516.200150978166, 5561.833145005657], "value": 5327.437300975535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8744076303215, 614.9292831324397, 615.4676205082604, 626.2766504687087, 637.3148864970156, 43091.56908430919, 43826.561734382645, 43908.560914390844, 43928.0, 46883.29675054877, 43892.56107438925, 44565.777171114096, 44636.776816115875, 44671.55328446715, 44698.329525057154, 8915.643374265022, 8988.865167022499, 9004.00955894851, 9004.729858104267, 9047.230985366252, 8867.556622168899, 8949.105089491064, 8950.776230594221, 8956.686515971942, 8960.238379737697, 9017.278617710568, 9023.819523609523, 9070.27437804974, 9090.590923408463, 9122.908770912305, 8939.418937769024, 8982.461052336848, 9006.694029365737, 9013.324000699973, 9026.23277021454, 8920.197182253629, 8967.506787126706, 8968.46189228642, 8988.955055224682, 9020.323475739346, 43372.783136084436, 43379.56620433787, 43498.782506087264, 43539.12921741547, 43564.128717425476, 3481.3559491494157, 3552.8934131976084, 3552.987398591415, 3620.4026335654585, 4140.792960352001, 32584.674153258402, 32624.6737532624, 33000.6699933, 33022.17444563881, 34299.48550771741, 4260.637845783112, 4366.192254432908, 4366.585174408426, 4469.061497085616, 4495.078508905699, 253335.0, 254687.0, 255869.0, 256436.0, 257560.0, 33729.325413492086, 58084.70957645269, 58189.127163092584, 58226.0, 58529.0, 33500.664993349754, 35792.82103589518, 36162.63837361645, 36287.0, 36383.636163638024, 15723.292451839694, 15936.123513206652, 15939.601509962344, 15947.362105515882, 15951.44169954046, 12071.637850864488, 12080.335581543099, 12099.57651482194, 12127.332996685267, 12206.450709718085, 8210.425270231026, 8221.958890205511, 8297.875531867026, 8313.210245026712, 8360.038595561467, 3300.6204286506877, 3305.405027095098, 3308.669133086672, 3309.6028476582965, 3346.2470944037395, 933.7432206143229, 1032.8980524632336, 1049.1187402581868, 1135.8182690769438, 1194.9581764638197, 31354.21614459611, 31498.685013149574, 31617.20956976048, 32094.83952580269, 32369.838150809566, 1120.4005856866538, 1124.8144056230794, 1155.763068570941, 1234.9814752778716, 1279.4242590834162, 16694.6661066778, 16953.0, 16957.830421695624, 16960.15199240033, 17167.57081072983, 571297.0, 574444.0, 578791.0, 581321.0, 583510.0, 58902.705486472296, 59239.40760592425, 59390.703046484494, 59553.0, 59654.10518842221, 1309.8362704661918, 1345.643404497809, 1367.418846990045, 1374.0381732787089, 1387.9444822207201, 30679.2330191747, 31064.22339441532, 31551.684483154873, 31786.59381636536, 31883.681163188998, 49462.75268623634, 49599.752001239765, 49829.75085124551, 49942.500574993785, 50015.0, 506685.0, 507274.0, 507460.0, 511487.0, 512178.0, 27735.583966240927, 27839.721602783713, 27938.441231175668, 28142.85928570426, 28160.43679126365, 47676.523234767206, 48434.75782621064, 48757.756211218715, 49477.25784113169, 49779.25331119964, 41288.0, 41630.16739665129, 41748.16503669849, 42558.148837023706, 42665.786671066446, 40623.39064913969, 40853.0, 41033.179336412504, 41219.38170927498, 41831.0, 40791.59208407878, 41092.58907410887, 41330.586694132675, 41346.1730765389, 44367.556324436344, 34401.0, 36765.26469470649, 37365.4395184067, 37834.62165378421, 37896.0, 27727.30681732973, 27872.0, 27952.0, 28035.083541691343, 28314.59325957317], "value": 19002.221919705495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.93731034379323, 385.2122409672218, 393.41381341800724, 396.3440505962631, 414.06008361020486, 17832.821671783277, 18689.62620747584, 18724.812751872494, 19304.227830886783, 19445.611087778238, 18163.545911352223, 18549.0, 18917.716234256462, 19522.0, 19535.511612209666, 5644.096944488882, 5664.915026274599, 5780.161876527901, 5811.157382179582, 5864.76540938362, 5716.914246286309, 5737.684427356494, 5747.195392645033, 5756.02147634903, 5773.249477567911, 5634.295713035871, 5707.77168913243, 5742.167385729067, 5760.654360738348, 5760.942390576103, 5551.195076713874, 5598.1602759585985, 5650.802221922254, 5653.632513886605, 5661.2357331760095, 4794.736289504076, 5061.16490779021, 5084.3644544431945, 5086.364204474441, 5090.694558326475, 22177.667334989987, 22231.333060008226, 23338.299851004496, 23446.413839653975, 23627.881860590758, 2305.907763689467, 2340.6372012338115, 2484.2174714964726, 2544.3766277262002, 3124.7968882022597, 14295.200903919034, 14715.55853324402, 14776.630584235372, 14793.260336983109, 14809.259537023107, 1852.2776117314258, 1962.7154062660977, 1989.5921336126205, 2012.6880333548177, 2033.217211373617, 79193.0, 79615.78017194079, 80199.19800801975, 80337.19662803356, 80448.59775701142, 9845.360051596623, 9857.950710246403, 10065.4464004479, 10288.845667314996, 10514.684559463229, 13933.442662293597, 14038.719225615634, 14057.85942140586, 14096.154230746188, 14099.85900141006, 8080.424317258078, 8160.591970401575, 8235.95882020586, 8392.79018024542, 8500.65997360111, 8280.337572994145, 8335.208155225366, 8373.665053397795, 8459.703910363107, 8491.19333663301, 6358.459530939922, 6398.456131228898, 6456.451201647818, 6496.123023391876, 6611.23970743361, 1865.682833918237, 1932.120884997323, 1932.3333449959741, 1945.367755479475, 1959.8726082804571, 946.3091942881734, 950.3917492804611, 957.2676902169845, 1038.4236748604596, 1077.5635867473686, 18974.0, 19483.415497535098, 19606.0, 19660.410187694393, 19804.70292945607, 1018.9439580823126, 1023.5701005577675, 1035.9896401036044, 1076.6662334676275, 1093.191038631407, 10977.451127443595, 11447.0, 11503.424828758529, 11522.36626985507, 11563.132765042656, 434280.0, 436393.0, 438052.0, 439252.0, 441111.0, 55922.16116758252, 80763.19236807674, 80813.19186808175, 81159.0, 82807.0, 996.5166894056376, 1028.5268776362807, 1039.3192458939257, 1048.4024106259512, 1054.7310435838813, 17159.28407159324, 17343.479695609152, 17519.299228031246, 17737.113144342988, 17797.911010444866, 34497.137571559906, 38356.232875342896, 38749.0, 43202.78398607987, 44953.55046449494, 57403.0, 58815.41184588099, 59206.703966479894, 59498.70250648719, 60317.39682603118, 8437.0, 8450.408471406943, 8490.490570565786, 8708.825823483368, 8748.69379571712, 12992.870071299167, 13898.652533686738, 13967.720645587235, 14081.295935203403, 14093.859061409255, 6000.249968753906, 10230.795384092426, 11956.940215298868, 12107.636770896886, 12276.202046866925, 11610.593629222936, 11725.88274117282, 11862.406879656155, 11931.701707457383, 12393.318367489876, 12221.266723996589, 12276.570320038756, 12297.938510307391, 12661.620151395473, 12744.61766147017, 8176.100628930932, 8210.671573137008, 8394.580270986304, 8532.744017679479, 8750.168733970262, 8603.784905377415, 11973.281603103842, 12384.504619815107, 12405.069619778373, 12606.684832879251], "value": 9304.94932401814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.20716812921, 1480.082348943655, 1544.55207989683, 1708.9401870934519, 1709.2991873331944, 7385.187629360766, 8023.9598802005985, 8209.712660056899, 8592.183742544465, 8630.007549131844, 8260.710875119372, 8364.619837726783, 8394.076651568323, 8472.534010629413, 8475.957620211906, 2242.4281808138903, 2266.764613285763, 2269.9432514187197, 2273.068042102738, 2277.52172043871, 2274.2267629006133, 2278.9658155127686, 2347.5774360615083, 2348.471593891378, 2351.1065794997876, 2251.0, 2260.977390226093, 2273.783990520898, 2274.7042884425086, 2287.794098531132, 2215.5458131083087, 2221.0671517962496, 2223.5997520446313, 2229.5317983223545, 2244.80919121874, 2188.0919418441486, 2210.6794514795424, 2211.6461366181334, 2236.2508559632543, 2236.2955668964223, 8434.072252052269, 8439.535825529594, 8530.82938341236, 8552.187542183483, 8559.572021398968, 4844.152273352184, 4913.434954980187, 4922.483139270396, 4932.0, 4951.579115775164, 3018.5019471787127, 3054.5570892220503, 3226.451503244454, 3233.4988076848126, 3252.577164968539, 1105.6461932181705, 1115.5426275227198, 1127.616610352484, 1138.1520767028535, 1146.9655910322704, 11553.711157221052, 11583.594574189947, 11586.0, 11596.826047609293, 11634.47644855975, 4447.243968525294, 4520.683552151318, 4569.725816451024, 4614.0, 4617.0, 10035.498225088717, 10052.095311422006, 10059.044390782863, 10060.0945914868, 10071.69784906454, 5021.422536408287, 5088.363954505687, 5104.821331253388, 5163.741812909339, 5181.922271165936, 3962.8018599070506, 4601.631869450436, 4694.647901407408, 4705.670603057753, 4730.172219861579, 3786.5456145262747, 3804.2201348723447, 3882.4176373544196, 3927.253821773854, 4007.519097708294, 1260.0990291941123, 1262.6401475579598, 1273.4842388832537, 1289.27156156773, 1291.1026836348647, 844.2654890245526, 966.21253678252, 973.245734555725, 976.5654283843621, 995.4674249276602, 5877.177195192591, 5881.088431293157, 5897.144913987534, 5966.591852543422, 5993.61041532299, 403.18355330456063, 407.893947573633, 409.61086967381107, 409.81967934108894, 412.6368795459976, 4016.879493615196, 4078.7144899856726, 4082.0, 4110.198511290329, 4110.486189226347, 9895.851562226573, 10516.263861529773, 10522.684319470429, 10523.473826308655, 10563.260571760056, 10188.694339169837, 10356.741081473023, 10378.844317335246, 10463.68608941733, 10526.263161578616, 7963.800904977306, 8036.4374493786045, 8072.636731347104, 8077.27304542594, 8090.919090809017, 5676.631018983753, 5686.203931449518, 5762.0204565223175, 5788.247527821356, 5843.707814609167, 9723.85414218773, 9743.853842192231, 9860.506974651382, 9867.555959981675, 9875.555599997873, 9289.16397524226, 9755.414675119231, 9893.901060989298, 10002.099811017044, 10064.949675251577, 6707.228668703162, 7305.196428392979, 7435.405167586472, 7500.062492188476, 7651.846963060596, 8365.832683346178, 8419.242268195892, 8423.241908228043, 8491.830163396575, 8508.787280318042, 7475.626218689153, 7576.848463030598, 7592.202818704178, 7660.846783064419, 7774.455788094779, 7324.450666199949, 7365.337119659256, 7425.777226683208, 7488.513246638951, 7590.051243594551, 6749.4600431964345, 6884.277150899084, 6902.137232845895, 6915.792526224222, 6926.341997510229, 5038.345015148007, 5102.438731739431, 5262.552683021986, 5318.335208098988, 5341.65279256847, 5213.661112027706, 5293.788248470172, 5319.175527793198, 5339.46605339463, 5426.403095659553], "value": 4422.34829601133, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.32056194125164, 319.0508237991974, 320.8668402612916, 322.5661485302268, 325.3444309715922, 5376.301080859483, 5448.645838020526, 5611.887762244753, 5741.224934633823, 5778.8266352009505, 5622.240997465351, 5638.210650508932, 5648.237487939127, 5651.9152212716845, 5657.377688454267, 4252.87241382759, 4333.15840767674, 4347.456567929009, 4349.673774466912, 4353.956460435403, 4244.87265382039, 4327.567243275663, 4331.090471001094, 4383.145286669101, 4387.539308372623, 4247.299195632717, 4263.339182426714, 4265.829366825324, 4266.338717498793, 4275.315949448089, 4263.211305908401, 4267.978660106695, 4273.0, 4283.828646854122, 4311.9784401078105, 3765.8305376258136, 3769.359208934488, 3772.7170462215445, 3780.0, 3826.942595861064, 5379.0, 5457.481539253765, 5504.311961004874, 5522.116461366202, 5536.100551012383, 4860.708357498526, 4873.8781530461665, 4880.194767863299, 4890.779914903802, 4899.387576552931, 5663.235463212496, 5851.356350801409, 5865.237519122529, 5885.676287804169, 5887.967696636236, 4087.915163266726, 4119.505659320901, 4125.855595054189, 4126.690498212616, 4132.119885452112, 5741.540676745851, 6024.427679370453, 6064.9689552776135, 6093.299270583895, 6148.385161483816, 4263.978680106579, 4272.081502476983, 4273.55127711592, 4293.205756934977, 4293.6689626215975, 4330.852324134107, 4353.978230108829, 4355.455568053993, 4374.19077470669, 4375.146846364992, 4881.902361952741, 4934.3338649282605, 4964.3298154748645, 4982.153033984159, 4985.551300382983, 5791.942080579224, 5841.328247251536, 5866.442687944638, 5875.11873219012, 5881.32364778056, 1451.1800832529586, 1455.9517147653673, 1464.3630020940925, 1469.6987117640858, 1478.874295684879, 903.846346121161, 948.8007518421209, 950.3537594435712, 962.8603852441357, 963.7012526116927, 5021.363784013349, 5110.770015349318, 5114.772454610941, 5158.143068495338, 5178.482151784867, 5276.34045744282, 5319.414864364994, 5321.281626980385, 5351.331083614548, 5389.2006135674255, 4984.451710311862, 5006.797009315889, 5007.649464537448, 5016.874578135503, 5162.896742065138, 2913.373624670706, 2914.941701166007, 2916.2709322669334, 2918.4746745586, 2920.7225313595172, 5457.672539647634, 5480.972595136999, 5521.613487055948, 5531.0, 5567.832965011056, 5311.353480421082, 5416.566674666017, 5419.458054194628, 5453.263809385761, 5472.753726082336, 5440.238366628675, 5454.236406903036, 5454.799944012311, 5466.8952453305765, 5481.561475082063, 5265.78936842522, 5286.97356513215, 5308.362996440452, 5318.521333080042, 5566.610337276514, 5990.760369585168, 6038.305594856648, 6051.697415129314, 6076.6961651916345, 6086.908696369646, 5991.700414979321, 6114.755409783559, 6163.660998645118, 6209.2548894133, 6235.220597425322, 4178.373244013423, 4192.140611174641, 4212.073343864345, 4213.47331583552, 4226.731980405804, 5701.515371193329, 5979.162917191509, 6009.549283803644, 6010.819675409744, 6021.819345419644, 5808.738606762621, 5880.029795083934, 5913.6747478887355, 5915.970420147872, 5925.377835327228, 5796.884062318814, 5871.794487192928, 5893.292804863444, 5894.322152952293, 5917.6745279010065, 5662.433756624305, 5731.312242530923, 5821.301443826768, 5823.563232757645, 5866.67733274674, 5947.699027040035, 5972.940270597239, 5983.910241346296, 5993.340732519507, 6005.909911351246, 5543.279373681396, 5768.1636162757, 5801.882312955825, 5868.530517558671, 5878.823635290948], "value": 4333.549335845464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6401235369959, 768.1396835544188, 778.1323823936311, 805.2028491793119, 829.0631586307471, 15222.238888055594, 16018.519444416657, 16023.27895244714, 16041.0, 16064.19679016049, 13833.93083034586, 14055.508057218, 14071.296435178227, 14090.64773380666, 14109.365078571464, 655.9180102487189, 779.2363483785894, 799.188823344306, 807.9151689072665, 814.4380377539509, 786.319833344159, 788.3850596534712, 790.1032328307384, 792.0732742691065, 794.8688466403065, 853.5007020892754, 855.0936007831688, 855.2815634866711, 856.4561503445295, 858.9269912057482, 846.8433339832089, 847.1232274595794, 849.5285116760195, 850.1753299299731, 851.7615067781031, 614.5145335185198, 618.1346115438422, 620.0141774578397, 620.9627422354673, 621.4779585148452, 14286.142831430043, 14386.496472623512, 14414.927925360305, 14416.567502974927, 14434.927825360912, 14815.259237038104, 14921.104733715903, 14930.925345373313, 14978.925105374512, 15074.321655525528, 12278.0, 12297.0, 12398.62804115878, 12423.813642795365, 12428.316442595653, 3895.02624343914, 3944.112574670705, 3998.900027499336, 4047.0691740899465, 4062.370332598452, 76307.23692763112, 76377.23622763756, 76382.0, 76678.0, 77087.61456192739, 10487.94756026215, 10926.617568385227, 11075.280106793032, 11452.94273528627, 11476.4835582399, 20591.4852128695, 20696.379108626767, 20857.374278771662, 21012.789872101388, 21336.0, 8318.792030199293, 8386.580670966427, 8446.113158118433, 8485.745427637181, 8608.870866937, 4532.443220649555, 4541.72749635023, 4545.929408253063, 4582.69698582704, 4683.578477937002, 3409.215880347534, 3490.6334834842482, 3507.982460087683, 3515.2969406118877, 3522.7710198836994, 570.6361001893813, 583.233048541167, 583.7839999200323, 587.5182350472656, 588.1941739816479, 639.2424976402884, 676.0894349823957, 680.6358598149966, 682.7064362324248, 690.7996680962565, 8987.820243595223, 9046.185843274137, 9183.357164998386, 9298.95350523243, 9403.858942115874, 567.5204452237853, 612.6507890502371, 627.3663599764179, 635.8092572228313, 648.2998361769278, 4253.0, 4403.9559604404185, 4412.823487060546, 4425.137098265872, 4532.116237333754, 69086.309136909, 69334.0, 84119.57940210382, 111022.0, 111465.0, 104223.47888260662, 105116.47441762743, 105336.0, 105898.0, 106461.46769266104, 89855.55072224597, 91028.5448572753, 91217.54391228002, 91673.0, 93924.53037734768, 8532.530710810717, 8553.700620478254, 8737.519436431057, 8803.00750386142, 9110.590023449093, 51670.74164629153, 51886.740566296925, 52706.0, 53144.4685553155, 54190.458095418544, 49313.50686493089, 49487.25769113394, 56309.0, 65951.01073483998, 71382.0, 11015.173861960226, 11065.0, 11071.53649148704, 11321.264117832314, 11512.94243528777, 12715.0, 12893.29086900192, 13262.0, 13625.386857591235, 13627.340043277263, 11726.824097638371, 12057.216280942062, 12090.214136081127, 12212.694682633006, 12285.508579656713, 12199.085068619712, 12288.791051879929, 12355.75288494243, 12491.0, 13321.13412628176, 11606.129540284344, 11667.6499705009, 11678.6496405108, 12758.362081896053, 12827.679308017374, 9269.304802139732, 9819.0, 9930.950345248228, 10241.786729148891, 10261.74345641365, 9476.95261523688, 9659.372140810825, 9725.270604704818, 9850.32544467428, 9921.0], "value": 7198.054172895479, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 113.0, 113.0, 111.0, 111.0, 110.0, 118.0, 111.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 130.0, 160.0, 177.0, 130.0, 149.0, 160.0, 130.0, 193.0, 128.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 162.0, 167.0, 169.0, 162.0, 163.0, 161.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 81.0, 164.0, 76.0, 76.0, 75.0, 76.0, 182.0, 75.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 146.0, 84.0, 88.0, 85.0, 137.0, 85.0, 84.0, 144.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 146.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 55.0, 55.0, 55.0, 56.0, 56.0, 67.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 63.0, 62.0, 61.0, 63.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 79.0, 80.0, 81.0, 81.0, 84.0, 86.0, 108.0, 79.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 135.0, 130.0, 126.0, 130.0, 143.0, 128.0, 139.0, 138.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 167.0, 166.0, 162.0, 168.0, 165.0, 163.0, 163.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 62.0, 63.0, 65.0, 66.0, 63.0, 65.0, 62.0], "value": 63.9, "unit": "score"}]}]} 14:27:04 INFO - Return code: 0 14:27:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:27:04 ERROR - # TBPL SUCCESS # 14:27:04 INFO - Running post-action listener: _resource_record_post_action 14:27:04 INFO - ##### 14:27:04 INFO - ##### Finished run-tests step (success) 14:27:04 INFO - ##### 14:27:04 INFO - Running post-run listener: _resource_record_post_run 14:27:04 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 4096; Write bytes: 549023744; Read time: 208; Write time: 452248 14:27:04 INFO - TinderboxPrint: CPU usage
13.5% 14:27:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 208 14:27:04 INFO - TinderboxPrint: I/O write bytes / time
549,023,744 / 452,248 14:27:04 INFO - TinderboxPrint: CPU idle
8,216.5 (86.5%) 14:27:04 INFO - TinderboxPrint: CPU user
1,227.1 (12.9%) 14:27:04 INFO - TinderboxPrint: Swap in / out
0 / 0 14:27:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255557632; Read time: 0; Write time: 247400 14:27:04 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 4096; Write bytes: 293466112; Read time: 208; Write time: 204848 14:27:05 INFO - Running post-run listener: _upload_blobber_files 14:27:05 INFO - Blob upload gear active. 14:27:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:27:05 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:27:05 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:27:05 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:27:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:06 INFO - (blobuploader) - INFO - Done attempting. 14:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:27:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:10 INFO - (blobuploader) - INFO - Done attempting. 14:27:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:27:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:27:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:10 INFO - (blobuploader) - INFO - Done attempting. 14:27:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:10 INFO - Return code: 0 14:27:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:27:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c75feccd6b079ab401b6d814045c33c64bbad309b3facdb64696b152c7ccb2aaab6eca86c85164d395f47c61f4d3f2f4808a3c5bc963e0ef2ae0e07298f0e674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83d6b7c416c6274d14f500a374f7e87cf7074873ec4e8cbf5d8f61cd5418481926d9c3c9637921ed40518c5125cd819698fdb74ce8c7ba4f1ad96071ac3c5af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d09f1b8d6eb2a7f2b9486a8164d5402e2fa99788073e891977f9d4668409fb3d5363a46b231b91dd56e47ec8b62c194958e01975c00d40a2d51a53ff8b934001"} 14:27:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:27:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:27:10 INFO - Contents: 14:27:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c75feccd6b079ab401b6d814045c33c64bbad309b3facdb64696b152c7ccb2aaab6eca86c85164d395f47c61f4d3f2f4808a3c5bc963e0ef2ae0e07298f0e674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83d6b7c416c6274d14f500a374f7e87cf7074873ec4e8cbf5d8f61cd5418481926d9c3c9637921ed40518c5125cd819698fdb74ce8c7ba4f1ad96071ac3c5af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d09f1b8d6eb2a7f2b9486a8164d5402e2fa99788073e891977f9d4668409fb3d5363a46b231b91dd56e47ec8b62c194958e01975c00d40a2d51a53ff8b934001"} 14:27:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:10 INFO - Copying logs to upload dir... 14:27:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:27:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.302117 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-16 14:27:09.345658) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 14:27:09.349010) ========= 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=6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466 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/sha512/c75feccd6b079ab401b6d814045c33c64bbad309b3facdb64696b152c7ccb2aaab6eca86c85164d395f47c61f4d3f2f4808a3c5bc963e0ef2ae0e07298f0e674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83d6b7c416c6274d14f500a374f7e87cf7074873ec4e8cbf5d8f61cd5418481926d9c3c9637921ed40518c5125cd819698fdb74ce8c7ba4f1ad96071ac3c5af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d09f1b8d6eb2a7f2b9486a8164d5402e2fa99788073e891977f9d4668409fb3d5363a46b231b91dd56e47ec8b62c194958e01975c00d40a2d51a53ff8b934001"} build_url:https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/OQmKbB4MQHe6eqUR-8q5Zg/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/sha512/c75feccd6b079ab401b6d814045c33c64bbad309b3facdb64696b152c7ccb2aaab6eca86c85164d395f47c61f4d3f2f4808a3c5bc963e0ef2ae0e07298f0e674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83d6b7c416c6274d14f500a374f7e87cf7074873ec4e8cbf5d8f61cd5418481926d9c3c9637921ed40518c5125cd819698fdb74ce8c7ba4f1ad96071ac3c5af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d09f1b8d6eb2a7f2b9486a8164d5402e2fa99788073e891977f9d4668409fb3d5363a46b231b91dd56e47ec8b62c194958e01975c00d40a2d51a53ff8b934001"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 14:27:09.375374) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 14:27:09.375720) ========= 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=6dbc10da6d83fee962c624be000001a8-1466108827.354352-1771034466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 14:27:09.457418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 14:27:09.457739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 14:27:09.458025) ========= ========= Total master_lag: 0.18 =========