builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1466607385.57 results: success (0) buildid: 20160622063901 builduid: eaca88a07a6142ae95eef53a4d422973 revision: c9edfe35619f69f7785776ebd19a3140684024dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.565558) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.566186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.566485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.595235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.595564) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 07:56:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-06-22 07:56:26 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.762650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.762935) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020295 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.818426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.818783) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c9edfe35619f69f7785776ebd19a3140684024dc --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 c9edfe35619f69f7785776ebd19a3140684024dc --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=9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 07:56:26,287 truncating revision to first 12 chars 2016-06-22 07:56:26,288 Setting DEBUG logging. 2016-06-22 07:56:26,288 attempt 1/10 2016-06-22 07:56:26,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c9edfe35619f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 07:56:26,587 unpacking tar archive at: mozilla-central-c9edfe35619f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617579 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.452210) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.452481) ========= script_repo_revision: c9edfe35619f69f7785776ebd19a3140684024dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.452869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.453132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.463529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 15 secs) (at 2016-06-22 07:56:26.463796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:56:27 INFO - MultiFileLogger online at 20160622 07:56:27 in /builds/slave/test 07:56:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 07:56:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:27 INFO - {'append_to_log': False, 07:56:27 INFO - 'base_work_dir': '/builds/slave/test', 07:56:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:56:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:27 INFO - 'branch': 'Firefox-Non-PGO', 07:56:27 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:27 INFO - 'config_files': ('talos/linux_config.py',), 07:56:27 INFO - 'default_actions': ('clobber', 07:56:27 INFO - 'read-buildbot-config', 07:56:27 INFO - 'download-and-extract', 07:56:27 INFO - 'populate-webroot', 07:56:27 INFO - 'create-virtualenv', 07:56:27 INFO - 'install', 07:56:27 INFO - 'run-tests'), 07:56:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:27 INFO - 'download_minidump_stackwalk': True, 07:56:27 INFO - 'download_symbols': 'ondemand', 07:56:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:27 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:27 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:27 INFO - 'installer_path': 'installer.exe', 07:56:27 INFO - 'log_level': 'info', 07:56:27 INFO - 'log_name': 'talos', 07:56:27 INFO - 'log_to_console': True, 07:56:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:56:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:56:27 INFO - 'opt_config_files': (), 07:56:27 INFO - 'pip_index': False, 07:56:27 INFO - 'sps_profile': False, 07:56:27 INFO - 'sps_profile_interval': 0, 07:56:27 INFO - 'suite': 'dromaeojs', 07:56:27 INFO - 'system_bits': '32', 07:56:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:27 INFO - 'title': 'talos-linux64-ix-040', 07:56:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:27 INFO - 'use_talos_json': True, 07:56:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:27 INFO - 'work_dir': 'build'} 07:56:27 INFO - ##### 07:56:27 INFO - ##### Running clobber step. 07:56:27 INFO - ##### 07:56:27 INFO - Running pre-action listener: _resource_record_pre_action 07:56:27 INFO - Running main action method: clobber 07:56:27 INFO - rmtree: /builds/slave/test/build 07:56:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:27 INFO - Running post-action listener: _resource_record_post_action 07:56:27 INFO - ##### 07:56:27 INFO - ##### Finished clobber step (success) 07:56:27 INFO - ##### 07:56:27 INFO - ##### 07:56:27 INFO - ##### Running read-buildbot-config step. 07:56:27 INFO - ##### 07:56:27 INFO - Running pre-action listener: _resource_record_pre_action 07:56:27 INFO - Running main action method: read_buildbot_config 07:56:27 INFO - Using buildbot properties: 07:56:27 INFO - { 07:56:27 INFO - "project": "", 07:56:27 INFO - "product": "firefox", 07:56:27 INFO - "script_repo_revision": "production", 07:56:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:56:27 INFO - "repository": "", 07:56:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:56:27 INFO - "buildid": "20160622063901", 07:56:27 INFO - "pgo_build": "False", 07:56:27 INFO - "basedir": "/builds/slave/test", 07:56:27 INFO - "buildnumber": 124, 07:56:27 INFO - "slavename": "talos-linux64-ix-040", 07:56:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:56:27 INFO - "platform": "ubuntu64_hw", 07:56:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:56:27 INFO - "branch": "mozilla-central", 07:56:27 INFO - "repo_path": "mozilla-central", 07:56:27 INFO - "revision": "c9edfe35619f69f7785776ebd19a3140684024dc", 07:56:27 INFO - "stage_platform": "linux64", 07:56:27 INFO - "builduid": "eaca88a07a6142ae95eef53a4d422973", 07:56:27 INFO - "slavebuilddir": "test" 07:56:27 INFO - } 07:56:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:56:27 INFO - Running post-action listener: _resource_record_post_action 07:56:27 INFO - ##### 07:56:27 INFO - ##### Finished read-buildbot-config step (success) 07:56:27 INFO - ##### 07:56:27 INFO - ##### 07:56:27 INFO - ##### Running download-and-extract step. 07:56:27 INFO - ##### 07:56:27 INFO - Running pre-action listener: _resource_record_pre_action 07:56:27 INFO - Running main action method: download_and_extract 07:56:27 INFO - mkdir: /builds/slave/test/build/tests 07:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:27 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:34 INFO - Downloaded 1361 bytes. 07:56:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:34 INFO - Using the following test package requirements: 07:56:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:56:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:56:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'jsshell-linux-x86_64.zip'], 07:56:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:56:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:56:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:56:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:56:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:56:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:34 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:39 INFO - Downloaded 22703215 bytes. 07:56:39 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'] 07:56:39 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 07:56:40 INFO - Return code: 0 07:56:40 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 07:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:40 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:45 INFO - Downloaded 22703215 bytes. 07:56:45 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'] 07:56:45 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 07:56:46 INFO - Return code: 0 07:56:46 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')]} 07:56:46 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:56:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:47 INFO - Downloaded 14405384 bytes. 07:56:47 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'] 07:56:47 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 07:56:48 INFO - Return code: 0 07:56:48 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')]} 07:56:48 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 07:57:27 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 07:57:27 INFO - retry: attempt #1 caught exception: The read operation timed out 07:57:27 INFO - retry: Failed, sleeping 30 seconds before retrying 07:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 #2 07:58:06 INFO - Downloaded 56261643 bytes. 07:58:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:06 INFO - mkdir: /builds/slave/test/properties 07:58:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:58:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:58:06 INFO - Contents: 07:58:06 INFO - build_url:https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:07 INFO - Running post-action listener: _resource_record_post_action 07:58:07 INFO - Running post-action listener: set_extra_try_arguments 07:58:07 INFO - ##### 07:58:07 INFO - ##### Finished download-and-extract step (success) 07:58:07 INFO - ##### 07:58:07 INFO - ##### 07:58:07 INFO - ##### Running populate-webroot step. 07:58:07 INFO - ##### 07:58:07 INFO - Running pre-action listener: _resource_record_pre_action 07:58:07 INFO - Running main action method: populate_webroot 07:58:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:58:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:58:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:58:07 INFO - '--tppagecycles', 07:58:07 INFO - '7'], 07:58:07 INFO - 'tests': ['tsvgm']}}, 07:58:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:58:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:58:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:58:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:58:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['damp', 'tps']}, 07:58:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'tests': ['damp', 'tps']}, 07:58:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['dromaeo_dom']}, 07:58:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['basic_compositor_video']}, 07:58:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:58:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['a11yr', 07:58:07 INFO - 'ts_paint', 07:58:07 INFO - 'tpaint', 07:58:07 INFO - 'sessionrestore', 07:58:07 INFO - 'sessionrestore_no_auto_restore', 07:58:07 INFO - 'tabpaint']}, 07:58:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:58:07 INFO - 'ts_paint', 07:58:07 INFO - 'tpaint', 07:58:07 INFO - 'sessionrestore', 07:58:07 INFO - 'sessionrestore_no_auto_restore', 07:58:07 INFO - 'tabpaint']}, 07:58:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:58:07 INFO - 'ts_paint', 07:58:07 INFO - 'tpaint', 07:58:07 INFO - 'sessionrestore', 07:58:07 INFO - 'sessionrestore_no_auto_restore', 07:58:07 INFO - 'tabpaint']}, 07:58:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:58:07 INFO - 'ts_paint', 07:58:07 INFO - 'tpaint', 07:58:07 INFO - 'sessionrestore', 07:58:07 INFO - 'sessionrestore_no_auto_restore', 07:58:07 INFO - 'tabpaint']}, 07:58:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['a11yr', 07:58:07 INFO - 'ts_paint', 07:58:07 INFO - 'tpaint', 07:58:07 INFO - 'sessionrestore', 07:58:07 INFO - 'sessionrestore_no_auto_restore', 07:58:07 INFO - 'tabpaint']}, 07:58:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['a11yr', 07:58:07 INFO - 'ts_paint', 07:58:07 INFO - 'tpaint', 07:58:07 INFO - 'sessionrestore', 07:58:07 INFO - 'sessionrestore_no_auto_restore', 07:58:07 INFO - 'tabpaint']}, 07:58:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['tsvgx', 07:58:07 INFO - 'tsvgr_opacity', 07:58:07 INFO - 'tart', 07:58:07 INFO - 'tscrollx', 07:58:07 INFO - 'cart']}, 07:58:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:58:07 INFO - 'tsvgr_opacity', 07:58:07 INFO - 'tart', 07:58:07 INFO - 'tscrollx', 07:58:07 INFO - 'cart']}, 07:58:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'talos_options': ['--disable-e10s'], 07:58:07 INFO - 'tests': ['tp5o']}, 07:58:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'tests': ['tp5o']}, 07:58:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'talos_options': ['--disable-e10s', 07:58:07 INFO - '--xperf_path', 07:58:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:07 INFO - 'tests': ['tp5n']}, 07:58:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:07 INFO - 'talos_options': ['--xperf_path', 07:58:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:07 INFO - 'tests': ['tp5n']}}, 07:58:07 INFO - 'talos.zip': {'path': '', 07:58:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:58:07 INFO - Running post-action listener: _resource_record_post_action 07:58:07 INFO - ##### 07:58:07 INFO - ##### Finished populate-webroot step (success) 07:58:07 INFO - ##### 07:58:07 INFO - ##### 07:58:07 INFO - ##### Running create-virtualenv step. 07:58:07 INFO - ##### 07:58:07 INFO - Running pre-action listener: _resource_record_pre_action 07:58:07 INFO - Running main action method: create_virtualenv 07:58:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:07 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 07:58:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:58:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:07 INFO - Using real prefix '/usr' 07:58:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:10 INFO - Installing pip.................done. 07:58:10 INFO - Return code: 0 07:58:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:58:10 INFO - Using env: {'DISPLAY': ':0', 07:58:10 INFO - 'HOME': '/home/cltbld', 07:58:10 INFO - 'LANG': 'en_US.UTF-8', 07:58:10 INFO - 'LANGUAGE': 'en_US:en', 07:58:10 INFO - 'LOGNAME': 'cltbld', 07:58:10 INFO - 'MAIL': '/var/mail/cltbld', 07:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:10 INFO - 'MOZ_NO_REMOTE': '1', 07:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:10 INFO - 'NO_EM_RESTART': '1', 07:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:10 INFO - 'PWD': '/builds/slave/test', 07:58:10 INFO - 'SHELL': '/bin/bash', 07:58:10 INFO - 'SHLVL': '1', 07:58:10 INFO - 'TERM': 'linux', 07:58:10 INFO - 'TMOUT': '86400', 07:58:10 INFO - 'USER': 'cltbld', 07:58:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:10 INFO - '_': '/tools/buildbot/bin/python'} 07:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:10 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 07:58:10 INFO - Cleaning up... 07:58:10 INFO - Return code: 0 07:58:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:58:10 INFO - Using env: {'DISPLAY': ':0', 07:58:10 INFO - 'HOME': '/home/cltbld', 07:58:10 INFO - 'LANG': 'en_US.UTF-8', 07:58:10 INFO - 'LANGUAGE': 'en_US:en', 07:58:10 INFO - 'LOGNAME': 'cltbld', 07:58:10 INFO - 'MAIL': '/var/mail/cltbld', 07:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:10 INFO - 'MOZ_NO_REMOTE': '1', 07:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:10 INFO - 'NO_EM_RESTART': '1', 07:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:10 INFO - 'PWD': '/builds/slave/test', 07:58:10 INFO - 'SHELL': '/bin/bash', 07:58:10 INFO - 'SHLVL': '1', 07:58:10 INFO - 'TERM': 'linux', 07:58:10 INFO - 'TMOUT': '86400', 07:58:10 INFO - 'USER': 'cltbld', 07:58:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:10 INFO - '_': '/tools/buildbot/bin/python'} 07:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:10 INFO - Downloading/unpacking psutil>=3.1.1 07:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:12 INFO - Installing collected packages: psutil 07:58:12 INFO - Running setup.py install for psutil 07:58:12 INFO - building 'psutil._psutil_linux' extension 07:58:12 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 07:58:12 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 07:58:12 INFO - building 'psutil._psutil_posix' extension 07:58:12 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 07:58:12 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 07:58:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:13 INFO - Successfully installed psutil 07:58:13 INFO - Cleaning up... 07:58:13 INFO - Return code: 0 07:58:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:58:13 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')]} 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:13 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')]} 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:13 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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:13 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 07:58:13 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 07:58:13 INFO - Using env: {'DISPLAY': ':0', 07:58:13 INFO - 'HOME': '/home/cltbld', 07:58:13 INFO - 'LANG': 'en_US.UTF-8', 07:58:13 INFO - 'LANGUAGE': 'en_US:en', 07:58:13 INFO - 'LOGNAME': 'cltbld', 07:58:13 INFO - 'MAIL': '/var/mail/cltbld', 07:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:13 INFO - 'MOZ_NO_REMOTE': '1', 07:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:13 INFO - 'NO_EM_RESTART': '1', 07:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:13 INFO - 'PWD': '/builds/slave/test', 07:58:13 INFO - 'SHELL': '/bin/bash', 07:58:13 INFO - 'SHLVL': '1', 07:58:13 INFO - 'TERM': 'linux', 07:58:13 INFO - 'TMOUT': '86400', 07:58:13 INFO - 'USER': 'cltbld', 07:58:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:13 INFO - '_': '/tools/buildbot/bin/python'} 07:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:58:15 INFO - Installing collected packages: mozsystemmonitor 07:58:15 INFO - Running setup.py install for mozsystemmonitor 07:58:15 INFO - Successfully installed mozsystemmonitor 07:58:15 INFO - Cleaning up... 07:58:15 INFO - Return code: 0 07:58:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:58:15 INFO - Using env: {'DISPLAY': ':0', 07:58:15 INFO - 'HOME': '/home/cltbld', 07:58:15 INFO - 'LANG': 'en_US.UTF-8', 07:58:15 INFO - 'LANGUAGE': 'en_US:en', 07:58:15 INFO - 'LOGNAME': 'cltbld', 07:58:15 INFO - 'MAIL': '/var/mail/cltbld', 07:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:15 INFO - 'MOZ_NO_REMOTE': '1', 07:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:15 INFO - 'NO_EM_RESTART': '1', 07:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:15 INFO - 'PWD': '/builds/slave/test', 07:58:15 INFO - 'SHELL': '/bin/bash', 07:58:15 INFO - 'SHLVL': '1', 07:58:15 INFO - 'TERM': 'linux', 07:58:15 INFO - 'TMOUT': '86400', 07:58:15 INFO - 'USER': 'cltbld', 07:58:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:15 INFO - '_': '/tools/buildbot/bin/python'} 07:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:15 INFO - Downloading/unpacking jsonschema==2.5.1 07:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:58:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:58:17 INFO - warning: no files found matching '*.txt' 07:58:17 INFO - no previously-included directories found matching 'build' 07:58:17 INFO - no previously-included directories found matching 'dist' 07:58:17 INFO - no previously-included directories found matching '.git*' 07:58:17 INFO - Installing collected packages: jsonschema, functools32 07:58:17 INFO - Running setup.py install for functools32 07:58:17 INFO - warning: no files found matching '*.txt' 07:58:17 INFO - no previously-included directories found matching 'build' 07:58:17 INFO - no previously-included directories found matching 'dist' 07:58:17 INFO - no previously-included directories found matching '.git*' 07:58:17 INFO - Successfully installed jsonschema functools32 07:58:17 INFO - Cleaning up... 07:58:18 INFO - Return code: 0 07:58:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:58: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')]} 07:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58: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')]} 07:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58: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', '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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:58: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 blobuploader==1.2.4 07:58:18 INFO - Using env: {'DISPLAY': ':0', 07:58:18 INFO - 'HOME': '/home/cltbld', 07:58:18 INFO - 'LANG': 'en_US.UTF-8', 07:58:18 INFO - 'LANGUAGE': 'en_US:en', 07:58:18 INFO - 'LOGNAME': 'cltbld', 07:58:18 INFO - 'MAIL': '/var/mail/cltbld', 07:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:18 INFO - 'MOZ_NO_REMOTE': '1', 07:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:18 INFO - 'NO_EM_RESTART': '1', 07:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:18 INFO - 'PWD': '/builds/slave/test', 07:58:18 INFO - 'SHELL': '/bin/bash', 07:58:18 INFO - 'SHLVL': '1', 07:58:18 INFO - 'TERM': 'linux', 07:58:18 INFO - 'TMOUT': '86400', 07:58:18 INFO - 'USER': 'cltbld', 07:58:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:18 INFO - '_': '/tools/buildbot/bin/python'} 07:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:18 INFO - Downloading/unpacking blobuploader==1.2.4 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:20 INFO - Downloading blobuploader-1.2.4.tar.gz 07:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:58:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:58:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 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 07:58:20 INFO - Downloading docopt-0.6.1.tar.gz 07:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:58:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:58:20 INFO - Running setup.py install for blobuploader 07:58:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:58:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:58:20 INFO - Running setup.py install for requests 07:58:21 INFO - Running setup.py install for docopt 07:58:21 INFO - Successfully installed blobuploader requests docopt 07:58:21 INFO - Cleaning up... 07:58:21 INFO - Return code: 0 07:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58: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')]} 07:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58: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')]} 07:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:21 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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:21 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 07:58:21 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 07:58:21 INFO - Using env: {'DISPLAY': ':0', 07:58:21 INFO - 'HOME': '/home/cltbld', 07:58:21 INFO - 'LANG': 'en_US.UTF-8', 07:58:21 INFO - 'LANGUAGE': 'en_US:en', 07:58:21 INFO - 'LOGNAME': 'cltbld', 07:58:21 INFO - 'MAIL': '/var/mail/cltbld', 07:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:21 INFO - 'MOZ_NO_REMOTE': '1', 07:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:21 INFO - 'NO_EM_RESTART': '1', 07:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:21 INFO - 'PWD': '/builds/slave/test', 07:58:21 INFO - 'SHELL': '/bin/bash', 07:58:21 INFO - 'SHLVL': '1', 07:58:21 INFO - 'TERM': 'linux', 07:58:21 INFO - 'TMOUT': '86400', 07:58:21 INFO - 'USER': 'cltbld', 07:58:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:21 INFO - '_': '/tools/buildbot/bin/python'} 07:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:21 INFO - Running setup.py (path:/tmp/pip-jmYMof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:21 INFO - Running setup.py (path:/tmp/pip-GgnOpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:21 INFO - Running setup.py (path:/tmp/pip-QGjT7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:21 INFO - Running setup.py (path:/tmp/pip-rP3Qif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:21 INFO - Running setup.py (path:/tmp/pip-1OdlRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:22 INFO - Running setup.py (path:/tmp/pip-gD3c2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:22 INFO - Running setup.py (path:/tmp/pip-rFO53j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:22 INFO - Running setup.py (path:/tmp/pip-gmb9gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:22 INFO - Running setup.py (path:/tmp/pip-JVUy9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:22 INFO - Running setup.py (path:/tmp/pip-gKj5tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:22 INFO - Running setup.py (path:/tmp/pip-wvNS9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:22 INFO - Running setup.py (path:/tmp/pip-n1qCLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:22 INFO - Running setup.py (path:/tmp/pip-tnHIsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:22 INFO - Running setup.py (path:/tmp/pip-AHuIKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:22 INFO - Running setup.py (path:/tmp/pip-h4UyRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:22 INFO - Running setup.py (path:/tmp/pip-FMZNIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:22 INFO - Running setup.py (path:/tmp/pip-CjUqPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:58:22 INFO - Running setup.py install for manifestparser 07:58:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:58:22 INFO - Running setup.py install for mozcrash 07:58:23 INFO - Running setup.py install for mozdebug 07:58:23 INFO - Running setup.py install for mozdevice 07:58:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Running setup.py install for mozfile 07:58:23 INFO - Running setup.py install for mozhttpd 07:58:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Running setup.py install for mozinfo 07:58:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Running setup.py install for mozInstall 07:58:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Running setup.py install for mozleak 07:58:23 INFO - Running setup.py install for mozlog 07:58:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:58:23 INFO - Running setup.py install for moznetwork 07:58:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:58:24 INFO - Running setup.py install for mozprocess 07:58:24 INFO - Running setup.py install for mozprofile 07:58:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:58:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:58:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:58:24 INFO - Running setup.py install for mozrunner 07:58:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:58:24 INFO - Running setup.py install for mozscreenshot 07:58:24 INFO - Running setup.py install for moztest 07:58:24 INFO - Running setup.py install for mozversion 07:58:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:58:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:58:24 INFO - Cleaning up... 07:58:24 INFO - Return code: 0 07:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:24 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')]} 07:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:24 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')]} 07:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:24 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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:24 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 07:58:24 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 07:58:24 INFO - Using env: {'DISPLAY': ':0', 07:58:24 INFO - 'HOME': '/home/cltbld', 07:58:24 INFO - 'LANG': 'en_US.UTF-8', 07:58:24 INFO - 'LANGUAGE': 'en_US:en', 07:58:24 INFO - 'LOGNAME': 'cltbld', 07:58:24 INFO - 'MAIL': '/var/mail/cltbld', 07:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:24 INFO - 'MOZ_NO_REMOTE': '1', 07:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:24 INFO - 'NO_EM_RESTART': '1', 07:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:24 INFO - 'PWD': '/builds/slave/test', 07:58:24 INFO - 'SHELL': '/bin/bash', 07:58:24 INFO - 'SHLVL': '1', 07:58:24 INFO - 'TERM': 'linux', 07:58:24 INFO - 'TMOUT': '86400', 07:58:24 INFO - 'USER': 'cltbld', 07:58:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:24 INFO - '_': '/tools/buildbot/bin/python'} 07:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:24 INFO - Running setup.py (path:/tmp/pip-xZPb68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:24 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)) 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:24 INFO - Running setup.py (path:/tmp/pip-3jmu1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:25 INFO - Running setup.py (path:/tmp/pip-66ZSjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:25 INFO - Running setup.py (path:/tmp/pip-zxJgnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:25 INFO - Running setup.py (path:/tmp/pip-QIRDsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:25 INFO - Running setup.py (path:/tmp/pip-fqCRji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:25 INFO - Running setup.py (path:/tmp/pip-aYXKC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:25 INFO - Running setup.py (path:/tmp/pip-xN_vWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:25 INFO - Running setup.py (path:/tmp/pip-x3lXBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:25 INFO - Running setup.py (path:/tmp/pip-AoIujB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:25 INFO - Running setup.py (path:/tmp/pip-QjJ1DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:25 INFO - Running setup.py (path:/tmp/pip-MCWBTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:25 INFO - Running setup.py (path:/tmp/pip-X9YfKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:25 INFO - Running setup.py (path:/tmp/pip-Dm96GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:25 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)) 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:25 INFO - Running setup.py (path:/tmp/pip-TM1fjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:26 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)) 07:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:26 INFO - Running setup.py (path:/tmp/pip-wzW5N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:26 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)) 07:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:26 INFO - Running setup.py (path:/tmp/pip-guJPb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:26 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)) 07:58:26 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)) 07:58:26 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)) 07:58:26 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)) 07:58:26 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)) 07:58:26 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)) 07:58:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:28 INFO - Downloading blessings-1.6.tar.gz 07:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:58:28 INFO - Installing collected packages: blessings 07:58:28 INFO - Running setup.py install for blessings 07:58:28 INFO - Successfully installed blessings 07:58:28 INFO - Cleaning up... 07:58:28 INFO - Return code: 0 07:58:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:58:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:28 INFO - Reading from file tmpfile_stdout 07:58:28 INFO - Current package versions: 07:58:28 INFO - argparse == 1.2.1 07:58:28 INFO - blessings == 1.6 07:58:28 INFO - blobuploader == 1.2.4 07:58:28 INFO - docopt == 0.6.1 07:58:28 INFO - functools32 == 3.2.3-2 07:58:28 INFO - jsonschema == 2.5.1 07:58:28 INFO - manifestparser == 1.1 07:58:28 INFO - mozInstall == 1.12 07:58:28 INFO - mozcrash == 0.17 07:58:28 INFO - mozdebug == 0.1 07:58:28 INFO - mozdevice == 0.48 07:58:28 INFO - mozfile == 1.2 07:58:28 INFO - mozhttpd == 0.7 07:58:28 INFO - mozinfo == 0.9 07:58:28 INFO - mozleak == 0.1 07:58:28 INFO - mozlog == 3.2 07:58:28 INFO - moznetwork == 0.27 07:58:28 INFO - mozprocess == 0.22 07:58:28 INFO - mozprofile == 0.28 07:58:28 INFO - mozrunner == 6.11 07:58:28 INFO - mozscreenshot == 0.1 07:58:28 INFO - mozsystemmonitor == 0.3 07:58:28 INFO - moztest == 0.7 07:58:28 INFO - mozversion == 1.4 07:58:28 INFO - psutil == 3.1.1 07:58:28 INFO - requests == 1.2.3 07:58:28 INFO - wsgiref == 0.1.2 07:58:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:28 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')]} 07:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:28 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')]} 07:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:28 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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:28 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 07:58:28 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 07:58:28 INFO - Using env: {'DISPLAY': ':0', 07:58:28 INFO - 'HOME': '/home/cltbld', 07:58:28 INFO - 'LANG': 'en_US.UTF-8', 07:58:28 INFO - 'LANGUAGE': 'en_US:en', 07:58:28 INFO - 'LOGNAME': 'cltbld', 07:58:28 INFO - 'MAIL': '/var/mail/cltbld', 07:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:28 INFO - 'MOZ_NO_REMOTE': '1', 07:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:28 INFO - 'NO_EM_RESTART': '1', 07:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:28 INFO - 'PWD': '/builds/slave/test', 07:58:28 INFO - 'SHELL': '/bin/bash', 07:58:28 INFO - 'SHLVL': '1', 07:58:28 INFO - 'TERM': 'linux', 07:58:28 INFO - 'TMOUT': '86400', 07:58:28 INFO - 'USER': 'cltbld', 07:58:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:28 INFO - '_': '/tools/buildbot/bin/python'} 07:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 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)) 07:58:28 INFO - Cleaning up... 07:58:28 INFO - Return code: 0 07:58:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:58:28 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')]} 07:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:28 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')]} 07:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:28 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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:28 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 07:58:28 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 07:58:28 INFO - Using env: {'DISPLAY': ':0', 07:58:28 INFO - 'HOME': '/home/cltbld', 07:58:28 INFO - 'LANG': 'en_US.UTF-8', 07:58:28 INFO - 'LANGUAGE': 'en_US:en', 07:58:28 INFO - 'LOGNAME': 'cltbld', 07:58:28 INFO - 'MAIL': '/var/mail/cltbld', 07:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:28 INFO - 'MOZ_NO_REMOTE': '1', 07:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:28 INFO - 'NO_EM_RESTART': '1', 07:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:28 INFO - 'PWD': '/builds/slave/test', 07:58:28 INFO - 'SHELL': '/bin/bash', 07:58:28 INFO - 'SHLVL': '1', 07:58:28 INFO - 'TERM': 'linux', 07:58:28 INFO - 'TMOUT': '86400', 07:58:28 INFO - 'USER': 'cltbld', 07:58:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:28 INFO - '_': '/tools/buildbot/bin/python'} 07:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:58:28 INFO - Cleaning up... 07:58:28 INFO - Return code: 0 07:58:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:58:28 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')]} 07:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:28 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')]} 07:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:28 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 0x7f30eae85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', '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 07:58:28 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 07:58:28 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 07:58:28 INFO - Using env: {'DISPLAY': ':0', 07:58:28 INFO - 'HOME': '/home/cltbld', 07:58:28 INFO - 'LANG': 'en_US.UTF-8', 07:58:28 INFO - 'LANGUAGE': 'en_US:en', 07:58:28 INFO - 'LOGNAME': 'cltbld', 07:58:28 INFO - 'MAIL': '/var/mail/cltbld', 07:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:28 INFO - 'MOZ_NO_REMOTE': '1', 07:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:28 INFO - 'NO_EM_RESTART': '1', 07:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:28 INFO - 'PWD': '/builds/slave/test', 07:58:28 INFO - 'SHELL': '/bin/bash', 07:58:28 INFO - 'SHLVL': '1', 07:58:28 INFO - 'TERM': 'linux', 07:58:28 INFO - 'TMOUT': '86400', 07:58:28 INFO - 'USER': 'cltbld', 07:58:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:28 INFO - '_': '/tools/buildbot/bin/python'} 07:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:29 INFO - Downloading/unpacking flake8 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:58:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:58:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:58:32 INFO - no previously-included directories found matching 'docs/_build' 07:58:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:58:32 INFO - Running setup.py install for pep8 07:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:58:32 INFO - no previously-included directories found matching 'docs/_build' 07:58:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:58:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:58:32 INFO - Cleaning up... 07:58:33 INFO - Return code: 0 07:58:33 INFO - Running post-action listener: _resource_record_post_action 07:58:33 INFO - Running post-action listener: _start_resource_monitoring 07:58:33 INFO - Starting resource monitoring. 07:58:33 INFO - ##### 07:58:33 INFO - ##### Finished create-virtualenv step (success) 07:58:33 INFO - ##### 07:58:33 INFO - ##### 07:58:33 INFO - ##### Running install step. 07:58:33 INFO - ##### 07:58:33 INFO - Running pre-action listener: _resource_record_pre_action 07:58:33 INFO - Running main action method: install 07:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:33 INFO - Reading from file tmpfile_stdout 07:58:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:58:33 INFO - Reading from file tmpfile_stdout 07:58:33 INFO - Output received: 07:58:33 INFO - Usage: mozinstall [options] installer 07:58:33 INFO - Options: 07:58:33 INFO - -h, --help show this help message and exit 07:58:33 INFO - -d DEST, --destination=DEST 07:58:33 INFO - Directory to install application into. [default: 07:58:33 INFO - "/builds/slave/test"] 07:58:33 INFO - --app=APP Application being installed. [default: firefox] 07:58:33 INFO - mkdir: /builds/slave/test/build/application 07:58:33 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'] 07:58:33 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 07:58:49 INFO - Reading from file tmpfile_stdout 07:58:49 INFO - Output received: 07:58:49 INFO - /builds/slave/test/build/application/firefox/firefox 07:58:49 INFO - Running post-action listener: _resource_record_post_action 07:58:49 INFO - ##### 07:58:49 INFO - ##### Finished install step (success) 07:58:49 INFO - ##### 07:58:49 INFO - ##### 07:58:49 INFO - ##### Running run-tests step. 07:58:49 INFO - ##### 07:58:49 INFO - Running pre-action listener: _resource_record_pre_action 07:58:49 INFO - Running main action method: run_tests 07:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:58:49 INFO - Python 2.7.3 07:58:49 INFO - Return code: 0 07:58:49 INFO - grabbing minidump binary from tooltool 07:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:49 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 0x24751c0>, '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 0x24760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:58:49 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 07:58:49 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 07:58:49 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 07:58:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:58:49 INFO - Return code: 0 07:58:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:58:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:58:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:58:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:58:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:58:50 INFO - Return code: 0 07:58:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:58:50 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:58:50 INFO - Using env: {'DISPLAY': ':0', 07:58:50 INFO - 'HOME': '/home/cltbld', 07:58:50 INFO - 'LANG': 'en_US.UTF-8', 07:58:50 INFO - 'LANGUAGE': 'en_US:en', 07:58:50 INFO - 'LOGNAME': 'cltbld', 07:58:50 INFO - 'MAIL': '/var/mail/cltbld', 07:58:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:58:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:50 INFO - 'MOZ_NO_REMOTE': '1', 07:58:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:50 INFO - 'NO_EM_RESTART': '1', 07:58:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:50 INFO - 'PWD': '/builds/slave/test', 07:58:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:58:50 INFO - 'SHELL': '/bin/bash', 07:58:50 INFO - 'SHLVL': '1', 07:58:50 INFO - 'TERM': 'linux', 07:58:50 INFO - 'TMOUT': '86400', 07:58:50 INFO - 'USER': 'cltbld', 07:58:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730', 07:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:50 INFO - '_': '/tools/buildbot/bin/python'} 07:58:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:58:50 INFO - mozversion application_buildid: 20160622063901 07:58:50 INFO - mozversion application_changeset: c9edfe35619f69f7785776ebd19a3140684024dc 07:58:50 INFO - mozversion application_display_name: Nightly 07:58:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:58:50 INFO - mozversion application_name: Firefox 07:58:50 INFO - mozversion application_remotingname: firefox 07:58:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:58:50 INFO - mozversion application_vendor: Mozilla 07:58:50 INFO - mozversion application_version: 50.0a1 07:58:50 INFO - mozversion platform_buildid: 20160622063901 07:58:50 INFO - mozversion platform_changeset: c9edfe35619f69f7785776ebd19a3140684024dc 07:58:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:58:50 INFO - mozversion platform_version: 50.0a1 07:58:50 INFO - using testdate: 1466607530 07:58:50 INFO - actual date: 1466607530 07:58:50 INFO - starting webserver on 'localhost:36395' 07:58:50 INFO - SUITE-START | Running 2 tests 07:58:50 INFO - TEST-START | dromaeo_css 07:58:50 INFO - operating with platform_type : linux_ 07:58:50 INFO - Initialising browser for dromaeo_css test... 07:58:50 INFO - TEST-INFO | started process 3629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaWA1rj/profile http://localhost:36395/getInfo.html) 07:58:55 INFO - PROCESS | 3629 | __metrics Screen width/height:1600/1200 07:58:55 INFO - PROCESS | 3629 | colorDepth:24 07:58:55 INFO - PROCESS | 3629 | Browser inner width/height: 1024/697 07:58:55 INFO - PROCESS | 3629 | __metrics 07:58:56 INFO - PROCESS | 3629 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:58:57 INFO - TEST-INFO | 3629: exit 0 07:58:57 INFO - Browser initialized. 07:58:57 INFO - Running cycle 1/1 for dromaeo_css test... 07:58:57 INFO - TEST-INFO | started process 3707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaWA1rj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:09 INFO - PROCESS | 3707 | RSS: Main: 175366144 07:59:09 INFO - PROCESS | 3707 | 08:00:00 INFO - PROCESS | 3707 | 1466607600616 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:02:13 INFO - PROCESS | 3707 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36395/tests/dromaeo/cssquery-ext.html) 08:02:14 INFO - PROCESS | 3707 | RSS: Main: 265826304 08:02:14 INFO - PROCESS | 3707 | 08:05:17 INFO - PROCESS | 3707 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-ext.html (next: http://localhost:36395/tests/dromaeo/cssquery-jquery.html) 08:05:18 INFO - PROCESS | 3707 | RSS: Main: 262586368 08:05:18 INFO - PROCESS | 3707 | 08:08:20 INFO - PROCESS | 3707 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36395/tests/dromaeo/cssquery-mootools.html) 08:08:20 INFO - PROCESS | 3707 | RSS: Main: 253771776 08:08:20 INFO - PROCESS | 3707 | 08:11:23 INFO - PROCESS | 3707 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36395/tests/dromaeo/cssquery-prototype.html) 08:11:23 INFO - PROCESS | 3707 | RSS: Main: 257081344 08:11:23 INFO - PROCESS | 3707 | 08:14:26 INFO - PROCESS | 3707 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36395/tests/dromaeo/cssquery-yui.html) 08:14:27 INFO - PROCESS | 3707 | RSS: Main: 230178816 08:14:27 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-yui.html (next: http://localhost:36395/tests/dromaeo/cssquery-dojo.html) 08:17:30 INFO - PROCESS | 3707 | RSS: Main: 337530880 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | __start_tp_report 08:17:30 INFO - PROCESS | 3707 | _x_x_mozilla_page_load 08:17:30 INFO - PROCESS | 3707 | _x_x_mozilla_page_load_details 08:17:30 INFO - PROCESS | 3707 | |i|pagename|runs| 08:17:30 INFO - PROCESS | 3707 | |0;dojo.html;2627.2643659775263;2634.6443230163923;2670.212287375224;2674.5453272943596;2684.8791804368802;4659.720416774996;4667.953320466794;4768.499307572698;4778;4861.73260470674;4845.3216549683075;4874.853754387365;4889.9755501222535;4901.1177987962155;4911.410630724309;4432.822687092513;4470.7317560946285;4508.075844451896;4579.954200458003;4600.309953506967;4496.640268778507;4536.138133754593;4551.5676010778925;4555.066211426666;4584.656150788687;4330.610245077958;4364.301711726109;4396.472423309191;4408.823647054114;4413.646908247332;4458.197524445599;4462.933056004163;4463.531329210451;4518.43519560055;4572.199865023607;4492.730436173807;4510.639148868083;4517.299818528133;4520;4566.45202575693;4829.1790395632825;4841.878953026167;4890.0953323634885;4944.33251511045;4992.850214493571;5290.994711004897;5300.681959082467;5314.893702125974;5318.149096144598;5318.30861987943;5316.946830531684;5340.038793017256;5342.545883599899;5354.759035843357;5355.892882142374;4713.67004309695;4845.1278769821065;4877.804887804448;4888.5111488850835;4953.45511993684;5381.542568881689;5392.05639013179;5465.9726701366235;5472.315960504937;5480.616356854982;5174.275601415805;5186.662866913639;5232.659877107976;5234.790608375699;5237.685738855681;5128.487151284841;5234.18870075139;5266.10476219036;5270.341207349082;5275.498827611371;5230.189320655304;5239.423663397023;5248.685078895279;5249.343832020997;5303.124984377535;5084.593232541388;5232.136697444879;5239.5284424401225;5239.869003274873;5244.396894357198;4361.80371883266;4393.802278897458;4406.1187762447635;4407.272799987966;4409.5149533551285;3857.7106716996336;3893.53277606689;3896.551896531935;3900.1224724436775;3901.239258344652;4457.554244575516;4473.6868419211;4474.172278128557;4480.238359478896;4481.484629267611;5300.072487314705;5303.7348132593215;5316;5327.467253274719;5331.786728530893;4493.460784705856;4506.864794056183;4507.166174257773;4514.10533244902;4551.886202844889;4602.723836569749;4655;4708.929366059512;4725.64557658177;4790.8323208687525;4907.55831975124;4917.0903382874285;4922.3847019121895;4923.704577725348;4924.72913989734;5276.234945932895;5289.3652761668845;5290.81482148123;5291.814786482455;5293.100172970681;4746.644001699818;4863.4650188479945;4869.610431165569;4904.117258893433;4938.506149385176;5175.042617115846;5192.324997750268;5199.168133098686;5205.869853253699;5250.26496290512;5091.719955402488;5256.684598923924;5275.8681032972945;5276.472352764847;5282.366116066097;4966.081274964144;5006.0738763327445;5010.048090862724;5045.899082018413;5082.263071854634;5063.620228482805;5072.721000345016;5074.035933172685;5078.035173317058;5123.308353372247;4910.8281210157475;4943.406791185081;4999.250112483157;5013.197888337849;5061.595072394126;5082.898342033212;5097.184450488053;5115;5122.743862806919;5175.715335656575;5009;5020.221865610836;5020.949790502194;5025.321581586585;5073.11220536412 08:17:30 INFO - PROCESS | 3707 | |1;ext.html;554.165526408382;575.278026077273;578.8755417585219;580.4804699793684;597.5787070115567;27048.594271085924;30086.849565752196;30105.849470752644;30112.397752044944;39611.40582891259;37439;41669.58330416695;41670.37494437586;41736.373954390634;41741;7809.375249980002;7960.283574478296;7965.72119975801;7968.163342848975;7973;7508.511946723473;7712.922870771305;7716.537007779523;7823.3350165236025;7927.881081783749;10077.093061624453;10366.326188797704;10373.688789336333;10661.520231589559;10679.41263230522;10091.142252908512;10192.337498062601;10194.388336699822;10197.847032294521;10202.693919182437;7483.6258187090425;9876.95061524695;10068.546915388752;10147.137493313003;10257.384556926609;38651.61348386537;38878.61121388806;38928.80535597332;38963.22073558541;38992.41511377331;3185.5221716742444;3276.3447310537986;3290.4241757692307;3742.1580144467275;3821.1402434452025;29276.560851587245;29380.41239175226;30026.549601755993;30259.697403025908;30778.846105769328;3391;3419.8290085495873;3430.5711786026745;3447.7241820654285;3478.7043101336417;245344;245360;245563;246287;246550;54423.18365224525;54667.45332546703;54812;54824.725876370365;54861;57092;57441;57537.13694294589;57540.13689794656;57548.84902302014;14896.255187240595;15456.845431545766;15463.38146474151;15466.690666186612;15474.922625386802;10407.167426605853;10538.683839484827;10843.45782710877;10851.945740271249;11072.058874995555;16014.519564413085;16149.67700646004;16285.59286017859;16755.748663770053;16971.575710607085;6125.418085281891;6246.3753624637175;6275.215598050244;6301.306856245809;6358.713857876407;796.653455746752;935.2190920581255;945.4610871803144;977.8337682593976;982.6266018912768;27218.863905680344;28359.57460638092;28434.87814622461;29039;29080.418391632047;972.9805403891883;981.3768257156756;1002.2332915319786;1100.5047728522197;1107.8426484519216;14807.555773326818;15036.849631503765;15130.394784208509;15144.54566363011;15174.468893588672;362632;362678;363858;364745;365763;50974;51396;51521.48478515167;51537.7423112882;51590;1055.2138656700806;1094.3762055628215;1138.4535422997174;1193.1528614683673;1226.7607816475702;27436.862815685792;29379.265518362212;29530.852345738993;30138.849305754207;30633.54049689301;43277;43532;43771.343429849214;43794.56205437905;43829.56170438255;300306;303973;304165;304204;304363;31346.843265783526;37553;38714.22571548497;38975.61024389833;42386.788066059475;38009.80995095007;43207.78396107999;43367.132657347305;44125;44544.77727611341;35816;36904.63095369012;37214.44178337381;37224.62775372212;37457.25085498329;36406.81796591;36657.45013824741;36903.44644830276;37101.443478347304;37590.43614345841;35640.4653930186;36153.45769813402;36307.27385452329;36443;36575;32124.357512849143;32676.83661581677;32920.45829129616;33232.335353292314;33456.66543334633;25109;25119.744012799652;25256.74743252544;25611.231663050137;25833.483330333664 08:17:30 INFO - PROCESS | 3707 | |2;jquery.html;368.88933320003997;369.6451406649616;369.92971335446265;379.4611651454934;390.52746177125675;15774;16025;16959;16963.236654350552;16984.915075424622;15443.613909652237;16181.919090404532;16939.491815245532;16963.91518042408;16969.57576060596;5169.457206993268;5335.973320133413;5374.6237763356585;5374.7850085996515;5375.892482150374;3788.867389641363;3939.9606003940025;5274.314339135926;5914.349421563625;6270.65511396873;6306.968465157691;6309.716062777163;6330.746770129213;6331.081993111019;6333.366663333676;6043.546733994924;6173.2900716417735;6192.256929168529;6296.464800491964;6298.87402251957;3417.5215469834243;5112.948870511284;5318.042752304584;5440.537554307889;5453.863653408657;19764.604707905906;20433.386998390073;20539.38381848547;20660.483487912923;20680.276190333265;1923.3652894544907;1936.1190658250462;1984.4641946674317;2024.3926821953503;2048.6107639548586;13139.817416432472;13179.60461186166;13321.533746318832;13503.729925401436;13599.728005439836;1729.57625381781;1741.9912900435543;1764.3912850066706;1764.9117544122741;1833.4316361927845;63428.36571634317;63564.68217658928;64360.67819660919;64363;64448;9411.43531388119;9471.526423678788;9880;9943.303968722264;10067.59729610822;13339.066265361525;13422;13422.865771342356;13436.798448023288;13471.326433678278;7198.100237470317;7212.531185472927;7283.397652516438;7456.142543607446;7479.70081196746;6813.7955861324235;6868.931310686829;6886.931130688729;6973.686184121727;6983.406410455066;5879.7060146993335;5990.64056156632;6124.391477210693;6179.752809887644;6226.968865155736;1523.5200911712775;1683.7221858393227;1736.887102338344;1741.2773698915062;1748.6590114927722;871.263782104121;889.6485888074175;938.596403546468;952.4142652268805;980.3235767320526;17029.48911532656;17097.829021709873;17139.828601714074;17791.822081779275;17824.287028518713;875.2516598308482;880.3749337970113;901.085398320705;934.780326623243;964.2478866484154;9787.951060244653;10063.19494440443;10194.184465242763;10204.687623723254;10258.640947566799;370699.4395084076;376851;377161;378703;384543;65752;65916.67041664761;66002.33997660058;67595;67659.66170169118;915.8351496730652;933.1088810186255;940.1585580905052;948.7059011706256;950.5247376311844;15258.389664413744;15393;15596.92201538985;15611.531654050397;15801.446949356718;32424.83787581047;33748.49377259392;33843;34672.133196670286;34808;42600.78699606606;43568.782156089015;43977.34033989557;45504.31743523916;45694.314585281914;7459.142198647008;7595.848083038419;7607.88588171189;7750.302472777477;7752.883706744291;11621.6513504595;11804.586839460577;11833.644990650295;11923.642290730944;12076.275423474619;9966.40201587907;10359.741006474596;10416.427096509462;10432.478376081013;10526.31578947366;9071.274298056273;10055.346402483816;10278.229132814919;10360.948195259278;10531.684049478528;10374.636887708893;10471.895281047093;10539.683809485728;10629.25595208328;10938.726531836768;7313.524620899624;7441.888371674538;7462.4776265660885;7519.398448124246;7622.923770762443;9830.164436022733;10219.489025548544;10485.318454300446;10709.250352475252;10766.438866364177 08:17:30 INFO - PROCESS | 3707 | |3;mootools.html;1192.511070461111;1366.24856329019;1391.4781956766212;1465.7141857337817;1633.9428120015803;6821.522493425462;7604.429667774912;7785.883211751814;7796.766097017085;8007.599620019005;7780.455368124233;7937.4840635358805;7940.801479963004;7946.801329966754;7965.203479652047;1869.1495369606796;2141.3468891987936;2190.3538456155393;2218.589560931233;2232.57581059599;2280.2361208995007;2300.3903965449167;2302.9539409211807;2303.2629558541275;2305.596520608895;2168.5879682860286;2173.054721196285;2226.599212141814;2230.063373383183;2230.364346161336;1814.2652225848553;2101.558672678739;2177.194438057929;2183.530540933691;2204.6582779669097;2196.0556960506974;2214;2220.034285085993;2220.455988282881;2222.511047569532;7972.322352600036;7982.9600851995365;7987.281144696947;7991.8401631967035;8101.716439924633;4563.794629241659;4616.39986801717;4630.398048253705;4678.134545109166;4680.695754775928;2853.372258103214;2952.9261768455744;3062.9846850765603;3075.5079187330143;3076.015674984006;961.6922584772875;962.6149540183912;967.4727273635885;991.6430085169334;997.6607953295842;10862.565497380174;10869;10911.07255883251;10937.125029997582;10956.780864382747;4196.433481480022;4345.869623911288;4396.120775844844;4408.691391602557;4423.181711383404;9198;9242.86135707965;9250.583723732449;9255.95372023149;9268.073192680813;4764.904701905943;4766.95233047672;4771.427428708577;4771.475137734847;4772.0694464579765;3769.1707824279165;4143.0678097428445;4276.679249056333;4283.164782867373;4347.3261644445165;3698.3712768828827;3758.586555478895;3849.480320156743;3870.787106709102;3874.9225015499533;1205.6081773423498;1221.7861874171983;1226.7117227451542;1229.8032314829763;1230.8399908011902;721.5346101764437;786.5084322298563;833.9166083391613;848.4569875279826;848.4909054567211;5164.509371609691;5379.601303660998;5392.352917649907;5413.052715774802;5413.5263537546325;875.1904488348252;885.8848349714495;903.3495882964255;908.1917093786535;912.5026860361119;3386.255023894739;3504.3867323218333;3504.7546671732734;3616.2752365064025;3819.1788765415567;9864.358816677037;10121.139703125316;10137.189024877993;10168.084872361524;10175.08424241807;9815.36200146988;9925.3548519346;9964;9992.550335234931;10004;7422.665980030912;7622.8094297643;7633.351165151024;7634.656440460304;7646.617669116522;5202.115640341075;5376.650517716336;5394.568434525307;5448.073827449264;5506.174073888948;9152.725418237464;9166.404183728037;9290.210332121575;9500.192483638692;9519.476428796483;9137.908620913971;9336.719898403058;9371.953140234255;9478.763030924281;9532;6315.873682526232;6771.729130834711;6931.202911665223;6988.266232045766;7125.216226215216;7862.764117076496;7884.29041386278;7969.561674107979;7973.322267607086;7992.040955085427;7026.086608740831;7171.892421613784;7199.532030418006;7297;7307.744228951961;6970.860582788418;7091.82270443243;7095.787126386217;7129;7199.424046076406;5986.700664966647;6163.7842675506145;6215.533834962305;6322.747090116344;6322.841928951813;4285.571442855814;4369.606735393702;4404.427424434803;4534.727916325031;4566.26939689648;4640.071985602825;4731.313959475788;4738.881527961828;4803.903921921612;4856.902861942671 08:17:30 INFO - PROCESS | 3707 | |4;prototype.html;305.8638905686969;306.3566510328311;308.32630701916315;314.50308512550174;315.5030826448344;4894.681845680028;4920.581750551203;4928.3593132892765;4945.749683893829;4955.900881982358;4824.855254342376;4858.4898585648525;4881.145799485093;4888.804447822083;4905;3627.6009638939695;3781.3004594150034;3792.886213413602;3866.574676785551;3929.1552316252;3831.731778775487;3882.8058597070176;3893.2213557288514;3895.4935858338376;3908.394198899161;3851.6533511983916;3851.826667799956;3859.903502412434;3866.4007078902814;3867;3670.1742108025614;3770.7360484766077;3839.500864887547;3842.8078596070086;3883.805809709503;3412.77816941898;3414.590249170091;3415.214500664861;3429.7770644908;3439.6044454887756;4713.599344055725;4739.620830333565;4744.430668319824;4746.667733258673;4752.405949256343;4228.492580890313;4297.484301883763;4321.459817522809;4404.779761011937;4414.53647367025;5062.519060689266;5065.822696205652;5083.872903177413;5087.26234695967;5118.206677964921;3722.348588996942;3728.9813550932345;3737.906552336186;3765.4163604641326;3779.622037796226;5145.485451454862;5324.76359928827;5332.800119972975;5340.863654538177;5379.919301210485;3798.3163030654196;3851.345271303885;3858.6720128788807;3863.265979463893;3863.5363756349416;3895.14306852492;3903.414487826792;3911.5501717302873;3912.9217415652097;3922.9019274517796;4386.214753631403;4403.097365040159;4412.933805992912;4416.205083085076;4422.71252368595;4889.804407823718;5162.793488260428;5177.689338639693;5198.116320225571;5218.791248350023;1301.4989229146847;1309.3845892430543;1313.2514466754048;1315.5724389573427;1320.3002408723391;814.9470284431611;825.3685930263354;845.2519520224522;845.691322667222;854.0349405172116;4448.199324121624;4550.840720574764;4557.430321209848;4565.474970378383;4565.977170114194;5293.947060529345;5318.680879147263;5322.600804939645;5330.946690533123;5333.173358129496;4396.890077748082;4495.955040449619;4501.8616157325005;4506.81972721094;4529.411176547093;2775.3894143288444;2847.985760071186;2854.4005758790886;2867.827930324187;2869.899553515617;4999.950000500021;5003.149464591028;5041.193409054534;5043.722595257223;5055.393352797614;5180.565134386832;5468.48049435303;5487.106948102898;5495.148252020943;5509.669419834822;4946.77395172174;4977.282837421084;4978.850634480971;4984.501549844987;4990.500949905053;5258.158694608845;5259.815906443256;5285.207218917193;5293.2589437479555;5304.602154838325;4986.850394488171;5244.396894357198;5252.527272545489;5270.735023594387;5304.336957880265;4890.731009794496;4904.828331008541;5015.3480047593575;5035.395752509576;5035.496450354935;3629.4374371972385;3629.727770417282;3642.7085833133815;3645.489631451652;3651.8904432867057;5088.923666144937;5296.3379577552805;5301.469853014822;5330.147176451749;5341.813036543703;5104.2088476286235;5109.6678715883345;5117.769700363567;5121.770775014044;5127.692338459704;5138.743062846917;5152.27868098474;5159.458256882973;5187.610929180402;5204.724842413633;4778.808847646055;5071;5112.207607820794;5118.692878427306;5122;4975.900481990412;5021.694359466492;5209.4009188943755;5212.348456442945;5212.452692467236;5104.259882316969;5111.364363403675;5116.927644304063;5121.103806833864;5122.871928201825 08:17:30 INFO - PROCESS | 3707 | |5;yui.html;723.106962900817;727.3344889426176;727.3962611032844;735.521601580823;774.7636970723927;12723.236605803646;13777.655558611039;13895;13901.860981390184;13969.930150349246;12339.814902776443;12341.5063397464;12342.07434442416;12410.069244806653;12567.748645027117;615.0374663651371;753.6231884057971;767.4090949968521;771.1324759645399;773.5126870071847;774.1716363491067;775.806048487878;777.2111307023375;779.5673401262297;780.063923292049;819.6967122164807;821.3962737388015;822.2887202569764;822.3955392786297;822.6585966823761;640.0431355124073;793.2583034862394;816.073756286613;818.8976377952756;819.9914105650084;600.9429104235135;601.2034054877262;601.2994860986945;601.5879122800895;601.6781022153127;11990.520379184822;12041.578544750979;12049.216800907912;12053.57812476559;12058.758824823455;11739.295642261492;12563.560275390317;12822.230666159967;12999.090063695545;13067.346632668423;11349.978501934866;11528.193026488148;11544.711382215428;11673.824892626533;11943.641690749291;4027.3153563894207;4050.675945924319;4101.4668093148;4149.232392007489;4208.884645568926;59905.40094599042;60076.699616502076;60132.398676013116;60144.99999999956;60300.396996029915;9445.811083778286;9478;9711.854322185172;9872.753181170385;10082.243831712503;17545.035023073597;17564.912175439298;17566.12169391551;17594.824051759573;17610.2075406607;6712.127423434922;6712.697928593225;6957.130358705162;7025.508214424941;7043.894341584778;3852.749571277858;3919.1573811630064;3931.5871833457645;4011.3180759270995;4073.91852162961;2835.787315951312;2944.4994350960387;2944.9411011779644;2948.1450379389735;2953.61602991614;409.78076728949867;484.08024752968936;504.95202955719145;507.46969416959365;553.914143307788;613.6808859393179;621.9191505104308;625.6371304643296;631.6778442994014;650.8242774450966;8363.205495478041;8462.576871156418;8542.74371768848;8584.613692383859;8608.698695545625;614.115673430268;616.7378863982879;619.8822223777468;623.8409205652621;651.081974416071;4189.685773566995;4214.473190851144;4236.364545318165;4349.3041113421705;4364.258076127066;79251;100264;102577;103299.483502582;104619.47690261652;81928;86517.5674121638;86538;86955.1304486947;87818;75169;78471;78990.21009789943;79140.20859791328;79294;8152.103268640326;8159.46963447374;8200.589970501333;8244.628991695508;8330.625121869409;40957.590424095375;45408.31887521624;45411.545884540734;45967.080658385974;46868.7656561715;44361.55638443703;63291.367086328544;64529.35470645234;65070.67464662647;65665.67167164134;11149.777004460027;11915.582954596548;11948.880511194777;12295.385230738606;12301.938490307492;12416.565420210249;12681.175723577939;12886.871131288568;13623.591292261248;13662;11695.590654327058;11713.648590542298;12115.212511186744;12135.271883687006;13257.734845303234;12249.755004900031;12258.20321679088;12404.069694773108;12937.676558086123;12989;11765.235259708092;12010.75978480408;12337.321447320124;12437;12442;10199.235057370579;10358.430286334324;10448.634297799845;10613.150947924301;10739.301945373525;10195.694129176136;10197.745056373353;10281.280310378203;10307.639232626821;10646.787064258826 08:17:30 INFO - PROCESS | 3707 | __end_tp_report 08:17:30 INFO - PROCESS | 3707 | __start_cc_report 08:17:30 INFO - PROCESS | 3707 | _x_x_mozilla_cycle_collect,908 08:17:30 INFO - PROCESS | 3707 | __end_cc_report 08:17:30 INFO - PROCESS | 3707 | __startTimestamp1466608650447__endTimestamp 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | ------- Summary: start ------- 08:17:30 INFO - PROCESS | 3707 | Number of tests: 6 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | [#0] dojo.html Cycles:165 Average:4834.70 Median:4938.51 stddev:529.47 (10.7%) stddev-sans-first:501.98 08:17:30 INFO - PROCESS | 3707 | Values: 2627.3 2634.6 2670.2 2674.5 2684.9 4659.7 4668.0 4768.5 4778.0 4861.7 4845.3 4874.9 4890.0 4901.1 4911.4 4432.8 4470.7 4508.1 4580.0 4600.3 4496.6 4536.1 4551.6 4555.1 4584.7 4330.6 4364.3 4396.5 4408.8 4413.6 4458.2 4462.9 4463.5 4518.4 4572.2 4492.7 4510.6 4517.3 4520.0 4566.5 4829.2 4841.9 4890.1 4944.3 4992.9 5291.0 5300.7 5314.9 5318.1 5318.3 5316.9 5340.0 5342.5 5354.8 5355.9 4713.7 4845.1 4877.8 4888.5 4953.5 5381.5 5392.1 5466.0 5472.3 5480.6 5174.3 5186.7 5232.7 5234.8 5237.7 5128.5 5234.2 5266.1 5270.3 5275.5 5230.2 5239.4 5248.7 5249.3 5303.1 5084.6 5232.1 5239.5 5239.9 5244.4 4361.8 4393.8 4406.1 4407.3 4409.5 3857.7 3893.5 3896.6 3900.1 3901.2 4457.6 4473.7 4474.2 4480.2 4481.5 5300.1 5303.7 5316.0 5327.5 5331.8 4493.5 4506.9 4507.2 4514.1 4551.9 4602.7 4655.0 4708.9 4725.6 4790.8 4907.6 4917.1 4922.4 4923.7 4924.7 5276.2 5289.4 5290.8 5291.8 5293.1 4746.6 4863.5 4869.6 4904.1 4938.5 5175.0 5192.3 5199.2 5205.9 5250.3 5091.7 5256.7 5275.9 5276.5 5282.4 4966.1 5006.1 5010.0 5045.9 5082.3 5063.6 5072.7 5074.0 5078.0 5123.3 4910.8 4943.4 4999.3 5013.2 5061.6 5082.9 5097.2 5115.0 5122.7 5175.7 5009.0 5020.2 5020.9 5025.3 5073.1 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | [#1] ext.html Cycles:180 Average:46898.36 Median:35984.73 stddev:80800.41 (224.5%) stddev-sans-first:80952.15 08:17:30 INFO - PROCESS | 3707 | Values: 554.2 575.3 578.9 580.5 597.6 27048.6 30086.8 30105.8 30112.4 39611.4 37439.0 41669.6 41670.4 41736.4 41741.0 7809.4 7960.3 7965.7 7968.2 7973.0 7508.5 7712.9 7716.5 7823.3 7927.9 10077.1 10366.3 10373.7 10661.5 10679.4 10091.1 10192.3 10194.4 10197.8 10202.7 7483.6 9877.0 10068.5 10147.1 10257.4 38651.6 38878.6 38928.8 38963.2 38992.4 3185.5 3276.3 3290.4 3742.2 3821.1 29276.6 29380.4 30026.5 30259.7 30778.8 3391.0 3419.8 3430.6 3447.7 3478.7 245344.0 245360.0 245563.0 246287.0 246550.0 54423.2 54667.5 54812.0 54824.7 54861.0 57092.0 57441.0 57537.1 57540.1 57548.8 14896.3 15456.8 15463.4 15466.7 15474.9 10407.2 10538.7 10843.5 10851.9 11072.1 16014.5 16149.7 16285.6 16755.7 16971.6 6125.4 6246.4 6275.2 6301.3 6358.7 796.7 935.2 945.5 977.8 982.6 27218.9 28359.6 28434.9 29039.0 29080.4 973.0 981.4 1002.2 1100.5 1107.8 14807.6 15036.8 15130.4 15144.5 15174.5 362632.0 362678.0 363858.0 364745.0 365763.0 50974.0 51396.0 51521.5 51537.7 51590.0 1055.2 1094.4 1138.5 1193.2 1226.8 27436.9 29379.3 29530.9 30138.8 30633.5 43277.0 43532.0 43771.3 43794.6 43829.6 300306.0 303973.0 304165.0 304204.0 304363.0 31346.8 37553.0 38714.2 38975.6 42386.8 38009.8 43207.8 43367.1 44125.0 44544.8 35816.0 36904.6 37214.4 37224.6 37457.3 36406.8 36657.5 36903.4 37101.4 37590.4 35640.5 36153.5 36307.3 36443.0 36575.0 32124.4 32676.8 32920.5 33232.3 33456.7 25109.0 25119.7 25256.7 25611.2 25833.5 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | [#2] jquery.html Cycles:180 Average:23457.01 Median:2084.16 stddev:61971.23 (2973.4%) stddev-sans-first:62120.82 08:17:30 INFO - PROCESS | 3707 | Values: 368.9 369.6 369.9 379.5 390.5 15774.0 16025.0 16959.0 16963.2 16984.9 15443.6 16181.9 16939.5 16963.9 16969.6 5169.5 5336.0 5374.6 5374.8 5375.9 3788.9 3940.0 5274.3 5914.3 6270.7 6307.0 6309.7 6330.7 6331.1 6333.4 6043.5 6173.3 6192.3 6296.5 6298.9 3417.5 5112.9 5318.0 5440.5 5453.9 19764.6 20433.4 20539.4 20660.5 20680.3 1923.4 1936.1 1984.5 2024.4 2048.6 13139.8 13179.6 13321.5 13503.7 13599.7 1729.6 1742.0 1764.4 1764.9 1833.4 63428.4 63564.7 64360.7 64363.0 64448.0 9411.4 9471.5 9880.0 9943.3 10067.6 13339.1 13422.0 13422.9 13436.8 13471.3 7198.1 7212.5 7283.4 7456.1 7479.7 6813.8 6868.9 6886.9 6973.7 6983.4 5879.7 5990.6 6124.4 6179.8 6227.0 1523.5 1683.7 1736.9 1741.3 1748.7 871.3 889.6 938.6 952.4 980.3 17029.5 17097.8 17139.8 17791.8 17824.3 875.3 880.4 901.1 934.8 964.2 9788.0 10063.2 10194.2 10204.7 10258.6 370699.4 376851.0 377161.0 378703.0 384543.0 65752.0 65916.7 66002.3 67595.0 67659.7 915.8 933.1 940.2 948.7 950.5 15258.4 15393.0 15596.9 15611.5 15801.4 32424.8 33748.5 33843.0 34672.1 34808.0 42600.8 43568.8 43977.3 45504.3 45694.3 7459.1 7595.8 7607.9 7750.3 7752.9 11621.7 11804.6 11833.6 11923.6 12076.3 9966.4 10359.7 10416.4 10432.5 10526.3 9071.3 10055.3 10278.2 10360.9 10531.7 10374.6 10471.9 10539.7 10629.3 10938.7 7313.5 7441.9 7462.5 7519.4 7622.9 9830.2 10219.5 10485.3 10709.3 10766.4 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | [#3] mootools.html Cycles:180 Average:5270.74 Median:5183.31 stddev:2986.70 (57.6%) stddev-sans-first:2979.35 08:17:30 INFO - PROCESS | 3707 | Values: 1192.5 1366.2 1391.5 1465.7 1633.9 6821.5 7604.4 7785.9 7796.8 8007.6 7780.5 7937.5 7940.8 7946.8 7965.2 1869.1 2141.3 2190.4 2218.6 2232.6 2280.2 2300.4 2303.0 2303.3 2305.6 2168.6 2173.1 2226.6 2230.1 2230.4 1814.3 2101.6 2177.2 2183.5 2204.7 2196.1 2214.0 2220.0 2220.5 2222.5 7972.3 7983.0 7987.3 7991.8 8101.7 4563.8 4616.4 4630.4 4678.1 4680.7 2853.4 2952.9 3063.0 3075.5 3076.0 961.7 962.6 967.5 991.6 997.7 10862.6 10869.0 10911.1 10937.1 10956.8 4196.4 4345.9 4396.1 4408.7 4423.2 9198.0 9242.9 9250.6 9256.0 9268.1 4764.9 4767.0 4771.4 4771.5 4772.1 3769.2 4143.1 4276.7 4283.2 4347.3 3698.4 3758.6 3849.5 3870.8 3874.9 1205.6 1221.8 1226.7 1229.8 1230.8 721.5 786.5 833.9 848.5 848.5 5164.5 5379.6 5392.4 5413.1 5413.5 875.2 885.9 903.3 908.2 912.5 3386.3 3504.4 3504.8 3616.3 3819.2 9864.4 10121.1 10137.2 10168.1 10175.1 9815.4 9925.4 9964.0 9992.6 10004.0 7422.7 7622.8 7633.4 7634.7 7646.6 5202.1 5376.7 5394.6 5448.1 5506.2 9152.7 9166.4 9290.2 9500.2 9519.5 9137.9 9336.7 9372.0 9478.8 9532.0 6315.9 6771.7 6931.2 6988.3 7125.2 7862.8 7884.3 7969.6 7973.3 7992.0 7026.1 7171.9 7199.5 7297.0 7307.7 6970.9 7091.8 7095.8 7129.0 7199.4 5986.7 6163.8 6215.5 6322.7 6322.8 4285.6 4369.6 4404.4 4534.7 4566.3 4640.1 4731.3 4738.9 4803.9 4856.9 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | [#4] prototype.html Cycles:180 Average:4280.35 Median:4890.27 stddev:1238.93 (25.3%) stddev-sans-first:1205.96 08:17:30 INFO - PROCESS | 3707 | Values: 305.9 306.4 308.3 314.5 315.5 4894.7 4920.6 4928.4 4945.7 4955.9 4824.9 4858.5 4881.1 4888.8 4905.0 3627.6 3781.3 3792.9 3866.6 3929.2 3831.7 3882.8 3893.2 3895.5 3908.4 3851.7 3851.8 3859.9 3866.4 3867.0 3670.2 3770.7 3839.5 3842.8 3883.8 3412.8 3414.6 3415.2 3429.8 3439.6 4713.6 4739.6 4744.4 4746.7 4752.4 4228.5 4297.5 4321.5 4404.8 4414.5 5062.5 5065.8 5083.9 5087.3 5118.2 3722.3 3729.0 3737.9 3765.4 3779.6 5145.5 5324.8 5332.8 5340.9 5379.9 3798.3 3851.3 3858.7 3863.3 3863.5 3895.1 3903.4 3911.6 3912.9 3922.9 4386.2 4403.1 4412.9 4416.2 4422.7 4889.8 5162.8 5177.7 5198.1 5218.8 1301.5 1309.4 1313.3 1315.6 1320.3 814.9 825.4 845.3 845.7 854.0 4448.2 4550.8 4557.4 4565.5 4566.0 5293.9 5318.7 5322.6 5330.9 5333.2 4396.9 4496.0 4501.9 4506.8 4529.4 2775.4 2848.0 2854.4 2867.8 2869.9 5000.0 5003.1 5041.2 5043.7 5055.4 5180.6 5468.5 5487.1 5495.1 5509.7 4946.8 4977.3 4978.9 4984.5 4990.5 5258.2 5259.8 5285.2 5293.3 5304.6 4986.9 5244.4 5252.5 5270.7 5304.3 4890.7 4904.8 5015.3 5035.4 5035.5 3629.4 3629.7 3642.7 3645.5 3651.9 5088.9 5296.3 5301.5 5330.1 5341.8 5104.2 5109.7 5117.8 5121.8 5127.7 5138.7 5152.3 5159.5 5187.6 5204.7 4778.8 5071.0 5112.2 5118.7 5122.0 4975.9 5021.7 5209.4 5212.3 5212.5 5104.3 5111.4 5116.9 5121.1 5122.9 08:17:30 INFO - PROCESS | 3707 | 08:17:30 INFO - PROCESS | 3707 | [#5] yui.html Cycles:180 Average:17922.80 Median:4356.78 stddev:25584.77 (587.2%) stddev-sans-first:25623.94 08:17:30 INFO - PROCESS | 3707 | Values: 723.1 727.3 727.4 735.5 774.8 12723.2 13777.7 13895.0 13901.9 13969.9 12339.8 12341.5 12342.1 12410.1 12567.7 615.0 753.6 767.4 771.1 773.5 774.2 775.8 777.2 779.6 780.1 819.7 821.4 822.3 822.4 822.7 640.0 793.3 816.1 818.9 820.0 600.9 601.2 601.3 601.6 601.7 11990.5 12041.6 12049.2 12053.6 12058.8 11739.3 12563.6 12822.2 12999.1 13067.3 11350.0 11528.2 11544.7 11673.8 11943.6 4027.3 4050.7 4101.5 4149.2 4208.9 59905.4 60076.7 60132.4 60145.0 60300.4 9445.8 9478.0 9711.9 9872.8 10082.2 17545.0 17564.9 17566.1 17594.8 17610.2 6712.1 6712.7 6957.1 7025.5 7043.9 3852.7 3919.2 3931.6 4011.3 4073.9 2835.8 2944.5 2944.9 2948.1 2953.6 409.8 484.1 505.0 507.5 553.9 613.7 621.9 625.6 631.7 650.8 8363.2 8462.6 8542.7 8584.6 8608.7 614.1 616.7 619.9 623.8 651.1 4189.7 4214.5 4236.4 4349.3 4364.3 79251.0 100264.0 102577.0 103299.5 104619.5 81928.0 86517.6 86538.0 86955.1 87818.0 75169.0 78471.0 78990.2 79140.2 79294.0 8152.1 8159.5 8200.6 8244.6 8330.6 40957.6 45408.3 45411.5 45967.1 46868.8 44361.6 63291.4 64529.4 65070.7 65665.7 11149.8 11915.6 11948.9 12295.4 12301.9 12416.6 12681.2 12886.9 13623.6 13662.0 11695.6 11713.6 12115.2 12135.3 13257.7 12249.8 12258.2 12404.1 12937.7 12989.0 11765.2 12010.8 12337.3 12437.0 12442.0 10199.2 10358.4 10448.6 10613.2 10739.3 10195.7 10197.7 10281.3 10307.6 10646.8 08:17:30 INFO - PROCESS | 3707 | -------- Summary: end -------- 08:17:30 INFO - PROCESS | 3707 | 08:17:31 INFO - TEST-INFO | 3707: exit 0 08:17:31 INFO - TEST-OK | dromaeo_css | took 1120649ms 08:17:31 INFO - TEST-START | kraken 08:17:31 INFO - operating with platform_type : linux_ 08:17:31 INFO - Initialising browser for kraken test... 08:17:31 INFO - TEST-INFO | started process 3896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx8DLr_/profile http://localhost:36395/getInfo.html) 08:17:35 INFO - PROCESS | 3896 | __metrics Screen width/height:1600/1200 08:17:35 INFO - PROCESS | 3896 | colorDepth:24 08:17:35 INFO - PROCESS | 3896 | Browser inner width/height: 1024/697 08:17:35 INFO - PROCESS | 3896 | __metrics 08:17:36 INFO - PROCESS | 3896 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:17:37 INFO - TEST-INFO | 3896: exit 0 08:17:37 INFO - Browser initialized. 08:17:37 INFO - Running cycle 1/1 for kraken test... 08:17:37 INFO - TEST-INFO | started process 3978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx8DLr_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:50 INFO - PROCESS | 3978 | RSS: Main: 174911488 08:17:50 INFO - PROCESS | 3978 | 08:17:52 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:53 INFO - PROCESS | 3978 | RSS: Main: 233922560 08:17:53 INFO - PROCESS | 3978 | 08:17:56 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-dft) 08:17:57 INFO - PROCESS | 3978 | RSS: Main: 221851648 08:17:57 INFO - PROCESS | 3978 | 08:18:00 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-fft) 08:18:01 INFO - PROCESS | 3978 | RSS: Main: 288378880 08:18:01 INFO - PROCESS | 3978 | 08:18:03 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-oscillator) 08:18:03 INFO - PROCESS | 3978 | RSS: Main: 199245824 08:18:03 INFO - PROCESS | 3978 | 08:18:06 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:06 INFO - PROCESS | 3978 | RSS: Main: 203071488 08:18:06 INFO - PROCESS | 3978 | 08:18:09 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36395/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:10 INFO - PROCESS | 3978 | RSS: Main: 239063040 08:18:10 INFO - PROCESS | 3978 | 08:18:14 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36395/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:14 INFO - PROCESS | 3978 | RSS: Main: 239595520 08:18:14 INFO - PROCESS | 3978 | 08:18:17 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36395/tests/kraken/driver.html?testName=json-parse-financial) 08:18:18 INFO - PROCESS | 3978 | RSS: Main: 239575040 08:18:18 INFO - PROCESS | 3978 | 08:18:19 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:18:20 INFO - PROCESS | 3978 | RSS: Main: 226856960 08:18:20 INFO - PROCESS | 3978 | 08:18:22 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:18:22 INFO - PROCESS | 3978 | RSS: Main: 231657472 08:18:22 INFO - PROCESS | 3978 | 08:18:25 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:18:25 INFO - PROCESS | 3978 | RSS: Main: 238903296 08:18:25 INFO - PROCESS | 3978 | 08:18:28 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:18:29 INFO - PROCESS | 3978 | RSS: Main: 239759360 08:18:29 INFO - PROCESS | 3978 | 08:18:31 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:18:32 INFO - PROCESS | 3978 | RSS: Main: 238804992 08:18:32 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36395/tests/kraken/driver.html?testName=ai-astar) 08:18:34 INFO - PROCESS | 3978 | RSS: Main: 281919488 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | __start_tp_report 08:18:34 INFO - PROCESS | 3978 | _x_x_mozilla_page_load 08:18:34 INFO - PROCESS | 3978 | _x_x_mozilla_page_load_details 08:18:34 INFO - PROCESS | 3978 | |i|pagename|runs| 08:18:34 INFO - PROCESS | 3978 | |0;ai-astar;103;114;114;113;115;113;114;115;112;114 08:18:34 INFO - PROCESS | 3978 | |1;audio-beat-detection;161;131;140;193;139;152;158;141;194;132 08:18:34 INFO - PROCESS | 3978 | |2;audio-dft;160;162;161;161;160;159;163;161;163;160 08:18:34 INFO - PROCESS | 3978 | |3;audio-fft;82;76;78;115;76;76;74;76;99;75 08:18:34 INFO - PROCESS | 3978 | |4;audio-oscillator;87;86;121;86;85;87;116;86;85;132 08:18:34 INFO - PROCESS | 3978 | |5;imaging-gaussian-blur;116;117;118;118;118;118;118;117;117;117 08:18:34 INFO - PROCESS | 3978 | |6;imaging-darkroom;147;147;146;148;147;147;146;148;147;145 08:18:34 INFO - PROCESS | 3978 | |7;imaging-desaturate;95;95;95;94;95;94;95;95;95;95 08:18:34 INFO - PROCESS | 3978 | |8;json-parse-financial;63;67;62;61;61;63;61;63;62;62 08:18:34 INFO - PROCESS | 3978 | |9;json-stringify-tinderbox;64;64;65;64;65;65;64;64;67;70 08:18:34 INFO - PROCESS | 3978 | |10;stanford-crypto-aes;82;81;81;83;82;83;83;83;92;83 08:18:34 INFO - PROCESS | 3978 | |11;stanford-crypto-ccm;133;128;133;131;129;131;125;129;134;132 08:18:34 INFO - PROCESS | 3978 | |12;stanford-crypto-pbkdf2;171;173;172;170;169;168;166;167;168;175 08:18:34 INFO - PROCESS | 3978 | |13;stanford-crypto-sha256-iterative;70;68;70;67;67;66;67;67;66;66 08:18:34 INFO - PROCESS | 3978 | __end_tp_report 08:18:34 INFO - PROCESS | 3978 | __start_cc_report 08:18:34 INFO - PROCESS | 3978 | _x_x_mozilla_cycle_collect,1884 08:18:34 INFO - PROCESS | 3978 | __end_cc_report 08:18:34 INFO - PROCESS | 3978 | __startTimestamp1466608714618__endTimestamp 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | ------- Summary: start ------- 08:18:34 INFO - PROCESS | 3978 | Number of tests: 14 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.53 (3.1%) stddev-sans-first:0.97 08:18:34 INFO - PROCESS | 3978 | Values: 103.0 114.0 114.0 113.0 115.0 113.0 114.0 115.0 112.0 114.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:155.00 stddev:23.08 (14.9%) stddev-sans-first:24.34 08:18:34 INFO - PROCESS | 3978 | Values: 161.0 131.0 140.0 193.0 139.0 152.0 158.0 141.0 194.0 132.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.36 08:18:34 INFO - PROCESS | 3978 | Values: 160.0 162.0 161.0 161.0 160.0 159.0 163.0 161.0 163.0 160.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.52 (17.8%) stddev-sans-first:14.34 08:18:34 INFO - PROCESS | 3978 | Values: 82.0 76.0 78.0 115.0 76.0 76.0 74.0 76.0 99.0 75.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:86.00 stddev:18.30 (21.3%) stddev-sans-first:19.04 08:18:34 INFO - PROCESS | 3978 | Values: 87.0 86.0 121.0 86.0 85.0 87.0 116.0 86.0 85.0 132.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 08:18:34 INFO - PROCESS | 3978 | Values: 116.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 08:18:34 INFO - PROCESS | 3978 | Values: 147.0 147.0 146.0 148.0 147.0 147.0 146.0 148.0 147.0 145.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:18:34 INFO - PROCESS | 3978 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:1.78 (2.8%) stddev-sans-first:1.88 08:18:34 INFO - PROCESS | 3978 | Values: 63.0 67.0 62.0 61.0 61.0 63.0 61.0 63.0 62.0 62.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.93 (3.0%) stddev-sans-first:2.00 08:18:34 INFO - PROCESS | 3978 | Values: 64.0 64.0 65.0 64.0 65.0 65.0 64.0 64.0 67.0 70.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:3.16 (3.8%) stddev-sans-first:3.32 08:18:34 INFO - PROCESS | 3978 | Values: 82.0 81.0 81.0 83.0 82.0 83.0 83.0 83.0 92.0 83.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:131.50 stddev:2.76 (2.1%) stddev-sans-first:2.77 08:18:34 INFO - PROCESS | 3978 | Values: 133.0 128.0 133.0 131.0 129.0 131.0 125.0 129.0 134.0 132.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.50 stddev:2.85 (1.7%) stddev-sans-first:2.99 08:18:34 INFO - PROCESS | 3978 | Values: 171.0 173.0 172.0 170.0 169.0 168.0 166.0 167.0 168.0 175.0 08:18:34 INFO - PROCESS | 3978 | 08:18:34 INFO - PROCESS | 3978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.51 (2.2%) stddev-sans-first:1.27 08:18:34 INFO - PROCESS | 3978 | Values: 70.0 68.0 70.0 67.0 67.0 66.0 67.0 67.0 66.0 66.0 08:18:34 INFO - PROCESS | 3978 | -------- Summary: end -------- 08:18:34 INFO - PROCESS | 3978 | 08:18:35 INFO - TEST-INFO | 3978: exit 0 08:18:35 INFO - TEST-OK | kraken | took 64393ms 08:18:35 INFO - SUITE-END | took 1185s 08:18:35 INFO - Completed test suite (00:19:45) 08:18:35 INFO - javascript benchmark 08:18:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.2643659775263, 2634.6443230163923, 2670.212287375224, 2674.5453272943596, 2684.8791804368802, 4659.720416774996, 4667.953320466794, 4768.499307572698, 4778.0, 4861.73260470674, 4845.3216549683075, 4874.853754387365, 4889.9755501222535, 4901.1177987962155, 4911.410630724309, 4432.822687092513, 4470.7317560946285, 4508.075844451896, 4579.954200458003, 4600.309953506967, 4496.640268778507, 4536.138133754593, 4551.5676010778925, 4555.066211426666, 4584.656150788687, 4330.610245077958, 4364.301711726109, 4396.472423309191, 4408.823647054114, 4413.646908247332, 4458.197524445599, 4462.933056004163, 4463.531329210451, 4518.43519560055, 4572.199865023607, 4492.730436173807, 4510.639148868083, 4517.299818528133, 4520.0, 4566.45202575693, 4829.1790395632825, 4841.878953026167, 4890.0953323634885, 4944.33251511045, 4992.850214493571, 5290.994711004897, 5300.681959082467, 5314.893702125974, 5318.149096144598, 5318.30861987943, 5316.946830531684, 5340.038793017256, 5342.545883599899, 5354.759035843357, 5355.892882142374, 4713.67004309695, 4845.1278769821065, 4877.804887804448, 4888.5111488850835, 4953.45511993684, 5381.542568881689, 5392.05639013179, 5465.9726701366235, 5472.315960504937, 5480.616356854982, 5174.275601415805, 5186.662866913639, 5232.659877107976, 5234.790608375699, 5237.685738855681, 5128.487151284841, 5234.18870075139, 5266.10476219036, 5270.341207349082, 5275.498827611371, 5230.189320655304, 5239.423663397023, 5248.685078895279, 5249.343832020997, 5303.124984377535, 5084.593232541388, 5232.136697444879, 5239.5284424401225, 5239.869003274873, 5244.396894357198, 4361.80371883266, 4393.802278897458, 4406.1187762447635, 4407.272799987966, 4409.5149533551285, 3857.7106716996336, 3893.53277606689, 3896.551896531935, 3900.1224724436775, 3901.239258344652, 4457.554244575516, 4473.6868419211, 4474.172278128557, 4480.238359478896, 4481.484629267611, 5300.072487314705, 5303.7348132593215, 5316.0, 5327.467253274719, 5331.786728530893, 4493.460784705856, 4506.864794056183, 4507.166174257773, 4514.10533244902, 4551.886202844889, 4602.723836569749, 4655.0, 4708.929366059512, 4725.64557658177, 4790.8323208687525, 4907.55831975124, 4917.0903382874285, 4922.3847019121895, 4923.704577725348, 4924.72913989734, 5276.234945932895, 5289.3652761668845, 5290.81482148123, 5291.814786482455, 5293.100172970681, 4746.644001699818, 4863.4650188479945, 4869.610431165569, 4904.117258893433, 4938.506149385176, 5175.042617115846, 5192.324997750268, 5199.168133098686, 5205.869853253699, 5250.26496290512, 5091.719955402488, 5256.684598923924, 5275.8681032972945, 5276.472352764847, 5282.366116066097, 4966.081274964144, 5006.0738763327445, 5010.048090862724, 5045.899082018413, 5082.263071854634, 5063.620228482805, 5072.721000345016, 5074.035933172685, 5078.035173317058, 5123.308353372247, 4910.8281210157475, 4943.406791185081, 4999.250112483157, 5013.197888337849, 5061.595072394126, 5082.898342033212, 5097.184450488053, 5115.0, 5122.743862806919, 5175.715335656575, 5009.0, 5020.221865610836, 5020.949790502194, 5025.321581586585, 5073.11220536412], "value": 4799.196017430437, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.165526408382, 575.278026077273, 578.8755417585219, 580.4804699793684, 597.5787070115567, 27048.594271085924, 30086.849565752196, 30105.849470752644, 30112.397752044944, 39611.40582891259, 37439.0, 41669.58330416695, 41670.37494437586, 41736.373954390634, 41741.0, 7809.375249980002, 7960.283574478296, 7965.72119975801, 7968.163342848975, 7973.0, 7508.511946723473, 7712.922870771305, 7716.537007779523, 7823.3350165236025, 7927.881081783749, 10077.093061624453, 10366.326188797704, 10373.688789336333, 10661.520231589559, 10679.41263230522, 10091.142252908512, 10192.337498062601, 10194.388336699822, 10197.847032294521, 10202.693919182437, 7483.6258187090425, 9876.95061524695, 10068.546915388752, 10147.137493313003, 10257.384556926609, 38651.61348386537, 38878.61121388806, 38928.80535597332, 38963.22073558541, 38992.41511377331, 3185.5221716742444, 3276.3447310537986, 3290.4241757692307, 3742.1580144467275, 3821.1402434452025, 29276.560851587245, 29380.41239175226, 30026.549601755993, 30259.697403025908, 30778.846105769328, 3391.0, 3419.8290085495873, 3430.5711786026745, 3447.7241820654285, 3478.7043101336417, 245344.0, 245360.0, 245563.0, 246287.0, 246550.0, 54423.18365224525, 54667.45332546703, 54812.0, 54824.725876370365, 54861.0, 57092.0, 57441.0, 57537.13694294589, 57540.13689794656, 57548.84902302014, 14896.255187240595, 15456.845431545766, 15463.38146474151, 15466.690666186612, 15474.922625386802, 10407.167426605853, 10538.683839484827, 10843.45782710877, 10851.945740271249, 11072.058874995555, 16014.519564413085, 16149.67700646004, 16285.59286017859, 16755.748663770053, 16971.575710607085, 6125.418085281891, 6246.3753624637175, 6275.215598050244, 6301.306856245809, 6358.713857876407, 796.653455746752, 935.2190920581255, 945.4610871803144, 977.8337682593976, 982.6266018912768, 27218.863905680344, 28359.57460638092, 28434.87814622461, 29039.0, 29080.418391632047, 972.9805403891883, 981.3768257156756, 1002.2332915319786, 1100.5047728522197, 1107.8426484519216, 14807.555773326818, 15036.849631503765, 15130.394784208509, 15144.54566363011, 15174.468893588672, 362632.0, 362678.0, 363858.0, 364745.0, 365763.0, 50974.0, 51396.0, 51521.48478515167, 51537.7423112882, 51590.0, 1055.2138656700806, 1094.3762055628215, 1138.4535422997174, 1193.1528614683673, 1226.7607816475702, 27436.862815685792, 29379.265518362212, 29530.852345738993, 30138.849305754207, 30633.54049689301, 43277.0, 43532.0, 43771.343429849214, 43794.56205437905, 43829.56170438255, 300306.0, 303973.0, 304165.0, 304204.0, 304363.0, 31346.843265783526, 37553.0, 38714.22571548497, 38975.61024389833, 42386.788066059475, 38009.80995095007, 43207.78396107999, 43367.132657347305, 44125.0, 44544.77727611341, 35816.0, 36904.63095369012, 37214.44178337381, 37224.62775372212, 37457.25085498329, 36406.81796591, 36657.45013824741, 36903.44644830276, 37101.443478347304, 37590.43614345841, 35640.4653930186, 36153.45769813402, 36307.27385452329, 36443.0, 36575.0, 32124.357512849143, 32676.83661581677, 32920.45829129616, 33232.335353292314, 33456.66543334633, 25109.0, 25119.744012799652, 25256.74743252544, 25611.231663050137, 25833.483330333664], "value": 18105.233147577437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.88933320003997, 369.6451406649616, 369.92971335446265, 379.4611651454934, 390.52746177125675, 15774.0, 16025.0, 16959.0, 16963.236654350552, 16984.915075424622, 15443.613909652237, 16181.919090404532, 16939.491815245532, 16963.91518042408, 16969.57576060596, 5169.457206993268, 5335.973320133413, 5374.6237763356585, 5374.7850085996515, 5375.892482150374, 3788.867389641363, 3939.9606003940025, 5274.314339135926, 5914.349421563625, 6270.65511396873, 6306.968465157691, 6309.716062777163, 6330.746770129213, 6331.081993111019, 6333.366663333676, 6043.546733994924, 6173.2900716417735, 6192.256929168529, 6296.464800491964, 6298.87402251957, 3417.5215469834243, 5112.948870511284, 5318.042752304584, 5440.537554307889, 5453.863653408657, 19764.604707905906, 20433.386998390073, 20539.38381848547, 20660.483487912923, 20680.276190333265, 1923.3652894544907, 1936.1190658250462, 1984.4641946674317, 2024.3926821953503, 2048.6107639548586, 13139.817416432472, 13179.60461186166, 13321.533746318832, 13503.729925401436, 13599.728005439836, 1729.57625381781, 1741.9912900435543, 1764.3912850066706, 1764.9117544122741, 1833.4316361927845, 63428.36571634317, 63564.68217658928, 64360.67819660919, 64363.0, 64448.0, 9411.43531388119, 9471.526423678788, 9880.0, 9943.303968722264, 10067.59729610822, 13339.066265361525, 13422.0, 13422.865771342356, 13436.798448023288, 13471.326433678278, 7198.100237470317, 7212.531185472927, 7283.397652516438, 7456.142543607446, 7479.70081196746, 6813.7955861324235, 6868.931310686829, 6886.931130688729, 6973.686184121727, 6983.406410455066, 5879.7060146993335, 5990.64056156632, 6124.391477210693, 6179.752809887644, 6226.968865155736, 1523.5200911712775, 1683.7221858393227, 1736.887102338344, 1741.2773698915062, 1748.6590114927722, 871.263782104121, 889.6485888074175, 938.596403546468, 952.4142652268805, 980.3235767320526, 17029.48911532656, 17097.829021709873, 17139.828601714074, 17791.822081779275, 17824.287028518713, 875.2516598308482, 880.3749337970113, 901.085398320705, 934.780326623243, 964.2478866484154, 9787.951060244653, 10063.19494440443, 10194.184465242763, 10204.687623723254, 10258.640947566799, 370699.4395084076, 376851.0, 377161.0, 378703.0, 384543.0, 65752.0, 65916.67041664761, 66002.33997660058, 67595.0, 67659.66170169118, 915.8351496730652, 933.1088810186255, 940.1585580905052, 948.7059011706256, 950.5247376311844, 15258.389664413744, 15393.0, 15596.92201538985, 15611.531654050397, 15801.446949356718, 32424.83787581047, 33748.49377259392, 33843.0, 34672.133196670286, 34808.0, 42600.78699606606, 43568.782156089015, 43977.34033989557, 45504.31743523916, 45694.314585281914, 7459.142198647008, 7595.848083038419, 7607.88588171189, 7750.302472777477, 7752.883706744291, 11621.6513504595, 11804.586839460577, 11833.644990650295, 11923.642290730944, 12076.275423474619, 9966.40201587907, 10359.741006474596, 10416.427096509462, 10432.478376081013, 10526.31578947366, 9071.274298056273, 10055.346402483816, 10278.229132814919, 10360.948195259278, 10531.684049478528, 10374.636887708893, 10471.895281047093, 10539.683809485728, 10629.25595208328, 10938.726531836768, 7313.524620899624, 7441.888371674538, 7462.4776265660885, 7519.398448124246, 7622.923770762443, 9830.164436022733, 10219.489025548544, 10485.318454300446, 10709.250352475252, 10766.438866364177], "value": 8332.646747160015, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1192.511070461111, 1366.24856329019, 1391.4781956766212, 1465.7141857337817, 1633.9428120015803, 6821.522493425462, 7604.429667774912, 7785.883211751814, 7796.766097017085, 8007.599620019005, 7780.455368124233, 7937.4840635358805, 7940.801479963004, 7946.801329966754, 7965.203479652047, 1869.1495369606796, 2141.3468891987936, 2190.3538456155393, 2218.589560931233, 2232.57581059599, 2280.2361208995007, 2300.3903965449167, 2302.9539409211807, 2303.2629558541275, 2305.596520608895, 2168.5879682860286, 2173.054721196285, 2226.599212141814, 2230.063373383183, 2230.364346161336, 1814.2652225848553, 2101.558672678739, 2177.194438057929, 2183.530540933691, 2204.6582779669097, 2196.0556960506974, 2214.0, 2220.034285085993, 2220.455988282881, 2222.511047569532, 7972.322352600036, 7982.9600851995365, 7987.281144696947, 7991.8401631967035, 8101.716439924633, 4563.794629241659, 4616.39986801717, 4630.398048253705, 4678.134545109166, 4680.695754775928, 2853.372258103214, 2952.9261768455744, 3062.9846850765603, 3075.5079187330143, 3076.015674984006, 961.6922584772875, 962.6149540183912, 967.4727273635885, 991.6430085169334, 997.6607953295842, 10862.565497380174, 10869.0, 10911.07255883251, 10937.125029997582, 10956.780864382747, 4196.433481480022, 4345.869623911288, 4396.120775844844, 4408.691391602557, 4423.181711383404, 9198.0, 9242.86135707965, 9250.583723732449, 9255.95372023149, 9268.073192680813, 4764.904701905943, 4766.95233047672, 4771.427428708577, 4771.475137734847, 4772.0694464579765, 3769.1707824279165, 4143.0678097428445, 4276.679249056333, 4283.164782867373, 4347.3261644445165, 3698.3712768828827, 3758.586555478895, 3849.480320156743, 3870.787106709102, 3874.9225015499533, 1205.6081773423498, 1221.7861874171983, 1226.7117227451542, 1229.8032314829763, 1230.8399908011902, 721.5346101764437, 786.5084322298563, 833.9166083391613, 848.4569875279826, 848.4909054567211, 5164.509371609691, 5379.601303660998, 5392.352917649907, 5413.052715774802, 5413.5263537546325, 875.1904488348252, 885.8848349714495, 903.3495882964255, 908.1917093786535, 912.5026860361119, 3386.255023894739, 3504.3867323218333, 3504.7546671732734, 3616.2752365064025, 3819.1788765415567, 9864.358816677037, 10121.139703125316, 10137.189024877993, 10168.084872361524, 10175.08424241807, 9815.36200146988, 9925.3548519346, 9964.0, 9992.550335234931, 10004.0, 7422.665980030912, 7622.8094297643, 7633.351165151024, 7634.656440460304, 7646.617669116522, 5202.115640341075, 5376.650517716336, 5394.568434525307, 5448.073827449264, 5506.174073888948, 9152.725418237464, 9166.404183728037, 9290.210332121575, 9500.192483638692, 9519.476428796483, 9137.908620913971, 9336.719898403058, 9371.953140234255, 9478.763030924281, 9532.0, 6315.873682526232, 6771.729130834711, 6931.202911665223, 6988.266232045766, 7125.216226215216, 7862.764117076496, 7884.29041386278, 7969.561674107979, 7973.322267607086, 7992.040955085427, 7026.086608740831, 7171.892421613784, 7199.532030418006, 7297.0, 7307.744228951961, 6970.860582788418, 7091.82270443243, 7095.787126386217, 7129.0, 7199.424046076406, 5986.700664966647, 6163.7842675506145, 6215.533834962305, 6322.747090116344, 6322.841928951813, 4285.571442855814, 4369.606735393702, 4404.427424434803, 4534.727916325031, 4566.26939689648, 4640.071985602825, 4731.313959475788, 4738.881527961828, 4803.903921921612, 4856.902861942671], "value": 4224.932136456041, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.8638905686969, 306.3566510328311, 308.32630701916315, 314.50308512550174, 315.5030826448344, 4894.681845680028, 4920.581750551203, 4928.3593132892765, 4945.749683893829, 4955.900881982358, 4824.855254342376, 4858.4898585648525, 4881.145799485093, 4888.804447822083, 4905.0, 3627.6009638939695, 3781.3004594150034, 3792.886213413602, 3866.574676785551, 3929.1552316252, 3831.731778775487, 3882.8058597070176, 3893.2213557288514, 3895.4935858338376, 3908.394198899161, 3851.6533511983916, 3851.826667799956, 3859.903502412434, 3866.4007078902814, 3867.0, 3670.1742108025614, 3770.7360484766077, 3839.500864887547, 3842.8078596070086, 3883.805809709503, 3412.77816941898, 3414.590249170091, 3415.214500664861, 3429.7770644908, 3439.6044454887756, 4713.599344055725, 4739.620830333565, 4744.430668319824, 4746.667733258673, 4752.405949256343, 4228.492580890313, 4297.484301883763, 4321.459817522809, 4404.779761011937, 4414.53647367025, 5062.519060689266, 5065.822696205652, 5083.872903177413, 5087.26234695967, 5118.206677964921, 3722.348588996942, 3728.9813550932345, 3737.906552336186, 3765.4163604641326, 3779.622037796226, 5145.485451454862, 5324.76359928827, 5332.800119972975, 5340.863654538177, 5379.919301210485, 3798.3163030654196, 3851.345271303885, 3858.6720128788807, 3863.265979463893, 3863.5363756349416, 3895.14306852492, 3903.414487826792, 3911.5501717302873, 3912.9217415652097, 3922.9019274517796, 4386.214753631403, 4403.097365040159, 4412.933805992912, 4416.205083085076, 4422.71252368595, 4889.804407823718, 5162.793488260428, 5177.689338639693, 5198.116320225571, 5218.791248350023, 1301.4989229146847, 1309.3845892430543, 1313.2514466754048, 1315.5724389573427, 1320.3002408723391, 814.9470284431611, 825.3685930263354, 845.2519520224522, 845.691322667222, 854.0349405172116, 4448.199324121624, 4550.840720574764, 4557.430321209848, 4565.474970378383, 4565.977170114194, 5293.947060529345, 5318.680879147263, 5322.600804939645, 5330.946690533123, 5333.173358129496, 4396.890077748082, 4495.955040449619, 4501.8616157325005, 4506.81972721094, 4529.411176547093, 2775.3894143288444, 2847.985760071186, 2854.4005758790886, 2867.827930324187, 2869.899553515617, 4999.950000500021, 5003.149464591028, 5041.193409054534, 5043.722595257223, 5055.393352797614, 5180.565134386832, 5468.48049435303, 5487.106948102898, 5495.148252020943, 5509.669419834822, 4946.77395172174, 4977.282837421084, 4978.850634480971, 4984.501549844987, 4990.500949905053, 5258.158694608845, 5259.815906443256, 5285.207218917193, 5293.2589437479555, 5304.602154838325, 4986.850394488171, 5244.396894357198, 5252.527272545489, 5270.735023594387, 5304.336957880265, 4890.731009794496, 4904.828331008541, 5015.3480047593575, 5035.395752509576, 5035.496450354935, 3629.4374371972385, 3629.727770417282, 3642.7085833133815, 3645.489631451652, 3651.8904432867057, 5088.923666144937, 5296.3379577552805, 5301.469853014822, 5330.147176451749, 5341.813036543703, 5104.2088476286235, 5109.6678715883345, 5117.769700363567, 5121.770775014044, 5127.692338459704, 5138.743062846917, 5152.27868098474, 5159.458256882973, 5187.610929180402, 5204.724842413633, 4778.808847646055, 5071.0, 5112.207607820794, 5118.692878427306, 5122.0, 4975.900481990412, 5021.694359466492, 5209.4009188943755, 5212.348456442945, 5212.452692467236, 5104.259882316969, 5111.364363403675, 5116.927644304063, 5121.103806833864, 5122.871928201825], "value": 3884.652015181058, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.106962900817, 727.3344889426176, 727.3962611032844, 735.521601580823, 774.7636970723927, 12723.236605803646, 13777.655558611039, 13895.0, 13901.860981390184, 13969.930150349246, 12339.814902776443, 12341.5063397464, 12342.07434442416, 12410.069244806653, 12567.748645027117, 615.0374663651371, 753.6231884057971, 767.4090949968521, 771.1324759645399, 773.5126870071847, 774.1716363491067, 775.806048487878, 777.2111307023375, 779.5673401262297, 780.063923292049, 819.6967122164807, 821.3962737388015, 822.2887202569764, 822.3955392786297, 822.6585966823761, 640.0431355124073, 793.2583034862394, 816.073756286613, 818.8976377952756, 819.9914105650084, 600.9429104235135, 601.2034054877262, 601.2994860986945, 601.5879122800895, 601.6781022153127, 11990.520379184822, 12041.578544750979, 12049.216800907912, 12053.57812476559, 12058.758824823455, 11739.295642261492, 12563.560275390317, 12822.230666159967, 12999.090063695545, 13067.346632668423, 11349.978501934866, 11528.193026488148, 11544.711382215428, 11673.824892626533, 11943.641690749291, 4027.3153563894207, 4050.675945924319, 4101.4668093148, 4149.232392007489, 4208.884645568926, 59905.40094599042, 60076.699616502076, 60132.398676013116, 60144.99999999956, 60300.396996029915, 9445.811083778286, 9478.0, 9711.854322185172, 9872.753181170385, 10082.243831712503, 17545.035023073597, 17564.912175439298, 17566.12169391551, 17594.824051759573, 17610.2075406607, 6712.127423434922, 6712.697928593225, 6957.130358705162, 7025.508214424941, 7043.894341584778, 3852.749571277858, 3919.1573811630064, 3931.5871833457645, 4011.3180759270995, 4073.91852162961, 2835.787315951312, 2944.4994350960387, 2944.9411011779644, 2948.1450379389735, 2953.61602991614, 409.78076728949867, 484.08024752968936, 504.95202955719145, 507.46969416959365, 553.914143307788, 613.6808859393179, 621.9191505104308, 625.6371304643296, 631.6778442994014, 650.8242774450966, 8363.205495478041, 8462.576871156418, 8542.74371768848, 8584.613692383859, 8608.698695545625, 614.115673430268, 616.7378863982879, 619.8822223777468, 623.8409205652621, 651.081974416071, 4189.685773566995, 4214.473190851144, 4236.364545318165, 4349.3041113421705, 4364.258076127066, 79251.0, 100264.0, 102577.0, 103299.483502582, 104619.47690261652, 81928.0, 86517.5674121638, 86538.0, 86955.1304486947, 87818.0, 75169.0, 78471.0, 78990.21009789943, 79140.20859791328, 79294.0, 8152.103268640326, 8159.46963447374, 8200.589970501333, 8244.628991695508, 8330.625121869409, 40957.590424095375, 45408.31887521624, 45411.545884540734, 45967.080658385974, 46868.7656561715, 44361.55638443703, 63291.367086328544, 64529.35470645234, 65070.67464662647, 65665.67167164134, 11149.777004460027, 11915.582954596548, 11948.880511194777, 12295.385230738606, 12301.938490307492, 12416.565420210249, 12681.175723577939, 12886.871131288568, 13623.591292261248, 13662.0, 11695.590654327058, 11713.648590542298, 12115.212511186744, 12135.271883687006, 13257.734845303234, 12249.755004900031, 12258.20321679088, 12404.069694773108, 12937.676558086123, 12989.0, 11765.235259708092, 12010.75978480408, 12337.321447320124, 12437.0, 12442.0, 10199.235057370579, 10358.430286334324, 10448.634297799845, 10613.150947924301, 10739.301945373525, 10195.694129176136, 10197.745056373353, 10281.280310378203, 10307.639232626821, 10646.787064258826], "value": 6696.288235996271, "unit": "score"}], "name": "dromaeo_css", "value": 6558.457615293051, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 113.0, 115.0, 113.0, 114.0, 115.0, 112.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 131.0, 140.0, 193.0, 139.0, 152.0, 158.0, 141.0, 194.0, 132.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 160.0, 159.0, 163.0, 161.0, 163.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 78.0, 115.0, 76.0, 76.0, 74.0, 76.0, 99.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 121.0, 86.0, 85.0, 87.0, 116.0, 86.0, 85.0, 132.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0, 145.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 62.0, 61.0, 61.0, 63.0, 61.0, 63.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 67.0, 70.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 83.0, 82.0, 83.0, 83.0, 83.0, 92.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 133.0, 131.0, 129.0, 131.0, 125.0, 129.0, 134.0, 132.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 172.0, 170.0, 169.0, 168.0, 166.0, 167.0, 168.0, 175.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 70.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1545.4, "alertThreshold": 2.0}]} 08:18:35 INFO - Return code: 0 08:18:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:18:35 INFO - # TBPL SUCCESS # 08:18:35 INFO - Running post-action listener: _resource_record_post_action 08:18:35 INFO - ##### 08:18:35 INFO - ##### Finished run-tests step (success) 08:18:35 INFO - ##### 08:18:35 INFO - Running post-run listener: _resource_record_post_run 08:18:36 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 298541056; Read time: 0; Write time: 185312 08:18:36 INFO - TinderboxPrint: CPU usage
13.2% 08:18:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:18:36 INFO - TinderboxPrint: I/O write bytes / time
298,541,056 / 185,312 08:18:36 INFO - TinderboxPrint: CPU idle
8,328.5 (86.8%) 08:18:36 INFO - TinderboxPrint: CPU user
1,217.5 (12.7%) 08:18:36 INFO - TinderboxPrint: Swap in / out
0 / 0 08:18:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14471168; Read time: 0; Write time: 4052 08:18:36 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 282537984; Read time: 0; Write time: 181168 08:18:36 INFO - Running post-run listener: _upload_blobber_files 08:18:36 INFO - Blob upload gear active. 08:18:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:18:36 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:18:36 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:18:36 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:18:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:40 INFO - (blobuploader) - INFO - Done attempting. 08:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:41 INFO - (blobuploader) - INFO - Done attempting. 08:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:41 INFO - (blobuploader) - INFO - Done attempting. 08:18:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:18:41 INFO - Return code: 0 08:18:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:18:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:18:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb6de4ef95b7b0255254f0ccd1ba88a4dd600cc48b70f30059aab02c2abbac512442d561737b40affa9ae2553ff5938b60aa3cfb3d3dbf4f7d5f95455e73f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46a4b7c89ae1abdd0f91c289926ccb3a0f84a106a2da18ca12509ba8c0404d01a1cceeac0b834e8a445e2b632a104a33250911f582ce534b21d4f77f4cebad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d366168d5737e7c315bdcf5f7f8668cda1db2e91e4baaa15df8a3172bb6169e5342ba52de88f060f46c92b81d3075be6032e32e2838c083e7afff23bdc16c9a3"} 08:18:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:18:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:18:41 INFO - Contents: 08:18:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb6de4ef95b7b0255254f0ccd1ba88a4dd600cc48b70f30059aab02c2abbac512442d561737b40affa9ae2553ff5938b60aa3cfb3d3dbf4f7d5f95455e73f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46a4b7c89ae1abdd0f91c289926ccb3a0f84a106a2da18ca12509ba8c0404d01a1cceeac0b834e8a445e2b632a104a33250911f582ce534b21d4f77f4cebad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d366168d5737e7c315bdcf5f7f8668cda1db2e91e4baaa15df8a3172bb6169e5342ba52de88f060f46c92b81d3075be6032e32e2838c083e7afff23bdc16c9a3"} 08:18:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:18:41 INFO - Copying logs to upload dir... 08:18:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:18:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1335.064345 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 15 secs) (at 2016-06-22 08:18:42.089046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:42.096945) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb6de4ef95b7b0255254f0ccd1ba88a4dd600cc48b70f30059aab02c2abbac512442d561737b40affa9ae2553ff5938b60aa3cfb3d3dbf4f7d5f95455e73f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46a4b7c89ae1abdd0f91c289926ccb3a0f84a106a2da18ca12509ba8c0404d01a1cceeac0b834e8a445e2b632a104a33250911f582ce534b21d4f77f4cebad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d366168d5737e7c315bdcf5f7f8668cda1db2e91e4baaa15df8a3172bb6169e5342ba52de88f060f46c92b81d3075be6032e32e2838c083e7afff23bdc16c9a3"} build_url:https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb6de4ef95b7b0255254f0ccd1ba88a4dd600cc48b70f30059aab02c2abbac512442d561737b40affa9ae2553ff5938b60aa3cfb3d3dbf4f7d5f95455e73f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a46a4b7c89ae1abdd0f91c289926ccb3a0f84a106a2da18ca12509ba8c0404d01a1cceeac0b834e8a445e2b632a104a33250911f582ce534b21d4f77f4cebad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d366168d5737e7c315bdcf5f7f8668cda1db2e91e4baaa15df8a3172bb6169e5342ba52de88f060f46c92b81d3075be6032e32e2838c083e7afff23bdc16c9a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:42.121354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:42.124716) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466606547.82679-2085924730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:42.174299) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 08:18:42.174649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 08:18:42.174968) ========= ========= Total master_lag: 0.69 =========