builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1464987724.43 results: success (0) buildid: 20160603073911 builduid: 789b55693ca244739a418de3b3b8b116 revision: 99dacc787a59d79c080886f46bfe8daf61c1bd0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.430262) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.430915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.431237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.446868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.447195) ========= 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=826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 14:02:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-06-03 14:02:04 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.560583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.560962) ========= 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=826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015784 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:04.611162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 14:02:04.611556) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99dacc787a59d79c080886f46bfe8daf61c1bd0a --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 99dacc787a59d79c080886f46bfe8daf61c1bd0a --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=826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 14:02:04,690 truncating revision to first 12 chars 2016-06-03 14:02:04,690 Setting DEBUG logging. 2016-06-03 14:02:04,690 attempt 1/10 2016-06-03 14:02:04,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99dacc787a59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 14:02:06,090 unpacking tar archive at: fx-team-99dacc787a59/testing/mozharness/ program finished with exit code 0 elapsedTime=1.765353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 14:02:06.393178) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:06.393981) ========= script_repo_revision: 99dacc787a59d79c080886f46bfe8daf61c1bd0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:06.394965) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:06.395588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:02:06.407672) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-03 14:02:06.408001) ========= /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=826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:06 INFO - MultiFileLogger online at 20160603 14:02:06 in /builds/slave/test 14:02:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:02:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:02:06 INFO - {'append_to_log': False, 14:02:06 INFO - 'base_work_dir': '/builds/slave/test', 14:02:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:02:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:02:06 INFO - 'branch': 'Fx-Team-Non-PGO', 14:02:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:06 INFO - 'config_files': ('talos/linux_config.py',), 14:02:06 INFO - 'default_actions': ('clobber', 14:02:06 INFO - 'read-buildbot-config', 14:02:06 INFO - 'download-and-extract', 14:02:06 INFO - 'populate-webroot', 14:02:06 INFO - 'create-virtualenv', 14:02:06 INFO - 'install', 14:02:06 INFO - 'run-tests'), 14:02:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:06 INFO - 'download_minidump_stackwalk': True, 14:02:06 INFO - 'download_symbols': 'ondemand', 14:02:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:06 INFO - 'installer_path': 'installer.exe', 14:02:06 INFO - 'log_level': 'info', 14:02:06 INFO - 'log_name': 'talos', 14:02:06 INFO - 'log_to_console': True, 14:02:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:06 INFO - 'opt_config_files': (), 14:02:06 INFO - 'pip_index': False, 14:02:06 INFO - 'sps_profile': False, 14:02:06 INFO - 'sps_profile_interval': 0, 14:02:06 INFO - 'suite': 'dromaeojs-e10s', 14:02:06 INFO - 'system_bits': '32', 14:02:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:06 INFO - 'title': 'talos-linux64-ix-052', 14:02:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:06 INFO - 'use_talos_json': True, 14:02:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:02:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:06 INFO - 'work_dir': 'build'} 14:02:06 INFO - ##### 14:02:06 INFO - ##### Running clobber step. 14:02:06 INFO - ##### 14:02:06 INFO - Running pre-action listener: _resource_record_pre_action 14:02:06 INFO - Running main action method: clobber 14:02:06 INFO - rmtree: /builds/slave/test/build 14:02:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:02:07 INFO - Running post-action listener: _resource_record_post_action 14:02:07 INFO - ##### 14:02:07 INFO - ##### Finished clobber step (success) 14:02:07 INFO - ##### 14:02:07 INFO - ##### 14:02:07 INFO - ##### Running read-buildbot-config step. 14:02:07 INFO - ##### 14:02:07 INFO - Running pre-action listener: _resource_record_pre_action 14:02:07 INFO - Running main action method: read_buildbot_config 14:02:07 INFO - Using buildbot properties: 14:02:07 INFO - { 14:02:07 INFO - "project": "", 14:02:07 INFO - "product": "firefox", 14:02:07 INFO - "script_repo_revision": "production", 14:02:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:02:07 INFO - "repository": "", 14:02:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:02:07 INFO - "buildid": "20160603073911", 14:02:07 INFO - "pgo_build": "False", 14:02:07 INFO - "basedir": "/builds/slave/test", 14:02:07 INFO - "buildnumber": 1555, 14:02:07 INFO - "slavename": "talos-linux64-ix-052", 14:02:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:02:07 INFO - "platform": "ubuntu64_hw", 14:02:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:02:07 INFO - "branch": "fx-team", 14:02:07 INFO - "repo_path": "integration/fx-team", 14:02:07 INFO - "revision": "99dacc787a59d79c080886f46bfe8daf61c1bd0a", 14:02:07 INFO - "stage_platform": "linux64", 14:02:07 INFO - "builduid": "789b55693ca244739a418de3b3b8b116", 14:02:07 INFO - "slavebuilddir": "test" 14:02:07 INFO - } 14:02:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:02:07 INFO - Running post-action listener: _resource_record_post_action 14:02:07 INFO - ##### 14:02:07 INFO - ##### Finished read-buildbot-config step (success) 14:02:07 INFO - ##### 14:02:07 INFO - ##### 14:02:07 INFO - ##### Running download-and-extract step. 14:02:07 INFO - ##### 14:02:07 INFO - Running pre-action listener: _resource_record_pre_action 14:02:07 INFO - Running main action method: download_and_extract 14:02:07 INFO - mkdir: /builds/slave/test/build/tests 14:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:07 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:02:07 INFO - Downloaded 1361 bytes. 14:02:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:07 INFO - Using the following test package requirements: 14:02:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:02:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'jsshell-linux-x86_64.zip'], 14:02:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:07 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:08 INFO - Downloaded 22868152 bytes. 14:02:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:02:10 INFO - Return code: 0 14:02:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:10 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:11 INFO - Downloaded 22868152 bytes. 14:02:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:02:12 INFO - Return code: 0 14:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:12 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:02:14 INFO - Downloaded 10833369 bytes. 14:02:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:02:14 INFO - Return code: 0 14:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:14 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:02:15 INFO - Downloaded 55170158 bytes. 14:02:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:15 INFO - mkdir: /builds/slave/test/properties 14:02:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:15 INFO - Contents: 14:02:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:16 INFO - Running post-action listener: _resource_record_post_action 14:02:16 INFO - Running post-action listener: set_extra_try_arguments 14:02:16 INFO - ##### 14:02:16 INFO - ##### Finished download-and-extract step (success) 14:02:16 INFO - ##### 14:02:16 INFO - ##### 14:02:16 INFO - ##### Running populate-webroot step. 14:02:16 INFO - ##### 14:02:16 INFO - Running pre-action listener: _resource_record_pre_action 14:02:16 INFO - Running main action method: populate_webroot 14:02:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:16 INFO - '--tppagecycles', 14:02:16 INFO - '7'], 14:02:16 INFO - 'tests': ['tsvgm']}}, 14:02:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:02:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:02:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:02:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['damp', 'tps']}, 14:02:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'tests': ['damp', 'tps']}, 14:02:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['dromaeo_dom']}, 14:02:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['a11yr', 14:02:16 INFO - 'ts_paint', 14:02:16 INFO - 'tpaint', 14:02:16 INFO - 'sessionrestore', 14:02:16 INFO - 'sessionrestore_no_auto_restore', 14:02:16 INFO - 'tabpaint']}, 14:02:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:02:16 INFO - 'ts_paint', 14:02:16 INFO - 'tpaint', 14:02:16 INFO - 'sessionrestore', 14:02:16 INFO - 'sessionrestore_no_auto_restore', 14:02:16 INFO - 'tabpaint']}, 14:02:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:02:16 INFO - 'ts_paint', 14:02:16 INFO - 'tpaint', 14:02:16 INFO - 'sessionrestore', 14:02:16 INFO - 'sessionrestore_no_auto_restore', 14:02:16 INFO - 'tabpaint']}, 14:02:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:02:16 INFO - 'ts_paint', 14:02:16 INFO - 'tpaint', 14:02:16 INFO - 'sessionrestore', 14:02:16 INFO - 'sessionrestore_no_auto_restore', 14:02:16 INFO - 'tabpaint']}, 14:02:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['a11yr', 14:02:16 INFO - 'ts_paint', 14:02:16 INFO - 'tpaint', 14:02:16 INFO - 'sessionrestore', 14:02:16 INFO - 'sessionrestore_no_auto_restore', 14:02:16 INFO - 'tabpaint']}, 14:02:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['a11yr', 14:02:16 INFO - 'ts_paint', 14:02:16 INFO - 'tpaint', 14:02:16 INFO - 'sessionrestore', 14:02:16 INFO - 'sessionrestore_no_auto_restore', 14:02:16 INFO - 'tabpaint']}, 14:02:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['tsvgx', 14:02:16 INFO - 'tsvgr_opacity', 14:02:16 INFO - 'tart', 14:02:16 INFO - 'tscrollx', 14:02:16 INFO - 'cart']}, 14:02:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:02:16 INFO - 'tsvgr_opacity', 14:02:16 INFO - 'tart', 14:02:16 INFO - 'tscrollx', 14:02:16 INFO - 'cart']}, 14:02:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'talos_options': ['--disable-e10s'], 14:02:16 INFO - 'tests': ['tp5o']}, 14:02:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'tests': ['tp5o']}, 14:02:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'talos_options': ['--disable-e10s', 14:02:16 INFO - '--xperf_path', 14:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:16 INFO - 'tests': ['tp5n']}, 14:02:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:16 INFO - 'talos_options': ['--xperf_path', 14:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:16 INFO - 'tests': ['tp5n']}}, 14:02:16 INFO - 'talos.zip': {'path': '', 14:02:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:16 INFO - Running post-action listener: _resource_record_post_action 14:02:16 INFO - ##### 14:02:16 INFO - ##### Finished populate-webroot step (success) 14:02:16 INFO - ##### 14:02:16 INFO - ##### 14:02:16 INFO - ##### Running create-virtualenv step. 14:02:16 INFO - ##### 14:02:16 INFO - Running pre-action listener: _resource_record_pre_action 14:02:16 INFO - Running main action method: create_virtualenv 14:02:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:02:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:16 INFO - Using real prefix '/usr' 14:02:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:19 INFO - Installing pip.................done. 14:02:19 INFO - Return code: 0 14:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:02:19 INFO - Using env: {'DISPLAY': ':0', 14:02:19 INFO - 'HOME': '/home/cltbld', 14:02:19 INFO - 'LANG': 'en_US.UTF-8', 14:02:19 INFO - 'LANGUAGE': 'en_US:en', 14:02:19 INFO - 'LOGNAME': 'cltbld', 14:02:19 INFO - 'MAIL': '/var/mail/cltbld', 14:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:19 INFO - 'MOZ_NO_REMOTE': '1', 14:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:19 INFO - 'NO_EM_RESTART': '1', 14:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:19 INFO - 'PWD': '/builds/slave/test', 14:02:19 INFO - 'SHELL': '/bin/bash', 14:02:19 INFO - 'SHLVL': '1', 14:02:19 INFO - 'TERM': 'linux', 14:02:19 INFO - 'TMOUT': '86400', 14:02:19 INFO - 'USER': 'cltbld', 14:02:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:19 INFO - '_': '/tools/buildbot/bin/python'} 14:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:02:19 INFO - Cleaning up... 14:02:19 INFO - Return code: 0 14:02:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:02:19 INFO - Using env: {'DISPLAY': ':0', 14:02:19 INFO - 'HOME': '/home/cltbld', 14:02:19 INFO - 'LANG': 'en_US.UTF-8', 14:02:19 INFO - 'LANGUAGE': 'en_US:en', 14:02:19 INFO - 'LOGNAME': 'cltbld', 14:02:19 INFO - 'MAIL': '/var/mail/cltbld', 14:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:19 INFO - 'MOZ_NO_REMOTE': '1', 14:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:19 INFO - 'NO_EM_RESTART': '1', 14:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:19 INFO - 'PWD': '/builds/slave/test', 14:02:19 INFO - 'SHELL': '/bin/bash', 14:02:19 INFO - 'SHLVL': '1', 14:02:19 INFO - 'TERM': 'linux', 14:02:19 INFO - 'TMOUT': '86400', 14:02:19 INFO - 'USER': 'cltbld', 14:02:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:19 INFO - '_': '/tools/buildbot/bin/python'} 14:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:19 INFO - Downloading/unpacking psutil>=3.1.1 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:25 INFO - Installing collected packages: psutil 14:02:25 INFO - Running setup.py install for psutil 14:02:25 INFO - building 'psutil._psutil_linux' extension 14:02:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:02:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:02:25 INFO - building 'psutil._psutil_posix' extension 14:02:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:02:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:02:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:25 INFO - Successfully installed psutil 14:02:25 INFO - Cleaning up... 14:02:25 INFO - Return code: 0 14:02:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:25 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:02:25 INFO - Using env: {'DISPLAY': ':0', 14:02:25 INFO - 'HOME': '/home/cltbld', 14:02:25 INFO - 'LANG': 'en_US.UTF-8', 14:02:25 INFO - 'LANGUAGE': 'en_US:en', 14:02:25 INFO - 'LOGNAME': 'cltbld', 14:02:25 INFO - 'MAIL': '/var/mail/cltbld', 14:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:25 INFO - 'MOZ_NO_REMOTE': '1', 14:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:25 INFO - 'NO_EM_RESTART': '1', 14:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:25 INFO - 'PWD': '/builds/slave/test', 14:02:25 INFO - 'SHELL': '/bin/bash', 14:02:25 INFO - 'SHLVL': '1', 14:02:25 INFO - 'TERM': 'linux', 14:02:25 INFO - 'TMOUT': '86400', 14:02:25 INFO - 'USER': 'cltbld', 14:02:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:25 INFO - '_': '/tools/buildbot/bin/python'} 14:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:02:27 INFO - Installing collected packages: mozsystemmonitor 14:02:27 INFO - Running setup.py install for mozsystemmonitor 14:02:27 INFO - Successfully installed mozsystemmonitor 14:02:27 INFO - Cleaning up... 14:02:27 INFO - Return code: 0 14:02:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:27 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:02:27 INFO - Using env: {'DISPLAY': ':0', 14:02:27 INFO - 'HOME': '/home/cltbld', 14:02:27 INFO - 'LANG': 'en_US.UTF-8', 14:02:27 INFO - 'LANGUAGE': 'en_US:en', 14:02:27 INFO - 'LOGNAME': 'cltbld', 14:02:27 INFO - 'MAIL': '/var/mail/cltbld', 14:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:27 INFO - 'MOZ_NO_REMOTE': '1', 14:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:27 INFO - 'NO_EM_RESTART': '1', 14:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:27 INFO - 'PWD': '/builds/slave/test', 14:02:27 INFO - 'SHELL': '/bin/bash', 14:02:27 INFO - 'SHLVL': '1', 14:02:27 INFO - 'TERM': 'linux', 14:02:27 INFO - 'TMOUT': '86400', 14:02:27 INFO - 'USER': 'cltbld', 14:02:27 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:27 INFO - '_': '/tools/buildbot/bin/python'} 14:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:30 INFO - warning: no files found matching '*.txt' 14:02:30 INFO - no previously-included directories found matching 'build' 14:02:30 INFO - no previously-included directories found matching 'dist' 14:02:30 INFO - no previously-included directories found matching '.git*' 14:02:30 INFO - Installing collected packages: jsonschema, functools32 14:02:30 INFO - Running setup.py install for functools32 14:02:30 INFO - warning: no files found matching '*.txt' 14:02:30 INFO - no previously-included directories found matching 'build' 14:02:30 INFO - no previously-included directories found matching 'dist' 14:02:30 INFO - no previously-included directories found matching '.git*' 14:02:30 INFO - Successfully installed jsonschema functools32 14:02:30 INFO - Cleaning up... 14:02:30 INFO - Return code: 0 14:02:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:02:30 INFO - Using env: {'DISPLAY': ':0', 14:02:30 INFO - 'HOME': '/home/cltbld', 14:02:30 INFO - 'LANG': 'en_US.UTF-8', 14:02:30 INFO - 'LANGUAGE': 'en_US:en', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MAIL': '/var/mail/cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SHLVL': '1', 14:02:30 INFO - 'TERM': 'linux', 14:02:30 INFO - 'TMOUT': '86400', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - '_': '/tools/buildbot/bin/python'} 14:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:33 INFO - Downloading docopt-0.6.1.tar.gz 14:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:33 INFO - Running setup.py install for blobuploader 14:02:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:33 INFO - Running setup.py install for requests 14:02:33 INFO - Running setup.py install for docopt 14:02:33 INFO - Successfully installed blobuploader requests docopt 14:02:33 INFO - Cleaning up... 14:02:33 INFO - Return code: 0 14:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:33 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:33 INFO - Using env: {'DISPLAY': ':0', 14:02:33 INFO - 'HOME': '/home/cltbld', 14:02:33 INFO - 'LANG': 'en_US.UTF-8', 14:02:33 INFO - 'LANGUAGE': 'en_US:en', 14:02:33 INFO - 'LOGNAME': 'cltbld', 14:02:33 INFO - 'MAIL': '/var/mail/cltbld', 14:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:33 INFO - 'MOZ_NO_REMOTE': '1', 14:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:33 INFO - 'NO_EM_RESTART': '1', 14:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:33 INFO - 'PWD': '/builds/slave/test', 14:02:33 INFO - 'SHELL': '/bin/bash', 14:02:33 INFO - 'SHLVL': '1', 14:02:33 INFO - 'TERM': 'linux', 14:02:33 INFO - 'TMOUT': '86400', 14:02:33 INFO - 'USER': 'cltbld', 14:02:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:33 INFO - '_': '/tools/buildbot/bin/python'} 14:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:34 INFO - Running setup.py (path:/tmp/pip-hiQy2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:34 INFO - Running setup.py (path:/tmp/pip-bThTYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:34 INFO - Running setup.py (path:/tmp/pip-B4I4F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:34 INFO - Running setup.py (path:/tmp/pip-fY0GuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:34 INFO - Running setup.py (path:/tmp/pip-fxRssb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:34 INFO - Running setup.py (path:/tmp/pip-5xOUQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:34 INFO - Running setup.py (path:/tmp/pip-BoGJSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:34 INFO - Running setup.py (path:/tmp/pip-NX_vtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:34 INFO - Running setup.py (path:/tmp/pip-_cYbKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:34 INFO - Running setup.py (path:/tmp/pip-bSJtah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:34 INFO - Running setup.py (path:/tmp/pip-pdJ3sF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:34 INFO - Running setup.py (path:/tmp/pip-ULIDfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:34 INFO - Running setup.py (path:/tmp/pip-JdFydu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:35 INFO - Running setup.py (path:/tmp/pip-L1U7xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:35 INFO - Running setup.py (path:/tmp/pip-D6BNna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:35 INFO - Running setup.py (path:/tmp/pip-CcjPq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:35 INFO - Running setup.py (path:/tmp/pip-HJ8SWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:35 INFO - Running setup.py install for manifestparser 14:02:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozcrash 14:02:35 INFO - Running setup.py install for mozdebug 14:02:35 INFO - Running setup.py install for mozdevice 14:02:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozfile 14:02:35 INFO - Running setup.py install for mozhttpd 14:02:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozinfo 14:02:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozInstall 14:02:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozleak 14:02:36 INFO - Running setup.py install for mozlog 14:02:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for moznetwork 14:02:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozprocess 14:02:36 INFO - Running setup.py install for mozprofile 14:02:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozrunner 14:02:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozscreenshot 14:02:36 INFO - Running setup.py install for moztest 14:02:37 INFO - Running setup.py install for mozversion 14:02:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:37 INFO - Cleaning up... 14:02:37 INFO - Return code: 0 14:02:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:37 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:37 INFO - Using env: {'DISPLAY': ':0', 14:02:37 INFO - 'HOME': '/home/cltbld', 14:02:37 INFO - 'LANG': 'en_US.UTF-8', 14:02:37 INFO - 'LANGUAGE': 'en_US:en', 14:02:37 INFO - 'LOGNAME': 'cltbld', 14:02:37 INFO - 'MAIL': '/var/mail/cltbld', 14:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:37 INFO - 'MOZ_NO_REMOTE': '1', 14:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:37 INFO - 'NO_EM_RESTART': '1', 14:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:37 INFO - 'PWD': '/builds/slave/test', 14:02:37 INFO - 'SHELL': '/bin/bash', 14:02:37 INFO - 'SHLVL': '1', 14:02:37 INFO - 'TERM': 'linux', 14:02:37 INFO - 'TMOUT': '86400', 14:02:37 INFO - 'USER': 'cltbld', 14:02:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:37 INFO - '_': '/tools/buildbot/bin/python'} 14:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:37 INFO - Running setup.py (path:/tmp/pip-LQmOy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:37 INFO - Running setup.py (path:/tmp/pip-Mkykpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:37 INFO - Running setup.py (path:/tmp/pip-girbdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:37 INFO - Running setup.py (path:/tmp/pip-GELGvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:37 INFO - Running setup.py (path:/tmp/pip-UrEHCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:37 INFO - Running setup.py (path:/tmp/pip-lq7IzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:37 INFO - Running setup.py (path:/tmp/pip-ZMZSRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:37 INFO - Running setup.py (path:/tmp/pip-uhVwpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:37 INFO - Running setup.py (path:/tmp/pip-ZHQaMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:38 INFO - Running setup.py (path:/tmp/pip-pHlytV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:38 INFO - Running setup.py (path:/tmp/pip-PxUKrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:38 INFO - Running setup.py (path:/tmp/pip-5UdYr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:38 INFO - Running setup.py (path:/tmp/pip-utNZtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:38 INFO - Running setup.py (path:/tmp/pip-_YPxGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:38 INFO - Running setup.py (path:/tmp/pip-kL5qHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:38 INFO - Running setup.py (path:/tmp/pip-Rw5lxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:38 INFO - Running setup.py (path:/tmp/pip-R_yf8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:40 INFO - Downloading blessings-1.6.tar.gz 14:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:40 INFO - Installing collected packages: blessings 14:02:40 INFO - Running setup.py install for blessings 14:02:40 INFO - Successfully installed blessings 14:02:40 INFO - Cleaning up... 14:02:40 INFO - Return code: 0 14:02:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:40 INFO - Reading from file tmpfile_stdout 14:02:40 INFO - Current package versions: 14:02:40 INFO - argparse == 1.2.1 14:02:40 INFO - blessings == 1.6 14:02:40 INFO - blobuploader == 1.2.4 14:02:40 INFO - docopt == 0.6.1 14:02:40 INFO - functools32 == 3.2.3-2 14:02:40 INFO - jsonschema == 2.5.1 14:02:40 INFO - manifestparser == 1.1 14:02:40 INFO - mozInstall == 1.12 14:02:40 INFO - mozcrash == 0.17 14:02:40 INFO - mozdebug == 0.1 14:02:40 INFO - mozdevice == 0.48 14:02:40 INFO - mozfile == 1.2 14:02:40 INFO - mozhttpd == 0.7 14:02:40 INFO - mozinfo == 0.9 14:02:40 INFO - mozleak == 0.1 14:02:40 INFO - mozlog == 3.2 14:02:40 INFO - moznetwork == 0.27 14:02:40 INFO - mozprocess == 0.22 14:02:40 INFO - mozprofile == 0.28 14:02:40 INFO - mozrunner == 6.11 14:02:40 INFO - mozscreenshot == 0.1 14:02:40 INFO - mozsystemmonitor == 0.3 14:02:40 INFO - moztest == 0.7 14:02:40 INFO - mozversion == 1.4 14:02:40 INFO - psutil == 3.1.1 14:02:40 INFO - requests == 1.2.3 14:02:40 INFO - wsgiref == 0.1.2 14:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:40 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:40 INFO - Using env: {'DISPLAY': ':0', 14:02:40 INFO - 'HOME': '/home/cltbld', 14:02:40 INFO - 'LANG': 'en_US.UTF-8', 14:02:40 INFO - 'LANGUAGE': 'en_US:en', 14:02:40 INFO - 'LOGNAME': 'cltbld', 14:02:40 INFO - 'MAIL': '/var/mail/cltbld', 14:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:40 INFO - 'MOZ_NO_REMOTE': '1', 14:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:40 INFO - 'NO_EM_RESTART': '1', 14:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:40 INFO - 'PWD': '/builds/slave/test', 14:02:40 INFO - 'SHELL': '/bin/bash', 14:02:40 INFO - 'SHLVL': '1', 14:02:40 INFO - 'TERM': 'linux', 14:02:40 INFO - 'TMOUT': '86400', 14:02:40 INFO - 'USER': 'cltbld', 14:02:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:40 INFO - '_': '/tools/buildbot/bin/python'} 14:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:02:41 INFO - Cleaning up... 14:02:41 INFO - Return code: 0 14:02:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:41 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:02:41 INFO - Using env: {'DISPLAY': ':0', 14:02:41 INFO - 'HOME': '/home/cltbld', 14:02:41 INFO - 'LANG': 'en_US.UTF-8', 14:02:41 INFO - 'LANGUAGE': 'en_US:en', 14:02:41 INFO - 'LOGNAME': 'cltbld', 14:02:41 INFO - 'MAIL': '/var/mail/cltbld', 14:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:41 INFO - 'MOZ_NO_REMOTE': '1', 14:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:41 INFO - 'NO_EM_RESTART': '1', 14:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:41 INFO - 'PWD': '/builds/slave/test', 14:02:41 INFO - 'SHELL': '/bin/bash', 14:02:41 INFO - 'SHLVL': '1', 14:02:41 INFO - 'TERM': 'linux', 14:02:41 INFO - 'TMOUT': '86400', 14:02:41 INFO - 'USER': 'cltbld', 14:02:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:41 INFO - '_': '/tools/buildbot/bin/python'} 14:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:02:41 INFO - Cleaning up... 14:02:41 INFO - Return code: 0 14:02:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:41 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 0x7fa9c680cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:02:41 INFO - Using env: {'DISPLAY': ':0', 14:02:41 INFO - 'HOME': '/home/cltbld', 14:02:41 INFO - 'LANG': 'en_US.UTF-8', 14:02:41 INFO - 'LANGUAGE': 'en_US:en', 14:02:41 INFO - 'LOGNAME': 'cltbld', 14:02:41 INFO - 'MAIL': '/var/mail/cltbld', 14:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:41 INFO - 'MOZ_NO_REMOTE': '1', 14:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:41 INFO - 'NO_EM_RESTART': '1', 14:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:41 INFO - 'PWD': '/builds/slave/test', 14:02:41 INFO - 'SHELL': '/bin/bash', 14:02:41 INFO - 'SHLVL': '1', 14:02:41 INFO - 'TERM': 'linux', 14:02:41 INFO - 'TMOUT': '86400', 14:02:41 INFO - 'USER': 'cltbld', 14:02:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:41 INFO - '_': '/tools/buildbot/bin/python'} 14:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:41 INFO - Downloading/unpacking flake8 14:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:44 INFO - no previously-included directories found matching 'docs/_build' 14:02:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:44 INFO - Running setup.py install for pep8 14:02:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:44 INFO - no previously-included directories found matching 'docs/_build' 14:02:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:02:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:44 INFO - Cleaning up... 14:02:44 INFO - Return code: 0 14:02:44 INFO - Running post-action listener: _resource_record_post_action 14:02:44 INFO - Running post-action listener: _start_resource_monitoring 14:02:44 INFO - Starting resource monitoring. 14:02:44 INFO - ##### 14:02:44 INFO - ##### Finished create-virtualenv step (success) 14:02:44 INFO - ##### 14:02:44 INFO - ##### 14:02:44 INFO - ##### Running install step. 14:02:44 INFO - ##### 14:02:44 INFO - Running pre-action listener: _resource_record_pre_action 14:02:44 INFO - Running main action method: install 14:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:44 INFO - Reading from file tmpfile_stdout 14:02:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:44 INFO - Reading from file tmpfile_stdout 14:02:44 INFO - Output received: 14:02:44 INFO - Usage: mozinstall [options] installer 14:02:44 INFO - Options: 14:02:44 INFO - -h, --help show this help message and exit 14:02:44 INFO - -d DEST, --destination=DEST 14:02:44 INFO - Directory to install application into. [default: 14:02:44 INFO - "/builds/slave/test"] 14:02:44 INFO - --app=APP Application being installed. [default: firefox] 14:02:44 INFO - mkdir: /builds/slave/test/build/application 14:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:03:00 INFO - Reading from file tmpfile_stdout 14:03:00 INFO - Output received: 14:03:00 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:00 INFO - Running post-action listener: _resource_record_post_action 14:03:00 INFO - ##### 14:03:00 INFO - ##### Finished install step (success) 14:03:00 INFO - ##### 14:03:00 INFO - ##### 14:03:00 INFO - ##### Running run-tests step. 14:03:00 INFO - ##### 14:03:00 INFO - Running pre-action listener: _resource_record_pre_action 14:03:00 INFO - Running main action method: run_tests 14:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:00 INFO - Python 2.7.3 14:03:00 INFO - Return code: 0 14:03:00 INFO - grabbing minidump binary from tooltool 14:03: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')]} 14:03:00 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 0x1eaa2e0>, '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 0x1e16140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e165d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:03:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:03:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:03:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:00 INFO - Return code: 0 14:03:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:03:01 INFO - Return code: 0 14:03:01 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/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:03:01 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/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:03:01 INFO - Using env: {'DISPLAY': ':0', 14:03:01 INFO - 'HOME': '/home/cltbld', 14:03:01 INFO - 'LANG': 'en_US.UTF-8', 14:03:01 INFO - 'LANGUAGE': 'en_US:en', 14:03:01 INFO - 'LOGNAME': 'cltbld', 14:03:01 INFO - 'MAIL': '/var/mail/cltbld', 14:03:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:01 INFO - 'MOZ_NO_REMOTE': '1', 14:03:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:01 INFO - 'NO_EM_RESTART': '1', 14:03:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:01 INFO - 'PWD': '/builds/slave/test', 14:03:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:01 INFO - 'SHELL': '/bin/bash', 14:03:01 INFO - 'SHLVL': '1', 14:03:01 INFO - 'TERM': 'linux', 14:03:01 INFO - 'TMOUT': '86400', 14:03:01 INFO - 'USER': 'cltbld', 14:03:01 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467', 14:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:01 INFO - '_': '/tools/buildbot/bin/python'} 14:03:01 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/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:03:01 INFO - mozversion application_buildid: 20160603073911 14:03:01 INFO - mozversion application_changeset: 99dacc787a59d79c080886f46bfe8daf61c1bd0a 14:03:01 INFO - mozversion application_display_name: Nightly 14:03:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:01 INFO - mozversion application_name: Firefox 14:03:01 INFO - mozversion application_remotingname: firefox 14:03:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:03:01 INFO - mozversion application_vendor: Mozilla 14:03:01 INFO - mozversion application_version: 49.0a1 14:03:01 INFO - mozversion platform_buildid: 20160603073911 14:03:01 INFO - mozversion platform_changeset: 99dacc787a59d79c080886f46bfe8daf61c1bd0a 14:03:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:03:01 INFO - mozversion platform_version: 49.0a1 14:03:01 INFO - using testdate: 1464987781 14:03:01 INFO - actual date: 1464987781 14:03:01 INFO - starting webserver on 'localhost:45060' 14:03:01 INFO - SUITE-START | Running 2 tests 14:03:01 INFO - TEST-START | dromaeo_css 14:03:01 INFO - operating with platform_type : linux_ 14:03:01 INFO - Initialising browser for dromaeo_css test... 14:03:01 INFO - TEST-INFO | started process 24751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqFhna/profile http://localhost:45060/getInfo.html) 14:03:06 INFO - PROCESS | 24751 | __metrics Screen width/height:1600/1200 14:03:06 INFO - PROCESS | 24751 | colorDepth:24 14:03:06 INFO - PROCESS | 24751 | Browser inner width/height: 1024/697 14:03:06 INFO - PROCESS | 24751 | __metrics 14:03:07 ERROR - PROCESS | 24751 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:03:08 INFO - TEST-INFO | 24751: exit 0 14:03:08 INFO - Browser initialized. 14:03:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:08 INFO - TEST-INFO | started process 24868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqFhna/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:20 INFO - PROCESS | 24868 | RSS: Main: 168390656 14:03:20 INFO - PROCESS | 24868 | 14:04:09 INFO - PROCESS | 24868 | 1464987849690 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:06:21 INFO - PROCESS | 24868 | Cycle 1(1): loaded http://localhost:45060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45060/tests/dromaeo/cssquery-ext.html) 14:06:22 INFO - PROCESS | 24868 | RSS: Main: 170950656 14:06:22 INFO - PROCESS | 24868 | 14:09:24 INFO - PROCESS | 24868 | Cycle 1(1): loaded http://localhost:45060/tests/dromaeo/cssquery-ext.html (next: http://localhost:45060/tests/dromaeo/cssquery-jquery.html) 14:09:25 INFO - PROCESS | 24868 | RSS: Main: 170328064 14:09:25 INFO - PROCESS | 24868 | 14:12:27 INFO - PROCESS | 24868 | Cycle 1(1): loaded http://localhost:45060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45060/tests/dromaeo/cssquery-mootools.html) 14:12:27 INFO - PROCESS | 24868 | RSS: Main: 171704320 14:12:27 INFO - PROCESS | 24868 | 14:15:29 INFO - PROCESS | 24868 | Cycle 1(1): loaded http://localhost:45060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45060/tests/dromaeo/cssquery-prototype.html) 14:15:30 INFO - PROCESS | 24868 | RSS: Main: 169086976 14:15:30 INFO - PROCESS | 24868 | 14:18:33 INFO - PROCESS | 24868 | Cycle 1(1): loaded http://localhost:45060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45060/tests/dromaeo/cssquery-yui.html) 14:18:33 INFO - PROCESS | 24868 | RSS: Main: 170221568 14:18:33 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | Cycle 1(1): loaded http://localhost:45060/tests/dromaeo/cssquery-yui.html (next: http://localhost:45060/tests/dromaeo/cssquery-dojo.html) 14:21:36 INFO - PROCESS | 24868 | RSS: Main: 172003328 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | __start_tp_report 14:21:36 INFO - PROCESS | 24868 | _x_x_mozilla_page_load 14:21:36 INFO - PROCESS | 24868 | _x_x_mozilla_page_load_details 14:21:36 INFO - PROCESS | 24868 | |i|pagename|runs| 14:21:36 INFO - PROCESS | 24868 | |0;dojo.html;2673.2648521656547;2723.605077263797;2745.6567929008875;2749.5188342040137;2752.4495100979807;4681.297805329198;4735.1240020596215;4740.123077230711;4836.540528649782;4873.610111191105;4711.293306004101;4801.759912004394;4831.975840120804;4854.611631069515;4859.343988561552;4376.431063961681;4406.801693923781;4478.910421791562;4525.366448697185;4529.094181163764;4177.268977928866;4508.233600287943;4520.97739511302;4592.563706447899;4593.448786145667;4299.78501074945;4381.298992161271;4382.0797632497215;4398;4539.682222244444;4372.628326592244;4383.320585309282;4452.799624016927;4470.508244093147;4478.552144785528;4407.272799987998;4427.645788336926;4436.778161091965;4457.710248833848;4485.618722408599;4659;4712.952870471286;4732.1482133216;4741.478437371887;4762.190427627312;5185.248139019859;5195.220716892459;5198.324217851693;5200.349956255468;5260.473952604747;5069.340985671839;5124.9743751281;5198.610104242197;5220.112580861262;5220.504052115043;4832.444268909086;4864.951350486521;4888.7311197884455;4908.337374454474;4966.255061740731;5344.465553444625;5364.168553874156;5372.597055220874;5377.704226267515;5414.07960646691;4930.950690493121;5005.099082165245;5053.898922021539;5121.206213036985;5142.948570514322;5005.89988200234;5126.231065340229;5145.562627176732;5183;5219.1388420910125;5039.521245481674;5058.266551350107;5101.260317254051;5113.105206588906;5121;5014.072396606566;5041.495850414929;5099.566536844335;5106.259592359087;5167.715775632376;4354.586314300136;4355.564443555682;4359.738415695068;4393.319035549495;4399.73601583906;3795.1271207622403;3817.4846395736777;3822.9235415292096;3827.4258861171047;3896.7077469189926;4394.736315821061;4465.821367145343;4501.527339629357;4508.797104130322;4510.075434535912;5182.922256166161;5200.739963001834;5204.271402003723;5239.47605239473;5291.1798671206025;4489.820407183676;4492.438445194351;4504.662150338672;4520.4801447833925;4548.95451045492;4502.887427814331;4602.964333025043;4641.6518761092375;4649.5815376616265;4658.604018658384;4883.975580122076;4884.7313397762755;4909.4354149273295;4930.13722598551;4942.728149951788;5106.923396148986;5206.114960456807;5237.476252374732;5244.239585260192;5276.129438642581;4844.491328410466;4861.683990540603;4881.365422495195;4897.314375987294;4904.141775189399;5118.053160165233;5121.07820592297;5122.078025955364;5122.718250496258;5182.611304152279;4972.453030166751;5063.367079115111;5200.843974680765;5208.270842082187;5213.947860521346;4908.754562271801;4924.950750492592;4946.703197808143;4980.925286120639;5047.772850221675;4973.154563724248;5004.3994720633755;5005.399352077774;5008.248762685626;5045.949540504548;4765;4870.561649451566;4897.706137631753;4902.7058376497525;4913;5060.51925067118;5095.286659867547;5100.489951005018;5133.230015497706;5142.331496905378;4928.802847886044;4960.30555722192;4998.500149984972;5003.949960500348;5041.546260836542 14:21:36 INFO - PROCESS | 24868 | |1;ext.html;557.740650597472;587.5945597537701;599.3167788720859;604.0908432808625;616.5899676714984;28927.56608650872;31739.841300793494;39705.20589588206;40529;40819.18361632765;41286.58713412865;41883;41951.370729439004;41987.79006104973;42035.78982105093;7721.382289416847;7878.921210787905;7889.644965976516;7891.8421631567335;7907.5255484670815;7564.432667549956;7757.883631745528;7762.805929851771;7767.766966990999;7776.416768742339;7816.609169541529;7825.37397008238;7862.567558784264;7889.053313602376;7903.288704016637;7788.182240864712;7834.451588388843;7843.8431231375625;7844.2155784421675;7862.68549258029;7773.961130194313;7863.960680196619;7866.960665196694;7870.0949390820215;7875.684972601089;37300.62699372999;37639.4354084689;37663.4350484743;37694;37917.24165516702;3177.3168768714836;3249.301400198945;3251.951220731691;3327.2513684421056;3806.5812760596314;29442.70557294421;29588;29666.55500167499;29857;29892.252693682614;3423.298223864102;3473.6700013498676;3549.982250088759;3581.979135946269;3602.945955810665;256163;256438;256721;257337;257742.71128644425;29072.127836164527;29458.558121628193;29565.26086847846;29683.554746678816;50767.923207678934;34605.65394346075;34668.47997280043;34735;34740.47889281663;34774;12644.936775316064;12662.556810511773;12707.364631768374;12717.618471445872;12806.359682015862;9631.71104866855;9752.122308992224;9754.414735115915;9778.65774697882;9936.503174841373;7964.721234756756;7982.880256796153;8002.279794818494;8015.118336982927;8063.838723225503;3150.2439414540804;3178.55500229968;3226.596675415573;3232.3535292941506;3238.5789847319697;933.8575692793701;940.5955439161089;949.3449519831295;987.1658448610913;1097.067492631257;28231.858840706074;28686.856565717037;28909.56635650467;28944.710552894623;29131.85434072816;1007.1137399088755;1008.8184126857236;1041.5368898412808;1050.1965996013057;1161.0711430855451;14700.55898323052;15236.923815380853;15377.308021139075;15428;15563;391916;394152;394889;394913;396604;49309;49483.50516494861;49767.25349119766;49908.25137622938;50138.49861501411;1201.3092471828734;1227.5703503773607;1253.5048655781097;1255.2719422734974;1260.949562017509;27084.864575676995;28074.2981425466;28089;28496.145115645733;28539.28651783722;42469.57530424656;42525.36211956761;42578.57421425746;42741.35887961745;42774.57225427706;267634;269479;271792;271804;271984;21042.263520776698;21202.78797212008;21345.893270533546;21539.353819385444;21694.891525542273;42688.78655606702;42828;43090;43123.56876431195;43474.130517390106;35316.823415882754;36518.45222321614;36573.08567285839;36782.080447989014;36831;36049.27901442009;36365;36392.81803590965;36425.453618196276;36572.81713591415;30713.078607641808;34271.657283426845;35560.46659300061;35754.821225893706;35926.820365898006;31586.368272633958;33204.1698957528;33296;33537.832310839265;33544.66455335415;25188.748112519374;25481.49037019212;25485.3628659285;25504.489910202064;25617.359566011 14:21:36 INFO - PROCESS | 24868 | |2;jquery.html;362.82584359507433;363.09045840170376;370.2391585292223;374.32434455807277;381.9847206111756;15310.617234569141;15939.521814345573;16860.409885654004;16892.32430702772;16916.83083169168;13867.791983120262;14845.55463336099;14907.850921490783;14920.328585213665;14933;4759.666823322369;5154.5103215194495;5174.741262936857;5185.637005409623;5190.221466779994;3697.2235830475634;5048.066107770056;5642.520385767215;6029.186059881926;6031.607945483552;5972.731227094791;5986.2517185351835;6022.457978781908;6027.367126451725;6066.726997285133;5839.474447299742;6075.665838378887;6107.29766076898;6112.235970503687;6113.174721412597;5122.513361230677;5255.947440525584;5263.236830659571;5266.683998960037;5293.338332708411;19208.423747287605;19460.610787784164;19642.017899104987;19657.803421965742;19690.70463943042;1824.1335365701186;1906.9523261918425;1992.7110568967419;2024.8380129589598;2099.454141923096;12798.872011279862;12959.352032398436;13166.012549058763;13199.670008249774;13331.200127992255;1736.6787144378204;1773.698471259889;1783.5909631391185;1811.5923917118544;1837.843783278423;46346;62137.68931155315;62682.0597691035;62902.68548657227;63360;8769.298456123495;8802.91197088021;9155.084491550924;9191.816163676689;9397.859032114524;11884.286942783461;12004.459799309052;12014.879851201551;12029.398530073462;12053.698657533632;6474.741010359533;6672.366125218096;6691.0967019451755;6722.899156512656;6729.596224226562;6180.351063138396;6242.5942313749465;6345.809625711236;6347.270063942613;6378.74485020594;5672.546196304285;5896.233489646404;5983.970080149571;5996.070609055603;6000.609960352563;1505.3226048278318;1623.0991799551362;1632.5918520369908;1679.4877562343358;1719.1060648462728;893.1693525021662;920.346553946692;928.313048344234;966.2366730282997;978.5498670611456;14519.854801451851;15910.76133857993;16131.838681613033;16492.7630427716;16745;884.7345796261096;912.3567884641312;917.0645941140133;964.3297907953905;1005.2109094360892;9361.297902657328;9367.765805854771;9466.905330946602;9544.809103817885;9802.166815820592;335145;340231;344111;347472;349363;63921.68039159774;65421.67289163524;68583.65708171527;70292;74501.25498745052;955.4315182466421;962.4610218277787;989.351974456732;995.3182070281736;1001.6444162322271;15080;15101.546953591409;15116.697666046397;15285.923570382078;15649.608759781097;34587.82706086453;34846;35535;35849.82075089608;36466.08834779152;51522;51642;51695.2245716307;51797;52455.21317180169;7201.495895287279;7384.446166537424;7487.550746954982;7535.660895259836;7618.200088990576;9294;11340.829887551528;11661.825072624088;11794.76410471803;11918.225315354473;9975.102240798364;10078.092971632588;10087;10114.747131321776;10475.109615682752;9915.752106197402;9936.062467818705;10128;10249.897501024894;10335.276530643083;9549.474778887228;10155.593776249163;10201.948990255001;10509.211809114195;10753.89246107529;7626.618669066635;7654.923450765421;7718.382529397522;7738.148803631709;7740.574268415291;9649.951750241204;10260.486975651336;10347.12049475803;10458.63394781179;10536.789264214825 14:21:36 INFO - PROCESS | 24868 | |3;mootools.html;1416.7237388709202;1450.369089446091;1533.371317759718;1738.6261953679957;1756.042956588659;6658.933410665892;7566.394688424926;7581.241875812416;8071.717489887862;8075.111737708855;7628.0464941882265;7740.690372385098;7792.7662170134845;7810.882836757453;7865.370770338373;2149.2692484555287;2188.6935828983956;2190.605690975624;2196.9560608787815;2197.5385169114506;2124.915003399862;2168.8915554222303;2185.3553201805425;2199.054406605167;2199.5820794049077;2165.1880544795704;2171.337741988693;2172.565486902618;2175.4778853075304;2218.4675677837286;2084.583083383322;2107.5784843031456;2111.9894400527974;2113.619548481273;2114.8413868959738;2120.586485635302;2141.5609799990966;2160.4706846822473;2164.383150802014;2170.1644866726424;7793.103793063757;7796.766097017098;7851.685932562691;7852.528848269122;7867.370610351159;4429.53489883564;4528.8867778305475;4542.318652202163;4555.886102847422;4558.0655965526985;2894.348771526411;2926.6049083373687;2962.096560549032;2975.717306855867;3029.2729744861294;833.7123692326198;885.7608445719619;888.2228050455851;894.2667013049302;901.5492253873064;10047;10087.445190514592;10105.444200568965;10114.595416183343;10126.645567405105;4042.8584999524874;4089.7750623715388;4186.246475634415;4190.727602705814;4197.412362269285;8778.692745753868;8815.030346661862;8817.647294108165;8826.5586720665;8866.556672166365;4356.259435895905;4378.255696531597;4416.072624748775;4429.512753597101;4475.977620111878;3583.9104022399647;4010.0977280111742;4030.649732339699;4039.9192016159514;4091.6317531422314;3485.6688614581576;3519.278547897675;3610.458431235283;3634.5638523376833;3636.9818150909605;1142.657202839145;1157.5948418053783;1158.6581958322315;1160;1166.5100657723776;808.272554700774;910.4446287764458;929.5491686532026;931.6785708930408;959.098447459386;5584.804531841366;5587.8603034923635;5657.60396772222;5676.545876329884;5785.681787501644;387.6821006774418;388.4852570344249;392.48976330769887;396.15618732100444;906.057699992001;3777.9433308500393;3867.7679339239735;3952.8616498422416;4013.337799263147;4030.133521292936;9278.211352035018;9529.714108576754;9633.90366096344;9634.566444510014;9653;9417.717468475958;9615;9618.086281803218;9631;9653.951730241304;7494.21310762373;7498.062742157231;7553.055868016498;7565.546067235983;7583.2416758323725;5397.217403476396;5525.475079867406;5561.129997653736;5601.943980560142;5641.774329026793;8875.068117847792;8923.330750193632;8924.86612700797;8994;9042.81914361696;8817.515036673045;8980.86528702083;8989.146031127033;9210.171084602418;9243.352965292634;5841.649501029951;6200.81397558074;6366.80899572995;6379.138816259931;6497;7389.926100738924;7420.257974202753;7422.183559808309;7431.925680743123;7515.924840751522;6481.8703625928165;6564.704588293443;6599.967000164968;6698.263191049078;6830.077939478107;6653.900191497035;6658.400743933069;6658.500612453989;6712.429443497357;6794.966025169842;6029.457348838626;6120.357362477054;6122;6126.356732543019;6149.169862068564;4641.605463535638;4659.600305842561;4722.504137065559;4788.545088216614;4801.759912004456;4640.280756482751;4647.930281045855;4659.603933665677;4714.481407045291;4755.5719985201495 14:21:36 INFO - PROCESS | 24868 | |4;prototype.html;283.61570072551694;294.0868602987723;294.8275258973501;299.4579810542916;302.36201614593193;4756.26277926921;4827.8310259140935;4929.580985616222;4993.775280112394;5003.62472814539;4856.174450343441;4865.367502224706;4892.26616007599;4907.5583197512215;4928.975355123228;3914.4324073009398;3917.5690674025836;3917.8824635260844;3919.8824035278985;3919.9804000980025;3584.6415358464205;3911.452396664455;3916.4908561886914;3920.490336256297;3931.862384816532;3769.491118698968;3772.641599048086;3776.45241439991;3778.8488460461685;3796.6013568575318;3775.3959366501504;3781.5462144542694;3788.7537310074895;3793.506844110276;3813.7902415367143;3225.5322978168033;3325.700686938187;3328.9667103329143;3333.666633336671;3347.807186292982;4743.691660042086;4746.644001699887;4750.406199225097;4751.837913749236;4763.595094416979;4374.321980093091;4375.6937014409;4376.256036473807;4380.649548036149;4386.978065109654;4951.653384263103;5147.562457191143;5157.948420515784;5159.484051594848;5163.45096471061;3640.1809592841664;3647;3655.0131464504434;3657.6708096271464;3670.944935825965;5428.4842939920645;5458.863528411782;5459.208414779835;5480.6437581557075;5480.671159730389;3705.3515634763808;3706.388445906395;3707.295613833363;3719.5350581177354;3724.832382542792;3682.1531047859144;3787.110029143149;3789.450529673182;3792.070942619076;3799.2781371539318;4283.672061660895;4313.439252897166;4321.935170972375;4342.32693932441;4355.956440435619;5143.402581696219;5164.48355164488;5176.534111929945;5185.9740701297005;5191.922121168185;1224.2837939805136;1274.388293619068;1301.8567957524665;1305.849827269857;1308.4896890212824;802.7993001749562;812.3582369927809;836.8451836410284;837.4640230252643;844.4004756622867;4069.369247766601;4089.1208390196252;4098.118904435561;4109.445224894601;4115.58012485692;4704.600108990706;4727.267273572533;4733.242681170997;4744.7627618618935;4749.525047495292;4076.9603751043296;4085.7344272622186;4123.9381409278885;4125;4141.503019637603;2536.9112081077074;2647.205838248518;2875.3674191677796;2877.7985541011926;2894.1751600793673;4974.427940786856;5040.026384433202;5047.974760126176;5061.417936937226;5071.909539449036;5349.304590403222;5474.591179880839;5492.395836457987;5516.448355164532;5527.115661494142;5045.495450454925;5058.645894787403;5069.7465126744255;5072.974635126875;5094.949050509447;5366;5369.919451208313;5376.086065368819;5379.704116273642;5392.5416339611575;5087.084324821568;5265.921011184912;5268.341457317835;5296.814611488579;5327.22755200486;5016.2224855147515;5059;5064.455341120846;5087.974560127176;5090.4655011223285;3605.837737301775;3630.1287690953454;3631.8184090795885;3654.926901462009;3671.30245253401;5220.895582088413;5324.227986941794;5344.171653393731;5352.919706204488;5363.283749200218;5163.561097306771;5204.397801099451;5204.453532379197;5204.501839117169;5213.45258747826;5118.590512758896;5188.58491320701;5189.379363421448;5189.662671926313;5206.229881840192;4882.483702575033;5111.64218504716;5122.206058061007;5123.6157288202785;5129.615278854027;5125.43620201785;5139.383274007143;5146.305248791515;5149.819756308661;5206.765695543634;5020.748962551931;5035.84892453227;5040.202687508468;5048.217526283432;5063.620228482805 14:21:36 INFO - PROCESS | 24868 | |5;yui.html;607.9817605471837;609.3206075226122;633.3223450907528;648.157395385998;681.2744427185046;12214.145009849313;12820.67948301293;13005.934970325146;13029.478820847178;13068.673283167926;12606.432710528024;12956.09307348486;12958.611241662742;13010.544630937919;13014.804777928339;636.7962252079336;779.2441331908041;786.0920636664633;791.893094432253;792.0376742258155;810.5703976892256;817.8691409374501;818.9181081891793;819.0008190008181;820.5076953827686;860.1871231686059;863.8876945997043;864.5547543015352;866.9003064647583;867.5835598912525;852.2457625001887;852.9061803201643;855.5337341149027;860.0625318402939;863.8661007543841;619.6529943231759;624.4598422364668;624.9656268905209;626.6803929995735;628.6071205496564;12308.384580770926;12354.567590134302;12402.56591019319;12408.56570020045;12409.62771116868;13814.102083364649;14071.507497237548;14093.577192684235;14285.928570357186;14534.273286335641;10502.632407865687;10574.894251057467;10652.897144441373;10678.62624808128;10718.624848130277;2884.5528943013865;3109.5646609474693;3302.5046243063734;3329.9500507492166;3395.2360718838313;60584.697076514334;61317.08024379682;62499.37500624981;62596.37403625951;62855.37144628541;10754.623588174532;10775.94612026935;10856.294340867977;10858.294210876267;11178.776424471465;20847.687284690743;20854.791452085286;20860.37418877436;20895.37313880586;20895.895520522605;6875.965620171867;6966.477514186457;6976.4767642426;7025.156981162293;7063.646817659199;3600.4419315006216;3654.1778099927305;3665.376885929398;3762.755420897633;3843.7693738375788;3110.486769682977;3150.464421048427;3217.420864244412;3234.935301293961;3240.886568970122;522.8692826793301;525.1833399064492;537.7768226186089;547.0809040811475;548.8765027868698;537.3498067338564;550.3478378121858;619.4517851701187;646.3633321178635;650.3756393861851;7879.409044321699;8217.424780265444;8404.327653787683;8485;8760.145535964155;489.5447234072347;574.9540036797047;601.8344955137372;622.1476577089417;684.2029036172803;4187.623113919701;4201.844492764514;4207.474065741782;4254.595813397722;4326.805293761789;80316;81452;82471.58764206141;82488;82565.58717206375;50724.49275507198;71979;72148;73919;75761;45271.773641131585;45885;46265.76867115643;64888.67555662286;67330.66334668393;7911.604419778873;7975.162607926316;8005.439619226599;8039.356851451987;8167.591620419074;31765.20586985344;39650.60349396469;41916.58083419127;42266.30934762575;44945;52556;52915.73542132265;54426.45573544372;57827;60047;9651.758706032124;9861.112499875046;9888.258380621339;10076.647317344152;10104.747381315232;11093.833592495957;11301.208915375844;11396.259243149168;11520.88479115198;11688.18182727201;10784.406857622906;10805.243632945618;11110.722231943942;11220;11524.308541487537;10452.566367277763;10998.725031874266;11062.17033722458;11148.498317575566;11437.485313161094;10245.439767026674;10308.690739277834;10467.738306542398;10627.628033018807;10714.624988125379;9013.324000700104;9214.585343659686;9324.580393882427;9527.28545359087;9556.569954351931;9280;9340.906590934004;9355.589095274354;9476.194523465583;9506.191973682315 14:21:36 INFO - PROCESS | 24868 | __end_tp_report 14:21:36 INFO - PROCESS | 24868 | __start_cc_report 14:21:36 INFO - PROCESS | 24868 | _x_x_mozilla_cycle_collect,389 14:21:36 INFO - PROCESS | 24868 | __end_cc_report 14:21:36 INFO - PROCESS | 24868 | __startTimestamp1464988896602__endTimestamp 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | ------- Summary: start ------- 14:21:36 INFO - PROCESS | 24868 | Number of tests: 6 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | [#0] dojo.html Cycles:165 Average:4772.09 Median:4902.71 stddev:497.76 (10.2%) stddev-sans-first:471.27 14:21:36 INFO - PROCESS | 24868 | Values: 2673.3 2723.6 2745.7 2749.5 2752.4 4681.3 4735.1 4740.1 4836.5 4873.6 4711.3 4801.8 4832.0 4854.6 4859.3 4376.4 4406.8 4478.9 4525.4 4529.1 4177.3 4508.2 4521.0 4592.6 4593.4 4299.8 4381.3 4382.1 4398.0 4539.7 4372.6 4383.3 4452.8 4470.5 4478.6 4407.3 4427.6 4436.8 4457.7 4485.6 4659.0 4713.0 4732.1 4741.5 4762.2 5185.2 5195.2 5198.3 5200.3 5260.5 5069.3 5125.0 5198.6 5220.1 5220.5 4832.4 4865.0 4888.7 4908.3 4966.3 5344.5 5364.2 5372.6 5377.7 5414.1 4931.0 5005.1 5053.9 5121.2 5142.9 5005.9 5126.2 5145.6 5183.0 5219.1 5039.5 5058.3 5101.3 5113.1 5121.0 5014.1 5041.5 5099.6 5106.3 5167.7 4354.6 4355.6 4359.7 4393.3 4399.7 3795.1 3817.5 3822.9 3827.4 3896.7 4394.7 4465.8 4501.5 4508.8 4510.1 5182.9 5200.7 5204.3 5239.5 5291.2 4489.8 4492.4 4504.7 4520.5 4549.0 4502.9 4603.0 4641.7 4649.6 4658.6 4884.0 4884.7 4909.4 4930.1 4942.7 5106.9 5206.1 5237.5 5244.2 5276.1 4844.5 4861.7 4881.4 4897.3 4904.1 5118.1 5121.1 5122.1 5122.7 5182.6 4972.5 5063.4 5200.8 5208.3 5213.9 4908.8 4925.0 4946.7 4980.9 5047.8 4973.2 5004.4 5005.4 5008.2 5045.9 4765.0 4870.6 4897.7 4902.7 4913.0 5060.5 5095.3 5100.5 5133.2 5142.3 4928.8 4960.3 4998.5 5003.9 5041.5 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | [#1] ext.html Cycles:180 Average:44831.99 Median:19764.88 stddev:82717.66 (418.5%) stddev-sans-first:82882.91 14:21:36 INFO - PROCESS | 24868 | Values: 557.7 587.6 599.3 604.1 616.6 28927.6 31739.8 39705.2 40529.0 40819.2 41286.6 41883.0 41951.4 41987.8 42035.8 7721.4 7878.9 7889.6 7891.8 7907.5 7564.4 7757.9 7762.8 7767.8 7776.4 7816.6 7825.4 7862.6 7889.1 7903.3 7788.2 7834.5 7843.8 7844.2 7862.7 7774.0 7864.0 7867.0 7870.1 7875.7 37300.6 37639.4 37663.4 37694.0 37917.2 3177.3 3249.3 3252.0 3327.3 3806.6 29442.7 29588.0 29666.6 29857.0 29892.3 3423.3 3473.7 3550.0 3582.0 3602.9 256163.0 256438.0 256721.0 257337.0 257742.7 29072.1 29458.6 29565.3 29683.6 50767.9 34605.7 34668.5 34735.0 34740.5 34774.0 12644.9 12662.6 12707.4 12717.6 12806.4 9631.7 9752.1 9754.4 9778.7 9936.5 7964.7 7982.9 8002.3 8015.1 8063.8 3150.2 3178.6 3226.6 3232.4 3238.6 933.9 940.6 949.3 987.2 1097.1 28231.9 28686.9 28909.6 28944.7 29131.9 1007.1 1008.8 1041.5 1050.2 1161.1 14700.6 15236.9 15377.3 15428.0 15563.0 391916.0 394152.0 394889.0 394913.0 396604.0 49309.0 49483.5 49767.3 49908.3 50138.5 1201.3 1227.6 1253.5 1255.3 1260.9 27084.9 28074.3 28089.0 28496.1 28539.3 42469.6 42525.4 42578.6 42741.4 42774.6 267634.0 269479.0 271792.0 271804.0 271984.0 21042.3 21202.8 21345.9 21539.4 21694.9 42688.8 42828.0 43090.0 43123.6 43474.1 35316.8 36518.5 36573.1 36782.1 36831.0 36049.3 36365.0 36392.8 36425.5 36572.8 30713.1 34271.7 35560.5 35754.8 35926.8 31586.4 33204.2 33296.0 33537.8 33544.7 25188.7 25481.5 25485.4 25504.5 25617.4 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | [#2] jquery.html Cycles:180 Average:22397.45 Median:28322.26 stddev:56632.72 (200.0%) stddev-sans-first:56767.42 14:21:36 INFO - PROCESS | 24868 | Values: 362.8 363.1 370.2 374.3 382.0 15310.6 15939.5 16860.4 16892.3 16916.8 13867.8 14845.6 14907.9 14920.3 14933.0 4759.7 5154.5 5174.7 5185.6 5190.2 3697.2 5048.1 5642.5 6029.2 6031.6 5972.7 5986.3 6022.5 6027.4 6066.7 5839.5 6075.7 6107.3 6112.2 6113.2 5122.5 5255.9 5263.2 5266.7 5293.3 19208.4 19460.6 19642.0 19657.8 19690.7 1824.1 1907.0 1992.7 2024.8 2099.5 12798.9 12959.4 13166.0 13199.7 13331.2 1736.7 1773.7 1783.6 1811.6 1837.8 46346.0 62137.7 62682.1 62902.7 63360.0 8769.3 8802.9 9155.1 9191.8 9397.9 11884.3 12004.5 12014.9 12029.4 12053.7 6474.7 6672.4 6691.1 6722.9 6729.6 6180.4 6242.6 6345.8 6347.3 6378.7 5672.5 5896.2 5984.0 5996.1 6000.6 1505.3 1623.1 1632.6 1679.5 1719.1 893.2 920.3 928.3 966.2 978.5 14519.9 15910.8 16131.8 16492.8 16745.0 884.7 912.4 917.1 964.3 1005.2 9361.3 9367.8 9466.9 9544.8 9802.2 335145.0 340231.0 344111.0 347472.0 349363.0 63921.7 65421.7 68583.7 70292.0 74501.3 955.4 962.5 989.4 995.3 1001.6 15080.0 15101.5 15116.7 15285.9 15649.6 34587.8 34846.0 35535.0 35849.8 36466.1 51522.0 51642.0 51695.2 51797.0 52455.2 7201.5 7384.4 7487.6 7535.7 7618.2 9294.0 11340.8 11661.8 11794.8 11918.2 9975.1 10078.1 10087.0 10114.7 10475.1 9915.8 9936.1 10128.0 10249.9 10335.3 9549.5 10155.6 10201.9 10509.2 10753.9 7626.6 7654.9 7718.4 7738.1 7740.6 9650.0 10260.5 10347.1 10458.6 10536.8 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | [#3] mootools.html Cycles:180 Average:5106.42 Median:5543.30 stddev:2841.48 (51.3%) stddev-sans-first:2835.92 14:21:36 INFO - PROCESS | 24868 | Values: 1416.7 1450.4 1533.4 1738.6 1756.0 6658.9 7566.4 7581.2 8071.7 8075.1 7628.0 7740.7 7792.8 7810.9 7865.4 2149.3 2188.7 2190.6 2197.0 2197.5 2124.9 2168.9 2185.4 2199.1 2199.6 2165.2 2171.3 2172.6 2175.5 2218.5 2084.6 2107.6 2112.0 2113.6 2114.8 2120.6 2141.6 2160.5 2164.4 2170.2 7793.1 7796.8 7851.7 7852.5 7867.4 4429.5 4528.9 4542.3 4555.9 4558.1 2894.3 2926.6 2962.1 2975.7 3029.3 833.7 885.8 888.2 894.3 901.5 10047.0 10087.4 10105.4 10114.6 10126.6 4042.9 4089.8 4186.2 4190.7 4197.4 8778.7 8815.0 8817.6 8826.6 8866.6 4356.3 4378.3 4416.1 4429.5 4476.0 3583.9 4010.1 4030.6 4039.9 4091.6 3485.7 3519.3 3610.5 3634.6 3637.0 1142.7 1157.6 1158.7 1160.0 1166.5 808.3 910.4 929.5 931.7 959.1 5584.8 5587.9 5657.6 5676.5 5785.7 387.7 388.5 392.5 396.2 906.1 3777.9 3867.8 3952.9 4013.3 4030.1 9278.2 9529.7 9633.9 9634.6 9653.0 9417.7 9615.0 9618.1 9631.0 9654.0 7494.2 7498.1 7553.1 7565.5 7583.2 5397.2 5525.5 5561.1 5601.9 5641.8 8875.1 8923.3 8924.9 8994.0 9042.8 8817.5 8980.9 8989.1 9210.2 9243.4 5841.6 6200.8 6366.8 6379.1 6497.0 7389.9 7420.3 7422.2 7431.9 7515.9 6481.9 6564.7 6600.0 6698.3 6830.1 6653.9 6658.4 6658.5 6712.4 6795.0 6029.5 6120.4 6122.0 6126.4 6149.2 4641.6 4659.6 4722.5 4788.5 4801.8 4640.3 4647.9 4659.6 4714.5 4755.6 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | [#4] prototype.html Cycles:180 Average:4243.61 Median:4795.71 stddev:1256.08 (26.2%) stddev-sans-first:1223.93 14:21:36 INFO - PROCESS | 24868 | Values: 283.6 294.1 294.8 299.5 302.4 4756.3 4827.8 4929.6 4993.8 5003.6 4856.2 4865.4 4892.3 4907.6 4929.0 3914.4 3917.6 3917.9 3919.9 3920.0 3584.6 3911.5 3916.5 3920.5 3931.9 3769.5 3772.6 3776.5 3778.8 3796.6 3775.4 3781.5 3788.8 3793.5 3813.8 3225.5 3325.7 3329.0 3333.7 3347.8 4743.7 4746.6 4750.4 4751.8 4763.6 4374.3 4375.7 4376.3 4380.6 4387.0 4951.7 5147.6 5157.9 5159.5 5163.5 3640.2 3647.0 3655.0 3657.7 3670.9 5428.5 5458.9 5459.2 5480.6 5480.7 3705.4 3706.4 3707.3 3719.5 3724.8 3682.2 3787.1 3789.5 3792.1 3799.3 4283.7 4313.4 4321.9 4342.3 4356.0 5143.4 5164.5 5176.5 5186.0 5191.9 1224.3 1274.4 1301.9 1305.8 1308.5 802.8 812.4 836.8 837.5 844.4 4069.4 4089.1 4098.1 4109.4 4115.6 4704.6 4727.3 4733.2 4744.8 4749.5 4077.0 4085.7 4123.9 4125.0 4141.5 2536.9 2647.2 2875.4 2877.8 2894.2 4974.4 5040.0 5048.0 5061.4 5071.9 5349.3 5474.6 5492.4 5516.4 5527.1 5045.5 5058.6 5069.7 5073.0 5094.9 5366.0 5369.9 5376.1 5379.7 5392.5 5087.1 5265.9 5268.3 5296.8 5327.2 5016.2 5059.0 5064.5 5088.0 5090.5 3605.8 3630.1 3631.8 3654.9 3671.3 5220.9 5324.2 5344.2 5352.9 5363.3 5163.6 5204.4 5204.5 5204.5 5213.5 5118.6 5188.6 5189.4 5189.7 5206.2 4882.5 5111.6 5122.2 5123.6 5129.6 5125.4 5139.4 5146.3 5149.8 5206.8 5020.7 5035.8 5040.2 5048.2 5063.6 14:21:36 INFO - PROCESS | 24868 | 14:21:36 INFO - PROCESS | 24868 | [#5] yui.html Cycles:180 Average:15932.63 Median:26726.54 stddev:21349.68 (79.9%) stddev-sans-first:21378.56 14:21:36 INFO - PROCESS | 24868 | Values: 608.0 609.3 633.3 648.2 681.3 12214.1 12820.7 13005.9 13029.5 13068.7 12606.4 12956.1 12958.6 13010.5 13014.8 636.8 779.2 786.1 791.9 792.0 810.6 817.9 818.9 819.0 820.5 860.2 863.9 864.6 866.9 867.6 852.2 852.9 855.5 860.1 863.9 619.7 624.5 625.0 626.7 628.6 12308.4 12354.6 12402.6 12408.6 12409.6 13814.1 14071.5 14093.6 14285.9 14534.3 10502.6 10574.9 10652.9 10678.6 10718.6 2884.6 3109.6 3302.5 3330.0 3395.2 60584.7 61317.1 62499.4 62596.4 62855.4 10754.6 10775.9 10856.3 10858.3 11178.8 20847.7 20854.8 20860.4 20895.4 20895.9 6876.0 6966.5 6976.5 7025.2 7063.6 3600.4 3654.2 3665.4 3762.8 3843.8 3110.5 3150.5 3217.4 3234.9 3240.9 522.9 525.2 537.8 547.1 548.9 537.3 550.3 619.5 646.4 650.4 7879.4 8217.4 8404.3 8485.0 8760.1 489.5 575.0 601.8 622.1 684.2 4187.6 4201.8 4207.5 4254.6 4326.8 80316.0 81452.0 82471.6 82488.0 82565.6 50724.5 71979.0 72148.0 73919.0 75761.0 45271.8 45885.0 46265.8 64888.7 67330.7 7911.6 7975.2 8005.4 8039.4 8167.6 31765.2 39650.6 41916.6 42266.3 44945.0 52556.0 52915.7 54426.5 57827.0 60047.0 9651.8 9861.1 9888.3 10076.6 10104.7 11093.8 11301.2 11396.3 11520.9 11688.2 10784.4 10805.2 11110.7 11220.0 11524.3 10452.6 10998.7 11062.2 11148.5 11437.5 10245.4 10308.7 10467.7 10627.6 10714.6 9013.3 9214.6 9324.6 9527.3 9556.6 9280.0 9340.9 9355.6 9476.2 9506.2 14:21:36 INFO - PROCESS | 24868 | -------- Summary: end -------- 14:21:36 INFO - PROCESS | 24868 | 14:21:37 INFO - TEST-INFO | 24868: exit 0 14:21:37 INFO - TEST-OK | dromaeo_css | took 1115503ms 14:21:37 INFO - TEST-START | kraken 14:21:37 INFO - operating with platform_type : linux_ 14:21:37 INFO - Initialising browser for kraken test... 14:21:37 INFO - TEST-INFO | started process 25108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDIPm_t/profile http://localhost:45060/getInfo.html) 14:21:41 INFO - PROCESS | 25108 | __metrics Screen width/height:1600/1200 14:21:41 INFO - PROCESS | 25108 | colorDepth:24 14:21:41 INFO - PROCESS | 25108 | Browser inner width/height: 1024/697 14:21:41 INFO - PROCESS | 25108 | __metrics 14:21:42 ERROR - PROCESS | 25108 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:21:43 INFO - TEST-INFO | 25108: exit 0 14:21:43 INFO - Browser initialized. 14:21:43 INFO - Running cycle 1/1 for kraken test... 14:21:43 INFO - TEST-INFO | started process 25225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDIPm_t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:55 INFO - PROCESS | 25225 | RSS: Main: 168427520 14:21:55 INFO - PROCESS | 25225 | 14:21:58 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45060/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:59 INFO - PROCESS | 25225 | RSS: Main: 173010944 14:21:59 INFO - PROCESS | 25225 | 14:22:01 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45060/tests/kraken/driver.html?testName=audio-dft) 14:22:02 INFO - PROCESS | 25225 | RSS: Main: 172879872 14:22:02 INFO - PROCESS | 25225 | 14:22:05 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45060/tests/kraken/driver.html?testName=audio-fft) 14:22:06 INFO - PROCESS | 25225 | RSS: Main: 167440384 14:22:06 INFO - PROCESS | 25225 | 14:22:08 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45060/tests/kraken/driver.html?testName=audio-oscillator) 14:22:08 INFO - PROCESS | 25225 | RSS: Main: 168144896 14:22:08 INFO - PROCESS | 25225 | 14:22:11 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:11 INFO - PROCESS | 25225 | RSS: Main: 168394752 14:22:11 INFO - PROCESS | 25225 | 14:22:14 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45060/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:15 INFO - PROCESS | 25225 | RSS: Main: 168673280 14:22:15 INFO - PROCESS | 25225 | 14:22:19 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45060/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:19 INFO - PROCESS | 25225 | RSS: Main: 167124992 14:22:19 INFO - PROCESS | 25225 | 14:22:22 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45060/tests/kraken/driver.html?testName=json-parse-financial) 14:22:23 INFO - PROCESS | 25225 | RSS: Main: 168001536 14:22:23 INFO - PROCESS | 25225 | 14:22:24 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:25 INFO - PROCESS | 25225 | RSS: Main: 168230912 14:22:25 INFO - PROCESS | 25225 | 14:22:27 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:28 INFO - PROCESS | 25225 | RSS: Main: 168312832 14:22:28 INFO - PROCESS | 25225 | 14:22:30 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:31 INFO - PROCESS | 25225 | RSS: Main: 168710144 14:22:31 INFO - PROCESS | 25225 | 14:22:33 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:34 INFO - PROCESS | 25225 | RSS: Main: 169259008 14:22:34 INFO - PROCESS | 25225 | 14:22:37 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:38 INFO - PROCESS | 25225 | RSS: Main: 168706048 14:22:38 INFO - PROCESS | 25225 | 14:22:39 INFO - PROCESS | 25225 | Cycle 1(1): loaded http://localhost:45060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45060/tests/kraken/driver.html?testName=ai-astar) 14:22:40 INFO - PROCESS | 25225 | RSS: Main: 169517056 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | __start_tp_report 14:22:40 INFO - PROCESS | 25225 | _x_x_mozilla_page_load 14:22:40 INFO - PROCESS | 25225 | _x_x_mozilla_page_load_details 14:22:40 INFO - PROCESS | 25225 | |i|pagename|runs| 14:22:40 INFO - PROCESS | 25225 | |0;ai-astar;114;108;115;115;115;115;114;114;113;113 14:22:40 INFO - PROCESS | 25225 | |1;audio-beat-detection;162;134;157;187;132;165;169;131;185;134 14:22:40 INFO - PROCESS | 25225 | |2;audio-dft;165;162;164;174;163;164;162;161;161;162 14:22:40 INFO - PROCESS | 25225 | |3;audio-fft;76;76;77;159;81;76;75;75;167;76 14:22:40 INFO - PROCESS | 25225 | |4;audio-oscillator;86;87;157;87;86;86;135;86;86;135 14:22:40 INFO - PROCESS | 25225 | |5;imaging-gaussian-blur;118;118;116;117;118;117;117;117;118;119 14:22:40 INFO - PROCESS | 25225 | |6;imaging-darkroom;149;149;148;149;147;150;149;146;146;147 14:22:40 INFO - PROCESS | 25225 | |7;imaging-desaturate;95;96;96;96;96;95;96;95;96;95 14:22:40 INFO - PROCESS | 25225 | |8;json-parse-financial;65;66;65;65;66;66;67;64;66;66 14:22:40 INFO - PROCESS | 25225 | |9;json-stringify-tinderbox;67;66;66;66;66;66;67;66;66;66 14:22:40 INFO - PROCESS | 25225 | |10;stanford-crypto-aes;87;83;83;89;86;83;93;84;119;88 14:22:40 INFO - PROCESS | 25225 | |11;stanford-crypto-ccm;143;134;147;135;132;147;141;139;143;133 14:22:40 INFO - PROCESS | 25225 | |12;stanford-crypto-pbkdf2;166;174;168;169;173;167;168;168;164;166 14:22:40 INFO - PROCESS | 25225 | |13;stanford-crypto-sha256-iterative;69;67;68;68;69;70;68;66;71;69 14:22:40 INFO - PROCESS | 25225 | __end_tp_report 14:22:40 INFO - PROCESS | 25225 | __start_cc_report 14:22:40 INFO - PROCESS | 25225 | _x_x_mozilla_cycle_collect,992 14:22:40 INFO - PROCESS | 25225 | __end_cc_report 14:22:40 INFO - PROCESS | 25225 | __startTimestamp1464988960102__endTimestamp 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | ------- Summary: start ------- 14:22:40 INFO - PROCESS | 25225 | Number of tests: 14 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:2.12 (1.9%) stddev-sans-first:2.24 14:22:40 INFO - PROCESS | 25225 | Values: 114.0 108.0 115.0 115.0 115.0 115.0 114.0 114.0 113.0 113.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:163.50 stddev:21.75 (13.3%) stddev-sans-first:22.94 14:22:40 INFO - PROCESS | 25225 | Values: 162.0 134.0 157.0 187.0 132.0 165.0 169.0 131.0 185.0 134.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.82 (2.3%) stddev-sans-first:4.03 14:22:40 INFO - PROCESS | 25225 | Values: 165.0 162.0 164.0 174.0 163.0 164.0 162.0 161.0 161.0 162.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:36.56 (48.1%) stddev-sans-first:38.21 14:22:40 INFO - PROCESS | 25225 | Values: 76.0 76.0 77.0 159.0 81.0 76.0 75.0 75.0 167.0 76.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:86.00 stddev:27.73 (32.2%) stddev-sans-first:28.71 14:22:40 INFO - PROCESS | 25225 | Values: 86.0 87.0 157.0 87.0 86.0 86.0 135.0 86.0 86.0 135.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 14:22:40 INFO - PROCESS | 25225 | Values: 118.0 118.0 116.0 117.0 118.0 117.0 117.0 117.0 118.0 119.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:149.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 14:22:40 INFO - PROCESS | 25225 | Values: 149.0 149.0 148.0 149.0 147.0 150.0 149.0 146.0 146.0 147.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:22:40 INFO - PROCESS | 25225 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 14:22:40 INFO - PROCESS | 25225 | Values: 65.0 66.0 65.0 65.0 66.0 66.0 67.0 64.0 66.0 66.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 14:22:40 INFO - PROCESS | 25225 | Values: 67.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 66.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:86.50 stddev:10.86 (12.5%) stddev-sans-first:11.48 14:22:40 INFO - PROCESS | 25225 | Values: 87.0 83.0 83.0 89.0 86.0 83.0 93.0 84.0 119.0 88.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:142.00 stddev:5.66 (4.0%) stddev-sans-first:5.85 14:22:40 INFO - PROCESS | 25225 | Values: 143.0 134.0 147.0 135.0 132.0 147.0 141.0 139.0 143.0 133.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.00 stddev:3.09 (1.8%) stddev-sans-first:3.17 14:22:40 INFO - PROCESS | 25225 | Values: 166.0 174.0 168.0 169.0 173.0 167.0 168.0 168.0 164.0 166.0 14:22:40 INFO - PROCESS | 25225 | 14:22:40 INFO - PROCESS | 25225 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 14:22:40 INFO - PROCESS | 25225 | Values: 69.0 67.0 68.0 68.0 69.0 70.0 68.0 66.0 71.0 69.0 14:22:40 INFO - PROCESS | 25225 | -------- Summary: end -------- 14:22:40 INFO - PROCESS | 25225 | 14:22:41 INFO - TEST-INFO | 25225: exit 0 14:22:41 INFO - TEST-OK | kraken | took 63773ms 14:22:41 INFO - SUITE-END | took 1179s 14:22:41 INFO - Completed test suite (00:19:39) 14:22:41 INFO - javascript benchmark 14:22:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6307.519498836161, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.2648521656547, 2723.605077263797, 2745.6567929008875, 2749.5188342040137, 2752.4495100979807, 4681.297805329198, 4735.1240020596215, 4740.123077230711, 4836.540528649782, 4873.610111191105, 4711.293306004101, 4801.759912004394, 4831.975840120804, 4854.611631069515, 4859.343988561552, 4376.431063961681, 4406.801693923781, 4478.910421791562, 4525.366448697185, 4529.094181163764, 4177.268977928866, 4508.233600287943, 4520.97739511302, 4592.563706447899, 4593.448786145667, 4299.78501074945, 4381.298992161271, 4382.0797632497215, 4398.0, 4539.682222244444, 4372.628326592244, 4383.320585309282, 4452.799624016927, 4470.508244093147, 4478.552144785528, 4407.272799987998, 4427.645788336926, 4436.778161091965, 4457.710248833848, 4485.618722408599, 4659.0, 4712.952870471286, 4732.1482133216, 4741.478437371887, 4762.190427627312, 5185.248139019859, 5195.220716892459, 5198.324217851693, 5200.349956255468, 5260.473952604747, 5069.340985671839, 5124.9743751281, 5198.610104242197, 5220.112580861262, 5220.504052115043, 4832.444268909086, 4864.951350486521, 4888.7311197884455, 4908.337374454474, 4966.255061740731, 5344.465553444625, 5364.168553874156, 5372.597055220874, 5377.704226267515, 5414.07960646691, 4930.950690493121, 5005.099082165245, 5053.898922021539, 5121.206213036985, 5142.948570514322, 5005.89988200234, 5126.231065340229, 5145.562627176732, 5183.0, 5219.1388420910125, 5039.521245481674, 5058.266551350107, 5101.260317254051, 5113.105206588906, 5121.0, 5014.072396606566, 5041.495850414929, 5099.566536844335, 5106.259592359087, 5167.715775632376, 4354.586314300136, 4355.564443555682, 4359.738415695068, 4393.319035549495, 4399.73601583906, 3795.1271207622403, 3817.4846395736777, 3822.9235415292096, 3827.4258861171047, 3896.7077469189926, 4394.736315821061, 4465.821367145343, 4501.527339629357, 4508.797104130322, 4510.075434535912, 5182.922256166161, 5200.739963001834, 5204.271402003723, 5239.47605239473, 5291.1798671206025, 4489.820407183676, 4492.438445194351, 4504.662150338672, 4520.4801447833925, 4548.95451045492, 4502.887427814331, 4602.964333025043, 4641.6518761092375, 4649.5815376616265, 4658.604018658384, 4883.975580122076, 4884.7313397762755, 4909.4354149273295, 4930.13722598551, 4942.728149951788, 5106.923396148986, 5206.114960456807, 5237.476252374732, 5244.239585260192, 5276.129438642581, 4844.491328410466, 4861.683990540603, 4881.365422495195, 4897.314375987294, 4904.141775189399, 5118.053160165233, 5121.07820592297, 5122.078025955364, 5122.718250496258, 5182.611304152279, 4972.453030166751, 5063.367079115111, 5200.843974680765, 5208.270842082187, 5213.947860521346, 4908.754562271801, 4924.950750492592, 4946.703197808143, 4980.925286120639, 5047.772850221675, 4973.154563724248, 5004.3994720633755, 5005.399352077774, 5008.248762685626, 5045.949540504548, 4765.0, 4870.561649451566, 4897.706137631753, 4902.7058376497525, 4913.0, 5060.51925067118, 5095.286659867547, 5100.489951005018, 5133.230015497706, 5142.331496905378, 4928.802847886044, 4960.30555722192, 4998.500149984972, 5003.949960500348, 5041.546260836542], "value": 4740.842357558349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.740650597472, 587.5945597537701, 599.3167788720859, 604.0908432808625, 616.5899676714984, 28927.56608650872, 31739.841300793494, 39705.20589588206, 40529.0, 40819.18361632765, 41286.58713412865, 41883.0, 41951.370729439004, 41987.79006104973, 42035.78982105093, 7721.382289416847, 7878.921210787905, 7889.644965976516, 7891.8421631567335, 7907.5255484670815, 7564.432667549956, 7757.883631745528, 7762.805929851771, 7767.766966990999, 7776.416768742339, 7816.609169541529, 7825.37397008238, 7862.567558784264, 7889.053313602376, 7903.288704016637, 7788.182240864712, 7834.451588388843, 7843.8431231375625, 7844.2155784421675, 7862.68549258029, 7773.961130194313, 7863.960680196619, 7866.960665196694, 7870.0949390820215, 7875.684972601089, 37300.62699372999, 37639.4354084689, 37663.4350484743, 37694.0, 37917.24165516702, 3177.3168768714836, 3249.301400198945, 3251.951220731691, 3327.2513684421056, 3806.5812760596314, 29442.70557294421, 29588.0, 29666.55500167499, 29857.0, 29892.252693682614, 3423.298223864102, 3473.6700013498676, 3549.982250088759, 3581.979135946269, 3602.945955810665, 256163.0, 256438.0, 256721.0, 257337.0, 257742.71128644425, 29072.127836164527, 29458.558121628193, 29565.26086847846, 29683.554746678816, 50767.923207678934, 34605.65394346075, 34668.47997280043, 34735.0, 34740.47889281663, 34774.0, 12644.936775316064, 12662.556810511773, 12707.364631768374, 12717.618471445872, 12806.359682015862, 9631.71104866855, 9752.122308992224, 9754.414735115915, 9778.65774697882, 9936.503174841373, 7964.721234756756, 7982.880256796153, 8002.279794818494, 8015.118336982927, 8063.838723225503, 3150.2439414540804, 3178.55500229968, 3226.596675415573, 3232.3535292941506, 3238.5789847319697, 933.8575692793701, 940.5955439161089, 949.3449519831295, 987.1658448610913, 1097.067492631257, 28231.858840706074, 28686.856565717037, 28909.56635650467, 28944.710552894623, 29131.85434072816, 1007.1137399088755, 1008.8184126857236, 1041.5368898412808, 1050.1965996013057, 1161.0711430855451, 14700.55898323052, 15236.923815380853, 15377.308021139075, 15428.0, 15563.0, 391916.0, 394152.0, 394889.0, 394913.0, 396604.0, 49309.0, 49483.50516494861, 49767.25349119766, 49908.25137622938, 50138.49861501411, 1201.3092471828734, 1227.5703503773607, 1253.5048655781097, 1255.2719422734974, 1260.949562017509, 27084.864575676995, 28074.2981425466, 28089.0, 28496.145115645733, 28539.28651783722, 42469.57530424656, 42525.36211956761, 42578.57421425746, 42741.35887961745, 42774.57225427706, 267634.0, 269479.0, 271792.0, 271804.0, 271984.0, 21042.263520776698, 21202.78797212008, 21345.893270533546, 21539.353819385444, 21694.891525542273, 42688.78655606702, 42828.0, 43090.0, 43123.56876431195, 43474.130517390106, 35316.823415882754, 36518.45222321614, 36573.08567285839, 36782.080447989014, 36831.0, 36049.27901442009, 36365.0, 36392.81803590965, 36425.453618196276, 36572.81713591415, 30713.078607641808, 34271.657283426845, 35560.46659300061, 35754.821225893706, 35926.820365898006, 31586.368272633958, 33204.1698957528, 33296.0, 33537.832310839265, 33544.66455335415, 25188.748112519374, 25481.49037019212, 25485.3628659285, 25504.489910202064, 25617.359566011], "value": 16289.16973559869, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.82584359507433, 363.09045840170376, 370.2391585292223, 374.32434455807277, 381.9847206111756, 15310.617234569141, 15939.521814345573, 16860.409885654004, 16892.32430702772, 16916.83083169168, 13867.791983120262, 14845.55463336099, 14907.850921490783, 14920.328585213665, 14933.0, 4759.666823322369, 5154.5103215194495, 5174.741262936857, 5185.637005409623, 5190.221466779994, 3697.2235830475634, 5048.066107770056, 5642.520385767215, 6029.186059881926, 6031.607945483552, 5972.731227094791, 5986.2517185351835, 6022.457978781908, 6027.367126451725, 6066.726997285133, 5839.474447299742, 6075.665838378887, 6107.29766076898, 6112.235970503687, 6113.174721412597, 5122.513361230677, 5255.947440525584, 5263.236830659571, 5266.683998960037, 5293.338332708411, 19208.423747287605, 19460.610787784164, 19642.017899104987, 19657.803421965742, 19690.70463943042, 1824.1335365701186, 1906.9523261918425, 1992.7110568967419, 2024.8380129589598, 2099.454141923096, 12798.872011279862, 12959.352032398436, 13166.012549058763, 13199.670008249774, 13331.200127992255, 1736.6787144378204, 1773.698471259889, 1783.5909631391185, 1811.5923917118544, 1837.843783278423, 46346.0, 62137.68931155315, 62682.0597691035, 62902.68548657227, 63360.0, 8769.298456123495, 8802.91197088021, 9155.084491550924, 9191.816163676689, 9397.859032114524, 11884.286942783461, 12004.459799309052, 12014.879851201551, 12029.398530073462, 12053.698657533632, 6474.741010359533, 6672.366125218096, 6691.0967019451755, 6722.899156512656, 6729.596224226562, 6180.351063138396, 6242.5942313749465, 6345.809625711236, 6347.270063942613, 6378.74485020594, 5672.546196304285, 5896.233489646404, 5983.970080149571, 5996.070609055603, 6000.609960352563, 1505.3226048278318, 1623.0991799551362, 1632.5918520369908, 1679.4877562343358, 1719.1060648462728, 893.1693525021662, 920.346553946692, 928.313048344234, 966.2366730282997, 978.5498670611456, 14519.854801451851, 15910.76133857993, 16131.838681613033, 16492.7630427716, 16745.0, 884.7345796261096, 912.3567884641312, 917.0645941140133, 964.3297907953905, 1005.2109094360892, 9361.297902657328, 9367.765805854771, 9466.905330946602, 9544.809103817885, 9802.166815820592, 335145.0, 340231.0, 344111.0, 347472.0, 349363.0, 63921.68039159774, 65421.67289163524, 68583.65708171527, 70292.0, 74501.25498745052, 955.4315182466421, 962.4610218277787, 989.351974456732, 995.3182070281736, 1001.6444162322271, 15080.0, 15101.546953591409, 15116.697666046397, 15285.923570382078, 15649.608759781097, 34587.82706086453, 34846.0, 35535.0, 35849.82075089608, 36466.08834779152, 51522.0, 51642.0, 51695.2245716307, 51797.0, 52455.21317180169, 7201.495895287279, 7384.446166537424, 7487.550746954982, 7535.660895259836, 7618.200088990576, 9294.0, 11340.829887551528, 11661.825072624088, 11794.76410471803, 11918.225315354473, 9975.102240798364, 10078.092971632588, 10087.0, 10114.747131321776, 10475.109615682752, 9915.752106197402, 9936.062467818705, 10128.0, 10249.897501024894, 10335.276530643083, 9549.474778887228, 10155.593776249163, 10201.948990255001, 10509.211809114195, 10753.89246107529, 7626.618669066635, 7654.923450765421, 7718.382529397522, 7738.148803631709, 7740.574268415291, 9649.951750241204, 10260.486975651336, 10347.12049475803, 10458.63394781179, 10536.789264214825], "value": 8154.697734930293, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.7237388709202, 1450.369089446091, 1533.371317759718, 1738.6261953679957, 1756.042956588659, 6658.933410665892, 7566.394688424926, 7581.241875812416, 8071.717489887862, 8075.111737708855, 7628.0464941882265, 7740.690372385098, 7792.7662170134845, 7810.882836757453, 7865.370770338373, 2149.2692484555287, 2188.6935828983956, 2190.605690975624, 2196.9560608787815, 2197.5385169114506, 2124.915003399862, 2168.8915554222303, 2185.3553201805425, 2199.054406605167, 2199.5820794049077, 2165.1880544795704, 2171.337741988693, 2172.565486902618, 2175.4778853075304, 2218.4675677837286, 2084.583083383322, 2107.5784843031456, 2111.9894400527974, 2113.619548481273, 2114.8413868959738, 2120.586485635302, 2141.5609799990966, 2160.4706846822473, 2164.383150802014, 2170.1644866726424, 7793.103793063757, 7796.766097017098, 7851.685932562691, 7852.528848269122, 7867.370610351159, 4429.53489883564, 4528.8867778305475, 4542.318652202163, 4555.886102847422, 4558.0655965526985, 2894.348771526411, 2926.6049083373687, 2962.096560549032, 2975.717306855867, 3029.2729744861294, 833.7123692326198, 885.7608445719619, 888.2228050455851, 894.2667013049302, 901.5492253873064, 10047.0, 10087.445190514592, 10105.444200568965, 10114.595416183343, 10126.645567405105, 4042.8584999524874, 4089.7750623715388, 4186.246475634415, 4190.727602705814, 4197.412362269285, 8778.692745753868, 8815.030346661862, 8817.647294108165, 8826.5586720665, 8866.556672166365, 4356.259435895905, 4378.255696531597, 4416.072624748775, 4429.512753597101, 4475.977620111878, 3583.9104022399647, 4010.0977280111742, 4030.649732339699, 4039.9192016159514, 4091.6317531422314, 3485.6688614581576, 3519.278547897675, 3610.458431235283, 3634.5638523376833, 3636.9818150909605, 1142.657202839145, 1157.5948418053783, 1158.6581958322315, 1160.0, 1166.5100657723776, 808.272554700774, 910.4446287764458, 929.5491686532026, 931.6785708930408, 959.098447459386, 5584.804531841366, 5587.8603034923635, 5657.60396772222, 5676.545876329884, 5785.681787501644, 387.6821006774418, 388.4852570344249, 392.48976330769887, 396.15618732100444, 906.057699992001, 3777.9433308500393, 3867.7679339239735, 3952.8616498422416, 4013.337799263147, 4030.133521292936, 9278.211352035018, 9529.714108576754, 9633.90366096344, 9634.566444510014, 9653.0, 9417.717468475958, 9615.0, 9618.086281803218, 9631.0, 9653.951730241304, 7494.21310762373, 7498.062742157231, 7553.055868016498, 7565.546067235983, 7583.2416758323725, 5397.217403476396, 5525.475079867406, 5561.129997653736, 5601.943980560142, 5641.774329026793, 8875.068117847792, 8923.330750193632, 8924.86612700797, 8994.0, 9042.81914361696, 8817.515036673045, 8980.86528702083, 8989.146031127033, 9210.171084602418, 9243.352965292634, 5841.649501029951, 6200.81397558074, 6366.80899572995, 6379.138816259931, 6497.0, 7389.926100738924, 7420.257974202753, 7422.183559808309, 7431.925680743123, 7515.924840751522, 6481.8703625928165, 6564.704588293443, 6599.967000164968, 6698.263191049078, 6830.077939478107, 6653.900191497035, 6658.400743933069, 6658.500612453989, 6712.429443497357, 6794.966025169842, 6029.457348838626, 6120.357362477054, 6122.0, 6126.356732543019, 6149.169862068564, 4641.605463535638, 4659.600305842561, 4722.504137065559, 4788.545088216614, 4801.759912004456, 4640.280756482751, 4647.930281045855, 4659.603933665677, 4714.481407045291, 4755.5719985201495], "value": 4076.064287964232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.61570072551694, 294.0868602987723, 294.8275258973501, 299.4579810542916, 302.36201614593193, 4756.26277926921, 4827.8310259140935, 4929.580985616222, 4993.775280112394, 5003.62472814539, 4856.174450343441, 4865.367502224706, 4892.26616007599, 4907.5583197512215, 4928.975355123228, 3914.4324073009398, 3917.5690674025836, 3917.8824635260844, 3919.8824035278985, 3919.9804000980025, 3584.6415358464205, 3911.452396664455, 3916.4908561886914, 3920.490336256297, 3931.862384816532, 3769.491118698968, 3772.641599048086, 3776.45241439991, 3778.8488460461685, 3796.6013568575318, 3775.3959366501504, 3781.5462144542694, 3788.7537310074895, 3793.506844110276, 3813.7902415367143, 3225.5322978168033, 3325.700686938187, 3328.9667103329143, 3333.666633336671, 3347.807186292982, 4743.691660042086, 4746.644001699887, 4750.406199225097, 4751.837913749236, 4763.595094416979, 4374.321980093091, 4375.6937014409, 4376.256036473807, 4380.649548036149, 4386.978065109654, 4951.653384263103, 5147.562457191143, 5157.948420515784, 5159.484051594848, 5163.45096471061, 3640.1809592841664, 3647.0, 3655.0131464504434, 3657.6708096271464, 3670.944935825965, 5428.4842939920645, 5458.863528411782, 5459.208414779835, 5480.6437581557075, 5480.671159730389, 3705.3515634763808, 3706.388445906395, 3707.295613833363, 3719.5350581177354, 3724.832382542792, 3682.1531047859144, 3787.110029143149, 3789.450529673182, 3792.070942619076, 3799.2781371539318, 4283.672061660895, 4313.439252897166, 4321.935170972375, 4342.32693932441, 4355.956440435619, 5143.402581696219, 5164.48355164488, 5176.534111929945, 5185.9740701297005, 5191.922121168185, 1224.2837939805136, 1274.388293619068, 1301.8567957524665, 1305.849827269857, 1308.4896890212824, 802.7993001749562, 812.3582369927809, 836.8451836410284, 837.4640230252643, 844.4004756622867, 4069.369247766601, 4089.1208390196252, 4098.118904435561, 4109.445224894601, 4115.58012485692, 4704.600108990706, 4727.267273572533, 4733.242681170997, 4744.7627618618935, 4749.525047495292, 4076.9603751043296, 4085.7344272622186, 4123.9381409278885, 4125.0, 4141.503019637603, 2536.9112081077074, 2647.205838248518, 2875.3674191677796, 2877.7985541011926, 2894.1751600793673, 4974.427940786856, 5040.026384433202, 5047.974760126176, 5061.417936937226, 5071.909539449036, 5349.304590403222, 5474.591179880839, 5492.395836457987, 5516.448355164532, 5527.115661494142, 5045.495450454925, 5058.645894787403, 5069.7465126744255, 5072.974635126875, 5094.949050509447, 5366.0, 5369.919451208313, 5376.086065368819, 5379.704116273642, 5392.5416339611575, 5087.084324821568, 5265.921011184912, 5268.341457317835, 5296.814611488579, 5327.22755200486, 5016.2224855147515, 5059.0, 5064.455341120846, 5087.974560127176, 5090.4655011223285, 3605.837737301775, 3630.1287690953454, 3631.8184090795885, 3654.926901462009, 3671.30245253401, 5220.895582088413, 5324.227986941794, 5344.171653393731, 5352.919706204488, 5363.283749200218, 5163.561097306771, 5204.397801099451, 5204.453532379197, 5204.501839117169, 5213.45258747826, 5118.590512758896, 5188.58491320701, 5189.379363421448, 5189.662671926313, 5206.229881840192, 4882.483702575033, 5111.64218504716, 5122.206058061007, 5123.6157288202785, 5129.615278854027, 5125.43620201785, 5139.383274007143, 5146.305248791515, 5149.819756308661, 5206.765695543634, 5020.748962551931, 5035.84892453227, 5040.202687508468, 5048.217526283432, 5063.620228482805], "value": 3839.7635269612174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.9817605471837, 609.3206075226122, 633.3223450907528, 648.157395385998, 681.2744427185046, 12214.145009849313, 12820.67948301293, 13005.934970325146, 13029.478820847178, 13068.673283167926, 12606.432710528024, 12956.09307348486, 12958.611241662742, 13010.544630937919, 13014.804777928339, 636.7962252079336, 779.2441331908041, 786.0920636664633, 791.893094432253, 792.0376742258155, 810.5703976892256, 817.8691409374501, 818.9181081891793, 819.0008190008181, 820.5076953827686, 860.1871231686059, 863.8876945997043, 864.5547543015352, 866.9003064647583, 867.5835598912525, 852.2457625001887, 852.9061803201643, 855.5337341149027, 860.0625318402939, 863.8661007543841, 619.6529943231759, 624.4598422364668, 624.9656268905209, 626.6803929995735, 628.6071205496564, 12308.384580770926, 12354.567590134302, 12402.56591019319, 12408.56570020045, 12409.62771116868, 13814.102083364649, 14071.507497237548, 14093.577192684235, 14285.928570357186, 14534.273286335641, 10502.632407865687, 10574.894251057467, 10652.897144441373, 10678.62624808128, 10718.624848130277, 2884.5528943013865, 3109.5646609474693, 3302.5046243063734, 3329.9500507492166, 3395.2360718838313, 60584.697076514334, 61317.08024379682, 62499.37500624981, 62596.37403625951, 62855.37144628541, 10754.623588174532, 10775.94612026935, 10856.294340867977, 10858.294210876267, 11178.776424471465, 20847.687284690743, 20854.791452085286, 20860.37418877436, 20895.37313880586, 20895.895520522605, 6875.965620171867, 6966.477514186457, 6976.4767642426, 7025.156981162293, 7063.646817659199, 3600.4419315006216, 3654.1778099927305, 3665.376885929398, 3762.755420897633, 3843.7693738375788, 3110.486769682977, 3150.464421048427, 3217.420864244412, 3234.935301293961, 3240.886568970122, 522.8692826793301, 525.1833399064492, 537.7768226186089, 547.0809040811475, 548.8765027868698, 537.3498067338564, 550.3478378121858, 619.4517851701187, 646.3633321178635, 650.3756393861851, 7879.409044321699, 8217.424780265444, 8404.327653787683, 8485.0, 8760.145535964155, 489.5447234072347, 574.9540036797047, 601.8344955137372, 622.1476577089417, 684.2029036172803, 4187.623113919701, 4201.844492764514, 4207.474065741782, 4254.595813397722, 4326.805293761789, 80316.0, 81452.0, 82471.58764206141, 82488.0, 82565.58717206375, 50724.49275507198, 71979.0, 72148.0, 73919.0, 75761.0, 45271.773641131585, 45885.0, 46265.76867115643, 64888.67555662286, 67330.66334668393, 7911.604419778873, 7975.162607926316, 8005.439619226599, 8039.356851451987, 8167.591620419074, 31765.20586985344, 39650.60349396469, 41916.58083419127, 42266.30934762575, 44945.0, 52556.0, 52915.73542132265, 54426.45573544372, 57827.0, 60047.0, 9651.758706032124, 9861.112499875046, 9888.258380621339, 10076.647317344152, 10104.747381315232, 11093.833592495957, 11301.208915375844, 11396.259243149168, 11520.88479115198, 11688.18182727201, 10784.406857622906, 10805.243632945618, 11110.722231943942, 11220.0, 11524.308541487537, 10452.566367277763, 10998.725031874266, 11062.17033722458, 11148.498317575566, 11437.485313161094, 10245.439767026674, 10308.690739277834, 10467.738306542398, 10627.628033018807, 10714.624988125379, 9013.324000700104, 9214.585343659686, 9324.580393882427, 9527.28545359087, 9556.569954351931, 9280.0, 9340.906590934004, 9355.589095274354, 9476.194523465583, 9506.191973682315], "value": 6388.483121566327, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 134.0, 157.0, 187.0, 132.0, 165.0, 169.0, 131.0, 185.0, 134.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 174.0, 163.0, 164.0, 162.0, 161.0, 161.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 159.0, 81.0, 76.0, 75.0, 75.0, 167.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 157.0, 87.0, 86.0, 86.0, 135.0, 86.0, 86.0, 135.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 147.0, 150.0, 149.0, 146.0, 146.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 67.0, 64.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 83.0, 89.0, 86.0, 83.0, 93.0, 84.0, 119.0, 88.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 147.0, 135.0, 132.0, 147.0, 141.0, 139.0, 143.0, 133.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 174.0, 168.0, 169.0, 173.0, 167.0, 168.0, 168.0, 164.0, 166.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 69.0, 70.0, 68.0, 66.0, 71.0, 69.0], "value": 68.5, "unit": "score"}]}]} 14:22:41 INFO - Return code: 0 14:22:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:22:41 ERROR - # TBPL SUCCESS # 14:22:41 INFO - Running post-action listener: _resource_record_post_action 14:22:41 INFO - ##### 14:22:41 INFO - ##### Finished run-tests step (success) 14:22:41 INFO - ##### 14:22:41 INFO - Running post-run listener: _resource_record_post_run 14:22:41 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 524001280; Read time: 0; Write time: 543860 14:22:41 INFO - TinderboxPrint: CPU usage
13.5% 14:22:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:22:41 INFO - TinderboxPrint: I/O write bytes / time
524,001,280 / 543,860 14:22:41 INFO - TinderboxPrint: CPU idle
8,257.5 (86.5%) 14:22:41 INFO - TinderboxPrint: CPU user
1,230.0 (12.9%) 14:22:41 INFO - TinderboxPrint: Swap in / out
0 / 0 14:22:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237518848; Read time: 0; Write time: 312560 14:22:41 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 286482432; Read time: 0; Write time: 231300 14:22:42 INFO - Running post-run listener: _upload_blobber_files 14:22:42 INFO - Blob upload gear active. 14:22:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:22:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:22:42 INFO - (blobuploader) - INFO - Open directory for files ... 14:22:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:22:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:22:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:43 INFO - (blobuploader) - INFO - Done attempting. 14:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:22:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:46 INFO - (blobuploader) - INFO - Done attempting. 14:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:47 INFO - (blobuploader) - INFO - Done attempting. 14:22:47 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:47 INFO - Return code: 0 14:22:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:22:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e2e4891d08fba45383503063d818657878b7d758029a83450c35bea7e31734a709f5c16cea97774875eb9038204289cbcb6997ed41272bdfa869c0d10e8024f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efe9d583afc5a3bc582f0bf4a39d545d1a86c215a8e5b93110164fdd55e64ce561d7eb36c6fd05c0cb5eaf081d310107b4b6b4a439cf9af540c25ec0d72cec09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99412e61a601ed1d6f319c78a8ec444f5d40fdd42cbf85f7c61e2468c8d27a6433b6e44d4c46183bb790cc30798d4e5c76622d7119c805f0ae8aa3c9108eddbe"} 14:22:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:22:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:22:47 INFO - Contents: 14:22:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e2e4891d08fba45383503063d818657878b7d758029a83450c35bea7e31734a709f5c16cea97774875eb9038204289cbcb6997ed41272bdfa869c0d10e8024f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efe9d583afc5a3bc582f0bf4a39d545d1a86c215a8e5b93110164fdd55e64ce561d7eb36c6fd05c0cb5eaf081d310107b4b6b4a439cf9af540c25ec0d72cec09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99412e61a601ed1d6f319c78a8ec444f5d40fdd42cbf85f7c61e2468c8d27a6433b6e44d4c46183bb790cc30798d4e5c76622d7119c805f0ae8aa3c9108eddbe"} 14:22:47 INFO - Running post-run listener: copy_logs_to_upload_dir 14:22:47 INFO - Copying logs to upload dir... 14:22:47 INFO - mkdir: /builds/slave/test/build/upload/logs 14:22:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.137927 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-03 14:22:47.557200) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:22:47.561153) ========= 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=826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467 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/7e2e4891d08fba45383503063d818657878b7d758029a83450c35bea7e31734a709f5c16cea97774875eb9038204289cbcb6997ed41272bdfa869c0d10e8024f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efe9d583afc5a3bc582f0bf4a39d545d1a86c215a8e5b93110164fdd55e64ce561d7eb36c6fd05c0cb5eaf081d310107b4b6b4a439cf9af540c25ec0d72cec09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99412e61a601ed1d6f319c78a8ec444f5d40fdd42cbf85f7c61e2468c8d27a6433b6e44d4c46183bb790cc30798d4e5c76622d7119c805f0ae8aa3c9108eddbe"} build_url:https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.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/7e2e4891d08fba45383503063d818657878b7d758029a83450c35bea7e31734a709f5c16cea97774875eb9038204289cbcb6997ed41272bdfa869c0d10e8024f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efe9d583afc5a3bc582f0bf4a39d545d1a86c215a8e5b93110164fdd55e64ce561d7eb36c6fd05c0cb5eaf081d310107b4b6b4a439cf9af540c25ec0d72cec09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99412e61a601ed1d6f319c78a8ec444f5d40fdd42cbf85f7c61e2468c8d27a6433b6e44d4c46183bb790cc30798d4e5c76622d7119c805f0ae8aa3c9108eddbe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:22:47.587103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:22:47.587490) ========= 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=826874ccc97bd7bf541b4875000001d5-1464987723.763694-843691467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:22:47.669075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:22:47.669443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:22:47.669885) ========= ========= Total master_lag: 0.17 =========