builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1462122034.43 results: success (0) buildid: 20160501073345 builduid: 84b8b646b7eb4e8fba42a15b48c15ad1 revision: d2798011f1bb59095fe9c1fdb58b2d7414cd5562 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.435425) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.435947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.436265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.468510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.468854) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-01 10:00:34-- 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% 46.2M=0s 2016-05-01 10:00:34 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122539 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.615207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.615520) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014813 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.666696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:34.667069) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2798011f1bb59095fe9c1fdb58b2d7414cd5562 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2798011f1bb59095fe9c1fdb58b2d7414cd5562 --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=e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-01 10:00:34,950 truncating revision to first 12 chars 2016-05-01 10:00:34,950 Setting DEBUG logging. 2016-05-01 10:00:34,950 attempt 1/10 2016-05-01 10:00:34,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2798011f1bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-01 10:00:35,224 unpacking tar archive at: mozilla-inbound-d2798011f1bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:35.245640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:35.246006) ========= script_repo_revision: d2798011f1bb59095fe9c1fdb58b2d7414cd5562 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:35.246447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:35.246754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 10:00:35.255452) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 26 secs) (at 2016-05-01 10:00:35.255755) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:35 INFO - MultiFileLogger online at 20160501 10:00:35 in /builds/slave/test 10:00:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:00:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:35 INFO - {'append_to_log': False, 10:00:35 INFO - 'base_work_dir': '/builds/slave/test', 10:00:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:00:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:35 INFO - 'branch': 'Mozilla-Inbound', 10:00:35 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:35 INFO - 'config_files': ('talos/linux_config.py',), 10:00:35 INFO - 'default_actions': ('clobber', 10:00:35 INFO - 'read-buildbot-config', 10:00:35 INFO - 'download-and-extract', 10:00:35 INFO - 'populate-webroot', 10:00:35 INFO - 'create-virtualenv', 10:00:35 INFO - 'install', 10:00:35 INFO - 'run-tests'), 10:00:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:35 INFO - 'download_minidump_stackwalk': True, 10:00:35 INFO - 'download_symbols': 'ondemand', 10:00:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:35 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:35 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:35 INFO - 'installer_path': 'installer.exe', 10:00:35 INFO - 'log_level': 'info', 10:00:35 INFO - 'log_name': 'talos', 10:00:35 INFO - 'log_to_console': True, 10:00:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:35 INFO - 'opt_config_files': (), 10:00:35 INFO - 'pip_index': False, 10:00:35 INFO - 'sps_profile': False, 10:00:35 INFO - 'sps_profile_interval': 0, 10:00:35 INFO - 'suite': 'dromaeojs-e10s', 10:00:35 INFO - 'system_bits': '32', 10:00:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:35 INFO - 'title': 'talos-linux64-ix-067', 10:00:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:35 INFO - 'use_talos_json': True, 10:00:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:35 INFO - 'work_dir': 'build'} 10:00:35 INFO - ##### 10:00:35 INFO - ##### Running clobber step. 10:00:35 INFO - ##### 10:00:35 INFO - Running pre-action listener: _resource_record_pre_action 10:00:35 INFO - Running main action method: clobber 10:00:35 INFO - rmtree: /builds/slave/test/build 10:00:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:36 INFO - Running post-action listener: _resource_record_post_action 10:00:36 INFO - ##### 10:00:36 INFO - ##### Running read-buildbot-config step. 10:00:36 INFO - ##### 10:00:36 INFO - Running pre-action listener: _resource_record_pre_action 10:00:36 INFO - Running main action method: read_buildbot_config 10:00:36 INFO - Using buildbot properties: 10:00:36 INFO - { 10:00:36 INFO - "project": "", 10:00:36 INFO - "product": "firefox", 10:00:36 INFO - "script_repo_revision": "production", 10:00:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:00:36 INFO - "repository": "", 10:00:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:00:36 INFO - "buildid": "20160501073345", 10:00:36 INFO - "pgo_build": "True", 10:00:36 INFO - "basedir": "/builds/slave/test", 10:00:36 INFO - "buildnumber": 598, 10:00:36 INFO - "slavename": "talos-linux64-ix-067", 10:00:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:00:36 INFO - "platform": "ubuntu64_hw", 10:00:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:00:36 INFO - "branch": "mozilla-inbound", 10:00:36 INFO - "repo_path": "integration/mozilla-inbound", 10:00:36 INFO - "revision": "d2798011f1bb59095fe9c1fdb58b2d7414cd5562", 10:00:36 INFO - "stage_platform": "linux64-pgo", 10:00:36 INFO - "builduid": "84b8b646b7eb4e8fba42a15b48c15ad1", 10:00:36 INFO - "slavebuilddir": "test" 10:00:36 INFO - } 10:00:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:00:36 INFO - Running post-action listener: _resource_record_post_action 10:00:36 INFO - ##### 10:00:36 INFO - ##### Running download-and-extract step. 10:00:36 INFO - ##### 10:00:36 INFO - Running pre-action listener: _resource_record_pre_action 10:00:36 INFO - Running main action method: download_and_extract 10:00:36 INFO - mkdir: /builds/slave/test/build/tests 10:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:36 INFO - https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:01:06 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 10:01:06 INFO - retry: attempt #1 caught exception: timed out 10:01:06 INFO - retry: Failed, sleeping 30 seconds before retrying 10:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #2 10:02:06 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 10:02:06 INFO - retry: attempt #2 caught exception: timed out 10:02:06 INFO - retry: Failed, sleeping 60 seconds before retrying 10:03:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #3 10:03:36 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 10:03:36 INFO - retry: attempt #3 caught exception: timed out 10:03:36 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json! 10:03:36 INFO - Caught exception: timed out 10:03:36 INFO - Caught exception: timed out 10:03:36 INFO - Caught exception: timed out 10:03:36 INFO - trying https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:03:36 INFO - Downloading https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:03:37 INFO - Downloaded 1361 bytes. 10:03:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:03:37 INFO - Using the following test package requirements: 10:03:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:03:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:03:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:03:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'jsshell-linux-x86_64.zip'], 10:03:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:03:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:03:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:03:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:03:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:03:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:03:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:37 INFO - https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:07 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 10:04:07 INFO - retry: attempt #1 caught exception: timed out 10:04:07 INFO - retry: Failed, sleeping 30 seconds before retrying 10:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:05:07 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 10:05:07 INFO - retry: attempt #2 caught exception: timed out 10:05:07 INFO - retry: Failed, sleeping 60 seconds before retrying 10:06:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:06:37 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 10:06:37 INFO - retry: attempt #3 caught exception: timed out 10:06:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 10:06:37 INFO - Caught exception: timed out 10:06:37 INFO - Caught exception: timed out 10:06:37 INFO - Caught exception: timed out 10:06:37 INFO - trying https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:37 INFO - Downloading https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:38 INFO - Downloaded 23879159 bytes. 10:06:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:39 INFO - Return code: 0 10:06:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:06:39 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')]} 10:06:39 INFO - https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:09 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 10:07:09 INFO - retry: attempt #1 caught exception: timed out 10:07:09 INFO - retry: Failed, sleeping 30 seconds before retrying 10:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:08:10 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 10:08:10 INFO - retry: attempt #2 caught exception: timed out 10:08:10 INFO - retry: Failed, sleeping 60 seconds before retrying 10:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:09:40 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 10:09:40 INFO - retry: attempt #3 caught exception: timed out 10:09:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 10:09:40 INFO - Caught exception: timed out 10:09:40 INFO - Caught exception: timed out 10:09:40 INFO - Caught exception: timed out 10:09:40 INFO - trying https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:40 INFO - Downloading https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:09:41 INFO - Downloaded 23879159 bytes. 10:09:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:42 INFO - Return code: 0 10:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:42 INFO - https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:10:12 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 10:10:12 INFO - retry: attempt #1 caught exception: timed out 10:10:12 INFO - retry: Failed, sleeping 30 seconds before retrying 10:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 10:11:12 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 10:11:12 INFO - retry: attempt #2 caught exception: timed out 10:11:12 INFO - retry: Failed, sleeping 60 seconds before retrying 10:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 10:12:42 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 10:12:42 INFO - retry: attempt #3 caught exception: timed out 10:12:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip! 10:12:42 INFO - Caught exception: timed out 10:12:42 INFO - Caught exception: timed out 10:12:42 INFO - Caught exception: timed out 10:12:42 INFO - trying https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:42 INFO - Downloading https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:12:43 INFO - Downloaded 10840152 bytes. 10:12:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:12:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:12:44 INFO - Return code: 0 10:12:44 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')]} 10:12:44 INFO - https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:12:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:12:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:13:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 10:13:14 INFO - retry: attempt #1 caught exception: timed out 10:13:14 INFO - retry: Failed, sleeping 30 seconds before retrying 10:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 10:14:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 10:14:14 INFO - retry: attempt #2 caught exception: timed out 10:14:14 INFO - retry: Failed, sleeping 60 seconds before retrying 10:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #3 10:15:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 10:15:44 INFO - retry: attempt #3 caught exception: timed out 10:15:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2! 10:15:44 INFO - Caught exception: timed out 10:15:44 INFO - Caught exception: timed out 10:15:44 INFO - Caught exception: timed out 10:15:44 INFO - trying https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:44 INFO - Downloading https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:15:45 INFO - Downloaded 58591000 bytes. 10:15:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:45 INFO - mkdir: /builds/slave/test/properties 10:15:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:45 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:45 INFO - Contents: 10:15:45 INFO - build_url:https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:46 INFO - Running post-action listener: _resource_record_post_action 10:15:46 INFO - Running post-action listener: set_extra_try_arguments 10:15:46 INFO - ##### 10:15:46 INFO - ##### Running populate-webroot step. 10:15:46 INFO - ##### 10:15:46 INFO - Running pre-action listener: _resource_record_pre_action 10:15:46 INFO - Running main action method: populate_webroot 10:15:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:46 INFO - '--tppagecycles', 10:15:46 INFO - '7'], 10:15:46 INFO - 'tests': ['tsvgm']}}, 10:15:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['damp', 'tps']}, 10:15:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'tests': ['damp', 'tps']}, 10:15:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['dromaeo_dom']}, 10:15:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['a11yr', 10:15:46 INFO - 'ts_paint', 10:15:46 INFO - 'tpaint', 10:15:46 INFO - 'sessionrestore', 10:15:46 INFO - 'sessionrestore_no_auto_restore', 10:15:46 INFO - 'tabpaint']}, 10:15:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:46 INFO - 'ts_paint', 10:15:46 INFO - 'tpaint', 10:15:46 INFO - 'sessionrestore', 10:15:46 INFO - 'sessionrestore_no_auto_restore', 10:15:46 INFO - 'tabpaint']}, 10:15:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:46 INFO - 'ts_paint', 10:15:46 INFO - 'tpaint', 10:15:46 INFO - 'sessionrestore', 10:15:46 INFO - 'sessionrestore_no_auto_restore', 10:15:46 INFO - 'tabpaint']}, 10:15:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:46 INFO - 'ts_paint', 10:15:46 INFO - 'tpaint', 10:15:46 INFO - 'sessionrestore', 10:15:46 INFO - 'sessionrestore_no_auto_restore', 10:15:46 INFO - 'tabpaint']}, 10:15:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['a11yr', 10:15:46 INFO - 'ts_paint', 10:15:46 INFO - 'tpaint', 10:15:46 INFO - 'sessionrestore', 10:15:46 INFO - 'sessionrestore_no_auto_restore', 10:15:46 INFO - 'tabpaint']}, 10:15:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['a11yr', 10:15:46 INFO - 'ts_paint', 10:15:46 INFO - 'tpaint', 10:15:46 INFO - 'sessionrestore', 10:15:46 INFO - 'sessionrestore_no_auto_restore', 10:15:46 INFO - 'tabpaint']}, 10:15:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['tsvgx', 10:15:46 INFO - 'tsvgr_opacity', 10:15:46 INFO - 'tart', 10:15:46 INFO - 'tscrollx', 10:15:46 INFO - 'cart']}, 10:15:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:46 INFO - 'tsvgr_opacity', 10:15:46 INFO - 'tart', 10:15:46 INFO - 'tscrollx', 10:15:46 INFO - 'cart']}, 10:15:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'talos_options': ['--disable-e10s'], 10:15:46 INFO - 'tests': ['tp5o']}, 10:15:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'tests': ['tp5o']}, 10:15:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'talos_options': ['--disable-e10s', 10:15:46 INFO - '--xperf_path', 10:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:46 INFO - 'tests': ['tp5n']}, 10:15:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:46 INFO - 'talos_options': ['--xperf_path', 10:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:46 INFO - 'tests': ['tp5n']}}, 10:15:46 INFO - 'talos.zip': {'path': '', 10:15:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:46 INFO - Running post-action listener: _resource_record_post_action 10:15:46 INFO - ##### 10:15:46 INFO - ##### Running create-virtualenv step. 10:15:46 INFO - ##### 10:15:46 INFO - Running pre-action listener: _resource_record_pre_action 10:15:46 INFO - Running main action method: create_virtualenv 10:15:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:46 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 10:15:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:46 INFO - Using real prefix '/usr' 10:15:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:49 INFO - Installing pip.................done. 10:15:49 INFO - Return code: 0 10:15:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 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 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:15:49 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 10:15:49 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 10:15:49 INFO - Using env: {'DISPLAY': ':0', 10:15:49 INFO - 'HOME': '/home/cltbld', 10:15:49 INFO - 'LANG': 'en_US.UTF-8', 10:15:49 INFO - 'LANGUAGE': 'en_US:en', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MAIL': '/var/mail/cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SHLVL': '1', 10:15:49 INFO - 'TERM': 'linux', 10:15:49 INFO - 'TMOUT': '86400', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - '_': '/tools/buildbot/bin/python'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 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 10:15:49 INFO - Cleaning up... 10:15:49 INFO - Return code: 0 10:15:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:15:49 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>=0.7.1'] in /builds/slave/test/build 10:15:49 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>=0.7.1 10:15:49 INFO - Using env: {'DISPLAY': ':0', 10:15:49 INFO - 'HOME': '/home/cltbld', 10:15:49 INFO - 'LANG': 'en_US.UTF-8', 10:15:49 INFO - 'LANGUAGE': 'en_US:en', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MAIL': '/var/mail/cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SHLVL': '1', 10:15:49 INFO - 'TERM': 'linux', 10:15:49 INFO - 'TMOUT': '86400', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - '_': '/tools/buildbot/bin/python'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 INFO - Downloading/unpacking psutil>=0.7.1 10:15:49 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 10:15:49 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 10:15:49 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 10:15:49 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 10:15:49 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 10:15:49 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 10:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:51 INFO - Installing collected packages: psutil 10:15:51 INFO - Running setup.py install for psutil 10:15:51 INFO - building 'psutil._psutil_linux' extension 10:15:51 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 10:15:51 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 10:15:51 INFO - building 'psutil._psutil_posix' extension 10:15:51 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 10:15:52 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 10:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:52 INFO - Successfully installed psutil 10:15:52 INFO - Cleaning up... 10:15:52 INFO - Return code: 0 10:15:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:15:52 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')]} 10:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:52 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')]} 10:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:52 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:15:52 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.0.0'] in /builds/slave/test/build 10:15:52 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.0.0 10:15:52 INFO - Using env: {'DISPLAY': ':0', 10:15:52 INFO - 'HOME': '/home/cltbld', 10:15:52 INFO - 'LANG': 'en_US.UTF-8', 10:15:52 INFO - 'LANGUAGE': 'en_US:en', 10:15:52 INFO - 'LOGNAME': 'cltbld', 10:15:52 INFO - 'MAIL': '/var/mail/cltbld', 10:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:52 INFO - 'MOZ_NO_REMOTE': '1', 10:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:52 INFO - 'NO_EM_RESTART': '1', 10:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:52 INFO - 'PWD': '/builds/slave/test', 10:15:52 INFO - 'SHELL': '/bin/bash', 10:15:52 INFO - 'SHLVL': '1', 10:15:52 INFO - 'TERM': 'linux', 10:15:52 INFO - 'TMOUT': '86400', 10:15:52 INFO - 'USER': 'cltbld', 10:15:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:52 INFO - '_': '/tools/buildbot/bin/python'} 10:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:15:52 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 10:15:52 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 10:15:52 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 10:15:52 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 10:15:52 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 10:15:52 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 10:15:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:15:54 INFO - Installing collected packages: mozsystemmonitor 10:15:54 INFO - Running setup.py install for mozsystemmonitor 10:15:54 INFO - Successfully installed mozsystemmonitor 10:15:54 INFO - Cleaning up... 10:15:54 INFO - Return code: 0 10:15:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:54 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')]} 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:54 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')]} 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:54 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 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:15:54 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 10:15:54 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 10:15:54 INFO - Using env: {'DISPLAY': ':0', 10:15:54 INFO - 'HOME': '/home/cltbld', 10:15:54 INFO - 'LANG': 'en_US.UTF-8', 10:15:54 INFO - 'LANGUAGE': 'en_US:en', 10:15:54 INFO - 'LOGNAME': 'cltbld', 10:15:54 INFO - 'MAIL': '/var/mail/cltbld', 10:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:54 INFO - 'MOZ_NO_REMOTE': '1', 10:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:54 INFO - 'NO_EM_RESTART': '1', 10:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:54 INFO - 'PWD': '/builds/slave/test', 10:15:54 INFO - 'SHELL': '/bin/bash', 10:15:54 INFO - 'SHLVL': '1', 10:15:54 INFO - 'TERM': 'linux', 10:15:54 INFO - 'TMOUT': '86400', 10:15:54 INFO - 'USER': 'cltbld', 10:15:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:54 INFO - '_': '/tools/buildbot/bin/python'} 10:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:54 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 10:15:54 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 10:15:54 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 10:15:54 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 10:15:54 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 10:15:54 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 10:15:56 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:56 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 10:15:56 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 10:15:56 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 10:15:56 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 10:15:56 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 10:15:56 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 10:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:57 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 10:15:57 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 10:15:57 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 10:15:57 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 10:15:57 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 10:15:57 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 10:15:57 INFO - Downloading docopt-0.6.1.tar.gz 10:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:57 INFO - Running setup.py install for blobuploader 10:15:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:57 INFO - Running setup.py install for requests 10:15:58 INFO - Running setup.py install for docopt 10:15:58 INFO - Successfully installed blobuploader requests docopt 10:15:58 INFO - Cleaning up... 10:15:58 INFO - Return code: 0 10:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:58 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 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:15:58 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 10:15:58 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 10:15:58 INFO - Using env: {'DISPLAY': ':0', 10:15:58 INFO - 'HOME': '/home/cltbld', 10:15:58 INFO - 'LANG': 'en_US.UTF-8', 10:15:58 INFO - 'LANGUAGE': 'en_US:en', 10:15:58 INFO - 'LOGNAME': 'cltbld', 10:15:58 INFO - 'MAIL': '/var/mail/cltbld', 10:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:58 INFO - 'MOZ_NO_REMOTE': '1', 10:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:58 INFO - 'NO_EM_RESTART': '1', 10:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:58 INFO - 'PWD': '/builds/slave/test', 10:15:58 INFO - 'SHELL': '/bin/bash', 10:15:58 INFO - 'SHLVL': '1', 10:15:58 INFO - 'TERM': 'linux', 10:15:58 INFO - 'TMOUT': '86400', 10:15:58 INFO - 'USER': 'cltbld', 10:15:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:58 INFO - '_': '/tools/buildbot/bin/python'} 10:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:58 INFO - Running setup.py (path:/tmp/pip-QfAAfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:58 INFO - Running setup.py (path:/tmp/pip-eHfLYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:58 INFO - Running setup.py (path:/tmp/pip-d7anhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:58 INFO - Running setup.py (path:/tmp/pip-eH1EI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:58 INFO - Running setup.py (path:/tmp/pip-SnjKm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:58 INFO - Running setup.py (path:/tmp/pip-kHduIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:58 INFO - Running setup.py (path:/tmp/pip-98vbO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:58 INFO - Running setup.py (path:/tmp/pip-Jziz38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:58 INFO - Running setup.py (path:/tmp/pip-WqrwLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:59 INFO - Running setup.py (path:/tmp/pip-IPeW15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:59 INFO - Running setup.py (path:/tmp/pip-VwgX7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:59 INFO - Running setup.py (path:/tmp/pip-8k1LSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:59 INFO - Running setup.py (path:/tmp/pip-5fgJC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:59 INFO - Running setup.py (path:/tmp/pip-y9xVVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:59 INFO - Running setup.py (path:/tmp/pip-R0cu2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:59 INFO - Running setup.py (path:/tmp/pip-SeTJnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:59 INFO - Running setup.py (path:/tmp/pip-L5jp44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:59 INFO - Running setup.py install for manifestparser 10:15:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:59 INFO - Running setup.py install for mozcrash 10:15:59 INFO - Running setup.py install for mozdebug 10:15:59 INFO - Running setup.py install for mozdevice 10:16:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozfile 10:16:00 INFO - Running setup.py install for mozhttpd 10:16:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozinfo 10:16:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozInstall 10:16:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozleak 10:16:00 INFO - Running setup.py install for mozlog 10:16:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for moznetwork 10:16:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozprocess 10:16:00 INFO - Running setup.py install for mozprofile 10:16:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozrunner 10:16:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:01 INFO - Running setup.py install for mozscreenshot 10:16:01 INFO - Running setup.py install for moztest 10:16:01 INFO - Running setup.py install for mozversion 10:16:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:01 INFO - Cleaning up... 10:16:01 INFO - Return code: 0 10:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:01 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 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:16:01 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 10:16:01 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 10:16:01 INFO - Using env: {'DISPLAY': ':0', 10:16:01 INFO - 'HOME': '/home/cltbld', 10:16:01 INFO - 'LANG': 'en_US.UTF-8', 10:16:01 INFO - 'LANGUAGE': 'en_US:en', 10:16:01 INFO - 'LOGNAME': 'cltbld', 10:16:01 INFO - 'MAIL': '/var/mail/cltbld', 10:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:01 INFO - 'MOZ_NO_REMOTE': '1', 10:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:01 INFO - 'NO_EM_RESTART': '1', 10:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:01 INFO - 'PWD': '/builds/slave/test', 10:16:01 INFO - 'SHELL': '/bin/bash', 10:16:01 INFO - 'SHLVL': '1', 10:16:01 INFO - 'TERM': 'linux', 10:16:01 INFO - 'TMOUT': '86400', 10:16:01 INFO - 'USER': 'cltbld', 10:16:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:01 INFO - '_': '/tools/buildbot/bin/python'} 10:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:01 INFO - Running setup.py (path:/tmp/pip-f68ENH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:01 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)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:01 INFO - Running setup.py (path:/tmp/pip-5Nu6pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:01 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)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:01 INFO - Running setup.py (path:/tmp/pip-YQQ5T1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:01 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)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:01 INFO - Running setup.py (path:/tmp/pip-w6IedK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:01 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)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:01 INFO - Running setup.py (path:/tmp/pip-t0jc4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:01 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)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:01 INFO - Running setup.py (path:/tmp/pip-6thjeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:02 INFO - Running setup.py (path:/tmp/pip-20TzhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:02 INFO - Running setup.py (path:/tmp/pip-hIosVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:02 INFO - Running setup.py (path:/tmp/pip-mGWr7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:02 INFO - Running setup.py (path:/tmp/pip-xs7_gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:02 INFO - Running setup.py (path:/tmp/pip-ohbvjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:02 INFO - Running setup.py (path:/tmp/pip-EGf7s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:02 INFO - Running setup.py (path:/tmp/pip-e4NQ39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:02 INFO - Running setup.py (path:/tmp/pip-eB4m8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:02 INFO - Running setup.py (path:/tmp/pip-Pn25u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:02 INFO - Running setup.py (path:/tmp/pip-WuksEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:02 INFO - Running setup.py (path:/tmp/pip-Qg2wqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:02 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)) 10:16:02 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)) 10:16:02 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)) 10:16:02 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)) 10:16:02 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)) 10:16:02 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)) 10:16:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:04 INFO - Downloading blessings-1.6.tar.gz 10:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:04 INFO - Installing collected packages: blessings 10:16:04 INFO - Running setup.py install for blessings 10:16:04 INFO - Successfully installed blessings 10:16:04 INFO - Cleaning up... 10:16:04 INFO - Return code: 0 10:16:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:05 INFO - Reading from file tmpfile_stdout 10:16:05 INFO - Current package versions: 10:16:05 INFO - argparse == 1.2.1 10:16:05 INFO - blessings == 1.6 10:16:05 INFO - blobuploader == 1.2.4 10:16:05 INFO - docopt == 0.6.1 10:16:05 INFO - manifestparser == 1.1 10:16:05 INFO - mozInstall == 1.12 10:16:05 INFO - mozcrash == 0.17 10:16:05 INFO - mozdebug == 0.1 10:16:05 INFO - mozdevice == 0.48 10:16:05 INFO - mozfile == 1.2 10:16:05 INFO - mozhttpd == 0.7 10:16:05 INFO - mozinfo == 0.9 10:16:05 INFO - mozleak == 0.1 10:16:05 INFO - mozlog == 3.1 10:16:05 INFO - moznetwork == 0.27 10:16:05 INFO - mozprocess == 0.22 10:16:05 INFO - mozprofile == 0.28 10:16:05 INFO - mozrunner == 6.11 10:16:05 INFO - mozscreenshot == 0.1 10:16:05 INFO - mozsystemmonitor == 0.0 10:16:05 INFO - moztest == 0.7 10:16:05 INFO - mozversion == 1.4 10:16:05 INFO - psutil == 3.1.1 10:16:05 INFO - requests == 1.2.3 10:16:05 INFO - wsgiref == 0.1.2 10:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 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 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:16:05 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 10:16:05 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 10:16:05 INFO - Using env: {'DISPLAY': ':0', 10:16:05 INFO - 'HOME': '/home/cltbld', 10:16:05 INFO - 'LANG': 'en_US.UTF-8', 10:16:05 INFO - 'LANGUAGE': 'en_US:en', 10:16:05 INFO - 'LOGNAME': 'cltbld', 10:16:05 INFO - 'MAIL': '/var/mail/cltbld', 10:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:05 INFO - 'MOZ_NO_REMOTE': '1', 10:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:05 INFO - 'NO_EM_RESTART': '1', 10:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:05 INFO - 'PWD': '/builds/slave/test', 10:16:05 INFO - 'SHELL': '/bin/bash', 10:16:05 INFO - 'SHLVL': '1', 10:16:05 INFO - 'TERM': 'linux', 10:16:05 INFO - 'TMOUT': '86400', 10:16:05 INFO - 'USER': 'cltbld', 10:16:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:05 INFO - '_': '/tools/buildbot/bin/python'} 10:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 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)) 10:16:05 INFO - Cleaning up... 10:16:05 INFO - Return code: 0 10:16:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:16:05 INFO - Using env: {'DISPLAY': ':0', 10:16:05 INFO - 'HOME': '/home/cltbld', 10:16:05 INFO - 'LANG': 'en_US.UTF-8', 10:16:05 INFO - 'LANGUAGE': 'en_US:en', 10:16:05 INFO - 'LOGNAME': 'cltbld', 10:16:05 INFO - 'MAIL': '/var/mail/cltbld', 10:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:05 INFO - 'MOZ_NO_REMOTE': '1', 10:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:05 INFO - 'NO_EM_RESTART': '1', 10:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:05 INFO - 'PWD': '/builds/slave/test', 10:16:05 INFO - 'SHELL': '/bin/bash', 10:16:05 INFO - 'SHLVL': '1', 10:16:05 INFO - 'TERM': 'linux', 10:16:05 INFO - 'TMOUT': '86400', 10:16:05 INFO - 'USER': 'cltbld', 10:16:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:05 INFO - '_': '/tools/buildbot/bin/python'} 10:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:05 INFO - Downloading/unpacking jsonschema 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:07 INFO - Downloading/unpacking functools32 (from jsonschema) 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:07 INFO - warning: no files found matching '*.txt' 10:16:07 INFO - no previously-included directories found matching 'build' 10:16:07 INFO - no previously-included directories found matching 'dist' 10:16:07 INFO - no previously-included directories found matching '.git*' 10:16:07 INFO - Installing collected packages: jsonschema, functools32 10:16:07 INFO - Running setup.py install for functools32 10:16:07 INFO - warning: no files found matching '*.txt' 10:16:07 INFO - no previously-included directories found matching 'build' 10:16:07 INFO - no previously-included directories found matching 'dist' 10:16:07 INFO - no previously-included directories found matching '.git*' 10:16:07 INFO - Successfully installed jsonschema functools32 10:16:07 INFO - Cleaning up... 10:16:07 INFO - Return code: 0 10:16:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbc3a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', '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 10:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:16:07 INFO - Using env: {'DISPLAY': ':0', 10:16:07 INFO - 'HOME': '/home/cltbld', 10:16:07 INFO - 'LANG': 'en_US.UTF-8', 10:16:07 INFO - 'LANGUAGE': 'en_US:en', 10:16:07 INFO - 'LOGNAME': 'cltbld', 10:16:07 INFO - 'MAIL': '/var/mail/cltbld', 10:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:07 INFO - 'MOZ_NO_REMOTE': '1', 10:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:07 INFO - 'NO_EM_RESTART': '1', 10:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:07 INFO - 'PWD': '/builds/slave/test', 10:16:07 INFO - 'SHELL': '/bin/bash', 10:16:07 INFO - 'SHLVL': '1', 10:16:07 INFO - 'TERM': 'linux', 10:16:07 INFO - 'TMOUT': '86400', 10:16:07 INFO - 'USER': 'cltbld', 10:16:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:07 INFO - '_': '/tools/buildbot/bin/python'} 10:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:08 INFO - Downloading/unpacking flake8 10:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:16:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:16:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:10 INFO - no previously-included directories found matching 'docs/_build' 10:16:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:16:10 INFO - Running setup.py install for pep8 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:10 INFO - no previously-included directories found matching 'docs/_build' 10:16:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:16:10 INFO - Cleaning up... 10:16:10 INFO - Return code: 0 10:16:10 INFO - Running post-action listener: _resource_record_post_action 10:16:10 INFO - Running post-action listener: _start_resource_monitoring 10:16:10 INFO - Starting resource monitoring. 10:16:10 INFO - ##### 10:16:10 INFO - ##### Running install step. 10:16:10 INFO - ##### 10:16:10 INFO - Running pre-action listener: _resource_record_pre_action 10:16:10 INFO - Running main action method: install 10:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:11 INFO - Reading from file tmpfile_stdout 10:16:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:11 INFO - Reading from file tmpfile_stdout 10:16:11 INFO - Output received: 10:16:11 INFO - Usage: mozinstall [options] installer 10:16:11 INFO - Options: 10:16:11 INFO - -h, --help show this help message and exit 10:16:11 INFO - -d DEST, --destination=DEST 10:16:11 INFO - Directory to install application into. [default: 10:16:11 INFO - "/builds/slave/test"] 10:16:11 INFO - --app=APP Application being installed. [default: firefox] 10:16:11 INFO - mkdir: /builds/slave/test/build/application 10:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:16:27 INFO - Reading from file tmpfile_stdout 10:16:27 INFO - Output received: 10:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:27 INFO - Running post-action listener: _resource_record_post_action 10:16:27 INFO - ##### 10:16:27 INFO - ##### Running run-tests step. 10:16:27 INFO - ##### 10:16:27 INFO - Running pre-action listener: _resource_record_pre_action 10:16:27 INFO - Running main action method: run_tests 10:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:27 INFO - Python 2.7.3 10:16:27 INFO - Return code: 0 10:16:27 INFO - grabbing minidump binary from tooltool 10:16: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')]} 10:16:27 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5410>, '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 0x18c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:27 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 10:16:27 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 10:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:27 INFO - Return code: 0 10:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:16:28 INFO - Return code: 0 10:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:16:28 INFO - Using env: {'DISPLAY': ':0', 10:16:28 INFO - 'HOME': '/home/cltbld', 10:16:28 INFO - 'LANG': 'en_US.UTF-8', 10:16:28 INFO - 'LANGUAGE': 'en_US:en', 10:16:28 INFO - 'LOGNAME': 'cltbld', 10:16:28 INFO - 'MAIL': '/var/mail/cltbld', 10:16:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:28 INFO - 'MOZ_NO_REMOTE': '1', 10:16:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:28 INFO - 'NO_EM_RESTART': '1', 10:16:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:28 INFO - 'PWD': '/builds/slave/test', 10:16:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:28 INFO - 'SHELL': '/bin/bash', 10:16:28 INFO - 'SHLVL': '1', 10:16:28 INFO - 'TERM': 'linux', 10:16:28 INFO - 'TMOUT': '86400', 10:16:28 INFO - 'USER': 'cltbld', 10:16:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544', 10:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:28 INFO - '_': '/tools/buildbot/bin/python'} 10:16:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:16:29 INFO - mozversion application_buildid: 20160501073345 10:16:29 INFO - mozversion application_changeset: d2798011f1bb59095fe9c1fdb58b2d7414cd5562 10:16:29 INFO - mozversion application_display_name: Nightly 10:16:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:29 INFO - mozversion application_name: Firefox 10:16:29 INFO - mozversion application_remotingname: firefox 10:16:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:16:29 INFO - mozversion application_vendor: Mozilla 10:16:29 INFO - mozversion application_version: 49.0a1 10:16:29 INFO - mozversion platform_buildid: 20160501073345 10:16:29 INFO - mozversion platform_changeset: d2798011f1bb59095fe9c1fdb58b2d7414cd5562 10:16:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:16:29 INFO - mozversion platform_version: 49.0a1 10:16:29 INFO - using testdate: 1462122989 10:16:29 INFO - actual date: 1462122989 10:16:29 INFO - starting webserver on 'localhost:48148' 10:16:29 INFO - SUITE-START | Running 2 tests 10:16:29 INFO - TEST-START | dromaeo_css 10:16:29 INFO - operating with platform_type : linux_ 10:16:29 INFO - Initialising browser for dromaeo_css test... 10:16:29 INFO - TEST-INFO | started process 2038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpncMJ8A/profile http://localhost:48148/getInfo.html) 10:16:32 INFO - PROCESS | 2038 | 10:16:32 INFO - PROCESS | 2038 | (process:2103): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:16:33 INFO - PROCESS | 2038 | __metrics Screen width/height:1600/1200 10:16:33 INFO - PROCESS | 2038 | colorDepth:24 10:16:33 INFO - PROCESS | 2038 | Browser inner width/height: 1024/697 10:16:33 INFO - PROCESS | 2038 | __metrics 10:16:33 ERROR - PROCESS | 2038 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:16:34 INFO - TEST-INFO | 2038: exit 0 10:16:34 INFO - Browser initialized. 10:16:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:34 INFO - TEST-INFO | started process 2154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpncMJ8A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:36 INFO - PROCESS | 2154 | 10:16:36 INFO - PROCESS | 2154 | (process:2218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:16:46 INFO - PROCESS | 2154 | RSS: Main: 164487168 10:16:46 INFO - PROCESS | 2154 | 10:17:35 INFO - PROCESS | 2154 | 1462123055814 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] 10:19:43 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:48148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48148/tests/dromaeo/cssquery-ext.html) 10:19:44 INFO - PROCESS | 2154 | RSS: Main: 170881024 10:19:44 INFO - PROCESS | 2154 | 10:22:46 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:48148/tests/dromaeo/cssquery-ext.html (next: http://localhost:48148/tests/dromaeo/cssquery-jquery.html) 10:22:46 INFO - PROCESS | 2154 | RSS: Main: 167084032 10:22:46 INFO - PROCESS | 2154 | 10:25:48 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:48148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48148/tests/dromaeo/cssquery-mootools.html) 10:25:48 INFO - PROCESS | 2154 | RSS: Main: 168288256 10:25:48 INFO - PROCESS | 2154 | 10:28:50 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:48148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48148/tests/dromaeo/cssquery-prototype.html) 10:28:51 INFO - PROCESS | 2154 | RSS: Main: 165937152 10:28:51 INFO - PROCESS | 2154 | 10:31:53 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:48148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48148/tests/dromaeo/cssquery-yui.html) 10:31:54 INFO - PROCESS | 2154 | RSS: Main: 167137280 10:31:54 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:48148/tests/dromaeo/cssquery-yui.html (next: http://localhost:48148/tests/dromaeo/cssquery-dojo.html) 10:34:56 INFO - PROCESS | 2154 | RSS: Main: 169062400 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | __start_tp_report 10:34:56 INFO - PROCESS | 2154 | _x_x_mozilla_page_load 10:34:56 INFO - PROCESS | 2154 | _x_x_mozilla_page_load_details 10:34:56 INFO - PROCESS | 2154 | |i|pagename|runs| 10:34:56 INFO - PROCESS | 2154 | |0;dojo.html;3126.546650735643;3185.7292130168935;3192.6328472225696;3234.7573931955108;3235.7573182011342;5142.871428214292;5154.510321519454;5154.664946778456;5163.277141200226;5191;4967.602591792657;5057.367829021372;5093.898122037557;5112.284280200765;5185.870353241162;4635.281531362644;4675.485696573374;4709.317149013391;4731.668783185179;4751.073540659573;819.1368253511313;4697.9060418791605;4716.811327546894;4729.503402142777;4776.402949631296;4699;4706.552877476634;4723.173444647207;4727.338172655831;4735.834245801398;4500.189965806154;4692.718436893797;4703.858884233478;4779.952200477986;4816.8795780105775;4536.7504787236685;4592.5177856324935;4606.677532572721;4646.326282688991;4659.254519276899;5029.597632189416;5036.143855544567;5064.544191022789;5073.594112470993;5092.490750924915;5340.065488539529;5421;5456.863578410532;5459.645123066988;5471.425500322488;5349.22436246742;5350.224217488442;5350.5452036576935;5353.063213937546;5411.702356370398;5003.8874823069655;5004.924926126111;5025.346704928336;5035.874103147414;5085.923711144335;5439.3200849893765;5484.341878974548;5566;5633.859153521113;5661.433856614306;5312.840614781563;5331.653442526223;5332.120200167006;5342.759575819097;5353.197020446886;5382.3541175059245;5410.648307859977;5411.729413529308;5427.6200665953;5463.754131064112;5381.0583147948955;5432.429594892558;5434.375046869661;5492.725363731797;5504.724763761796;5351.866203344947;5450.236966824647;5485.067538518461;5509.421510741395;5577.721113944286;4387.4954380246045;4394.934075988863;4416.933745993812;4424.491183513873;4437.955620443754;3831.4827498287373;3840.8271627776817;3889;3902.570717221103;3926.1166237596885;5504.4770746779795;5528.474794894479;5536;5555.666660000332;5566.526845218121;5346.251524786533;5444.700541470257;5486.561075113981;5510.035743744908;5543.695096769636;5465.863353416196;5510.228568000483;5519.227308176858;5536.778528858881;5579.191017302468;4872.1473742094995;4878.365812444359;4879.048585525859;4904.485029071896;4924.975375123101;5887.705614719247;5897.705114744332;5899.587028908021;5939.703014849327;6055.878882422415;5431.321084864392;5463.371712253142;5465.918011229915;5470.425605311465;5509.807156749414;5935.0503919372695;5938.8218353449465;5963.224780778471;5963.850903727442;5970.940290597038;5307.336582927134;5333.12003519415;5359.812406565751;5362.946370536245;5414.458554144554;5431.782728690808;5465.72671366438;5474.835754927359;5510.504054635102;5519.8896022080135;5334.359876814807;5352.277442545206;5361.812336568201;5363.785448582013;5404.405515393382;5298.966701493172;5334.439883812144;5381.13901775714;5452.400235974119;5460.453954604508;5118.155504341742;5210.426853046086;5244.711540865136;5282.947170528246;5329.600279979095;5403.189521571639;5418.783248670009;5422.349318081855;5436.67379957188;5461.1808228766;5148.459411761861;5162.793488260428;5251.107311756934;5299.973500132474;5354.812581559627 10:34:56 INFO - PROCESS | 2154 | |1;ext.html;596.9343372229057;614.4838335797929;629.8771739510796;641.1472741254131;644.6357807838568;36325.27349453013;37435.43846842293;37669.43495847564;37739.811300943526;37903;39859.40210896839;40458;40600;40647.59352406475;40648.18703625926;8477.491350518972;8758.912410875906;8763.51800650964;8767.605457754384;8778.429402088876;8728.389012769108;8878.689245876396;8909.866352004725;8910.50992195429;8923.732288031337;8863.379563430562;8944.910550894472;8947;8947.77630559238;8959.641614335418;8790.6923257686;8804.163604457566;8874.156955089224;8884.333674974403;8886.73339799807;8624.266937310336;8696;8719.215270625611;8747.16901894319;8760;40348.193036139404;40695;41037.589624103675;41044.79477602593;41185.38221926644;3185.4584720597554;3352.6479719629574;3449.1721986723005;3586.0317714217276;3693.6675699187203;27959.580606290718;30761.538576921364;31756.682433175603;31824.363512729615;32003.39983000864;4208.747475151501;4288.678349123828;4300.569943005675;4333.2200203963275;4359.607635312837;181226;182012;182199;183558.16441835545;184486;31822.2044448886;53921.460785391646;54879.725601371734;55035;55112.72443637836;32676.67323326784;32681.67318326834;32713.509297360557;32727.83636081852;32793.67206327906;14984.10095394258;15259.313330900137;15296.235188240766;15379.538613841603;15392.307346169226;12821.807672884914;12956;12994.285314307615;13017.869821301856;13031.739365212643;8167.83664326722;8299.543525106057;8332.833343333099;8371.748847534584;8393.496390216484;3268.624108227537;3287.342531493711;3298.191942973987;3316.3201543683485;3319.6680331967095;917.5366439947784;918.1782304837134;992.9177196855462;1003.3327836988321;1069.657709532942;27004.324891877466;28852.855735721187;29237.415251694845;29827.85086074556;29921.40157196844;1097.2154909239932;1114.793763153803;1145.3128123126057;1165.4930105404176;1249.8312727781815;15477.613059673373;15706.450274240347;15844.52466426009;16096.839031609534;16290;459498;461866;463106;464740;465279;53806.73096634492;54713.1793023105;54715.72642136764;54800.725996369765;55095.173572396445;1391.047132714094;1413.159170293653;1419.74444599973;1425.2659880161725;1507.0279669613037;28853.27866803347;29354.559681604365;29676.70323296826;29681.703182967893;29942;47719.76140119277;47904.76047619739;48176;48222.07111715492;48224;319412;322726;322945;323503;324297;27255.454890901674;27520.449591007666;27650.86174569114;27848.303792405353;27854.582181267702;46944.7652761734;47316.52683473121;47771.28343074926;47959;48005.279920800516;40217.39673904952;40323.79838100908;40579;41281.380779287734;41903.371449428894;40439.595604043585;40699.59300407077;40999.59000409958;41391.7930410346;41658.16683666249;35656.64343356533;37176;40188.397174043;41228;41270.79364603278;33911.32177356489;34941.8252908744;35159.29681406306;35554;35613.82193089018;27049.59425608578;27087.45825083527;27172.72827271702;27207.727922720518;27480.725192747817 10:34:56 INFO - PROCESS | 2154 | |2;jquery.html;378.464472771029;381.32695791927233;393.54742046646356;394.6270774118459;400;16586.33654653814;18386.08069596518;18831.775934564263;18864;18887.527811804714;17635.73546396802;18148.455546333596;18556.350527731498;18596.07019649019;18689.90655046723;5419.810306639279;5458.1266997280445;5629.324481062258;5659.801906933259;5667.914981275284;5493.945060549403;5561.193626924093;5574.804881829137;5582.385937546866;5592.748326325325;5251.133562962106;5510.972445137789;5517.917231241535;5527.806526771564;5545.722713864311;5533.529649979757;5560.4161563035705;5561.388247292814;5566.805161819337;5592.944070559283;4891.315215869781;4928.088303663833;4943.6539442239055;4967.552920237196;5028.170351891933;21658.24196153143;21850.672239916414;21947.780522194735;22126;22129.889350553145;2340.040583360831;2501.124606387768;2580.9870950645313;2640.485105404447;2794.538901081319;13374.933125334408;13641.86358136416;13677.452901883913;13877.861221387759;14239.644008899757;1921.3563456242175;2014.2547257514666;2018.3238615063972;2020.464576887126;2054.95890082199;79754.20245797584;81005.59497202536;81136.59431702863;82041.58979205065;82530.17469825345;9509.66716164931;9693.41839489633;10178;10337.276390652582;10392.168626509861;14278;14374;14382.065165764192;14421.92789036048;14439.783403248959;8116.675332986614;8169.673213071529;8225;8256.876146857801;8319.500829950222;7823.100343460575;7960.1243863175005;7974.840503189904;7993.640286187136;8148.10370859205;5950.214935519327;6241.126242326078;6309.7160627770945;6342.460890824239;6402.743890244431;1837.5498002989352;1844.4374465788064;1864.8787828791085;1886.5755205079022;1887.5186827358937;968.2254196642658;1043.5356266461504;1069.1019543583427;1105.1987309200927;1157.0801213035656;18045.458636240935;18262.151693115084;18428.737010192766;18478.722819157454;18598.44204673862;1032.0866033560353;1037.180627304421;1074.355386767933;1092.8688557373166;1180.7048237940514;10598.205134614935;10672.46637668129;10793.24447288698;10795.352278863136;10801.24391292602;415627;417893;420108;431475;434112;79105;82122.58938705268;82243.58878205571;82592.58703706563;82744.58627706823;1003.3595072057093;1009.369144284822;1037.4501514197486;1037.9117774989058;1069.7593041565742;15198.46805361807;15662.843371566138;15702.9214853925;15810;15960.920195398949;36783;37243;38692.80653596714;39691.40462893117;39752.60247397489;52527.47472525226;52572;52653;52774.47225527695;53142.20286695625;7970.521768693897;8460.492370457792;8477.915220847712;8519.616617252363;8606.26846718036;7066.611336376549;11303.547858085585;12842.97256219519;12911.418986145458;13556.864431355954;11300.49147788368;11741.882581174421;12048.638540843789;12098.334591597546;12099;11709.180357375242;11722.179447438597;11802.173847830569;11814.978634080653;11936.522539098687;11826.46780894879;12041.75916481648;12080.697982550506;12233.388330583613;12403.62789116328;8185.631646575799;8359.289460395692;8441;8463.449875758057;8531.701390451553;11874.109441791727;12071.818922715991;12098.395080245777;12178.878211217774;12221.266723996589 10:34:56 INFO - PROCESS | 2154 | |3;mootools.html;1519.6352875309929;1531.2573401900077;1644.0628841560308;1756.273472599943;1787.4816303272053;7345.7428989985365;7779.260970207835;7965.6813727450835;8122.51264924105;8182.22268884455;7960.840783184347;7971.720989765359;7988.400869934749;7996.680132794696;8022.1576734442915;2125.7342832145982;2160.1467420368945;2160.2655097267007;2160.956780864382;2162.37291185556;2107.936761897138;2111.6410210264216;2160.459885028743;2171.8045375916163;2172.728408948881;2008.7589489261309;2028.4117605894273;2034.287999200283;2036.6334059869218;2046.6316063108634;2073.8444616653737;2076.3874656976077;2077.542940553076;2088.613606482798;2094.95810083799;1970.5072434848569;2044.877307361563;2078.605065037638;2102.959035277532;2103.1272022110807;8147.429679922408;8167.877481837777;8193.959030204871;8229.423940324179;8254.669813207465;4702.083093796711;4844.709317440965;4864;4868.269759536062;4882.877928051792;2889.9133026009254;2990.0880231529377;3028.9697103028907;3054.6487153977355;3098.4267910436643;965.1603105298365;976.2482888176136;987.6197663899378;995.9402435853872;1004.9045340692622;10523.789524209473;10806.081483073947;10914.617988370448;10935.726606834813;10937.83593246102;3967.147063381387;4064.9593504064583;4115.835366585363;4138.358554424069;4142.71001029931;8961.686340978165;9005.459672419676;9025.142611451902;9054.275657947348;9075.591598378089;4840.975795121002;4857.465678775332;4873.926891096637;4878.0975519529;4901.50984901507;3937.370020796659;4408.669349798778;4497.775111244425;4550.180967425829;4615.746133962597;3488.8081155536183;3562.9643703562633;3586.264815712773;3594.928101438009;3597.1007248187952;1000.9499525023865;1010.3079390617451;1017.4861694844057;1031.8916513765946;1045.6706137566641;846.9915300846912;974.3617930255693;983.7196399026243;1003.4581326083979;1014.8883622801486;5466.890662186734;5507.449255074541;5630.493255607015;5647.1529270609735;5693.943060569424;353.2687337211947;353.6693191865614;365.8426876443155;382.30993057531424;408.7036898248746;3936.193080418507;3996.680265578747;3999.4000899865255;4025.8590949316635;4039.5758445363404;9671.661491847752;10177.236707246986;10179.44013079273;10189.694309170736;10204.642837500653;9491.050894910592;9782.11960923506;9864.309498335191;10097.848532272023;10109.191264698806;7494.475386722877;7630.656620451982;7653.885191722128;7657.885131723028;7725.613719314012;5415.810446634507;5627.634203776742;5630.971845140912;5642.6614403135945;5711.885762284648;9052.683156089506;9133.680321188727;9146.95426522863;9179.173874351074;9247.583858726508;9378.624855005995;9453;9583;9818.803623927339;9828.213742900407;7322.450816188913;7343.5961022142155;7452.92547074544;7502.062242219723;7528.736494222676;8069.475484093515;8100.311473524581;8125.537403267233;8142.389320800845;8238.052623948322;6843.7604683835825;7210.278972102958;7425.146108197627;7449.478536502393;7573.583452910143;7205.963970180115;7286.854262914606;7361.521501102411;7427.591482468516;7440.55356678601;6649.966750166218;6703.195616526048;6718.764843230463;6723.2604413515455;6730.629815360006;4920.753962301942;4950.6782059166035;5005.274235235797;5005.949940500548;5075.92386114216;5069.112905241494;5077.060743762416;5146.69119852795;5146.9227961581355;5181.922271166011 10:34:56 INFO - PROCESS | 2154 | |4;prototype.html;283.17172271107006;291.1135592121988;293.3882854248891;293.53474742533075;294.4008941803431;5064.126273278883;5144.871378215537;5196.2725218469395;5264.104742391683;5278.524932756051;5193.5066168714;5224.817131400402;5228.29418028566;5243.659162154458;5259;4018.095928416112;4020.8793736187963;4029.697772667047;4040.2929487339743;4062.2281766464275;3941.960580394188;4056.6957478189106;4057.898552536181;4083.367078102884;4088.100617864065;4006.697823207455;4013.357862741962;4029.194161167778;4029.8917797605745;4047.8380864765372;3980.6218409251073;4006.3189257825948;4024.7585144891254;4032.8185231664647;4044.7865640307937;3528.641473032875;3548.5273611451216;3555.666625015619;3568.7145028397667;3570.83931223093;4946.208606622923;4966.528179822911;5045.772940217699;5053.747312634354;5100.285959965608;4527.592516673515;4551.294549344857;4552.248878934972;4555.863324100283;4583.197940360424;5378.435264297232;5407.540359069484;5421.695779293824;5428.240046393508;5438.646487978269;3812.7712337259854;3877.418387241908;3901.941470877939;3905.199434116028;3909.7654140751647;5675.489205971482;5703.629264097862;5714.942850571482;5726.370099289116;5742.54059675225;3949.1114499238015;3953.5058117735284;3956.3669812829808;3964.702647301406;3965.20695860829;3578.2306804036734;3809.2381523694817;4003.619656132663;4005.5193376794386;4009.67922566194;4457.375967364572;4467.106578684276;4479.275478940632;4480.4623445186135;4496.865094047183;5413.83758487246;5418.8916221675345;5474.795544980098;5475.342958844964;5489.2589500417735;1339.7320535892861;1378.5381897064597;1378.5726424808342;1388.9097208681403;1392.6978275312413;886.1714297132202;889.666375109334;897.5736525150501;898.1467605774541;905.791667916383;5935.139404786368;5940.287165540163;5951.7619295227705;5959.433853783884;5971.761129554856;5871.295444546682;5929.733162007634;5937.910931336033;5943.286805583358;5968.850778730566;5820.35976042635;5834.183214349994;5860.413958604191;5911.527077833763;5928.288605367384;3132.6867313268945;3149.0238026211946;3159.984200078985;3178.5867837181017;3184.4268031754045;6385.5210859185745;6573.934260657428;6599.571027883172;6600.108985287021;6600.867982640416;6024.216851809237;6056.576039677268;6077.817665470043;6081.513478921675;6103.42017508336;6440.4847612190915;6517.51118666102;6519.3154718754795;6550.541462097703;6574.408303252731;5724.284464441945;5918.2898052234;5934.643921364732;5937.079752638348;5946.791862284799;5848.5028772553105;5854.736536855937;5886.6173698709445;5899;5899.144624029577;6368.42684158428;6510.47916166715;6552.83617909537;6560.967195164185;6581.605103693793;3956.050547868433;3963.2073585283633;3964.900877478086;3965.068208970947;3981.581933896899;5322.547583455294;5906.822795316148;5923.674197919156;5954.46409823118;5969.820905372846;5313.335833020872;5421.132618780976;5455.8363249102595;5455.918161227664;5461.787975869779;5461.825707472913;5467.125259958388;5469.699166545878;5490.835274941758;5511.559075273888;5240.5588463172935;5369.597280203922;5397.460253974571;5404.729888476283;5419.187121931742;5495.477929596682;5501.487091049993;5512.5314348280845;5534.280543529316;5536.003519366553;5400.324959380077;5401.972990135181;5410.323709536308;5425.13197888336;5426.585169599491 10:34:56 INFO - PROCESS | 2154 | |5;yui.html;757.9090509138904;797.768647092343;817.9754607361778;827.3381294964029;845.4927043773737;13495.66260843477;13555.864441355583;14054.999999999987;14747.115173089622;14987.400503979841;13430.932845335785;13450.596482105528;13470;13494.662633434145;13610.795838062437;795.5425630262594;809.4859764049812;810.1372038778711;814.3281792521165;814.3810703865046;817.199144838059;817.8159914019328;822.8847961285425;825.558326295432;838.3335248477475;849.562475325208;853.3685073045932;853.6500034985658;854.363499193099;863.8661007543809;842.3303473738392;844.472204871955;845.306848384322;849.6941101203562;867.540203692041;627.425905296653;631.5011141198447;634.1597383466925;634.8127302445789;637.7863415755727;12945.54690585825;13000.804987925188;13057.477700891954;13064.673383165402;13087;13970.51103211393;13975.930120349332;14075.085119467201;14094.859051409458;14182.92908535461;10988.395638239894;11194.272372295774;11221.102311815035;11284.887151128465;11376.544938202462;3848.634379733921;3870.4000879863665;3961;3983.4224037514687;4061.5938406159444;51441.22838157431;51570.484295156944;52730.20904686433;52847.471525284636;52938.20592691074;10799;11068.557257709763;11074.143308359464;11254.662360129209;11279.943600281946;19766.60466790685;19819.10814013373;19950.800491994894;20024.89987550053;20529.589408211752;8416.74749757496;8531.829363412697;8580;8637.093105223861;8776.648934042694;4823.807047718122;4842.685225460334;4863.2461968394955;4940.901181976412;4940.950590494121;3228.967710322867;3305.5206994986074;3308.553345298402;3312.950305745416;3317.784344017631;586.9442402971711;597.068573026072;597.1520440973827;610.9266887973472;612.7579606055583;690.7962151165418;700.3871612339203;772.2854167600888;781.1329424338979;787.747920665393;9182.724518264462;9393.503595338458;9475.147236748726;9511.66709165176;9515.524223788783;708.840510885057;729.031649309951;740.174705203694;745.5824738146655;750.512167091395;4273.273543497613;4456.286994080931;4521.321801729701;4537.1833070047705;4586.862394128181;55188.44811551833;56749;57022.14466783001;57231.42768572344;57476.27571172788;51442.228366574534;51448.22827657588;51538.22692659613;52063.479365205865;53611.19583206255;46881.76559117251;47145;47253.29120063202;47792.7610361946;48046.75976620094;8820.779480512781;8845.336599754915;8924.68763593271;9006.54967251648;9034.367594268339;31190.376192476477;31641.5253771189;31947.6805231954;32112.197195070312;32138.19654508656;39117;40606.39090413587;41262.58737412708;41342.37986430266;41685.79157104316;10748.89251107479;11179.441027948733;11298.943505282421;11323.32060076398;11615.303081815118;12229.75540489203;12262.754744904874;12327.93836030814;12410.689732756753;12417.62747117588;11047.779044419227;11091.944540277247;11136.053435458076;11170.944145279222;11240.943795280971;11106.278091924;11183.273087249303;11200.719982000515;11223;11230.83153752678;10775.137988961022;10813.243072984815;10951.123910087015;11037;11096.944515277371;9717.805643887225;9878.308518403643;9935.752958484816;10017.69946901594;10430.374177549067;10028.949855250678;10098.697039088838;10146.492675366055;10286.331388459726;10290.588376464857 10:34:56 INFO - PROCESS | 2154 | __end_tp_report 10:34:56 INFO - PROCESS | 2154 | __start_cc_report 10:34:56 INFO - PROCESS | 2154 | _x_x_mozilla_cycle_collect,337 10:34:56 INFO - PROCESS | 2154 | __end_cc_report 10:34:56 INFO - PROCESS | 2154 | __startTimestamp1462124096784__endTimestamp 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | ------- Summary: start ------- 10:34:56 INFO - PROCESS | 2154 | Number of tests: 6 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | [#0] dojo.html Cycles:165 Average:5114.94 Median:5342.76 stddev:643.50 (12.0%) stddev-sans-first:626.29 10:34:56 INFO - PROCESS | 2154 | Values: 3126.5 3185.7 3192.6 3234.8 3235.8 5142.9 5154.5 5154.7 5163.3 5191.0 4967.6 5057.4 5093.9 5112.3 5185.9 4635.3 4675.5 4709.3 4731.7 4751.1 819.1 4697.9 4716.8 4729.5 4776.4 4699.0 4706.6 4723.2 4727.3 4735.8 4500.2 4692.7 4703.9 4780.0 4816.9 4536.8 4592.5 4606.7 4646.3 4659.3 5029.6 5036.1 5064.5 5073.6 5092.5 5340.1 5421.0 5456.9 5459.6 5471.4 5349.2 5350.2 5350.5 5353.1 5411.7 5003.9 5004.9 5025.3 5035.9 5085.9 5439.3 5484.3 5566.0 5633.9 5661.4 5312.8 5331.7 5332.1 5342.8 5353.2 5382.4 5410.6 5411.7 5427.6 5463.8 5381.1 5432.4 5434.4 5492.7 5504.7 5351.9 5450.2 5485.1 5509.4 5577.7 4387.5 4394.9 4416.9 4424.5 4438.0 3831.5 3840.8 3889.0 3902.6 3926.1 5504.5 5528.5 5536.0 5555.7 5566.5 5346.3 5444.7 5486.6 5510.0 5543.7 5465.9 5510.2 5519.2 5536.8 5579.2 4872.1 4878.4 4879.0 4904.5 4925.0 5887.7 5897.7 5899.6 5939.7 6055.9 5431.3 5463.4 5465.9 5470.4 5509.8 5935.1 5938.8 5963.2 5963.9 5970.9 5307.3 5333.1 5359.8 5362.9 5414.5 5431.8 5465.7 5474.8 5510.5 5519.9 5334.4 5352.3 5361.8 5363.8 5404.4 5299.0 5334.4 5381.1 5452.4 5460.5 5118.2 5210.4 5244.7 5282.9 5329.6 5403.2 5418.8 5422.3 5436.7 5461.2 5148.5 5162.8 5251.1 5300.0 5354.8 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | [#1] ext.html Cycles:180 Average:48110.20 Median:40023.90 stddev:90893.77 (227.1%) stddev-sans-first:91078.75 10:34:56 INFO - PROCESS | 2154 | Values: 596.9 614.5 629.9 641.1 644.6 36325.3 37435.4 37669.4 37739.8 37903.0 39859.4 40458.0 40600.0 40647.6 40648.2 8477.5 8758.9 8763.5 8767.6 8778.4 8728.4 8878.7 8909.9 8910.5 8923.7 8863.4 8944.9 8947.0 8947.8 8959.6 8790.7 8804.2 8874.2 8884.3 8886.7 8624.3 8696.0 8719.2 8747.2 8760.0 40348.2 40695.0 41037.6 41044.8 41185.4 3185.5 3352.6 3449.2 3586.0 3693.7 27959.6 30761.5 31756.7 31824.4 32003.4 4208.7 4288.7 4300.6 4333.2 4359.6 181226.0 182012.0 182199.0 183558.2 184486.0 31822.2 53921.5 54879.7 55035.0 55112.7 32676.7 32681.7 32713.5 32727.8 32793.7 14984.1 15259.3 15296.2 15379.5 15392.3 12821.8 12956.0 12994.3 13017.9 13031.7 8167.8 8299.5 8332.8 8371.7 8393.5 3268.6 3287.3 3298.2 3316.3 3319.7 917.5 918.2 992.9 1003.3 1069.7 27004.3 28852.9 29237.4 29827.9 29921.4 1097.2 1114.8 1145.3 1165.5 1249.8 15477.6 15706.5 15844.5 16096.8 16290.0 459498.0 461866.0 463106.0 464740.0 465279.0 53806.7 54713.2 54715.7 54800.7 55095.2 1391.0 1413.2 1419.7 1425.3 1507.0 28853.3 29354.6 29676.7 29681.7 29942.0 47719.8 47904.8 48176.0 48222.1 48224.0 319412.0 322726.0 322945.0 323503.0 324297.0 27255.5 27520.4 27650.9 27848.3 27854.6 46944.8 47316.5 47771.3 47959.0 48005.3 40217.4 40323.8 40579.0 41281.4 41903.4 40439.6 40699.6 40999.6 41391.8 41658.2 35656.6 37176.0 40188.4 41228.0 41270.8 33911.3 34941.8 35159.3 35554.0 35613.8 27049.6 27087.5 27172.7 27207.7 27480.7 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | [#2] jquery.html Cycles:180 Average:26537.34 Median:12234.96 stddev:70003.77 (572.2%) stddev-sans-first:70172.60 10:34:56 INFO - PROCESS | 2154 | Values: 378.5 381.3 393.5 394.6 400.0 16586.3 18386.1 18831.8 18864.0 18887.5 17635.7 18148.5 18556.4 18596.1 18689.9 5419.8 5458.1 5629.3 5659.8 5667.9 5493.9 5561.2 5574.8 5582.4 5592.7 5251.1 5511.0 5517.9 5527.8 5545.7 5533.5 5560.4 5561.4 5566.8 5592.9 4891.3 4928.1 4943.7 4967.6 5028.2 21658.2 21850.7 21947.8 22126.0 22129.9 2340.0 2501.1 2581.0 2640.5 2794.5 13374.9 13641.9 13677.5 13877.9 14239.6 1921.4 2014.3 2018.3 2020.5 2055.0 79754.2 81005.6 81136.6 82041.6 82530.2 9509.7 9693.4 10178.0 10337.3 10392.2 14278.0 14374.0 14382.1 14421.9 14439.8 8116.7 8169.7 8225.0 8256.9 8319.5 7823.1 7960.1 7974.8 7993.6 8148.1 5950.2 6241.1 6309.7 6342.5 6402.7 1837.5 1844.4 1864.9 1886.6 1887.5 968.2 1043.5 1069.1 1105.2 1157.1 18045.5 18262.2 18428.7 18478.7 18598.4 1032.1 1037.2 1074.4 1092.9 1180.7 10598.2 10672.5 10793.2 10795.4 10801.2 415627.0 417893.0 420108.0 431475.0 434112.0 79105.0 82122.6 82243.6 82592.6 82744.6 1003.4 1009.4 1037.5 1037.9 1069.8 15198.5 15662.8 15702.9 15810.0 15960.9 36783.0 37243.0 38692.8 39691.4 39752.6 52527.5 52572.0 52653.0 52774.5 53142.2 7970.5 8460.5 8477.9 8519.6 8606.3 7066.6 11303.5 12843.0 12911.4 13556.9 11300.5 11741.9 12048.6 12098.3 12099.0 11709.2 11722.2 11802.2 11815.0 11936.5 11826.5 12041.8 12080.7 12233.4 12403.6 8185.6 8359.3 8441.0 8463.4 8531.7 11874.1 12071.8 12098.4 12178.9 12221.3 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | [#3] mootools.html Cycles:180 Average:5353.42 Median:4977.98 stddev:3036.23 (61.0%) stddev-sans-first:3031.08 10:34:56 INFO - PROCESS | 2154 | Values: 1519.6 1531.3 1644.1 1756.3 1787.5 7345.7 7779.3 7965.7 8122.5 8182.2 7960.8 7971.7 7988.4 7996.7 8022.2 2125.7 2160.1 2160.3 2161.0 2162.4 2107.9 2111.6 2160.5 2171.8 2172.7 2008.8 2028.4 2034.3 2036.6 2046.6 2073.8 2076.4 2077.5 2088.6 2095.0 1970.5 2044.9 2078.6 2103.0 2103.1 8147.4 8167.9 8194.0 8229.4 8254.7 4702.1 4844.7 4864.0 4868.3 4882.9 2889.9 2990.1 3029.0 3054.6 3098.4 965.2 976.2 987.6 995.9 1004.9 10523.8 10806.1 10914.6 10935.7 10937.8 3967.1 4065.0 4115.8 4138.4 4142.7 8961.7 9005.5 9025.1 9054.3 9075.6 4841.0 4857.5 4873.9 4878.1 4901.5 3937.4 4408.7 4497.8 4550.2 4615.7 3488.8 3563.0 3586.3 3594.9 3597.1 1000.9 1010.3 1017.5 1031.9 1045.7 847.0 974.4 983.7 1003.5 1014.9 5466.9 5507.4 5630.5 5647.2 5693.9 353.3 353.7 365.8 382.3 408.7 3936.2 3996.7 3999.4 4025.9 4039.6 9671.7 10177.2 10179.4 10189.7 10204.6 9491.1 9782.1 9864.3 10097.8 10109.2 7494.5 7630.7 7653.9 7657.9 7725.6 5415.8 5627.6 5631.0 5642.7 5711.9 9052.7 9133.7 9147.0 9179.2 9247.6 9378.6 9453.0 9583.0 9818.8 9828.2 7322.5 7343.6 7452.9 7502.1 7528.7 8069.5 8100.3 8125.5 8142.4 8238.1 6843.8 7210.3 7425.1 7449.5 7573.6 7206.0 7286.9 7361.5 7427.6 7440.6 6650.0 6703.2 6718.8 6723.3 6730.6 4920.8 4950.7 5005.3 5005.9 5075.9 5069.1 5077.1 5146.7 5146.9 5181.9 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | [#4] prototype.html Cycles:180 Average:4731.46 Median:5398.89 stddev:1484.91 (27.5%) stddev-sans-first:1451.05 10:34:56 INFO - PROCESS | 2154 | Values: 283.2 291.1 293.4 293.5 294.4 5064.1 5144.9 5196.3 5264.1 5278.5 5193.5 5224.8 5228.3 5243.7 5259.0 4018.1 4020.9 4029.7 4040.3 4062.2 3942.0 4056.7 4057.9 4083.4 4088.1 4006.7 4013.4 4029.2 4029.9 4047.8 3980.6 4006.3 4024.8 4032.8 4044.8 3528.6 3548.5 3555.7 3568.7 3570.8 4946.2 4966.5 5045.8 5053.7 5100.3 4527.6 4551.3 4552.2 4555.9 4583.2 5378.4 5407.5 5421.7 5428.2 5438.6 3812.8 3877.4 3901.9 3905.2 3909.8 5675.5 5703.6 5714.9 5726.4 5742.5 3949.1 3953.5 3956.4 3964.7 3965.2 3578.2 3809.2 4003.6 4005.5 4009.7 4457.4 4467.1 4479.3 4480.5 4496.9 5413.8 5418.9 5474.8 5475.3 5489.3 1339.7 1378.5 1378.6 1388.9 1392.7 886.2 889.7 897.6 898.1 905.8 5935.1 5940.3 5951.8 5959.4 5971.8 5871.3 5929.7 5937.9 5943.3 5968.9 5820.4 5834.2 5860.4 5911.5 5928.3 3132.7 3149.0 3160.0 3178.6 3184.4 6385.5 6573.9 6599.6 6600.1 6600.9 6024.2 6056.6 6077.8 6081.5 6103.4 6440.5 6517.5 6519.3 6550.5 6574.4 5724.3 5918.3 5934.6 5937.1 5946.8 5848.5 5854.7 5886.6 5899.0 5899.1 6368.4 6510.5 6552.8 6561.0 6581.6 3956.1 3963.2 3964.9 3965.1 3981.6 5322.5 5906.8 5923.7 5954.5 5969.8 5313.3 5421.1 5455.8 5455.9 5461.8 5461.8 5467.1 5469.7 5490.8 5511.6 5240.6 5369.6 5397.5 5404.7 5419.2 5495.5 5501.5 5512.5 5534.3 5536.0 5400.3 5402.0 5410.3 5425.1 5426.6 10:34:56 INFO - PROCESS | 2154 | 10:34:56 INFO - PROCESS | 2154 | [#5] yui.html Cycles:180 Average:14043.05 Median:4562.02 stddev:15906.73 (348.7%) stddev-sans-first:15920.07 10:34:56 INFO - PROCESS | 2154 | Values: 757.9 797.8 818.0 827.3 845.5 13495.7 13555.9 14055.0 14747.1 14987.4 13430.9 13450.6 13470.0 13494.7 13610.8 795.5 809.5 810.1 814.3 814.4 817.2 817.8 822.9 825.6 838.3 849.6 853.4 853.7 854.4 863.9 842.3 844.5 845.3 849.7 867.5 627.4 631.5 634.2 634.8 637.8 12945.5 13000.8 13057.5 13064.7 13087.0 13970.5 13975.9 14075.1 14094.9 14182.9 10988.4 11194.3 11221.1 11284.9 11376.5 3848.6 3870.4 3961.0 3983.4 4061.6 51441.2 51570.5 52730.2 52847.5 52938.2 10799.0 11068.6 11074.1 11254.7 11279.9 19766.6 19819.1 19950.8 20024.9 20529.6 8416.7 8531.8 8580.0 8637.1 8776.6 4823.8 4842.7 4863.2 4940.9 4941.0 3229.0 3305.5 3308.6 3313.0 3317.8 586.9 597.1 597.2 610.9 612.8 690.8 700.4 772.3 781.1 787.7 9182.7 9393.5 9475.1 9511.7 9515.5 708.8 729.0 740.2 745.6 750.5 4273.3 4456.3 4521.3 4537.2 4586.9 55188.4 56749.0 57022.1 57231.4 57476.3 51442.2 51448.2 51538.2 52063.5 53611.2 46881.8 47145.0 47253.3 47792.8 48046.8 8820.8 8845.3 8924.7 9006.5 9034.4 31190.4 31641.5 31947.7 32112.2 32138.2 39117.0 40606.4 41262.6 41342.4 41685.8 10748.9 11179.4 11298.9 11323.3 11615.3 12229.8 12262.8 12327.9 12410.7 12417.6 11047.8 11091.9 11136.1 11170.9 11240.9 11106.3 11183.3 11200.7 11223.0 11230.8 10775.1 10813.2 10951.1 11037.0 11096.9 9717.8 9878.3 9935.8 10017.7 10430.4 10028.9 10098.7 10146.5 10286.3 10290.6 10:34:56 INFO - PROCESS | 2154 | -------- Summary: end -------- 10:34:56 INFO - PROCESS | 2154 | 10:34:57 INFO - TEST-INFO | 2154: exit 0 10:34:57 INFO - TEST-OK | dromaeo_css | took 1108357ms 10:34:57 INFO - TEST-START | kraken 10:34:57 INFO - operating with platform_type : linux_ 10:34:57 INFO - Initialising browser for kraken test... 10:34:57 INFO - TEST-INFO | started process 2482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCq5pZ/profile http://localhost:48148/getInfo.html) 10:35:00 INFO - PROCESS | 2482 | 10:35:00 INFO - PROCESS | 2482 | (process:2550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:35:01 INFO - PROCESS | 2482 | __metrics Screen width/height:1600/1200 10:35:01 INFO - PROCESS | 2482 | colorDepth:24 10:35:01 INFO - PROCESS | 2482 | Browser inner width/height: 1024/697 10:35:01 INFO - PROCESS | 2482 | __metrics 10:35:01 ERROR - PROCESS | 2482 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:35:02 INFO - TEST-INFO | 2482: exit 0 10:35:02 INFO - Browser initialized. 10:35:02 INFO - Running cycle 1/1 for kraken test... 10:35:02 INFO - TEST-INFO | started process 2601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCq5pZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:04 INFO - PROCESS | 2601 | 10:35:04 INFO - PROCESS | 2601 | (process:2694): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:35:14 INFO - PROCESS | 2601 | RSS: Main: 164323328 10:35:14 INFO - PROCESS | 2601 | 10:35:17 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48148/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:17 INFO - PROCESS | 2601 | RSS: Main: 169046016 10:35:17 INFO - PROCESS | 2601 | 10:35:20 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48148/tests/kraken/driver.html?testName=audio-dft) 10:35:21 INFO - PROCESS | 2601 | RSS: Main: 171507712 10:35:21 INFO - PROCESS | 2601 | 10:35:24 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48148/tests/kraken/driver.html?testName=audio-fft) 10:35:24 INFO - PROCESS | 2601 | RSS: Main: 163368960 10:35:24 INFO - PROCESS | 2601 | 10:35:26 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48148/tests/kraken/driver.html?testName=audio-oscillator) 10:35:27 INFO - PROCESS | 2601 | RSS: Main: 163524608 10:35:27 INFO - PROCESS | 2601 | 10:35:29 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:30 INFO - PROCESS | 2601 | RSS: Main: 164880384 10:35:30 INFO - PROCESS | 2601 | 10:35:33 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48148/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:34 INFO - PROCESS | 2601 | RSS: Main: 165969920 10:35:34 INFO - PROCESS | 2601 | 10:35:37 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48148/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:38 INFO - PROCESS | 2601 | RSS: Main: 165031936 10:35:38 INFO - PROCESS | 2601 | 10:35:41 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48148/tests/kraken/driver.html?testName=json-parse-financial) 10:35:41 INFO - PROCESS | 2601 | RSS: Main: 166522880 10:35:41 INFO - PROCESS | 2601 | 10:35:43 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:43 INFO - PROCESS | 2601 | RSS: Main: 166395904 10:35:43 INFO - PROCESS | 2601 | 10:35:45 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:46 INFO - PROCESS | 2601 | RSS: Main: 166457344 10:35:46 INFO - PROCESS | 2601 | 10:35:48 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:48 INFO - PROCESS | 2601 | RSS: Main: 166801408 10:35:48 INFO - PROCESS | 2601 | 10:35:51 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:52 INFO - PROCESS | 2601 | RSS: Main: 166793216 10:35:52 INFO - PROCESS | 2601 | 10:35:55 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:55 INFO - PROCESS | 2601 | RSS: Main: 166871040 10:35:55 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | Cycle 1(1): loaded http://localhost:48148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48148/tests/kraken/driver.html?testName=ai-astar) 10:35:57 INFO - PROCESS | 2601 | RSS: Main: 168239104 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | __start_tp_report 10:35:57 INFO - PROCESS | 2601 | _x_x_mozilla_page_load 10:35:57 INFO - PROCESS | 2601 | _x_x_mozilla_page_load_details 10:35:57 INFO - PROCESS | 2601 | |i|pagename|runs| 10:35:57 INFO - PROCESS | 2601 | |0;ai-astar;112;106;114;112;114;125;114;116;111;112 10:35:57 INFO - PROCESS | 2601 | |1;audio-beat-detection;153;134;155;179;137;163;160;134;198;131 10:35:57 INFO - PROCESS | 2601 | |2;audio-dft;164;166;163;164;166;176;163;165;167;164 10:35:57 INFO - PROCESS | 2601 | |3;audio-fft;89;80;78;175;79;79;79;79;182;78 10:35:57 INFO - PROCESS | 2601 | |4;audio-oscillator;94;94;151;93;93;95;152;92;93;148 10:35:57 INFO - PROCESS | 2601 | |5;imaging-gaussian-blur;117;117;117;118;117;117;121;120;117;117 10:35:57 INFO - PROCESS | 2601 | |6;imaging-darkroom;147;146;146;148;147;147;146;148;147;148 10:35:57 INFO - PROCESS | 2601 | |7;imaging-desaturate;96;95;95;96;96;97;95;95;95;96 10:35:57 INFO - PROCESS | 2601 | |8;json-parse-financial;58;57;62;57;57;57;61;74;55;56 10:35:57 INFO - PROCESS | 2601 | |9;json-stringify-tinderbox;62;62;63;63;63;62;63;64;65;64 10:35:57 INFO - PROCESS | 2601 | |10;stanford-crypto-aes;80;78;79;82;80;79;81;79;81;79 10:35:57 INFO - PROCESS | 2601 | |11;stanford-crypto-ccm;135;126;143;126;129;123;134;132;165;129 10:35:57 INFO - PROCESS | 2601 | |12;stanford-crypto-pbkdf2;176;177;173;179;178;173;173;175;173;173 10:35:57 INFO - PROCESS | 2601 | |13;stanford-crypto-sha256-iterative;72;71;70;69;71;71;70;71;70;69 10:35:57 INFO - PROCESS | 2601 | __end_tp_report 10:35:57 INFO - PROCESS | 2601 | __start_cc_report 10:35:57 INFO - PROCESS | 2601 | _x_x_mozilla_cycle_collect,828 10:35:57 INFO - PROCESS | 2601 | __end_cc_report 10:35:57 INFO - PROCESS | 2601 | __startTimestamp1462124157696__endTimestamp 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | ------- Summary: start ------- 10:35:57 INFO - PROCESS | 2601 | Number of tests: 14 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:4.81 (4.2%) stddev-sans-first:5.07 10:35:57 INFO - PROCESS | 2601 | Values: 112.0 106.0 114.0 112.0 114.0 125.0 114.0 116.0 111.0 112.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:157.50 stddev:21.85 (13.9%) stddev-sans-first:23.17 10:35:57 INFO - PROCESS | 2601 | Values: 153.0 134.0 155.0 179.0 137.0 163.0 160.0 134.0 198.0 131.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.82 (2.3%) stddev-sans-first:4.00 10:35:57 INFO - PROCESS | 2601 | Values: 164.0 166.0 163.0 164.0 166.0 176.0 163.0 165.0 167.0 164.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#3] audio-fft Cycles:10 Average:99.80 Median:79.00 stddev:41.64 (52.7%) stddev-sans-first:43.98 10:35:57 INFO - PROCESS | 2601 | Values: 89.0 80.0 78.0 175.0 79.0 79.0 79.0 79.0 182.0 78.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:93.00 stddev:27.52 (29.6%) stddev-sans-first:28.53 10:35:57 INFO - PROCESS | 2601 | Values: 94.0 94.0 151.0 93.0 93.0 95.0 152.0 92.0 93.0 148.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:1.48 (1.3%) stddev-sans-first:1.54 10:35:57 INFO - PROCESS | 2601 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 121.0 120.0 117.0 117.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:35:57 INFO - PROCESS | 2601 | Values: 147.0 146.0 146.0 148.0 147.0 147.0 146.0 148.0 147.0 148.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 10:35:57 INFO - PROCESS | 2601 | Values: 96.0 95.0 95.0 96.0 96.0 97.0 95.0 95.0 95.0 96.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:57.50 stddev:5.56 (9.7%) stddev-sans-first:5.88 10:35:57 INFO - PROCESS | 2601 | Values: 58.0 57.0 62.0 57.0 57.0 57.0 61.0 74.0 55.0 56.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 10:35:57 INFO - PROCESS | 2601 | Values: 62.0 62.0 63.0 63.0 63.0 62.0 63.0 64.0 65.0 64.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:1.23 (1.5%) stddev-sans-first:1.30 10:35:57 INFO - PROCESS | 2601 | Values: 80.0 78.0 79.0 82.0 80.0 79.0 81.0 79.0 81.0 79.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:133.00 stddev:12.23 (9.2%) stddev-sans-first:12.97 10:35:57 INFO - PROCESS | 2601 | Values: 135.0 126.0 143.0 126.0 129.0 123.0 134.0 132.0 165.0 129.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:175.50 stddev:2.36 (1.3%) stddev-sans-first:2.47 10:35:57 INFO - PROCESS | 2601 | Values: 176.0 177.0 173.0 179.0 178.0 173.0 173.0 175.0 173.0 173.0 10:35:57 INFO - PROCESS | 2601 | 10:35:57 INFO - PROCESS | 2601 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 10:35:57 INFO - PROCESS | 2601 | Values: 72.0 71.0 70.0 69.0 71.0 71.0 70.0 71.0 70.0 69.0 10:35:57 INFO - PROCESS | 2601 | -------- Summary: end -------- 10:35:57 INFO - PROCESS | 2601 | 10:35:58 INFO - TEST-INFO | 2601: exit 0 10:35:58 INFO - TEST-OK | kraken | took 61184ms 10:35:58 INFO - SUITE-END | took 1169s 10:35:58 INFO - Completed test suite (00:19:29) 10:35:58 INFO - javascript benchmark 10:35:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.546650735643, 3185.7292130168935, 3192.6328472225696, 3234.7573931955108, 3235.7573182011342, 5142.871428214292, 5154.510321519454, 5154.664946778456, 5163.277141200226, 5191.0, 4967.602591792657, 5057.367829021372, 5093.898122037557, 5112.284280200765, 5185.870353241162, 4635.281531362644, 4675.485696573374, 4709.317149013391, 4731.668783185179, 4751.073540659573, 819.1368253511313, 4697.9060418791605, 4716.811327546894, 4729.503402142777, 4776.402949631296, 4699.0, 4706.552877476634, 4723.173444647207, 4727.338172655831, 4735.834245801398, 4500.189965806154, 4692.718436893797, 4703.858884233478, 4779.952200477986, 4816.8795780105775, 4536.7504787236685, 4592.5177856324935, 4606.677532572721, 4646.326282688991, 4659.254519276899, 5029.597632189416, 5036.143855544567, 5064.544191022789, 5073.594112470993, 5092.490750924915, 5340.065488539529, 5421.0, 5456.863578410532, 5459.645123066988, 5471.425500322488, 5349.22436246742, 5350.224217488442, 5350.5452036576935, 5353.063213937546, 5411.702356370398, 5003.8874823069655, 5004.924926126111, 5025.346704928336, 5035.874103147414, 5085.923711144335, 5439.3200849893765, 5484.341878974548, 5566.0, 5633.859153521113, 5661.433856614306, 5312.840614781563, 5331.653442526223, 5332.120200167006, 5342.759575819097, 5353.197020446886, 5382.3541175059245, 5410.648307859977, 5411.729413529308, 5427.6200665953, 5463.754131064112, 5381.0583147948955, 5432.429594892558, 5434.375046869661, 5492.725363731797, 5504.724763761796, 5351.866203344947, 5450.236966824647, 5485.067538518461, 5509.421510741395, 5577.721113944286, 4387.4954380246045, 4394.934075988863, 4416.933745993812, 4424.491183513873, 4437.955620443754, 3831.4827498287373, 3840.8271627776817, 3889.0, 3902.570717221103, 3926.1166237596885, 5504.4770746779795, 5528.474794894479, 5536.0, 5555.666660000332, 5566.526845218121, 5346.251524786533, 5444.700541470257, 5486.561075113981, 5510.035743744908, 5543.695096769636, 5465.863353416196, 5510.228568000483, 5519.227308176858, 5536.778528858881, 5579.191017302468, 4872.1473742094995, 4878.365812444359, 4879.048585525859, 4904.485029071896, 4924.975375123101, 5887.705614719247, 5897.705114744332, 5899.587028908021, 5939.703014849327, 6055.878882422415, 5431.321084864392, 5463.371712253142, 5465.918011229915, 5470.425605311465, 5509.807156749414, 5935.0503919372695, 5938.8218353449465, 5963.224780778471, 5963.850903727442, 5970.940290597038, 5307.336582927134, 5333.12003519415, 5359.812406565751, 5362.946370536245, 5414.458554144554, 5431.782728690808, 5465.72671366438, 5474.835754927359, 5510.504054635102, 5519.8896022080135, 5334.359876814807, 5352.277442545206, 5361.812336568201, 5363.785448582013, 5404.405515393382, 5298.966701493172, 5334.439883812144, 5381.13901775714, 5452.400235974119, 5460.453954604508, 5118.155504341742, 5210.426853046086, 5244.711540865136, 5282.947170528246, 5329.600279979095, 5403.189521571639, 5418.783248670009, 5422.349318081855, 5436.67379957188, 5461.1808228766, 5148.459411761861, 5162.793488260428, 5251.107311756934, 5299.973500132474, 5354.812581559627], "value": 5077.180011083918, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9343372229057, 614.4838335797929, 629.8771739510796, 641.1472741254131, 644.6357807838568, 36325.27349453013, 37435.43846842293, 37669.43495847564, 37739.811300943526, 37903.0, 39859.40210896839, 40458.0, 40600.0, 40647.59352406475, 40648.18703625926, 8477.491350518972, 8758.912410875906, 8763.51800650964, 8767.605457754384, 8778.429402088876, 8728.389012769108, 8878.689245876396, 8909.866352004725, 8910.50992195429, 8923.732288031337, 8863.379563430562, 8944.910550894472, 8947.0, 8947.77630559238, 8959.641614335418, 8790.6923257686, 8804.163604457566, 8874.156955089224, 8884.333674974403, 8886.73339799807, 8624.266937310336, 8696.0, 8719.215270625611, 8747.16901894319, 8760.0, 40348.193036139404, 40695.0, 41037.589624103675, 41044.79477602593, 41185.38221926644, 3185.4584720597554, 3352.6479719629574, 3449.1721986723005, 3586.0317714217276, 3693.6675699187203, 27959.580606290718, 30761.538576921364, 31756.682433175603, 31824.363512729615, 32003.39983000864, 4208.747475151501, 4288.678349123828, 4300.569943005675, 4333.2200203963275, 4359.607635312837, 181226.0, 182012.0, 182199.0, 183558.16441835545, 184486.0, 31822.2044448886, 53921.460785391646, 54879.725601371734, 55035.0, 55112.72443637836, 32676.67323326784, 32681.67318326834, 32713.509297360557, 32727.83636081852, 32793.67206327906, 14984.10095394258, 15259.313330900137, 15296.235188240766, 15379.538613841603, 15392.307346169226, 12821.807672884914, 12956.0, 12994.285314307615, 13017.869821301856, 13031.739365212643, 8167.83664326722, 8299.543525106057, 8332.833343333099, 8371.748847534584, 8393.496390216484, 3268.624108227537, 3287.342531493711, 3298.191942973987, 3316.3201543683485, 3319.6680331967095, 917.5366439947784, 918.1782304837134, 992.9177196855462, 1003.3327836988321, 1069.657709532942, 27004.324891877466, 28852.855735721187, 29237.415251694845, 29827.85086074556, 29921.40157196844, 1097.2154909239932, 1114.793763153803, 1145.3128123126057, 1165.4930105404176, 1249.8312727781815, 15477.613059673373, 15706.450274240347, 15844.52466426009, 16096.839031609534, 16290.0, 459498.0, 461866.0, 463106.0, 464740.0, 465279.0, 53806.73096634492, 54713.1793023105, 54715.72642136764, 54800.725996369765, 55095.173572396445, 1391.047132714094, 1413.159170293653, 1419.74444599973, 1425.2659880161725, 1507.0279669613037, 28853.27866803347, 29354.559681604365, 29676.70323296826, 29681.703182967893, 29942.0, 47719.76140119277, 47904.76047619739, 48176.0, 48222.07111715492, 48224.0, 319412.0, 322726.0, 322945.0, 323503.0, 324297.0, 27255.454890901674, 27520.449591007666, 27650.86174569114, 27848.303792405353, 27854.582181267702, 46944.7652761734, 47316.52683473121, 47771.28343074926, 47959.0, 48005.279920800516, 40217.39673904952, 40323.79838100908, 40579.0, 41281.380779287734, 41903.371449428894, 40439.595604043585, 40699.59300407077, 40999.59000409958, 41391.7930410346, 41658.16683666249, 35656.64343356533, 37176.0, 40188.397174043, 41228.0, 41270.79364603278, 33911.32177356489, 34941.8252908744, 35159.29681406306, 35554.0, 35613.82193089018, 27049.59425608578, 27087.45825083527, 27172.72827271702, 27207.727922720518, 27480.725192747817], "value": 17825.224257115027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.464472771029, 381.32695791927233, 393.54742046646356, 394.6270774118459, 400.0, 16586.33654653814, 18386.08069596518, 18831.775934564263, 18864.0, 18887.527811804714, 17635.73546396802, 18148.455546333596, 18556.350527731498, 18596.07019649019, 18689.90655046723, 5419.810306639279, 5458.1266997280445, 5629.324481062258, 5659.801906933259, 5667.914981275284, 5493.945060549403, 5561.193626924093, 5574.804881829137, 5582.385937546866, 5592.748326325325, 5251.133562962106, 5510.972445137789, 5517.917231241535, 5527.806526771564, 5545.722713864311, 5533.529649979757, 5560.4161563035705, 5561.388247292814, 5566.805161819337, 5592.944070559283, 4891.315215869781, 4928.088303663833, 4943.6539442239055, 4967.552920237196, 5028.170351891933, 21658.24196153143, 21850.672239916414, 21947.780522194735, 22126.0, 22129.889350553145, 2340.040583360831, 2501.124606387768, 2580.9870950645313, 2640.485105404447, 2794.538901081319, 13374.933125334408, 13641.86358136416, 13677.452901883913, 13877.861221387759, 14239.644008899757, 1921.3563456242175, 2014.2547257514666, 2018.3238615063972, 2020.464576887126, 2054.95890082199, 79754.20245797584, 81005.59497202536, 81136.59431702863, 82041.58979205065, 82530.17469825345, 9509.66716164931, 9693.41839489633, 10178.0, 10337.276390652582, 10392.168626509861, 14278.0, 14374.0, 14382.065165764192, 14421.92789036048, 14439.783403248959, 8116.675332986614, 8169.673213071529, 8225.0, 8256.876146857801, 8319.500829950222, 7823.100343460575, 7960.1243863175005, 7974.840503189904, 7993.640286187136, 8148.10370859205, 5950.214935519327, 6241.126242326078, 6309.7160627770945, 6342.460890824239, 6402.743890244431, 1837.5498002989352, 1844.4374465788064, 1864.8787828791085, 1886.5755205079022, 1887.5186827358937, 968.2254196642658, 1043.5356266461504, 1069.1019543583427, 1105.1987309200927, 1157.0801213035656, 18045.458636240935, 18262.151693115084, 18428.737010192766, 18478.722819157454, 18598.44204673862, 1032.0866033560353, 1037.180627304421, 1074.355386767933, 1092.8688557373166, 1180.7048237940514, 10598.205134614935, 10672.46637668129, 10793.24447288698, 10795.352278863136, 10801.24391292602, 415627.0, 417893.0, 420108.0, 431475.0, 434112.0, 79105.0, 82122.58938705268, 82243.58878205571, 82592.58703706563, 82744.58627706823, 1003.3595072057093, 1009.369144284822, 1037.4501514197486, 1037.9117774989058, 1069.7593041565742, 15198.46805361807, 15662.843371566138, 15702.9214853925, 15810.0, 15960.920195398949, 36783.0, 37243.0, 38692.80653596714, 39691.40462893117, 39752.60247397489, 52527.47472525226, 52572.0, 52653.0, 52774.47225527695, 53142.20286695625, 7970.521768693897, 8460.492370457792, 8477.915220847712, 8519.616617252363, 8606.26846718036, 7066.611336376549, 11303.547858085585, 12842.97256219519, 12911.418986145458, 13556.864431355954, 11300.49147788368, 11741.882581174421, 12048.638540843789, 12098.334591597546, 12099.0, 11709.180357375242, 11722.179447438597, 11802.173847830569, 11814.978634080653, 11936.522539098687, 11826.46780894879, 12041.75916481648, 12080.697982550506, 12233.388330583613, 12403.62789116328, 8185.631646575799, 8359.289460395692, 8441.0, 8463.449875758057, 8531.701390451553, 11874.109441791727, 12071.818922715991, 12098.395080245777, 12178.878211217774, 12221.266723996589], "value": 9124.52508594695, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.6352875309929, 1531.2573401900077, 1644.0628841560308, 1756.273472599943, 1787.4816303272053, 7345.7428989985365, 7779.260970207835, 7965.6813727450835, 8122.51264924105, 8182.22268884455, 7960.840783184347, 7971.720989765359, 7988.400869934749, 7996.680132794696, 8022.1576734442915, 2125.7342832145982, 2160.1467420368945, 2160.2655097267007, 2160.956780864382, 2162.37291185556, 2107.936761897138, 2111.6410210264216, 2160.459885028743, 2171.8045375916163, 2172.728408948881, 2008.7589489261309, 2028.4117605894273, 2034.287999200283, 2036.6334059869218, 2046.6316063108634, 2073.8444616653737, 2076.3874656976077, 2077.542940553076, 2088.613606482798, 2094.95810083799, 1970.5072434848569, 2044.877307361563, 2078.605065037638, 2102.959035277532, 2103.1272022110807, 8147.429679922408, 8167.877481837777, 8193.959030204871, 8229.423940324179, 8254.669813207465, 4702.083093796711, 4844.709317440965, 4864.0, 4868.269759536062, 4882.877928051792, 2889.9133026009254, 2990.0880231529377, 3028.9697103028907, 3054.6487153977355, 3098.4267910436643, 965.1603105298365, 976.2482888176136, 987.6197663899378, 995.9402435853872, 1004.9045340692622, 10523.789524209473, 10806.081483073947, 10914.617988370448, 10935.726606834813, 10937.83593246102, 3967.147063381387, 4064.9593504064583, 4115.835366585363, 4138.358554424069, 4142.71001029931, 8961.686340978165, 9005.459672419676, 9025.142611451902, 9054.275657947348, 9075.591598378089, 4840.975795121002, 4857.465678775332, 4873.926891096637, 4878.0975519529, 4901.50984901507, 3937.370020796659, 4408.669349798778, 4497.775111244425, 4550.180967425829, 4615.746133962597, 3488.8081155536183, 3562.9643703562633, 3586.264815712773, 3594.928101438009, 3597.1007248187952, 1000.9499525023865, 1010.3079390617451, 1017.4861694844057, 1031.8916513765946, 1045.6706137566641, 846.9915300846912, 974.3617930255693, 983.7196399026243, 1003.4581326083979, 1014.8883622801486, 5466.890662186734, 5507.449255074541, 5630.493255607015, 5647.1529270609735, 5693.943060569424, 353.2687337211947, 353.6693191865614, 365.8426876443155, 382.30993057531424, 408.7036898248746, 3936.193080418507, 3996.680265578747, 3999.4000899865255, 4025.8590949316635, 4039.5758445363404, 9671.661491847752, 10177.236707246986, 10179.44013079273, 10189.694309170736, 10204.642837500653, 9491.050894910592, 9782.11960923506, 9864.309498335191, 10097.848532272023, 10109.191264698806, 7494.475386722877, 7630.656620451982, 7653.885191722128, 7657.885131723028, 7725.613719314012, 5415.810446634507, 5627.634203776742, 5630.971845140912, 5642.6614403135945, 5711.885762284648, 9052.683156089506, 9133.680321188727, 9146.95426522863, 9179.173874351074, 9247.583858726508, 9378.624855005995, 9453.0, 9583.0, 9818.803623927339, 9828.213742900407, 7322.450816188913, 7343.5961022142155, 7452.92547074544, 7502.062242219723, 7528.736494222676, 8069.475484093515, 8100.311473524581, 8125.537403267233, 8142.389320800845, 8238.052623948322, 6843.7604683835825, 7210.278972102958, 7425.146108197627, 7449.478536502393, 7573.583452910143, 7205.963970180115, 7286.854262914606, 7361.521501102411, 7427.591482468516, 7440.55356678601, 6649.966750166218, 6703.195616526048, 6718.764843230463, 6723.2604413515455, 6730.629815360006, 4920.753962301942, 4950.6782059166035, 5005.274235235797, 5005.949940500548, 5075.92386114216, 5069.112905241494, 5077.060743762416, 5146.69119852795, 5146.9227961581355, 5181.922271166011], "value": 4192.8805642537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.17172271107006, 291.1135592121988, 293.3882854248891, 293.53474742533075, 294.4008941803431, 5064.126273278883, 5144.871378215537, 5196.2725218469395, 5264.104742391683, 5278.524932756051, 5193.5066168714, 5224.817131400402, 5228.29418028566, 5243.659162154458, 5259.0, 4018.095928416112, 4020.8793736187963, 4029.697772667047, 4040.2929487339743, 4062.2281766464275, 3941.960580394188, 4056.6957478189106, 4057.898552536181, 4083.367078102884, 4088.100617864065, 4006.697823207455, 4013.357862741962, 4029.194161167778, 4029.8917797605745, 4047.8380864765372, 3980.6218409251073, 4006.3189257825948, 4024.7585144891254, 4032.8185231664647, 4044.7865640307937, 3528.641473032875, 3548.5273611451216, 3555.666625015619, 3568.7145028397667, 3570.83931223093, 4946.208606622923, 4966.528179822911, 5045.772940217699, 5053.747312634354, 5100.285959965608, 4527.592516673515, 4551.294549344857, 4552.248878934972, 4555.863324100283, 4583.197940360424, 5378.435264297232, 5407.540359069484, 5421.695779293824, 5428.240046393508, 5438.646487978269, 3812.7712337259854, 3877.418387241908, 3901.941470877939, 3905.199434116028, 3909.7654140751647, 5675.489205971482, 5703.629264097862, 5714.942850571482, 5726.370099289116, 5742.54059675225, 3949.1114499238015, 3953.5058117735284, 3956.3669812829808, 3964.702647301406, 3965.20695860829, 3578.2306804036734, 3809.2381523694817, 4003.619656132663, 4005.5193376794386, 4009.67922566194, 4457.375967364572, 4467.106578684276, 4479.275478940632, 4480.4623445186135, 4496.865094047183, 5413.83758487246, 5418.8916221675345, 5474.795544980098, 5475.342958844964, 5489.2589500417735, 1339.7320535892861, 1378.5381897064597, 1378.5726424808342, 1388.9097208681403, 1392.6978275312413, 886.1714297132202, 889.666375109334, 897.5736525150501, 898.1467605774541, 905.791667916383, 5935.139404786368, 5940.287165540163, 5951.7619295227705, 5959.433853783884, 5971.761129554856, 5871.295444546682, 5929.733162007634, 5937.910931336033, 5943.286805583358, 5968.850778730566, 5820.35976042635, 5834.183214349994, 5860.413958604191, 5911.527077833763, 5928.288605367384, 3132.6867313268945, 3149.0238026211946, 3159.984200078985, 3178.5867837181017, 3184.4268031754045, 6385.5210859185745, 6573.934260657428, 6599.571027883172, 6600.108985287021, 6600.867982640416, 6024.216851809237, 6056.576039677268, 6077.817665470043, 6081.513478921675, 6103.42017508336, 6440.4847612190915, 6517.51118666102, 6519.3154718754795, 6550.541462097703, 6574.408303252731, 5724.284464441945, 5918.2898052234, 5934.643921364732, 5937.079752638348, 5946.791862284799, 5848.5028772553105, 5854.736536855937, 5886.6173698709445, 5899.0, 5899.144624029577, 6368.42684158428, 6510.47916166715, 6552.83617909537, 6560.967195164185, 6581.605103693793, 3956.050547868433, 3963.2073585283633, 3964.900877478086, 3965.068208970947, 3981.581933896899, 5322.547583455294, 5906.822795316148, 5923.674197919156, 5954.46409823118, 5969.820905372846, 5313.335833020872, 5421.132618780976, 5455.8363249102595, 5455.918161227664, 5461.787975869779, 5461.825707472913, 5467.125259958388, 5469.699166545878, 5490.835274941758, 5511.559075273888, 5240.5588463172935, 5369.597280203922, 5397.460253974571, 5404.729888476283, 5419.187121931742, 5495.477929596682, 5501.487091049993, 5512.5314348280845, 5534.280543529316, 5536.003519366553, 5400.324959380077, 5401.972990135181, 5410.323709536308, 5425.13197888336, 5426.585169599491], "value": 4243.72852030138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.9090509138904, 797.768647092343, 817.9754607361778, 827.3381294964029, 845.4927043773737, 13495.66260843477, 13555.864441355583, 14054.999999999987, 14747.115173089622, 14987.400503979841, 13430.932845335785, 13450.596482105528, 13470.0, 13494.662633434145, 13610.795838062437, 795.5425630262594, 809.4859764049812, 810.1372038778711, 814.3281792521165, 814.3810703865046, 817.199144838059, 817.8159914019328, 822.8847961285425, 825.558326295432, 838.3335248477475, 849.562475325208, 853.3685073045932, 853.6500034985658, 854.363499193099, 863.8661007543809, 842.3303473738392, 844.472204871955, 845.306848384322, 849.6941101203562, 867.540203692041, 627.425905296653, 631.5011141198447, 634.1597383466925, 634.8127302445789, 637.7863415755727, 12945.54690585825, 13000.804987925188, 13057.477700891954, 13064.673383165402, 13087.0, 13970.51103211393, 13975.930120349332, 14075.085119467201, 14094.859051409458, 14182.92908535461, 10988.395638239894, 11194.272372295774, 11221.102311815035, 11284.887151128465, 11376.544938202462, 3848.634379733921, 3870.4000879863665, 3961.0, 3983.4224037514687, 4061.5938406159444, 51441.22838157431, 51570.484295156944, 52730.20904686433, 52847.471525284636, 52938.20592691074, 10799.0, 11068.557257709763, 11074.143308359464, 11254.662360129209, 11279.943600281946, 19766.60466790685, 19819.10814013373, 19950.800491994894, 20024.89987550053, 20529.589408211752, 8416.74749757496, 8531.829363412697, 8580.0, 8637.093105223861, 8776.648934042694, 4823.807047718122, 4842.685225460334, 4863.2461968394955, 4940.901181976412, 4940.950590494121, 3228.967710322867, 3305.5206994986074, 3308.553345298402, 3312.950305745416, 3317.784344017631, 586.9442402971711, 597.068573026072, 597.1520440973827, 610.9266887973472, 612.7579606055583, 690.7962151165418, 700.3871612339203, 772.2854167600888, 781.1329424338979, 787.747920665393, 9182.724518264462, 9393.503595338458, 9475.147236748726, 9511.66709165176, 9515.524223788783, 708.840510885057, 729.031649309951, 740.174705203694, 745.5824738146655, 750.512167091395, 4273.273543497613, 4456.286994080931, 4521.321801729701, 4537.1833070047705, 4586.862394128181, 55188.44811551833, 56749.0, 57022.14466783001, 57231.42768572344, 57476.27571172788, 51442.228366574534, 51448.22827657588, 51538.22692659613, 52063.479365205865, 53611.19583206255, 46881.76559117251, 47145.0, 47253.29120063202, 47792.7610361946, 48046.75976620094, 8820.779480512781, 8845.336599754915, 8924.68763593271, 9006.54967251648, 9034.367594268339, 31190.376192476477, 31641.5253771189, 31947.6805231954, 32112.197195070312, 32138.19654508656, 39117.0, 40606.39090413587, 41262.58737412708, 41342.37986430266, 41685.79157104316, 10748.89251107479, 11179.441027948733, 11298.943505282421, 11323.32060076398, 11615.303081815118, 12229.75540489203, 12262.754744904874, 12327.93836030814, 12410.689732756753, 12417.62747117588, 11047.779044419227, 11091.944540277247, 11136.053435458076, 11170.944145279222, 11240.943795280971, 11106.278091924, 11183.273087249303, 11200.719982000515, 11223.0, 11230.83153752678, 10775.137988961022, 10813.243072984815, 10951.123910087015, 11037.0, 11096.944515277371, 9717.805643887225, 9878.308518403643, 9935.752958484816, 10017.69946901594, 10430.374177549067, 10028.949855250678, 10098.697039088838, 10146.492675366055, 10286.331388459726, 10290.588376464857], "value": 6568.992257752297, "unit": "score"}], "name": "dromaeo_css", "value": 6772.9610114750685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 114.0, 112.0, 114.0, 125.0, 114.0, 116.0, 111.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 134.0, 155.0, 179.0, 137.0, 163.0, 160.0, 134.0, 198.0, 131.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 163.0, 164.0, 166.0, 176.0, 163.0, 165.0, 167.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 78.0, 175.0, 79.0, 79.0, 79.0, 79.0, 182.0, 78.0], "value": 99.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 151.0, 93.0, 93.0, 95.0, 152.0, 92.0, 93.0, 148.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 121.0, 120.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 62.0, 57.0, 57.0, 57.0, 61.0, 74.0, 55.0, 56.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0, 65.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 82.0, 80.0, 79.0, 81.0, 79.0, 81.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 143.0, 126.0, 129.0, 123.0, 134.0, 132.0, 165.0, 129.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 173.0, 179.0, 178.0, 173.0, 173.0, 175.0, 173.0, 173.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 70.0, 69.0, 71.0, 71.0, 70.0, 71.0, 70.0, 69.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1586.4, "alertThreshold": 2.0}]} 10:35:58 INFO - Return code: 0 10:35:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:35:59 ERROR - # TBPL SUCCESS # 10:35:59 INFO - Running post-action listener: _resource_record_post_action 10:35:59 INFO - Running post-run listener: _resource_record_post_run 10:36:00 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364064768; Read time: 8; Write time: 275840 10:36:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 73916416; Read time: 0; Write time: 64632 10:36:00 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290148352; Read time: 8; Write time: 211208 10:36:00 INFO - Running post-run listener: _upload_blobber_files 10:36:00 INFO - Blob upload gear active. 10:36:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:00 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 10:36:00 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:36:00 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:36:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:01 INFO - (blobuploader) - INFO - Done attempting. 10:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:02 INFO - (blobuploader) - INFO - Done attempting. 10:36:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:02 INFO - Return code: 0 10:36:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ac4bdd8579421661e5a0f8ffd8e59d5b30c677b1a150f9e0727426af49a8dc208ad9dde6b6751b8e8f4eda895d587739da0b4e4d76c6019278f2dd96c0bdc46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0b28cd3957436c8f0840d152beee30ba7d1ff37a5f83d80613a70f48c629cb6a906f2f3220e4605d4b91d8b1d8196415b9c58f53928b544941de5510a4f5511"} 10:36:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:02 INFO - Contents: 10:36:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ac4bdd8579421661e5a0f8ffd8e59d5b30c677b1a150f9e0727426af49a8dc208ad9dde6b6751b8e8f4eda895d587739da0b4e4d76c6019278f2dd96c0bdc46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0b28cd3957436c8f0840d152beee30ba7d1ff37a5f83d80613a70f48c629cb6a906f2f3220e4605d4b91d8b1d8196415b9c58f53928b544941de5510a4f5511"} 10:36:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:02 INFO - Copying logs to upload dir... 10:36:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2126.862272 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 26 secs) (at 2016-05-01 10:36:02.103974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 10:36:02.107426) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ac4bdd8579421661e5a0f8ffd8e59d5b30c677b1a150f9e0727426af49a8dc208ad9dde6b6751b8e8f4eda895d587739da0b4e4d76c6019278f2dd96c0bdc46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0b28cd3957436c8f0840d152beee30ba7d1ff37a5f83d80613a70f48c629cb6a906f2f3220e4605d4b91d8b1d8196415b9c58f53928b544941de5510a4f5511"} build_url:https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/f8t4d-UCR7eB9CBQXKFiMg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ac4bdd8579421661e5a0f8ffd8e59d5b30c677b1a150f9e0727426af49a8dc208ad9dde6b6751b8e8f4eda895d587739da0b4e4d76c6019278f2dd96c0bdc46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0b28cd3957436c8f0840d152beee30ba7d1ff37a5f83d80613a70f48c629cb6a906f2f3220e4605d4b91d8b1d8196415b9c58f53928b544941de5510a4f5511"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 10:36:02.134239) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:36:02.134624) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462117220.179324-1533046544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 10:36:02.218724) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 10:36:02.219435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 10:36:02.220124) ========= ========= Total master_lag: 0.15 =========