builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1465973140.15 results: success (0) buildid: 20160614222726 builduid: 3ac7aae7fd59489aa386a61d9fa451ca revision: da53037ac8087280b90ee94a55f116a24e5e9730 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.154172) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.154730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.155163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.188135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.188420) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 23:45:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.6M=0s 2016-06-14 23:45:40 (60.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.285671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.285943) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023172 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.339448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.339804) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev da53037ac8087280b90ee94a55f116a24e5e9730 --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 da53037ac8087280b90ee94a55f116a24e5e9730 --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=652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 23:45:40,974 truncating revision to first 12 chars 2016-06-14 23:45:40,974 Setting DEBUG logging. 2016-06-14 23:45:40,974 attempt 1/10 2016-06-14 23:45:40,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/da53037ac808?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 23:45:41,290 unpacking tar archive at: fx-team-da53037ac808/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651507 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.010745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.011025) ========= script_repo_revision: da53037ac8087280b90ee94a55f116a24e5e9730 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.011392) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.011666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.020217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-14 23:45:41.020494) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:45:41 INFO - MultiFileLogger online at 20160614 23:45:41 in /builds/slave/test 23:45:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 23:45:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:45:41 INFO - {'append_to_log': False, 23:45:41 INFO - 'base_work_dir': '/builds/slave/test', 23:45:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:45:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:45:41 INFO - 'branch': 'Fx-Team-Non-PGO', 23:45:41 INFO - 'buildbot_json_path': 'buildprops.json', 23:45:41 INFO - 'config_files': ('talos/linux_config.py',), 23:45:41 INFO - 'default_actions': ('clobber', 23:45:41 INFO - 'read-buildbot-config', 23:45:41 INFO - 'download-and-extract', 23:45:41 INFO - 'populate-webroot', 23:45:41 INFO - 'create-virtualenv', 23:45:41 INFO - 'install', 23:45:41 INFO - 'run-tests'), 23:45:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:45:41 INFO - 'download_minidump_stackwalk': True, 23:45:41 INFO - 'download_symbols': 'ondemand', 23:45:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:45:41 INFO - 'tooltool.py': '/tools/tooltool.py', 23:45:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:45:41 INFO - '/tools/misc-python/virtualenv.py')}, 23:45:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:45:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:45:41 INFO - 'installer_path': 'installer.exe', 23:45:41 INFO - 'log_level': 'info', 23:45:41 INFO - 'log_name': 'talos', 23:45:41 INFO - 'log_to_console': True, 23:45:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:45:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:45:41 INFO - 'opt_config_files': (), 23:45:41 INFO - 'pip_index': False, 23:45:41 INFO - 'sps_profile': False, 23:45:41 INFO - 'sps_profile_interval': 0, 23:45:41 INFO - 'suite': 'dromaeojs-e10s', 23:45:41 INFO - 'system_bits': '32', 23:45:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:45:41 INFO - 'title': 'talos-linux64-ix-046', 23:45:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:45:41 INFO - 'use_talos_json': True, 23:45:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:45:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:45:41 INFO - 'work_dir': 'build'} 23:45:41 INFO - ##### 23:45:41 INFO - ##### Running clobber step. 23:45:41 INFO - ##### 23:45:41 INFO - Running pre-action listener: _resource_record_pre_action 23:45:41 INFO - Running main action method: clobber 23:45:41 INFO - rmtree: /builds/slave/test/build 23:45:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:45:42 INFO - Running post-action listener: _resource_record_post_action 23:45:42 INFO - ##### 23:45:42 INFO - ##### Finished clobber step (success) 23:45:42 INFO - ##### 23:45:42 INFO - ##### 23:45:42 INFO - ##### Running read-buildbot-config step. 23:45:42 INFO - ##### 23:45:42 INFO - Running pre-action listener: _resource_record_pre_action 23:45:42 INFO - Running main action method: read_buildbot_config 23:45:42 INFO - Using buildbot properties: 23:45:42 INFO - { 23:45:42 INFO - "project": "", 23:45:42 INFO - "product": "firefox", 23:45:42 INFO - "script_repo_revision": "production", 23:45:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:45:42 INFO - "repository": "", 23:45:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 23:45:42 INFO - "buildid": "20160614222726", 23:45:42 INFO - "pgo_build": "False", 23:45:42 INFO - "basedir": "/builds/slave/test", 23:45:42 INFO - "buildnumber": 1589, 23:45:42 INFO - "slavename": "talos-linux64-ix-046", 23:45:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:45:42 INFO - "platform": "ubuntu64_hw", 23:45:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:45:42 INFO - "branch": "fx-team", 23:45:42 INFO - "repo_path": "integration/fx-team", 23:45:42 INFO - "revision": "da53037ac8087280b90ee94a55f116a24e5e9730", 23:45:42 INFO - "stage_platform": "linux64", 23:45:42 INFO - "builduid": "3ac7aae7fd59489aa386a61d9fa451ca", 23:45:42 INFO - "slavebuilddir": "test" 23:45:42 INFO - } 23:45:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:45:42 INFO - Running post-action listener: _resource_record_post_action 23:45:42 INFO - ##### 23:45:42 INFO - ##### Finished read-buildbot-config step (success) 23:45:42 INFO - ##### 23:45:42 INFO - ##### 23:45:42 INFO - ##### Running download-and-extract step. 23:45:42 INFO - ##### 23:45:42 INFO - Running pre-action listener: _resource_record_pre_action 23:45:42 INFO - Running main action method: download_and_extract 23:45:42 INFO - mkdir: /builds/slave/test/build/tests 23:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:45:42 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:45:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:45:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:45:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:50 INFO - Downloaded 1361 bytes. 23:45:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:45:50 INFO - Using the following test package requirements: 23:45:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:45:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:45:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:45:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'jsshell-linux-x86_64.zip'], 23:45:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:45:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:45:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:45:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:45:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:45:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:45:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:45: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')]} 23:45:50 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:45:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:45:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:45:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:53 INFO - Downloaded 22654307 bytes. 23:45:53 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'] 23:45:53 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 23:45:55 INFO - Return code: 0 23:45:55 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 23:45:55 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')]} 23:45:55 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:45:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:45:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:45:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:00 INFO - Downloaded 22654307 bytes. 23:46:00 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'] 23:46:00 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 23:46:01 INFO - Return code: 0 23:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:01 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:46:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:46:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:46:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:02 INFO - Downloaded 14405384 bytes. 23:46:02 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'] 23:46:02 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 23:46:02 INFO - Return code: 0 23:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:02 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:46:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:04 INFO - Downloaded 55425623 bytes. 23:46:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:04 INFO - mkdir: /builds/slave/test/properties 23:46:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:46:04 INFO - Writing to file /builds/slave/test/properties/build_url 23:46:04 INFO - Contents: 23:46:04 INFO - build_url:https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:04 INFO - Running post-action listener: _resource_record_post_action 23:46:05 INFO - Running post-action listener: set_extra_try_arguments 23:46:05 INFO - ##### 23:46:05 INFO - ##### Finished download-and-extract step (success) 23:46:05 INFO - ##### 23:46:05 INFO - ##### 23:46:05 INFO - ##### Running populate-webroot step. 23:46:05 INFO - ##### 23:46:05 INFO - Running pre-action listener: _resource_record_pre_action 23:46:05 INFO - Running main action method: populate_webroot 23:46:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:46:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:46:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:46:05 INFO - '--tppagecycles', 23:46:05 INFO - '7'], 23:46:05 INFO - 'tests': ['tsvgm']}}, 23:46:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:46:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:46:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:46:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:46:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['damp', 'tps']}, 23:46:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'tests': ['damp', 'tps']}, 23:46:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['dromaeo_dom']}, 23:46:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:46:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['basic_compositor_video']}, 23:46:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:46:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['a11yr', 23:46:05 INFO - 'ts_paint', 23:46:05 INFO - 'tpaint', 23:46:05 INFO - 'sessionrestore', 23:46:05 INFO - 'sessionrestore_no_auto_restore', 23:46:05 INFO - 'tabpaint']}, 23:46:05 INFO - 'other-e10s': {'tests': ['a11yr', 23:46:05 INFO - 'ts_paint', 23:46:05 INFO - 'tpaint', 23:46:05 INFO - 'sessionrestore', 23:46:05 INFO - 'sessionrestore_no_auto_restore', 23:46:05 INFO - 'tabpaint']}, 23:46:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:46:05 INFO - 'ts_paint', 23:46:05 INFO - 'tpaint', 23:46:05 INFO - 'sessionrestore', 23:46:05 INFO - 'sessionrestore_no_auto_restore', 23:46:05 INFO - 'tabpaint']}, 23:46:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:46:05 INFO - 'ts_paint', 23:46:05 INFO - 'tpaint', 23:46:05 INFO - 'sessionrestore', 23:46:05 INFO - 'sessionrestore_no_auto_restore', 23:46:05 INFO - 'tabpaint']}, 23:46:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['a11yr', 23:46:05 INFO - 'ts_paint', 23:46:05 INFO - 'tpaint', 23:46:05 INFO - 'sessionrestore', 23:46:05 INFO - 'sessionrestore_no_auto_restore', 23:46:05 INFO - 'tabpaint']}, 23:46:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['a11yr', 23:46:05 INFO - 'ts_paint', 23:46:05 INFO - 'tpaint', 23:46:05 INFO - 'sessionrestore', 23:46:05 INFO - 'sessionrestore_no_auto_restore', 23:46:05 INFO - 'tabpaint']}, 23:46:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['tsvgx', 23:46:05 INFO - 'tsvgr_opacity', 23:46:05 INFO - 'tart', 23:46:05 INFO - 'tscrollx', 23:46:05 INFO - 'cart']}, 23:46:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:46:05 INFO - 'tsvgr_opacity', 23:46:05 INFO - 'tart', 23:46:05 INFO - 'tscrollx', 23:46:05 INFO - 'cart']}, 23:46:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'talos_options': ['--disable-e10s'], 23:46:05 INFO - 'tests': ['tp5o']}, 23:46:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'tests': ['tp5o']}, 23:46:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'talos_options': ['--disable-e10s', 23:46:05 INFO - '--xperf_path', 23:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:05 INFO - 'tests': ['tp5n']}, 23:46:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:05 INFO - 'talos_options': ['--xperf_path', 23:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:05 INFO - 'tests': ['tp5n']}}, 23:46:05 INFO - 'talos.zip': {'path': '', 23:46:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:46:05 INFO - Running post-action listener: _resource_record_post_action 23:46:05 INFO - ##### 23:46:05 INFO - ##### Finished populate-webroot step (success) 23:46:05 INFO - ##### 23:46:05 INFO - ##### 23:46:05 INFO - ##### Running create-virtualenv step. 23:46:05 INFO - ##### 23:46:05 INFO - Running pre-action listener: _resource_record_pre_action 23:46:05 INFO - Running main action method: create_virtualenv 23:46:05 INFO - Creating virtualenv /builds/slave/test/build/venv 23:46:05 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 23:46:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:46:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:46:05 INFO - Using real prefix '/usr' 23:46:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:46:05 INFO - Installing distribute.............................................................................................................................................................................................done. 23:46:07 INFO - Installing pip.................done. 23:46:07 INFO - Return code: 0 23:46:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:46:07 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')]} 23:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:07 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')]} 23:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:07 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 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:07 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 23:46:07 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 23:46:07 INFO - Using env: {'DISPLAY': ':0', 23:46:07 INFO - 'HOME': '/home/cltbld', 23:46:07 INFO - 'LANG': 'en_US.UTF-8', 23:46:07 INFO - 'LANGUAGE': 'en_US:en', 23:46:07 INFO - 'LOGNAME': 'cltbld', 23:46:07 INFO - 'MAIL': '/var/mail/cltbld', 23:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:07 INFO - 'MOZ_NO_REMOTE': '1', 23:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:07 INFO - 'NO_EM_RESTART': '1', 23:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:07 INFO - 'PWD': '/builds/slave/test', 23:46:07 INFO - 'SHELL': '/bin/bash', 23:46:07 INFO - 'SHLVL': '1', 23:46:07 INFO - 'TERM': 'linux', 23:46:07 INFO - 'TMOUT': '86400', 23:46:07 INFO - 'USER': 'cltbld', 23:46:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:07 INFO - '_': '/tools/buildbot/bin/python'} 23:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:07 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 23:46:07 INFO - Cleaning up... 23:46:07 INFO - Return code: 0 23:46:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:46:07 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')]} 23:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:07 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')]} 23:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:07 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 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:07 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 23:46:07 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 23:46:07 INFO - Using env: {'DISPLAY': ':0', 23:46:07 INFO - 'HOME': '/home/cltbld', 23:46:07 INFO - 'LANG': 'en_US.UTF-8', 23:46:07 INFO - 'LANGUAGE': 'en_US:en', 23:46:07 INFO - 'LOGNAME': 'cltbld', 23:46:07 INFO - 'MAIL': '/var/mail/cltbld', 23:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:07 INFO - 'MOZ_NO_REMOTE': '1', 23:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:07 INFO - 'NO_EM_RESTART': '1', 23:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:07 INFO - 'PWD': '/builds/slave/test', 23:46:07 INFO - 'SHELL': '/bin/bash', 23:46:07 INFO - 'SHLVL': '1', 23:46:07 INFO - 'TERM': 'linux', 23:46:07 INFO - 'TMOUT': '86400', 23:46:07 INFO - 'USER': 'cltbld', 23:46:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:07 INFO - '_': '/tools/buildbot/bin/python'} 23:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:08 INFO - Downloading/unpacking psutil>=3.1.1 23:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:46:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:10 INFO - Installing collected packages: psutil 23:46:10 INFO - Running setup.py install for psutil 23:46:10 INFO - building 'psutil._psutil_linux' extension 23:46:10 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 23:46:10 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 23:46:10 INFO - building 'psutil._psutil_posix' extension 23:46:10 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 23:46:10 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 23:46:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:10 INFO - Successfully installed psutil 23:46:10 INFO - Cleaning up... 23:46:10 INFO - Return code: 0 23:46:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:46:10 INFO - Using env: {'DISPLAY': ':0', 23:46:10 INFO - 'HOME': '/home/cltbld', 23:46:10 INFO - 'LANG': 'en_US.UTF-8', 23:46:10 INFO - 'LANGUAGE': 'en_US:en', 23:46:10 INFO - 'LOGNAME': 'cltbld', 23:46:10 INFO - 'MAIL': '/var/mail/cltbld', 23:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:10 INFO - 'MOZ_NO_REMOTE': '1', 23:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:10 INFO - 'NO_EM_RESTART': '1', 23:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:10 INFO - 'PWD': '/builds/slave/test', 23:46:10 INFO - 'SHELL': '/bin/bash', 23:46:10 INFO - 'SHLVL': '1', 23:46:10 INFO - 'TERM': 'linux', 23:46:10 INFO - 'TMOUT': '86400', 23:46:10 INFO - 'USER': 'cltbld', 23:46:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:10 INFO - '_': '/tools/buildbot/bin/python'} 23:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:46:12 INFO - Installing collected packages: mozsystemmonitor 23:46:12 INFO - Running setup.py install for mozsystemmonitor 23:46:12 INFO - Successfully installed mozsystemmonitor 23:46:12 INFO - Cleaning up... 23:46:12 INFO - Return code: 0 23:46:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:46:12 INFO - Using env: {'DISPLAY': ':0', 23:46:12 INFO - 'HOME': '/home/cltbld', 23:46:12 INFO - 'LANG': 'en_US.UTF-8', 23:46:12 INFO - 'LANGUAGE': 'en_US:en', 23:46:12 INFO - 'LOGNAME': 'cltbld', 23:46:12 INFO - 'MAIL': '/var/mail/cltbld', 23:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:12 INFO - 'MOZ_NO_REMOTE': '1', 23:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:12 INFO - 'NO_EM_RESTART': '1', 23:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:12 INFO - 'PWD': '/builds/slave/test', 23:46:12 INFO - 'SHELL': '/bin/bash', 23:46:12 INFO - 'SHLVL': '1', 23:46:12 INFO - 'TERM': 'linux', 23:46:12 INFO - 'TMOUT': '86400', 23:46:12 INFO - 'USER': 'cltbld', 23:46:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:12 INFO - '_': '/tools/buildbot/bin/python'} 23:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:13 INFO - Downloading/unpacking jsonschema==2.5.1 23:46:13 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 23:46:13 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 23:46:13 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 23:46:13 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 23:46:13 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 23:46:13 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 23:46:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:46:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:46:15 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 23:46:15 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 23:46:15 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 23:46:15 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 23:46:15 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 23:46:15 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 23:46:15 INFO - Downloading functools32-3.2.3-2.tar.gz 23:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:46:15 INFO - warning: no files found matching '*.txt' 23:46:15 INFO - no previously-included directories found matching 'build' 23:46:15 INFO - no previously-included directories found matching 'dist' 23:46:15 INFO - no previously-included directories found matching '.git*' 23:46:15 INFO - Installing collected packages: jsonschema, functools32 23:46:15 INFO - Running setup.py install for functools32 23:46:15 INFO - warning: no files found matching '*.txt' 23:46:15 INFO - no previously-included directories found matching 'build' 23:46:15 INFO - no previously-included directories found matching 'dist' 23:46:15 INFO - no previously-included directories found matching '.git*' 23:46:15 INFO - Successfully installed jsonschema functools32 23:46:15 INFO - Cleaning up... 23:46:15 INFO - Return code: 0 23:46:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:15 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 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:15 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 23:46:15 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 23:46:15 INFO - Using env: {'DISPLAY': ':0', 23:46:15 INFO - 'HOME': '/home/cltbld', 23:46:15 INFO - 'LANG': 'en_US.UTF-8', 23:46:15 INFO - 'LANGUAGE': 'en_US:en', 23:46:15 INFO - 'LOGNAME': 'cltbld', 23:46:15 INFO - 'MAIL': '/var/mail/cltbld', 23:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:15 INFO - 'MOZ_NO_REMOTE': '1', 23:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:15 INFO - 'NO_EM_RESTART': '1', 23:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:15 INFO - 'PWD': '/builds/slave/test', 23:46:15 INFO - 'SHELL': '/bin/bash', 23:46:15 INFO - 'SHLVL': '1', 23:46:15 INFO - 'TERM': 'linux', 23:46:15 INFO - 'TMOUT': '86400', 23:46:15 INFO - 'USER': 'cltbld', 23:46:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:15 INFO - '_': '/tools/buildbot/bin/python'} 23:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:15 INFO - Downloading/unpacking blobuploader==1.2.4 23:46:15 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 23:46:15 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 23:46:15 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 23:46:15 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 23:46:15 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 23:46:15 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 23:46:17 INFO - Downloading blobuploader-1.2.4.tar.gz 23:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:46:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:46:17 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 23:46:17 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 23:46:17 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 23:46:17 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 23:46:17 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 23:46:17 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 23:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:46:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:46:18 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 23:46:18 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 23:46:18 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 23:46:18 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 23:46:18 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 23:46:18 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 23:46:18 INFO - Downloading docopt-0.6.1.tar.gz 23:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:46:18 INFO - Installing collected packages: blobuploader, requests, docopt 23:46:18 INFO - Running setup.py install for blobuploader 23:46:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:46:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:46:18 INFO - Running setup.py install for requests 23:46:18 INFO - Running setup.py install for docopt 23:46:18 INFO - Successfully installed blobuploader requests docopt 23:46:18 INFO - Cleaning up... 23:46:18 INFO - Return code: 0 23:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:18 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 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:18 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 23:46:18 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 23:46:18 INFO - Using env: {'DISPLAY': ':0', 23:46:18 INFO - 'HOME': '/home/cltbld', 23:46:18 INFO - 'LANG': 'en_US.UTF-8', 23:46:18 INFO - 'LANGUAGE': 'en_US:en', 23:46:18 INFO - 'LOGNAME': 'cltbld', 23:46:18 INFO - 'MAIL': '/var/mail/cltbld', 23:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:18 INFO - 'MOZ_NO_REMOTE': '1', 23:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:18 INFO - 'NO_EM_RESTART': '1', 23:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:18 INFO - 'PWD': '/builds/slave/test', 23:46:18 INFO - 'SHELL': '/bin/bash', 23:46:18 INFO - 'SHLVL': '1', 23:46:18 INFO - 'TERM': 'linux', 23:46:18 INFO - 'TMOUT': '86400', 23:46:18 INFO - 'USER': 'cltbld', 23:46:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:18 INFO - '_': '/tools/buildbot/bin/python'} 23:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:19 INFO - Running setup.py (path:/tmp/pip-EvEz1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:19 INFO - Running setup.py (path:/tmp/pip-MkjEgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:19 INFO - Running setup.py (path:/tmp/pip-x54lPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:19 INFO - Running setup.py (path:/tmp/pip-5y88tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:19 INFO - Running setup.py (path:/tmp/pip-W_b319-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:19 INFO - Running setup.py (path:/tmp/pip-JZM4oJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:19 INFO - Running setup.py (path:/tmp/pip-kBdNp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:19 INFO - Running setup.py (path:/tmp/pip-rFolRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:19 INFO - Running setup.py (path:/tmp/pip-toKdaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:19 INFO - Running setup.py (path:/tmp/pip-92Vve7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:19 INFO - Running setup.py (path:/tmp/pip-egIaei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:20 INFO - Running setup.py (path:/tmp/pip-HE_iv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:20 INFO - Running setup.py (path:/tmp/pip-fLIv__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:20 INFO - Running setup.py (path:/tmp/pip-fZukHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:20 INFO - Running setup.py (path:/tmp/pip-8D3AyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:20 INFO - Running setup.py (path:/tmp/pip-1IlAc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:20 INFO - Running setup.py (path:/tmp/pip-5FiDL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:46:20 INFO - Running setup.py install for manifestparser 23:46:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:46:20 INFO - Running setup.py install for mozcrash 23:46:20 INFO - Running setup.py install for mozdebug 23:46:20 INFO - Running setup.py install for mozdevice 23:46:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:46:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:46:20 INFO - Running setup.py install for mozfile 23:46:21 INFO - Running setup.py install for mozhttpd 23:46:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Running setup.py install for mozinfo 23:46:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Running setup.py install for mozInstall 23:46:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Running setup.py install for mozleak 23:46:21 INFO - Running setup.py install for mozlog 23:46:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Running setup.py install for moznetwork 23:46:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Running setup.py install for mozprocess 23:46:21 INFO - Running setup.py install for mozprofile 23:46:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Running setup.py install for mozrunner 23:46:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:46:21 INFO - Running setup.py install for mozscreenshot 23:46:22 INFO - Running setup.py install for moztest 23:46:22 INFO - Running setup.py install for mozversion 23:46:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:46:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:46:22 INFO - Cleaning up... 23:46:22 INFO - Return code: 0 23:46:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:22 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 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:22 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 23:46:22 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 23:46:22 INFO - Using env: {'DISPLAY': ':0', 23:46:22 INFO - 'HOME': '/home/cltbld', 23:46:22 INFO - 'LANG': 'en_US.UTF-8', 23:46:22 INFO - 'LANGUAGE': 'en_US:en', 23:46:22 INFO - 'LOGNAME': 'cltbld', 23:46:22 INFO - 'MAIL': '/var/mail/cltbld', 23:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:22 INFO - 'MOZ_NO_REMOTE': '1', 23:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:22 INFO - 'NO_EM_RESTART': '1', 23:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:22 INFO - 'PWD': '/builds/slave/test', 23:46:22 INFO - 'SHELL': '/bin/bash', 23:46:22 INFO - 'SHLVL': '1', 23:46:22 INFO - 'TERM': 'linux', 23:46:22 INFO - 'TMOUT': '86400', 23:46:22 INFO - 'USER': 'cltbld', 23:46:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:22 INFO - '_': '/tools/buildbot/bin/python'} 23:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:22 INFO - Running setup.py (path:/tmp/pip-L4avlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:22 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)) 23:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:22 INFO - Running setup.py (path:/tmp/pip-EXCFSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:22 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)) 23:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:22 INFO - Running setup.py (path:/tmp/pip-ogDv2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:22 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)) 23:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:22 INFO - Running setup.py (path:/tmp/pip-tcDvYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:22 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)) 23:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:22 INFO - Running setup.py (path:/tmp/pip-YsauN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:22 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)) 23:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:22 INFO - Running setup.py (path:/tmp/pip-J3cJ2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:22 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)) 23:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:22 INFO - Running setup.py (path:/tmp/pip-EVOa0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:23 INFO - Running setup.py (path:/tmp/pip-oN265u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:23 INFO - Running setup.py (path:/tmp/pip-XXpUPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:23 INFO - Running setup.py (path:/tmp/pip-ZPQKZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:23 INFO - Running setup.py (path:/tmp/pip-1C5fGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:23 INFO - Running setup.py (path:/tmp/pip-ewt09e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:23 INFO - Running setup.py (path:/tmp/pip-f4m1nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:23 INFO - Running setup.py (path:/tmp/pip-nPP6zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:23 INFO - Running setup.py (path:/tmp/pip-fJt_tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:23 INFO - Running setup.py (path:/tmp/pip-bC45IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:23 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)) 23:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:23 INFO - Running setup.py (path:/tmp/pip-RO6jXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:23 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)) 23:46:23 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)) 23:46:23 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)) 23:46:23 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)) 23:46:23 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)) 23:46:23 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)) 23:46:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:25 INFO - Downloading blessings-1.6.tar.gz 23:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:46:25 INFO - Installing collected packages: blessings 23:46:25 INFO - Running setup.py install for blessings 23:46:25 INFO - Successfully installed blessings 23:46:25 INFO - Cleaning up... 23:46:25 INFO - Return code: 0 23:46:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:46:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:46:26 INFO - Reading from file tmpfile_stdout 23:46:26 INFO - Current package versions: 23:46:26 INFO - argparse == 1.2.1 23:46:26 INFO - blessings == 1.6 23:46:26 INFO - blobuploader == 1.2.4 23:46:26 INFO - docopt == 0.6.1 23:46:26 INFO - functools32 == 3.2.3-2 23:46:26 INFO - jsonschema == 2.5.1 23:46:26 INFO - manifestparser == 1.1 23:46:26 INFO - mozInstall == 1.12 23:46:26 INFO - mozcrash == 0.17 23:46:26 INFO - mozdebug == 0.1 23:46:26 INFO - mozdevice == 0.48 23:46:26 INFO - mozfile == 1.2 23:46:26 INFO - mozhttpd == 0.7 23:46:26 INFO - mozinfo == 0.9 23:46:26 INFO - mozleak == 0.1 23:46:26 INFO - mozlog == 3.2 23:46:26 INFO - moznetwork == 0.27 23:46:26 INFO - mozprocess == 0.22 23:46:26 INFO - mozprofile == 0.28 23:46:26 INFO - mozrunner == 6.11 23:46:26 INFO - mozscreenshot == 0.1 23:46:26 INFO - mozsystemmonitor == 0.3 23:46:26 INFO - moztest == 0.7 23:46:26 INFO - mozversion == 1.4 23:46:26 INFO - psutil == 3.1.1 23:46:26 INFO - requests == 1.2.3 23:46:26 INFO - wsgiref == 0.1.2 23:46:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 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 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:26 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 23:46:26 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 23:46:26 INFO - Using env: {'DISPLAY': ':0', 23:46:26 INFO - 'HOME': '/home/cltbld', 23:46:26 INFO - 'LANG': 'en_US.UTF-8', 23:46:26 INFO - 'LANGUAGE': 'en_US:en', 23:46:26 INFO - 'LOGNAME': 'cltbld', 23:46:26 INFO - 'MAIL': '/var/mail/cltbld', 23:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:26 INFO - 'MOZ_NO_REMOTE': '1', 23:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:26 INFO - 'NO_EM_RESTART': '1', 23:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:26 INFO - 'PWD': '/builds/slave/test', 23:46:26 INFO - 'SHELL': '/bin/bash', 23:46:26 INFO - 'SHLVL': '1', 23:46:26 INFO - 'TERM': 'linux', 23:46:26 INFO - 'TMOUT': '86400', 23:46:26 INFO - 'USER': 'cltbld', 23:46:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:26 INFO - '_': '/tools/buildbot/bin/python'} 23:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 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)) 23:46:26 INFO - Cleaning up... 23:46:26 INFO - Return code: 0 23:46:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:46:26 INFO - Using env: {'DISPLAY': ':0', 23:46:26 INFO - 'HOME': '/home/cltbld', 23:46:26 INFO - 'LANG': 'en_US.UTF-8', 23:46:26 INFO - 'LANGUAGE': 'en_US:en', 23:46:26 INFO - 'LOGNAME': 'cltbld', 23:46:26 INFO - 'MAIL': '/var/mail/cltbld', 23:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:26 INFO - 'MOZ_NO_REMOTE': '1', 23:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:26 INFO - 'NO_EM_RESTART': '1', 23:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:26 INFO - 'PWD': '/builds/slave/test', 23:46:26 INFO - 'SHELL': '/bin/bash', 23:46:26 INFO - 'SHLVL': '1', 23:46:26 INFO - 'TERM': 'linux', 23:46:26 INFO - 'TMOUT': '86400', 23:46:26 INFO - 'USER': 'cltbld', 23:46:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:26 INFO - '_': '/tools/buildbot/bin/python'} 23:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:46:26 INFO - Cleaning up... 23:46:26 INFO - Return code: 0 23:46:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82941c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', '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 23:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:46:26 INFO - Using env: {'DISPLAY': ':0', 23:46:26 INFO - 'HOME': '/home/cltbld', 23:46:26 INFO - 'LANG': 'en_US.UTF-8', 23:46:26 INFO - 'LANGUAGE': 'en_US:en', 23:46:26 INFO - 'LOGNAME': 'cltbld', 23:46:26 INFO - 'MAIL': '/var/mail/cltbld', 23:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:26 INFO - 'MOZ_NO_REMOTE': '1', 23:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:26 INFO - 'NO_EM_RESTART': '1', 23:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:26 INFO - 'PWD': '/builds/slave/test', 23:46:26 INFO - 'SHELL': '/bin/bash', 23:46:26 INFO - 'SHLVL': '1', 23:46:26 INFO - 'TERM': 'linux', 23:46:26 INFO - 'TMOUT': '86400', 23:46:26 INFO - 'USER': 'cltbld', 23:46:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:26 INFO - '_': '/tools/buildbot/bin/python'} 23:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:26 INFO - Downloading/unpacking flake8 23:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:46:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:46:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:46:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:46:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:46:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:46:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:46:29 INFO - no previously-included directories found matching 'docs/_build' 23:46:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:46:29 INFO - Running setup.py install for pep8 23:46:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:46:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:46:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:46:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:46:29 INFO - no previously-included directories found matching 'docs/_build' 23:46:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:46:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:46:29 INFO - Cleaning up... 23:46:29 INFO - Return code: 0 23:46:29 INFO - Running post-action listener: _resource_record_post_action 23:46:29 INFO - Running post-action listener: _start_resource_monitoring 23:46:29 INFO - Starting resource monitoring. 23:46:29 INFO - ##### 23:46:29 INFO - ##### Finished create-virtualenv step (success) 23:46:29 INFO - ##### 23:46:29 INFO - ##### 23:46:29 INFO - ##### Running install step. 23:46:29 INFO - ##### 23:46:29 INFO - Running pre-action listener: _resource_record_pre_action 23:46:29 INFO - Running main action method: install 23:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:46:29 INFO - Reading from file tmpfile_stdout 23:46:29 INFO - Detecting whether we're running mozinstall >=1.0... 23:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:46:29 INFO - Reading from file tmpfile_stdout 23:46:29 INFO - Output received: 23:46:29 INFO - Usage: mozinstall [options] installer 23:46:29 INFO - Options: 23:46:29 INFO - -h, --help show this help message and exit 23:46:29 INFO - -d DEST, --destination=DEST 23:46:29 INFO - Directory to install application into. [default: 23:46:29 INFO - "/builds/slave/test"] 23:46:29 INFO - --app=APP Application being installed. [default: firefox] 23:46:29 INFO - mkdir: /builds/slave/test/build/application 23:46:29 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'] 23:46:29 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 23:46:45 INFO - Reading from file tmpfile_stdout 23:46:45 INFO - Output received: 23:46:45 INFO - /builds/slave/test/build/application/firefox/firefox 23:46:45 INFO - Running post-action listener: _resource_record_post_action 23:46:45 INFO - ##### 23:46:45 INFO - ##### Finished install step (success) 23:46:45 INFO - ##### 23:46:45 INFO - ##### 23:46:45 INFO - ##### Running run-tests step. 23:46:45 INFO - ##### 23:46:45 INFO - Running pre-action listener: _resource_record_pre_action 23:46:45 INFO - Running main action method: run_tests 23:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:46:45 INFO - Python 2.7.3 23:46:45 INFO - Return code: 0 23:46:45 INFO - grabbing minidump binary from tooltool 23:46: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')]} 23:46:45 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 0x13e91c0>, '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 0x13ea0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:46:45 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 23:46:46 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 23:46:46 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 23:46:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:46:46 INFO - Return code: 0 23:46:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:46:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:46:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:46:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:46:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:46:47 INFO - Return code: 0 23:46:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:46:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 23:46:47 INFO - Using env: {'DISPLAY': ':0', 23:46:47 INFO - 'HOME': '/home/cltbld', 23:46:47 INFO - 'LANG': 'en_US.UTF-8', 23:46:47 INFO - 'LANGUAGE': 'en_US:en', 23:46:47 INFO - 'LOGNAME': 'cltbld', 23:46:47 INFO - 'MAIL': '/var/mail/cltbld', 23:46:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:46:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:47 INFO - 'MOZ_NO_REMOTE': '1', 23:46:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:47 INFO - 'NO_EM_RESTART': '1', 23:46:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:47 INFO - 'PWD': '/builds/slave/test', 23:46:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:46:47 INFO - 'SHELL': '/bin/bash', 23:46:47 INFO - 'SHLVL': '1', 23:46:47 INFO - 'TERM': 'linux', 23:46:47 INFO - 'TMOUT': '86400', 23:46:47 INFO - 'USER': 'cltbld', 23:46:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774', 23:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:47 INFO - '_': '/tools/buildbot/bin/python'} 23:46:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:46:47 INFO - mozversion application_buildid: 20160614222726 23:46:47 INFO - mozversion application_changeset: da53037ac8087280b90ee94a55f116a24e5e9730 23:46:47 INFO - mozversion application_display_name: Nightly 23:46:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:46:47 INFO - mozversion application_name: Firefox 23:46:47 INFO - mozversion application_remotingname: firefox 23:46:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:46:47 INFO - mozversion application_vendor: Mozilla 23:46:47 INFO - mozversion application_version: 50.0a1 23:46:47 INFO - mozversion platform_buildid: 20160614222726 23:46:47 INFO - mozversion platform_changeset: da53037ac8087280b90ee94a55f116a24e5e9730 23:46:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:46:47 INFO - mozversion platform_version: 50.0a1 23:46:47 INFO - using testdate: 1465973207 23:46:47 INFO - actual date: 1465973207 23:46:47 INFO - starting webserver on 'localhost:44380' 23:46:47 INFO - SUITE-START | Running 2 tests 23:46:47 INFO - TEST-START | dromaeo_css 23:46:47 INFO - operating with platform_type : linux_ 23:46:47 INFO - Initialising browser for dromaeo_css test... 23:46:47 INFO - TEST-INFO | started process 19505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiUP8q_/profile http://localhost:44380/getInfo.html) 23:46:52 INFO - PROCESS | 19505 | __metrics Screen width/height:1600/1200 23:46:52 INFO - PROCESS | 19505 | colorDepth:24 23:46:52 INFO - PROCESS | 19505 | Browser inner width/height: 1024/697 23:46:52 INFO - PROCESS | 19505 | __metrics 23:46:53 ERROR - PROCESS | 19505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 23:46:54 INFO - TEST-INFO | 19505: exit 0 23:46:54 INFO - Browser initialized. 23:46:54 INFO - Running cycle 1/1 for dromaeo_css test... 23:46:54 INFO - TEST-INFO | started process 19622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiUP8q_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:47:06 INFO - PROCESS | 19622 | RSS: Main: 186662912 23:47:06 INFO - PROCESS | 19622 | 23:47:55 INFO - PROCESS | 19622 | 1465973275803 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] 23:50:08 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:44380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44380/tests/dromaeo/cssquery-ext.html) 23:50:09 INFO - PROCESS | 19622 | RSS: Main: 189509632 23:50:09 INFO - PROCESS | 19622 | 23:53:11 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:44380/tests/dromaeo/cssquery-ext.html (next: http://localhost:44380/tests/dromaeo/cssquery-jquery.html) 23:53:12 INFO - PROCESS | 19622 | RSS: Main: 188346368 23:53:12 INFO - PROCESS | 19622 | 23:56:14 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:44380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44380/tests/dromaeo/cssquery-mootools.html) 23:56:14 INFO - PROCESS | 19622 | RSS: Main: 189550592 23:56:14 INFO - PROCESS | 19622 | 23:59:16 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:44380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44380/tests/dromaeo/cssquery-prototype.html) 23:59:17 INFO - PROCESS | 19622 | RSS: Main: 186830848 23:59:17 INFO - PROCESS | 19622 | 00:02:20 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:44380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44380/tests/dromaeo/cssquery-yui.html) 00:02:20 INFO - PROCESS | 19622 | RSS: Main: 191315968 00:02:20 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:44380/tests/dromaeo/cssquery-yui.html (next: http://localhost:44380/tests/dromaeo/cssquery-dojo.html) 00:05:23 INFO - PROCESS | 19622 | RSS: Main: 187121664 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | __start_tp_report 00:05:23 INFO - PROCESS | 19622 | _x_x_mozilla_page_load 00:05:23 INFO - PROCESS | 19622 | _x_x_mozilla_page_load_details 00:05:23 INFO - PROCESS | 19622 | |i|pagename|runs| 00:05:23 INFO - PROCESS | 19622 | |0;dojo.html;2575.30466773971;2644.537205988952;2689.058829409708;2693.838369697818;2698.784097272217;4772.498887616803;4784.306275590037;4824.46930837608;4860.343853579766;4928.926066109011;4683.180443422404;4693.8357157499495;4700.6004489618335;4808.615310775138;4866.31871537985;4423.513413524518;4478.552144785528;4542.068875880453;4560.33875088112;4609.67732258742;568.6032498692153;4316.978415107936;4389;4410.492793328776;4424.358468022135;4408.603225709701;4456.376107344974;4468.3074123510905;4470.061287129706;4502.144592527442;4465.732056076613;4468.061707041526;4475.7985890635;4478.77606119696;4500.054988452429;4296.63478604319;4376;4411.602955733999;4422.469303683579;4458.554144585515;4753.524647535253;4837.806487740486;4843.128236917353;4852.708837469728;4852.733099679516;5111.591072714174;5180.248863914749;5185.662931909414;5211.765470553796;5275.050490911634;5192.454792246797;5222.503862133091;5228.895422091537;5238.816641417532;5274.736263186825;4808;4836.830710925136;4861.416630004422;4867.829625963074;4904.6566740327835;5026.396832380065;5228.215767634809;5229.241759944786;5322.946770532322;5325.733713314319;5074.771635276422;5075.8984820303385;5077.923831142536;5093.465186155475;5110.207917772751;5156.871078222999;5171.663841850343;5177.094008548489;5185.870353241199;5225.320708307896;5027.4721154279005;5115.488451154929;5133.4096578893905;5163.225516172529;5193.532582067556;5159.742012899415;5160.509751573594;5169.302144210558;5176.870578235499;5177.896442071137;4415.62467190286;4419.005723712139;4425.513193548707;4448.666350023761;4487.282034874404;3720.2187540616774;3760.981195094007;3822.9869084692577;3838.539375274929;3838.788866612363;4344.218040752632;4419.270820314612;4464.888377790581;4489.124620698998;4506.504284528699;5229.346331708536;5233.685978841282;5238.240455133984;5240.528352448222;5305.336832895888;4290.892727681833;4470.284754439274;4480.686351955397;4510.797014134372;4538.341940418621;4742.928856067162;4744.098621261949;4744.5492678195515;4747.264174053027;4800.5199480052415;4875.878103047381;4936.580390666833;4939.950600494093;4948.604111671058;4986.376702912136;5096.566791822736;5123.590112791042;5180.61145414103;5181.792728290826;5181.870453238699;4809.2064809306075;4825.179719447772;4844.927326090041;4892.706437613754;4897.779599917941;4986.351774269322;5153.50003981844;5153.5361817436615;5165;5165.483451654804;5112.309838171799;5121.103806833864;5145.691258524501;5161.3032240647035;5208.244804503402;5005.324281222134;5017.046761115376;5020.874478138076;5030;5048.242763585492;4949.950500494949;4988.825391111293;5003.649744517848;5017.297578338962;5056.443791183041;4949.257611358325;4988.301637770787;4992.900141997213;5011.323471331323;5052.065367906949;5119.89922166736;5122.282880396822;5123.89836185222;5124.5131712487255;5156.2523434102595;4850.587700045536;4892.755362231803;4925.802967881388;4950.985048065066;5015.971725796276 00:05:23 INFO - PROCESS | 19622 | |1;ext.html;539.209617738896;565.0619970848392;587.8589138606735;597.4831770518501;604.88204800064;35021.29957400854;38495.23009539811;38583.61416385835;38587.61412385875;38749.22501549967;33221.83389083051;33237.33525329492;33280.66719332806;33322.166945826306;33499.66500334996;7541.245875412456;7714.305712485875;7730.4975176613625;7755.844883102334;7756.883646745303;7742.109657389387;7766.184550622188;7837.529748215097;7853.921460785376;7888.763337099867;7865.174156713549;7899.605019748989;7899.8420031599335;7904.170062143478;7929.881051784228;7870.960645196766;7879.960600196962;7884.842303153933;7892.842143157105;7909.24862138096;7620.657070431844;7698.2686644768655;7707.383409327241;7739.961300193463;7742.845143097163;36753.44869826928;36875.07812304687;36885.81557092224;37008;37132.62867371319;2572.254046326563;2939.241061636336;2970.450466663674;3130.2487403023338;3146.8269245191736;27415.588766168523;27527.31181720453;28067.157985260474;28391.57412638812;28808.855955720086;3323.7839540429795;3334.916627084318;3344.6320904700465;3354.245294808673;3395.7792743471596;207543;208763;209353;209515.95242023843;209962;28160.155195344174;31341.8432907834;31636.841815790773;31638.209044773605;31649;33778.66221337755;33832.32335353279;33937.83031084878;33961.49057764136;34006.82996585001;13068.803967940488;13156.671083222805;13244.602661920158;13255.403506842022;13271.270080145492;10647.201459890539;10680.57277708883;10691.30506517074;10717.35695858251;10726.19553533488;7893.210678932061;7893.565853877977;7899.921000789918;7986.241307075818;7988.320992715568;3119.189010857148;3123.109913674592;3152.3852848694282;3155.857986390618;3164.2880351920635;867.3841572483607;872.9694460693845;886.2732559301311;913.8706813125402;1030.4229631406436;26718;27705.445891082065;27950.16149515518;27952.860235698692;28202.85898570494;940.6707652321769;963.2775418436173;977.3891317926297;1015.4922538730634;1078.741102135482;14247.857521424654;14797.260136993107;14935.395360439012;14946.551603451697;14959.775603365959;381869;426785;435633.8619682829;437077;650090;48273.5172648269;48741.756291219026;48849.51150488521;48989.755051224514;49098;1187.1986409173774;1197.4252358867793;1202.4889421995617;1204.7771162334996;1213.4600102954278;26938.191854244404;27819.582706259825;28281.85859070774;28439.28901777472;28572.85713571419;40762.59237407707;41294;41413;41441;41486.58513414827;280376;281996;283819;284663;285460;25318.49363012766;25626.23121306364;25701;25854.35364115837;25937.351566210997;39542.802285988386;40402.79798600988;40503.10316913036;41005.38491922564;42205.155896882505;35554.46668299926;36142.457863131545;36516.53933842616;36564;36665.633343666224;35371.29257414889;35602.46596301006;35634.82182589174;35839.104022399646;36004.09989750277;33150.668493314755;34959.82520087485;35091.298174036885;35315.47026794651;36010;31692.683073169894;32553.560451971603;33207.833960830045;33274.667253327156;33574.32851343008;25290.494190116464;25295.873520632278;25437.491250175262;25508.489830203664;26076.478470430866 00:05:23 INFO - PROCESS | 19622 | |2;jquery.html;359.969402600779;360.9729270304727;365.5631520333203;377.1683438019168;380.8914459379076;15715.52853414398;16115.83884161158;16475.91762041188;16984.065876376793;17026.999999999967;15734.763978540303;15980.680386392265;16768.161591920416;16806.32774689014;16908.239129239184;5039.798408063673;5265.736713164346;5278.630495865291;5284.2866213061325;5290.259363689067;5176.922346164811;5194.194899790519;5256.737163141846;5274.918641678447;5282.973585132069;5072.923906141411;5213.218017297417;5220.347456567929;5221.216817477371;5239.056969745444;5113.769880355374;5118.744062796864;5163;5192.818251361185;5194.558462530689;4505.301678239878;4576.3821884045565;4585.656075794295;4601.171789077965;4615.584597386218;19766.308179213804;19918;20496.59006819855;20545.897270513553;20591.176352946015;1947.2318081012027;2000.8895063239895;2043.5197728533783;2085.4577809769416;2384.546936082156;10926.453677316102;11998.880011199864;12859.42132604035;12931.5473958411;13438.12652177615;1721.3630956546033;1749.09921390484;1778.1464896849454;1781.7060185069447;1798.307651554148;48773.756131219474;62659;67651.66174169147;68471.31528684699;68567.65716171387;9497.525123743786;9517.714468565953;9542.520909259076;9597.376170548892;9682.467464289392;12768.297743624003;12799.232046077264;12927.418266178045;12993.090483666241;13062.608121756362;6941.167059952737;6985.93014069863;7007.229204787469;7031.156261248683;7125.857482850314;6478.093066970628;6479;6608.537402381883;6617.602943823386;6626.768063117768;3932.9016774580864;4018.618231268025;4088.34586466164;4116.794160291974;4366.366876802846;1790.543411430103;1823.7355583440326;1858.5353661584604;1860.7674040744907;1869.7008478643352;783.1385475976381;835.5989125219928;847.1020718038899;863.7106569299355;877;15985.44050958211;16791.916040419965;17076.914615427093;17227.913860430617;17284.913575432292;836.4019725896013;851.3572252948984;869.9652013919499;889.2930120554175;925.2413021322451;8901.465912045298;9480.668176613786;9655.855162172573;9685.806283874424;9702.27232957531;368903.1554842209;374189;376688;377921;383572;50120;64880.05359839212;79403.20596793958;79708;79937.20062799414;897.7576054465258;898.6854600889767;911.8814554107923;927.2535608834818;928.2573940847295;15003.174825384272;15038.398464061314;15073.547793566211;15198.696026079195;15490.07059576429;35471.82264088663;35621.46567801537;36023.819880900424;36291.81854090712;36817.26365472729;50985.490145098076;51639.48360516347;51739.528041191064;51928.48071519387;52054;7307.086614173229;7380.409567234716;7390.630468476662;7495.737649182252;7506.737264195727;10873.130149588173;11349.14881383883;11441.542338306375;11507.712307192387;11739.823902641638;10124.59501619927;10129.290949633749;10279.434631095362;10299.558061871194;10400.27198096126;9477.478738669439;9591.088846559845;9592.856107158537;9632.181264592307;9667.468289243878;9579.089986451276;9621.663241786504;9743.561539730586;10338.948305258426;10606.681799546026;7449.6275186241555;7474.402047836052;7538.170801211972;7572.886406704014;7619.047619047619;8641.654333826827;9107.408018478778;9111.088891110836;9618.807623847624;10048.246381521269 00:05:23 INFO - PROCESS | 19622 | |3;mootools.html;1378.5244090788678;1416.362636813434;1437.8562143785616;1633.9509814705564;1665.6335606166654;6519.185101862267;7278.81802954925;7279.672414741336;7754.37964962803;7762.262585054418;7432.628368581576;7577.772666820004;7630.198829122945;7651.84696306075;7665;2170.4248374180816;2206.3491270075288;2209.7458792238936;2210.5689390568846;2212.668099785029;2127.3405244374294;2168.111074459472;2200.0869639099756;2205.44863784054;2205.4596623827183;2162.383720639618;2171.6416791229426;2172.869627822328;2187.4093994621444;2211.6793065005563;2169.772173921739;2197.8021978022057;2200.9449763755874;2202.0751284460566;2202.361315218585;2141.7858214178614;2166.393409845246;2169.197396963118;2171.0881429799365;2174.662927246279;7604.125525564576;7646.350060244886;7653.119891212526;7688.115866675292;7696.268854458817;4378.277584198603;4506.8873278167985;4517.435320584927;4545.272756358967;4549.340345649863;2769.9446011079867;2877.9136625901256;2899.594056832045;2939.4562006028955;2949.911502654924;915.9542022898895;952.6522819171022;953.4088864903734;963.7301555564453;1000.1248907206194;9726.881408638026;9768.21854251658;9778.119969202806;9782.413055216639;9799.11807937282;3927.6465118139504;4051.858184963571;4087.3255912774653;4088.4684990950987;4116.732412393185;8536.8719469208;8569.914300857037;8615.310775137974;8616.526091064927;8624.741257762276;4482.439695038121;4485.596296333346;4487.214737420938;4492.73043617384;4494.438195225597;3662.633736626316;3960.2871483133313;4024.7182697210915;4054.7769872657286;4158.688098392633;3510.9297814043575;3570;3621.492990981265;3651.1054791576234;3658.5243918290985;1152.1704372851534;1208.3716467436884;1220.267839296415;1223.8103094020441;1227.2636418149038;789.2659826361424;809.1463506001107;825.3809642767924;833.021200089892;836.6041611877165;4914.70511769295;5003.399592048904;5024.598032157492;5040.722760248148;5046.545810877039;370.7775334799099;393.7932585392692;399.3729844144723;409.70091832962106;410.1284769864039;3218.2758879251983;3275.4595491743594;3294.7034766871097;3309.040378290269;3348.2466445049668;8876.955615221883;9235.12266334697;9249.953750231205;9259.583318750538;9322.627094916263;8870.379073464796;9061.954690226507;9075.909240907638;9179.357444978787;9192.908070919206;6993.370596646327;7004;7024.683889225099;7075.115610548682;7103.183133939559;4615.699979501322;4722.693024953367;4733.100710864925;4789.090072886141;4790.161721698759;8411.242988131098;8477.067522572388;8567.143285671384;8614.138586141336;8642.740717778224;8649.56752162402;8706.434081784664;8711.912880871363;8714.956425217833;8795.956020219857;5804.390538993345;6110.816675499742;6390.105385245976;6398.104265402941;6462.3537646235;7141.85716285661;7164.176119746087;7167.3549380556;7210.855782884418;7273.8908916365235;6015.548833837567;6093.299270583762;6116.847078823065;6221.47117495018;6247.625142491465;6103.664298463627;6113.786017489367;6114.144019837316;6225.595336303126;6284.277308109626;5977.073553599199;6060.303065147565;6075.635461872302;6085;6110.7250173741395;3986.5016872890887;4036.3340048891605;4050.432939388547;4075.3071977763257;4170.040890595119;4060.0864805418546;4060.878173654677;4112.362583799516;4121.423000779953;4122.670186385142 00:05:23 INFO - PROCESS | 19622 | |4;prototype.html;277.067667299537;277.71534177468095;285.32947573202966;289.5483046447542;290.4582952793039;4919.70481771094;4933.333999910011;5026.723530205837;5119.334486516752;5139.794408223666;4999.775010124544;5001.899962000758;5016.523430274127;5018.9749051254785;5033;4012.418199361091;4018.5378681451716;4028.7179897407195;4032.8588499402526;4033.838646454138;3869;4012.9197416051807;4042.3724579023574;4053.3717273822604;4067.2678917794783;3939.5666476687543;3941.960580394202;3955.46601208836;3958.4260282259056;3984.8406063757416;3952.1898010907694;3953.802309884494;3965.1871366369824;3966.484357033596;4015.538213105501;3474.801193588208;3479.408500554912;3483.529723487322;3503.5490042308306;3519.6480351964856;4834.444038935532;4907.067657145167;4920.434150072751;4925.630577706651;4980.352554167971;4501.257292546758;4513.458384993789;4519.864404067883;4536.092781443692;4544.295634176708;5278.340207474066;5289.3123893893935;5350.886399872068;5380.623356365056;5412.890357476708;3480.843362048714;3683.723720720957;3690.3541880171133;3882.4758657581147;3895.844166233347;5471.972640136813;5522.282103326582;5523.309586301712;5560.221568980346;5596.4403559644115;3725.4598083278315;3726.9813650931574;3729.198222382201;3731.7014638828828;3737.4767532545466;3554.289142171576;3760.8683696070507;3778.3576791945434;3789.2800367930004;3799.373103437957;4334.393184954109;4337.544557821383;4346.47842258931;4350.412694286294;4373.059792144704;5338;5341.519263266325;5365.892682146336;5386.703731294817;5422.945770542323;1236.6829326766965;1328.2561765411401;1355.7762969110183;1361.3057340756286;1366.7334869700312;845.2392846438255;853.3557164340883;861.8362511122866;866.2680035370103;878.7759121423996;4129.318662420667;4162.687798415131;4202.306619407764;4210.578942105826;4212.925703945474;4851.854444366674;4889.339939108246;4902.583280421133;4909.674387915243;4913.631477639191;4120.340745480708;4127.4015267786;4145.813438395279;4156.854510092132;4211.263028969918;2500.4749002709636;2583.922482325496;2591.2744431559195;2603.635491031257;2604.570245909442;4514.25514790056;4559.99680070384;4607.170709272363;4620.168369693421;4633.8841528961375;4984.327115839388;5006.274090256965;5006.3992320921;5009.974950125299;5043.5712964398435;4423.668224883147;4528.230200865861;4537.410136682211;4572.81708731647;4574.725516468956;4826.8069277228515;4846.95153048465;4855.95144048555;4872.9512704872495;4894;4733.5266473352385;4749.335093086902;4789.8323558676675;4796.328514008112;4802.926127278474;4389.7489215573405;4473.261911784519;4565.452145742533;4603.401557797465;4613.953860461486;3543.344481270973;3560.643935606419;3571.178628915312;3580.534530511017;3584.7849129052343;4817.253325734517;4825.3485779420735;4900.240462728283;4918.2294374024605;5087;5206.062908676475;5324.1747529133045;5335.786568537215;5341.768230220816;5374.193870919394;5294.205869119663;5306.204069389468;5325.147976323925;5336.199570064521;5362.517373436253;5166.844994650167;5181.870453238548;5238.214267859851;5259.8422047338645;5292.867678308073;5310.256564080954;5340.359156901197;5386.461353864583;5401.810936617199;5412.269343638716;5234.162533994542;5236.973815131052;5241.449647786927;5272.472752724697;5274.7098909560345 00:05:23 INFO - PROCESS | 19622 | |5;yui.html;591.7011908985961;632.6976559396105;639.4532674563247;643.5559463969861;654.9050387693785;11546.191766576343;12685.746285074305;13135.868641313597;13192.934035329821;13964.162150270991;13563.932180339085;13886.30568471575;13905.235212063333;14003;14052.437902483889;797.2784629909941;807.019471342319;810.1736229046369;810.9270165685087;812.7927378518469;789.2423273657296;793.761871438569;795.3358945280697;795.7135431244776;796.9840603187932;817.807815163439;831.2975535672347;832.883396324515;833.3291700181352;836.6611522333434;821.5892053973014;825.5789547330844;832.6835802395082;832.7959649885756;833.4999000599653;614.4070971512512;615.5937081526216;617.9412955769195;618.5979113576167;618.9690515474208;12442.751144977141;12762.106652534327;13165.210087394787;13188.86811131886;13205.867941320656;13053.80419293702;13654.726905461934;13761.724765504734;13948.02363834532;14051.859481405158;10190.388576685422;10329.638462653846;10506.579736810518;10621.628243011535;10627.202959778047;3280.4587243105098;3376.4935259710996;3389.3390788796196;3390.677885600864;3449.6722811332884;59960.400395995915;60585.39414605842;61255.693721531556;61476.692616537075;61731;10412.427316497513;10659.413732244646;10689.251752377259;10765.30025548337;10765.89234107649;20232.393028208884;20269.797302026793;20541.281055163297;20548.58902821935;20637.071331790106;7040.6479676016;7069.399101076363;7130.893036604455;7149.857002859913;7279.090113735783;3778.6599206071587;3869.28418242626;3897.395903634941;3916.1971795781797;3936.4292177634657;2863.498887694687;2970.1386597886803;2973.405318936221;2974.6133002709944;2987.9402411951637;483.13036534238233;494.74273377844037;507.13027158422744;509.7960815673686;516.0144124721763;508.51182864450544;511.7236692186178;542.2164971616056;596.7374355283662;653.9280679125293;7256.673449694671;7542.170361260257;7669.247567996757;7804.609769511501;8001.559914204775;449.4673811533344;546.6938514431931;549.5383877542884;571.9542436605061;613.2518327640272;3858.151206734514;3917.5298964124486;3963.1083006323347;3989.162275922089;4094.160697057096;89889.55055224813;92537.53731231435;93053;93449.5327523358;94452;76110.61944690353;78558.21441785623;79974.20025799784;80806.59596701979;82154.17845821584;44554.55445445504;45383.31925021127;67773.66113169403;69926.300736993;76363;7402.888956665762;7565.962170189114;7587.620618968919;7625.8856117157175;7632;37809.62190378171;40301.39547906842;42491;42615.36076958786;42616.57383426126;38470.80764596159;39869.60130398775;60735.69632151811;61917.45206369697;62051;11327.886721133013;11462.369569673749;11641.243319184226;11741.17811753169;11837.46731397072;12424.503019879103;12785.36073196355;13207.66980825487;13394.129381590166;13404;11823.76352472963;11916.52333906634;12092.214006089576;12229.93885030569;12389.132760706663;12490;12548.30984295836;12569.622911312676;12570.937145314216;13080.80378794338;12096.697582560506;12152;12181.939090304491;12289.877101228873;12421.93789031049;9945.900540994497;10133.240006999356;10329.173666106844;10371.222158338003;10585.364878107339;10170.08469237772;10398.844017339898;10431.895681043396;10475.214358923264;10609.098226650513 00:05:23 INFO - PROCESS | 19622 | __end_tp_report 00:05:23 INFO - PROCESS | 19622 | __start_cc_report 00:05:23 INFO - PROCESS | 19622 | _x_x_mozilla_cycle_collect,416 00:05:23 INFO - PROCESS | 19622 | __end_cc_report 00:05:23 INFO - PROCESS | 19622 | __startTimestamp1465974323274__endTimestamp 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | ------- Summary: start ------- 00:05:23 INFO - PROCESS | 19622 | Number of tests: 6 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | [#0] dojo.html Cycles:165 Average:4759.60 Median:4928.93 stddev:604.69 (12.3%) stddev-sans-first:581.76 00:05:23 INFO - PROCESS | 19622 | Values: 2575.3 2644.5 2689.1 2693.8 2698.8 4772.5 4784.3 4824.5 4860.3 4928.9 4683.2 4693.8 4700.6 4808.6 4866.3 4423.5 4478.6 4542.1 4560.3 4609.7 568.6 4317.0 4389.0 4410.5 4424.4 4408.6 4456.4 4468.3 4470.1 4502.1 4465.7 4468.1 4475.8 4478.8 4500.1 4296.6 4376.0 4411.6 4422.5 4458.6 4753.5 4837.8 4843.1 4852.7 4852.7 5111.6 5180.2 5185.7 5211.8 5275.1 5192.5 5222.5 5228.9 5238.8 5274.7 4808.0 4836.8 4861.4 4867.8 4904.7 5026.4 5228.2 5229.2 5322.9 5325.7 5074.8 5075.9 5077.9 5093.5 5110.2 5156.9 5171.7 5177.1 5185.9 5225.3 5027.5 5115.5 5133.4 5163.2 5193.5 5159.7 5160.5 5169.3 5176.9 5177.9 4415.6 4419.0 4425.5 4448.7 4487.3 3720.2 3761.0 3823.0 3838.5 3838.8 4344.2 4419.3 4464.9 4489.1 4506.5 5229.3 5233.7 5238.2 5240.5 5305.3 4290.9 4470.3 4480.7 4510.8 4538.3 4742.9 4744.1 4744.5 4747.3 4800.5 4875.9 4936.6 4940.0 4948.6 4986.4 5096.6 5123.6 5180.6 5181.8 5181.9 4809.2 4825.2 4844.9 4892.7 4897.8 4986.4 5153.5 5153.5 5165.0 5165.5 5112.3 5121.1 5145.7 5161.3 5208.2 5005.3 5017.0 5020.9 5030.0 5048.2 4950.0 4988.8 5003.6 5017.3 5056.4 4949.3 4988.3 4992.9 5011.3 5052.1 5119.9 5122.3 5123.9 5124.5 5156.3 4850.6 4892.8 4925.8 4951.0 5016.0 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | [#1] ext.html Cycles:180 Average:45437.71 Median:18666.80 stddev:91098.06 (488.0%) stddev-sans-first:91291.24 00:05:23 INFO - PROCESS | 19622 | Values: 539.2 565.1 587.9 597.5 604.9 35021.3 38495.2 38583.6 38587.6 38749.2 33221.8 33237.3 33280.7 33322.2 33499.7 7541.2 7714.3 7730.5 7755.8 7756.9 7742.1 7766.2 7837.5 7853.9 7888.8 7865.2 7899.6 7899.8 7904.2 7929.9 7871.0 7880.0 7884.8 7892.8 7909.2 7620.7 7698.3 7707.4 7740.0 7742.8 36753.4 36875.1 36885.8 37008.0 37132.6 2572.3 2939.2 2970.5 3130.2 3146.8 27415.6 27527.3 28067.2 28391.6 28808.9 3323.8 3334.9 3344.6 3354.2 3395.8 207543.0 208763.0 209353.0 209516.0 209962.0 28160.2 31341.8 31636.8 31638.2 31649.0 33778.7 33832.3 33937.8 33961.5 34006.8 13068.8 13156.7 13244.6 13255.4 13271.3 10647.2 10680.6 10691.3 10717.4 10726.2 7893.2 7893.6 7899.9 7986.2 7988.3 3119.2 3123.1 3152.4 3155.9 3164.3 867.4 873.0 886.3 913.9 1030.4 26718.0 27705.4 27950.2 27952.9 28202.9 940.7 963.3 977.4 1015.5 1078.7 14247.9 14797.3 14935.4 14946.6 14959.8 381869.0 426785.0 435633.9 437077.0 650090.0 48273.5 48741.8 48849.5 48989.8 49098.0 1187.2 1197.4 1202.5 1204.8 1213.5 26938.2 27819.6 28281.9 28439.3 28572.9 40762.6 41294.0 41413.0 41441.0 41486.6 280376.0 281996.0 283819.0 284663.0 285460.0 25318.5 25626.2 25701.0 25854.4 25937.4 39542.8 40402.8 40503.1 41005.4 42205.2 35554.5 36142.5 36516.5 36564.0 36665.6 35371.3 35602.5 35634.8 35839.1 36004.1 33150.7 34959.8 35091.3 35315.5 36010.0 31692.7 32553.6 33207.8 33274.7 33574.3 25290.5 25295.9 25437.5 25508.5 26076.5 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | [#2] jquery.html Cycles:180 Average:23467.41 Median:5056.36 stddev:62039.36 (1227.0%) stddev-sans-first:62189.14 00:05:23 INFO - PROCESS | 19622 | Values: 360.0 361.0 365.6 377.2 380.9 15715.5 16115.8 16475.9 16984.1 17027.0 15734.8 15980.7 16768.2 16806.3 16908.2 5039.8 5265.7 5278.6 5284.3 5290.3 5176.9 5194.2 5256.7 5274.9 5283.0 5072.9 5213.2 5220.3 5221.2 5239.1 5113.8 5118.7 5163.0 5192.8 5194.6 4505.3 4576.4 4585.7 4601.2 4615.6 19766.3 19918.0 20496.6 20545.9 20591.2 1947.2 2000.9 2043.5 2085.5 2384.5 10926.5 11998.9 12859.4 12931.5 13438.1 1721.4 1749.1 1778.1 1781.7 1798.3 48773.8 62659.0 67651.7 68471.3 68567.7 9497.5 9517.7 9542.5 9597.4 9682.5 12768.3 12799.2 12927.4 12993.1 13062.6 6941.2 6985.9 7007.2 7031.2 7125.9 6478.1 6479.0 6608.5 6617.6 6626.8 3932.9 4018.6 4088.3 4116.8 4366.4 1790.5 1823.7 1858.5 1860.8 1869.7 783.1 835.6 847.1 863.7 877.0 15985.4 16791.9 17076.9 17227.9 17284.9 836.4 851.4 870.0 889.3 925.2 8901.5 9480.7 9655.9 9685.8 9702.3 368903.2 374189.0 376688.0 377921.0 383572.0 50120.0 64880.1 79403.2 79708.0 79937.2 897.8 898.7 911.9 927.3 928.3 15003.2 15038.4 15073.5 15198.7 15490.1 35471.8 35621.5 36023.8 36291.8 36817.3 50985.5 51639.5 51739.5 51928.5 52054.0 7307.1 7380.4 7390.6 7495.7 7506.7 10873.1 11349.1 11441.5 11507.7 11739.8 10124.6 10129.3 10279.4 10299.6 10400.3 9477.5 9591.1 9592.9 9632.2 9667.5 9579.1 9621.7 9743.6 10338.9 10606.7 7449.6 7474.4 7538.2 7572.9 7619.0 8641.7 9107.4 9111.1 9618.8 10048.2 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | [#3] mootools.html Cycles:180 Average:4882.96 Median:4852.43 stddev:2717.41 (56.0%) stddev-sans-first:2712.28 00:05:23 INFO - PROCESS | 19622 | Values: 1378.5 1416.4 1437.9 1634.0 1665.6 6519.2 7278.8 7279.7 7754.4 7762.3 7432.6 7577.8 7630.2 7651.8 7665.0 2170.4 2206.3 2209.7 2210.6 2212.7 2127.3 2168.1 2200.1 2205.4 2205.5 2162.4 2171.6 2172.9 2187.4 2211.7 2169.8 2197.8 2200.9 2202.1 2202.4 2141.8 2166.4 2169.2 2171.1 2174.7 7604.1 7646.4 7653.1 7688.1 7696.3 4378.3 4506.9 4517.4 4545.3 4549.3 2769.9 2877.9 2899.6 2939.5 2949.9 916.0 952.7 953.4 963.7 1000.1 9726.9 9768.2 9778.1 9782.4 9799.1 3927.6 4051.9 4087.3 4088.5 4116.7 8536.9 8569.9 8615.3 8616.5 8624.7 4482.4 4485.6 4487.2 4492.7 4494.4 3662.6 3960.3 4024.7 4054.8 4158.7 3510.9 3570.0 3621.5 3651.1 3658.5 1152.2 1208.4 1220.3 1223.8 1227.3 789.3 809.1 825.4 833.0 836.6 4914.7 5003.4 5024.6 5040.7 5046.5 370.8 393.8 399.4 409.7 410.1 3218.3 3275.5 3294.7 3309.0 3348.2 8877.0 9235.1 9250.0 9259.6 9322.6 8870.4 9062.0 9075.9 9179.4 9192.9 6993.4 7004.0 7024.7 7075.1 7103.2 4615.7 4722.7 4733.1 4789.1 4790.2 8411.2 8477.1 8567.1 8614.1 8642.7 8649.6 8706.4 8711.9 8715.0 8796.0 5804.4 6110.8 6390.1 6398.1 6462.4 7141.9 7164.2 7167.4 7210.9 7273.9 6015.5 6093.3 6116.8 6221.5 6247.6 6103.7 6113.8 6114.1 6225.6 6284.3 5977.1 6060.3 6075.6 6085.0 6110.7 3986.5 4036.3 4050.4 4075.3 4170.0 4060.1 4060.9 4112.4 4121.4 4122.7 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | [#4] prototype.html Cycles:180 Average:4229.41 Median:4605.29 stddev:1232.89 (26.8%) stddev-sans-first:1200.12 00:05:23 INFO - PROCESS | 19622 | Values: 277.1 277.7 285.3 289.5 290.5 4919.7 4933.3 5026.7 5119.3 5139.8 4999.8 5001.9 5016.5 5019.0 5033.0 4012.4 4018.5 4028.7 4032.9 4033.8 3869.0 4012.9 4042.4 4053.4 4067.3 3939.6 3942.0 3955.5 3958.4 3984.8 3952.2 3953.8 3965.2 3966.5 4015.5 3474.8 3479.4 3483.5 3503.5 3519.6 4834.4 4907.1 4920.4 4925.6 4980.4 4501.3 4513.5 4519.9 4536.1 4544.3 5278.3 5289.3 5350.9 5380.6 5412.9 3480.8 3683.7 3690.4 3882.5 3895.8 5472.0 5522.3 5523.3 5560.2 5596.4 3725.5 3727.0 3729.2 3731.7 3737.5 3554.3 3760.9 3778.4 3789.3 3799.4 4334.4 4337.5 4346.5 4350.4 4373.1 5338.0 5341.5 5365.9 5386.7 5422.9 1236.7 1328.3 1355.8 1361.3 1366.7 845.2 853.4 861.8 866.3 878.8 4129.3 4162.7 4202.3 4210.6 4212.9 4851.9 4889.3 4902.6 4909.7 4913.6 4120.3 4127.4 4145.8 4156.9 4211.3 2500.5 2583.9 2591.3 2603.6 2604.6 4514.3 4560.0 4607.2 4620.2 4633.9 4984.3 5006.3 5006.4 5010.0 5043.6 4423.7 4528.2 4537.4 4572.8 4574.7 4826.8 4847.0 4856.0 4873.0 4894.0 4733.5 4749.3 4789.8 4796.3 4802.9 4389.7 4473.3 4565.5 4603.4 4614.0 3543.3 3560.6 3571.2 3580.5 3584.8 4817.3 4825.3 4900.2 4918.2 5087.0 5206.1 5324.2 5335.8 5341.8 5374.2 5294.2 5306.2 5325.1 5336.2 5362.5 5166.8 5181.9 5238.2 5259.8 5292.9 5310.3 5340.4 5386.5 5401.8 5412.3 5234.2 5237.0 5241.4 5272.5 5274.7 00:05:23 INFO - PROCESS | 19622 | 00:05:23 INFO - PROCESS | 19622 | [#5] yui.html Cycles:180 Average:16881.20 Median:22145.28 stddev:23274.87 (105.1%) stddev-sans-first:23308.02 00:05:23 INFO - PROCESS | 19622 | Values: 591.7 632.7 639.5 643.6 654.9 11546.2 12685.7 13135.9 13192.9 13964.2 13563.9 13886.3 13905.2 14003.0 14052.4 797.3 807.0 810.2 810.9 812.8 789.2 793.8 795.3 795.7 797.0 817.8 831.3 832.9 833.3 836.7 821.6 825.6 832.7 832.8 833.5 614.4 615.6 617.9 618.6 619.0 12442.8 12762.1 13165.2 13188.9 13205.9 13053.8 13654.7 13761.7 13948.0 14051.9 10190.4 10329.6 10506.6 10621.6 10627.2 3280.5 3376.5 3389.3 3390.7 3449.7 59960.4 60585.4 61255.7 61476.7 61731.0 10412.4 10659.4 10689.3 10765.3 10765.9 20232.4 20269.8 20541.3 20548.6 20637.1 7040.6 7069.4 7130.9 7149.9 7279.1 3778.7 3869.3 3897.4 3916.2 3936.4 2863.5 2970.1 2973.4 2974.6 2987.9 483.1 494.7 507.1 509.8 516.0 508.5 511.7 542.2 596.7 653.9 7256.7 7542.2 7669.2 7804.6 8001.6 449.5 546.7 549.5 572.0 613.3 3858.2 3917.5 3963.1 3989.2 4094.2 89889.6 92537.5 93053.0 93449.5 94452.0 76110.6 78558.2 79974.2 80806.6 82154.2 44554.6 45383.3 67773.7 69926.3 76363.0 7402.9 7566.0 7587.6 7625.9 7632.0 37809.6 40301.4 42491.0 42615.4 42616.6 38470.8 39869.6 60735.7 61917.5 62051.0 11327.9 11462.4 11641.2 11741.2 11837.5 12424.5 12785.4 13207.7 13394.1 13404.0 11823.8 11916.5 12092.2 12229.9 12389.1 12490.0 12548.3 12569.6 12570.9 13080.8 12096.7 12152.0 12181.9 12289.9 12421.9 9945.9 10133.2 10329.2 10371.2 10585.4 10170.1 10398.8 10431.9 10475.2 10609.1 00:05:23 INFO - PROCESS | 19622 | -------- Summary: end -------- 00:05:23 INFO - PROCESS | 19622 | 00:05:24 INFO - TEST-INFO | 19622: exit 0 00:05:24 INFO - TEST-OK | dromaeo_css | took 1116862ms 00:05:24 INFO - TEST-START | kraken 00:05:24 INFO - operating with platform_type : linux_ 00:05:24 INFO - Initialising browser for kraken test... 00:05:24 INFO - TEST-INFO | started process 19860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeEXkGZ/profile http://localhost:44380/getInfo.html) 00:05:29 INFO - PROCESS | 19860 | __metrics Screen width/height:1600/1200 00:05:29 INFO - PROCESS | 19860 | colorDepth:24 00:05:29 INFO - PROCESS | 19860 | Browser inner width/height: 1024/697 00:05:29 INFO - PROCESS | 19860 | __metrics 00:05:29 ERROR - PROCESS | 19860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 00:05:30 INFO - TEST-INFO | 19860: exit 0 00:05:30 INFO - Browser initialized. 00:05:30 INFO - Running cycle 1/1 for kraken test... 00:05:30 INFO - TEST-INFO | started process 19978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeEXkGZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:05:43 INFO - PROCESS | 19978 | RSS: Main: 186748928 00:05:43 INFO - PROCESS | 19978 | 00:05:45 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44380/tests/kraken/driver.html?testName=audio-beat-detection) 00:05:46 INFO - PROCESS | 19978 | RSS: Main: 191279104 00:05:46 INFO - PROCESS | 19978 | 00:05:49 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44380/tests/kraken/driver.html?testName=audio-dft) 00:05:50 INFO - PROCESS | 19978 | RSS: Main: 191062016 00:05:50 INFO - PROCESS | 19978 | 00:05:53 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44380/tests/kraken/driver.html?testName=audio-fft) 00:05:53 INFO - PROCESS | 19978 | RSS: Main: 186777600 00:05:53 INFO - PROCESS | 19978 | 00:05:55 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44380/tests/kraken/driver.html?testName=audio-oscillator) 00:05:56 INFO - PROCESS | 19978 | RSS: Main: 187613184 00:05:56 INFO - PROCESS | 19978 | 00:05:58 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:05:59 INFO - PROCESS | 19978 | RSS: Main: 187817984 00:05:59 INFO - PROCESS | 19978 | 00:06:02 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44380/tests/kraken/driver.html?testName=imaging-darkroom) 00:06:03 INFO - PROCESS | 19978 | RSS: Main: 187617280 00:06:03 INFO - PROCESS | 19978 | 00:06:06 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44380/tests/kraken/driver.html?testName=imaging-desaturate) 00:06:07 INFO - PROCESS | 19978 | RSS: Main: 185503744 00:06:07 INFO - PROCESS | 19978 | 00:06:10 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44380/tests/kraken/driver.html?testName=json-parse-financial) 00:06:10 INFO - PROCESS | 19978 | RSS: Main: 186331136 00:06:10 INFO - PROCESS | 19978 | 00:06:12 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:06:13 INFO - PROCESS | 19978 | RSS: Main: 186736640 00:06:13 INFO - PROCESS | 19978 | 00:06:15 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:06:15 INFO - PROCESS | 19978 | RSS: Main: 186757120 00:06:15 INFO - PROCESS | 19978 | 00:06:17 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:06:18 INFO - PROCESS | 19978 | RSS: Main: 187621376 00:06:18 INFO - PROCESS | 19978 | 00:06:21 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:06:22 INFO - PROCESS | 19978 | RSS: Main: 187699200 00:06:22 INFO - PROCESS | 19978 | 00:06:25 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:06:25 INFO - PROCESS | 19978 | RSS: Main: 187019264 00:06:25 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | Cycle 1(1): loaded http://localhost:44380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44380/tests/kraken/driver.html?testName=ai-astar) 00:06:27 INFO - PROCESS | 19978 | RSS: Main: 188055552 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | __start_tp_report 00:06:27 INFO - PROCESS | 19978 | _x_x_mozilla_page_load 00:06:27 INFO - PROCESS | 19978 | _x_x_mozilla_page_load_details 00:06:27 INFO - PROCESS | 19978 | |i|pagename|runs| 00:06:27 INFO - PROCESS | 19978 | |0;ai-astar;114;108;118;114;116;115;115;113;114;114 00:06:27 INFO - PROCESS | 19978 | |1;audio-beat-detection;157;133;168;189;148;165;161;132;192;142 00:06:27 INFO - PROCESS | 19978 | |2;audio-dft;171;182;173;164;162;163;163;163;163;164 00:06:27 INFO - PROCESS | 19978 | |3;audio-fft;78;76;78;171;77;76;77;77;159;77 00:06:27 INFO - PROCESS | 19978 | |4;audio-oscillator;87;87;149;87;88;88;136;88;87;129 00:06:27 INFO - PROCESS | 19978 | |5;imaging-gaussian-blur;120;118;117;117;117;118;118;118;122;118 00:06:27 INFO - PROCESS | 19978 | |6;imaging-darkroom;148;148;148;149;148;150;149;148;147;149 00:06:27 INFO - PROCESS | 19978 | |7;imaging-desaturate;95;96;98;95;96;96;96;96;95;96 00:06:27 INFO - PROCESS | 19978 | |8;json-parse-financial;64;68;67;62;64;65;64;65;64;64 00:06:27 INFO - PROCESS | 19978 | |9;json-stringify-tinderbox;64;66;65;65;65;65;65;65;64;65 00:06:27 INFO - PROCESS | 19978 | |10;stanford-crypto-aes;83;86;86;86;85;85;86;91;110;86 00:06:27 INFO - PROCESS | 19978 | |11;stanford-crypto-ccm;135;149;134;129;137;133;140;132;156;135 00:06:27 INFO - PROCESS | 19978 | |12;stanford-crypto-pbkdf2;166;169;174;174;168;168;170;168;167;173 00:06:27 INFO - PROCESS | 19978 | |13;stanford-crypto-sha256-iterative;71;69;68;68;69;67;71;67;68;67 00:06:27 INFO - PROCESS | 19978 | __end_tp_report 00:06:27 INFO - PROCESS | 19978 | __start_cc_report 00:06:27 INFO - PROCESS | 19978 | _x_x_mozilla_cycle_collect,958 00:06:27 INFO - PROCESS | 19978 | __end_cc_report 00:06:27 INFO - PROCESS | 19978 | __startTimestamp1465974387679__endTimestamp 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | ------- Summary: start ------- 00:06:27 INFO - PROCESS | 19978 | Number of tests: 14 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:2.56 (2.2%) stddev-sans-first:2.71 00:06:27 INFO - PROCESS | 19978 | Values: 114.0 108.0 118.0 114.0 116.0 115.0 115.0 113.0 114.0 114.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#1] audio-beat-detection Cycles:10 Average:158.70 Median:163.00 stddev:20.89 (12.8%) stddev-sans-first:22.15 00:06:27 INFO - PROCESS | 19978 | Values: 157.0 133.0 168.0 189.0 148.0 165.0 161.0 132.0 192.0 142.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#2] audio-dft Cycles:10 Average:166.80 Median:164.00 stddev:6.53 (4.0%) stddev-sans-first:6.75 00:06:27 INFO - PROCESS | 19978 | Values: 171.0 182.0 173.0 164.0 162.0 163.0 163.0 163.0 163.0 164.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.00 stddev:37.22 (48.3%) stddev-sans-first:38.99 00:06:27 INFO - PROCESS | 19978 | Values: 78.0 76.0 78.0 171.0 77.0 76.0 77.0 77.0 159.0 77.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:87.00 stddev:24.90 (28.6%) stddev-sans-first:25.76 00:06:27 INFO - PROCESS | 19978 | Values: 87.0 87.0 149.0 87.0 88.0 88.0 136.0 88.0 87.0 129.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.57 (1.3%) stddev-sans-first:1.54 00:06:27 INFO - PROCESS | 19978 | Values: 120.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 122.0 118.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 00:06:27 INFO - PROCESS | 19978 | Values: 148.0 148.0 148.0 149.0 148.0 150.0 149.0 148.0 147.0 149.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 00:06:27 INFO - PROCESS | 19978 | Values: 95.0 96.0 98.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.50 stddev:1.70 (2.6%) stddev-sans-first:1.79 00:06:27 INFO - PROCESS | 19978 | Values: 64.0 68.0 67.0 62.0 64.0 65.0 64.0 65.0 64.0 64.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 00:06:27 INFO - PROCESS | 19978 | Values: 64.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:86.00 stddev:7.85 (9.1%) stddev-sans-first:8.08 00:06:27 INFO - PROCESS | 19978 | Values: 83.0 86.0 86.0 86.0 85.0 85.0 86.0 91.0 110.0 86.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:136.00 stddev:8.34 (6.1%) stddev-sans-first:8.77 00:06:27 INFO - PROCESS | 19978 | Values: 135.0 149.0 134.0 129.0 137.0 133.0 140.0 132.0 156.0 135.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:169.50 stddev:2.95 (1.7%) stddev-sans-first:2.80 00:06:27 INFO - PROCESS | 19978 | Values: 166.0 169.0 174.0 174.0 168.0 168.0 170.0 168.0 167.0 173.0 00:06:27 INFO - PROCESS | 19978 | 00:06:27 INFO - PROCESS | 19978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.51 (2.2%) stddev-sans-first:1.30 00:06:27 INFO - PROCESS | 19978 | Values: 71.0 69.0 68.0 68.0 69.0 67.0 71.0 67.0 68.0 67.0 00:06:27 INFO - PROCESS | 19978 | -------- Summary: end -------- 00:06:27 INFO - PROCESS | 19978 | 00:06:28 INFO - TEST-INFO | 19978: exit 0 00:06:28 INFO - TEST-OK | kraken | took 64855ms 00:06:28 INFO - SUITE-END | took 1181s 00:06:29 INFO - Completed test suite (00:19:42) 00:06:29 INFO - javascript benchmark 00:06:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6247.211001616659, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.30466773971, 2644.537205988952, 2689.058829409708, 2693.838369697818, 2698.784097272217, 4772.498887616803, 4784.306275590037, 4824.46930837608, 4860.343853579766, 4928.926066109011, 4683.180443422404, 4693.8357157499495, 4700.6004489618335, 4808.615310775138, 4866.31871537985, 4423.513413524518, 4478.552144785528, 4542.068875880453, 4560.33875088112, 4609.67732258742, 568.6032498692153, 4316.978415107936, 4389.0, 4410.492793328776, 4424.358468022135, 4408.603225709701, 4456.376107344974, 4468.3074123510905, 4470.061287129706, 4502.144592527442, 4465.732056076613, 4468.061707041526, 4475.7985890635, 4478.77606119696, 4500.054988452429, 4296.63478604319, 4376.0, 4411.602955733999, 4422.469303683579, 4458.554144585515, 4753.524647535253, 4837.806487740486, 4843.128236917353, 4852.708837469728, 4852.733099679516, 5111.591072714174, 5180.248863914749, 5185.662931909414, 5211.765470553796, 5275.050490911634, 5192.454792246797, 5222.503862133091, 5228.895422091537, 5238.816641417532, 5274.736263186825, 4808.0, 4836.830710925136, 4861.416630004422, 4867.829625963074, 4904.6566740327835, 5026.396832380065, 5228.215767634809, 5229.241759944786, 5322.946770532322, 5325.733713314319, 5074.771635276422, 5075.8984820303385, 5077.923831142536, 5093.465186155475, 5110.207917772751, 5156.871078222999, 5171.663841850343, 5177.094008548489, 5185.870353241199, 5225.320708307896, 5027.4721154279005, 5115.488451154929, 5133.4096578893905, 5163.225516172529, 5193.532582067556, 5159.742012899415, 5160.509751573594, 5169.302144210558, 5176.870578235499, 5177.896442071137, 4415.62467190286, 4419.005723712139, 4425.513193548707, 4448.666350023761, 4487.282034874404, 3720.2187540616774, 3760.981195094007, 3822.9869084692577, 3838.539375274929, 3838.788866612363, 4344.218040752632, 4419.270820314612, 4464.888377790581, 4489.124620698998, 4506.504284528699, 5229.346331708536, 5233.685978841282, 5238.240455133984, 5240.528352448222, 5305.336832895888, 4290.892727681833, 4470.284754439274, 4480.686351955397, 4510.797014134372, 4538.341940418621, 4742.928856067162, 4744.098621261949, 4744.5492678195515, 4747.264174053027, 4800.5199480052415, 4875.878103047381, 4936.580390666833, 4939.950600494093, 4948.604111671058, 4986.376702912136, 5096.566791822736, 5123.590112791042, 5180.61145414103, 5181.792728290826, 5181.870453238699, 4809.2064809306075, 4825.179719447772, 4844.927326090041, 4892.706437613754, 4897.779599917941, 4986.351774269322, 5153.50003981844, 5153.5361817436615, 5165.0, 5165.483451654804, 5112.309838171799, 5121.103806833864, 5145.691258524501, 5161.3032240647035, 5208.244804503402, 5005.324281222134, 5017.046761115376, 5020.874478138076, 5030.0, 5048.242763585492, 4949.950500494949, 4988.825391111293, 5003.649744517848, 5017.297578338962, 5056.443791183041, 4949.257611358325, 4988.301637770787, 4992.900141997213, 5011.323471331323, 5052.065367906949, 5119.89922166736, 5122.282880396822, 5123.89836185222, 5124.5131712487255, 5156.2523434102595, 4850.587700045536, 4892.755362231803, 4925.802967881388, 4950.985048065066, 5015.971725796276], "value": 4721.9914721394125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.209617738896, 565.0619970848392, 587.8589138606735, 597.4831770518501, 604.88204800064, 35021.29957400854, 38495.23009539811, 38583.61416385835, 38587.61412385875, 38749.22501549967, 33221.83389083051, 33237.33525329492, 33280.66719332806, 33322.166945826306, 33499.66500334996, 7541.245875412456, 7714.305712485875, 7730.4975176613625, 7755.844883102334, 7756.883646745303, 7742.109657389387, 7766.184550622188, 7837.529748215097, 7853.921460785376, 7888.763337099867, 7865.174156713549, 7899.605019748989, 7899.8420031599335, 7904.170062143478, 7929.881051784228, 7870.960645196766, 7879.960600196962, 7884.842303153933, 7892.842143157105, 7909.24862138096, 7620.657070431844, 7698.2686644768655, 7707.383409327241, 7739.961300193463, 7742.845143097163, 36753.44869826928, 36875.07812304687, 36885.81557092224, 37008.0, 37132.62867371319, 2572.254046326563, 2939.241061636336, 2970.450466663674, 3130.2487403023338, 3146.8269245191736, 27415.588766168523, 27527.31181720453, 28067.157985260474, 28391.57412638812, 28808.855955720086, 3323.7839540429795, 3334.916627084318, 3344.6320904700465, 3354.245294808673, 3395.7792743471596, 207543.0, 208763.0, 209353.0, 209515.95242023843, 209962.0, 28160.155195344174, 31341.8432907834, 31636.841815790773, 31638.209044773605, 31649.0, 33778.66221337755, 33832.32335353279, 33937.83031084878, 33961.49057764136, 34006.82996585001, 13068.803967940488, 13156.671083222805, 13244.602661920158, 13255.403506842022, 13271.270080145492, 10647.201459890539, 10680.57277708883, 10691.30506517074, 10717.35695858251, 10726.19553533488, 7893.210678932061, 7893.565853877977, 7899.921000789918, 7986.241307075818, 7988.320992715568, 3119.189010857148, 3123.109913674592, 3152.3852848694282, 3155.857986390618, 3164.2880351920635, 867.3841572483607, 872.9694460693845, 886.2732559301311, 913.8706813125402, 1030.4229631406436, 26718.0, 27705.445891082065, 27950.16149515518, 27952.860235698692, 28202.85898570494, 940.6707652321769, 963.2775418436173, 977.3891317926297, 1015.4922538730634, 1078.741102135482, 14247.857521424654, 14797.260136993107, 14935.395360439012, 14946.551603451697, 14959.775603365959, 381869.0, 426785.0, 435633.8619682829, 437077.0, 650090.0, 48273.5172648269, 48741.756291219026, 48849.51150488521, 48989.755051224514, 49098.0, 1187.1986409173774, 1197.4252358867793, 1202.4889421995617, 1204.7771162334996, 1213.4600102954278, 26938.191854244404, 27819.582706259825, 28281.85859070774, 28439.28901777472, 28572.85713571419, 40762.59237407707, 41294.0, 41413.0, 41441.0, 41486.58513414827, 280376.0, 281996.0, 283819.0, 284663.0, 285460.0, 25318.49363012766, 25626.23121306364, 25701.0, 25854.35364115837, 25937.351566210997, 39542.802285988386, 40402.79798600988, 40503.10316913036, 41005.38491922564, 42205.155896882505, 35554.46668299926, 36142.457863131545, 36516.53933842616, 36564.0, 36665.633343666224, 35371.29257414889, 35602.46596301006, 35634.82182589174, 35839.104022399646, 36004.09989750277, 33150.668493314755, 34959.82520087485, 35091.298174036885, 35315.47026794651, 36010.0, 31692.683073169894, 32553.560451971603, 33207.833960830045, 33274.667253327156, 33574.32851343008, 25290.494190116464, 25295.873520632278, 25437.491250175262, 25508.489830203664, 26076.478470430866], "value": 15996.453788938545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.969402600779, 360.9729270304727, 365.5631520333203, 377.1683438019168, 380.8914459379076, 15715.52853414398, 16115.83884161158, 16475.91762041188, 16984.065876376793, 17026.999999999967, 15734.763978540303, 15980.680386392265, 16768.161591920416, 16806.32774689014, 16908.239129239184, 5039.798408063673, 5265.736713164346, 5278.630495865291, 5284.2866213061325, 5290.259363689067, 5176.922346164811, 5194.194899790519, 5256.737163141846, 5274.918641678447, 5282.973585132069, 5072.923906141411, 5213.218017297417, 5220.347456567929, 5221.216817477371, 5239.056969745444, 5113.769880355374, 5118.744062796864, 5163.0, 5192.818251361185, 5194.558462530689, 4505.301678239878, 4576.3821884045565, 4585.656075794295, 4601.171789077965, 4615.584597386218, 19766.308179213804, 19918.0, 20496.59006819855, 20545.897270513553, 20591.176352946015, 1947.2318081012027, 2000.8895063239895, 2043.5197728533783, 2085.4577809769416, 2384.546936082156, 10926.453677316102, 11998.880011199864, 12859.42132604035, 12931.5473958411, 13438.12652177615, 1721.3630956546033, 1749.09921390484, 1778.1464896849454, 1781.7060185069447, 1798.307651554148, 48773.756131219474, 62659.0, 67651.66174169147, 68471.31528684699, 68567.65716171387, 9497.525123743786, 9517.714468565953, 9542.520909259076, 9597.376170548892, 9682.467464289392, 12768.297743624003, 12799.232046077264, 12927.418266178045, 12993.090483666241, 13062.608121756362, 6941.167059952737, 6985.93014069863, 7007.229204787469, 7031.156261248683, 7125.857482850314, 6478.093066970628, 6479.0, 6608.537402381883, 6617.602943823386, 6626.768063117768, 3932.9016774580864, 4018.618231268025, 4088.34586466164, 4116.794160291974, 4366.366876802846, 1790.543411430103, 1823.7355583440326, 1858.5353661584604, 1860.7674040744907, 1869.7008478643352, 783.1385475976381, 835.5989125219928, 847.1020718038899, 863.7106569299355, 877.0, 15985.44050958211, 16791.916040419965, 17076.914615427093, 17227.913860430617, 17284.913575432292, 836.4019725896013, 851.3572252948984, 869.9652013919499, 889.2930120554175, 925.2413021322451, 8901.465912045298, 9480.668176613786, 9655.855162172573, 9685.806283874424, 9702.27232957531, 368903.1554842209, 374189.0, 376688.0, 377921.0, 383572.0, 50120.0, 64880.05359839212, 79403.20596793958, 79708.0, 79937.20062799414, 897.7576054465258, 898.6854600889767, 911.8814554107923, 927.2535608834818, 928.2573940847295, 15003.174825384272, 15038.398464061314, 15073.547793566211, 15198.696026079195, 15490.07059576429, 35471.82264088663, 35621.46567801537, 36023.819880900424, 36291.81854090712, 36817.26365472729, 50985.490145098076, 51639.48360516347, 51739.528041191064, 51928.48071519387, 52054.0, 7307.086614173229, 7380.409567234716, 7390.630468476662, 7495.737649182252, 7506.737264195727, 10873.130149588173, 11349.14881383883, 11441.542338306375, 11507.712307192387, 11739.823902641638, 10124.59501619927, 10129.290949633749, 10279.434631095362, 10299.558061871194, 10400.27198096126, 9477.478738669439, 9591.088846559845, 9592.856107158537, 9632.181264592307, 9667.468289243878, 9579.089986451276, 9621.663241786504, 9743.561539730586, 10338.948305258426, 10606.681799546026, 7449.6275186241555, 7474.402047836052, 7538.170801211972, 7572.886406704014, 7619.047619047619, 8641.654333826827, 9107.408018478778, 9111.088891110836, 9618.807623847624, 10048.246381521269], "value": 8046.7257040288305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.5244090788678, 1416.362636813434, 1437.8562143785616, 1633.9509814705564, 1665.6335606166654, 6519.185101862267, 7278.81802954925, 7279.672414741336, 7754.37964962803, 7762.262585054418, 7432.628368581576, 7577.772666820004, 7630.198829122945, 7651.84696306075, 7665.0, 2170.4248374180816, 2206.3491270075288, 2209.7458792238936, 2210.5689390568846, 2212.668099785029, 2127.3405244374294, 2168.111074459472, 2200.0869639099756, 2205.44863784054, 2205.4596623827183, 2162.383720639618, 2171.6416791229426, 2172.869627822328, 2187.4093994621444, 2211.6793065005563, 2169.772173921739, 2197.8021978022057, 2200.9449763755874, 2202.0751284460566, 2202.361315218585, 2141.7858214178614, 2166.393409845246, 2169.197396963118, 2171.0881429799365, 2174.662927246279, 7604.125525564576, 7646.350060244886, 7653.119891212526, 7688.115866675292, 7696.268854458817, 4378.277584198603, 4506.8873278167985, 4517.435320584927, 4545.272756358967, 4549.340345649863, 2769.9446011079867, 2877.9136625901256, 2899.594056832045, 2939.4562006028955, 2949.911502654924, 915.9542022898895, 952.6522819171022, 953.4088864903734, 963.7301555564453, 1000.1248907206194, 9726.881408638026, 9768.21854251658, 9778.119969202806, 9782.413055216639, 9799.11807937282, 3927.6465118139504, 4051.858184963571, 4087.3255912774653, 4088.4684990950987, 4116.732412393185, 8536.8719469208, 8569.914300857037, 8615.310775137974, 8616.526091064927, 8624.741257762276, 4482.439695038121, 4485.596296333346, 4487.214737420938, 4492.73043617384, 4494.438195225597, 3662.633736626316, 3960.2871483133313, 4024.7182697210915, 4054.7769872657286, 4158.688098392633, 3510.9297814043575, 3570.0, 3621.492990981265, 3651.1054791576234, 3658.5243918290985, 1152.1704372851534, 1208.3716467436884, 1220.267839296415, 1223.8103094020441, 1227.2636418149038, 789.2659826361424, 809.1463506001107, 825.3809642767924, 833.021200089892, 836.6041611877165, 4914.70511769295, 5003.399592048904, 5024.598032157492, 5040.722760248148, 5046.545810877039, 370.7775334799099, 393.7932585392692, 399.3729844144723, 409.70091832962106, 410.1284769864039, 3218.2758879251983, 3275.4595491743594, 3294.7034766871097, 3309.040378290269, 3348.2466445049668, 8876.955615221883, 9235.12266334697, 9249.953750231205, 9259.583318750538, 9322.627094916263, 8870.379073464796, 9061.954690226507, 9075.909240907638, 9179.357444978787, 9192.908070919206, 6993.370596646327, 7004.0, 7024.683889225099, 7075.115610548682, 7103.183133939559, 4615.699979501322, 4722.693024953367, 4733.100710864925, 4789.090072886141, 4790.161721698759, 8411.242988131098, 8477.067522572388, 8567.143285671384, 8614.138586141336, 8642.740717778224, 8649.56752162402, 8706.434081784664, 8711.912880871363, 8714.956425217833, 8795.956020219857, 5804.390538993345, 6110.816675499742, 6390.105385245976, 6398.104265402941, 6462.3537646235, 7141.85716285661, 7164.176119746087, 7167.3549380556, 7210.855782884418, 7273.8908916365235, 6015.548833837567, 6093.299270583762, 6116.847078823065, 6221.47117495018, 6247.625142491465, 6103.664298463627, 6113.786017489367, 6114.144019837316, 6225.595336303126, 6284.277308109626, 5977.073553599199, 6060.303065147565, 6075.635461872302, 6085.0, 6110.7250173741395, 3986.5016872890887, 4036.3340048891605, 4050.432939388547, 4075.3071977763257, 4170.040890595119, 4060.0864805418546, 4060.878173654677, 4112.362583799516, 4121.423000779953, 4122.670186385142], "value": 3905.098076965906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.067667299537, 277.71534177468095, 285.32947573202966, 289.5483046447542, 290.4582952793039, 4919.70481771094, 4933.333999910011, 5026.723530205837, 5119.334486516752, 5139.794408223666, 4999.775010124544, 5001.899962000758, 5016.523430274127, 5018.9749051254785, 5033.0, 4012.418199361091, 4018.5378681451716, 4028.7179897407195, 4032.8588499402526, 4033.838646454138, 3869.0, 4012.9197416051807, 4042.3724579023574, 4053.3717273822604, 4067.2678917794783, 3939.5666476687543, 3941.960580394202, 3955.46601208836, 3958.4260282259056, 3984.8406063757416, 3952.1898010907694, 3953.802309884494, 3965.1871366369824, 3966.484357033596, 4015.538213105501, 3474.801193588208, 3479.408500554912, 3483.529723487322, 3503.5490042308306, 3519.6480351964856, 4834.444038935532, 4907.067657145167, 4920.434150072751, 4925.630577706651, 4980.352554167971, 4501.257292546758, 4513.458384993789, 4519.864404067883, 4536.092781443692, 4544.295634176708, 5278.340207474066, 5289.3123893893935, 5350.886399872068, 5380.623356365056, 5412.890357476708, 3480.843362048714, 3683.723720720957, 3690.3541880171133, 3882.4758657581147, 3895.844166233347, 5471.972640136813, 5522.282103326582, 5523.309586301712, 5560.221568980346, 5596.4403559644115, 3725.4598083278315, 3726.9813650931574, 3729.198222382201, 3731.7014638828828, 3737.4767532545466, 3554.289142171576, 3760.8683696070507, 3778.3576791945434, 3789.2800367930004, 3799.373103437957, 4334.393184954109, 4337.544557821383, 4346.47842258931, 4350.412694286294, 4373.059792144704, 5338.0, 5341.519263266325, 5365.892682146336, 5386.703731294817, 5422.945770542323, 1236.6829326766965, 1328.2561765411401, 1355.7762969110183, 1361.3057340756286, 1366.7334869700312, 845.2392846438255, 853.3557164340883, 861.8362511122866, 866.2680035370103, 878.7759121423996, 4129.318662420667, 4162.687798415131, 4202.306619407764, 4210.578942105826, 4212.925703945474, 4851.854444366674, 4889.339939108246, 4902.583280421133, 4909.674387915243, 4913.631477639191, 4120.340745480708, 4127.4015267786, 4145.813438395279, 4156.854510092132, 4211.263028969918, 2500.4749002709636, 2583.922482325496, 2591.2744431559195, 2603.635491031257, 2604.570245909442, 4514.25514790056, 4559.99680070384, 4607.170709272363, 4620.168369693421, 4633.8841528961375, 4984.327115839388, 5006.274090256965, 5006.3992320921, 5009.974950125299, 5043.5712964398435, 4423.668224883147, 4528.230200865861, 4537.410136682211, 4572.81708731647, 4574.725516468956, 4826.8069277228515, 4846.95153048465, 4855.95144048555, 4872.9512704872495, 4894.0, 4733.5266473352385, 4749.335093086902, 4789.8323558676675, 4796.328514008112, 4802.926127278474, 4389.7489215573405, 4473.261911784519, 4565.452145742533, 4603.401557797465, 4613.953860461486, 3543.344481270973, 3560.643935606419, 3571.178628915312, 3580.534530511017, 3584.7849129052343, 4817.253325734517, 4825.3485779420735, 4900.240462728283, 4918.2294374024605, 5087.0, 5206.062908676475, 5324.1747529133045, 5335.786568537215, 5341.768230220816, 5374.193870919394, 5294.205869119663, 5306.204069389468, 5325.147976323925, 5336.199570064521, 5362.517373436253, 5166.844994650167, 5181.870453238548, 5238.214267859851, 5259.8422047338645, 5292.867678308073, 5310.256564080954, 5340.359156901197, 5386.461353864583, 5401.810936617199, 5412.269343638716, 5234.162533994542, 5236.973815131052, 5241.449647786927, 5272.472752724697, 5274.7098909560345], "value": 3832.9495774850275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7011908985961, 632.6976559396105, 639.4532674563247, 643.5559463969861, 654.9050387693785, 11546.191766576343, 12685.746285074305, 13135.868641313597, 13192.934035329821, 13964.162150270991, 13563.932180339085, 13886.30568471575, 13905.235212063333, 14003.0, 14052.437902483889, 797.2784629909941, 807.019471342319, 810.1736229046369, 810.9270165685087, 812.7927378518469, 789.2423273657296, 793.761871438569, 795.3358945280697, 795.7135431244776, 796.9840603187932, 817.807815163439, 831.2975535672347, 832.883396324515, 833.3291700181352, 836.6611522333434, 821.5892053973014, 825.5789547330844, 832.6835802395082, 832.7959649885756, 833.4999000599653, 614.4070971512512, 615.5937081526216, 617.9412955769195, 618.5979113576167, 618.9690515474208, 12442.751144977141, 12762.106652534327, 13165.210087394787, 13188.86811131886, 13205.867941320656, 13053.80419293702, 13654.726905461934, 13761.724765504734, 13948.02363834532, 14051.859481405158, 10190.388576685422, 10329.638462653846, 10506.579736810518, 10621.628243011535, 10627.202959778047, 3280.4587243105098, 3376.4935259710996, 3389.3390788796196, 3390.677885600864, 3449.6722811332884, 59960.400395995915, 60585.39414605842, 61255.693721531556, 61476.692616537075, 61731.0, 10412.427316497513, 10659.413732244646, 10689.251752377259, 10765.30025548337, 10765.89234107649, 20232.393028208884, 20269.797302026793, 20541.281055163297, 20548.58902821935, 20637.071331790106, 7040.6479676016, 7069.399101076363, 7130.893036604455, 7149.857002859913, 7279.090113735783, 3778.6599206071587, 3869.28418242626, 3897.395903634941, 3916.1971795781797, 3936.4292177634657, 2863.498887694687, 2970.1386597886803, 2973.405318936221, 2974.6133002709944, 2987.9402411951637, 483.13036534238233, 494.74273377844037, 507.13027158422744, 509.7960815673686, 516.0144124721763, 508.51182864450544, 511.7236692186178, 542.2164971616056, 596.7374355283662, 653.9280679125293, 7256.673449694671, 7542.170361260257, 7669.247567996757, 7804.609769511501, 8001.559914204775, 449.4673811533344, 546.6938514431931, 549.5383877542884, 571.9542436605061, 613.2518327640272, 3858.151206734514, 3917.5298964124486, 3963.1083006323347, 3989.162275922089, 4094.160697057096, 89889.55055224813, 92537.53731231435, 93053.0, 93449.5327523358, 94452.0, 76110.61944690353, 78558.21441785623, 79974.20025799784, 80806.59596701979, 82154.17845821584, 44554.55445445504, 45383.31925021127, 67773.66113169403, 69926.300736993, 76363.0, 7402.888956665762, 7565.962170189114, 7587.620618968919, 7625.8856117157175, 7632.0, 37809.62190378171, 40301.39547906842, 42491.0, 42615.36076958786, 42616.57383426126, 38470.80764596159, 39869.60130398775, 60735.69632151811, 61917.45206369697, 62051.0, 11327.886721133013, 11462.369569673749, 11641.243319184226, 11741.17811753169, 11837.46731397072, 12424.503019879103, 12785.36073196355, 13207.66980825487, 13394.129381590166, 13404.0, 11823.76352472963, 11916.52333906634, 12092.214006089576, 12229.93885030569, 12389.132760706663, 12490.0, 12548.30984295836, 12569.622911312676, 12570.937145314216, 13080.80378794338, 12096.697582560506, 12152.0, 12181.939090304491, 12289.877101228873, 12421.93789031049, 9945.900540994497, 10133.240006999356, 10329.173666106844, 10371.222158338003, 10585.364878107339, 10170.08469237772, 10398.844017339898, 10431.895681043396, 10475.214358923264, 10609.098226650513], "value": 6533.365022126319, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 118.0, 114.0, 116.0, 115.0, 115.0, 113.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 133.0, 168.0, 189.0, 148.0, 165.0, 161.0, 132.0, 192.0, 142.0], "value": 158.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 182.0, 173.0, 164.0, 162.0, 163.0, 163.0, 163.0, 163.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 171.0, 77.0, 76.0, 77.0, 77.0, 159.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 149.0, 87.0, 88.0, 88.0, 136.0, 88.0, 87.0, 129.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 122.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 150.0, 149.0, 148.0, 147.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 67.0, 62.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 86.0, 86.0, 85.0, 85.0, 86.0, 91.0, 110.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 149.0, 134.0, 129.0, 137.0, 133.0, 140.0, 132.0, 156.0, 135.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 174.0, 174.0, 168.0, 168.0, 170.0, 168.0, 167.0, 173.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 68.0, 69.0, 67.0, 71.0, 67.0, 68.0, 67.0], "value": 68.5, "unit": "score"}]}]} 00:06:29 INFO - Return code: 0 00:06:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:06:29 ERROR - # TBPL SUCCESS # 00:06:29 INFO - Running post-action listener: _resource_record_post_action 00:06:29 INFO - ##### 00:06:29 INFO - ##### Finished run-tests step (success) 00:06:29 INFO - ##### 00:06:29 INFO - Running post-run listener: _resource_record_post_run 00:06:29 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 543608832; Read time: 20; Write time: 449996 00:06:29 INFO - TinderboxPrint: CPU usage
13.5% 00:06:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 00:06:29 INFO - TinderboxPrint: I/O write bytes / time
543,608,832 / 449,996 00:06:29 INFO - TinderboxPrint: CPU idle
8,267.4 (86.4%) 00:06:29 INFO - TinderboxPrint: CPU user
1,239.9 (13.0%) 00:06:29 INFO - TinderboxPrint: Swap in / out
0 / 0 00:06:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245026816; Read time: 0; Write time: 245008 00:06:29 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 298524672; Read time: 20; Write time: 204964 00:06:30 INFO - Running post-run listener: _upload_blobber_files 00:06:30 INFO - Blob upload gear active. 00:06:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:06:30 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 00:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:06:30 INFO - (blobuploader) - INFO - Open directory for files ... 00:06:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:06:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:31 INFO - (blobuploader) - INFO - Done attempting. 00:06:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:06:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:06:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:32 INFO - (blobuploader) - INFO - Done attempting. 00:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:06:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:37 INFO - (blobuploader) - INFO - Done attempting. 00:06:37 INFO - (blobuploader) - INFO - Iteration through files over. 00:06:37 INFO - Return code: 0 00:06:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:06:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:06:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6727baae70224a176089f2d5b209a9316b0c42f4a75825d435cd598611987afa667ebe62a7865877770bfff3b8a1bc424c29edee3f9e6a59093b4ee58607c4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0d05125b44c1a19bb416511401f399b7cc226776991161ecc152285ffaa3d709d1b0c04ce67ac8c2fdaa3afdbd77e12c12cbb9cb73437a7e42f7aafafdab1dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/991bcebfc39179fe30c09229f1ba8914168945dfe98dcb87ea1802ca9cbfd2ba7e4137c9da8ada9a029fd3d2896e58cd214cc2d1187b156cc2bc5be2f96654f2"} 00:06:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:06:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:06:37 INFO - Contents: 00:06:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6727baae70224a176089f2d5b209a9316b0c42f4a75825d435cd598611987afa667ebe62a7865877770bfff3b8a1bc424c29edee3f9e6a59093b4ee58607c4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0d05125b44c1a19bb416511401f399b7cc226776991161ecc152285ffaa3d709d1b0c04ce67ac8c2fdaa3afdbd77e12c12cbb9cb73437a7e42f7aafafdab1dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/991bcebfc39179fe30c09229f1ba8914168945dfe98dcb87ea1802ca9cbfd2ba7e4137c9da8ada9a029fd3d2896e58cd214cc2d1187b156cc2bc5be2f96654f2"} 00:06:37 INFO - Running post-run listener: copy_logs_to_upload_dir 00:06:37 INFO - Copying logs to upload dir... 00:06:37 INFO - mkdir: /builds/slave/test/build/upload/logs 00:06:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.452992 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-15 00:06:36.500039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:36.503907) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6727baae70224a176089f2d5b209a9316b0c42f4a75825d435cd598611987afa667ebe62a7865877770bfff3b8a1bc424c29edee3f9e6a59093b4ee58607c4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0d05125b44c1a19bb416511401f399b7cc226776991161ecc152285ffaa3d709d1b0c04ce67ac8c2fdaa3afdbd77e12c12cbb9cb73437a7e42f7aafafdab1dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/991bcebfc39179fe30c09229f1ba8914168945dfe98dcb87ea1802ca9cbfd2ba7e4137c9da8ada9a029fd3d2896e58cd214cc2d1187b156cc2bc5be2f96654f2"} build_url:https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6727baae70224a176089f2d5b209a9316b0c42f4a75825d435cd598611987afa667ebe62a7865877770bfff3b8a1bc424c29edee3f9e6a59093b4ee58607c4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0d05125b44c1a19bb416511401f399b7cc226776991161ecc152285ffaa3d709d1b0c04ce67ac8c2fdaa3afdbd77e12c12cbb9cb73437a7e42f7aafafdab1dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/991bcebfc39179fe30c09229f1ba8914168945dfe98dcb87ea1802ca9cbfd2ba7e4137c9da8ada9a029fd3d2896e58cd214cc2d1187b156cc2bc5be2f96654f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:36.533177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:36.533538) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465972522.402130-240788774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:36.617145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:06:36.617863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:06:36.618584) ========= ========= Total master_lag: 0.20 =========