builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1465570798.49 results: success (0) buildid: 20160610064032 builduid: bc424c7ae5be49acae6de7605d307785 revision: 52679ce4756c53fd88054a55da482291c26ef8db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.491457) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.491921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.492207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.531450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.531770) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 07:59:59-- 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% 227M=0s 2016-06-10 07:59:59 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117392 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.662939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.666327) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.718801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 07:59:58.719174) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52679ce4756c53fd88054a55da482291c26ef8db --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 52679ce4756c53fd88054a55da482291c26ef8db --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=a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 07:59:59,398 truncating revision to first 12 chars 2016-06-10 07:59:59,398 Setting DEBUG logging. 2016-06-10 07:59:59,398 attempt 1/10 2016-06-10 07:59:59,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52679ce4756c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 08:00:00,264 unpacking tar archive at: mozilla-central-52679ce4756c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.213266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 07:59:59.950398) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.950941) ========= script_repo_revision: 52679ce4756c53fd88054a55da482291c26ef8db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.951655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.952093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.963590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-10 07:59:59.964235) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:00 INFO - MultiFileLogger online at 20160610 08:00:00 in /builds/slave/test 08:00:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:00:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:00 INFO - {'append_to_log': False, 08:00:00 INFO - 'base_work_dir': '/builds/slave/test', 08:00:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:00:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:00 INFO - 'branch': 'Firefox-Non-PGO', 08:00:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:00 INFO - 'config_files': ('talos/linux_config.py',), 08:00:00 INFO - 'default_actions': ('clobber', 08:00:00 INFO - 'read-buildbot-config', 08:00:00 INFO - 'download-and-extract', 08:00:00 INFO - 'populate-webroot', 08:00:00 INFO - 'create-virtualenv', 08:00:00 INFO - 'install', 08:00:00 INFO - 'run-tests'), 08:00:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:00 INFO - 'download_minidump_stackwalk': True, 08:00:00 INFO - 'download_symbols': 'ondemand', 08:00:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:00 INFO - 'installer_path': 'installer.exe', 08:00:00 INFO - 'log_level': 'info', 08:00:00 INFO - 'log_name': 'talos', 08:00:00 INFO - 'log_to_console': True, 08:00:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:00 INFO - 'opt_config_files': (), 08:00:00 INFO - 'pip_index': False, 08:00:00 INFO - 'sps_profile': False, 08:00:00 INFO - 'sps_profile_interval': 0, 08:00:00 INFO - 'suite': 'dromaeojs-e10s', 08:00:00 INFO - 'system_bits': '32', 08:00:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:00 INFO - 'title': 'talos-linux64-ix-062', 08:00:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:00 INFO - 'use_talos_json': True, 08:00:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:00 INFO - 'work_dir': 'build'} 08:00:00 INFO - ##### 08:00:00 INFO - ##### Running clobber step. 08:00:00 INFO - ##### 08:00:00 INFO - Running pre-action listener: _resource_record_pre_action 08:00:00 INFO - Running main action method: clobber 08:00:00 INFO - rmtree: /builds/slave/test/build 08:00:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:01 INFO - Running post-action listener: _resource_record_post_action 08:00:01 INFO - ##### 08:00:01 INFO - ##### Finished clobber step (success) 08:00:01 INFO - ##### 08:00:01 INFO - ##### 08:00:01 INFO - ##### Running read-buildbot-config step. 08:00:01 INFO - ##### 08:00:01 INFO - Running pre-action listener: _resource_record_pre_action 08:00:01 INFO - Running main action method: read_buildbot_config 08:00:01 INFO - Using buildbot properties: 08:00:01 INFO - { 08:00:01 INFO - "project": "", 08:00:01 INFO - "product": "firefox", 08:00:01 INFO - "script_repo_revision": "production", 08:00:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:00:01 INFO - "repository": "", 08:00:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:00:01 INFO - "buildid": "20160610064032", 08:00:01 INFO - "pgo_build": "False", 08:00:01 INFO - "basedir": "/builds/slave/test", 08:00:01 INFO - "buildnumber": 80, 08:00:01 INFO - "slavename": "talos-linux64-ix-062", 08:00:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:00:01 INFO - "platform": "ubuntu64_hw", 08:00:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:00:01 INFO - "branch": "mozilla-central", 08:00:01 INFO - "repo_path": "mozilla-central", 08:00:01 INFO - "revision": "52679ce4756c53fd88054a55da482291c26ef8db", 08:00:01 INFO - "stage_platform": "linux64", 08:00:01 INFO - "builduid": "bc424c7ae5be49acae6de7605d307785", 08:00:01 INFO - "slavebuilddir": "test" 08:00:01 INFO - } 08:00:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:00:01 INFO - Running post-action listener: _resource_record_post_action 08:00:01 INFO - ##### 08:00:01 INFO - ##### Finished read-buildbot-config step (success) 08:00:01 INFO - ##### 08:00:01 INFO - ##### 08:00:01 INFO - ##### Running download-and-extract step. 08:00:01 INFO - ##### 08:00:01 INFO - Running pre-action listener: _resource_record_pre_action 08:00:01 INFO - Running main action method: download_and_extract 08:00:01 INFO - mkdir: /builds/slave/test/build/tests 08:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:01 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:00:05 INFO - Downloaded 1361 bytes. 08:00:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:05 INFO - Using the following test package requirements: 08:00:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'jsshell-linux-x86_64.zip'], 08:00:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:05 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:07 INFO - Downloaded 22891291 bytes. 08:00:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:09 INFO - Return code: 0 08:00:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:09 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:10 INFO - Downloaded 22891291 bytes. 08:00:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:11 INFO - Return code: 0 08:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:11 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:12 INFO - Downloaded 10833377 bytes. 08:00:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:00:12 INFO - Return code: 0 08:00: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')]} 08:00:12 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:14 INFO - Downloaded 55392537 bytes. 08:00:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:14 INFO - mkdir: /builds/slave/test/properties 08:00:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:14 INFO - Contents: 08:00:14 INFO - build_url:https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:15 INFO - Running post-action listener: _resource_record_post_action 08:00:15 INFO - Running post-action listener: set_extra_try_arguments 08:00:15 INFO - ##### 08:00:15 INFO - ##### Finished download-and-extract step (success) 08:00:15 INFO - ##### 08:00:15 INFO - ##### 08:00:15 INFO - ##### Running populate-webroot step. 08:00:15 INFO - ##### 08:00:15 INFO - Running pre-action listener: _resource_record_pre_action 08:00:15 INFO - Running main action method: populate_webroot 08:00:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:15 INFO - '--tppagecycles', 08:00:15 INFO - '7'], 08:00:15 INFO - 'tests': ['tsvgm']}}, 08:00:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['damp', 'tps']}, 08:00:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'tests': ['damp', 'tps']}, 08:00:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['dromaeo_dom']}, 08:00:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['a11yr', 08:00:15 INFO - 'ts_paint', 08:00:15 INFO - 'tpaint', 08:00:15 INFO - 'sessionrestore', 08:00:15 INFO - 'sessionrestore_no_auto_restore', 08:00:15 INFO - 'tabpaint']}, 08:00:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:15 INFO - 'ts_paint', 08:00:15 INFO - 'tpaint', 08:00:15 INFO - 'sessionrestore', 08:00:15 INFO - 'sessionrestore_no_auto_restore', 08:00:15 INFO - 'tabpaint']}, 08:00:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:15 INFO - 'ts_paint', 08:00:15 INFO - 'tpaint', 08:00:15 INFO - 'sessionrestore', 08:00:15 INFO - 'sessionrestore_no_auto_restore', 08:00:15 INFO - 'tabpaint']}, 08:00:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:15 INFO - 'ts_paint', 08:00:15 INFO - 'tpaint', 08:00:15 INFO - 'sessionrestore', 08:00:15 INFO - 'sessionrestore_no_auto_restore', 08:00:15 INFO - 'tabpaint']}, 08:00:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['a11yr', 08:00:15 INFO - 'ts_paint', 08:00:15 INFO - 'tpaint', 08:00:15 INFO - 'sessionrestore', 08:00:15 INFO - 'sessionrestore_no_auto_restore', 08:00:15 INFO - 'tabpaint']}, 08:00:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['a11yr', 08:00:15 INFO - 'ts_paint', 08:00:15 INFO - 'tpaint', 08:00:15 INFO - 'sessionrestore', 08:00:15 INFO - 'sessionrestore_no_auto_restore', 08:00:15 INFO - 'tabpaint']}, 08:00:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['tsvgx', 08:00:15 INFO - 'tsvgr_opacity', 08:00:15 INFO - 'tart', 08:00:15 INFO - 'tscrollx', 08:00:15 INFO - 'cart']}, 08:00:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:15 INFO - 'tsvgr_opacity', 08:00:15 INFO - 'tart', 08:00:15 INFO - 'tscrollx', 08:00:15 INFO - 'cart']}, 08:00:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'talos_options': ['--disable-e10s'], 08:00:15 INFO - 'tests': ['tp5o']}, 08:00:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'tests': ['tp5o']}, 08:00:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'talos_options': ['--disable-e10s', 08:00:15 INFO - '--xperf_path', 08:00:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:15 INFO - 'tests': ['tp5n']}, 08:00:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:15 INFO - 'talos_options': ['--xperf_path', 08:00:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:15 INFO - 'tests': ['tp5n']}}, 08:00:15 INFO - 'talos.zip': {'path': '', 08:00:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:15 INFO - Running post-action listener: _resource_record_post_action 08:00:15 INFO - ##### 08:00:15 INFO - ##### Finished populate-webroot step (success) 08:00:15 INFO - ##### 08:00:15 INFO - ##### 08:00:15 INFO - ##### Running create-virtualenv step. 08:00:15 INFO - ##### 08:00:15 INFO - Running pre-action listener: _resource_record_pre_action 08:00:15 INFO - Running main action method: create_virtualenv 08:00:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:15 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 08:00:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:15 INFO - Using real prefix '/usr' 08:00:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:18 INFO - Installing pip.................done. 08:00:18 INFO - Return code: 0 08:00:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:18 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 08:00:18 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 08:00:18 INFO - Using env: {'DISPLAY': ':0', 08:00:18 INFO - 'HOME': '/home/cltbld', 08:00:18 INFO - 'LANG': 'en_US.UTF-8', 08:00:18 INFO - 'LANGUAGE': 'en_US:en', 08:00:18 INFO - 'LOGNAME': 'cltbld', 08:00:18 INFO - 'MAIL': '/var/mail/cltbld', 08:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:18 INFO - 'MOZ_NO_REMOTE': '1', 08:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:18 INFO - 'NO_EM_RESTART': '1', 08:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:18 INFO - 'PWD': '/builds/slave/test', 08:00:18 INFO - 'SHELL': '/bin/bash', 08:00:18 INFO - 'SHLVL': '1', 08:00:18 INFO - 'TERM': 'linux', 08:00:18 INFO - 'TMOUT': '86400', 08:00:18 INFO - 'USER': 'cltbld', 08:00:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:18 INFO - '_': '/tools/buildbot/bin/python'} 08:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:18 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 08:00:18 INFO - Cleaning up... 08:00:18 INFO - Return code: 0 08:00:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:18 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 08:00:18 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 08:00:18 INFO - Using env: {'DISPLAY': ':0', 08:00:18 INFO - 'HOME': '/home/cltbld', 08:00:18 INFO - 'LANG': 'en_US.UTF-8', 08:00:18 INFO - 'LANGUAGE': 'en_US:en', 08:00:18 INFO - 'LOGNAME': 'cltbld', 08:00:18 INFO - 'MAIL': '/var/mail/cltbld', 08:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:18 INFO - 'MOZ_NO_REMOTE': '1', 08:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:18 INFO - 'NO_EM_RESTART': '1', 08:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:18 INFO - 'PWD': '/builds/slave/test', 08:00:18 INFO - 'SHELL': '/bin/bash', 08:00:18 INFO - 'SHLVL': '1', 08:00:18 INFO - 'TERM': 'linux', 08:00:18 INFO - 'TMOUT': '86400', 08:00:18 INFO - 'USER': 'cltbld', 08:00:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:18 INFO - '_': '/tools/buildbot/bin/python'} 08:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:18 INFO - Downloading/unpacking psutil>=3.1.1 08:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:20 INFO - Installing collected packages: psutil 08:00:20 INFO - Running setup.py install for psutil 08:00:20 INFO - building 'psutil._psutil_linux' extension 08:00:20 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 08:00:20 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 08:00:20 INFO - building 'psutil._psutil_posix' extension 08:00:20 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 08:00:20 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 08:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:21 INFO - Successfully installed psutil 08:00:21 INFO - Cleaning up... 08:00:21 INFO - Return code: 0 08:00:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:00:21 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')]} 08:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:21 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')]} 08:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:21 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:21 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 08:00:21 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 08:00:21 INFO - Using env: {'DISPLAY': ':0', 08:00:21 INFO - 'HOME': '/home/cltbld', 08:00:21 INFO - 'LANG': 'en_US.UTF-8', 08:00:21 INFO - 'LANGUAGE': 'en_US:en', 08:00:21 INFO - 'LOGNAME': 'cltbld', 08:00:21 INFO - 'MAIL': '/var/mail/cltbld', 08:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:21 INFO - 'MOZ_NO_REMOTE': '1', 08:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:21 INFO - 'NO_EM_RESTART': '1', 08:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:21 INFO - 'PWD': '/builds/slave/test', 08:00:21 INFO - 'SHELL': '/bin/bash', 08:00:21 INFO - 'SHLVL': '1', 08:00:21 INFO - 'TERM': 'linux', 08:00:21 INFO - 'TMOUT': '86400', 08:00:21 INFO - 'USER': 'cltbld', 08:00:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:21 INFO - '_': '/tools/buildbot/bin/python'} 08:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:00:23 INFO - Installing collected packages: mozsystemmonitor 08:00:23 INFO - Running setup.py install for mozsystemmonitor 08:00:23 INFO - Successfully installed mozsystemmonitor 08:00:23 INFO - Cleaning up... 08:00:23 INFO - Return code: 0 08:00:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:00:23 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')]} 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:23 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')]} 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:23 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:23 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 08:00:23 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 08:00:23 INFO - Using env: {'DISPLAY': ':0', 08:00:23 INFO - 'HOME': '/home/cltbld', 08:00:23 INFO - 'LANG': 'en_US.UTF-8', 08:00:23 INFO - 'LANGUAGE': 'en_US:en', 08:00:23 INFO - 'LOGNAME': 'cltbld', 08:00:23 INFO - 'MAIL': '/var/mail/cltbld', 08:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:23 INFO - 'MOZ_NO_REMOTE': '1', 08:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:23 INFO - 'NO_EM_RESTART': '1', 08:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:23 INFO - 'PWD': '/builds/slave/test', 08:00:23 INFO - 'SHELL': '/bin/bash', 08:00:23 INFO - 'SHLVL': '1', 08:00:23 INFO - 'TERM': 'linux', 08:00:23 INFO - 'TMOUT': '86400', 08:00:23 INFO - 'USER': 'cltbld', 08:00:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:23 INFO - '_': '/tools/buildbot/bin/python'} 08:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:26 INFO - warning: no files found matching '*.txt' 08:00:26 INFO - no previously-included directories found matching 'build' 08:00:26 INFO - no previously-included directories found matching 'dist' 08:00:26 INFO - no previously-included directories found matching '.git*' 08:00:26 INFO - Installing collected packages: jsonschema, functools32 08:00:26 INFO - Running setup.py install for functools32 08:00:26 INFO - warning: no files found matching '*.txt' 08:00:26 INFO - no previously-included directories found matching 'build' 08:00:26 INFO - no previously-included directories found matching 'dist' 08:00:26 INFO - no previously-included directories found matching '.git*' 08:00:26 INFO - Successfully installed jsonschema functools32 08:00:26 INFO - Cleaning up... 08:00:26 INFO - Return code: 0 08:00:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:00:26 INFO - Using env: {'DISPLAY': ':0', 08:00:26 INFO - 'HOME': '/home/cltbld', 08:00:26 INFO - 'LANG': 'en_US.UTF-8', 08:00:26 INFO - 'LANGUAGE': 'en_US:en', 08:00:26 INFO - 'LOGNAME': 'cltbld', 08:00:26 INFO - 'MAIL': '/var/mail/cltbld', 08:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:26 INFO - 'MOZ_NO_REMOTE': '1', 08:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:26 INFO - 'NO_EM_RESTART': '1', 08:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:26 INFO - 'PWD': '/builds/slave/test', 08:00:26 INFO - 'SHELL': '/bin/bash', 08:00:26 INFO - 'SHLVL': '1', 08:00:26 INFO - 'TERM': 'linux', 08:00:26 INFO - 'TMOUT': '86400', 08:00:26 INFO - 'USER': 'cltbld', 08:00:26 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:26 INFO - '_': '/tools/buildbot/bin/python'} 08:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:27 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 08:00:27 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 08:00:27 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 08:00:27 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 08:00:27 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 08:00:27 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 08:00:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:00:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:29 INFO - Downloading docopt-0.6.1.tar.gz 08:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:29 INFO - Running setup.py install for blobuploader 08:00:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:00:29 INFO - Running setup.py install for requests 08:00:30 INFO - Running setup.py install for docopt 08:00:30 INFO - Successfully installed blobuploader requests docopt 08:00:30 INFO - Cleaning up... 08:00:30 INFO - Return code: 0 08:00:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:30 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:30 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 08:00:30 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 08:00:30 INFO - Using env: {'DISPLAY': ':0', 08:00:30 INFO - 'HOME': '/home/cltbld', 08:00:30 INFO - 'LANG': 'en_US.UTF-8', 08:00:30 INFO - 'LANGUAGE': 'en_US:en', 08:00:30 INFO - 'LOGNAME': 'cltbld', 08:00:30 INFO - 'MAIL': '/var/mail/cltbld', 08:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:30 INFO - 'MOZ_NO_REMOTE': '1', 08:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:30 INFO - 'NO_EM_RESTART': '1', 08:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:30 INFO - 'PWD': '/builds/slave/test', 08:00:30 INFO - 'SHELL': '/bin/bash', 08:00:30 INFO - 'SHLVL': '1', 08:00:30 INFO - 'TERM': 'linux', 08:00:30 INFO - 'TMOUT': '86400', 08:00:30 INFO - 'USER': 'cltbld', 08:00:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:30 INFO - '_': '/tools/buildbot/bin/python'} 08:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:30 INFO - Running setup.py (path:/tmp/pip-Tn6C8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:30 INFO - Running setup.py (path:/tmp/pip-85a5cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:30 INFO - Running setup.py (path:/tmp/pip-TBmAAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:30 INFO - Running setup.py (path:/tmp/pip-U3HAf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:30 INFO - Running setup.py (path:/tmp/pip-epPC7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:30 INFO - Running setup.py (path:/tmp/pip-GWykTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:31 INFO - Running setup.py (path:/tmp/pip-maCdjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:31 INFO - Running setup.py (path:/tmp/pip-rMkEAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:31 INFO - Running setup.py (path:/tmp/pip-czmfp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:31 INFO - Running setup.py (path:/tmp/pip-lHqQyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:31 INFO - Running setup.py (path:/tmp/pip-ETsC7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:31 INFO - Running setup.py (path:/tmp/pip-6yf6Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:31 INFO - Running setup.py (path:/tmp/pip-sDJEC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:31 INFO - Running setup.py (path:/tmp/pip-79nhZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:31 INFO - Running setup.py (path:/tmp/pip-eBtO1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:31 INFO - Running setup.py (path:/tmp/pip-jA1dbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:31 INFO - Running setup.py (path:/tmp/pip-q4AIsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:31 INFO - Running setup.py install for manifestparser 08:00:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozcrash 08:00:32 INFO - Running setup.py install for mozdebug 08:00:32 INFO - Running setup.py install for mozdevice 08:00:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for mozfile 08:00:32 INFO - Running setup.py install for mozhttpd 08:00:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for mozinfo 08:00:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for mozInstall 08:00:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for mozleak 08:00:32 INFO - Running setup.py install for mozlog 08:00:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for moznetwork 08:00:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for mozprocess 08:00:33 INFO - Running setup.py install for mozprofile 08:00:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:33 INFO - Running setup.py install for mozrunner 08:00:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:33 INFO - Running setup.py install for mozscreenshot 08:00:33 INFO - Running setup.py install for moztest 08:00:33 INFO - Running setup.py install for mozversion 08:00:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:33 INFO - Cleaning up... 08:00:33 INFO - Return code: 0 08:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:33 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 08:00:33 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 08:00:33 INFO - Using env: {'DISPLAY': ':0', 08:00:33 INFO - 'HOME': '/home/cltbld', 08:00:33 INFO - 'LANG': 'en_US.UTF-8', 08:00:33 INFO - 'LANGUAGE': 'en_US:en', 08:00:33 INFO - 'LOGNAME': 'cltbld', 08:00:33 INFO - 'MAIL': '/var/mail/cltbld', 08:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:33 INFO - 'MOZ_NO_REMOTE': '1', 08:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:33 INFO - 'NO_EM_RESTART': '1', 08:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:33 INFO - 'PWD': '/builds/slave/test', 08:00:33 INFO - 'SHELL': '/bin/bash', 08:00:33 INFO - 'SHLVL': '1', 08:00:33 INFO - 'TERM': 'linux', 08:00:33 INFO - 'TMOUT': '86400', 08:00:33 INFO - 'USER': 'cltbld', 08:00:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:33 INFO - '_': '/tools/buildbot/bin/python'} 08:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:33 INFO - Running setup.py (path:/tmp/pip-pBBCK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:33 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)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:33 INFO - Running setup.py (path:/tmp/pip-4e9wsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:34 INFO - Running setup.py (path:/tmp/pip-g2r1pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:34 INFO - Running setup.py (path:/tmp/pip-MAaFNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:34 INFO - Running setup.py (path:/tmp/pip-AFE6hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:34 INFO - Running setup.py (path:/tmp/pip-FL0kFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:34 INFO - Running setup.py (path:/tmp/pip-sUDX9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:34 INFO - Running setup.py (path:/tmp/pip-xkOWgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:34 INFO - Running setup.py (path:/tmp/pip-tSeoO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:34 INFO - Running setup.py (path:/tmp/pip-V8qIIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:34 INFO - Running setup.py (path:/tmp/pip-4bkQur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:34 INFO - Running setup.py (path:/tmp/pip-qD0GG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:34 INFO - Running setup.py (path:/tmp/pip-CkX4gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:34 INFO - Running setup.py (path:/tmp/pip-q_GHQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:34 INFO - Running setup.py (path:/tmp/pip-lc3KQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:34 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)) 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:34 INFO - Running setup.py (path:/tmp/pip-CUnDD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:35 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)) 08:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:35 INFO - Running setup.py (path:/tmp/pip-qODoZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:35 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)) 08:00:35 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)) 08:00:35 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)) 08:00:35 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)) 08:00:35 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)) 08:00:35 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)) 08:00:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:35 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 08:00:35 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 08:00:35 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 08:00:35 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 08:00:35 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 08:00:35 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 08:00:36 INFO - Downloading blessings-1.6.tar.gz 08:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:37 INFO - Installing collected packages: blessings 08:00:37 INFO - Running setup.py install for blessings 08:00:37 INFO - Successfully installed blessings 08:00:37 INFO - Cleaning up... 08:00:37 INFO - Return code: 0 08:00:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:37 INFO - Reading from file tmpfile_stdout 08:00:37 INFO - Current package versions: 08:00:37 INFO - argparse == 1.2.1 08:00:37 INFO - blessings == 1.6 08:00:37 INFO - blobuploader == 1.2.4 08:00:37 INFO - docopt == 0.6.1 08:00:37 INFO - functools32 == 3.2.3-2 08:00:37 INFO - jsonschema == 2.5.1 08:00:37 INFO - manifestparser == 1.1 08:00:37 INFO - mozInstall == 1.12 08:00:37 INFO - mozcrash == 0.17 08:00:37 INFO - mozdebug == 0.1 08:00:37 INFO - mozdevice == 0.48 08:00:37 INFO - mozfile == 1.2 08:00:37 INFO - mozhttpd == 0.7 08:00:37 INFO - mozinfo == 0.9 08:00:37 INFO - mozleak == 0.1 08:00:37 INFO - mozlog == 3.2 08:00:37 INFO - moznetwork == 0.27 08:00:37 INFO - mozprocess == 0.22 08:00:37 INFO - mozprofile == 0.28 08:00:37 INFO - mozrunner == 6.11 08:00:37 INFO - mozscreenshot == 0.1 08:00:37 INFO - mozsystemmonitor == 0.3 08:00:37 INFO - moztest == 0.7 08:00:37 INFO - mozversion == 1.4 08:00:37 INFO - psutil == 3.1.1 08:00:37 INFO - requests == 1.2.3 08:00:37 INFO - wsgiref == 0.1.2 08:00:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:37 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:37 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 08:00:37 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 08:00:37 INFO - Using env: {'DISPLAY': ':0', 08:00:37 INFO - 'HOME': '/home/cltbld', 08:00:37 INFO - 'LANG': 'en_US.UTF-8', 08:00:37 INFO - 'LANGUAGE': 'en_US:en', 08:00:37 INFO - 'LOGNAME': 'cltbld', 08:00:37 INFO - 'MAIL': '/var/mail/cltbld', 08:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:37 INFO - 'MOZ_NO_REMOTE': '1', 08:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:37 INFO - 'NO_EM_RESTART': '1', 08:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:37 INFO - 'PWD': '/builds/slave/test', 08:00:37 INFO - 'SHELL': '/bin/bash', 08:00:37 INFO - 'SHLVL': '1', 08:00:37 INFO - 'TERM': 'linux', 08:00:37 INFO - 'TMOUT': '86400', 08:00:37 INFO - 'USER': 'cltbld', 08:00:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:37 INFO - '_': '/tools/buildbot/bin/python'} 08:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 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)) 08:00:37 INFO - Cleaning up... 08:00:37 INFO - Return code: 0 08:00:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:37 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:37 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 08:00:37 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 08:00:37 INFO - Using env: {'DISPLAY': ':0', 08:00:37 INFO - 'HOME': '/home/cltbld', 08:00:37 INFO - 'LANG': 'en_US.UTF-8', 08:00:37 INFO - 'LANGUAGE': 'en_US:en', 08:00:37 INFO - 'LOGNAME': 'cltbld', 08:00:37 INFO - 'MAIL': '/var/mail/cltbld', 08:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:37 INFO - 'MOZ_NO_REMOTE': '1', 08:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:37 INFO - 'NO_EM_RESTART': '1', 08:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:37 INFO - 'PWD': '/builds/slave/test', 08:00:37 INFO - 'SHELL': '/bin/bash', 08:00:37 INFO - 'SHLVL': '1', 08:00:37 INFO - 'TERM': 'linux', 08:00:37 INFO - 'TMOUT': '86400', 08:00:37 INFO - 'USER': 'cltbld', 08:00:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:37 INFO - '_': '/tools/buildbot/bin/python'} 08:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:37 INFO - Cleaning up... 08:00:37 INFO - Return code: 0 08:00:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:37 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 0x7f8c629def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', '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 08:00:37 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 08:00:37 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 08:00:37 INFO - Using env: {'DISPLAY': ':0', 08:00:37 INFO - 'HOME': '/home/cltbld', 08:00:37 INFO - 'LANG': 'en_US.UTF-8', 08:00:37 INFO - 'LANGUAGE': 'en_US:en', 08:00:37 INFO - 'LOGNAME': 'cltbld', 08:00:37 INFO - 'MAIL': '/var/mail/cltbld', 08:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:37 INFO - 'MOZ_NO_REMOTE': '1', 08:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:37 INFO - 'NO_EM_RESTART': '1', 08:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:37 INFO - 'PWD': '/builds/slave/test', 08:00:37 INFO - 'SHELL': '/bin/bash', 08:00:37 INFO - 'SHLVL': '1', 08:00:37 INFO - 'TERM': 'linux', 08:00:37 INFO - 'TMOUT': '86400', 08:00:37 INFO - 'USER': 'cltbld', 08:00:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:37 INFO - '_': '/tools/buildbot/bin/python'} 08:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:38 INFO - Downloading/unpacking flake8 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:40 INFO - no previously-included directories found matching 'docs/_build' 08:00:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:40 INFO - Running setup.py install for pep8 08:00:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:40 INFO - no previously-included directories found matching 'docs/_build' 08:00:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:00:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:40 INFO - Cleaning up... 08:00:41 INFO - Return code: 0 08:00:41 INFO - Running post-action listener: _resource_record_post_action 08:00:41 INFO - Running post-action listener: _start_resource_monitoring 08:00:41 INFO - Starting resource monitoring. 08:00:41 INFO - ##### 08:00:41 INFO - ##### Finished create-virtualenv step (success) 08:00:41 INFO - ##### 08:00:41 INFO - ##### 08:00:41 INFO - ##### Running install step. 08:00:41 INFO - ##### 08:00:41 INFO - Running pre-action listener: _resource_record_pre_action 08:00:41 INFO - Running main action method: install 08:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:41 INFO - Reading from file tmpfile_stdout 08:00:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:41 INFO - Reading from file tmpfile_stdout 08:00:41 INFO - Output received: 08:00:41 INFO - Usage: mozinstall [options] installer 08:00:41 INFO - Options: 08:00:41 INFO - -h, --help show this help message and exit 08:00:41 INFO - -d DEST, --destination=DEST 08:00:41 INFO - Directory to install application into. [default: 08:00:41 INFO - "/builds/slave/test"] 08:00:41 INFO - --app=APP Application being installed. [default: firefox] 08:00:41 INFO - mkdir: /builds/slave/test/build/application 08:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:00:57 INFO - Reading from file tmpfile_stdout 08:00:57 INFO - Output received: 08:00:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:57 INFO - Running post-action listener: _resource_record_post_action 08:00:57 INFO - ##### 08:00:57 INFO - ##### Finished install step (success) 08:00:57 INFO - ##### 08:00:57 INFO - ##### 08:00:57 INFO - ##### Running run-tests step. 08:00:57 INFO - ##### 08:00:57 INFO - Running pre-action listener: _resource_record_pre_action 08:00:57 INFO - Running main action method: run_tests 08:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:57 INFO - Python 2.7.3 08:00:57 INFO - Return code: 0 08:00:57 INFO - grabbing minidump binary from tooltool 08:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:57 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 0x16731c0>, '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 0x16740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1674550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:57 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 08:00:57 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 08:00:57 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 08:00:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:57 INFO - Return code: 0 08:00:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:00:58 INFO - Return code: 0 08:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 08:00:58 INFO - Using env: {'DISPLAY': ':0', 08:00:58 INFO - 'HOME': '/home/cltbld', 08:00:58 INFO - 'LANG': 'en_US.UTF-8', 08:00:58 INFO - 'LANGUAGE': 'en_US:en', 08:00:58 INFO - 'LOGNAME': 'cltbld', 08:00:58 INFO - 'MAIL': '/var/mail/cltbld', 08:00:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:58 INFO - 'MOZ_NO_REMOTE': '1', 08:00:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:58 INFO - 'NO_EM_RESTART': '1', 08:00:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:58 INFO - 'PWD': '/builds/slave/test', 08:00:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:58 INFO - 'SHELL': '/bin/bash', 08:00:58 INFO - 'SHLVL': '1', 08:00:58 INFO - 'TERM': 'linux', 08:00:58 INFO - 'TMOUT': '86400', 08:00:58 INFO - 'USER': 'cltbld', 08:00:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616', 08:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:58 INFO - '_': '/tools/buildbot/bin/python'} 08:00:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:00:58 INFO - mozversion application_buildid: 20160610064032 08:00:58 INFO - mozversion application_changeset: 52679ce4756c53fd88054a55da482291c26ef8db 08:00:58 INFO - mozversion application_display_name: Nightly 08:00:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:58 INFO - mozversion application_name: Firefox 08:00:58 INFO - mozversion application_remotingname: firefox 08:00:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:00:58 INFO - mozversion application_vendor: Mozilla 08:00:58 INFO - mozversion application_version: 50.0a1 08:00:58 INFO - mozversion platform_buildid: 20160610064032 08:00:58 INFO - mozversion platform_changeset: 52679ce4756c53fd88054a55da482291c26ef8db 08:00:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:00:58 INFO - mozversion platform_version: 50.0a1 08:00:58 INFO - using testdate: 1465570858 08:00:58 INFO - actual date: 1465570858 08:00:58 INFO - starting webserver on 'localhost:56662' 08:00:58 INFO - SUITE-START | Running 2 tests 08:00:58 INFO - TEST-START | dromaeo_css 08:00:58 INFO - operating with platform_type : linux_ 08:00:58 INFO - Initialising browser for dromaeo_css test... 08:00:58 INFO - TEST-INFO | started process 5932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwbuUnE/profile http://localhost:56662/getInfo.html) 08:01:02 INFO - PROCESS | 5932 | __metrics Screen width/height:1600/1200 08:01:02 INFO - PROCESS | 5932 | colorDepth:24 08:01:02 INFO - PROCESS | 5932 | Browser inner width/height: 1024/697 08:01:02 INFO - PROCESS | 5932 | __metrics 08:01:03 ERROR - PROCESS | 5932 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:01:04 INFO - TEST-INFO | 5932: exit 0 08:01:04 INFO - Browser initialized. 08:01:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:04 INFO - TEST-INFO | started process 6051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwbuUnE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:16 INFO - PROCESS | 6051 | RSS: Main: 185790464 08:01:16 INFO - PROCESS | 6051 | 08:02:06 INFO - PROCESS | 6051 | 1465570926032 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] 08:04:19 INFO - PROCESS | 6051 | Cycle 1(1): loaded http://localhost:56662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56662/tests/dromaeo/cssquery-ext.html) 08:04:20 INFO - PROCESS | 6051 | RSS: Main: 186699776 08:04:20 INFO - PROCESS | 6051 | 08:07:22 INFO - PROCESS | 6051 | Cycle 1(1): loaded http://localhost:56662/tests/dromaeo/cssquery-ext.html (next: http://localhost:56662/tests/dromaeo/cssquery-jquery.html) 08:07:23 INFO - PROCESS | 6051 | RSS: Main: 187506688 08:07:23 INFO - PROCESS | 6051 | 08:10:25 INFO - PROCESS | 6051 | Cycle 1(1): loaded http://localhost:56662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56662/tests/dromaeo/cssquery-mootools.html) 08:10:25 INFO - PROCESS | 6051 | RSS: Main: 188882944 08:10:25 INFO - PROCESS | 6051 | 08:13:27 INFO - PROCESS | 6051 | Cycle 1(1): loaded http://localhost:56662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56662/tests/dromaeo/cssquery-prototype.html) 08:13:28 INFO - PROCESS | 6051 | RSS: Main: 187334656 08:13:28 INFO - PROCESS | 6051 | 08:16:30 INFO - PROCESS | 6051 | Cycle 1(1): loaded http://localhost:56662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56662/tests/dromaeo/cssquery-yui.html) 08:16:31 INFO - PROCESS | 6051 | RSS: Main: 189001728 08:16:31 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | Cycle 1(1): loaded http://localhost:56662/tests/dromaeo/cssquery-yui.html (next: http://localhost:56662/tests/dromaeo/cssquery-dojo.html) 08:19:34 INFO - PROCESS | 6051 | RSS: Main: 190025728 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | __start_tp_report 08:19:34 INFO - PROCESS | 6051 | _x_x_mozilla_page_load 08:19:34 INFO - PROCESS | 6051 | _x_x_mozilla_page_load_details 08:19:34 INFO - PROCESS | 6051 | |i|pagename|runs| 08:19:34 INFO - PROCESS | 6051 | |0;dojo.html;2590.145252066818;2621.2529429112706;2622.895084196632;2656.150031989762;2661.36127329441;4795.856124316272;4832.420109586855;4853.126437241295;4865.6594038417325;4906.165951788195;4691.554302341281;4757.9286310705365;4839.540243676854;4841.709497430156;4909.533594308535;4316.374125751764;4318.287482565373;4340.435743353375;4502.122086193193;4520.095980803852;4433.157700036999;4511.323301504768;4537.478190008158;4564.04155127422;4583.3125031245245;4289.6997210195295;4371.3224450209955;4396.648268138541;4398.64810815134;4459.44256967879;4372.912541749147;4410.117976404732;4416.889577760549;4417.204903117437;4424.9557504424865;4411.713238639478;4430.025394413224;4442.8667139985855;4460.50934397216;4491.146682130385;4749.928751068736;4806.423229212482;4827.058723548909;4829.323894654751;4888;5154.38147422308;5161.4322424533275;5173.094708426048;5175.611829112831;5244.239585260154;5080.415752188509;5213.035588416155;5226.55574276187;5228.5555727763185;5235.869103272411;4882.6826256293225;4899.632527560448;4925.802967881316;4934.333864928189;4936.111499930047;5331.360236771535;5363.570914326922;5379.731013449312;5381.650192737459;5458;4849.684770489906;5028.17035189197;5097.745112744348;5103.489651034867;5115.590752739772;5066.974665126724;5112.36095488064;5144.9742751286;5215.58275337972;5256.868578285497;5076.416212135578;5091.618128640367;5108.489151084936;5115.053715062725;5123.641345105807;5000.174971129795;5071.518205770446;5096.770645320969;5098.668586541863;5137.563307118862;4230.873073807791;4275.187714334266;4278.422412974271;4281.100968796525;4282.76444795533;3733.775973441602;3750.437434384864;3766.152615661509;3783.902668226184;3827.9808600956817;4502.707324023928;4523.615492683093;4526.366308716782;4541.84103556374;4550.13547425988;5040.269160971712;5090;5159.690418574897;5165.74171291434;5187.299714538564;4462.799174037176;4500.482444518922;4542.568455996675;4542.613877820422;4547.408836851254;4622.46841613212;4623.791929363187;4629.236176030917;4629.305604159403;4672.042231342567;4652.534746525321;4799.568038876518;4803.735794531194;4907.1903135982875;4924.212126059813;5195.636305458582;5276.76254568553;5304;5306.230596563554;5334.573234141337;4917.385326834145;4941.50584941503;4981.053599816023;5004.374453193351;5016.423111342242;4921.212605983025;5072.771725272445;5167.095758242368;5181.481851814789;5210.088234559013;5188.58491320701;5246.97376513115;5255.579553635624;5258.158694608845;5295.285136506523;5080.872978175576;5094.5669618082875;5095.363079615048;5097.949020509747;5164.32863727713;4887.291342755351;4887.926681099715;4975.154223781893;5090.567301779391;5097.643164978416;4857.247126695368;4918.778654960607;4934.432540257916;4940.975295123645;4984.252362145708;5043.344365232496;5050.242463630485;5050.520200580939;5062.924056139087;5117.334746482933;4785.042991401803;4909;4938.061768264019;4961.2806143109765;5004.174311238605 08:19:34 INFO - PROCESS | 6051 | |1;ext.html;535.7964163280401;570.3754388944104;581.8516278349022;597.9923828349232;603.602659842465;34716.65283347166;38297.808510957475;38317.233655326876;38350;38413.42379864301;37729.43405848915;37882;38144.80927595358;38215.61784382162;38244.61755382446;7532;7558.773236802905;7637.961810190969;7675.078990521145;7696.807579810494;7595.696172153107;7657.731979380723;7658.8468230635635;7701.576413297266;7715;7706.614669266514;7751.263629955145;7800.141984381714;7813.882791758128;7836.412269079813;7684.731034413797;7709.2290770922455;7726.7681969541;7740.961295193544;7785.221477852226;7635.121960974503;7719.498232614862;7737.458377913548;7737.535747855147;7739.729109481141;36082.27835443303;36117.45823812645;36191.81904090463;36193.81903090494;36335.81832090849;2490.7297278387973;2821.5203415419223;2832.8583570821374;2863.656361236644;2950.8819647214086;27047.729522704718;27512.724872751216;27552.311192220153;27730.5840412394;28063.579046314117;3281.7233254796383;3299.538064670948;3303.6035675719068;3322.7840190387546;3350.6816852398983;219330;221922;223449;225057;226490;30463.23841903926;30640.54039189414;30911.2272193197;30934;31023.379532409224;30751.384972300428;32812.507812382835;32923.835380822944;32964.835175824446;33005.339893202;12545.31000794965;12759;12833.486660533661;12839;12856.55002074923;10570.10154136907;10775.245732798785;10781.838272425919;10799.190060745319;10806.783864322826;7796.142424333319;7800.063992320957;7830.491018083806;7884.72403465876;7906.7627971160955;3052.175912503656;3054.2059064643354;3078.846057697106;3098.5352197170155;3141.8164375759084;888.9066648001996;918.1002617434951;947.8862536495665;989.6437282578266;1030.9175265978704;27070;27171.1848644541;27507.862460687567;27948.86025569859;28031;922.4004397141778;926.9884350958301;950.4819873169139;955.9426434413957;959.6449313753956;14282;14598;14793.334299956528;14979.775303370458;15067;389679;390989;395835;399172;399852;47793.044139117024;47995.52004479981;48457;48505;48704.75647621739;1195.4919159357412;1200.3878022208562;1206.3968015992004;1209.9594348859973;1215.2829830400105;26159;27834.721652784025;27841.16476505708;28038;28244.43511129807;43050.13899722051;43186.78406607947;43336.783316083216;43629.56370436382;43779.343309851014;344881;346320;347047;347107;348469;36543.63456365402;36700.26599468049;37031.814840925625;37649;37801.243975120895;40461;40755;41019.384709229984;41438.58561414347;41696.79151604223;34926.47610285797;35548.28903421969;35707.46438803472;35833.82083089568;36188;34709.47935780915;34992.65007349996;35170.47244291389;35543.46684799782;35980;34704.57068005215;34932.30135397227;34959.30081398409;35298.11754706153;35376.29247415089;30457.847710761303;31662.683373166896;31781.841090794398;31829.681703182672;32061.839690801397;24960.251192464257;25050.37374065663;25126.246212613652;25476.49047019012;25602.74397256078 08:19:34 INFO - PROCESS | 6051 | |2;jquery.html;371.8196674612813;372.8098669678463;374.8613013185121;383.43251987059136;387.77315270566714;15533.611659708498;16569.33722651094;17214.13929303536;17271.91364043178;17309.134543272816;15142.470013549528;15630.29663665135;15750.84249157511;15869.365225390971;15923.84076159238;4995.875103122424;5159.509846564571;5190.299309593213;5190.506901844337;5198;3685.7419980601367;5113.43752187261;5775.1337299405;6131.846703832395;6152.1387005819;6184.721687524072;6197.256329240475;6211.47202487789;6231.22109736283;6241.407066328714;5010.398752149747;5364.892702145974;5387.946120538783;5422.810201642963;5446.945530544684;5083.974580127113;5265.341832270966;5266.631335806495;5335.546478549328;5353.464653534655;12192.878071219351;12359.567415140427;12422.56521021769;17763.644727105515;20080;1769.0977601423367;1775.7158854583204;1785.098525244756;1835.1008006077059;1973;8793;9057.592408341641;9382.718518444457;9427.575759090789;9496.857547136799;1634.6975809475166;1726.8704847136514;1736.5311365931254;1764.6382491589193;1768.1689605885342;65365.346346536404;65971.340286597;67337;68000.9999999995;69746.30253697449;8634;8894.532402153573;10050.195984321383;10073;10147.238957078249;13985.160890346611;14031.859681403055;14043.368048437846;14074.085184462978;14114.153150810778;6918.204406493217;6950.617716025566;6969.4424446044195;7124.43004559634;7126.786196414116;6550.377714117151;6586;6661.733530658817;6781.982702594651;6816.488763342769;4291.163223171514;4336.3278691802825;4368.36658684489;4404.757738324423;4407.162639098561;1628.462607339599;1687.5696697342344;1782.189103957696;1810.9094545272683;1878.3707458001722;800.9959950200329;849.1423662101322;866.1814585217036;905.0406569036842;906.8730377747121;15586.376544938303;16204.270807813677;16440;16566.917165414336;16745.413910513074;792.0653628718053;824.1799409587499;843.3464065349281;849.7450764770545;898.9235914947303;9068.637254509746;9265.166135047879;9362.344635875423;9522.047795220562;9710.951445242728;371488;375398;377937;382052;385157;70567;75246;79882;81699;81881.59059204666;816.420341557489;837.1586555511793;844.9155084491501;847.6100993542916;852.6376290076693;15089.47186848455;15207.315670795062;15424.614384640474;15442;15793.36826526926;37517;37552.43671344878;37577;38331.42502862515;38965.2206955865;45646.31530526978;46685.066298674516;48602.756986214845;50612.49387506225;50818.491815081376;7297.708091676486;7436.9295367801515;7563.810904727426;7573;7624.847503049797;8676.91323086761;10895.237333386587;11339.716507087389;11485.19603627738;12034.699132521757;10092.54583543757;10299.897001030193;10302.896971030494;10381.792364152523;10441.582336706446;10677.412742298937;10788.298760580537;10891.509882055485;11015.779684406427;11093.833592496281;10556.208284378548;10600.681979540626;10808.729781755519;10830.891691082988;10875.782484350428;6764.898526522008;7065.434765218873;7222.783316500513;7782.610869456391;7940;10249.282550221413;10456.47717614101;10457.895421045692;10550.472476375997;10677.09244714208 08:19:34 INFO - PROCESS | 6051 | |3;mootools.html;1366.0369439545118;1406.711624117056;1433.4767809749437;1606.1969015492255;1609.0667412900518;6808.421284190849;7469.141048779392;7521.473496855222;7983.720569780066;7993.200679932012;7254.202037775854;7444.069491313586;7447.32974032337;7480.588567628778;7536;2175.9456013599706;2206.161658569741;2209.9889500552476;2214.036893951128;2216.3350994701605;2128.7658357580654;2183.148572056899;2191.2549733090746;2208.7901649343366;2209.5249521352907;2213.5904857601395;2221.1559607349186;2224.232639739287;2227.164813195052;2237.2952519956243;2074.8651337663077;2086.5096702275027;2099.2862426774896;2118.9576208475896;2121;2118.555103428282;2157.3420106867397;2171.3051823416513;2173.163332117146;2173.521825198454;7796.415268854858;7901.604919754047;7920.326772224368;7922.603869806487;7972.441929064968;4759.571638552512;4895.290182923456;4898.632602554787;4898.877528061791;4905.8773530661665;2889.7688184945155;2917.693642167584;2970.628671416073;3005.2637103909683;3059.7552195824283;854.2695994924312;875.6497401039635;879.1384443245591;886.7916039730658;895.9193672569435;10918.181136414722;11083.113350931906;11089.83365249522;11108.277961932448;11118.55525778976;4276.444062271885;4384.693071484965;4471.754053527022;4486.685931984795;4511.661625378044;9208.815823683623;9279.76800579991;9309.44143351401;9309.72070837876;9312.161905428544;4579.656525760582;4727.621790256771;4728.881777955578;4775.594074503637;4785.688930219525;3839.404892241707;4184.2050010498515;4282.421873047161;4318.52496225415;4343.891402714958;3671.504346913186;3740.1958578905665;3815.2178803345246;3835.4246862970776;3915.7650540967634;1230.4094034863315;1240.460399726104;1263.92416455013;1271.5358894003623;1271.8028705550655;660.8281846719888;792.1919641965163;810.8864758933754;812.959352032396;833.0919297965247;5111.309973153651;5360.973195133999;5365.463453654604;5385.299911011543;5442.9930462864495;384.8499085356713;388.2719900187149;388.65409785291115;403.650842021655;410.06914304528556;3581.3195492856275;3624.4563315502887;3651.6165802590876;3689.9815500922323;3731.552213734369;9336.95331523338;9624.181944534794;9755.756106097262;9770.902290977141;9771.853422198672;9590.08894155054;9594;9613.807723845624;9631.036896310314;9703.611855525842;7250.673719682627;7306.086739157606;7357.301056399633;7369.410447164214;7394.704211831574;5454.863628409163;5469.644473109235;5521.061419558765;5593.384727680033;5747.683877386617;8822.07368226327;8836.823263534821;8931.106889311017;8944.642214311354;9011.639534418811;8678.132186781524;9080.863787043067;9090.500022498825;9108.271338292789;9259.537023148681;6281.811545653638;6633.336666333328;6677.465802735866;6717.395434410926;6989.405900498311;7687.9231207689445;7692.000039994765;7734.883976740466;7780.183080776437;7789.610519474117;6667.666616669244;6982.685779140053;7015.614141222078;7028.50800443964;7123.074000379917;6862.519623626298;6901.89647155283;6930.203026651798;7038.577685338896;7042.119735033121;5960.225170727777;6127.938720612737;6187.102870083722;6348.77779277723;6397.296297407374;4388.758618276025;4421.734695918255;4428.158649856517;4469.754163521037;4510.819567217274;4549.135664223787;4572.245579479349;4589.701669391479;4625.699329543569;4677.859664210079 08:19:34 INFO - PROCESS | 6051 | |4;prototype.html;298.1933868884667;298.9402119576085;303.2842491719543;303.2963524622874;303.9437704024757;5022.598192144629;5028.371453568304;5074.5432911038;5112.258722485242;5122.743862806863;4993.675411098276;5004.849854504361;5005.824796132136;5014.2227954667;5034.320366750488;3645.671889529942;3799.9810000949956;3884.8834534964;3913.2369188008206;3917.334053210961;3862.9376921346575;3873.5861410585217;3882.2041481496226;3916.295066887959;3929.332013557688;3909.944315034939;3911.5306163260448;3945.625165609277;3971.106501037258;3976.324024915771;3845.5385353757447;3905.472761177233;3929.292727309083;3941.310270702644;3944.7830369329677;3455.2053027803495;3470.7570470067108;3473.9652603473896;3480.3039392121677;3495.2659941412335;4816.56650901417;4855;4906.0808818752785;4907.337509436216;4940.654154209206;4357.891052723676;4443.355713421568;4485.372047913294;4488.551144885485;4494.168578812897;5184.403793563713;5195.272661827347;5196.53231209193;5198.454162312941;5238.842834714965;3780.6597406233295;3812.379738611079;3822.2737679840743;3830.2339532093415;3869.3228684980018;5382.946170538323;5503.944960550383;5519.503244707996;5538.335399752055;5554.888902221974;3911.882643520699;3919.274934137137;3927.6465118139504;3936.4095385691803;3952.3281042222893;3991.501062367204;3993.1215132671346;4006.258842114218;4007.7996100194873;4013;4509.932351014738;4528.230200865861;4536.956500005017;4542.6593005524055;4549.931751023737;5124.538791508782;5237.476252374809;5250.3962044364625;5286.762095705702;5341.626086174008;1372.7460419822364;1386.4454218312756;1392.331680793225;1394.198335956829;1394.842280906845;856.7643897928119;860.0281681699639;892.7366426904078;911.1685512120686;921.4747593871429;4465.955340446619;4645.488996210414;4657.417822772153;4666.370040044619;4707.223308154184;5339.79854532727;5414.3502779665905;5478.287822583118;5498.752556134984;5501.972490137604;4512.661550383735;4721.433427988594;4729.635182408796;4731.95268047322;4749.453812811571;2831.419558990402;2866.269101379135;2874.597556342114;2888.768898488116;2907.25864904448;5079.822206222764;5087.491250874883;5117.1045067113855;5140.280360749498;5150.922736158961;5445.210444485528;5486.286782718221;5543.752655652526;5556.305461817273;5566.693831839207;5093.439721630618;5113.51421614946;5119.1553393690365;5121.411037730634;5150.278960945396;5356.098585002268;5397.622166448311;5437.972810136082;5478.91781623284;5509.972450137724;5051.055343692631;5266.78932842682;5304.840854774363;5321.308229930084;5352.384475785335;5081.4918508148885;5098.898022039612;5106.565941894832;5106.821261255838;5117.897642047213;3936.5079365079364;3943.802809859553;3954.624310690595;3963.5838236985855;3963.6630886374983;5286.735663216747;5338.946610533845;5371.758270877898;5377.166539186433;5448.809291674773;5230.7384630769075;5257.5005374489365;5267.157254839208;5272.130098533699;5272.9736351318;5194.844154675366;5228.418533304698;5237.790488380422;5246.186841039645;5269.552088072557;4929.309896614405;5191.9751296994955;5196.4283928767045;5198.558122559625;5222.895542089061;5032.949670503248;5144.887343157336;5323.946760532345;5326.6537675050995;5336.252924590638;5152.201408781645;5152.355955505562;5154.123798954111;5171.086697921643;5201 08:19:34 INFO - PROCESS | 6051 | |5;yui.html;656.6486929492722;665.9633720145391;703.7747920665387;723.5730918757931;726.2737262737263;11936.582219622314;13055.543055993043;13079.93460032701;13087.280199589031;13091.410886510106;12371.38143092844;12420.751584968295;12426.192297500678;12463.937680311608;12469.937650311758;621.0404924391803;753.506453273107;759.4835511851938;763.3664058831184;777.0713996773843;768.5503980171578;779.9220077992212;779.9844003119935;781.6326326626477;782.7769085810545;836.6653338664553;838.6896848166188;843.1484200957016;844.6368061733452;845.247729520727;822.0300045945781;831.1812864328631;832.5213002523543;832.6253186066264;834.3783881008687;605.939406059395;608.2154021312501;608.5618354784592;610.66108309888;614.6312212672406;13014.86985130146;13029.674258143528;13103.737925241538;13106.148100373444;13118.344082795917;13784.862151378458;13835.30823458823;13892.7701704659;14065.5077072303;14087.506937257147;9924.900750992541;10090.899091009069;10256.435896025716;11142.721431964266;11162.107031437465;4224.619784219435;4246.936295955563;4256.808443620013;4263.4031235627035;4267.765272909989;56561.15158272629;56602.433975660126;56605.71697141488;57260.999999999585;58219;9459;9612;9774.218062554979;10016.49917504122;10284.125849302744;16384.590385240463;16542.751858722128;16770.580735481468;16805.83194168067;16817;6760.42536384403;7203.96398018017;7246.420286377077;7247.16657584374;7416.0729908761405;3834.4785099289884;3959.3862951242604;3966.6628336591134;4038.394240863835;4073.91852162961;2932.8386938718577;3082.321889184376;3087.1356020313897;3092.768042396829;3098.8760449582214;539.3689383421406;543.9265699130567;572.6420986883198;573.6042130929645;579.1804596495911;460.39688008708697;556.8496505943373;568.687222027883;572.4761842913771;594.5629961977943;8168;8539.662983864593;8557.272631826365;8635.797871542716;8776.385653004356;464.38237144597605;608.0939400293531;609.3540846702509;618.2580902916428;637.8915584350672;3648.4709717091405;3893.844246230176;3953.466282051944;3990.1421194443333;4007.5992400760274;83835;85577.57211214029;90782.54608726915;94722;96247.51876240574;75477.24522754703;77625;77817;79645.60177199077;79732;72185.63907180431;72969.6351518239;73221.2677873225;74494.62752686093;74790.62604686942;7373.9262607375385;7429.5542267464125;7526.5860377679755;7673.232676732506;7687.5387476751575;41949.370759438025;42636.36045459383;43252.351214732436;43443.782781085894;44196.11607767762;56224;62671.6866415665;63069.36930630819;64406;64445;10046.69859904204;10123.088921997056;10240.53917573696;10264.384136951807;10299.176065914859;11202.327860328407;11560;11666.416679166177;12066;12331.50673973031;9185.265178785814;9227.953860230657;9306.953465232631;9338.719838404859;9685.41887486753;10075.496225188564;10421;10460.581576736846;10530.684079477627;10600.4699765013;9539.57071931751;9639.951800241235;9696.5151742414;9719.41683498964;10031.949840250752;8477.74566762998;8680.869786953326;8855.955720221358;8886.911130888868;9116.453012819253;8796.208341249318;8900.154485323885;8911.910880891368;8916.242119419663;9288.164065234161 08:19:34 INFO - PROCESS | 6051 | __end_tp_report 08:19:34 INFO - PROCESS | 6051 | __start_cc_report 08:19:34 INFO - PROCESS | 6051 | _x_x_mozilla_cycle_collect,389 08:19:34 INFO - PROCESS | 6051 | __end_cc_report 08:19:34 INFO - PROCESS | 6051 | __startTimestamp1465571974454__endTimestamp 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | ------- Summary: start ------- 08:19:34 INFO - PROCESS | 6051 | Number of tests: 6 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | [#0] dojo.html Cycles:165 Average:4776.53 Median:4917.39 stddev:521.08 (10.6%) stddev-sans-first:493.65 08:19:34 INFO - PROCESS | 6051 | Values: 2590.1 2621.3 2622.9 2656.2 2661.4 4795.9 4832.4 4853.1 4865.7 4906.2 4691.6 4757.9 4839.5 4841.7 4909.5 4316.4 4318.3 4340.4 4502.1 4520.1 4433.2 4511.3 4537.5 4564.0 4583.3 4289.7 4371.3 4396.6 4398.6 4459.4 4372.9 4410.1 4416.9 4417.2 4425.0 4411.7 4430.0 4442.9 4460.5 4491.1 4749.9 4806.4 4827.1 4829.3 4888.0 5154.4 5161.4 5173.1 5175.6 5244.2 5080.4 5213.0 5226.6 5228.6 5235.9 4882.7 4899.6 4925.8 4934.3 4936.1 5331.4 5363.6 5379.7 5381.7 5458.0 4849.7 5028.2 5097.7 5103.5 5115.6 5067.0 5112.4 5145.0 5215.6 5256.9 5076.4 5091.6 5108.5 5115.1 5123.6 5000.2 5071.5 5096.8 5098.7 5137.6 4230.9 4275.2 4278.4 4281.1 4282.8 3733.8 3750.4 3766.2 3783.9 3828.0 4502.7 4523.6 4526.4 4541.8 4550.1 5040.3 5090.0 5159.7 5165.7 5187.3 4462.8 4500.5 4542.6 4542.6 4547.4 4622.5 4623.8 4629.2 4629.3 4672.0 4652.5 4799.6 4803.7 4907.2 4924.2 5195.6 5276.8 5304.0 5306.2 5334.6 4917.4 4941.5 4981.1 5004.4 5016.4 4921.2 5072.8 5167.1 5181.5 5210.1 5188.6 5247.0 5255.6 5258.2 5295.3 5080.9 5094.6 5095.4 5097.9 5164.3 4887.3 4887.9 4975.2 5090.6 5097.6 4857.2 4918.8 4934.4 4941.0 4984.3 5043.3 5050.2 5050.5 5062.9 5117.3 4785.0 4909.0 4938.1 4961.3 5004.2 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | [#1] ext.html Cycles:180 Average:45921.34 Median:35459.88 stddev:87215.16 (246.0%) stddev-sans-first:87393.25 08:19:34 INFO - PROCESS | 6051 | Values: 535.8 570.4 581.9 598.0 603.6 34716.7 38297.8 38317.2 38350.0 38413.4 37729.4 37882.0 38144.8 38215.6 38244.6 7532.0 7558.8 7638.0 7675.1 7696.8 7595.7 7657.7 7658.8 7701.6 7715.0 7706.6 7751.3 7800.1 7813.9 7836.4 7684.7 7709.2 7726.8 7741.0 7785.2 7635.1 7719.5 7737.5 7737.5 7739.7 36082.3 36117.5 36191.8 36193.8 36335.8 2490.7 2821.5 2832.9 2863.7 2950.9 27047.7 27512.7 27552.3 27730.6 28063.6 3281.7 3299.5 3303.6 3322.8 3350.7 219330.0 221922.0 223449.0 225057.0 226490.0 30463.2 30640.5 30911.2 30934.0 31023.4 30751.4 32812.5 32923.8 32964.8 33005.3 12545.3 12759.0 12833.5 12839.0 12856.6 10570.1 10775.2 10781.8 10799.2 10806.8 7796.1 7800.1 7830.5 7884.7 7906.8 3052.2 3054.2 3078.8 3098.5 3141.8 888.9 918.1 947.9 989.6 1030.9 27070.0 27171.2 27507.9 27948.9 28031.0 922.4 927.0 950.5 955.9 959.6 14282.0 14598.0 14793.3 14979.8 15067.0 389679.0 390989.0 395835.0 399172.0 399852.0 47793.0 47995.5 48457.0 48505.0 48704.8 1195.5 1200.4 1206.4 1210.0 1215.3 26159.0 27834.7 27841.2 28038.0 28244.4 43050.1 43186.8 43336.8 43629.6 43779.3 344881.0 346320.0 347047.0 347107.0 348469.0 36543.6 36700.3 37031.8 37649.0 37801.2 40461.0 40755.0 41019.4 41438.6 41696.8 34926.5 35548.3 35707.5 35833.8 36188.0 34709.5 34992.7 35170.5 35543.5 35980.0 34704.6 34932.3 34959.3 35298.1 35376.3 30457.8 31662.7 31781.8 31829.7 32061.8 24960.3 25050.4 25126.2 25476.5 25602.7 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | [#2] jquery.html Cycles:180 Average:23697.39 Median:4386.56 stddev:62554.89 (1426.1%) stddev-sans-first:62705.86 08:19:34 INFO - PROCESS | 6051 | Values: 371.8 372.8 374.9 383.4 387.8 15533.6 16569.3 17214.1 17271.9 17309.1 15142.5 15630.3 15750.8 15869.4 15923.8 4995.9 5159.5 5190.3 5190.5 5198.0 3685.7 5113.4 5775.1 6131.8 6152.1 6184.7 6197.3 6211.5 6231.2 6241.4 5010.4 5364.9 5387.9 5422.8 5446.9 5084.0 5265.3 5266.6 5335.5 5353.5 12192.9 12359.6 12422.6 17763.6 20080.0 1769.1 1775.7 1785.1 1835.1 1973.0 8793.0 9057.6 9382.7 9427.6 9496.9 1634.7 1726.9 1736.5 1764.6 1768.2 65365.3 65971.3 67337.0 68001.0 69746.3 8634.0 8894.5 10050.2 10073.0 10147.2 13985.2 14031.9 14043.4 14074.1 14114.2 6918.2 6950.6 6969.4 7124.4 7126.8 6550.4 6586.0 6661.7 6782.0 6816.5 4291.2 4336.3 4368.4 4404.8 4407.2 1628.5 1687.6 1782.2 1810.9 1878.4 801.0 849.1 866.2 905.0 906.9 15586.4 16204.3 16440.0 16566.9 16745.4 792.1 824.2 843.3 849.7 898.9 9068.6 9265.2 9362.3 9522.0 9711.0 371488.0 375398.0 377937.0 382052.0 385157.0 70567.0 75246.0 79882.0 81699.0 81881.6 816.4 837.2 844.9 847.6 852.6 15089.5 15207.3 15424.6 15442.0 15793.4 37517.0 37552.4 37577.0 38331.4 38965.2 45646.3 46685.1 48602.8 50612.5 50818.5 7297.7 7436.9 7563.8 7573.0 7624.8 8676.9 10895.2 11339.7 11485.2 12034.7 10092.5 10299.9 10302.9 10381.8 10441.6 10677.4 10788.3 10891.5 11015.8 11093.8 10556.2 10600.7 10808.7 10830.9 10875.8 6764.9 7065.4 7222.8 7782.6 7940.0 10249.3 10456.5 10457.9 10550.5 10677.1 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | [#3] mootools.html Cycles:180 Average:5182.24 Median:5236.14 stddev:2925.71 (55.9%) stddev-sans-first:2919.86 08:19:34 INFO - PROCESS | 6051 | Values: 1366.0 1406.7 1433.5 1606.2 1609.1 6808.4 7469.1 7521.5 7983.7 7993.2 7254.2 7444.1 7447.3 7480.6 7536.0 2175.9 2206.2 2210.0 2214.0 2216.3 2128.8 2183.1 2191.3 2208.8 2209.5 2213.6 2221.2 2224.2 2227.2 2237.3 2074.9 2086.5 2099.3 2119.0 2121.0 2118.6 2157.3 2171.3 2173.2 2173.5 7796.4 7901.6 7920.3 7922.6 7972.4 4759.6 4895.3 4898.6 4898.9 4905.9 2889.8 2917.7 2970.6 3005.3 3059.8 854.3 875.6 879.1 886.8 895.9 10918.2 11083.1 11089.8 11108.3 11118.6 4276.4 4384.7 4471.8 4486.7 4511.7 9208.8 9279.8 9309.4 9309.7 9312.2 4579.7 4727.6 4728.9 4775.6 4785.7 3839.4 4184.2 4282.4 4318.5 4343.9 3671.5 3740.2 3815.2 3835.4 3915.8 1230.4 1240.5 1263.9 1271.5 1271.8 660.8 792.2 810.9 813.0 833.1 5111.3 5361.0 5365.5 5385.3 5443.0 384.8 388.3 388.7 403.7 410.1 3581.3 3624.5 3651.6 3690.0 3731.6 9337.0 9624.2 9755.8 9770.9 9771.9 9590.1 9594.0 9613.8 9631.0 9703.6 7250.7 7306.1 7357.3 7369.4 7394.7 5454.9 5469.6 5521.1 5593.4 5747.7 8822.1 8836.8 8931.1 8944.6 9011.6 8678.1 9080.9 9090.5 9108.3 9259.5 6281.8 6633.3 6677.5 6717.4 6989.4 7687.9 7692.0 7734.9 7780.2 7789.6 6667.7 6982.7 7015.6 7028.5 7123.1 6862.5 6901.9 6930.2 7038.6 7042.1 5960.2 6127.9 6187.1 6348.8 6397.3 4388.8 4421.7 4428.2 4469.8 4510.8 4549.1 4572.2 4589.7 4625.7 4677.9 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | [#4] prototype.html Cycles:180 Average:4384.57 Median:5025.48 stddev:1262.88 (25.1%) stddev-sans-first:1228.61 08:19:34 INFO - PROCESS | 6051 | Values: 298.2 298.9 303.3 303.3 303.9 5022.6 5028.4 5074.5 5112.3 5122.7 4993.7 5004.8 5005.8 5014.2 5034.3 3645.7 3800.0 3884.9 3913.2 3917.3 3862.9 3873.6 3882.2 3916.3 3929.3 3909.9 3911.5 3945.6 3971.1 3976.3 3845.5 3905.5 3929.3 3941.3 3944.8 3455.2 3470.8 3474.0 3480.3 3495.3 4816.6 4855.0 4906.1 4907.3 4940.7 4357.9 4443.4 4485.4 4488.6 4494.2 5184.4 5195.3 5196.5 5198.5 5238.8 3780.7 3812.4 3822.3 3830.2 3869.3 5382.9 5503.9 5519.5 5538.3 5554.9 3911.9 3919.3 3927.6 3936.4 3952.3 3991.5 3993.1 4006.3 4007.8 4013.0 4509.9 4528.2 4537.0 4542.7 4549.9 5124.5 5237.5 5250.4 5286.8 5341.6 1372.7 1386.4 1392.3 1394.2 1394.8 856.8 860.0 892.7 911.2 921.5 4466.0 4645.5 4657.4 4666.4 4707.2 5339.8 5414.4 5478.3 5498.8 5502.0 4512.7 4721.4 4729.6 4732.0 4749.5 2831.4 2866.3 2874.6 2888.8 2907.3 5079.8 5087.5 5117.1 5140.3 5150.9 5445.2 5486.3 5543.8 5556.3 5566.7 5093.4 5113.5 5119.2 5121.4 5150.3 5356.1 5397.6 5438.0 5478.9 5510.0 5051.1 5266.8 5304.8 5321.3 5352.4 5081.5 5098.9 5106.6 5106.8 5117.9 3936.5 3943.8 3954.6 3963.6 3963.7 5286.7 5338.9 5371.8 5377.2 5448.8 5230.7 5257.5 5267.2 5272.1 5273.0 5194.8 5228.4 5237.8 5246.2 5269.6 4929.3 5192.0 5196.4 5198.6 5222.9 5032.9 5144.9 5323.9 5326.7 5336.3 5152.2 5152.4 5154.1 5171.1 5201.0 08:19:34 INFO - PROCESS | 6051 | 08:19:34 INFO - PROCESS | 6051 | [#5] yui.html Cycles:180 Average:16868.65 Median:608.15 stddev:23939.80 (3936.5%) stddev-sans-first:23976.01 08:19:34 INFO - PROCESS | 6051 | Values: 656.6 666.0 703.8 723.6 726.3 11936.6 13055.5 13079.9 13087.3 13091.4 12371.4 12420.8 12426.2 12463.9 12469.9 621.0 753.5 759.5 763.4 777.1 768.6 779.9 780.0 781.6 782.8 836.7 838.7 843.1 844.6 845.2 822.0 831.2 832.5 832.6 834.4 605.9 608.2 608.6 610.7 614.6 13014.9 13029.7 13103.7 13106.1 13118.3 13784.9 13835.3 13892.8 14065.5 14087.5 9924.9 10090.9 10256.4 11142.7 11162.1 4224.6 4246.9 4256.8 4263.4 4267.8 56561.2 56602.4 56605.7 57261.0 58219.0 9459.0 9612.0 9774.2 10016.5 10284.1 16384.6 16542.8 16770.6 16805.8 16817.0 6760.4 7204.0 7246.4 7247.2 7416.1 3834.5 3959.4 3966.7 4038.4 4073.9 2932.8 3082.3 3087.1 3092.8 3098.9 539.4 543.9 572.6 573.6 579.2 460.4 556.8 568.7 572.5 594.6 8168.0 8539.7 8557.3 8635.8 8776.4 464.4 608.1 609.4 618.3 637.9 3648.5 3893.8 3953.5 3990.1 4007.6 83835.0 85577.6 90782.5 94722.0 96247.5 75477.2 77625.0 77817.0 79645.6 79732.0 72185.6 72969.6 73221.3 74494.6 74790.6 7373.9 7429.6 7526.6 7673.2 7687.5 41949.4 42636.4 43252.4 43443.8 44196.1 56224.0 62671.7 63069.4 64406.0 64445.0 10046.7 10123.1 10240.5 10264.4 10299.2 11202.3 11560.0 11666.4 12066.0 12331.5 9185.3 9228.0 9307.0 9338.7 9685.4 10075.5 10421.0 10460.6 10530.7 10600.5 9539.6 9640.0 9696.5 9719.4 10031.9 8477.7 8680.9 8856.0 8886.9 9116.5 8796.2 8900.2 8911.9 8916.2 9288.2 08:19:34 INFO - PROCESS | 6051 | -------- Summary: end -------- 08:19:34 INFO - PROCESS | 6051 | 08:19:35 INFO - TEST-INFO | 6051: exit 0 08:19:35 INFO - TEST-OK | dromaeo_css | took 1116766ms 08:19:35 INFO - TEST-START | kraken 08:19:35 INFO - operating with platform_type : linux_ 08:19:35 INFO - Initialising browser for kraken test... 08:19:35 INFO - TEST-INFO | started process 6285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuKiqZp/profile http://localhost:56662/getInfo.html) 08:19:39 INFO - PROCESS | 6285 | __metrics Screen width/height:1600/1200 08:19:39 INFO - PROCESS | 6285 | colorDepth:24 08:19:39 INFO - PROCESS | 6285 | Browser inner width/height: 1024/697 08:19:39 INFO - PROCESS | 6285 | __metrics 08:19:40 ERROR - PROCESS | 6285 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:19:41 INFO - TEST-INFO | 6285: exit 0 08:19:41 INFO - Browser initialized. 08:19:41 INFO - Running cycle 1/1 for kraken test... 08:19:41 INFO - TEST-INFO | started process 6402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuKiqZp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:53 INFO - PROCESS | 6402 | RSS: Main: 186191872 08:19:53 INFO - PROCESS | 6402 | 08:19:56 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56662/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:57 INFO - PROCESS | 6402 | RSS: Main: 190685184 08:19:57 INFO - PROCESS | 6402 | 08:20:00 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56662/tests/kraken/driver.html?testName=audio-dft) 08:20:00 INFO - PROCESS | 6402 | RSS: Main: 190099456 08:20:00 INFO - PROCESS | 6402 | 08:20:03 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56662/tests/kraken/driver.html?testName=audio-fft) 08:20:04 INFO - PROCESS | 6402 | RSS: Main: 185638912 08:20:04 INFO - PROCESS | 6402 | 08:20:06 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56662/tests/kraken/driver.html?testName=audio-oscillator) 08:20:07 INFO - PROCESS | 6402 | RSS: Main: 186044416 08:20:07 INFO - PROCESS | 6402 | 08:20:09 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:10 INFO - PROCESS | 6402 | RSS: Main: 186134528 08:20:10 INFO - PROCESS | 6402 | 08:20:13 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56662/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:14 INFO - PROCESS | 6402 | RSS: Main: 186306560 08:20:14 INFO - PROCESS | 6402 | 08:20:17 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56662/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:18 INFO - PROCESS | 6402 | RSS: Main: 183484416 08:20:18 INFO - PROCESS | 6402 | 08:20:21 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56662/tests/kraken/driver.html?testName=json-parse-financial) 08:20:21 INFO - PROCESS | 6402 | RSS: Main: 185131008 08:20:21 INFO - PROCESS | 6402 | 08:20:23 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:24 INFO - PROCESS | 6402 | RSS: Main: 185413632 08:20:24 INFO - PROCESS | 6402 | 08:20:26 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:26 INFO - PROCESS | 6402 | RSS: Main: 185339904 08:20:26 INFO - PROCESS | 6402 | 08:20:29 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:29 INFO - PROCESS | 6402 | RSS: Main: 185962496 08:20:29 INFO - PROCESS | 6402 | 08:20:32 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:33 INFO - PROCESS | 6402 | RSS: Main: 185298944 08:20:33 INFO - PROCESS | 6402 | 08:20:36 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:36 INFO - PROCESS | 6402 | RSS: Main: 185323520 08:20:36 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:56662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56662/tests/kraken/driver.html?testName=ai-astar) 08:20:38 INFO - PROCESS | 6402 | RSS: Main: 186744832 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | __start_tp_report 08:20:38 INFO - PROCESS | 6402 | _x_x_mozilla_page_load 08:20:38 INFO - PROCESS | 6402 | _x_x_mozilla_page_load_details 08:20:38 INFO - PROCESS | 6402 | |i|pagename|runs| 08:20:38 INFO - PROCESS | 6402 | |0;ai-astar;114;109;114;125;117;115;114;114;114;114 08:20:38 INFO - PROCESS | 6402 | |1;audio-beat-detection;162;132;161;195;133;166;157;131;191;132 08:20:38 INFO - PROCESS | 6402 | |2;audio-dft;165;169;169;165;165;166;164;166;167;163 08:20:38 INFO - PROCESS | 6402 | |3;audio-fft;77;77;78;169;77;77;74;76;167;76 08:20:38 INFO - PROCESS | 6402 | |4;audio-oscillator;87;90;165;88;89;87;146;86;86;150 08:20:38 INFO - PROCESS | 6402 | |5;imaging-gaussian-blur;118;121;120;118;118;118;118;118;118;119 08:20:38 INFO - PROCESS | 6402 | |6;imaging-darkroom;148;150;151;149;148;150;150;149;150;149 08:20:38 INFO - PROCESS | 6402 | |7;imaging-desaturate;96;96;95;95;96;96;95;95;96;96 08:20:38 INFO - PROCESS | 6402 | |8;json-parse-financial;65;65;64;64;66;65;64;65;64;69 08:20:38 INFO - PROCESS | 6402 | |9;json-stringify-tinderbox;67;65;66;67;66;65;71;66;65;65 08:20:38 INFO - PROCESS | 6402 | |10;stanford-crypto-aes;84;86;87;86;84;85;84;84;119;84 08:20:38 INFO - PROCESS | 6402 | |11;stanford-crypto-ccm;135;132;135;133;138;140;149;138;151;139 08:20:38 INFO - PROCESS | 6402 | |12;stanford-crypto-pbkdf2;173;177;172;171;172;169;174;173;172;169 08:20:38 INFO - PROCESS | 6402 | |13;stanford-crypto-sha256-iterative;70;69;71;69;69;72;68;66;66;68 08:20:38 INFO - PROCESS | 6402 | __end_tp_report 08:20:38 INFO - PROCESS | 6402 | __start_cc_report 08:20:38 INFO - PROCESS | 6402 | _x_x_mozilla_cycle_collect,1014 08:20:38 INFO - PROCESS | 6402 | __end_cc_report 08:20:38 INFO - PROCESS | 6402 | __startTimestamp1465572038766__endTimestamp 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | ------- Summary: start ------- 08:20:38 INFO - PROCESS | 6402 | Number of tests: 14 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:4.03 (3.5%) stddev-sans-first:4.26 08:20:38 INFO - PROCESS | 6402 | Values: 114.0 109.0 114.0 125.0 117.0 115.0 114.0 114.0 114.0 114.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:161.50 stddev:24.07 (14.9%) stddev-sans-first:25.43 08:20:38 INFO - PROCESS | 6402 | Values: 162.0 132.0 161.0 195.0 133.0 166.0 157.0 131.0 191.0 132.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:1.97 (1.2%) stddev-sans-first:2.06 08:20:38 INFO - PROCESS | 6402 | Values: 165.0 169.0 169.0 165.0 165.0 166.0 164.0 166.0 167.0 163.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:38.60 (50.1%) stddev-sans-first:40.40 08:20:38 INFO - PROCESS | 6402 | Values: 77.0 77.0 78.0 169.0 77.0 77.0 74.0 76.0 167.0 76.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:87.00 stddev:32.30 (37.1%) stddev-sans-first:33.40 08:20:38 INFO - PROCESS | 6402 | Values: 87.0 90.0 165.0 88.0 89.0 87.0 146.0 86.0 86.0 150.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 08:20:38 INFO - PROCESS | 6402 | Values: 118.0 121.0 120.0 118.0 118.0 118.0 118.0 118.0 118.0 119.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:150.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 08:20:38 INFO - PROCESS | 6402 | Values: 148.0 150.0 151.0 149.0 148.0 150.0 150.0 149.0 150.0 149.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:20:38 INFO - PROCESS | 6402 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 08:20:38 INFO - PROCESS | 6402 | Values: 65.0 65.0 64.0 64.0 66.0 65.0 64.0 65.0 64.0 69.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.92 08:20:38 INFO - PROCESS | 6402 | Values: 67.0 65.0 66.0 67.0 66.0 65.0 71.0 66.0 65.0 65.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:84.50 stddev:10.84 (12.8%) stddev-sans-first:11.39 08:20:38 INFO - PROCESS | 6402 | Values: 84.0 86.0 87.0 86.0 84.0 85.0 84.0 84.0 119.0 84.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.50 stddev:6.36 (4.6%) stddev-sans-first:6.58 08:20:38 INFO - PROCESS | 6402 | Values: 135.0 132.0 135.0 133.0 138.0 140.0 149.0 138.0 151.0 139.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.50 stddev:2.35 (1.4%) stddev-sans-first:2.47 08:20:38 INFO - PROCESS | 6402 | Values: 173.0 177.0 172.0 171.0 172.0 169.0 174.0 173.0 172.0 169.0 08:20:38 INFO - PROCESS | 6402 | 08:20:38 INFO - PROCESS | 6402 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:2.00 08:20:38 INFO - PROCESS | 6402 | Values: 70.0 69.0 71.0 69.0 69.0 72.0 68.0 66.0 66.0 68.0 08:20:38 INFO - PROCESS | 6402 | -------- Summary: end -------- 08:20:38 INFO - PROCESS | 6402 | 08:20:39 INFO - TEST-INFO | 6402: exit 0 08:20:39 INFO - TEST-OK | kraken | took 64568ms 08:20:39 INFO - SUITE-END | took 1181s 08:20:39 INFO - Completed test suite (00:19:41) 08:20:39 INFO - javascript benchmark 08:20:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6324.238738431917, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.145252066818, 2621.2529429112706, 2622.895084196632, 2656.150031989762, 2661.36127329441, 4795.856124316272, 4832.420109586855, 4853.126437241295, 4865.6594038417325, 4906.165951788195, 4691.554302341281, 4757.9286310705365, 4839.540243676854, 4841.709497430156, 4909.533594308535, 4316.374125751764, 4318.287482565373, 4340.435743353375, 4502.122086193193, 4520.095980803852, 4433.157700036999, 4511.323301504768, 4537.478190008158, 4564.04155127422, 4583.3125031245245, 4289.6997210195295, 4371.3224450209955, 4396.648268138541, 4398.64810815134, 4459.44256967879, 4372.912541749147, 4410.117976404732, 4416.889577760549, 4417.204903117437, 4424.9557504424865, 4411.713238639478, 4430.025394413224, 4442.8667139985855, 4460.50934397216, 4491.146682130385, 4749.928751068736, 4806.423229212482, 4827.058723548909, 4829.323894654751, 4888.0, 5154.38147422308, 5161.4322424533275, 5173.094708426048, 5175.611829112831, 5244.239585260154, 5080.415752188509, 5213.035588416155, 5226.55574276187, 5228.5555727763185, 5235.869103272411, 4882.6826256293225, 4899.632527560448, 4925.802967881316, 4934.333864928189, 4936.111499930047, 5331.360236771535, 5363.570914326922, 5379.731013449312, 5381.650192737459, 5458.0, 4849.684770489906, 5028.17035189197, 5097.745112744348, 5103.489651034867, 5115.590752739772, 5066.974665126724, 5112.36095488064, 5144.9742751286, 5215.58275337972, 5256.868578285497, 5076.416212135578, 5091.618128640367, 5108.489151084936, 5115.053715062725, 5123.641345105807, 5000.174971129795, 5071.518205770446, 5096.770645320969, 5098.668586541863, 5137.563307118862, 4230.873073807791, 4275.187714334266, 4278.422412974271, 4281.100968796525, 4282.76444795533, 3733.775973441602, 3750.437434384864, 3766.152615661509, 3783.902668226184, 3827.9808600956817, 4502.707324023928, 4523.615492683093, 4526.366308716782, 4541.84103556374, 4550.13547425988, 5040.269160971712, 5090.0, 5159.690418574897, 5165.74171291434, 5187.299714538564, 4462.799174037176, 4500.482444518922, 4542.568455996675, 4542.613877820422, 4547.408836851254, 4622.46841613212, 4623.791929363187, 4629.236176030917, 4629.305604159403, 4672.042231342567, 4652.534746525321, 4799.568038876518, 4803.735794531194, 4907.1903135982875, 4924.212126059813, 5195.636305458582, 5276.76254568553, 5304.0, 5306.230596563554, 5334.573234141337, 4917.385326834145, 4941.50584941503, 4981.053599816023, 5004.374453193351, 5016.423111342242, 4921.212605983025, 5072.771725272445, 5167.095758242368, 5181.481851814789, 5210.088234559013, 5188.58491320701, 5246.97376513115, 5255.579553635624, 5258.158694608845, 5295.285136506523, 5080.872978175576, 5094.5669618082875, 5095.363079615048, 5097.949020509747, 5164.32863727713, 4887.291342755351, 4887.926681099715, 4975.154223781893, 5090.567301779391, 5097.643164978416, 4857.247126695368, 4918.778654960607, 4934.432540257916, 4940.975295123645, 4984.252362145708, 5043.344365232496, 5050.242463630485, 5050.520200580939, 5062.924056139087, 5117.334746482933, 4785.042991401803, 4909.0, 4938.061768264019, 4961.2806143109765, 5004.174311238605], "value": 4741.675968069012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.7964163280401, 570.3754388944104, 581.8516278349022, 597.9923828349232, 603.602659842465, 34716.65283347166, 38297.808510957475, 38317.233655326876, 38350.0, 38413.42379864301, 37729.43405848915, 37882.0, 38144.80927595358, 38215.61784382162, 38244.61755382446, 7532.0, 7558.773236802905, 7637.961810190969, 7675.078990521145, 7696.807579810494, 7595.696172153107, 7657.731979380723, 7658.8468230635635, 7701.576413297266, 7715.0, 7706.614669266514, 7751.263629955145, 7800.141984381714, 7813.882791758128, 7836.412269079813, 7684.731034413797, 7709.2290770922455, 7726.7681969541, 7740.961295193544, 7785.221477852226, 7635.121960974503, 7719.498232614862, 7737.458377913548, 7737.535747855147, 7739.729109481141, 36082.27835443303, 36117.45823812645, 36191.81904090463, 36193.81903090494, 36335.81832090849, 2490.7297278387973, 2821.5203415419223, 2832.8583570821374, 2863.656361236644, 2950.8819647214086, 27047.729522704718, 27512.724872751216, 27552.311192220153, 27730.5840412394, 28063.579046314117, 3281.7233254796383, 3299.538064670948, 3303.6035675719068, 3322.7840190387546, 3350.6816852398983, 219330.0, 221922.0, 223449.0, 225057.0, 226490.0, 30463.23841903926, 30640.54039189414, 30911.2272193197, 30934.0, 31023.379532409224, 30751.384972300428, 32812.507812382835, 32923.835380822944, 32964.835175824446, 33005.339893202, 12545.31000794965, 12759.0, 12833.486660533661, 12839.0, 12856.55002074923, 10570.10154136907, 10775.245732798785, 10781.838272425919, 10799.190060745319, 10806.783864322826, 7796.142424333319, 7800.063992320957, 7830.491018083806, 7884.72403465876, 7906.7627971160955, 3052.175912503656, 3054.2059064643354, 3078.846057697106, 3098.5352197170155, 3141.8164375759084, 888.9066648001996, 918.1002617434951, 947.8862536495665, 989.6437282578266, 1030.9175265978704, 27070.0, 27171.1848644541, 27507.862460687567, 27948.86025569859, 28031.0, 922.4004397141778, 926.9884350958301, 950.4819873169139, 955.9426434413957, 959.6449313753956, 14282.0, 14598.0, 14793.334299956528, 14979.775303370458, 15067.0, 389679.0, 390989.0, 395835.0, 399172.0, 399852.0, 47793.044139117024, 47995.52004479981, 48457.0, 48505.0, 48704.75647621739, 1195.4919159357412, 1200.3878022208562, 1206.3968015992004, 1209.9594348859973, 1215.2829830400105, 26159.0, 27834.721652784025, 27841.16476505708, 28038.0, 28244.43511129807, 43050.13899722051, 43186.78406607947, 43336.783316083216, 43629.56370436382, 43779.343309851014, 344881.0, 346320.0, 347047.0, 347107.0, 348469.0, 36543.63456365402, 36700.26599468049, 37031.814840925625, 37649.0, 37801.243975120895, 40461.0, 40755.0, 41019.384709229984, 41438.58561414347, 41696.79151604223, 34926.47610285797, 35548.28903421969, 35707.46438803472, 35833.82083089568, 36188.0, 34709.47935780915, 34992.65007349996, 35170.47244291389, 35543.46684799782, 35980.0, 34704.57068005215, 34932.30135397227, 34959.30081398409, 35298.11754706153, 35376.29247415089, 30457.847710761303, 31662.683373166896, 31781.841090794398, 31829.681703182672, 32061.839690801397, 24960.251192464257, 25050.37374065663, 25126.246212613652, 25476.49047019012, 25602.74397256078], "value": 16115.41955877762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.8196674612813, 372.8098669678463, 374.8613013185121, 383.43251987059136, 387.77315270566714, 15533.611659708498, 16569.33722651094, 17214.13929303536, 17271.91364043178, 17309.134543272816, 15142.470013549528, 15630.29663665135, 15750.84249157511, 15869.365225390971, 15923.84076159238, 4995.875103122424, 5159.509846564571, 5190.299309593213, 5190.506901844337, 5198.0, 3685.7419980601367, 5113.43752187261, 5775.1337299405, 6131.846703832395, 6152.1387005819, 6184.721687524072, 6197.256329240475, 6211.47202487789, 6231.22109736283, 6241.407066328714, 5010.398752149747, 5364.892702145974, 5387.946120538783, 5422.810201642963, 5446.945530544684, 5083.974580127113, 5265.341832270966, 5266.631335806495, 5335.546478549328, 5353.464653534655, 12192.878071219351, 12359.567415140427, 12422.56521021769, 17763.644727105515, 20080.0, 1769.0977601423367, 1775.7158854583204, 1785.098525244756, 1835.1008006077059, 1973.0, 8793.0, 9057.592408341641, 9382.718518444457, 9427.575759090789, 9496.857547136799, 1634.6975809475166, 1726.8704847136514, 1736.5311365931254, 1764.6382491589193, 1768.1689605885342, 65365.346346536404, 65971.340286597, 67337.0, 68000.9999999995, 69746.30253697449, 8634.0, 8894.532402153573, 10050.195984321383, 10073.0, 10147.238957078249, 13985.160890346611, 14031.859681403055, 14043.368048437846, 14074.085184462978, 14114.153150810778, 6918.204406493217, 6950.617716025566, 6969.4424446044195, 7124.43004559634, 7126.786196414116, 6550.377714117151, 6586.0, 6661.733530658817, 6781.982702594651, 6816.488763342769, 4291.163223171514, 4336.3278691802825, 4368.36658684489, 4404.757738324423, 4407.162639098561, 1628.462607339599, 1687.5696697342344, 1782.189103957696, 1810.9094545272683, 1878.3707458001722, 800.9959950200329, 849.1423662101322, 866.1814585217036, 905.0406569036842, 906.8730377747121, 15586.376544938303, 16204.270807813677, 16440.0, 16566.917165414336, 16745.413910513074, 792.0653628718053, 824.1799409587499, 843.3464065349281, 849.7450764770545, 898.9235914947303, 9068.637254509746, 9265.166135047879, 9362.344635875423, 9522.047795220562, 9710.951445242728, 371488.0, 375398.0, 377937.0, 382052.0, 385157.0, 70567.0, 75246.0, 79882.0, 81699.0, 81881.59059204666, 816.420341557489, 837.1586555511793, 844.9155084491501, 847.6100993542916, 852.6376290076693, 15089.47186848455, 15207.315670795062, 15424.614384640474, 15442.0, 15793.36826526926, 37517.0, 37552.43671344878, 37577.0, 38331.42502862515, 38965.2206955865, 45646.31530526978, 46685.066298674516, 48602.756986214845, 50612.49387506225, 50818.491815081376, 7297.708091676486, 7436.9295367801515, 7563.810904727426, 7573.0, 7624.847503049797, 8676.91323086761, 10895.237333386587, 11339.716507087389, 11485.19603627738, 12034.699132521757, 10092.54583543757, 10299.897001030193, 10302.896971030494, 10381.792364152523, 10441.582336706446, 10677.412742298937, 10788.298760580537, 10891.509882055485, 11015.779684406427, 11093.833592496281, 10556.208284378548, 10600.681979540626, 10808.729781755519, 10830.891691082988, 10875.782484350428, 6764.898526522008, 7065.434765218873, 7222.783316500513, 7782.610869456391, 7940.0, 10249.282550221413, 10456.47717614101, 10457.895421045692, 10550.472476375997, 10677.09244714208], "value": 8048.76733508138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.0369439545118, 1406.711624117056, 1433.4767809749437, 1606.1969015492255, 1609.0667412900518, 6808.421284190849, 7469.141048779392, 7521.473496855222, 7983.720569780066, 7993.200679932012, 7254.202037775854, 7444.069491313586, 7447.32974032337, 7480.588567628778, 7536.0, 2175.9456013599706, 2206.161658569741, 2209.9889500552476, 2214.036893951128, 2216.3350994701605, 2128.7658357580654, 2183.148572056899, 2191.2549733090746, 2208.7901649343366, 2209.5249521352907, 2213.5904857601395, 2221.1559607349186, 2224.232639739287, 2227.164813195052, 2237.2952519956243, 2074.8651337663077, 2086.5096702275027, 2099.2862426774896, 2118.9576208475896, 2121.0, 2118.555103428282, 2157.3420106867397, 2171.3051823416513, 2173.163332117146, 2173.521825198454, 7796.415268854858, 7901.604919754047, 7920.326772224368, 7922.603869806487, 7972.441929064968, 4759.571638552512, 4895.290182923456, 4898.632602554787, 4898.877528061791, 4905.8773530661665, 2889.7688184945155, 2917.693642167584, 2970.628671416073, 3005.2637103909683, 3059.7552195824283, 854.2695994924312, 875.6497401039635, 879.1384443245591, 886.7916039730658, 895.9193672569435, 10918.181136414722, 11083.113350931906, 11089.83365249522, 11108.277961932448, 11118.55525778976, 4276.444062271885, 4384.693071484965, 4471.754053527022, 4486.685931984795, 4511.661625378044, 9208.815823683623, 9279.76800579991, 9309.44143351401, 9309.72070837876, 9312.161905428544, 4579.656525760582, 4727.621790256771, 4728.881777955578, 4775.594074503637, 4785.688930219525, 3839.404892241707, 4184.2050010498515, 4282.421873047161, 4318.52496225415, 4343.891402714958, 3671.504346913186, 3740.1958578905665, 3815.2178803345246, 3835.4246862970776, 3915.7650540967634, 1230.4094034863315, 1240.460399726104, 1263.92416455013, 1271.5358894003623, 1271.8028705550655, 660.8281846719888, 792.1919641965163, 810.8864758933754, 812.959352032396, 833.0919297965247, 5111.309973153651, 5360.973195133999, 5365.463453654604, 5385.299911011543, 5442.9930462864495, 384.8499085356713, 388.2719900187149, 388.65409785291115, 403.650842021655, 410.06914304528556, 3581.3195492856275, 3624.4563315502887, 3651.6165802590876, 3689.9815500922323, 3731.552213734369, 9336.95331523338, 9624.181944534794, 9755.756106097262, 9770.902290977141, 9771.853422198672, 9590.08894155054, 9594.0, 9613.807723845624, 9631.036896310314, 9703.611855525842, 7250.673719682627, 7306.086739157606, 7357.301056399633, 7369.410447164214, 7394.704211831574, 5454.863628409163, 5469.644473109235, 5521.061419558765, 5593.384727680033, 5747.683877386617, 8822.07368226327, 8836.823263534821, 8931.106889311017, 8944.642214311354, 9011.639534418811, 8678.132186781524, 9080.863787043067, 9090.500022498825, 9108.271338292789, 9259.537023148681, 6281.811545653638, 6633.336666333328, 6677.465802735866, 6717.395434410926, 6989.405900498311, 7687.9231207689445, 7692.000039994765, 7734.883976740466, 7780.183080776437, 7789.610519474117, 6667.666616669244, 6982.685779140053, 7015.614141222078, 7028.50800443964, 7123.074000379917, 6862.519623626298, 6901.89647155283, 6930.203026651798, 7038.577685338896, 7042.119735033121, 5960.225170727777, 6127.938720612737, 6187.102870083722, 6348.77779277723, 6397.296297407374, 4388.758618276025, 4421.734695918255, 4428.158649856517, 4469.754163521037, 4510.819567217274, 4549.135664223787, 4572.245579479349, 4589.701669391479, 4625.699329543569, 4677.859664210079], "value": 4086.380016820002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.1933868884667, 298.9402119576085, 303.2842491719543, 303.2963524622874, 303.9437704024757, 5022.598192144629, 5028.371453568304, 5074.5432911038, 5112.258722485242, 5122.743862806863, 4993.675411098276, 5004.849854504361, 5005.824796132136, 5014.2227954667, 5034.320366750488, 3645.671889529942, 3799.9810000949956, 3884.8834534964, 3913.2369188008206, 3917.334053210961, 3862.9376921346575, 3873.5861410585217, 3882.2041481496226, 3916.295066887959, 3929.332013557688, 3909.944315034939, 3911.5306163260448, 3945.625165609277, 3971.106501037258, 3976.324024915771, 3845.5385353757447, 3905.472761177233, 3929.292727309083, 3941.310270702644, 3944.7830369329677, 3455.2053027803495, 3470.7570470067108, 3473.9652603473896, 3480.3039392121677, 3495.2659941412335, 4816.56650901417, 4855.0, 4906.0808818752785, 4907.337509436216, 4940.654154209206, 4357.891052723676, 4443.355713421568, 4485.372047913294, 4488.551144885485, 4494.168578812897, 5184.403793563713, 5195.272661827347, 5196.53231209193, 5198.454162312941, 5238.842834714965, 3780.6597406233295, 3812.379738611079, 3822.2737679840743, 3830.2339532093415, 3869.3228684980018, 5382.946170538323, 5503.944960550383, 5519.503244707996, 5538.335399752055, 5554.888902221974, 3911.882643520699, 3919.274934137137, 3927.6465118139504, 3936.4095385691803, 3952.3281042222893, 3991.501062367204, 3993.1215132671346, 4006.258842114218, 4007.7996100194873, 4013.0, 4509.932351014738, 4528.230200865861, 4536.956500005017, 4542.6593005524055, 4549.931751023737, 5124.538791508782, 5237.476252374809, 5250.3962044364625, 5286.762095705702, 5341.626086174008, 1372.7460419822364, 1386.4454218312756, 1392.331680793225, 1394.198335956829, 1394.842280906845, 856.7643897928119, 860.0281681699639, 892.7366426904078, 911.1685512120686, 921.4747593871429, 4465.955340446619, 4645.488996210414, 4657.417822772153, 4666.370040044619, 4707.223308154184, 5339.79854532727, 5414.3502779665905, 5478.287822583118, 5498.752556134984, 5501.972490137604, 4512.661550383735, 4721.433427988594, 4729.635182408796, 4731.95268047322, 4749.453812811571, 2831.419558990402, 2866.269101379135, 2874.597556342114, 2888.768898488116, 2907.25864904448, 5079.822206222764, 5087.491250874883, 5117.1045067113855, 5140.280360749498, 5150.922736158961, 5445.210444485528, 5486.286782718221, 5543.752655652526, 5556.305461817273, 5566.693831839207, 5093.439721630618, 5113.51421614946, 5119.1553393690365, 5121.411037730634, 5150.278960945396, 5356.098585002268, 5397.622166448311, 5437.972810136082, 5478.91781623284, 5509.972450137724, 5051.055343692631, 5266.78932842682, 5304.840854774363, 5321.308229930084, 5352.384475785335, 5081.4918508148885, 5098.898022039612, 5106.565941894832, 5106.821261255838, 5117.897642047213, 3936.5079365079364, 3943.802809859553, 3954.624310690595, 3963.5838236985855, 3963.6630886374983, 5286.735663216747, 5338.946610533845, 5371.758270877898, 5377.166539186433, 5448.809291674773, 5230.7384630769075, 5257.5005374489365, 5267.157254839208, 5272.130098533699, 5272.9736351318, 5194.844154675366, 5228.418533304698, 5237.790488380422, 5246.186841039645, 5269.552088072557, 4929.309896614405, 5191.9751296994955, 5196.4283928767045, 5198.558122559625, 5222.895542089061, 5032.949670503248, 5144.887343157336, 5323.946760532345, 5326.6537675050995, 5336.252924590638, 5152.201408781645, 5152.355955505562, 5154.123798954111, 5171.086697921643, 5201.0], "value": 3979.695086706444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.6486929492722, 665.9633720145391, 703.7747920665387, 723.5730918757931, 726.2737262737263, 11936.582219622314, 13055.543055993043, 13079.93460032701, 13087.280199589031, 13091.410886510106, 12371.38143092844, 12420.751584968295, 12426.192297500678, 12463.937680311608, 12469.937650311758, 621.0404924391803, 753.506453273107, 759.4835511851938, 763.3664058831184, 777.0713996773843, 768.5503980171578, 779.9220077992212, 779.9844003119935, 781.6326326626477, 782.7769085810545, 836.6653338664553, 838.6896848166188, 843.1484200957016, 844.6368061733452, 845.247729520727, 822.0300045945781, 831.1812864328631, 832.5213002523543, 832.6253186066264, 834.3783881008687, 605.939406059395, 608.2154021312501, 608.5618354784592, 610.66108309888, 614.6312212672406, 13014.86985130146, 13029.674258143528, 13103.737925241538, 13106.148100373444, 13118.344082795917, 13784.862151378458, 13835.30823458823, 13892.7701704659, 14065.5077072303, 14087.506937257147, 9924.900750992541, 10090.899091009069, 10256.435896025716, 11142.721431964266, 11162.107031437465, 4224.619784219435, 4246.936295955563, 4256.808443620013, 4263.4031235627035, 4267.765272909989, 56561.15158272629, 56602.433975660126, 56605.71697141488, 57260.999999999585, 58219.0, 9459.0, 9612.0, 9774.218062554979, 10016.49917504122, 10284.125849302744, 16384.590385240463, 16542.751858722128, 16770.580735481468, 16805.83194168067, 16817.0, 6760.42536384403, 7203.96398018017, 7246.420286377077, 7247.16657584374, 7416.0729908761405, 3834.4785099289884, 3959.3862951242604, 3966.6628336591134, 4038.394240863835, 4073.91852162961, 2932.8386938718577, 3082.321889184376, 3087.1356020313897, 3092.768042396829, 3098.8760449582214, 539.3689383421406, 543.9265699130567, 572.6420986883198, 573.6042130929645, 579.1804596495911, 460.39688008708697, 556.8496505943373, 568.687222027883, 572.4761842913771, 594.5629961977943, 8168.0, 8539.662983864593, 8557.272631826365, 8635.797871542716, 8776.385653004356, 464.38237144597605, 608.0939400293531, 609.3540846702509, 618.2580902916428, 637.8915584350672, 3648.4709717091405, 3893.844246230176, 3953.466282051944, 3990.1421194443333, 4007.5992400760274, 83835.0, 85577.57211214029, 90782.54608726915, 94722.0, 96247.51876240574, 75477.24522754703, 77625.0, 77817.0, 79645.60177199077, 79732.0, 72185.63907180431, 72969.6351518239, 73221.2677873225, 74494.62752686093, 74790.62604686942, 7373.9262607375385, 7429.5542267464125, 7526.5860377679755, 7673.232676732506, 7687.5387476751575, 41949.370759438025, 42636.36045459383, 43252.351214732436, 43443.782781085894, 44196.11607767762, 56224.0, 62671.6866415665, 63069.36930630819, 64406.0, 64445.0, 10046.69859904204, 10123.088921997056, 10240.53917573696, 10264.384136951807, 10299.176065914859, 11202.327860328407, 11560.0, 11666.416679166177, 12066.0, 12331.50673973031, 9185.265178785814, 9227.953860230657, 9306.953465232631, 9338.719838404859, 9685.41887486753, 10075.496225188564, 10421.0, 10460.581576736846, 10530.684079477627, 10600.4699765013, 9539.57071931751, 9639.951800241235, 9696.5151742414, 9719.41683498964, 10031.949840250752, 8477.74566762998, 8680.869786953326, 8855.955720221358, 8886.911130888868, 9116.453012819253, 8796.208341249318, 8900.154485323885, 8911.910880891368, 8916.242119419663, 9288.164065234161], "value": 6396.086982385218, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 114.0, 125.0, 117.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 161.0, 195.0, 133.0, 166.0, 157.0, 131.0, 191.0, 132.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 169.0, 165.0, 165.0, 166.0, 164.0, 166.0, 167.0, 163.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 169.0, 77.0, 77.0, 74.0, 76.0, 167.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 165.0, 88.0, 89.0, 87.0, 146.0, 86.0, 86.0, 150.0], "value": 107.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 120.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 151.0, 149.0, 148.0, 150.0, 150.0, 149.0, 150.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 66.0, 65.0, 64.0, 65.0, 64.0, 69.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 67.0, 66.0, 65.0, 71.0, 66.0, 65.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 87.0, 86.0, 84.0, 85.0, 84.0, 84.0, 119.0, 84.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 135.0, 133.0, 138.0, 140.0, 149.0, 138.0, 151.0, 139.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 172.0, 171.0, 172.0, 169.0, 174.0, 173.0, 172.0, 169.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 71.0, 69.0, 69.0, 72.0, 68.0, 66.0, 66.0, 68.0], "value": 68.8, "unit": "score"}]}]} 08:20:40 INFO - Return code: 0 08:20:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:20:40 ERROR - # TBPL SUCCESS # 08:20:40 INFO - Running post-action listener: _resource_record_post_action 08:20:40 INFO - ##### 08:20:40 INFO - ##### Finished run-tests step (success) 08:20:40 INFO - ##### 08:20:40 INFO - Running post-run listener: _resource_record_post_run 08:20:40 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525070336; Read time: 8; Write time: 458404 08:20:40 INFO - TinderboxPrint: CPU usage
13.5% 08:20:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:20:40 INFO - TinderboxPrint: I/O write bytes / time
525,070,336 / 458,404 08:20:40 INFO - TinderboxPrint: CPU idle
8,267.8 (86.5%) 08:20:40 INFO - TinderboxPrint: CPU user
1,233.1 (12.9%) 08:20:40 INFO - TinderboxPrint: Swap in / out
0 / 0 08:20:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237555712; Read time: 0; Write time: 284696 08:20:40 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286990336; Read time: 8; Write time: 173708 08:20:40 INFO - Running post-run listener: _upload_blobber_files 08:20:40 INFO - Blob upload gear active. 08:20:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:40 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 08:20:40 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:20:40 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:20:41 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:41 INFO - (blobuploader) - INFO - Done attempting. 08:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:45 INFO - (blobuploader) - INFO - Done attempting. 08:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:20:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:46 INFO - (blobuploader) - INFO - Done attempting. 08:20:46 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:46 INFO - Return code: 0 08:20:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd6249965c05c2e42acb22b2d440f37ecf2db6de59748dd21eb91767fb0089d21d9b3cbf3b7e41e08044b4174f24d1085be9a9bc6434261b401bfa22dd3eab24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e273ad7d32c9e6c718209601aea65ae4299956cf5169b652ebee4ebca7bcb129935314f62df5cb43159881ae347daa83009316083606e39085c5ff8d107f4eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70699e3d42974c3e4391ec1467e6f62c7c8e28686666a6f1e11e11300f06a73338f23a3c67a5f8fb390e86a13ffa04f4e940b26bb8c19997a5cff7fbd4b3e918"} 08:20:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:46 INFO - Contents: 08:20:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd6249965c05c2e42acb22b2d440f37ecf2db6de59748dd21eb91767fb0089d21d9b3cbf3b7e41e08044b4174f24d1085be9a9bc6434261b401bfa22dd3eab24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e273ad7d32c9e6c718209601aea65ae4299956cf5169b652ebee4ebca7bcb129935314f62df5cb43159881ae347daa83009316083606e39085c5ff8d107f4eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70699e3d42974c3e4391ec1467e6f62c7c8e28686666a6f1e11e11300f06a73338f23a3c67a5f8fb390e86a13ffa04f4e940b26bb8c19997a5cff7fbd4b3e918"} 08:20:46 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:46 INFO - Copying logs to upload dir... 08:20:46 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.784247 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-10 08:20:45.771519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:45.774822) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616 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/Firefox-Non-PGO/sha512/bd6249965c05c2e42acb22b2d440f37ecf2db6de59748dd21eb91767fb0089d21d9b3cbf3b7e41e08044b4174f24d1085be9a9bc6434261b401bfa22dd3eab24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e273ad7d32c9e6c718209601aea65ae4299956cf5169b652ebee4ebca7bcb129935314f62df5cb43159881ae347daa83009316083606e39085c5ff8d107f4eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70699e3d42974c3e4391ec1467e6f62c7c8e28686666a6f1e11e11300f06a73338f23a3c67a5f8fb390e86a13ffa04f4e940b26bb8c19997a5cff7fbd4b3e918"} build_url:https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd6249965c05c2e42acb22b2d440f37ecf2db6de59748dd21eb91767fb0089d21d9b3cbf3b7e41e08044b4174f24d1085be9a9bc6434261b401bfa22dd3eab24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e273ad7d32c9e6c718209601aea65ae4299956cf5169b652ebee4ebca7bcb129935314f62df5cb43159881ae347daa83009316083606e39085c5ff8d107f4eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70699e3d42974c3e4391ec1467e6f62c7c8e28686666a6f1e11e11300f06a73338f23a3c67a5f8fb390e86a13ffa04f4e940b26bb8c19997a5cff7fbd4b3e918"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:45.803332) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:45.803704) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465570502.439555-748183616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:45.887785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:20:45.888271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:20:45.888749) ========= ========= Total master_lag: 0.18 =========