builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1466126798.99 results: success (0) buildid: 20160616170426 builduid: 55626b7eaafe417e8841ec3f50270bc4 revision: 5f95858f8ddf21ea2271a12810332efd09eff138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:38.991069) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:38.992290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:38.992766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:39.024412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:39.024922) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 18:26: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% 37.5M=0s 2016-06-16 18:26:40 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:39.191089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:39.191415) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:39.241558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 18:26:39.241924) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f95858f8ddf21ea2271a12810332efd09eff138 --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 5f95858f8ddf21ea2271a12810332efd09eff138 --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=8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 18:26:40,377 truncating revision to first 12 chars 2016-06-16 18:26:40,377 Setting DEBUG logging. 2016-06-16 18:26:40,377 attempt 1/10 2016-06-16 18:26:40,377 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f95858f8ddf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 18:26:41,389 unpacking tar archive at: fx-team-5f95858f8ddf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.363464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 18:26:40.619008) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:40.619320) ========= script_repo_revision: 5f95858f8ddf21ea2271a12810332efd09eff138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:40.619751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:40.620034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:40.630602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-16 18:26:40.630932) ========= /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=8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:26:41 INFO - MultiFileLogger online at 20160616 18:26:41 in /builds/slave/test 18:26: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 18:26:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:26:41 INFO - {'append_to_log': False, 18:26:41 INFO - 'base_work_dir': '/builds/slave/test', 18:26:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:26:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:26:41 INFO - 'branch': 'Fx-Team-Non-PGO', 18:26:41 INFO - 'buildbot_json_path': 'buildprops.json', 18:26:41 INFO - 'config_files': ('talos/linux_config.py',), 18:26:41 INFO - 'default_actions': ('clobber', 18:26:41 INFO - 'read-buildbot-config', 18:26:41 INFO - 'download-and-extract', 18:26:41 INFO - 'populate-webroot', 18:26:41 INFO - 'create-virtualenv', 18:26:41 INFO - 'install', 18:26:41 INFO - 'run-tests'), 18:26:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:26:41 INFO - 'download_minidump_stackwalk': True, 18:26:41 INFO - 'download_symbols': 'ondemand', 18:26:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:26:41 INFO - 'tooltool.py': '/tools/tooltool.py', 18:26:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:26:41 INFO - '/tools/misc-python/virtualenv.py')}, 18:26:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:26:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:26:41 INFO - 'installer_path': 'installer.exe', 18:26:41 INFO - 'log_level': 'info', 18:26:41 INFO - 'log_name': 'talos', 18:26:41 INFO - 'log_to_console': True, 18:26:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:26:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:26:41 INFO - 'opt_config_files': (), 18:26:41 INFO - 'pip_index': False, 18:26:41 INFO - 'sps_profile': False, 18:26:41 INFO - 'sps_profile_interval': 0, 18:26:41 INFO - 'suite': 'dromaeojs-e10s', 18:26:41 INFO - 'system_bits': '32', 18:26:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:26:41 INFO - 'title': 'talos-linux64-ix-001', 18:26:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:26:41 INFO - 'use_talos_json': True, 18:26:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:26:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:26:41 INFO - 'work_dir': 'build'} 18:26:41 INFO - ##### 18:26:41 INFO - ##### Running clobber step. 18:26:41 INFO - ##### 18:26:41 INFO - Running pre-action listener: _resource_record_pre_action 18:26:41 INFO - Running main action method: clobber 18:26:41 INFO - rmtree: /builds/slave/test/build 18:26:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:26:42 INFO - Running post-action listener: _resource_record_post_action 18:26:42 INFO - ##### 18:26:42 INFO - ##### Finished clobber step (success) 18:26:42 INFO - ##### 18:26:42 INFO - ##### 18:26:42 INFO - ##### Running read-buildbot-config step. 18:26:42 INFO - ##### 18:26:42 INFO - Running pre-action listener: _resource_record_pre_action 18:26:42 INFO - Running main action method: read_buildbot_config 18:26:42 INFO - Using buildbot properties: 18:26:42 INFO - { 18:26:42 INFO - "project": "", 18:26:42 INFO - "product": "firefox", 18:26:42 INFO - "script_repo_revision": "production", 18:26:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:26:42 INFO - "repository": "", 18:26:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:26:42 INFO - "buildid": "20160616170426", 18:26:42 INFO - "pgo_build": "False", 18:26:42 INFO - "basedir": "/builds/slave/test", 18:26:42 INFO - "buildnumber": 1595, 18:26:42 INFO - "slavename": "talos-linux64-ix-001", 18:26:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:26:42 INFO - "platform": "ubuntu64_hw", 18:26:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:26:42 INFO - "branch": "fx-team", 18:26:42 INFO - "repo_path": "integration/fx-team", 18:26:42 INFO - "revision": "5f95858f8ddf21ea2271a12810332efd09eff138", 18:26:42 INFO - "stage_platform": "linux64", 18:26:42 INFO - "builduid": "55626b7eaafe417e8841ec3f50270bc4", 18:26:42 INFO - "slavebuilddir": "test" 18:26:42 INFO - } 18:26:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:26:42 INFO - Running post-action listener: _resource_record_post_action 18:26:42 INFO - ##### 18:26:42 INFO - ##### Finished read-buildbot-config step (success) 18:26:42 INFO - ##### 18:26:42 INFO - ##### 18:26:42 INFO - ##### Running download-and-extract step. 18:26:42 INFO - ##### 18:26:42 INFO - Running pre-action listener: _resource_record_pre_action 18:26:42 INFO - Running main action method: download_and_extract 18:26:42 INFO - mkdir: /builds/slave/test/build/tests 18:26: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')]} 18:26:42 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:45 INFO - Downloaded 1361 bytes. 18:26:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:26:45 INFO - Using the following test package requirements: 18:26:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:26:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:26:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'jsshell-linux-x86_64.zip'], 18:26:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:26:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:26:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:26:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:26:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:26:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:26: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')]} 18:26:45 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:48 INFO - Downloaded 22654592 bytes. 18:26:48 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'] 18:26:48 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 18:26:49 INFO - Return code: 0 18:26:49 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 18:26:49 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')]} 18:26:49 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:50 INFO - Downloaded 22654592 bytes. 18:26:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:26:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:26:51 INFO - Return code: 0 18:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:51 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:26:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:52 INFO - Downloaded 14405384 bytes. 18:26:52 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'] 18:26:52 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 18:26:53 INFO - Return code: 0 18:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:53 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:26:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:54 INFO - Downloaded 55448507 bytes. 18:26:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:54 INFO - mkdir: /builds/slave/test/properties 18:26:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:26:54 INFO - Writing to file /builds/slave/test/properties/build_url 18:26:54 INFO - Contents: 18:26:54 INFO - build_url:https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:55 INFO - Running post-action listener: _resource_record_post_action 18:26:55 INFO - Running post-action listener: set_extra_try_arguments 18:26:55 INFO - ##### 18:26:55 INFO - ##### Finished download-and-extract step (success) 18:26:55 INFO - ##### 18:26:55 INFO - ##### 18:26:55 INFO - ##### Running populate-webroot step. 18:26:55 INFO - ##### 18:26:55 INFO - Running pre-action listener: _resource_record_pre_action 18:26:55 INFO - Running main action method: populate_webroot 18:26:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:26:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:26:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:26:55 INFO - '--tppagecycles', 18:26:55 INFO - '7'], 18:26:55 INFO - 'tests': ['tsvgm']}}, 18:26:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:26:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:26:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:26:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:26:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['damp', 'tps']}, 18:26:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'tests': ['damp', 'tps']}, 18:26:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['dromaeo_dom']}, 18:26:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:26:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['basic_compositor_video']}, 18:26:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:26:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['a11yr', 18:26:55 INFO - 'ts_paint', 18:26:55 INFO - 'tpaint', 18:26:55 INFO - 'sessionrestore', 18:26:55 INFO - 'sessionrestore_no_auto_restore', 18:26:55 INFO - 'tabpaint']}, 18:26:55 INFO - 'other-e10s': {'tests': ['a11yr', 18:26:55 INFO - 'ts_paint', 18:26:55 INFO - 'tpaint', 18:26:55 INFO - 'sessionrestore', 18:26:55 INFO - 'sessionrestore_no_auto_restore', 18:26:55 INFO - 'tabpaint']}, 18:26:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:26:55 INFO - 'ts_paint', 18:26:55 INFO - 'tpaint', 18:26:55 INFO - 'sessionrestore', 18:26:55 INFO - 'sessionrestore_no_auto_restore', 18:26:55 INFO - 'tabpaint']}, 18:26:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:26:55 INFO - 'ts_paint', 18:26:55 INFO - 'tpaint', 18:26:55 INFO - 'sessionrestore', 18:26:55 INFO - 'sessionrestore_no_auto_restore', 18:26:55 INFO - 'tabpaint']}, 18:26:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['a11yr', 18:26:55 INFO - 'ts_paint', 18:26:55 INFO - 'tpaint', 18:26:55 INFO - 'sessionrestore', 18:26:55 INFO - 'sessionrestore_no_auto_restore', 18:26:55 INFO - 'tabpaint']}, 18:26:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['a11yr', 18:26:55 INFO - 'ts_paint', 18:26:55 INFO - 'tpaint', 18:26:55 INFO - 'sessionrestore', 18:26:55 INFO - 'sessionrestore_no_auto_restore', 18:26:55 INFO - 'tabpaint']}, 18:26:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['tsvgx', 18:26:55 INFO - 'tsvgr_opacity', 18:26:55 INFO - 'tart', 18:26:55 INFO - 'tscrollx', 18:26:55 INFO - 'cart']}, 18:26:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:26:55 INFO - 'tsvgr_opacity', 18:26:55 INFO - 'tart', 18:26:55 INFO - 'tscrollx', 18:26:55 INFO - 'cart']}, 18:26:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'talos_options': ['--disable-e10s'], 18:26:55 INFO - 'tests': ['tp5o']}, 18:26:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'tests': ['tp5o']}, 18:26:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'talos_options': ['--disable-e10s', 18:26:55 INFO - '--xperf_path', 18:26:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:55 INFO - 'tests': ['tp5n']}, 18:26:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:55 INFO - 'talos_options': ['--xperf_path', 18:26:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:55 INFO - 'tests': ['tp5n']}}, 18:26:55 INFO - 'talos.zip': {'path': '', 18:26:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:26:55 INFO - Running post-action listener: _resource_record_post_action 18:26:55 INFO - ##### 18:26:55 INFO - ##### Finished populate-webroot step (success) 18:26:55 INFO - ##### 18:26:55 INFO - ##### 18:26:55 INFO - ##### Running create-virtualenv step. 18:26:55 INFO - ##### 18:26:55 INFO - Running pre-action listener: _resource_record_pre_action 18:26:55 INFO - Running main action method: create_virtualenv 18:26:55 INFO - Creating virtualenv /builds/slave/test/build/venv 18:26:55 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 18:26:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:26:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:26:55 INFO - Using real prefix '/usr' 18:26:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:26:55 INFO - Installing distribute.............................................................................................................................................................................................done. 18:26:57 INFO - Installing pip.................done. 18:26:57 INFO - Return code: 0 18:26:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:57 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:26:57 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 18:26:57 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 18:26:57 INFO - Using env: {'DISPLAY': ':0', 18:26:57 INFO - 'HOME': '/home/cltbld', 18:26:57 INFO - 'LANG': 'en_US.UTF-8', 18:26:57 INFO - 'LANGUAGE': 'en_US:en', 18:26:57 INFO - 'LOGNAME': 'cltbld', 18:26:57 INFO - 'MAIL': '/var/mail/cltbld', 18:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:57 INFO - 'MOZ_NO_REMOTE': '1', 18:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:57 INFO - 'NO_EM_RESTART': '1', 18:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:57 INFO - 'PWD': '/builds/slave/test', 18:26:57 INFO - 'SHELL': '/bin/bash', 18:26:57 INFO - 'SHLVL': '1', 18:26:57 INFO - 'TERM': 'linux', 18:26:57 INFO - 'TMOUT': '86400', 18:26:57 INFO - 'USER': 'cltbld', 18:26:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:57 INFO - '_': '/tools/buildbot/bin/python'} 18:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:58 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 18:26:58 INFO - Cleaning up... 18:26:58 INFO - Return code: 0 18:26:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:26:58 INFO - Using env: {'DISPLAY': ':0', 18:26:58 INFO - 'HOME': '/home/cltbld', 18:26:58 INFO - 'LANG': 'en_US.UTF-8', 18:26:58 INFO - 'LANGUAGE': 'en_US:en', 18:26:58 INFO - 'LOGNAME': 'cltbld', 18:26:58 INFO - 'MAIL': '/var/mail/cltbld', 18:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:58 INFO - 'MOZ_NO_REMOTE': '1', 18:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:58 INFO - 'NO_EM_RESTART': '1', 18:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:58 INFO - 'PWD': '/builds/slave/test', 18:26:58 INFO - 'SHELL': '/bin/bash', 18:26:58 INFO - 'SHLVL': '1', 18:26:58 INFO - 'TERM': 'linux', 18:26:58 INFO - 'TMOUT': '86400', 18:26:58 INFO - 'USER': 'cltbld', 18:26:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:58 INFO - '_': '/tools/buildbot/bin/python'} 18:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:58 INFO - Downloading/unpacking psutil>=3.1.1 18:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:27:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:00 INFO - Installing collected packages: psutil 18:27:00 INFO - Running setup.py install for psutil 18:27:00 INFO - building 'psutil._psutil_linux' extension 18:27:00 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 18:27:00 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 18:27:00 INFO - building 'psutil._psutil_posix' extension 18:27:00 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 18:27:00 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 18:27:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:00 INFO - Successfully installed psutil 18:27:00 INFO - Cleaning up... 18:27:00 INFO - Return code: 0 18:27:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:27:00 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')]} 18:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:00 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')]} 18:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:00 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:00 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 18:27:00 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 18:27:00 INFO - Using env: {'DISPLAY': ':0', 18:27:00 INFO - 'HOME': '/home/cltbld', 18:27:00 INFO - 'LANG': 'en_US.UTF-8', 18:27:00 INFO - 'LANGUAGE': 'en_US:en', 18:27:00 INFO - 'LOGNAME': 'cltbld', 18:27:00 INFO - 'MAIL': '/var/mail/cltbld', 18:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:00 INFO - 'MOZ_NO_REMOTE': '1', 18:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:00 INFO - 'NO_EM_RESTART': '1', 18:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:00 INFO - 'PWD': '/builds/slave/test', 18:27:00 INFO - 'SHELL': '/bin/bash', 18:27:00 INFO - 'SHLVL': '1', 18:27:00 INFO - 'TERM': 'linux', 18:27:00 INFO - 'TMOUT': '86400', 18:27:00 INFO - 'USER': 'cltbld', 18:27:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:00 INFO - '_': '/tools/buildbot/bin/python'} 18:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:27:02 INFO - Installing collected packages: mozsystemmonitor 18:27:02 INFO - Running setup.py install for mozsystemmonitor 18:27:03 INFO - Successfully installed mozsystemmonitor 18:27:03 INFO - Cleaning up... 18:27:03 INFO - Return code: 0 18:27:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:27:03 INFO - Using env: {'DISPLAY': ':0', 18:27:03 INFO - 'HOME': '/home/cltbld', 18:27:03 INFO - 'LANG': 'en_US.UTF-8', 18:27:03 INFO - 'LANGUAGE': 'en_US:en', 18:27:03 INFO - 'LOGNAME': 'cltbld', 18:27:03 INFO - 'MAIL': '/var/mail/cltbld', 18:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:03 INFO - 'MOZ_NO_REMOTE': '1', 18:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:03 INFO - 'NO_EM_RESTART': '1', 18:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:03 INFO - 'PWD': '/builds/slave/test', 18:27:03 INFO - 'SHELL': '/bin/bash', 18:27:03 INFO - 'SHLVL': '1', 18:27:03 INFO - 'TERM': 'linux', 18:27:03 INFO - 'TMOUT': '86400', 18:27:03 INFO - 'USER': 'cltbld', 18:27:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:03 INFO - '_': '/tools/buildbot/bin/python'} 18:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:03 INFO - Downloading/unpacking jsonschema==2.5.1 18:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:27:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 INFO - Downloading functools32-3.2.3-2.tar.gz 18:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:27:05 INFO - warning: no files found matching '*.txt' 18:27:05 INFO - no previously-included directories found matching 'build' 18:27:05 INFO - no previously-included directories found matching 'dist' 18:27:05 INFO - no previously-included directories found matching '.git*' 18:27:05 INFO - Installing collected packages: jsonschema, functools32 18:27:05 INFO - Running setup.py install for functools32 18:27:05 INFO - warning: no files found matching '*.txt' 18:27:05 INFO - no previously-included directories found matching 'build' 18:27:05 INFO - no previously-included directories found matching 'dist' 18:27:05 INFO - no previously-included directories found matching '.git*' 18:27:05 INFO - Successfully installed jsonschema functools32 18:27:05 INFO - Cleaning up... 18:27:05 INFO - Return code: 0 18:27:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:05 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:05 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 18:27:05 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 18:27:05 INFO - Using env: {'DISPLAY': ':0', 18:27:05 INFO - 'HOME': '/home/cltbld', 18:27:05 INFO - 'LANG': 'en_US.UTF-8', 18:27:05 INFO - 'LANGUAGE': 'en_US:en', 18:27:05 INFO - 'LOGNAME': 'cltbld', 18:27:05 INFO - 'MAIL': '/var/mail/cltbld', 18:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:05 INFO - 'MOZ_NO_REMOTE': '1', 18:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:05 INFO - 'NO_EM_RESTART': '1', 18:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:05 INFO - 'PWD': '/builds/slave/test', 18:27:05 INFO - 'SHELL': '/bin/bash', 18:27:05 INFO - 'SHLVL': '1', 18:27:05 INFO - 'TERM': 'linux', 18:27:05 INFO - 'TMOUT': '86400', 18:27:05 INFO - 'USER': 'cltbld', 18:27:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:05 INFO - '_': '/tools/buildbot/bin/python'} 18:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:05 INFO - Downloading/unpacking blobuploader==1.2.4 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:07 INFO - Downloading blobuploader-1.2.4.tar.gz 18:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:27:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:27:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:08 INFO - Downloading docopt-0.6.1.tar.gz 18:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:27:08 INFO - Installing collected packages: blobuploader, requests, docopt 18:27:08 INFO - Running setup.py install for blobuploader 18:27:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:27:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:27:08 INFO - Running setup.py install for requests 18:27:09 INFO - Running setup.py install for docopt 18:27:09 INFO - Successfully installed blobuploader requests docopt 18:27:09 INFO - Cleaning up... 18:27:09 INFO - Return code: 0 18:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:09 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:09 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 18:27:09 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 18:27:09 INFO - Using env: {'DISPLAY': ':0', 18:27:09 INFO - 'HOME': '/home/cltbld', 18:27:09 INFO - 'LANG': 'en_US.UTF-8', 18:27:09 INFO - 'LANGUAGE': 'en_US:en', 18:27:09 INFO - 'LOGNAME': 'cltbld', 18:27:09 INFO - 'MAIL': '/var/mail/cltbld', 18:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:09 INFO - 'MOZ_NO_REMOTE': '1', 18:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:09 INFO - 'NO_EM_RESTART': '1', 18:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:09 INFO - 'PWD': '/builds/slave/test', 18:27:09 INFO - 'SHELL': '/bin/bash', 18:27:09 INFO - 'SHLVL': '1', 18:27:09 INFO - 'TERM': 'linux', 18:27:09 INFO - 'TMOUT': '86400', 18:27:09 INFO - 'USER': 'cltbld', 18:27:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:09 INFO - '_': '/tools/buildbot/bin/python'} 18:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:09 INFO - Running setup.py (path:/tmp/pip-y5AMY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:09 INFO - Running setup.py (path:/tmp/pip-W6mG39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:09 INFO - Running setup.py (path:/tmp/pip-F_VidJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:09 INFO - Running setup.py (path:/tmp/pip-T2G7TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:09 INFO - Running setup.py (path:/tmp/pip-dyZ8u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:09 INFO - Running setup.py (path:/tmp/pip-xNILom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:09 INFO - Running setup.py (path:/tmp/pip-Y9EWY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:10 INFO - Running setup.py (path:/tmp/pip-CQjdU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:10 INFO - Running setup.py (path:/tmp/pip-SaM9Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:10 INFO - Running setup.py (path:/tmp/pip-lQ5YD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:10 INFO - Running setup.py (path:/tmp/pip-RGqZv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:10 INFO - Running setup.py (path:/tmp/pip-wZTZ5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:10 INFO - Running setup.py (path:/tmp/pip-tLhKlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:10 INFO - Running setup.py (path:/tmp/pip-JKVm_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:10 INFO - Running setup.py (path:/tmp/pip-yAAghq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:10 INFO - Running setup.py (path:/tmp/pip-GKlP28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:10 INFO - Running setup.py (path:/tmp/pip-Vrcn4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:27:10 INFO - Running setup.py install for manifestparser 18:27:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:27:10 INFO - Running setup.py install for mozcrash 18:27:10 INFO - Running setup.py install for mozdebug 18:27:11 INFO - Running setup.py install for mozdevice 18:27:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Running setup.py install for mozfile 18:27:11 INFO - Running setup.py install for mozhttpd 18:27:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Running setup.py install for mozinfo 18:27:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Running setup.py install for mozInstall 18:27:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Running setup.py install for mozleak 18:27:11 INFO - Running setup.py install for mozlog 18:27:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Running setup.py install for moznetwork 18:27:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:27:11 INFO - Running setup.py install for mozprocess 18:27:11 INFO - Running setup.py install for mozprofile 18:27:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:27:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:27:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:27:12 INFO - Running setup.py install for mozrunner 18:27:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:27:12 INFO - Running setup.py install for mozscreenshot 18:27:12 INFO - Running setup.py install for moztest 18:27:12 INFO - Running setup.py install for mozversion 18:27:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:27:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:27:12 INFO - Cleaning up... 18:27:12 INFO - Return code: 0 18:27:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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')]} 18:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:12 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:12 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 18:27:12 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 18:27:12 INFO - Using env: {'DISPLAY': ':0', 18:27:12 INFO - 'HOME': '/home/cltbld', 18:27:12 INFO - 'LANG': 'en_US.UTF-8', 18:27:12 INFO - 'LANGUAGE': 'en_US:en', 18:27:12 INFO - 'LOGNAME': 'cltbld', 18:27:12 INFO - 'MAIL': '/var/mail/cltbld', 18:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:12 INFO - 'MOZ_NO_REMOTE': '1', 18:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:12 INFO - 'NO_EM_RESTART': '1', 18:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:12 INFO - 'PWD': '/builds/slave/test', 18:27:12 INFO - 'SHELL': '/bin/bash', 18:27:12 INFO - 'SHLVL': '1', 18:27:12 INFO - 'TERM': 'linux', 18:27:12 INFO - 'TMOUT': '86400', 18:27:12 INFO - 'USER': 'cltbld', 18:27:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:12 INFO - '_': '/tools/buildbot/bin/python'} 18:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:12 INFO - Running setup.py (path:/tmp/pip-SjNRkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:12 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)) 18:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:12 INFO - Running setup.py (path:/tmp/pip-lDB1dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:12 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)) 18:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:12 INFO - Running setup.py (path:/tmp/pip-jtNvdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:12 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)) 18:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:12 INFO - Running setup.py (path:/tmp/pip-zzU24P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:13 INFO - Running setup.py (path:/tmp/pip-DJ326i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:13 INFO - Running setup.py (path:/tmp/pip-s4uw4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:13 INFO - Running setup.py (path:/tmp/pip-dKdS12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:13 INFO - Running setup.py (path:/tmp/pip-NtglRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:13 INFO - Running setup.py (path:/tmp/pip-NBOvPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:13 INFO - Running setup.py (path:/tmp/pip-It2G6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:13 INFO - Running setup.py (path:/tmp/pip-dcwZZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:13 INFO - Running setup.py (path:/tmp/pip-NII6HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:13 INFO - Running setup.py (path:/tmp/pip-9FjH8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:13 INFO - Running setup.py (path:/tmp/pip-jFreSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:13 INFO - Running setup.py (path:/tmp/pip-RlRZ6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:13 INFO - Running setup.py (path:/tmp/pip-abLB1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:13 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)) 18:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:13 INFO - Running setup.py (path:/tmp/pip-qeHFOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:13 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)) 18:27:13 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)) 18:27:13 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)) 18:27:13 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)) 18:27:13 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)) 18:27:13 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)) 18:27:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:15 INFO - Downloading blessings-1.6.tar.gz 18:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:27:15 INFO - Installing collected packages: blessings 18:27:15 INFO - Running setup.py install for blessings 18:27:16 INFO - Successfully installed blessings 18:27:16 INFO - Cleaning up... 18:27:16 INFO - Return code: 0 18:27:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:16 INFO - Reading from file tmpfile_stdout 18:27:16 INFO - Current package versions: 18:27:16 INFO - argparse == 1.2.1 18:27:16 INFO - blessings == 1.6 18:27:16 INFO - blobuploader == 1.2.4 18:27:16 INFO - docopt == 0.6.1 18:27:16 INFO - functools32 == 3.2.3-2 18:27:16 INFO - jsonschema == 2.5.1 18:27:16 INFO - manifestparser == 1.1 18:27:16 INFO - mozInstall == 1.12 18:27:16 INFO - mozcrash == 0.17 18:27:16 INFO - mozdebug == 0.1 18:27:16 INFO - mozdevice == 0.48 18:27:16 INFO - mozfile == 1.2 18:27:16 INFO - mozhttpd == 0.7 18:27:16 INFO - mozinfo == 0.9 18:27:16 INFO - mozleak == 0.1 18:27:16 INFO - mozlog == 3.2 18:27:16 INFO - moznetwork == 0.27 18:27:16 INFO - mozprocess == 0.22 18:27:16 INFO - mozprofile == 0.28 18:27:16 INFO - mozrunner == 6.11 18:27:16 INFO - mozscreenshot == 0.1 18:27:16 INFO - mozsystemmonitor == 0.3 18:27:16 INFO - moztest == 0.7 18:27:16 INFO - mozversion == 1.4 18:27:16 INFO - psutil == 3.1.1 18:27:16 INFO - requests == 1.2.3 18:27:16 INFO - wsgiref == 0.1.2 18:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:16 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')]} 18:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:16 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')]} 18:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:16 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:16 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 18:27:16 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 18:27:16 INFO - Using env: {'DISPLAY': ':0', 18:27:16 INFO - 'HOME': '/home/cltbld', 18:27:16 INFO - 'LANG': 'en_US.UTF-8', 18:27:16 INFO - 'LANGUAGE': 'en_US:en', 18:27:16 INFO - 'LOGNAME': 'cltbld', 18:27:16 INFO - 'MAIL': '/var/mail/cltbld', 18:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:16 INFO - 'MOZ_NO_REMOTE': '1', 18:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:16 INFO - 'NO_EM_RESTART': '1', 18:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:16 INFO - 'PWD': '/builds/slave/test', 18:27:16 INFO - 'SHELL': '/bin/bash', 18:27:16 INFO - 'SHLVL': '1', 18:27:16 INFO - 'TERM': 'linux', 18:27:16 INFO - 'TMOUT': '86400', 18:27:16 INFO - 'USER': 'cltbld', 18:27:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:16 INFO - '_': '/tools/buildbot/bin/python'} 18:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 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)) 18:27:16 INFO - Cleaning up... 18:27:16 INFO - Return code: 0 18:27:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:27:16 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')]} 18:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:16 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')]} 18:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:16 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:16 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 18:27:16 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 18:27:16 INFO - Using env: {'DISPLAY': ':0', 18:27:16 INFO - 'HOME': '/home/cltbld', 18:27:16 INFO - 'LANG': 'en_US.UTF-8', 18:27:16 INFO - 'LANGUAGE': 'en_US:en', 18:27:16 INFO - 'LOGNAME': 'cltbld', 18:27:16 INFO - 'MAIL': '/var/mail/cltbld', 18:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:16 INFO - 'MOZ_NO_REMOTE': '1', 18:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:16 INFO - 'NO_EM_RESTART': '1', 18:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:16 INFO - 'PWD': '/builds/slave/test', 18:27:16 INFO - 'SHELL': '/bin/bash', 18:27:16 INFO - 'SHLVL': '1', 18:27:16 INFO - 'TERM': 'linux', 18:27:16 INFO - 'TMOUT': '86400', 18:27:16 INFO - 'USER': 'cltbld', 18:27:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:16 INFO - '_': '/tools/buildbot/bin/python'} 18:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:27:16 INFO - Cleaning up... 18:27:16 INFO - Return code: 0 18:27:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:27:16 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')]} 18:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:16 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')]} 18:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:16 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 0x7fc1abf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', '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 18:27:16 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 18:27:16 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 18:27:16 INFO - Using env: {'DISPLAY': ':0', 18:27:16 INFO - 'HOME': '/home/cltbld', 18:27:16 INFO - 'LANG': 'en_US.UTF-8', 18:27:16 INFO - 'LANGUAGE': 'en_US:en', 18:27:16 INFO - 'LOGNAME': 'cltbld', 18:27:16 INFO - 'MAIL': '/var/mail/cltbld', 18:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:16 INFO - 'MOZ_NO_REMOTE': '1', 18:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:16 INFO - 'NO_EM_RESTART': '1', 18:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:16 INFO - 'PWD': '/builds/slave/test', 18:27:16 INFO - 'SHELL': '/bin/bash', 18:27:16 INFO - 'SHLVL': '1', 18:27:16 INFO - 'TERM': 'linux', 18:27:16 INFO - 'TMOUT': '86400', 18:27:16 INFO - 'USER': 'cltbld', 18:27:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:16 INFO - '_': '/tools/buildbot/bin/python'} 18:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:16 INFO - Downloading/unpacking flake8 18:27:16 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 18:27:16 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 18:27:16 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 18:27:16 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 18:27:16 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 18:27:16 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 18:27:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:27:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:27:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 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 18:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:27:19 INFO - no previously-included directories found matching 'docs/_build' 18:27:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:27:19 INFO - Running setup.py install for pep8 18:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:27:19 INFO - no previously-included directories found matching 'docs/_build' 18:27:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:27:19 INFO - Cleaning up... 18:27:19 INFO - Return code: 0 18:27:19 INFO - Running post-action listener: _resource_record_post_action 18:27:19 INFO - Running post-action listener: _start_resource_monitoring 18:27:19 INFO - Starting resource monitoring. 18:27:19 INFO - ##### 18:27:19 INFO - ##### Finished create-virtualenv step (success) 18:27:19 INFO - ##### 18:27:19 INFO - ##### 18:27:19 INFO - ##### Running install step. 18:27:19 INFO - ##### 18:27:19 INFO - Running pre-action listener: _resource_record_pre_action 18:27:19 INFO - Running main action method: install 18:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:20 INFO - Reading from file tmpfile_stdout 18:27:20 INFO - Detecting whether we're running mozinstall >=1.0... 18:27:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:27:20 INFO - Reading from file tmpfile_stdout 18:27:20 INFO - Output received: 18:27:20 INFO - Usage: mozinstall [options] installer 18:27:20 INFO - Options: 18:27:20 INFO - -h, --help show this help message and exit 18:27:20 INFO - -d DEST, --destination=DEST 18:27:20 INFO - Directory to install application into. [default: 18:27:20 INFO - "/builds/slave/test"] 18:27:20 INFO - --app=APP Application being installed. [default: firefox] 18:27:20 INFO - mkdir: /builds/slave/test/build/application 18:27:20 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'] 18:27:20 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 18:27:36 INFO - Reading from file tmpfile_stdout 18:27:36 INFO - Output received: 18:27:36 INFO - /builds/slave/test/build/application/firefox/firefox 18:27:36 INFO - Running post-action listener: _resource_record_post_action 18:27:36 INFO - ##### 18:27:36 INFO - ##### Finished install step (success) 18:27:36 INFO - ##### 18:27:36 INFO - ##### 18:27:36 INFO - ##### Running run-tests step. 18:27:36 INFO - ##### 18:27:36 INFO - Running pre-action listener: _resource_record_pre_action 18:27:36 INFO - Running main action method: run_tests 18:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:27:36 INFO - Python 2.7.3 18:27:36 INFO - Return code: 0 18:27:36 INFO - grabbing minidump binary from tooltool 18:27:36 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')]} 18:27:36 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 0x21582e0>, '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 0x20c4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c45d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:27:36 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 18:27:36 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 18:27:36 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 18:27:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:27:36 INFO - Return code: 0 18:27:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:27:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:27:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:27:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:27:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:27:37 INFO - Return code: 0 18:27:37 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/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 18:27:37 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/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 18:27:37 INFO - Using env: {'DISPLAY': ':0', 18:27:37 INFO - 'HOME': '/home/cltbld', 18:27:37 INFO - 'LANG': 'en_US.UTF-8', 18:27:37 INFO - 'LANGUAGE': 'en_US:en', 18:27:37 INFO - 'LOGNAME': 'cltbld', 18:27:37 INFO - 'MAIL': '/var/mail/cltbld', 18:27:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:27:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:37 INFO - 'MOZ_NO_REMOTE': '1', 18:27:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:37 INFO - 'NO_EM_RESTART': '1', 18:27:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:37 INFO - 'PWD': '/builds/slave/test', 18:27:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:27:37 INFO - 'SHELL': '/bin/bash', 18:27:37 INFO - 'SHLVL': '1', 18:27:37 INFO - 'TERM': 'linux', 18:27:37 INFO - 'TMOUT': '86400', 18:27:37 INFO - 'USER': 'cltbld', 18:27:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791', 18:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:37 INFO - '_': '/tools/buildbot/bin/python'} 18:27:37 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/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 18:27:37 INFO - mozversion application_buildid: 20160616170426 18:27:37 INFO - mozversion application_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 18:27:37 INFO - mozversion application_display_name: Nightly 18:27:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:27:37 INFO - mozversion application_name: Firefox 18:27:37 INFO - mozversion application_remotingname: firefox 18:27:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:27:37 INFO - mozversion application_vendor: Mozilla 18:27:37 INFO - mozversion application_version: 50.0a1 18:27:37 INFO - mozversion platform_buildid: 20160616170426 18:27:37 INFO - mozversion platform_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 18:27:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:27:37 INFO - mozversion platform_version: 50.0a1 18:27:37 INFO - using testdate: 1466126857 18:27:37 INFO - actual date: 1466126857 18:27:37 INFO - starting webserver on 'localhost:33297' 18:27:37 INFO - SUITE-START | Running 2 tests 18:27:37 INFO - TEST-START | dromaeo_css 18:27:37 INFO - operating with platform_type : linux_ 18:27:37 INFO - Initialising browser for dromaeo_css test... 18:27:37 INFO - TEST-INFO | started process 31032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKRFZq/profile http://localhost:33297/getInfo.html) 18:27:42 INFO - PROCESS | 31032 | __metrics Screen width/height:1600/1200 18:27:42 INFO - PROCESS | 31032 | colorDepth:24 18:27:42 INFO - PROCESS | 31032 | Browser inner width/height: 1024/697 18:27:42 INFO - PROCESS | 31032 | __metrics 18:27:43 ERROR - PROCESS | 31032 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:27:44 INFO - TEST-INFO | 31032: exit 0 18:27:44 INFO - Browser initialized. 18:27:44 INFO - Running cycle 1/1 for dromaeo_css test... 18:27:44 INFO - TEST-INFO | started process 31153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKRFZq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:56 INFO - PROCESS | 31153 | RSS: Main: 186220544 18:27:56 INFO - PROCESS | 31153 | 18:28:45 INFO - PROCESS | 31153 | 1466126925864 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] 18:30:58 INFO - PROCESS | 31153 | Cycle 1(1): loaded http://localhost:33297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33297/tests/dromaeo/cssquery-ext.html) 18:30:59 INFO - PROCESS | 31153 | RSS: Main: 188952576 18:30:59 INFO - PROCESS | 31153 | 18:34:01 INFO - PROCESS | 31153 | Cycle 1(1): loaded http://localhost:33297/tests/dromaeo/cssquery-ext.html (next: http://localhost:33297/tests/dromaeo/cssquery-jquery.html) 18:34:02 INFO - PROCESS | 31153 | RSS: Main: 188346368 18:34:02 INFO - PROCESS | 31153 | 18:37:04 INFO - PROCESS | 31153 | Cycle 1(1): loaded http://localhost:33297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33297/tests/dromaeo/cssquery-mootools.html) 18:37:05 INFO - PROCESS | 31153 | RSS: Main: 189386752 18:37:05 INFO - PROCESS | 31153 | 18:40:06 INFO - PROCESS | 31153 | Cycle 1(1): loaded http://localhost:33297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33297/tests/dromaeo/cssquery-prototype.html) 18:40:07 INFO - PROCESS | 31153 | RSS: Main: 186716160 18:40:07 INFO - PROCESS | 31153 | 18:43:10 INFO - PROCESS | 31153 | Cycle 1(1): loaded http://localhost:33297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33297/tests/dromaeo/cssquery-yui.html) 18:43:10 INFO - PROCESS | 31153 | RSS: Main: 189407232 18:43:10 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | Cycle 1(1): loaded http://localhost:33297/tests/dromaeo/cssquery-yui.html (next: http://localhost:33297/tests/dromaeo/cssquery-dojo.html) 18:46:13 INFO - PROCESS | 31153 | RSS: Main: 189947904 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | __start_tp_report 18:46:13 INFO - PROCESS | 31153 | _x_x_mozilla_page_load 18:46:13 INFO - PROCESS | 31153 | _x_x_mozilla_page_load_details 18:46:13 INFO - PROCESS | 31153 | |i|pagename|runs| 18:46:13 INFO - PROCESS | 31153 | |0;dojo.html;2655.296346468186;2701.4867175236704;2714.823536470128;2721.5917612358144;2722.101706436876;4850.078485087835;4851.514848515147;4889.071076495464;4937;4982.377202849644;4796.544328288807;4873.342098816659;4874.171390863553;4889.9755501222535;4914.311996320518;4455.866324010277;4498.212812757771;4577;4604.286335617984;4610.67725259232;4286.228478873802;4565.3836732041245;4621.79201935912;4630.305454181866;4657.953420465786;4388.956110438887;4430.601245887853;4434.2905135178535;4450.2434586120435;4524.09518096382;4421.624161946206;4433.445819272591;4477.7984990675495;4488.955110448919;4502.032063106415;4445.333200019991;4472.8881777955485;4475.820967161342;4497.145542346943;4513.526079761644;4856.271559266103;4904.2643603459765;4915.016996600694;4928.852134435937;4933.827316043921;5266.1837415200325;5278.551323137538;5304.867378315535;5307.150855863043;5330.360356757175;5161.922571161435;5244.973775131138;5287.339082614673;5301.098813201765;5311.893762124774;4878.43897951733;4910.754462276872;4929.3345398371475;4948.604111671058;4968.8757781055765;5419.376771671229;5420.105682562412;5424.294841670637;5437.646552974044;5461.890762184734;5032.698038117652;5095.617828662865;5121.718305493159;5190;5196.818111366084;5065;5218.869528261748;5220.712860792617;5249.081410753103;5274.894502109936;5202.791888324425;5206.271122042917;5207.661502002357;5229.267902493654;5253.395859476209;5061.5950723942;5163.4062082860955;5202.2456743771945;5204.089284375219;5266.104762190437;4493.483249426293;4496.752678602643;4506.954930450719;4529.501754806968;4542.841000564964;3874.5156855393075;3889.9416508752392;3893.9415908761393;3937.940930886039;3953.743006704555;4402.515723270438;4447.266201076786;4502.347159661831;4505.053938672915;4509.053098849213;5241.9737901310245;5268.394134674485;5268.947310526923;5301.496357845998;5304.628675992643;4513.210188217049;4521.61566266871;4530.139273538017;4552.362669226311;4556.134334476439;4618.769061546909;4702.929456058094;4712.64655150865;4753.667243292936;4767.237242041326;4920.975395123001;4943.752812359439;4956.801727930842;4966.801327946986;5008.924866127084;5056.873578160576;5310.389305229948;5316.521513063843;5322.574194064543;5324.387695415076;4801.039792041675;4807.351007614067;4841.2496063110275;4844.031193761191;4857.344258525195;5086.109930762176;5092.236164575195;5095.363079615048;5096.439391666988;5136.8202112925865;5173.63784535079;5175.637705360588;5176.3011993381915;5179.611529135254;5228.111221092499;4981.676191047571;5091.338126043591;5117.923231151462;5134.204198349262;5158.6131040171385;5176.896462070662;5185.559227465707;5188.844334669966;5190.766415511235;5245.291885595396;4865.0756356292195;4983.6760610560195;5010.874728131826;5088.491150884882;5096.592272618256;5076.746162691925;5174.379074511083;5184.45563215872;5188.507091826271;5226.581873450191;4983;5067.569256613229;5068.645194836474;5070.923936140887;5073.086844368049 18:46:13 INFO - PROCESS | 31153 | |1;ext.html;537.1888448442852;557.0835974821418;581.2298704216912;586.7594286342601;593.0688818554868;30350.696493035062;30888.84555577222;43397.34903976439;44504.10991780162;44506;41043.38434923479;41469.792651036776;41471.58528414722;41520.58479415213;41521.96195095124;7830.608469576527;7867.567283799417;7886.053673559181;7904.920950790476;7974.840503189933;7714.575698336589;7728.26581474759;7835.098963619172;7849.0581130264445;7850.450468467209;7750.379969602418;7795.298423141916;7848.489848159851;7858.921410785904;7879.369650427981;7725.845483090335;7803.726869559595;7820.100688420847;7824.491408058487;7838.902553642494;7733.6133193340675;7747.109082455533;7775.611219439005;7786.727464538771;7810.414218933603;38172.80913595442;38528;38562.22875542474;38636;38932.02669933246;2972.093511478998;3057.4343746406985;3071.216839705883;3107.8135311881133;3322.96677033229;28599.714002859913;28730.281742956384;28808.42383152346;28852.71147288542;28947.85526072356;3380.425327694273;3418.538497302857;3436.8453419596176;3488.5639295088113;3493.3013397320383;241277;242765;243623.99999999822;243988;244555;31861.362772744415;32933.3413331732;52448.475515245125;52689;52744.20883686748;33749.66250337465;34058.31883362319;34103.488447673306;34185.14537136542;34195.658043419244;13131.146475479063;13196.802047969288;13329.333533323488;13337.533186338625;13357.53248636293;10821.67534973952;10872.836907446395;10879.292845964987;10909.618163364245;10986.450677466095;7725.343345815556;7835.0597928247835;7880.172581878935;7896.842063158705;7953.125156232925;3086.5215891536845;3097.6747441518314;3101.100680802542;3104.7360974316985;3176.8093914365213;850.8978922529212;871.4161511787117;875.369733791669;897.2866571076011;914.6752902719572;27933.720662793112;28640.283992900346;28702;28996;29193.270168245537;958.3579002068631;963.3738070254391;970.5826494607245;975.2636759246724;987.2398253344884;14213.43146274158;14703.705925881637;14819.555413337617;14953.40186392554;14957.476488322856;374463;376496;376702;378582;379440;48121.278180827314;49006.5099349002;49262.26106608332;49296;49388.75305623449;1160.5531870229854;1182.2138278045004;1183.6094088950626;1197.3294954825326;1211.7818792617413;26333.473330533667;27200.319992000357;27520.17439476819;27533.449331012867;27585.724142758314;40463.393049103695;41153.588464116176;41189.1762164749;41272.58727412808;41278;276144;276377;335725;336194;338486;24984;25090.874545627154;25466.618000730374;25476;25615.487690245718;42052;42304.78847605742;42415.3637695441;42613.786931065144;43182;36598.268034638626;36784.81607591945;36875.81562092173;37232.62767372291;37643;35931.640683593876;36605.81697091497;36664.63335366612;36672.81663591665;37331.6266837339;30688.386232275676;35160.82419587886;35719.821400892826;36004.45993310155;36047.27905441929;29440.41119177647;33166.502502462965;33207.833960830045;33290.167745806546;33492;24728.629070563595;24771.752282476944;25309.74690253074;25552;25849.612255815802 18:46:13 INFO - PROCESS | 31153 | |2;jquery.html;356.54540460912324;358.8062446279009;361.48307919674863;370.1135779807363;381.1329226010825;15514.767278490817;16715.498535043953;17656.205470753815;17657.20542575584;17682.115894205286;15889.761653575206;16129.677406451894;16792.244349004293;16822.915885420585;16883.24025418856;4837.4195096588455;5019.673721208128;5054.898902021957;5056.29211910331;5061.367329083864;3662.7985460799646;5000.899982000358;5626.887462250753;5975.611585246945;6008.579399442041;5852.912206316909;5909.7636094556165;5931.436513531207;5948.643081415129;5976.402359764033;5734.397888221718;5790.652560846363;5838.912416313738;5848.912266316009;5888.558358123115;4489.708168969007;5209.895802083937;5212.166053431471;5216.061109000379;5221.869453263699;11746.88253117475;11883.821742673867;11912.940435297854;11918.880811191864;11975.940120299343;1784.3130394797965;1853.1105069566684;1858.2288350334595;1910.2168111074393;1919.500929758259;8483.490990540588;8538.274246688978;8692.956535217283;8747.78130546735;8973.596188171548;1640.6636639488877;1665.1424516373957;1665.3588368478102;1669.2488380228945;1762.8677849161236;68495;68993.3100668992;69000.30999689989;70298.99999999949;70668;9176.403533770417;9462.57418416173;9988.550515226832;10056.245781566266;10124.595016199417;13524.526641567498;13591.86408135906;13878.514252001334;13911.513097041758;13933;6981.720731170798;7060.082189315356;7240.275972402717;7279.672414741243;7459.067616547932;6790.253072162058;6805.829854253683;6918.135233095863;7097.680604372816;7117.395021423134;3878;4066.3493840985893;4125.8968525786495;4221.704480686384;4382.189294980375;1673.86609071274;1684.3851994022093;1814.3740409558682;1834.1837882142318;1915.425372388278;835.1396467100158;867.9218870301577;929.8977112517617;954.3033585482636;977.6627063663025;16252.674946501003;16388.590285242724;16612.923384576927;16648.583785405463;16990.49028529146;859.1880672764178;886.2909672262165;895.4269267668698;908.8545832666741;920.7007722490217;7239.963800180965;9291.860622090675;9459.810803783887;9510;9526.047395260419;377829;392006;401965;405972;407095;72030.63984680043;74118;74543.62728186324;74814.25185748182;75326.62336688282;845.0957475501154;862.8058686795421;868.3487384461654;876.1720174435225;878.3236907581127;14832.777508337167;14977.700445991237;15148.091114533163;15214.771778423112;15255.160966146968;35210.47184292186;35688.64311356957;35829;36217.63782362143;36413.63586364102;45544.77227613973;47746.28380574364;48803;49006.26490602715;49105.263421047996;7296.343329100407;7364.815879603053;7490.887636685345;7529.661165247687;7542;11257.380844053656;11416.429178541206;11778.646640600795;11844.70388240301;11864.406779661154;9775.755606109904;10009.349392289478;10097.242706797166;10371.844422333521;10435.634752783617;9786.51067446639;9837.754056148653;9858.507074646383;9939.900600993897;10279.53742081623;9787.85318220213;9894.010598940049;9948.413412512944;10393.584256629953;10485.9475702621;7309.5248808827255;7371.115466144097;7420.628968551443;7424.183339832722;7437.442191835526;9809.803803923738;10063.194944404577;10116.24128190374;10158.542865570918;10363.06732394088 18:46:13 INFO - PROCESS | 31153 | |3;mootools.html;1372.5813626843815;1414.3423308161705;1467.6551010512528;1623.5291765388038;1666.2918259739615;6934.930650693492;7495.063117110361;7549.698012079517;7990.081140668832;8006.359491240702;7635.121960974489;7799.961000195005;7825.060992680872;7839.725609603665;7877.4485785995;2192.4628466025806;2238.854474459163;2241.3051953894264;2242.473018840571;2245.9101635934626;2225.1766846266905;2236.463248820288;2275.954480910381;2279.555486680098;2280.1221529711015;2210.5799898019327;2227.9777202228015;2232.10715713715;2235.4299653588314;2238.440389902524;2138.17680193126;2138.5509043100888;2151.3223334649533;2152.3435352217566;2167.6856855755987;2122.8407869409702;2127.617028934791;2130.0627723801476;2132.626790311689;2142.2609199826193;7798.9220107798765;7920.930674358945;7930.722424715165;7945.880811787828;7977.521348719096;4430.26900561407;4547.386102876102;4552.112338094073;4557.020240648243;4572.862814115582;2752.1330780803983;2841.275474753945;2951.3507028453705;2959.511680572703;2960.407918416304;864.6152462154344;885.7608445719684;896.7085697148453;906.2523418180028;909.4316052467208;10057;10465.52905119279;10595.046445819837;10630.893691063146;10710.46447677613;4067.9626695192537;4175.54069052404;4227.302495088276;4311.48262208537;4321.438213032286;8894.822103557892;8923.509206993678;8966.372353935161;9198;9226;4604.608608268335;4613.976930115395;4616.399868017136;4621.69958952667;4636.86089417318;3626.1841085755495;4104.651104656078;4239.915201695949;4250.617444430016;4321.092570560155;3678.429843374281;3723.0506220913494;3749.868754593631;3805.657490825839;3825.1775868187915;1213.50246398976;1229.342301868496;1231.1566576894677;1231.950721971129;1238.7089034076985;708.6208878250214;740.2227660956082;758.9924100759032;768.2893323675578;791.4894892794116;5053.9494605054215;5058.570021548136;5083.872903177376;5153.742312884341;5247.527722504917;372.3744109895402;390.57622479609375;392.8075243130845;394.5915976963886;398.9162275922089;3280.6883346082564;3364.6130694970393;3368.898933032013;3401.132711158639;3448.189899735249;9324.440533568008;9597.328187026842;9654.420734755937;9656.75858103553;9716.659916902874;9484.620615175316;9487.241020718326;9509.952450237704;9516.809663806824;9595;6991.211020450905;7404.2595740426605;7448.329650331388;7506.3244308012545;7589.99999999989;5171.715555644476;5355.812546560852;5428.45715428454;5522.475364840334;5608.158776183442;8889.822203555763;8895.332850036144;9003.954980225057;9029.41308814925;9030.45817250967;8938.37431379797;8985.326100542356;9036.096390360912;9056.13966673165;9128.406653567497;6298.370162983848;6642.169728783902;6762.120924279812;6903.447724182154;6942.583444993316;7638.847223055619;7658.8085297868;7696.653650585625;7722.38220942312;7735.303822655988;6612.735490580323;6946.930530694628;6947.687354068978;7039.120109986252;7174.1032370953635;6824.658767061528;6847.383735463832;6977.1278590176225;7000.579965202104;7055.964720176366;5988.101784732151;6021.367756385516;6033.42682445167;6140.324564298013;6178.474829639531;4499.707519011254;4550.294704320836;4569.177548041384;4581.954180458153;4648.233041548242;4501.07727915783;4608.88477788058;4720.740359280273;4755.738434386004;4756.096341695067 18:46:13 INFO - PROCESS | 31153 | |4;prototype.html;294.8584679353909;300.52817077188814;304.876525007372;306.91866655336355;312.0451418658904;4953.678010929296;5041.722880127919;5130.101862310941;5206.750379908823;5212.348456442945;5025.7235852028125;5060.493950604938;5101.795928162869;5109.974450127745;5110.616703747224;3988.0029992501945;3993.960060399402;4007.8597249096288;4012.2577323195155;4014.2774300625874;3915.7846318452475;4010.538788039369;4012.277789997799;4030.9318030721884;4034.7780872052026;3963.9603603964024;3972.682185425159;3975.8807235782974;3976.5228172619327;3993.4808474898223;3974.682025437958;3981.7810020448865;3986.4418981342637;3991.600839916014;4012.87317721608;3515.859365625372;3519.5424594802766;3548.769329993568;3553.236054248349;3575.1419659281587;4816.56650901417;4961.727105009223;4970.925436118461;5010.5240002199735;5083.6441449098575;4470;4485.529019452975;4496.213162696515;4499.280115181556;4513.480949690762;5334.91997620036;5338.304156401032;5345.7594408251725;5359.677000259864;5365.946340536584;3540.4866294387425;3700.3154416433044;3722.4602432647116;3836.290286297044;3844.596722196406;5487.204355368489;5544.140658197985;5556.416576259516;5630.605857589971;5633.155026745939;3760.7367484276383;3776.490173826553;3791.6777073949024;3795.1593477163556;3796.867109651149;3607.1703508192736;3839.827207775657;3845.134844659929;3858.749181303206;3858.9228215435533;4372.40972468719;4372.934405983913;4378.868633940987;4389.934150987738;4391.451068616423;5331.81338653153;5350.5184533392185;5351.86620334487;5360.973195133999;5371.838844834661;1226.6381417481864;1343.1806597975228;1383.273781264844;1383.6785869494609;1385.3973521518171;867.3754896474528;872.8696338241865;873.7160422862595;875.6584931876573;893.2853717026353;4168.458100446983;4170.35359519275;4175.164967006611;4185.639667108202;4187.958120418818;4746.264329029006;4821.373221481185;4849.975750121227;4870.245112007645;4884.3650325458175;4153.9199808050125;4167.2082304362075;4171.937420938689;4188.889944164799;4204.801631535059;2526.84838909666;2600.6346667999073;2609.5172393107337;2616.9869150654504;2620.2270330252622;4522.253828118323;4547.249703798836;4568.223402021597;4580.908381832344;4587.678862479661;4861.781219845116;4903.705777653352;4950.791826947138;4952.662781049096;4998.750062496861;4364.759938203366;4575.81696732127;4582.518835522289;4598.471175814757;4610.838620648396;4793.23308270675;4828.237693242012;4833.589144922721;4887.828925987574;4895.118878601886;4696.436427628706;4724.905501889874;4800.399950006249;4807.990322032412;4810.63920205993;4388.583084607085;4424.579664931826;4536.6143877770755;4554.2257816172;4581.144636422255;3533.2403533240476;3543.9291214175055;3557.128503516655;3569.2861427714042;3598.5681718193982;4854.417469903634;4859.465458799458;4870.610351171968;4910.705357678551;5278.630495865253;5210.124355232189;5366.275552800478;5367.704776237344;5377.687594334474;5382.381026182039;5307.389650190277;5353.143497040455;5399.5950303726595;5399.7300134993875;5422.810201642924;5117.2579975902545;5254.65844720092;5255.369355677343;5296.655717378358;5304.310439642822;5357.651752636066;5387.191921211693;5399.271098401822;5418.756155973069;5434.864128396822;5288.65623734456;5301.231321458444;5308.920366194588;5314.601404894725;5319.202119682079 18:46:13 INFO - PROCESS | 31153 | |5;yui.html;629.546726357023;663.7112855907681;710.4777988178688;715.4026387966046;755.7279379423403;12856.421461034253;13051.282179480124;13510.527131550398;13520.526781562647;13521.864781352184;12260.632181034583;12541.122121451503;12558.497660093586;12572.434240459179;12591.370431478412;620.1008537620469;750.7635094945102;776.735909790671;797.8404319136196;800.8678568036296;785.3952456608437;785.5286827903241;788.1055002572065;788.4756636836526;789.3645615279697;824.4970567953544;830.1449507007792;833.8790875323075;836.8786525953764;837.0123254559617;818.2390376949435;818.9672413103468;821.8685010398337;823.3989187892872;823.423603477565;605.315992927993;607.7052629474701;608.1151923950641;608.7047781825811;610.6854969690613;13986;14111.929440352835;14136.363863626162;14147.080439771486;14365.640858978504;14020.509282175177;14163.07939983908;14385;14399.640008999753;14460.276986150651;10528.210384221138;10633.680989570325;10653.307535010199;10742;10975.176861735323;3328.7503437242062;3332.516785066176;3348.4307667696307;3357.261402491448;3410.2497450560836;64907.3509264906;65014.674926625536;65093.3490665092;65715;66165;11059.336439813636;11075.390853503135;11131.610393636183;11188.496517656726;11254.268472549258;17192.398266060878;17844.286228550973;21185.15259389638;21219;21245.78754212469;6945;7003.754868579677;7019.92980070203;7064.540804847668;7395.667194976131;3577.767445116111;3630.8184590770356;3672.8826458284566;3681.392570225936;3719.1631882826146;2892.3058465968015;2970.688077751848;2975.1669532530927;3168.7940283881476;3367.225538126245;539.6573176033247;548.8243761996123;558.154396089924;558.2352177516747;571.9647438136985;459.9816007359668;472.2561964905288;481.4872161148366;487.15964960442955;488.3992688992488;7578.886316705254;7642.159362470124;8057.43597948138;8079.878801817978;8228.177182281725;403.3445650817422;413.3097726796257;501.3182072381558;510.27031345176755;523.2073408785693;3554.6089930108183;3691.206390626028;3863.517060367454;3943.6253555912144;3993.3011722948368;93781;94051;94299.0570094304;94934.52532737292;95739;50035;63037.36962630407;83749;84424;84514;74524;75414;76336.23663763402;77169.61415192888;77259.61370193225;7233.240509746401;7445.143808462096;7469.7323941565655;7610.391168706379;7666.4633475656165;44133.33799993067;44491.555084448744;44814.77592612016;45360.54639453563;45717.314240285756;57572.424275758385;57894;59467.702661486415;61665.38334616776;64639;9351.579178936829;9511.714648560554;9533.618655253713;9617.278704097082;9790.461524616214;10216.846747298649;10409.42748148859;10437.843432348369;10467.633632822815;10512.369257844553;9003.729888103368;9112.453252804853;9116.316276279173;9219.953900230455;9235.1688348049;9073;9147.451152930846;9265.953670231605;9343.392679475812;9388.95305523468;8681.91318086811;8826.602802873758;8885.378023538291;8965.820683586162;9109.362344636076;7976.880346794686;8011.43919925623;8255;8376.246137847624;8552.700655477029;8363.498190108612;8434.789130271547;8452.535110568731;8526.190011948855;8871.068537803438 18:46:13 INFO - PROCESS | 31153 | __end_tp_report 18:46:13 INFO - PROCESS | 31153 | __start_cc_report 18:46:13 INFO - PROCESS | 31153 | _x_x_mozilla_cycle_collect,392 18:46:13 INFO - PROCESS | 31153 | __end_cc_report 18:46:13 INFO - PROCESS | 31153 | __startTimestamp1466127973595__endTimestamp 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | ------- Summary: start ------- 18:46:13 INFO - PROCESS | 31153 | Number of tests: 6 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | [#0] dojo.html Cycles:165 Average:4842.92 Median:4966.80 stddev:513.31 (10.3%) stddev-sans-first:485.35 18:46:13 INFO - PROCESS | 31153 | Values: 2655.3 2701.5 2714.8 2721.6 2722.1 4850.1 4851.5 4889.1 4937.0 4982.4 4796.5 4873.3 4874.2 4890.0 4914.3 4455.9 4498.2 4577.0 4604.3 4610.7 4286.2 4565.4 4621.8 4630.3 4658.0 4389.0 4430.6 4434.3 4450.2 4524.1 4421.6 4433.4 4477.8 4489.0 4502.0 4445.3 4472.9 4475.8 4497.1 4513.5 4856.3 4904.3 4915.0 4928.9 4933.8 5266.2 5278.6 5304.9 5307.2 5330.4 5161.9 5245.0 5287.3 5301.1 5311.9 4878.4 4910.8 4929.3 4948.6 4968.9 5419.4 5420.1 5424.3 5437.6 5461.9 5032.7 5095.6 5121.7 5190.0 5196.8 5065.0 5218.9 5220.7 5249.1 5274.9 5202.8 5206.3 5207.7 5229.3 5253.4 5061.6 5163.4 5202.2 5204.1 5266.1 4493.5 4496.8 4507.0 4529.5 4542.8 3874.5 3889.9 3893.9 3937.9 3953.7 4402.5 4447.3 4502.3 4505.1 4509.1 5242.0 5268.4 5268.9 5301.5 5304.6 4513.2 4521.6 4530.1 4552.4 4556.1 4618.8 4702.9 4712.6 4753.7 4767.2 4921.0 4943.8 4956.8 4966.8 5008.9 5056.9 5310.4 5316.5 5322.6 5324.4 4801.0 4807.4 4841.2 4844.0 4857.3 5086.1 5092.2 5095.4 5096.4 5136.8 5173.6 5175.6 5176.3 5179.6 5228.1 4981.7 5091.3 5117.9 5134.2 5158.6 5176.9 5185.6 5188.8 5190.8 5245.3 4865.1 4983.7 5010.9 5088.5 5096.6 5076.7 5174.4 5184.5 5188.5 5226.6 4983.0 5067.6 5068.6 5070.9 5073.1 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | [#1] ext.html Cycles:180 Average:45504.69 Median:36602.04 stddev:83382.41 (227.8%) stddev-sans-first:83547.96 18:46:13 INFO - PROCESS | 31153 | Values: 537.2 557.1 581.2 586.8 593.1 30350.7 30888.8 43397.3 44504.1 44506.0 41043.4 41469.8 41471.6 41520.6 41522.0 7830.6 7867.6 7886.1 7904.9 7974.8 7714.6 7728.3 7835.1 7849.1 7850.5 7750.4 7795.3 7848.5 7858.9 7879.4 7725.8 7803.7 7820.1 7824.5 7838.9 7733.6 7747.1 7775.6 7786.7 7810.4 38172.8 38528.0 38562.2 38636.0 38932.0 2972.1 3057.4 3071.2 3107.8 3323.0 28599.7 28730.3 28808.4 28852.7 28947.9 3380.4 3418.5 3436.8 3488.6 3493.3 241277.0 242765.0 243624.0 243988.0 244555.0 31861.4 32933.3 52448.5 52689.0 52744.2 33749.7 34058.3 34103.5 34185.1 34195.7 13131.1 13196.8 13329.3 13337.5 13357.5 10821.7 10872.8 10879.3 10909.6 10986.5 7725.3 7835.1 7880.2 7896.8 7953.1 3086.5 3097.7 3101.1 3104.7 3176.8 850.9 871.4 875.4 897.3 914.7 27933.7 28640.3 28702.0 28996.0 29193.3 958.4 963.4 970.6 975.3 987.2 14213.4 14703.7 14819.6 14953.4 14957.5 374463.0 376496.0 376702.0 378582.0 379440.0 48121.3 49006.5 49262.3 49296.0 49388.8 1160.6 1182.2 1183.6 1197.3 1211.8 26333.5 27200.3 27520.2 27533.4 27585.7 40463.4 41153.6 41189.2 41272.6 41278.0 276144.0 276377.0 335725.0 336194.0 338486.0 24984.0 25090.9 25466.6 25476.0 25615.5 42052.0 42304.8 42415.4 42613.8 43182.0 36598.3 36784.8 36875.8 37232.6 37643.0 35931.6 36605.8 36664.6 36672.8 37331.6 30688.4 35160.8 35719.8 36004.5 36047.3 29440.4 33166.5 33207.8 33290.2 33492.0 24728.6 24771.8 25309.7 25552.0 25849.6 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | [#2] jquery.html Cycles:180 Average:23981.90 Median:27053.08 stddev:65482.82 (242.1%) stddev-sans-first:65642.49 18:46:13 INFO - PROCESS | 31153 | Values: 356.5 358.8 361.5 370.1 381.1 15514.8 16715.5 17656.2 17657.2 17682.1 15889.8 16129.7 16792.2 16822.9 16883.2 4837.4 5019.7 5054.9 5056.3 5061.4 3662.8 5000.9 5626.9 5975.6 6008.6 5852.9 5909.8 5931.4 5948.6 5976.4 5734.4 5790.7 5838.9 5848.9 5888.6 4489.7 5209.9 5212.2 5216.1 5221.9 11746.9 11883.8 11912.9 11918.9 11975.9 1784.3 1853.1 1858.2 1910.2 1919.5 8483.5 8538.3 8693.0 8747.8 8973.6 1640.7 1665.1 1665.4 1669.2 1762.9 68495.0 68993.3 69000.3 70299.0 70668.0 9176.4 9462.6 9988.6 10056.2 10124.6 13524.5 13591.9 13878.5 13911.5 13933.0 6981.7 7060.1 7240.3 7279.7 7459.1 6790.3 6805.8 6918.1 7097.7 7117.4 3878.0 4066.3 4125.9 4221.7 4382.2 1673.9 1684.4 1814.4 1834.2 1915.4 835.1 867.9 929.9 954.3 977.7 16252.7 16388.6 16612.9 16648.6 16990.5 859.2 886.3 895.4 908.9 920.7 7240.0 9291.9 9459.8 9510.0 9526.0 377829.0 392006.0 401965.0 405972.0 407095.0 72030.6 74118.0 74543.6 74814.3 75326.6 845.1 862.8 868.3 876.2 878.3 14832.8 14977.7 15148.1 15214.8 15255.2 35210.5 35688.6 35829.0 36217.6 36413.6 45544.8 47746.3 48803.0 49006.3 49105.3 7296.3 7364.8 7490.9 7529.7 7542.0 11257.4 11416.4 11778.6 11844.7 11864.4 9775.8 10009.3 10097.2 10371.8 10435.6 9786.5 9837.8 9858.5 9939.9 10279.5 9787.9 9894.0 9948.4 10393.6 10485.9 7309.5 7371.1 7420.6 7424.2 7437.4 9809.8 10063.2 10116.2 10158.5 10363.1 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | [#3] mootools.html Cycles:180 Average:5131.79 Median:5056.26 stddev:2895.61 (57.3%) stddev-sans-first:2889.96 18:46:13 INFO - PROCESS | 31153 | Values: 1372.6 1414.3 1467.7 1623.5 1666.3 6934.9 7495.1 7549.7 7990.1 8006.4 7635.1 7800.0 7825.1 7839.7 7877.4 2192.5 2238.9 2241.3 2242.5 2245.9 2225.2 2236.5 2276.0 2279.6 2280.1 2210.6 2228.0 2232.1 2235.4 2238.4 2138.2 2138.6 2151.3 2152.3 2167.7 2122.8 2127.6 2130.1 2132.6 2142.3 7798.9 7920.9 7930.7 7945.9 7977.5 4430.3 4547.4 4552.1 4557.0 4572.9 2752.1 2841.3 2951.4 2959.5 2960.4 864.6 885.8 896.7 906.3 909.4 10057.0 10465.5 10595.0 10630.9 10710.5 4068.0 4175.5 4227.3 4311.5 4321.4 8894.8 8923.5 8966.4 9198.0 9226.0 4604.6 4614.0 4616.4 4621.7 4636.9 3626.2 4104.7 4239.9 4250.6 4321.1 3678.4 3723.1 3749.9 3805.7 3825.2 1213.5 1229.3 1231.2 1232.0 1238.7 708.6 740.2 759.0 768.3 791.5 5053.9 5058.6 5083.9 5153.7 5247.5 372.4 390.6 392.8 394.6 398.9 3280.7 3364.6 3368.9 3401.1 3448.2 9324.4 9597.3 9654.4 9656.8 9716.7 9484.6 9487.2 9510.0 9516.8 9595.0 6991.2 7404.3 7448.3 7506.3 7590.0 5171.7 5355.8 5428.5 5522.5 5608.2 8889.8 8895.3 9004.0 9029.4 9030.5 8938.4 8985.3 9036.1 9056.1 9128.4 6298.4 6642.2 6762.1 6903.4 6942.6 7638.8 7658.8 7696.7 7722.4 7735.3 6612.7 6946.9 6947.7 7039.1 7174.1 6824.7 6847.4 6977.1 7000.6 7056.0 5988.1 6021.4 6033.4 6140.3 6178.5 4499.7 4550.3 4569.2 4582.0 4648.2 4501.1 4608.9 4720.7 4755.7 4756.1 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | [#4] prototype.html Cycles:180 Average:4243.91 Median:4581.83 stddev:1233.20 (26.9%) stddev-sans-first:1200.51 18:46:13 INFO - PROCESS | 31153 | Values: 294.9 300.5 304.9 306.9 312.0 4953.7 5041.7 5130.1 5206.8 5212.3 5025.7 5060.5 5101.8 5110.0 5110.6 3988.0 3994.0 4007.9 4012.3 4014.3 3915.8 4010.5 4012.3 4030.9 4034.8 3964.0 3972.7 3975.9 3976.5 3993.5 3974.7 3981.8 3986.4 3991.6 4012.9 3515.9 3519.5 3548.8 3553.2 3575.1 4816.6 4961.7 4970.9 5010.5 5083.6 4470.0 4485.5 4496.2 4499.3 4513.5 5334.9 5338.3 5345.8 5359.7 5365.9 3540.5 3700.3 3722.5 3836.3 3844.6 5487.2 5544.1 5556.4 5630.6 5633.2 3760.7 3776.5 3791.7 3795.2 3796.9 3607.2 3839.8 3845.1 3858.7 3858.9 4372.4 4372.9 4378.9 4389.9 4391.5 5331.8 5350.5 5351.9 5361.0 5371.8 1226.6 1343.2 1383.3 1383.7 1385.4 867.4 872.9 873.7 875.7 893.3 4168.5 4170.4 4175.2 4185.6 4188.0 4746.3 4821.4 4850.0 4870.2 4884.4 4153.9 4167.2 4171.9 4188.9 4204.8 2526.8 2600.6 2609.5 2617.0 2620.2 4522.3 4547.2 4568.2 4580.9 4587.7 4861.8 4903.7 4950.8 4952.7 4998.8 4364.8 4575.8 4582.5 4598.5 4610.8 4793.2 4828.2 4833.6 4887.8 4895.1 4696.4 4724.9 4800.4 4808.0 4810.6 4388.6 4424.6 4536.6 4554.2 4581.1 3533.2 3543.9 3557.1 3569.3 3598.6 4854.4 4859.5 4870.6 4910.7 5278.6 5210.1 5366.3 5367.7 5377.7 5382.4 5307.4 5353.1 5399.6 5399.7 5422.8 5117.3 5254.7 5255.4 5296.7 5304.3 5357.7 5387.2 5399.3 5418.8 5434.9 5288.7 5301.2 5308.9 5314.6 5319.2 18:46:13 INFO - PROCESS | 31153 | 18:46:13 INFO - PROCESS | 31153 | [#5] yui.html Cycles:180 Average:17127.53 Median:624.82 stddev:24699.22 (3953.0%) stddev-sans-first:24737.44 18:46:13 INFO - PROCESS | 31153 | Values: 629.5 663.7 710.5 715.4 755.7 12856.4 13051.3 13510.5 13520.5 13521.9 12260.6 12541.1 12558.5 12572.4 12591.4 620.1 750.8 776.7 797.8 800.9 785.4 785.5 788.1 788.5 789.4 824.5 830.1 833.9 836.9 837.0 818.2 819.0 821.9 823.4 823.4 605.3 607.7 608.1 608.7 610.7 13986.0 14111.9 14136.4 14147.1 14365.6 14020.5 14163.1 14385.0 14399.6 14460.3 10528.2 10633.7 10653.3 10742.0 10975.2 3328.8 3332.5 3348.4 3357.3 3410.2 64907.4 65014.7 65093.3 65715.0 66165.0 11059.3 11075.4 11131.6 11188.5 11254.3 17192.4 17844.3 21185.2 21219.0 21245.8 6945.0 7003.8 7019.9 7064.5 7395.7 3577.8 3630.8 3672.9 3681.4 3719.2 2892.3 2970.7 2975.2 3168.8 3367.2 539.7 548.8 558.2 558.2 572.0 460.0 472.3 481.5 487.2 488.4 7578.9 7642.2 8057.4 8079.9 8228.2 403.3 413.3 501.3 510.3 523.2 3554.6 3691.2 3863.5 3943.6 3993.3 93781.0 94051.0 94299.1 94934.5 95739.0 50035.0 63037.4 83749.0 84424.0 84514.0 74524.0 75414.0 76336.2 77169.6 77259.6 7233.2 7445.1 7469.7 7610.4 7666.5 44133.3 44491.6 44814.8 45360.5 45717.3 57572.4 57894.0 59467.7 61665.4 64639.0 9351.6 9511.7 9533.6 9617.3 9790.5 10216.8 10409.4 10437.8 10467.6 10512.4 9003.7 9112.5 9116.3 9220.0 9235.2 9073.0 9147.5 9266.0 9343.4 9389.0 8681.9 8826.6 8885.4 8965.8 9109.4 7976.9 8011.4 8255.0 8376.2 8552.7 8363.5 8434.8 8452.5 8526.2 8871.1 18:46:13 INFO - PROCESS | 31153 | -------- Summary: end -------- 18:46:13 INFO - PROCESS | 31153 | 18:46:14 INFO - TEST-INFO | 31153: exit 0 18:46:14 INFO - TEST-OK | dromaeo_css | took 1117048ms 18:46:14 INFO - TEST-START | kraken 18:46:14 INFO - operating with platform_type : linux_ 18:46:14 INFO - Initialising browser for kraken test... 18:46:14 INFO - TEST-INFO | started process 31384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvYmqk0/profile http://localhost:33297/getInfo.html) 18:46:19 INFO - PROCESS | 31384 | __metrics Screen width/height:1600/1200 18:46:19 INFO - PROCESS | 31384 | colorDepth:24 18:46:19 INFO - PROCESS | 31384 | Browser inner width/height: 1024/697 18:46:19 INFO - PROCESS | 31384 | __metrics 18:46:20 ERROR - PROCESS | 31384 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:46:20 INFO - TEST-INFO | 31384: exit 0 18:46:20 INFO - Browser initialized. 18:46:20 INFO - Running cycle 1/1 for kraken test... 18:46:20 INFO - TEST-INFO | started process 31503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvYmqk0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:33 INFO - PROCESS | 31503 | RSS: Main: 185901056 18:46:33 INFO - PROCESS | 31503 | 18:46:35 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33297/tests/kraken/driver.html?testName=audio-beat-detection) 18:46:36 INFO - PROCESS | 31503 | RSS: Main: 190496768 18:46:36 INFO - PROCESS | 31503 | 18:46:39 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33297/tests/kraken/driver.html?testName=audio-dft) 18:46:40 INFO - PROCESS | 31503 | RSS: Main: 190214144 18:46:40 INFO - PROCESS | 31503 | 18:46:43 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33297/tests/kraken/driver.html?testName=audio-fft) 18:46:43 INFO - PROCESS | 31503 | RSS: Main: 186937344 18:46:43 INFO - PROCESS | 31503 | 18:46:46 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33297/tests/kraken/driver.html?testName=audio-oscillator) 18:46:46 INFO - PROCESS | 31503 | RSS: Main: 186925056 18:46:46 INFO - PROCESS | 31503 | 18:46:48 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:46:49 INFO - PROCESS | 31503 | RSS: Main: 187080704 18:46:49 INFO - PROCESS | 31503 | 18:46:52 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33297/tests/kraken/driver.html?testName=imaging-darkroom) 18:46:53 INFO - PROCESS | 31503 | RSS: Main: 187363328 18:46:53 INFO - PROCESS | 31503 | 18:46:57 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33297/tests/kraken/driver.html?testName=imaging-desaturate) 18:46:57 INFO - PROCESS | 31503 | RSS: Main: 184168448 18:46:57 INFO - PROCESS | 31503 | 18:47:00 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33297/tests/kraken/driver.html?testName=json-parse-financial) 18:47:01 INFO - PROCESS | 31503 | RSS: Main: 185806848 18:47:01 INFO - PROCESS | 31503 | 18:47:02 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:47:03 INFO - PROCESS | 31503 | RSS: Main: 186437632 18:47:03 INFO - PROCESS | 31503 | 18:47:05 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:47:06 INFO - PROCESS | 31503 | RSS: Main: 186560512 18:47:06 INFO - PROCESS | 31503 | 18:47:08 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:47:09 INFO - PROCESS | 31503 | RSS: Main: 186683392 18:47:09 INFO - PROCESS | 31503 | 18:47:11 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:47:12 INFO - PROCESS | 31503 | RSS: Main: 187006976 18:47:12 INFO - PROCESS | 31503 | 18:47:15 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:47:16 INFO - PROCESS | 31503 | RSS: Main: 187658240 18:47:16 INFO - PROCESS | 31503 | 18:47:17 INFO - PROCESS | 31503 | Cycle 1(1): loaded http://localhost:33297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33297/tests/kraken/driver.html?testName=ai-astar) 18:47:18 INFO - PROCESS | 31503 | RSS: Main: 188612608 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | __start_tp_report 18:47:18 INFO - PROCESS | 31503 | _x_x_mozilla_page_load 18:47:18 INFO - PROCESS | 31503 | _x_x_mozilla_page_load_details 18:47:18 INFO - PROCESS | 31503 | |i|pagename|runs| 18:47:18 INFO - PROCESS | 31503 | |0;ai-astar;114;108;119;115;117;116;113;114;113;116 18:47:18 INFO - PROCESS | 31503 | |1;audio-beat-detection;163;140;160;194;135;159;160;133;190;140 18:47:18 INFO - PROCESS | 31503 | |2;audio-dft;163;171;166;164;164;163;164;163;163;162 18:47:18 INFO - PROCESS | 31503 | |3;audio-fft;76;77;76;179;78;77;78;77;161;76 18:47:18 INFO - PROCESS | 31503 | |4;audio-oscillator;86;88;150;87;86;88;139;86;87;137 18:47:18 INFO - PROCESS | 31503 | |5;imaging-gaussian-blur;117;118;118;118;118;117;119;118;119;118 18:47:18 INFO - PROCESS | 31503 | |6;imaging-darkroom;149;148;148;149;149;148;148;148;150;147 18:47:18 INFO - PROCESS | 31503 | |7;imaging-desaturate;98;95;97;96;97;97;97;96;96;96 18:47:18 INFO - PROCESS | 31503 | |8;json-parse-financial;66;63;64;63;64;62;63;66;64;64 18:47:18 INFO - PROCESS | 31503 | |9;json-stringify-tinderbox;65;65;64;66;66;65;64;64;66;66 18:47:18 INFO - PROCESS | 31503 | |10;stanford-crypto-aes;84;83;85;88;93;85;84;85;114;90 18:47:18 INFO - PROCESS | 31503 | |11;stanford-crypto-ccm;143;148;132;131;144;132;147;144;145;140 18:47:18 INFO - PROCESS | 31503 | |12;stanford-crypto-pbkdf2;173;172;172;172;172;179;172;172;178;176 18:47:18 INFO - PROCESS | 31503 | |13;stanford-crypto-sha256-iterative;77;69;68;70;71;68;69;69;68;67 18:47:18 INFO - PROCESS | 31503 | __end_tp_report 18:47:18 INFO - PROCESS | 31503 | __start_cc_report 18:47:18 INFO - PROCESS | 31503 | _x_x_mozilla_cycle_collect,982 18:47:18 INFO - PROCESS | 31503 | __end_cc_report 18:47:18 INFO - PROCESS | 31503 | __startTimestamp1466128038169__endTimestamp 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | ------- Summary: start ------- 18:47:18 INFO - PROCESS | 31503 | Number of tests: 14 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.50 stddev:2.95 (2.6%) stddev-sans-first:3.13 18:47:18 INFO - PROCESS | 31503 | Values: 114.0 108.0 119.0 115.0 117.0 116.0 113.0 114.0 113.0 116.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:160.00 stddev:21.48 (13.4%) stddev-sans-first:22.69 18:47:18 INFO - PROCESS | 31503 | Values: 163.0 140.0 160.0 194.0 135.0 159.0 160.0 133.0 190.0 140.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.58 (1.6%) stddev-sans-first:2.70 18:47:18 INFO - PROCESS | 31503 | Values: 163.0 171.0 166.0 164.0 164.0 163.0 164.0 163.0 163.0 162.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#3] audio-fft Cycles:10 Average:95.50 Median:77.00 stddev:39.50 (51.3%) stddev-sans-first:41.26 18:47:18 INFO - PROCESS | 31503 | Values: 76.0 77.0 76.0 179.0 78.0 77.0 78.0 77.0 161.0 76.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:86.50 stddev:26.85 (31.0%) stddev-sans-first:27.73 18:47:18 INFO - PROCESS | 31503 | Values: 86.0 88.0 150.0 87.0 86.0 88.0 139.0 86.0 87.0 137.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 18:47:18 INFO - PROCESS | 31503 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 119.0 118.0 119.0 118.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 18:47:18 INFO - PROCESS | 31503 | Values: 149.0 148.0 148.0 149.0 149.0 148.0 148.0 148.0 150.0 147.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 18:47:18 INFO - PROCESS | 31503 | Values: 98.0 95.0 97.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.29 (2.0%) stddev-sans-first:1.12 18:47:18 INFO - PROCESS | 31503 | Values: 66.0 63.0 64.0 63.0 64.0 62.0 63.0 66.0 64.0 64.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 18:47:18 INFO - PROCESS | 31503 | Values: 65.0 65.0 64.0 66.0 66.0 65.0 64.0 64.0 66.0 66.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:85.00 stddev:9.29 (10.9%) stddev-sans-first:9.67 18:47:18 INFO - PROCESS | 31503 | Values: 84.0 83.0 85.0 88.0 93.0 85.0 84.0 85.0 114.0 90.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:144.00 stddev:6.54 (4.5%) stddev-sans-first:6.87 18:47:18 INFO - PROCESS | 31503 | Values: 143.0 148.0 132.0 131.0 144.0 132.0 147.0 144.0 145.0 140.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:172.50 stddev:2.78 (1.6%) stddev-sans-first:2.93 18:47:18 INFO - PROCESS | 31503 | Values: 173.0 172.0 172.0 172.0 172.0 179.0 172.0 172.0 178.0 176.0 18:47:18 INFO - PROCESS | 31503 | 18:47:18 INFO - PROCESS | 31503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:2.84 (4.1%) stddev-sans-first:1.20 18:47:18 INFO - PROCESS | 31503 | Values: 77.0 69.0 68.0 70.0 71.0 68.0 69.0 69.0 68.0 67.0 18:47:18 INFO - PROCESS | 31503 | -------- Summary: end -------- 18:47:18 INFO - PROCESS | 31503 | 18:47:19 INFO - TEST-INFO | 31503: exit 0 18:47:19 INFO - TEST-OK | kraken | took 64848ms 18:47:19 INFO - SUITE-END | took 1181s 18:47:19 INFO - Completed test suite (00:19:41) 18:47:19 INFO - javascript benchmark 18:47:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6279.292093005423, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2655.296346468186, 2701.4867175236704, 2714.823536470128, 2721.5917612358144, 2722.101706436876, 4850.078485087835, 4851.514848515147, 4889.071076495464, 4937.0, 4982.377202849644, 4796.544328288807, 4873.342098816659, 4874.171390863553, 4889.9755501222535, 4914.311996320518, 4455.866324010277, 4498.212812757771, 4577.0, 4604.286335617984, 4610.67725259232, 4286.228478873802, 4565.3836732041245, 4621.79201935912, 4630.305454181866, 4657.953420465786, 4388.956110438887, 4430.601245887853, 4434.2905135178535, 4450.2434586120435, 4524.09518096382, 4421.624161946206, 4433.445819272591, 4477.7984990675495, 4488.955110448919, 4502.032063106415, 4445.333200019991, 4472.8881777955485, 4475.820967161342, 4497.145542346943, 4513.526079761644, 4856.271559266103, 4904.2643603459765, 4915.016996600694, 4928.852134435937, 4933.827316043921, 5266.1837415200325, 5278.551323137538, 5304.867378315535, 5307.150855863043, 5330.360356757175, 5161.922571161435, 5244.973775131138, 5287.339082614673, 5301.098813201765, 5311.893762124774, 4878.43897951733, 4910.754462276872, 4929.3345398371475, 4948.604111671058, 4968.8757781055765, 5419.376771671229, 5420.105682562412, 5424.294841670637, 5437.646552974044, 5461.890762184734, 5032.698038117652, 5095.617828662865, 5121.718305493159, 5190.0, 5196.818111366084, 5065.0, 5218.869528261748, 5220.712860792617, 5249.081410753103, 5274.894502109936, 5202.791888324425, 5206.271122042917, 5207.661502002357, 5229.267902493654, 5253.395859476209, 5061.5950723942, 5163.4062082860955, 5202.2456743771945, 5204.089284375219, 5266.104762190437, 4493.483249426293, 4496.752678602643, 4506.954930450719, 4529.501754806968, 4542.841000564964, 3874.5156855393075, 3889.9416508752392, 3893.9415908761393, 3937.940930886039, 3953.743006704555, 4402.515723270438, 4447.266201076786, 4502.347159661831, 4505.053938672915, 4509.053098849213, 5241.9737901310245, 5268.394134674485, 5268.947310526923, 5301.496357845998, 5304.628675992643, 4513.210188217049, 4521.61566266871, 4530.139273538017, 4552.362669226311, 4556.134334476439, 4618.769061546909, 4702.929456058094, 4712.64655150865, 4753.667243292936, 4767.237242041326, 4920.975395123001, 4943.752812359439, 4956.801727930842, 4966.801327946986, 5008.924866127084, 5056.873578160576, 5310.389305229948, 5316.521513063843, 5322.574194064543, 5324.387695415076, 4801.039792041675, 4807.351007614067, 4841.2496063110275, 4844.031193761191, 4857.344258525195, 5086.109930762176, 5092.236164575195, 5095.363079615048, 5096.439391666988, 5136.8202112925865, 5173.63784535079, 5175.637705360588, 5176.3011993381915, 5179.611529135254, 5228.111221092499, 4981.676191047571, 5091.338126043591, 5117.923231151462, 5134.204198349262, 5158.6131040171385, 5176.896462070662, 5185.559227465707, 5188.844334669966, 5190.766415511235, 5245.291885595396, 4865.0756356292195, 4983.6760610560195, 5010.874728131826, 5088.491150884882, 5096.592272618256, 5076.746162691925, 5174.379074511083, 5184.45563215872, 5188.507091826271, 5226.581873450191, 4983.0, 5067.569256613229, 5068.645194836474, 5070.923936140887, 5073.086844368049], "value": 4809.648826799915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.1888448442852, 557.0835974821418, 581.2298704216912, 586.7594286342601, 593.0688818554868, 30350.696493035062, 30888.84555577222, 43397.34903976439, 44504.10991780162, 44506.0, 41043.38434923479, 41469.792651036776, 41471.58528414722, 41520.58479415213, 41521.96195095124, 7830.608469576527, 7867.567283799417, 7886.053673559181, 7904.920950790476, 7974.840503189933, 7714.575698336589, 7728.26581474759, 7835.098963619172, 7849.0581130264445, 7850.450468467209, 7750.379969602418, 7795.298423141916, 7848.489848159851, 7858.921410785904, 7879.369650427981, 7725.845483090335, 7803.726869559595, 7820.100688420847, 7824.491408058487, 7838.902553642494, 7733.6133193340675, 7747.109082455533, 7775.611219439005, 7786.727464538771, 7810.414218933603, 38172.80913595442, 38528.0, 38562.22875542474, 38636.0, 38932.02669933246, 2972.093511478998, 3057.4343746406985, 3071.216839705883, 3107.8135311881133, 3322.96677033229, 28599.714002859913, 28730.281742956384, 28808.42383152346, 28852.71147288542, 28947.85526072356, 3380.425327694273, 3418.538497302857, 3436.8453419596176, 3488.5639295088113, 3493.3013397320383, 241277.0, 242765.0, 243623.99999999822, 243988.0, 244555.0, 31861.362772744415, 32933.3413331732, 52448.475515245125, 52689.0, 52744.20883686748, 33749.66250337465, 34058.31883362319, 34103.488447673306, 34185.14537136542, 34195.658043419244, 13131.146475479063, 13196.802047969288, 13329.333533323488, 13337.533186338625, 13357.53248636293, 10821.67534973952, 10872.836907446395, 10879.292845964987, 10909.618163364245, 10986.450677466095, 7725.343345815556, 7835.0597928247835, 7880.172581878935, 7896.842063158705, 7953.125156232925, 3086.5215891536845, 3097.6747441518314, 3101.100680802542, 3104.7360974316985, 3176.8093914365213, 850.8978922529212, 871.4161511787117, 875.369733791669, 897.2866571076011, 914.6752902719572, 27933.720662793112, 28640.283992900346, 28702.0, 28996.0, 29193.270168245537, 958.3579002068631, 963.3738070254391, 970.5826494607245, 975.2636759246724, 987.2398253344884, 14213.43146274158, 14703.705925881637, 14819.555413337617, 14953.40186392554, 14957.476488322856, 374463.0, 376496.0, 376702.0, 378582.0, 379440.0, 48121.278180827314, 49006.5099349002, 49262.26106608332, 49296.0, 49388.75305623449, 1160.5531870229854, 1182.2138278045004, 1183.6094088950626, 1197.3294954825326, 1211.7818792617413, 26333.473330533667, 27200.319992000357, 27520.17439476819, 27533.449331012867, 27585.724142758314, 40463.393049103695, 41153.588464116176, 41189.1762164749, 41272.58727412808, 41278.0, 276144.0, 276377.0, 335725.0, 336194.0, 338486.0, 24984.0, 25090.874545627154, 25466.618000730374, 25476.0, 25615.487690245718, 42052.0, 42304.78847605742, 42415.3637695441, 42613.786931065144, 43182.0, 36598.268034638626, 36784.81607591945, 36875.81562092173, 37232.62767372291, 37643.0, 35931.640683593876, 36605.81697091497, 36664.63335366612, 36672.81663591665, 37331.6266837339, 30688.386232275676, 35160.82419587886, 35719.821400892826, 36004.45993310155, 36047.27905441929, 29440.41119177647, 33166.502502462965, 33207.833960830045, 33290.167745806546, 33492.0, 24728.629070563595, 24771.752282476944, 25309.74690253074, 25552.0, 25849.612255815802], "value": 16345.763995443163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.54540460912324, 358.8062446279009, 361.48307919674863, 370.1135779807363, 381.1329226010825, 15514.767278490817, 16715.498535043953, 17656.205470753815, 17657.20542575584, 17682.115894205286, 15889.761653575206, 16129.677406451894, 16792.244349004293, 16822.915885420585, 16883.24025418856, 4837.4195096588455, 5019.673721208128, 5054.898902021957, 5056.29211910331, 5061.367329083864, 3662.7985460799646, 5000.899982000358, 5626.887462250753, 5975.611585246945, 6008.579399442041, 5852.912206316909, 5909.7636094556165, 5931.436513531207, 5948.643081415129, 5976.402359764033, 5734.397888221718, 5790.652560846363, 5838.912416313738, 5848.912266316009, 5888.558358123115, 4489.708168969007, 5209.895802083937, 5212.166053431471, 5216.061109000379, 5221.869453263699, 11746.88253117475, 11883.821742673867, 11912.940435297854, 11918.880811191864, 11975.940120299343, 1784.3130394797965, 1853.1105069566684, 1858.2288350334595, 1910.2168111074393, 1919.500929758259, 8483.490990540588, 8538.274246688978, 8692.956535217283, 8747.78130546735, 8973.596188171548, 1640.6636639488877, 1665.1424516373957, 1665.3588368478102, 1669.2488380228945, 1762.8677849161236, 68495.0, 68993.3100668992, 69000.30999689989, 70298.99999999949, 70668.0, 9176.403533770417, 9462.57418416173, 9988.550515226832, 10056.245781566266, 10124.595016199417, 13524.526641567498, 13591.86408135906, 13878.514252001334, 13911.513097041758, 13933.0, 6981.720731170798, 7060.082189315356, 7240.275972402717, 7279.672414741243, 7459.067616547932, 6790.253072162058, 6805.829854253683, 6918.135233095863, 7097.680604372816, 7117.395021423134, 3878.0, 4066.3493840985893, 4125.8968525786495, 4221.704480686384, 4382.189294980375, 1673.86609071274, 1684.3851994022093, 1814.3740409558682, 1834.1837882142318, 1915.425372388278, 835.1396467100158, 867.9218870301577, 929.8977112517617, 954.3033585482636, 977.6627063663025, 16252.674946501003, 16388.590285242724, 16612.923384576927, 16648.583785405463, 16990.49028529146, 859.1880672764178, 886.2909672262165, 895.4269267668698, 908.8545832666741, 920.7007722490217, 7239.963800180965, 9291.860622090675, 9459.810803783887, 9510.0, 9526.047395260419, 377829.0, 392006.0, 401965.0, 405972.0, 407095.0, 72030.63984680043, 74118.0, 74543.62728186324, 74814.25185748182, 75326.62336688282, 845.0957475501154, 862.8058686795421, 868.3487384461654, 876.1720174435225, 878.3236907581127, 14832.777508337167, 14977.700445991237, 15148.091114533163, 15214.771778423112, 15255.160966146968, 35210.47184292186, 35688.64311356957, 35829.0, 36217.63782362143, 36413.63586364102, 45544.77227613973, 47746.28380574364, 48803.0, 49006.26490602715, 49105.263421047996, 7296.343329100407, 7364.815879603053, 7490.887636685345, 7529.661165247687, 7542.0, 11257.380844053656, 11416.429178541206, 11778.646640600795, 11844.70388240301, 11864.406779661154, 9775.755606109904, 10009.349392289478, 10097.242706797166, 10371.844422333521, 10435.634752783617, 9786.51067446639, 9837.754056148653, 9858.507074646383, 9939.900600993897, 10279.53742081623, 9787.85318220213, 9894.010598940049, 9948.413412512944, 10393.584256629953, 10485.9475702621, 7309.5248808827255, 7371.115466144097, 7420.628968551443, 7424.183339832722, 7437.442191835526, 9809.803803923738, 10063.194944404577, 10116.24128190374, 10158.542865570918, 10363.06732394088], "value": 7969.323381430532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.5813626843815, 1414.3423308161705, 1467.6551010512528, 1623.5291765388038, 1666.2918259739615, 6934.930650693492, 7495.063117110361, 7549.698012079517, 7990.081140668832, 8006.359491240702, 7635.121960974489, 7799.961000195005, 7825.060992680872, 7839.725609603665, 7877.4485785995, 2192.4628466025806, 2238.854474459163, 2241.3051953894264, 2242.473018840571, 2245.9101635934626, 2225.1766846266905, 2236.463248820288, 2275.954480910381, 2279.555486680098, 2280.1221529711015, 2210.5799898019327, 2227.9777202228015, 2232.10715713715, 2235.4299653588314, 2238.440389902524, 2138.17680193126, 2138.5509043100888, 2151.3223334649533, 2152.3435352217566, 2167.6856855755987, 2122.8407869409702, 2127.617028934791, 2130.0627723801476, 2132.626790311689, 2142.2609199826193, 7798.9220107798765, 7920.930674358945, 7930.722424715165, 7945.880811787828, 7977.521348719096, 4430.26900561407, 4547.386102876102, 4552.112338094073, 4557.020240648243, 4572.862814115582, 2752.1330780803983, 2841.275474753945, 2951.3507028453705, 2959.511680572703, 2960.407918416304, 864.6152462154344, 885.7608445719684, 896.7085697148453, 906.2523418180028, 909.4316052467208, 10057.0, 10465.52905119279, 10595.046445819837, 10630.893691063146, 10710.46447677613, 4067.9626695192537, 4175.54069052404, 4227.302495088276, 4311.48262208537, 4321.438213032286, 8894.822103557892, 8923.509206993678, 8966.372353935161, 9198.0, 9226.0, 4604.608608268335, 4613.976930115395, 4616.399868017136, 4621.69958952667, 4636.86089417318, 3626.1841085755495, 4104.651104656078, 4239.915201695949, 4250.617444430016, 4321.092570560155, 3678.429843374281, 3723.0506220913494, 3749.868754593631, 3805.657490825839, 3825.1775868187915, 1213.50246398976, 1229.342301868496, 1231.1566576894677, 1231.950721971129, 1238.7089034076985, 708.6208878250214, 740.2227660956082, 758.9924100759032, 768.2893323675578, 791.4894892794116, 5053.9494605054215, 5058.570021548136, 5083.872903177376, 5153.742312884341, 5247.527722504917, 372.3744109895402, 390.57622479609375, 392.8075243130845, 394.5915976963886, 398.9162275922089, 3280.6883346082564, 3364.6130694970393, 3368.898933032013, 3401.132711158639, 3448.189899735249, 9324.440533568008, 9597.328187026842, 9654.420734755937, 9656.75858103553, 9716.659916902874, 9484.620615175316, 9487.241020718326, 9509.952450237704, 9516.809663806824, 9595.0, 6991.211020450905, 7404.2595740426605, 7448.329650331388, 7506.3244308012545, 7589.99999999989, 5171.715555644476, 5355.812546560852, 5428.45715428454, 5522.475364840334, 5608.158776183442, 8889.822203555763, 8895.332850036144, 9003.954980225057, 9029.41308814925, 9030.45817250967, 8938.37431379797, 8985.326100542356, 9036.096390360912, 9056.13966673165, 9128.406653567497, 6298.370162983848, 6642.169728783902, 6762.120924279812, 6903.447724182154, 6942.583444993316, 7638.847223055619, 7658.8085297868, 7696.653650585625, 7722.38220942312, 7735.303822655988, 6612.735490580323, 6946.930530694628, 6947.687354068978, 7039.120109986252, 7174.1032370953635, 6824.658767061528, 6847.383735463832, 6977.1278590176225, 7000.579965202104, 7055.964720176366, 5988.101784732151, 6021.367756385516, 6033.42682445167, 6140.324564298013, 6178.474829639531, 4499.707519011254, 4550.294704320836, 4569.177548041384, 4581.954180458153, 4648.233041548242, 4501.07727915783, 4608.88477788058, 4720.740359280273, 4755.738434386004, 4756.096341695067], "value": 4048.06237209272, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.8584679353909, 300.52817077188814, 304.876525007372, 306.91866655336355, 312.0451418658904, 4953.678010929296, 5041.722880127919, 5130.101862310941, 5206.750379908823, 5212.348456442945, 5025.7235852028125, 5060.493950604938, 5101.795928162869, 5109.974450127745, 5110.616703747224, 3988.0029992501945, 3993.960060399402, 4007.8597249096288, 4012.2577323195155, 4014.2774300625874, 3915.7846318452475, 4010.538788039369, 4012.277789997799, 4030.9318030721884, 4034.7780872052026, 3963.9603603964024, 3972.682185425159, 3975.8807235782974, 3976.5228172619327, 3993.4808474898223, 3974.682025437958, 3981.7810020448865, 3986.4418981342637, 3991.600839916014, 4012.87317721608, 3515.859365625372, 3519.5424594802766, 3548.769329993568, 3553.236054248349, 3575.1419659281587, 4816.56650901417, 4961.727105009223, 4970.925436118461, 5010.5240002199735, 5083.6441449098575, 4470.0, 4485.529019452975, 4496.213162696515, 4499.280115181556, 4513.480949690762, 5334.91997620036, 5338.304156401032, 5345.7594408251725, 5359.677000259864, 5365.946340536584, 3540.4866294387425, 3700.3154416433044, 3722.4602432647116, 3836.290286297044, 3844.596722196406, 5487.204355368489, 5544.140658197985, 5556.416576259516, 5630.605857589971, 5633.155026745939, 3760.7367484276383, 3776.490173826553, 3791.6777073949024, 3795.1593477163556, 3796.867109651149, 3607.1703508192736, 3839.827207775657, 3845.134844659929, 3858.749181303206, 3858.9228215435533, 4372.40972468719, 4372.934405983913, 4378.868633940987, 4389.934150987738, 4391.451068616423, 5331.81338653153, 5350.5184533392185, 5351.86620334487, 5360.973195133999, 5371.838844834661, 1226.6381417481864, 1343.1806597975228, 1383.273781264844, 1383.6785869494609, 1385.3973521518171, 867.3754896474528, 872.8696338241865, 873.7160422862595, 875.6584931876573, 893.2853717026353, 4168.458100446983, 4170.35359519275, 4175.164967006611, 4185.639667108202, 4187.958120418818, 4746.264329029006, 4821.373221481185, 4849.975750121227, 4870.245112007645, 4884.3650325458175, 4153.9199808050125, 4167.2082304362075, 4171.937420938689, 4188.889944164799, 4204.801631535059, 2526.84838909666, 2600.6346667999073, 2609.5172393107337, 2616.9869150654504, 2620.2270330252622, 4522.253828118323, 4547.249703798836, 4568.223402021597, 4580.908381832344, 4587.678862479661, 4861.781219845116, 4903.705777653352, 4950.791826947138, 4952.662781049096, 4998.750062496861, 4364.759938203366, 4575.81696732127, 4582.518835522289, 4598.471175814757, 4610.838620648396, 4793.23308270675, 4828.237693242012, 4833.589144922721, 4887.828925987574, 4895.118878601886, 4696.436427628706, 4724.905501889874, 4800.399950006249, 4807.990322032412, 4810.63920205993, 4388.583084607085, 4424.579664931826, 4536.6143877770755, 4554.2257816172, 4581.144636422255, 3533.2403533240476, 3543.9291214175055, 3557.128503516655, 3569.2861427714042, 3598.5681718193982, 4854.417469903634, 4859.465458799458, 4870.610351171968, 4910.705357678551, 5278.630495865253, 5210.124355232189, 5366.275552800478, 5367.704776237344, 5377.687594334474, 5382.381026182039, 5307.389650190277, 5353.143497040455, 5399.5950303726595, 5399.7300134993875, 5422.810201642924, 5117.2579975902545, 5254.65844720092, 5255.369355677343, 5296.655717378358, 5304.310439642822, 5357.651752636066, 5387.191921211693, 5399.271098401822, 5418.756155973069, 5434.864128396822, 5288.65623734456, 5301.231321458444, 5308.920366194588, 5314.601404894725, 5319.202119682079], "value": 3854.616154066572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.546726357023, 663.7112855907681, 710.4777988178688, 715.4026387966046, 755.7279379423403, 12856.421461034253, 13051.282179480124, 13510.527131550398, 13520.526781562647, 13521.864781352184, 12260.632181034583, 12541.122121451503, 12558.497660093586, 12572.434240459179, 12591.370431478412, 620.1008537620469, 750.7635094945102, 776.735909790671, 797.8404319136196, 800.8678568036296, 785.3952456608437, 785.5286827903241, 788.1055002572065, 788.4756636836526, 789.3645615279697, 824.4970567953544, 830.1449507007792, 833.8790875323075, 836.8786525953764, 837.0123254559617, 818.2390376949435, 818.9672413103468, 821.8685010398337, 823.3989187892872, 823.423603477565, 605.315992927993, 607.7052629474701, 608.1151923950641, 608.7047781825811, 610.6854969690613, 13986.0, 14111.929440352835, 14136.363863626162, 14147.080439771486, 14365.640858978504, 14020.509282175177, 14163.07939983908, 14385.0, 14399.640008999753, 14460.276986150651, 10528.210384221138, 10633.680989570325, 10653.307535010199, 10742.0, 10975.176861735323, 3328.7503437242062, 3332.516785066176, 3348.4307667696307, 3357.261402491448, 3410.2497450560836, 64907.3509264906, 65014.674926625536, 65093.3490665092, 65715.0, 66165.0, 11059.336439813636, 11075.390853503135, 11131.610393636183, 11188.496517656726, 11254.268472549258, 17192.398266060878, 17844.286228550973, 21185.15259389638, 21219.0, 21245.78754212469, 6945.0, 7003.754868579677, 7019.92980070203, 7064.540804847668, 7395.667194976131, 3577.767445116111, 3630.8184590770356, 3672.8826458284566, 3681.392570225936, 3719.1631882826146, 2892.3058465968015, 2970.688077751848, 2975.1669532530927, 3168.7940283881476, 3367.225538126245, 539.6573176033247, 548.8243761996123, 558.154396089924, 558.2352177516747, 571.9647438136985, 459.9816007359668, 472.2561964905288, 481.4872161148366, 487.15964960442955, 488.3992688992488, 7578.886316705254, 7642.159362470124, 8057.43597948138, 8079.878801817978, 8228.177182281725, 403.3445650817422, 413.3097726796257, 501.3182072381558, 510.27031345176755, 523.2073408785693, 3554.6089930108183, 3691.206390626028, 3863.517060367454, 3943.6253555912144, 3993.3011722948368, 93781.0, 94051.0, 94299.0570094304, 94934.52532737292, 95739.0, 50035.0, 63037.36962630407, 83749.0, 84424.0, 84514.0, 74524.0, 75414.0, 76336.23663763402, 77169.61415192888, 77259.61370193225, 7233.240509746401, 7445.143808462096, 7469.7323941565655, 7610.391168706379, 7666.4633475656165, 44133.33799993067, 44491.555084448744, 44814.77592612016, 45360.54639453563, 45717.314240285756, 57572.424275758385, 57894.0, 59467.702661486415, 61665.38334616776, 64639.0, 9351.579178936829, 9511.714648560554, 9533.618655253713, 9617.278704097082, 9790.461524616214, 10216.846747298649, 10409.42748148859, 10437.843432348369, 10467.633632822815, 10512.369257844553, 9003.729888103368, 9112.453252804853, 9116.316276279173, 9219.953900230455, 9235.1688348049, 9073.0, 9147.451152930846, 9265.953670231605, 9343.392679475812, 9388.95305523468, 8681.91318086811, 8826.602802873758, 8885.378023538291, 8965.820683586162, 9109.362344636076, 7976.880346794686, 8011.43919925623, 8255.0, 8376.246137847624, 8552.700655477029, 8363.498190108612, 8434.789130271547, 8452.535110568731, 8526.190011948855, 8871.068537803438], "value": 6269.748892838283, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 119.0, 115.0, 117.0, 116.0, 113.0, 114.0, 113.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 140.0, 160.0, 194.0, 135.0, 159.0, 160.0, 133.0, 190.0, 140.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 166.0, 164.0, 164.0, 163.0, 164.0, 163.0, 163.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 179.0, 78.0, 77.0, 78.0, 77.0, 161.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 150.0, 87.0, 86.0, 88.0, 139.0, 86.0, 87.0, 137.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 150.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 63.0, 64.0, 62.0, 63.0, 66.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 64.0, 64.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 88.0, 93.0, 85.0, 84.0, 85.0, 114.0, 90.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 148.0, 132.0, 131.0, 144.0, 132.0, 147.0, 144.0, 145.0, 140.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 172.0, 172.0, 172.0, 179.0, 172.0, 172.0, 178.0, 176.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 69.0, 68.0, 70.0, 71.0, 68.0, 69.0, 69.0, 68.0, 67.0], "value": 69.6, "unit": "score"}]}]} 18:47:19 INFO - Return code: 0 18:47:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:47:19 ERROR - # TBPL SUCCESS # 18:47:19 INFO - Running post-action listener: _resource_record_post_action 18:47:19 INFO - ##### 18:47:19 INFO - ##### Finished run-tests step (success) 18:47:19 INFO - ##### 18:47:19 INFO - Running post-run listener: _resource_record_post_run 18:47:19 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 553902080; Read time: 12; Write time: 418356 18:47:19 INFO - TinderboxPrint: CPU usage
13.5% 18:47:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:47:19 INFO - TinderboxPrint: I/O write bytes / time
553,902,080 / 418,356 18:47:19 INFO - TinderboxPrint: CPU idle
8,265.9 (86.4%) 18:47:19 INFO - TinderboxPrint: CPU user
1,240.9 (13.0%) 18:47:19 INFO - TinderboxPrint: Swap in / out
0 / 0 18:47:19 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244875264; Read time: 0; Write time: 234140 18:47:19 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 296329216; Read time: 12; Write time: 181644 18:47:20 INFO - Running post-run listener: _upload_blobber_files 18:47:20 INFO - Blob upload gear active. 18:47:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:47:20 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 18:47:20 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'] 18:47:20 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 18:47:20 INFO - (blobuploader) - INFO - Open directory for files ... 18:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:47:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:23 INFO - (blobuploader) - INFO - Done attempting. 18:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:47:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:24 INFO - (blobuploader) - INFO - Done attempting. 18:47:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:47:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:25 INFO - (blobuploader) - INFO - Done attempting. 18:47:25 INFO - (blobuploader) - INFO - Iteration through files over. 18:47:25 INFO - Return code: 0 18:47:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:47:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:47:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d98ce2129982cf728e20ad1651f64af304ab62cb1787997e08a1b271c7354a44e07dff2ca255993a8118a8bcf3820f762e93978d901b6be6f0434ef12e423dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5fcb4eb08531c17ebdb5d9102bafe3606293dd212a65b9a7094908f96c3612f2b893ab70f6be2bac52bc363b9360d7e6bd8c49372ddd84262cb0e88edda60d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2868da1da4f5fbb84c0a4653c0832c329fc45fe124e30fe7c27ddfe4e214f4038c75e0a89c07e7ddeb946a03bc4f02bd12c9fa16951adbed74184368b0ca3bb"} 18:47:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:47:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:47:25 INFO - Contents: 18:47:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d98ce2129982cf728e20ad1651f64af304ab62cb1787997e08a1b271c7354a44e07dff2ca255993a8118a8bcf3820f762e93978d901b6be6f0434ef12e423dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5fcb4eb08531c17ebdb5d9102bafe3606293dd212a65b9a7094908f96c3612f2b893ab70f6be2bac52bc363b9360d7e6bd8c49372ddd84262cb0e88edda60d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2868da1da4f5fbb84c0a4653c0832c329fc45fe124e30fe7c27ddfe4e214f4038c75e0a89c07e7ddeb946a03bc4f02bd12c9fa16951adbed74184368b0ca3bb"} 18:47:25 INFO - Running post-run listener: copy_logs_to_upload_dir 18:47:25 INFO - Copying logs to upload dir... 18:47:25 INFO - mkdir: /builds/slave/test/build/upload/logs 18:47:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.802756 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-16 18:47:24.450792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:24.453915) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791 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/d98ce2129982cf728e20ad1651f64af304ab62cb1787997e08a1b271c7354a44e07dff2ca255993a8118a8bcf3820f762e93978d901b6be6f0434ef12e423dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5fcb4eb08531c17ebdb5d9102bafe3606293dd212a65b9a7094908f96c3612f2b893ab70f6be2bac52bc363b9360d7e6bd8c49372ddd84262cb0e88edda60d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2868da1da4f5fbb84c0a4653c0832c329fc45fe124e30fe7c27ddfe4e214f4038c75e0a89c07e7ddeb946a03bc4f02bd12c9fa16951adbed74184368b0ca3bb"} build_url:https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/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/d98ce2129982cf728e20ad1651f64af304ab62cb1787997e08a1b271c7354a44e07dff2ca255993a8118a8bcf3820f762e93978d901b6be6f0434ef12e423dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5fcb4eb08531c17ebdb5d9102bafe3606293dd212a65b9a7094908f96c3612f2b893ab70f6be2bac52bc363b9360d7e6bd8c49372ddd84262cb0e88edda60d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d2868da1da4f5fbb84c0a4653c0832c329fc45fe124e30fe7c27ddfe4e214f4038c75e0a89c07e7ddeb946a03bc4f02bd12c9fa16951adbed74184368b0ca3bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:24.479888) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:24.480214) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466125780.382224-282055791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:24.565965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 18:47:24.566501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 18:47:24.567155) ========= ========= Total master_lag: 0.17 =========