builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1461635673.95 results: success (0) buildid: 20160425163001 builduid: 9420a187edb24558b4255de3a26d0614 revision: 79de998e7307650fec99ea6188ae60ac64ebeedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:33.951852) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:33.952305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:33.952743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:33.969067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:33.969375) ========= 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=0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 18:54:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2016-04-25 18:54:34 (17.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150961 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.133279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.133614) ========= 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=0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019911 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.187055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.187414) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 79de998e7307650fec99ea6188ae60ac64ebeedb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 79de998e7307650fec99ea6188ae60ac64ebeedb --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=0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 18:54:34,248 truncating revision to first 12 chars 2016-04-25 18:54:34,248 Setting DEBUG logging. 2016-04-25 18:54:34,248 attempt 1/10 2016-04-25 18:54:34,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/79de998e7307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 18:54:34,516 unpacking tar archive at: mozilla-central-79de998e7307/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563624 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.763989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.764297) ========= script_repo_revision: 79de998e7307650fec99ea6188ae60ac64ebeedb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.764687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.764976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 18:54:34.774386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-25 18:54:34.774899) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:54:34 INFO - MultiFileLogger online at 20160425 18:54:34 in /builds/slave/test 18:54:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:54:34 INFO - {'append_to_log': False, 18:54:34 INFO - 'base_work_dir': '/builds/slave/test', 18:54:34 INFO - 'blob_upload_branch': 'Firefox', 18:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:54:34 INFO - 'branch': 'Firefox', 18:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:54:34 INFO - 'config_files': ('talos/linux_config.py',), 18:54:34 INFO - 'default_actions': ('clobber', 18:54:34 INFO - 'read-buildbot-config', 18:54:34 INFO - 'download-and-extract', 18:54:34 INFO - 'populate-webroot', 18:54:34 INFO - 'create-virtualenv', 18:54:34 INFO - 'install', 18:54:34 INFO - 'run-tests'), 18:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:54:34 INFO - 'download_minidump_stackwalk': True, 18:54:34 INFO - 'download_symbols': 'ondemand', 18:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:54:34 INFO - 'installer_path': 'installer.exe', 18:54:34 INFO - 'log_level': 'info', 18:54:34 INFO - 'log_name': 'talos', 18:54:34 INFO - 'log_to_console': True, 18:54:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:54:34 INFO - 'opt_config_files': (), 18:54:34 INFO - 'pip_index': False, 18:54:34 INFO - 'sps_profile': False, 18:54:34 INFO - 'sps_profile_interval': 0, 18:54:34 INFO - 'suite': 'dromaeojs', 18:54:34 INFO - 'system_bits': '32', 18:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:54:34 INFO - 'title': 'talos-linux64-ix-058', 18:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:54:34 INFO - 'use_talos_json': True, 18:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:54:34 INFO - 'work_dir': 'build'} 18:54:34 INFO - ##### 18:54:34 INFO - ##### Running clobber step. 18:54:34 INFO - ##### 18:54:34 INFO - Running pre-action listener: _resource_record_pre_action 18:54:34 INFO - Running main action method: clobber 18:54:34 INFO - rmtree: /builds/slave/test/build 18:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:54:35 INFO - Running post-action listener: _resource_record_post_action 18:54:35 INFO - ##### 18:54:35 INFO - ##### Running read-buildbot-config step. 18:54:35 INFO - ##### 18:54:35 INFO - Running pre-action listener: _resource_record_pre_action 18:54:35 INFO - Running main action method: read_buildbot_config 18:54:35 INFO - Using buildbot properties: 18:54:35 INFO - { 18:54:35 INFO - "project": "", 18:54:35 INFO - "product": "firefox", 18:54:35 INFO - "script_repo_revision": "production", 18:54:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:54:35 INFO - "repository": "", 18:54:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:54:35 INFO - "buildid": "20160425163001", 18:54:35 INFO - "pgo_build": "True", 18:54:35 INFO - "basedir": "/builds/slave/test", 18:54:35 INFO - "buildnumber": 419, 18:54:35 INFO - "slavename": "talos-linux64-ix-058", 18:54:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:54:35 INFO - "platform": "ubuntu64_hw", 18:54:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:54:35 INFO - "branch": "mozilla-central", 18:54:35 INFO - "repo_path": "mozilla-central", 18:54:35 INFO - "revision": "79de998e7307650fec99ea6188ae60ac64ebeedb", 18:54:35 INFO - "stage_platform": "linux64-pgo", 18:54:35 INFO - "builduid": "9420a187edb24558b4255de3a26d0614", 18:54:35 INFO - "slavebuilddir": "test" 18:54:35 INFO - } 18:54:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:54:35 INFO - Running post-action listener: _resource_record_post_action 18:54:35 INFO - ##### 18:54:35 INFO - ##### Running download-and-extract step. 18:54:35 INFO - ##### 18:54:35 INFO - Running pre-action listener: _resource_record_pre_action 18:54:35 INFO - Running main action method: download_and_extract 18:54:35 INFO - mkdir: /builds/slave/test/build/tests 18:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:35 INFO - https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:36 INFO - Downloaded 1361 bytes. 18:54:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:54:36 INFO - Using the following test package requirements: 18:54:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:54:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:54:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'jsshell-linux-x86_64.zip'], 18:54:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:54:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:54:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:54:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:54:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:54:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:36 INFO - https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:38 INFO - Downloaded 23860733 bytes. 18:54: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'] 18:54: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 18:54:39 INFO - Return code: 0 18:54: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 18:54: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')]} 18:54:39 INFO - https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:40 INFO - Downloaded 23860733 bytes. 18:54:40 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'] 18:54:40 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 18:54:42 INFO - Return code: 0 18:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:42 INFO - https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:43 INFO - Downloaded 10840145 bytes. 18:54: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'] 18:54: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 18:54:43 INFO - Return code: 0 18:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:43 INFO - https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:54:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:54:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:54:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SazbZHfQQ36JaFwoIvlLXg/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 18:54:45 INFO - Downloaded 58344577 bytes. 18:54:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:54:45 INFO - mkdir: /builds/slave/test/properties 18:54:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:54:45 INFO - Writing to file /builds/slave/test/properties/build_url 18:54:45 INFO - Contents: 18:54:45 INFO - build_url:https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:54:45 INFO - Running post-action listener: _resource_record_post_action 18:54:45 INFO - Running post-action listener: set_extra_try_arguments 18:54:45 INFO - ##### 18:54:45 INFO - ##### Running populate-webroot step. 18:54:45 INFO - ##### 18:54:45 INFO - Running pre-action listener: _resource_record_pre_action 18:54:45 INFO - Running main action method: populate_webroot 18:54:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:54:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:54:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:54:45 INFO - '--tppagecycles', 18:54:45 INFO - '7'], 18:54:45 INFO - 'tests': ['tsvgm']}}, 18:54:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:54:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:54:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:54:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:54:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['damp', 'tps']}, 18:54:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'tests': ['damp', 'tps']}, 18:54:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['dromaeo_dom']}, 18:54:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:54:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['a11yr', 18:54:45 INFO - 'ts_paint', 18:54:45 INFO - 'tpaint', 18:54:45 INFO - 'sessionrestore', 18:54:45 INFO - 'sessionrestore_no_auto_restore', 18:54:45 INFO - 'tabpaint']}, 18:54:45 INFO - 'other-e10s': {'tests': ['a11yr', 18:54:45 INFO - 'ts_paint', 18:54:45 INFO - 'tpaint', 18:54:45 INFO - 'sessionrestore', 18:54:45 INFO - 'sessionrestore_no_auto_restore', 18:54:45 INFO - 'tabpaint']}, 18:54:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:54:45 INFO - 'ts_paint', 18:54:45 INFO - 'tpaint', 18:54:45 INFO - 'sessionrestore', 18:54:45 INFO - 'sessionrestore_no_auto_restore', 18:54:45 INFO - 'tabpaint']}, 18:54:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:54:45 INFO - 'ts_paint', 18:54:45 INFO - 'tpaint', 18:54:45 INFO - 'sessionrestore', 18:54:45 INFO - 'sessionrestore_no_auto_restore', 18:54:45 INFO - 'tabpaint']}, 18:54:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['a11yr', 18:54:45 INFO - 'ts_paint', 18:54:45 INFO - 'tpaint', 18:54:45 INFO - 'sessionrestore', 18:54:45 INFO - 'sessionrestore_no_auto_restore', 18:54:45 INFO - 'tabpaint']}, 18:54:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['a11yr', 18:54:45 INFO - 'ts_paint', 18:54:45 INFO - 'tpaint', 18:54:45 INFO - 'sessionrestore', 18:54:45 INFO - 'sessionrestore_no_auto_restore', 18:54:45 INFO - 'tabpaint']}, 18:54:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['tsvgx', 18:54:45 INFO - 'tsvgr_opacity', 18:54:45 INFO - 'tart', 18:54:45 INFO - 'tscrollx', 18:54:45 INFO - 'cart']}, 18:54:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:54:45 INFO - 'tsvgr_opacity', 18:54:45 INFO - 'tart', 18:54:45 INFO - 'tscrollx', 18:54:45 INFO - 'cart']}, 18:54:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'talos_options': ['--disable-e10s'], 18:54:45 INFO - 'tests': ['tp5o']}, 18:54:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'tests': ['tp5o']}, 18:54:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'talos_options': ['--disable-e10s', 18:54:45 INFO - '--xperf_path', 18:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:45 INFO - 'tests': ['tp5n']}, 18:54:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:45 INFO - 'talos_options': ['--xperf_path', 18:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:45 INFO - 'tests': ['tp5n']}}, 18:54:45 INFO - 'talos.zip': {'path': '', 18:54:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:54:45 INFO - Running post-action listener: _resource_record_post_action 18:54:45 INFO - ##### 18:54:45 INFO - ##### Running create-virtualenv step. 18:54:45 INFO - ##### 18:54:45 INFO - Running pre-action listener: _resource_record_pre_action 18:54:45 INFO - Running main action method: create_virtualenv 18:54:45 INFO - Creating virtualenv /builds/slave/test/build/venv 18:54:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:54:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:54:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:54:46 INFO - Using real prefix '/usr' 18:54:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:54:48 INFO - Installing pip.................done. 18:54:48 INFO - Return code: 0 18:54:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:48 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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:54:48 INFO - Using env: {'DISPLAY': ':0', 18:54:48 INFO - 'HOME': '/home/cltbld', 18:54:48 INFO - 'LANG': 'en_US.UTF-8', 18:54:48 INFO - 'LANGUAGE': 'en_US:en', 18:54:48 INFO - 'LOGNAME': 'cltbld', 18:54:48 INFO - 'MAIL': '/var/mail/cltbld', 18:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:48 INFO - 'MOZ_NO_REMOTE': '1', 18:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:48 INFO - 'NO_EM_RESTART': '1', 18:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:48 INFO - 'PWD': '/builds/slave/test', 18:54:48 INFO - 'SHELL': '/bin/bash', 18:54:48 INFO - 'SHLVL': '1', 18:54:48 INFO - 'TERM': 'linux', 18:54:48 INFO - 'TMOUT': '86400', 18:54:48 INFO - 'USER': 'cltbld', 18:54:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:48 INFO - '_': '/tools/buildbot/bin/python'} 18:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:54:48 INFO - Cleaning up... 18:54:48 INFO - Return code: 0 18:54:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:48 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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:48 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 18:54:48 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 18:54:48 INFO - Using env: {'DISPLAY': ':0', 18:54:48 INFO - 'HOME': '/home/cltbld', 18:54:48 INFO - 'LANG': 'en_US.UTF-8', 18:54:48 INFO - 'LANGUAGE': 'en_US:en', 18:54:48 INFO - 'LOGNAME': 'cltbld', 18:54:48 INFO - 'MAIL': '/var/mail/cltbld', 18:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:48 INFO - 'MOZ_NO_REMOTE': '1', 18:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:48 INFO - 'NO_EM_RESTART': '1', 18:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:48 INFO - 'PWD': '/builds/slave/test', 18:54:48 INFO - 'SHELL': '/bin/bash', 18:54:48 INFO - 'SHLVL': '1', 18:54:48 INFO - 'TERM': 'linux', 18:54:48 INFO - 'TMOUT': '86400', 18:54:48 INFO - 'USER': 'cltbld', 18:54:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:48 INFO - '_': '/tools/buildbot/bin/python'} 18:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:48 INFO - Downloading/unpacking psutil>=0.7.1 18:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:50 INFO - Installing collected packages: psutil 18:54:50 INFO - Running setup.py install for psutil 18:54:51 INFO - building 'psutil._psutil_linux' extension 18:54: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 18:54: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 18:54:51 INFO - building 'psutil._psutil_posix' extension 18:54: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 18:54: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:51 INFO - Successfully installed psutil 18:54:51 INFO - Cleaning up... 18:54:51 INFO - Return code: 0 18:54:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:51 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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:51 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 18:54:51 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 18:54:51 INFO - Using env: {'DISPLAY': ':0', 18:54:51 INFO - 'HOME': '/home/cltbld', 18:54:51 INFO - 'LANG': 'en_US.UTF-8', 18:54:51 INFO - 'LANGUAGE': 'en_US:en', 18:54:51 INFO - 'LOGNAME': 'cltbld', 18:54:51 INFO - 'MAIL': '/var/mail/cltbld', 18:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:51 INFO - 'MOZ_NO_REMOTE': '1', 18:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:51 INFO - 'NO_EM_RESTART': '1', 18:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:51 INFO - 'PWD': '/builds/slave/test', 18:54:51 INFO - 'SHELL': '/bin/bash', 18:54:51 INFO - 'SHLVL': '1', 18:54:51 INFO - 'TERM': 'linux', 18:54:51 INFO - 'TMOUT': '86400', 18:54:51 INFO - 'USER': 'cltbld', 18:54:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:51 INFO - '_': '/tools/buildbot/bin/python'} 18:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:54:53 INFO - Installing collected packages: mozsystemmonitor 18:54:53 INFO - Running setup.py install for mozsystemmonitor 18:54:53 INFO - Successfully installed mozsystemmonitor 18:54:53 INFO - Cleaning up... 18:54:53 INFO - Return code: 0 18:54:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:53 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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:54:53 INFO - Using env: {'DISPLAY': ':0', 18:54:53 INFO - 'HOME': '/home/cltbld', 18:54:53 INFO - 'LANG': 'en_US.UTF-8', 18:54:53 INFO - 'LANGUAGE': 'en_US:en', 18:54:53 INFO - 'LOGNAME': 'cltbld', 18:54:53 INFO - 'MAIL': '/var/mail/cltbld', 18:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:53 INFO - 'MOZ_NO_REMOTE': '1', 18:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:53 INFO - 'NO_EM_RESTART': '1', 18:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:53 INFO - 'PWD': '/builds/slave/test', 18:54:53 INFO - 'SHELL': '/bin/bash', 18:54:53 INFO - 'SHLVL': '1', 18:54:53 INFO - 'TERM': 'linux', 18:54:53 INFO - 'TMOUT': '86400', 18:54:53 INFO - 'USER': 'cltbld', 18:54:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:53 INFO - '_': '/tools/buildbot/bin/python'} 18:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:54:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:54:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:56 INFO - Downloading docopt-0.6.1.tar.gz 18:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:54:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:54:56 INFO - Running setup.py install for blobuploader 18:54:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:54:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:54:56 INFO - Running setup.py install for requests 18:54:57 INFO - Running setup.py install for docopt 18:54:57 INFO - Successfully installed blobuploader requests docopt 18:54:57 INFO - Cleaning up... 18:54:57 INFO - Return code: 0 18:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:57 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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:54:57 INFO - Using env: {'DISPLAY': ':0', 18:54:57 INFO - 'HOME': '/home/cltbld', 18:54:57 INFO - 'LANG': 'en_US.UTF-8', 18:54:57 INFO - 'LANGUAGE': 'en_US:en', 18:54:57 INFO - 'LOGNAME': 'cltbld', 18:54:57 INFO - 'MAIL': '/var/mail/cltbld', 18:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:57 INFO - 'MOZ_NO_REMOTE': '1', 18:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:57 INFO - 'NO_EM_RESTART': '1', 18:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:57 INFO - 'PWD': '/builds/slave/test', 18:54:57 INFO - 'SHELL': '/bin/bash', 18:54:57 INFO - 'SHLVL': '1', 18:54:57 INFO - 'TERM': 'linux', 18:54:57 INFO - 'TMOUT': '86400', 18:54:57 INFO - 'USER': 'cltbld', 18:54:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:57 INFO - '_': '/tools/buildbot/bin/python'} 18:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:57 INFO - Running setup.py (path:/tmp/pip-cI_1u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:57 INFO - Running setup.py (path:/tmp/pip-dRvGbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:57 INFO - Running setup.py (path:/tmp/pip-XD8aK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:57 INFO - Running setup.py (path:/tmp/pip-pDv84w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:57 INFO - Running setup.py (path:/tmp/pip-WfA3Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:57 INFO - Running setup.py (path:/tmp/pip-GJW31z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:57 INFO - Running setup.py (path:/tmp/pip-CfRIk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:58 INFO - Running setup.py (path:/tmp/pip-3FqNhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:58 INFO - Running setup.py (path:/tmp/pip-hNCwC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:58 INFO - Running setup.py (path:/tmp/pip-aV4BrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:58 INFO - Running setup.py (path:/tmp/pip-u7a_NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:58 INFO - Running setup.py (path:/tmp/pip-WSS_Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:58 INFO - Running setup.py (path:/tmp/pip-Wu6ztl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:58 INFO - Running setup.py (path:/tmp/pip-rzpnuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:58 INFO - Running setup.py (path:/tmp/pip-Cyjq3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:58 INFO - Running setup.py (path:/tmp/pip-Zgbyjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:58 INFO - Running setup.py (path:/tmp/pip-joRNBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:54:58 INFO - Running setup.py install for manifestparser 18:54:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Running setup.py install for mozcrash 18:54:58 INFO - Running setup.py install for mozdebug 18:54:59 INFO - Running setup.py install for mozdevice 18:54:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozfile 18:54:59 INFO - Running setup.py install for mozhttpd 18:54:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozinfo 18:54:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozInstall 18:54:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozleak 18:54:59 INFO - Running setup.py install for mozlog 18:54:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for moznetwork 18:54:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozprocess 18:54:59 INFO - Running setup.py install for mozprofile 18:55:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:55:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:55:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:55:00 INFO - Running setup.py install for mozrunner 18:55:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:55:00 INFO - Running setup.py install for mozscreenshot 18:55:00 INFO - Running setup.py install for moztest 18:55:00 INFO - Running setup.py install for mozversion 18:55:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:55:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:55:00 INFO - Cleaning up... 18:55:00 INFO - Return code: 0 18:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:00 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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:55:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:55:00 INFO - Using env: {'DISPLAY': ':0', 18:55:00 INFO - 'HOME': '/home/cltbld', 18:55:00 INFO - 'LANG': 'en_US.UTF-8', 18:55:00 INFO - 'LANGUAGE': 'en_US:en', 18:55:00 INFO - 'LOGNAME': 'cltbld', 18:55:00 INFO - 'MAIL': '/var/mail/cltbld', 18:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:00 INFO - 'MOZ_NO_REMOTE': '1', 18:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:00 INFO - 'NO_EM_RESTART': '1', 18:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:00 INFO - 'PWD': '/builds/slave/test', 18:55:00 INFO - 'SHELL': '/bin/bash', 18:55:00 INFO - 'SHLVL': '1', 18:55:00 INFO - 'TERM': 'linux', 18:55:00 INFO - 'TMOUT': '86400', 18:55:00 INFO - 'USER': 'cltbld', 18:55:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:00 INFO - '_': '/tools/buildbot/bin/python'} 18:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:00 INFO - Running setup.py (path:/tmp/pip-VowIBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:00 INFO - Running setup.py (path:/tmp/pip-2Oq0MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:00 INFO - Running setup.py (path:/tmp/pip-4nYCah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:00 INFO - Running setup.py (path:/tmp/pip-U5q00z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55: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)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:01 INFO - Running setup.py (path:/tmp/pip-pnLtPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55: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)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:01 INFO - Running setup.py (path:/tmp/pip-zUNqYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:01 INFO - Running setup.py (path:/tmp/pip-ZMPzcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:01 INFO - Running setup.py (path:/tmp/pip-HsAXVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:01 INFO - Running setup.py (path:/tmp/pip-Xh2YEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:01 INFO - Running setup.py (path:/tmp/pip-5CLmlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:01 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)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:01 INFO - Running setup.py (path:/tmp/pip-v5RPcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:55:01 INFO - Running setup.py (path:/tmp/pip-VYVbzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:55:01 INFO - Running setup.py (path:/tmp/pip-eWrmig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:55:01 INFO - Running setup.py (path:/tmp/pip-ZZCsjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:01 INFO - Running setup.py (path:/tmp/pip-ay9aIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:55:01 INFO - Running setup.py (path:/tmp/pip-mubYoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:55:01 INFO - Running setup.py (path:/tmp/pip-wX8ltK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:55:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:03 INFO - Downloading blessings-1.6.tar.gz 18:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:55:04 INFO - Installing collected packages: blessings 18:55:04 INFO - Running setup.py install for blessings 18:55:04 INFO - Successfully installed blessings 18:55:04 INFO - Cleaning up... 18:55:05 INFO - Return code: 0 18:55:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:05 INFO - Reading from file tmpfile_stdout 18:55:05 INFO - Current package versions: 18:55:05 INFO - argparse == 1.2.1 18:55:05 INFO - blessings == 1.6 18:55:05 INFO - blobuploader == 1.2.4 18:55:05 INFO - docopt == 0.6.1 18:55:05 INFO - manifestparser == 1.1 18:55:05 INFO - mozInstall == 1.12 18:55:05 INFO - mozcrash == 0.17 18:55:05 INFO - mozdebug == 0.1 18:55:05 INFO - mozdevice == 0.48 18:55:05 INFO - mozfile == 1.2 18:55:05 INFO - mozhttpd == 0.7 18:55:05 INFO - mozinfo == 0.9 18:55:05 INFO - mozleak == 0.1 18:55:05 INFO - mozlog == 3.1 18:55:05 INFO - moznetwork == 0.27 18:55:05 INFO - mozprocess == 0.22 18:55:05 INFO - mozprofile == 0.28 18:55:05 INFO - mozrunner == 6.11 18:55:05 INFO - mozscreenshot == 0.1 18:55:05 INFO - mozsystemmonitor == 0.0 18:55:05 INFO - moztest == 0.7 18:55:05 INFO - mozversion == 1.4 18:55:05 INFO - psutil == 3.1.1 18:55:05 INFO - requests == 1.2.3 18:55:05 INFO - wsgiref == 0.1.2 18:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:55: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 18:55: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 18:55:05 INFO - Using env: {'DISPLAY': ':0', 18:55:05 INFO - 'HOME': '/home/cltbld', 18:55:05 INFO - 'LANG': 'en_US.UTF-8', 18:55:05 INFO - 'LANGUAGE': 'en_US:en', 18:55:05 INFO - 'LOGNAME': 'cltbld', 18:55:05 INFO - 'MAIL': '/var/mail/cltbld', 18:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:05 INFO - 'MOZ_NO_REMOTE': '1', 18:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:05 INFO - 'NO_EM_RESTART': '1', 18:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:05 INFO - 'PWD': '/builds/slave/test', 18:55:05 INFO - 'SHELL': '/bin/bash', 18:55:05 INFO - 'SHLVL': '1', 18:55:05 INFO - 'TERM': 'linux', 18:55:05 INFO - 'TMOUT': '86400', 18:55:05 INFO - 'USER': 'cltbld', 18:55:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:05 INFO - '_': '/tools/buildbot/bin/python'} 18:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55: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)) 18:55:05 INFO - Cleaning up... 18:55:05 INFO - Return code: 0 18:55:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:55: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 18:55: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 18:55:05 INFO - Using env: {'DISPLAY': ':0', 18:55:05 INFO - 'HOME': '/home/cltbld', 18:55:05 INFO - 'LANG': 'en_US.UTF-8', 18:55:05 INFO - 'LANGUAGE': 'en_US:en', 18:55:05 INFO - 'LOGNAME': 'cltbld', 18:55:05 INFO - 'MAIL': '/var/mail/cltbld', 18:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:05 INFO - 'MOZ_NO_REMOTE': '1', 18:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:05 INFO - 'NO_EM_RESTART': '1', 18:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:05 INFO - 'PWD': '/builds/slave/test', 18:55:05 INFO - 'SHELL': '/bin/bash', 18:55:05 INFO - 'SHLVL': '1', 18:55:05 INFO - 'TERM': 'linux', 18:55:05 INFO - 'TMOUT': '86400', 18:55:05 INFO - 'USER': 'cltbld', 18:55:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:05 INFO - '_': '/tools/buildbot/bin/python'} 18:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:05 INFO - Downloading/unpacking jsonschema 18:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:55:07 INFO - Downloading/unpacking functools32 (from jsonschema) 18:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:55:07 INFO - warning: no files found matching '*.txt' 18:55:07 INFO - no previously-included directories found matching 'build' 18:55:07 INFO - no previously-included directories found matching 'dist' 18:55:07 INFO - no previously-included directories found matching '.git*' 18:55:07 INFO - Installing collected packages: jsonschema, functools32 18:55:07 INFO - Running setup.py install for functools32 18:55:07 INFO - warning: no files found matching '*.txt' 18:55:07 INFO - no previously-included directories found matching 'build' 18:55:07 INFO - no previously-included directories found matching 'dist' 18:55:07 INFO - no previously-included directories found matching '.git*' 18:55:08 INFO - Successfully installed jsonschema functools32 18:55:08 INFO - Cleaning up... 18:55:08 INFO - Return code: 0 18:55:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:08 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 0x7f89eee8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:55:08 INFO - Using env: {'DISPLAY': ':0', 18:55:08 INFO - 'HOME': '/home/cltbld', 18:55:08 INFO - 'LANG': 'en_US.UTF-8', 18:55:08 INFO - 'LANGUAGE': 'en_US:en', 18:55:08 INFO - 'LOGNAME': 'cltbld', 18:55:08 INFO - 'MAIL': '/var/mail/cltbld', 18:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:08 INFO - 'MOZ_NO_REMOTE': '1', 18:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:08 INFO - 'NO_EM_RESTART': '1', 18:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:08 INFO - 'PWD': '/builds/slave/test', 18:55:08 INFO - 'SHELL': '/bin/bash', 18:55:08 INFO - 'SHLVL': '1', 18:55:08 INFO - 'TERM': 'linux', 18:55:08 INFO - 'TMOUT': '86400', 18:55:08 INFO - 'USER': 'cltbld', 18:55:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:08 INFO - '_': '/tools/buildbot/bin/python'} 18:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:08 INFO - Downloading/unpacking flake8 18:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:55:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:55:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55: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 18:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:55:10 INFO - no previously-included directories found matching 'docs/_build' 18:55:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:55:10 INFO - Running setup.py install for pep8 18:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:55:11 INFO - no previously-included directories found matching 'docs/_build' 18:55:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:55:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:55:11 INFO - Cleaning up... 18:55:11 INFO - Return code: 0 18:55:11 INFO - Running post-action listener: _resource_record_post_action 18:55:11 INFO - Running post-action listener: _start_resource_monitoring 18:55:11 INFO - Starting resource monitoring. 18:55:11 INFO - ##### 18:55:11 INFO - ##### Running install step. 18:55:11 INFO - ##### 18:55:11 INFO - Running pre-action listener: _resource_record_pre_action 18:55:11 INFO - Running main action method: install 18:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:11 INFO - Reading from file tmpfile_stdout 18:55:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:55:11 INFO - Reading from file tmpfile_stdout 18:55:11 INFO - Output received: 18:55:11 INFO - Usage: mozinstall [options] installer 18:55:11 INFO - Options: 18:55:11 INFO - -h, --help show this help message and exit 18:55:11 INFO - -d DEST, --destination=DEST 18:55:11 INFO - Directory to install application into. [default: 18:55:11 INFO - "/builds/slave/test"] 18:55:11 INFO - --app=APP Application being installed. [default: firefox] 18:55:11 INFO - mkdir: /builds/slave/test/build/application 18:55: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'] 18:55: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 18:55:28 INFO - Reading from file tmpfile_stdout 18:55:28 INFO - Output received: 18:55:28 INFO - /builds/slave/test/build/application/firefox/firefox 18:55:28 INFO - Running post-action listener: _resource_record_post_action 18:55:28 INFO - ##### 18:55:28 INFO - ##### Running run-tests step. 18:55:28 INFO - ##### 18:55:28 INFO - Running pre-action listener: _resource_record_pre_action 18:55:28 INFO - Running main action method: run_tests 18:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:55:28 INFO - Python 2.7.3 18:55:28 INFO - Return code: 0 18:55:28 INFO - grabbing minidump binary from tooltool 18:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:28 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 0x1baa810>, '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 0x1bab710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:55:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:55:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:55:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:55:28 INFO - Return code: 0 18:55:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:55:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:55:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:55:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:55:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:55:29 INFO - Return code: 0 18:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:55:29 INFO - Using env: {'DISPLAY': ':0', 18:55:29 INFO - 'HOME': '/home/cltbld', 18:55:29 INFO - 'LANG': 'en_US.UTF-8', 18:55:29 INFO - 'LANGUAGE': 'en_US:en', 18:55:29 INFO - 'LOGNAME': 'cltbld', 18:55:29 INFO - 'MAIL': '/var/mail/cltbld', 18:55:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:55:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:29 INFO - 'MOZ_NO_REMOTE': '1', 18:55:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:29 INFO - 'NO_EM_RESTART': '1', 18:55:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:29 INFO - 'PWD': '/builds/slave/test', 18:55:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:55:29 INFO - 'SHELL': '/bin/bash', 18:55:29 INFO - 'SHLVL': '1', 18:55:29 INFO - 'TERM': 'linux', 18:55:29 INFO - 'TMOUT': '86400', 18:55:29 INFO - 'USER': 'cltbld', 18:55:29 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939', 18:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:29 INFO - '_': '/tools/buildbot/bin/python'} 18:55:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:55:29 INFO - mozversion application_buildid: 20160425163001 18:55:29 INFO - mozversion application_changeset: 79de998e7307650fec99ea6188ae60ac64ebeedb 18:55:29 INFO - mozversion application_display_name: Nightly 18:55:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:55:29 INFO - mozversion application_name: Firefox 18:55:29 INFO - mozversion application_remotingname: firefox 18:55:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:55:29 INFO - mozversion application_vendor: Mozilla 18:55:29 INFO - mozversion application_version: 49.0a1 18:55:29 INFO - mozversion platform_buildid: 20160425163001 18:55:29 INFO - mozversion platform_changeset: 79de998e7307650fec99ea6188ae60ac64ebeedb 18:55:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:55:29 INFO - mozversion platform_version: 49.0a1 18:55:29 INFO - using testdate: 1461635729 18:55:29 INFO - actual date: 1461635729 18:55:29 INFO - starting webserver on 'localhost:39217' 18:55:29 INFO - SUITE-START | Running 2 tests 18:55:29 INFO - TEST-START | dromaeo_css 18:55:29 INFO - operating with platform_type : linux_ 18:55:29 INFO - Initialising browser for dromaeo_css test... 18:55:29 INFO - TEST-INFO | started process 27358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLAxPZn/profile http://localhost:39217/getInfo.html) 18:55:33 INFO - PROCESS | 27358 | __metrics Screen width/height:1600/1200 18:55:33 INFO - PROCESS | 27358 | colorDepth:24 18:55:33 INFO - PROCESS | 27358 | Browser inner width/height: 1024/697 18:55:33 INFO - PROCESS | 27358 | __metrics 18:55:34 ERROR - PROCESS | 27358 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:55:35 INFO - TEST-INFO | 27358: exit 0 18:55:35 INFO - Browser initialized. 18:55:35 INFO - Running cycle 1/1 for dromaeo_css test... 18:55:35 INFO - TEST-INFO | started process 27437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLAxPZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:55:46 INFO - PROCESS | 27437 | RSS: Main: 154279936 18:55:46 INFO - PROCESS | 27437 | 18:56:38 INFO - PROCESS | 27437 | 1461635798189 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:58:45 INFO - PROCESS | 27437 | Cycle 1(1): loaded http://localhost:39217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39217/tests/dromaeo/cssquery-ext.html) 18:58:46 INFO - PROCESS | 27437 | RSS: Main: 253067264 18:58:46 INFO - PROCESS | 27437 | 19:01:49 INFO - PROCESS | 27437 | Cycle 1(1): loaded http://localhost:39217/tests/dromaeo/cssquery-ext.html (next: http://localhost:39217/tests/dromaeo/cssquery-jquery.html) 19:01:49 INFO - PROCESS | 27437 | RSS: Main: 236314624 19:01:49 INFO - PROCESS | 27437 | 19:04:51 INFO - PROCESS | 27437 | Cycle 1(1): loaded http://localhost:39217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39217/tests/dromaeo/cssquery-mootools.html) 19:04:52 INFO - PROCESS | 27437 | RSS: Main: 240885760 19:04:52 INFO - PROCESS | 27437 | 19:07:54 INFO - PROCESS | 27437 | Cycle 1(1): loaded http://localhost:39217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39217/tests/dromaeo/cssquery-prototype.html) 19:07:54 INFO - PROCESS | 27437 | RSS: Main: 230137856 19:07:54 INFO - PROCESS | 27437 | 19:10:57 INFO - PROCESS | 27437 | Cycle 1(1): loaded http://localhost:39217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39217/tests/dromaeo/cssquery-yui.html) 19:10:57 INFO - PROCESS | 27437 | RSS: Main: 202854400 19:10:57 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | Cycle 1(1): loaded http://localhost:39217/tests/dromaeo/cssquery-yui.html (next: http://localhost:39217/tests/dromaeo/cssquery-dojo.html) 19:14:00 INFO - PROCESS | 27437 | RSS: Main: 271540224 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | __start_tp_report 19:14:00 INFO - PROCESS | 27437 | _x_x_mozilla_page_load 19:14:00 INFO - PROCESS | 27437 | _x_x_mozilla_page_load_details 19:14:00 INFO - PROCESS | 27437 | |i|pagename|runs| 19:14:00 INFO - PROCESS | 27437 | |0;dojo.html;3060.7704422168335;3099.6590375058754;3139.2465808206025;3149.6220453545566;3178.936421271574;5109.770060347284;5231.5814734821215;5232.764525596348;5299.231611416342;5299.549538289245;5230.450802665722;5244.239585260145;5244.659097158691;5257.158854583258;5275.314209152804;4714.669973101875;4727.81088756451;4741.431028276612;4751.14479393709;4885.096257192413;4804.25534042224;4807.351007613962;4850.563449289563;4854.732989685566;4885.804567817283;4714.811407543694;4749.311349854269;4771.23660214364;4818.469968303484;4833.419989601235;4769.737664428455;4782.7130372177435;4788.425388953313;4801.18379875422;4818.975905120487;4638.6752927294765;4736.928946065812;4738.005018946025;4760.857174284777;4803.879903002453;5176.430592634807;5189.221616757479;5214.608904332153;5221.190715439113;5225.085610018232;5530.336359636829;5547.362053363874;5570.805021824217;5572.192032155355;5587.7485513152005;5515.641483303572;5604;5616.719164041781;5621.184928185431;5664.291963504562;5298.708571028592;5317.069512835277;5328.280682107905;5332.760025798849;5377.381601115843;5759.539236861041;5773.3072031356505;5775.047117225695;5776.855578610568;5779.133130030529;5402.297701298806;5529.751161197756;5548.72256387179;5570.192322113271;5580.609357345028;5638.464345887134;5641.379448260688;5654.46282603152;5656.208130861683;5665.5184309333345;5583.609147359727;5603.075492543766;5611.074172761449;5613.747381367848;5615.4946054854445;5365.38298095724;5555.194496797942;5601.439856014447;5637.746301416446;5640.210370548127;4218.767967761742;4231.724937879028;4234.703570750018;4235.9364609530885;4272.252355837716;3813.7330386872654;3813.980930095387;3822.025383527183;3826.1391186982705;3838.692904567628;5194.870128246748;5299.099153143975;5319.787208511693;5407;5424.267723857229;5665.5467562594895;5669.829905102853;5670.149477578314;5677.17680936262;5693.772249110072;5343.759530821122;5349.331333583302;5371.328583927009;5375.354957405137;5420.295361602966;4704.482506924235;4834.734089625034;4885.511448855086;4922.90154196914;4926.5073492650445;5785.30576330843;5788.9710551447815;5794.072948328248;5794.333651630117;5794.913076303858;5446.373667028342;5597.720113994203;5604.299462567179;5605.215269862141;5651.124075768263;5825.126231065374;5855.092460668603;5865.3254875689845;5903.291605007426;5905.084711869667;5551.611387202857;5554.222408862844;5561.888762224814;5562.638428502134;5564.19319198722;5546.334439867242;5608.6073974821375;5665.03694371966;5680.857978550569;5682.772689092555;5487;5515.310586176728;5524.364698059614;5527.474889885454;5578.414266501959;5486.423925487767;5494.395616482104;5503.752331145188;5511.448855114457;5512.6968016759465;5359.437259087896;5432.103702888979;5446.537044351275;5463.289772329572;5476.17857321405;5585.162225666182;5587.329520457409;5589.916151257653;5597.328320601554;5626.521745651666;5439.401665816677;5490.231367608618;5490.313710786152;5491;5535.6955367455175 19:14:00 INFO - PROCESS | 27437 | |1;ext.html;611.2390074357423;643.6041834271924;661.8543920337526;662.4336192555362;669.6584741781692;31175;31755.36489270213;31814.36371272573;31868.36263274736;36941.630583694154;40390.39414408786;40962.385564216485;41139.88601139885;41222.7938860306;41229.38155927663;8502.319814414848;8662.393632445732;8697.913020869773;8711.651533938635;8720.127987201293;7762.417818663623;7964.641591128413;8576.957115214414;9913.752156196117;10157.187425005981;10285.537150828193;10385.273030887842;10402.37585744854;10416;10419.635312764054;10152.187824974022;10255.743606409826;10269.845952310721;10274.48627568626;10299.17606591471;10177.134943529809;10304.690859274233;10309.587616495406;10318.948405258001;10318.948405258001;36848.07879803026;40628;40744.18511629751;40744.79627601843;40781.18437631231;3553.5913369962527;3745.213505163919;4001;4062.6546743526837;4110.34234522478;30533;31014;31273.37453250945;31288.21779455509;32231.355372892645;3833.884983450501;3974.125692347679;3996.2407142643096;4034.8789536313957;4139.8965025874295;332181;332944;333752;334178;335212;56415.43584564184;57273.71363143158;57393.71303143458;57423.712881436164;57459.71270143623;60135;60364;60462;60591.39408605946;60723;14177.858221417653;14240.786388204186;14269.928650356682;14277.500287490097;14281.571552853431;10397.792044159225;11799.115066370057;11826.34955077479;11832.94083529594;11849.289042657469;15312.387504499695;15513.905622740785;15519.84480155184;15576.376944922076;15693.215339232993;6398.392152745481;6501.674916254168;6588.571742836701;6715.571957193691;6792.898106528406;993.8062077894886;1019.1286450085219;1091.0889407344955;1106.926281506937;1126.622581435212;28913.56629650557;30902.845485772876;31345;31523.36953260922;31926.361472770877;1107.7729065541544;1144.6852115668091;1157.3171828621155;1175.9886497612047;1205.5358686905429;15881.28534215963;16157.59606009859;16226;16279.348826047062;16514.75227871583;473669;478810;479018;479960;481696;53795.193072103946;54884.451155487935;54924.45075549273;54959;55001.72499137479;1252.7118762684634;1295.8315418995471;1341.7718987772103;1345.1256683156028;1480.0749531542785;27854.721452785212;28462.57306140368;28533.857330713214;28810.423791523634;29126.27184320324;40607.39088913728;40749;41194.58805412027;41203.7939810299;41243.1751364965;249202;249755;249831;249872;250032;22775.544489109794;24186.87906560456;24605.87697061503;24659.630105548073;24701.50596988086;38832.61167388403;38941.415878761276;39235.80382098071;39934.60065399309;40093.39859902045;36924;37630;37633.81183094067;37679.246415071;38333.4249986256;37196.44205336868;37322.626773733;37835.432468512445;37894.8105259483;38165.427518586686;37241;37950.430743538316;38054.429183562825;38152.236955261294;38248.235035299695;32042.35915281728;32991.50512742263;33007.50488742623;33482.83258583691;33779.831100845324;26154.476910461304;26226.213213603623;26419.735802641728;26505.33736656599;26942.461150777268 19:14:00 INFO - PROCESS | 27437 | |2;jquery.html;387.7169666143716;395.4977178982692;398.0824200218499;403.9293123703353;414.5398607545626;17624.735628965558;17897.463076107706;18248.817511824895;18309.267629294827;20049.899750501263;16365.181740912967;16926.40757573485;17306;17331.39340123096;17335;5512.6968016759265;5585.1063829787245;5749.712514374285;5755.39568345324;5781.39295373986;5683.204351390808;5692.829215123553;5718.9428105719035;5743.224664670258;5745.138229265623;5458.1266997280245;5560.527355174795;5647.519960803336;5669.744861481243;5710.743016564244;5584.46947539983;5625.184348269478;5695.487406133447;5699.829005129832;5704.1443783432405;5056.115179843549;5077.213031980049;5229.660072095339;5508.20131080995;5515.283013208297;20924.686129708065;20944.057517411602;20947.68578471324;21193.894030529904;21211.575768484698;2205.2722601541454;2221.1892659179284;2404.8677322747244;2528.747125287475;2604.4400453902313;9689;9778.462184579845;9942.204623630092;9971.700848974542;10062.094411503;1965.8525610579263;2017.5460521382718;2018.3944816554974;2039.9184032638677;2101.5166511702396;54478;69917;71010.64494677546;81794;84115;9544.856827147598;9649.179819715262;9812.558434870449;9819.656312029045;10326.070653641209;14216.644583885485;14230.359633816295;14258.429662813578;14282.143071415749;14283;7574.5076570022775;7623.885641715378;7678;7708.421868359784;7828.686852525835;7707.306342429209;7723.304902558797;7825.765227043198;7892.4869883457395;7899.605019748989;4428.269335559597;4528.547145285445;4537.500874903824;4640.930386044212;4652.813887444464;1859.181959937623;1864.1890777511826;1879.633471473077;1909.415185396118;1931.4109196695142;871.9171678690515;904.1004200820095;914.8170365926708;965.792354643755;1058.1587637827945;18142.546436338933;18236.45290641283;18560.628787424444;18584.907075464806;18769.90615046916;972.1930797438109;980.0836218136066;999.1507218863908;1036.79782442423;1038.5378506564657;10213.846792298122;10552.15582753378;10614.89385106139;10668.253222274521;10720.892791072145;184137;455870;459185;465910;474434;82037;89738;90206.99999999869;90739;91596;1009.6819501856892;1016.588281745894;1033.8914413986574;1037.201354956679;1037.64719995202;15897.443589474775;16327.67344653124;16368.508944731677;16416.589585260463;16532.338706451606;33210.83394583012;37757.05607359838;38473.61526384812;39190.80404597959;39242.607573923895;44812.551874482146;48974.75512622414;49354.75322623364;49473.25790113079;49528;8074.335788570155;8139.918600813916;8252.21603947624;8287.694613888783;8325.666973321;9318.906810931803;9745;12357.196782209128;12450.81323780126;12476.126671132934;10680.305780124267;10867.456627168453;11221.60724374643;11384.260023098472;11410.543578256777;10547;10665.520051597852;10796.352218866894;10890;10999.23005389615;11124.276922000045;11464.25482343645;11555.595554155565;11588.94205528967;11715.882841171479;8054.677812887418;8182.877256841033;8220.301274391744;8244.670213191404;8434.114417986024;8391.328693704367;10317.690469285933;10817.675469735921;10955.616553420592;11296.661100167008 19:14:00 INFO - PROCESS | 27437 | |3;mootools.html;1320.854705982341;1406.6131813751217;1455.2723638180908;1550.6356006338508;1751.5708651380405;7398.6670599823;8001.599920004006;8218.753437396872;8227.300679442254;8232.094469608339;8026.157253488387;8166.3875209359385;8190.631421586028;8197;8211.219934106266;2016.5462770876582;2078.0025587717905;2081.906314215864;2288.450771814765;2321.9883900580558;2293.2776175504746;2370.478494731165;2375.70303712036;2377.476955069882;2379.4884099918513;2304.1704986204954;2332.6034574122355;2339.7660233976553;2342.10999820069;2345.847519911209;1990.5521257717044;2148.6562150055915;2286.371247906822;2290.9083636654514;2293.7706229377013;2337.439014636492;2366.2901129661204;2367.5975084235547;2368.2895131460664;2371.1108334374608;8031.95984020082;8092.1503242159315;8095.028596568391;8106.148854370324;8107.067687215927;4724.267738500504;4891.633127515451;4918.188498897677;4923;4924.064427758714;3037.438073956303;3143.748500119985;3167.7940933839227;3181.904542863718;3190.1546090286092;1048.8479170520309;1050.4012712753656;1061.601899287767;1067.071647666535;1087.5486673030682;11138.665840024812;11143.609973650964;11148.721281967935;11157.832632510519;11160.609378671788;4427.734335939854;4432.335149727567;4635.7450340230935;4654.557817007379;4654.953450465519;9514.0010298919;9532.714018579454;9537.713868583953;9539.427634341962;9542.188913942255;5044.445111037783;5113.51421614946;5119.0529751995255;5120.078385890501;5124.8206312778875;4176.206520761046;4552.203364411214;4620.214563524209;4681.087187998376;4700.435947686231;3716.925661486755;3781.1870447853844;3794.7533410328792;3833.9041523962123;3872.1674839909556;1183.7869183547043;1193.117093350914;1203.5907791350983;1204.3015051270418;1217.2027322103859;852.7910661887877;977.6969139566758;984.9015098490094;1002.6540843409012;1031.5306535526317;5615.241942337814;5747.1379293106365;5772.2207501986695;5803.506701930383;5904.7933322334375;408.28346252326975;414.18819114535245;426.0477832045376;426.9146170765859;440.1680823244071;4151.12826306473;4183.163367326486;4197.895052623709;4209.410682504452;4263.232618128766;9754.512274386252;10348.482575871176;10364.948175259075;10395.116415104649;10416.375017498824;10001.549930253155;10174.796504069876;10278.434686092336;10285.2800303978;10305.072543471124;7356.668949897267;7831.412644051719;7879.763607091796;7896.842063158705;7914.722984695508;5539.833804985857;5601.439856014366;5655.293088363955;5727.198192253171;5813.069908814569;9226.35415520907;9438.575264112995;9458.858117128386;9490.288228383037;9496.952515237379;9104.180623743894;9282.118198771106;9294.9535252326;9303.86044209351;9346.813063738824;6644.235912869888;6904.447644188554;7058.54119482232;7093.1488221413765;7281.927180728125;7942.682292708227;7958.562279074707;8006;8022.237887400687;8036.959815200887;7118.715251389886;7280.1435633913015;7341.706331746884;7448.217937116525;7466.36535894455;7119.82200444993;7171.354578087997;7194.928050719426;7210.855782884208;7222.783316500513;6678.365555272241;6729.293424190585;6745.494087943326;6747.730090796314;6748.055272261985;5019.32239147725;5058.367704036996;5115.283860259492;5118.616103792305;5121.8463446096675;5080.314157588826;5190.506901844319;5190.714510701948;5233.450487698737;5246.213068039672 19:14:00 INFO - PROCESS | 27437 | |4;prototype.html;316.0833582610431;323.9983800080999;325.6580590380101;327.87049115599336;328.87502748955393;5069.21427178787;5139.177731562951;5246.658967167132;5280;5307.867303317415;5207.5369879030495;5217.608679349045;5231.267622532849;5240.842774716764;5248.160294352904;4007.5792041835625;4014.478117844676;4061.5735347788354;4118.629323360897;4123.587641235882;3871.9419208711893;3919;4103.671706263507;4130.483689538808;4151.813168407414;4040.717149799515;4052.837886484537;4094.6314831665145;4105.3431450967855;4131.297679394495;4025.2955732746946;4053.2298863215897;4067.755934643916;4094.6928980326593;4100.077482566398;3548.5741710994844;3637.3086514770757;3648.2521083177885;3650.9269814603826;3658.5243918290716;5003;5012.298278241049;5027.522385373383;5039.118154323016;5045.873853153664;4651.395318608559;4656.3946686930485;4665.696729712592;4669.649776266793;4669.6731228814;5163.974180129113;5399.271098401705;5420.674759514442;5420.7018613976215;5473.890522189574;3861.517310336208;3886.358750806142;3891.805409729502;3900.395438707005;3903.5706072332023;5588.86027849307;5631.915521267184;5662.886742265173;5683.971580142114;5705.632162652453;3842.1547259602844;3939.3697008478507;3941.2117576484816;3963.048868271594;3972.66232370246;3988.960110398859;3989.4414781930554;4000.9199816003515;4002.8799136025964;4017.8593749218635;4555.2256116460285;4589.885252868705;4592.632589392841;4602.010567727954;4635.791389387486;5339.225812257201;5445.264889239981;5493.176023596413;5497.972510137423;5527.50252477279;1433.9426422943175;1446.616646588655;1447.6815100678045;1447.9276036198148;1455.6360909772557;946.8816397950256;965.8406362950175;976.038601977052;978.3151793744265;980.3382716666222;5634.760352722395;5660.801871934463;5665.348484924204;5679.375268720438;5694.174344719992;5991.490723288569;6009.2188015557695;6009.429104235091;6022.156898034279;6031.819045428644;5497.285352904097;5642.379338272786;5671.801486947937;5728.656280623176;5730.08318669011;3192.457282262021;3208.5668434761474;3215.903522894317;3216.195951012247;3219.6297425796333;6001.3098493672915;6180.721867515973;6202.472789812917;6210.882041232621;6254.437100660872;6026.6986650667295;6044.9395506044375;6052.880217159752;6085.648761135809;6103.3591472894705;6119.2350956130485;6204.7828326008375;6247.250329960434;6249.406306400975;6258.9374106259265;5792.797252096325;5983.910241346296;6007.789727359522;6022.705118399565;6026.216591843032;5901.144334071621;5936.732847021808;5939.2575928009;5947.9702601486715;5954.851128721816;5995.8008398319635;6132.325444201224;6176.930728205922;6183.443490085734;6239.126522286974;3668.853245870242;3754.0666556722763;3774.150816066363;3787.450819631193;3877.1389732927787;5597.6641401516035;5629.4652008059165;5631.070873306023;5631.662100273997;5650.152477128464;5339.893202135858;5473.151661492475;5474.863128421821;5491.835244942658;5501.119820828648;5453.372862120748;5459.235707001102;5488.286522752017;5493.835184944458;5500.477454641803;5364.919526207188;5366.731663416892;5368.302120724437;5416.322959630046;5429.782808687766;5268.841934741964;5500.6347270674;5519.951209270226;5526.171074338881;5587.469190426903;5398.811041613525;5446.237526746179;5446.373667028342;5458.972705136608;5510.338759348743 19:14:00 INFO - PROCESS | 27437 | |5;yui.html;669.3574168797953;676.5771392879453;721.7077083781068;735.525585997032;745.8684252343874;12542.310172940484;12861.807072893891;12879.871201287984;12892;15147.318370673318;14537.92731036346;14605.780913286282;14637;14695.191764452951;14716.411343546271;641.8844607970564;777.3159619534802;795.4193438789687;806.6289506826866;806.9072056713466;795.1968511803092;807.8020884883182;808.4502538273971;808.4744915804715;808.6926967752275;834.7913021744564;838.7106448275335;841.7979684875617;841.8400503904269;842.0989541190928;678.1319910514574;810.7040930060485;832.5337810825957;832.8584140696096;839.2404873589411;613.7851751886803;614.7540983606549;615.1357342933186;616.1158737212115;616.3713012727038;13502.93248533761;13525.932370338085;13529.255890925995;13537.661558461117;13561.389737461739;10948.178886583539;11335.37655428951;11730;11761.000314973238;11792.764144717057;10445.738856528571;10626.30928989621;10711.303765255234;10775.946120269427;11184.44077796115;3638.43604241343;3667.413213885792;3693.686036686885;3728.142527218755;3804.8097595120134;53667.463325367025;54174.187387189224;54649;54775.72612136954;57210.71394643;8740.475571465733;8842.115788421106;9053.094690530894;9120.81758364829;9132.726018219464;19033.238670453306;19088.14103365352;19146;19150.233990640496;19188.424347269603;7434.442416818761;7596.544207347577;7598.164201937782;7709.768706938801;7727.49771264866;4220.451341325608;4224.4930608327195;4232;4341.869743907625;4447.488538818077;3220.3076338587316;3261.2825178460703;3280.3603297357263;3287.983560082232;3288.473844184919;540.8269353806744;586.2730214534032;595.4402861310355;597.8236420256035;609.1563184988822;559.3846768554639;629.6159342800888;699.8110510162329;717.8872747241754;740.2597402597403;8209.38429617781;8789.82985016652;9039.367244292836;9110.407823491585;9177.495237761854;579.5566391710345;649.6524359467662;666.3170250493283;670.4569298867932;698.1064237775655;4225.661947044229;4421.867343979686;4430.734155950653;4446.3552784846015;4493.73037617744;61773.382266177665;61866.38133618696;62019;63452;63690.681546592896;58065.70967145222;58437.12344314839;58701.41298587045;58967.70516147392;60180.39819601835;53240.73379633077;53293.46706532963;53985.46014539883;54460.183097253575;54916.45083549113;8843.248323892542;8986.775330616787;9044.63821447161;9079.636814527345;9277.16505514507;30119;30922;31035.68964310328;32234.35531289408;33199.66800332062;42982.35526467168;43081.353779692705;43422.78288608537;43444.56555434405;44578.77710611426;11921;11948.820767688318;12038.879611203776;12089;12382.690432738893;11644.76710465769;12456.626301210978;12803.551875684307;12898.290594017419;12970.481180752664;10907.781844363228;11042.957003166728;11287;11418.942905285421;11672.824907626222;11775.587854425054;11800.232984855957;11948.76102477963;12237.69405764863;12279.815802762787;11112.444377781241;11428.657140285804;11438.252074042635;11545.191836571696;11911.821322679993;8838.823223535364;8975.416597921114;9083.409578377385;9167.541622918961;9258.166764991183;9684.176844968257;9731.41611503312;9793.75515612087;9815.705528834147;9836.262280328861 19:14:00 INFO - PROCESS | 27437 | __end_tp_report 19:14:00 INFO - PROCESS | 27437 | __start_cc_report 19:14:00 INFO - PROCESS | 27437 | _x_x_mozilla_cycle_collect,839 19:14:00 INFO - PROCESS | 27437 | __end_cc_report 19:14:00 INFO - PROCESS | 27437 | __startTimestamp1461636840515__endTimestamp 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | ------- Summary: start ------- 19:14:00 INFO - PROCESS | 27437 | Number of tests: 6 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | [#0] dojo.html Cycles:165 Average:5230.92 Median:5463.29 stddev:590.37 (10.8%) stddev-sans-first:567.10 19:14:00 INFO - PROCESS | 27437 | Values: 3060.8 3099.7 3139.2 3149.6 3178.9 5109.8 5231.6 5232.8 5299.2 5299.5 5230.5 5244.2 5244.7 5257.2 5275.3 4714.7 4727.8 4741.4 4751.1 4885.1 4804.3 4807.4 4850.6 4854.7 4885.8 4714.8 4749.3 4771.2 4818.5 4833.4 4769.7 4782.7 4788.4 4801.2 4819.0 4638.7 4736.9 4738.0 4760.9 4803.9 5176.4 5189.2 5214.6 5221.2 5225.1 5530.3 5547.4 5570.8 5572.2 5587.7 5515.6 5604.0 5616.7 5621.2 5664.3 5298.7 5317.1 5328.3 5332.8 5377.4 5759.5 5773.3 5775.0 5776.9 5779.1 5402.3 5529.8 5548.7 5570.2 5580.6 5638.5 5641.4 5654.5 5656.2 5665.5 5583.6 5603.1 5611.1 5613.7 5615.5 5365.4 5555.2 5601.4 5637.7 5640.2 4218.8 4231.7 4234.7 4235.9 4272.3 3813.7 3814.0 3822.0 3826.1 3838.7 5194.9 5299.1 5319.8 5407.0 5424.3 5665.5 5669.8 5670.1 5677.2 5693.8 5343.8 5349.3 5371.3 5375.4 5420.3 4704.5 4834.7 4885.5 4922.9 4926.5 5785.3 5789.0 5794.1 5794.3 5794.9 5446.4 5597.7 5604.3 5605.2 5651.1 5825.1 5855.1 5865.3 5903.3 5905.1 5551.6 5554.2 5561.9 5562.6 5564.2 5546.3 5608.6 5665.0 5680.9 5682.8 5487.0 5515.3 5524.4 5527.5 5578.4 5486.4 5494.4 5503.8 5511.4 5512.7 5359.4 5432.1 5446.5 5463.3 5476.2 5585.2 5587.3 5589.9 5597.3 5626.5 5439.4 5490.2 5490.3 5491.0 5535.7 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | [#1] ext.html Cycles:180 Average:51133.95 Median:183830.42 stddev:97017.93 (52.8%) stddev-sans-first:97215.94 19:14:00 INFO - PROCESS | 27437 | Values: 611.2 643.6 661.9 662.4 669.7 31175.0 31755.4 31814.4 31868.4 36941.6 40390.4 40962.4 41139.9 41222.8 41229.4 8502.3 8662.4 8697.9 8711.7 8720.1 7762.4 7964.6 8577.0 9913.8 10157.2 10285.5 10385.3 10402.4 10416.0 10419.6 10152.2 10255.7 10269.8 10274.5 10299.2 10177.1 10304.7 10309.6 10318.9 10318.9 36848.1 40628.0 40744.2 40744.8 40781.2 3553.6 3745.2 4001.0 4062.7 4110.3 30533.0 31014.0 31273.4 31288.2 32231.4 3833.9 3974.1 3996.2 4034.9 4139.9 332181.0 332944.0 333752.0 334178.0 335212.0 56415.4 57273.7 57393.7 57423.7 57459.7 60135.0 60364.0 60462.0 60591.4 60723.0 14177.9 14240.8 14269.9 14277.5 14281.6 10397.8 11799.1 11826.3 11832.9 11849.3 15312.4 15513.9 15519.8 15576.4 15693.2 6398.4 6501.7 6588.6 6715.6 6792.9 993.8 1019.1 1091.1 1106.9 1126.6 28913.6 30902.8 31345.0 31523.4 31926.4 1107.8 1144.7 1157.3 1176.0 1205.5 15881.3 16157.6 16226.0 16279.3 16514.8 473669.0 478810.0 479018.0 479960.0 481696.0 53795.2 54884.5 54924.5 54959.0 55001.7 1252.7 1295.8 1341.8 1345.1 1480.1 27854.7 28462.6 28533.9 28810.4 29126.3 40607.4 40749.0 41194.6 41203.8 41243.2 249202.0 249755.0 249831.0 249872.0 250032.0 22775.5 24186.9 24605.9 24659.6 24701.5 38832.6 38941.4 39235.8 39934.6 40093.4 36924.0 37630.0 37633.8 37679.2 38333.4 37196.4 37322.6 37835.4 37894.8 38165.4 37241.0 37950.4 38054.4 38152.2 38248.2 32042.4 32991.5 33007.5 33482.8 33779.8 26154.5 26226.2 26419.7 26505.3 26942.5 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | [#2] jquery.html Cycles:180 Average:25555.10 Median:401.01 stddev:70054.23 (17469.6%) stddev-sans-first:70225.26 19:14:00 INFO - PROCESS | 27437 | Values: 387.7 395.5 398.1 403.9 414.5 17624.7 17897.5 18248.8 18309.3 20049.9 16365.2 16926.4 17306.0 17331.4 17335.0 5512.7 5585.1 5749.7 5755.4 5781.4 5683.2 5692.8 5718.9 5743.2 5745.1 5458.1 5560.5 5647.5 5669.7 5710.7 5584.5 5625.2 5695.5 5699.8 5704.1 5056.1 5077.2 5229.7 5508.2 5515.3 20924.7 20944.1 20947.7 21193.9 21211.6 2205.3 2221.2 2404.9 2528.7 2604.4 9689.0 9778.5 9942.2 9971.7 10062.1 1965.9 2017.5 2018.4 2039.9 2101.5 54478.0 69917.0 71010.6 81794.0 84115.0 9544.9 9649.2 9812.6 9819.7 10326.1 14216.6 14230.4 14258.4 14282.1 14283.0 7574.5 7623.9 7678.0 7708.4 7828.7 7707.3 7723.3 7825.8 7892.5 7899.6 4428.3 4528.5 4537.5 4640.9 4652.8 1859.2 1864.2 1879.6 1909.4 1931.4 871.9 904.1 914.8 965.8 1058.2 18142.5 18236.5 18560.6 18584.9 18769.9 972.2 980.1 999.2 1036.8 1038.5 10213.8 10552.2 10614.9 10668.3 10720.9 184137.0 455870.0 459185.0 465910.0 474434.0 82037.0 89738.0 90207.0 90739.0 91596.0 1009.7 1016.6 1033.9 1037.2 1037.6 15897.4 16327.7 16368.5 16416.6 16532.3 33210.8 37757.1 38473.6 39190.8 39242.6 44812.6 48974.8 49354.8 49473.3 49528.0 8074.3 8139.9 8252.2 8287.7 8325.7 9318.9 9745.0 12357.2 12450.8 12476.1 10680.3 10867.5 11221.6 11384.3 11410.5 10547.0 10665.5 10796.4 10890.0 10999.2 11124.3 11464.3 11555.6 11588.9 11715.9 8054.7 8182.9 8220.3 8244.7 8434.1 8391.3 10317.7 10817.7 10955.6 11296.7 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | [#3] mootools.html Cycles:180 Average:5461.62 Median:4971.69 stddev:3033.74 (61.0%) stddev-sans-first:3026.29 19:14:00 INFO - PROCESS | 27437 | Values: 1320.9 1406.6 1455.3 1550.6 1751.6 7398.7 8001.6 8218.8 8227.3 8232.1 8026.2 8166.4 8190.6 8197.0 8211.2 2016.5 2078.0 2081.9 2288.5 2322.0 2293.3 2370.5 2375.7 2377.5 2379.5 2304.2 2332.6 2339.8 2342.1 2345.8 1990.6 2148.7 2286.4 2290.9 2293.8 2337.4 2366.3 2367.6 2368.3 2371.1 8032.0 8092.2 8095.0 8106.1 8107.1 4724.3 4891.6 4918.2 4923.0 4924.1 3037.4 3143.7 3167.8 3181.9 3190.2 1048.8 1050.4 1061.6 1067.1 1087.5 11138.7 11143.6 11148.7 11157.8 11160.6 4427.7 4432.3 4635.7 4654.6 4655.0 9514.0 9532.7 9537.7 9539.4 9542.2 5044.4 5113.5 5119.1 5120.1 5124.8 4176.2 4552.2 4620.2 4681.1 4700.4 3716.9 3781.2 3794.8 3833.9 3872.2 1183.8 1193.1 1203.6 1204.3 1217.2 852.8 977.7 984.9 1002.7 1031.5 5615.2 5747.1 5772.2 5803.5 5904.8 408.3 414.2 426.0 426.9 440.2 4151.1 4183.2 4197.9 4209.4 4263.2 9754.5 10348.5 10364.9 10395.1 10416.4 10001.5 10174.8 10278.4 10285.3 10305.1 7356.7 7831.4 7879.8 7896.8 7914.7 5539.8 5601.4 5655.3 5727.2 5813.1 9226.4 9438.6 9458.9 9490.3 9497.0 9104.2 9282.1 9295.0 9303.9 9346.8 6644.2 6904.4 7058.5 7093.1 7281.9 7942.7 7958.6 8006.0 8022.2 8037.0 7118.7 7280.1 7341.7 7448.2 7466.4 7119.8 7171.4 7194.9 7210.9 7222.8 6678.4 6729.3 6745.5 6747.7 6748.1 5019.3 5058.4 5115.3 5118.6 5121.8 5080.3 5190.5 5190.7 5233.5 5246.2 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | [#4] prototype.html Cycles:180 Average:4704.27 Median:5367.52 stddev:1425.43 (26.6%) stddev-sans-first:1390.86 19:14:00 INFO - PROCESS | 27437 | Values: 316.1 324.0 325.7 327.9 328.9 5069.2 5139.2 5246.7 5280.0 5307.9 5207.5 5217.6 5231.3 5240.8 5248.2 4007.6 4014.5 4061.6 4118.6 4123.6 3871.9 3919.0 4103.7 4130.5 4151.8 4040.7 4052.8 4094.6 4105.3 4131.3 4025.3 4053.2 4067.8 4094.7 4100.1 3548.6 3637.3 3648.3 3650.9 3658.5 5003.0 5012.3 5027.5 5039.1 5045.9 4651.4 4656.4 4665.7 4669.6 4669.7 5164.0 5399.3 5420.7 5420.7 5473.9 3861.5 3886.4 3891.8 3900.4 3903.6 5588.9 5631.9 5662.9 5684.0 5705.6 3842.2 3939.4 3941.2 3963.0 3972.7 3989.0 3989.4 4000.9 4002.9 4017.9 4555.2 4589.9 4592.6 4602.0 4635.8 5339.2 5445.3 5493.2 5498.0 5527.5 1433.9 1446.6 1447.7 1447.9 1455.6 946.9 965.8 976.0 978.3 980.3 5634.8 5660.8 5665.3 5679.4 5694.2 5991.5 6009.2 6009.4 6022.2 6031.8 5497.3 5642.4 5671.8 5728.7 5730.1 3192.5 3208.6 3215.9 3216.2 3219.6 6001.3 6180.7 6202.5 6210.9 6254.4 6026.7 6044.9 6052.9 6085.6 6103.4 6119.2 6204.8 6247.3 6249.4 6258.9 5792.8 5983.9 6007.8 6022.7 6026.2 5901.1 5936.7 5939.3 5948.0 5954.9 5995.8 6132.3 6176.9 6183.4 6239.1 3668.9 3754.1 3774.2 3787.5 3877.1 5597.7 5629.5 5631.1 5631.7 5650.2 5339.9 5473.2 5474.9 5491.8 5501.1 5453.4 5459.2 5488.3 5493.8 5500.5 5364.9 5366.7 5368.3 5416.3 5429.8 5268.8 5500.6 5520.0 5526.2 5587.5 5398.8 5446.2 5446.4 5459.0 5510.3 19:14:00 INFO - PROCESS | 27437 | 19:14:00 INFO - PROCESS | 27437 | [#5] yui.html Cycles:180 Average:14527.05 Median:54317.19 stddev:17559.07 (32.3%) stddev-sans-first:17577.49 19:14:00 INFO - PROCESS | 27437 | Values: 669.4 676.6 721.7 735.5 745.9 12542.3 12861.8 12879.9 12892.0 15147.3 14537.9 14605.8 14637.0 14695.2 14716.4 641.9 777.3 795.4 806.6 806.9 795.2 807.8 808.5 808.5 808.7 834.8 838.7 841.8 841.8 842.1 678.1 810.7 832.5 832.9 839.2 613.8 614.8 615.1 616.1 616.4 13502.9 13525.9 13529.3 13537.7 13561.4 10948.2 11335.4 11730.0 11761.0 11792.8 10445.7 10626.3 10711.3 10775.9 11184.4 3638.4 3667.4 3693.7 3728.1 3804.8 53667.5 54174.2 54649.0 54775.7 57210.7 8740.5 8842.1 9053.1 9120.8 9132.7 19033.2 19088.1 19146.0 19150.2 19188.4 7434.4 7596.5 7598.2 7709.8 7727.5 4220.5 4224.5 4232.0 4341.9 4447.5 3220.3 3261.3 3280.4 3288.0 3288.5 540.8 586.3 595.4 597.8 609.2 559.4 629.6 699.8 717.9 740.3 8209.4 8789.8 9039.4 9110.4 9177.5 579.6 649.7 666.3 670.5 698.1 4225.7 4421.9 4430.7 4446.4 4493.7 61773.4 61866.4 62019.0 63452.0 63690.7 58065.7 58437.1 58701.4 58967.7 60180.4 53240.7 53293.5 53985.5 54460.2 54916.5 8843.2 8986.8 9044.6 9079.6 9277.2 30119.0 30922.0 31035.7 32234.4 33199.7 42982.4 43081.4 43422.8 43444.6 44578.8 11921.0 11948.8 12038.9 12089.0 12382.7 11644.8 12456.6 12803.6 12898.3 12970.5 10907.8 11043.0 11287.0 11418.9 11672.8 11775.6 11800.2 11948.8 12237.7 12279.8 11112.4 11428.7 11438.3 11545.2 11911.8 8838.8 8975.4 9083.4 9167.5 9258.2 9684.2 9731.4 9793.8 9815.7 9836.3 19:14:00 INFO - PROCESS | 27437 | -------- Summary: end -------- 19:14:00 INFO - PROCESS | 27437 | 19:14:01 INFO - TEST-INFO | 27437: exit 0 19:14:01 INFO - TEST-OK | dromaeo_css | took 1112024ms 19:14:01 INFO - TEST-START | kraken 19:14:01 INFO - operating with platform_type : linux_ 19:14:01 INFO - Initialising browser for kraken test... 19:14:01 INFO - TEST-INFO | started process 27621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPeoXpt/profile http://localhost:39217/getInfo.html) 19:14:05 INFO - PROCESS | 27621 | __metrics Screen width/height:1600/1200 19:14:05 INFO - PROCESS | 27621 | colorDepth:24 19:14:05 INFO - PROCESS | 27621 | Browser inner width/height: 1024/697 19:14:05 INFO - PROCESS | 27621 | __metrics 19:14:06 ERROR - PROCESS | 27621 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:14:06 INFO - TEST-INFO | 27621: exit 0 19:14:06 INFO - Browser initialized. 19:14:06 INFO - Running cycle 1/1 for kraken test... 19:14:06 INFO - TEST-INFO | started process 27705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPeoXpt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:18 INFO - PROCESS | 27705 | RSS: Main: 154386432 19:14:18 INFO - PROCESS | 27705 | 19:14:21 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39217/tests/kraken/driver.html?testName=audio-beat-detection) 19:14:22 INFO - PROCESS | 27705 | RSS: Main: 209526784 19:14:22 INFO - PROCESS | 27705 | 19:14:24 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39217/tests/kraken/driver.html?testName=audio-dft) 19:14:25 INFO - PROCESS | 27705 | RSS: Main: 194805760 19:14:25 INFO - PROCESS | 27705 | 19:14:28 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39217/tests/kraken/driver.html?testName=audio-fft) 19:14:29 INFO - PROCESS | 27705 | RSS: Main: 265658368 19:14:29 INFO - PROCESS | 27705 | 19:14:31 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39217/tests/kraken/driver.html?testName=audio-oscillator) 19:14:31 INFO - PROCESS | 27705 | RSS: Main: 174108672 19:14:31 INFO - PROCESS | 27705 | 19:14:33 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:14:34 INFO - PROCESS | 27705 | RSS: Main: 178200576 19:14:34 INFO - PROCESS | 27705 | 19:14:37 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39217/tests/kraken/driver.html?testName=imaging-darkroom) 19:14:38 INFO - PROCESS | 27705 | RSS: Main: 214630400 19:14:38 INFO - PROCESS | 27705 | 19:14:41 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39217/tests/kraken/driver.html?testName=imaging-desaturate) 19:14:42 INFO - PROCESS | 27705 | RSS: Main: 214691840 19:14:42 INFO - PROCESS | 27705 | 19:14:44 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39217/tests/kraken/driver.html?testName=json-parse-financial) 19:14:45 INFO - PROCESS | 27705 | RSS: Main: 215121920 19:14:45 INFO - PROCESS | 27705 | 19:14:47 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:14:47 INFO - PROCESS | 27705 | RSS: Main: 202268672 19:14:47 INFO - PROCESS | 27705 | 19:14:49 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:14:50 INFO - PROCESS | 27705 | RSS: Main: 206462976 19:14:50 INFO - PROCESS | 27705 | 19:14:52 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:14:52 INFO - PROCESS | 27705 | RSS: Main: 215957504 19:14:52 INFO - PROCESS | 27705 | 19:14:55 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:14:56 INFO - PROCESS | 27705 | RSS: Main: 220381184 19:14:56 INFO - PROCESS | 27705 | 19:14:58 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:14:59 INFO - PROCESS | 27705 | RSS: Main: 219615232 19:14:59 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | Cycle 1(1): loaded http://localhost:39217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39217/tests/kraken/driver.html?testName=ai-astar) 19:15:01 INFO - PROCESS | 27705 | RSS: Main: 282968064 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | __start_tp_report 19:15:01 INFO - PROCESS | 27705 | _x_x_mozilla_page_load 19:15:01 INFO - PROCESS | 27705 | _x_x_mozilla_page_load_details 19:15:01 INFO - PROCESS | 27705 | |i|pagename|runs| 19:15:01 INFO - PROCESS | 27705 | |0;ai-astar;109;114;106;110;111;111;100;110;111;111 19:15:01 INFO - PROCESS | 27705 | |1;audio-beat-detection;157;128;152;192;135;152;162;126;180;127 19:15:01 INFO - PROCESS | 27705 | |2;audio-dft;162;162;160;160;160;161;159;161;163;161 19:15:01 INFO - PROCESS | 27705 | |3;audio-fft;72;74;118;108;77;72;75;127;104;73 19:15:01 INFO - PROCESS | 27705 | |4;audio-oscillator;93;92;148;93;94;93;160;94;94;147 19:15:01 INFO - PROCESS | 27705 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;116;116;117 19:15:01 INFO - PROCESS | 27705 | |6;imaging-darkroom;146;146;145;146;146;145;146;146;145;146 19:15:01 INFO - PROCESS | 27705 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 19:15:01 INFO - PROCESS | 27705 | |8;json-parse-financial;59;60;58;60;59;59;62;74;57;57 19:15:01 INFO - PROCESS | 27705 | |9;json-stringify-tinderbox;61;61;61;61;61;67;62;61;61;61 19:15:01 INFO - PROCESS | 27705 | |10;stanford-crypto-aes;76;84;76;84;78;79;78;78;79;79 19:15:01 INFO - PROCESS | 27705 | |11;stanford-crypto-ccm;125;131;123;131;120;121;127;122;221;137 19:15:01 INFO - PROCESS | 27705 | |12;stanford-crypto-pbkdf2;170;174;172;173;173;169;173;166;166;165 19:15:01 INFO - PROCESS | 27705 | |13;stanford-crypto-sha256-iterative;71;74;72;67;69;67;67;68;68;69 19:15:01 INFO - PROCESS | 27705 | __end_tp_report 19:15:01 INFO - PROCESS | 27705 | __start_cc_report 19:15:01 INFO - PROCESS | 27705 | _x_x_mozilla_cycle_collect,1644 19:15:01 INFO - PROCESS | 27705 | __end_cc_report 19:15:01 INFO - PROCESS | 27705 | __startTimestamp1461636901431__endTimestamp 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | ------- Summary: start ------- 19:15:01 INFO - PROCESS | 27705 | Number of tests: 14 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.83 (3.5%) stddev-sans-first:4.06 19:15:01 INFO - PROCESS | 27705 | Values: 109.0 114.0 106.0 110.0 111.0 111.0 100.0 110.0 111.0 111.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:154.50 stddev:22.77 (14.7%) stddev-sans-first:24.05 19:15:01 INFO - PROCESS | 27705 | Values: 157.0 128.0 152.0 192.0 135.0 152.0 162.0 126.0 180.0 127.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 19:15:01 INFO - PROCESS | 27705 | Values: 162.0 162.0 160.0 160.0 160.0 161.0 159.0 161.0 163.0 161.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#3] audio-fft Cycles:10 Average:90.00 Median:72.50 stddev:21.76 (30.0%) stddev-sans-first:22.08 19:15:01 INFO - PROCESS | 27705 | Values: 72.0 74.0 118.0 108.0 77.0 72.0 75.0 127.0 104.0 73.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:93.00 stddev:28.41 (30.6%) stddev-sans-first:29.40 19:15:01 INFO - PROCESS | 27705 | Values: 93.0 92.0 148.0 93.0 94.0 93.0 160.0 94.0 94.0 147.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:15:01 INFO - PROCESS | 27705 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 116.0 117.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 19:15:01 INFO - PROCESS | 27705 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:15:01 INFO - PROCESS | 27705 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:59.50 stddev:4.97 (8.4%) stddev-sans-first:5.24 19:15:01 INFO - PROCESS | 27705 | Values: 59.0 60.0 58.0 60.0 59.0 59.0 62.0 74.0 57.0 57.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.00 stddev:1.89 (3.1%) stddev-sans-first:1.99 19:15:01 INFO - PROCESS | 27705 | Values: 61.0 61.0 61.0 61.0 61.0 67.0 62.0 61.0 61.0 61.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:2.81 (3.6%) stddev-sans-first:2.74 19:15:01 INFO - PROCESS | 27705 | Values: 76.0 84.0 76.0 84.0 78.0 79.0 78.0 78.0 79.0 79.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:129.00 stddev:30.41 (23.6%) stddev-sans-first:32.00 19:15:01 INFO - PROCESS | 27705 | Values: 125.0 131.0 123.0 131.0 120.0 121.0 127.0 122.0 221.0 137.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:172.50 stddev:3.41 (2.0%) stddev-sans-first:3.62 19:15:01 INFO - PROCESS | 27705 | Values: 170.0 174.0 172.0 173.0 173.0 169.0 173.0 166.0 166.0 165.0 19:15:01 INFO - PROCESS | 27705 | 19:15:01 INFO - PROCESS | 27705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:2.39 (3.5%) stddev-sans-first:2.45 19:15:01 INFO - PROCESS | 27705 | Values: 71.0 74.0 72.0 67.0 69.0 67.0 67.0 68.0 68.0 69.0 19:15:01 INFO - PROCESS | 27705 | -------- Summary: end -------- 19:15:01 INFO - PROCESS | 27705 | 19:15:02 INFO - TEST-INFO | 27705: exit 0 19:15:02 INFO - TEST-OK | kraken | took 61163ms 19:15:02 INFO - SUITE-END | took 1173s 19:15:02 INFO - Completed test suite (00:19:33) 19:15:02 INFO - javascript benchmark 19:15:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.7704422168335, 3099.6590375058754, 3139.2465808206025, 3149.6220453545566, 3178.936421271574, 5109.770060347284, 5231.5814734821215, 5232.764525596348, 5299.231611416342, 5299.549538289245, 5230.450802665722, 5244.239585260145, 5244.659097158691, 5257.158854583258, 5275.314209152804, 4714.669973101875, 4727.81088756451, 4741.431028276612, 4751.14479393709, 4885.096257192413, 4804.25534042224, 4807.351007613962, 4850.563449289563, 4854.732989685566, 4885.804567817283, 4714.811407543694, 4749.311349854269, 4771.23660214364, 4818.469968303484, 4833.419989601235, 4769.737664428455, 4782.7130372177435, 4788.425388953313, 4801.18379875422, 4818.975905120487, 4638.6752927294765, 4736.928946065812, 4738.005018946025, 4760.857174284777, 4803.879903002453, 5176.430592634807, 5189.221616757479, 5214.608904332153, 5221.190715439113, 5225.085610018232, 5530.336359636829, 5547.362053363874, 5570.805021824217, 5572.192032155355, 5587.7485513152005, 5515.641483303572, 5604.0, 5616.719164041781, 5621.184928185431, 5664.291963504562, 5298.708571028592, 5317.069512835277, 5328.280682107905, 5332.760025798849, 5377.381601115843, 5759.539236861041, 5773.3072031356505, 5775.047117225695, 5776.855578610568, 5779.133130030529, 5402.297701298806, 5529.751161197756, 5548.72256387179, 5570.192322113271, 5580.609357345028, 5638.464345887134, 5641.379448260688, 5654.46282603152, 5656.208130861683, 5665.5184309333345, 5583.609147359727, 5603.075492543766, 5611.074172761449, 5613.747381367848, 5615.4946054854445, 5365.38298095724, 5555.194496797942, 5601.439856014447, 5637.746301416446, 5640.210370548127, 4218.767967761742, 4231.724937879028, 4234.703570750018, 4235.9364609530885, 4272.252355837716, 3813.7330386872654, 3813.980930095387, 3822.025383527183, 3826.1391186982705, 3838.692904567628, 5194.870128246748, 5299.099153143975, 5319.787208511693, 5407.0, 5424.267723857229, 5665.5467562594895, 5669.829905102853, 5670.149477578314, 5677.17680936262, 5693.772249110072, 5343.759530821122, 5349.331333583302, 5371.328583927009, 5375.354957405137, 5420.295361602966, 4704.482506924235, 4834.734089625034, 4885.511448855086, 4922.90154196914, 4926.5073492650445, 5785.30576330843, 5788.9710551447815, 5794.072948328248, 5794.333651630117, 5794.913076303858, 5446.373667028342, 5597.720113994203, 5604.299462567179, 5605.215269862141, 5651.124075768263, 5825.126231065374, 5855.092460668603, 5865.3254875689845, 5903.291605007426, 5905.084711869667, 5551.611387202857, 5554.222408862844, 5561.888762224814, 5562.638428502134, 5564.19319198722, 5546.334439867242, 5608.6073974821375, 5665.03694371966, 5680.857978550569, 5682.772689092555, 5487.0, 5515.310586176728, 5524.364698059614, 5527.474889885454, 5578.414266501959, 5486.423925487767, 5494.395616482104, 5503.752331145188, 5511.448855114457, 5512.6968016759465, 5359.437259087896, 5432.103702888979, 5446.537044351275, 5463.289772329572, 5476.17857321405, 5585.162225666182, 5587.329520457409, 5589.916151257653, 5597.328320601554, 5626.521745651666, 5439.401665816677, 5490.231367608618, 5490.313710786152, 5491.0, 5535.6955367455175], "value": 5191.6596338415275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.2390074357423, 643.6041834271924, 661.8543920337526, 662.4336192555362, 669.6584741781692, 31175.0, 31755.36489270213, 31814.36371272573, 31868.36263274736, 36941.630583694154, 40390.39414408786, 40962.385564216485, 41139.88601139885, 41222.7938860306, 41229.38155927663, 8502.319814414848, 8662.393632445732, 8697.913020869773, 8711.651533938635, 8720.127987201293, 7762.417818663623, 7964.641591128413, 8576.957115214414, 9913.752156196117, 10157.187425005981, 10285.537150828193, 10385.273030887842, 10402.37585744854, 10416.0, 10419.635312764054, 10152.187824974022, 10255.743606409826, 10269.845952310721, 10274.48627568626, 10299.17606591471, 10177.134943529809, 10304.690859274233, 10309.587616495406, 10318.948405258001, 10318.948405258001, 36848.07879803026, 40628.0, 40744.18511629751, 40744.79627601843, 40781.18437631231, 3553.5913369962527, 3745.213505163919, 4001.0, 4062.6546743526837, 4110.34234522478, 30533.0, 31014.0, 31273.37453250945, 31288.21779455509, 32231.355372892645, 3833.884983450501, 3974.125692347679, 3996.2407142643096, 4034.8789536313957, 4139.8965025874295, 332181.0, 332944.0, 333752.0, 334178.0, 335212.0, 56415.43584564184, 57273.71363143158, 57393.71303143458, 57423.712881436164, 57459.71270143623, 60135.0, 60364.0, 60462.0, 60591.39408605946, 60723.0, 14177.858221417653, 14240.786388204186, 14269.928650356682, 14277.500287490097, 14281.571552853431, 10397.792044159225, 11799.115066370057, 11826.34955077479, 11832.94083529594, 11849.289042657469, 15312.387504499695, 15513.905622740785, 15519.84480155184, 15576.376944922076, 15693.215339232993, 6398.392152745481, 6501.674916254168, 6588.571742836701, 6715.571957193691, 6792.898106528406, 993.8062077894886, 1019.1286450085219, 1091.0889407344955, 1106.926281506937, 1126.622581435212, 28913.56629650557, 30902.845485772876, 31345.0, 31523.36953260922, 31926.361472770877, 1107.7729065541544, 1144.6852115668091, 1157.3171828621155, 1175.9886497612047, 1205.5358686905429, 15881.28534215963, 16157.59606009859, 16226.0, 16279.348826047062, 16514.75227871583, 473669.0, 478810.0, 479018.0, 479960.0, 481696.0, 53795.193072103946, 54884.451155487935, 54924.45075549273, 54959.0, 55001.72499137479, 1252.7118762684634, 1295.8315418995471, 1341.7718987772103, 1345.1256683156028, 1480.0749531542785, 27854.721452785212, 28462.57306140368, 28533.857330713214, 28810.423791523634, 29126.27184320324, 40607.39088913728, 40749.0, 41194.58805412027, 41203.7939810299, 41243.1751364965, 249202.0, 249755.0, 249831.0, 249872.0, 250032.0, 22775.544489109794, 24186.87906560456, 24605.87697061503, 24659.630105548073, 24701.50596988086, 38832.61167388403, 38941.415878761276, 39235.80382098071, 39934.60065399309, 40093.39859902045, 36924.0, 37630.0, 37633.81183094067, 37679.246415071, 38333.4249986256, 37196.44205336868, 37322.626773733, 37835.432468512445, 37894.8105259483, 38165.427518586686, 37241.0, 37950.430743538316, 38054.429183562825, 38152.236955261294, 38248.235035299695, 32042.35915281728, 32991.50512742263, 33007.50488742623, 33482.83258583691, 33779.831100845324, 26154.476910461304, 26226.213213603623, 26419.735802641728, 26505.33736656599, 26942.461150777268], "value": 18836.689749560865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.7169666143716, 395.4977178982692, 398.0824200218499, 403.9293123703353, 414.5398607545626, 17624.735628965558, 17897.463076107706, 18248.817511824895, 18309.267629294827, 20049.899750501263, 16365.181740912967, 16926.40757573485, 17306.0, 17331.39340123096, 17335.0, 5512.6968016759265, 5585.1063829787245, 5749.712514374285, 5755.39568345324, 5781.39295373986, 5683.204351390808, 5692.829215123553, 5718.9428105719035, 5743.224664670258, 5745.138229265623, 5458.1266997280245, 5560.527355174795, 5647.519960803336, 5669.744861481243, 5710.743016564244, 5584.46947539983, 5625.184348269478, 5695.487406133447, 5699.829005129832, 5704.1443783432405, 5056.115179843549, 5077.213031980049, 5229.660072095339, 5508.20131080995, 5515.283013208297, 20924.686129708065, 20944.057517411602, 20947.68578471324, 21193.894030529904, 21211.575768484698, 2205.2722601541454, 2221.1892659179284, 2404.8677322747244, 2528.747125287475, 2604.4400453902313, 9689.0, 9778.462184579845, 9942.204623630092, 9971.700848974542, 10062.094411503, 1965.8525610579263, 2017.5460521382718, 2018.3944816554974, 2039.9184032638677, 2101.5166511702396, 54478.0, 69917.0, 71010.64494677546, 81794.0, 84115.0, 9544.856827147598, 9649.179819715262, 9812.558434870449, 9819.656312029045, 10326.070653641209, 14216.644583885485, 14230.359633816295, 14258.429662813578, 14282.143071415749, 14283.0, 7574.5076570022775, 7623.885641715378, 7678.0, 7708.421868359784, 7828.686852525835, 7707.306342429209, 7723.304902558797, 7825.765227043198, 7892.4869883457395, 7899.605019748989, 4428.269335559597, 4528.547145285445, 4537.500874903824, 4640.930386044212, 4652.813887444464, 1859.181959937623, 1864.1890777511826, 1879.633471473077, 1909.415185396118, 1931.4109196695142, 871.9171678690515, 904.1004200820095, 914.8170365926708, 965.792354643755, 1058.1587637827945, 18142.546436338933, 18236.45290641283, 18560.628787424444, 18584.907075464806, 18769.90615046916, 972.1930797438109, 980.0836218136066, 999.1507218863908, 1036.79782442423, 1038.5378506564657, 10213.846792298122, 10552.15582753378, 10614.89385106139, 10668.253222274521, 10720.892791072145, 184137.0, 455870.0, 459185.0, 465910.0, 474434.0, 82037.0, 89738.0, 90206.99999999869, 90739.0, 91596.0, 1009.6819501856892, 1016.588281745894, 1033.8914413986574, 1037.201354956679, 1037.64719995202, 15897.443589474775, 16327.67344653124, 16368.508944731677, 16416.589585260463, 16532.338706451606, 33210.83394583012, 37757.05607359838, 38473.61526384812, 39190.80404597959, 39242.607573923895, 44812.551874482146, 48974.75512622414, 49354.75322623364, 49473.25790113079, 49528.0, 8074.335788570155, 8139.918600813916, 8252.21603947624, 8287.694613888783, 8325.666973321, 9318.906810931803, 9745.0, 12357.196782209128, 12450.81323780126, 12476.126671132934, 10680.305780124267, 10867.456627168453, 11221.60724374643, 11384.260023098472, 11410.543578256777, 10547.0, 10665.520051597852, 10796.352218866894, 10890.0, 10999.23005389615, 11124.276922000045, 11464.25482343645, 11555.595554155565, 11588.94205528967, 11715.882841171479, 8054.677812887418, 8182.877256841033, 8220.301274391744, 8244.670213191404, 8434.114417986024, 8391.328693704367, 10317.690469285933, 10817.675469735921, 10955.616553420592, 11296.661100167008], "value": 8746.239899578086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.854705982341, 1406.6131813751217, 1455.2723638180908, 1550.6356006338508, 1751.5708651380405, 7398.6670599823, 8001.599920004006, 8218.753437396872, 8227.300679442254, 8232.094469608339, 8026.157253488387, 8166.3875209359385, 8190.631421586028, 8197.0, 8211.219934106266, 2016.5462770876582, 2078.0025587717905, 2081.906314215864, 2288.450771814765, 2321.9883900580558, 2293.2776175504746, 2370.478494731165, 2375.70303712036, 2377.476955069882, 2379.4884099918513, 2304.1704986204954, 2332.6034574122355, 2339.7660233976553, 2342.10999820069, 2345.847519911209, 1990.5521257717044, 2148.6562150055915, 2286.371247906822, 2290.9083636654514, 2293.7706229377013, 2337.439014636492, 2366.2901129661204, 2367.5975084235547, 2368.2895131460664, 2371.1108334374608, 8031.95984020082, 8092.1503242159315, 8095.028596568391, 8106.148854370324, 8107.067687215927, 4724.267738500504, 4891.633127515451, 4918.188498897677, 4923.0, 4924.064427758714, 3037.438073956303, 3143.748500119985, 3167.7940933839227, 3181.904542863718, 3190.1546090286092, 1048.8479170520309, 1050.4012712753656, 1061.601899287767, 1067.071647666535, 1087.5486673030682, 11138.665840024812, 11143.609973650964, 11148.721281967935, 11157.832632510519, 11160.609378671788, 4427.734335939854, 4432.335149727567, 4635.7450340230935, 4654.557817007379, 4654.953450465519, 9514.0010298919, 9532.714018579454, 9537.713868583953, 9539.427634341962, 9542.188913942255, 5044.445111037783, 5113.51421614946, 5119.0529751995255, 5120.078385890501, 5124.8206312778875, 4176.206520761046, 4552.203364411214, 4620.214563524209, 4681.087187998376, 4700.435947686231, 3716.925661486755, 3781.1870447853844, 3794.7533410328792, 3833.9041523962123, 3872.1674839909556, 1183.7869183547043, 1193.117093350914, 1203.5907791350983, 1204.3015051270418, 1217.2027322103859, 852.7910661887877, 977.6969139566758, 984.9015098490094, 1002.6540843409012, 1031.5306535526317, 5615.241942337814, 5747.1379293106365, 5772.2207501986695, 5803.506701930383, 5904.7933322334375, 408.28346252326975, 414.18819114535245, 426.0477832045376, 426.9146170765859, 440.1680823244071, 4151.12826306473, 4183.163367326486, 4197.895052623709, 4209.410682504452, 4263.232618128766, 9754.512274386252, 10348.482575871176, 10364.948175259075, 10395.116415104649, 10416.375017498824, 10001.549930253155, 10174.796504069876, 10278.434686092336, 10285.2800303978, 10305.072543471124, 7356.668949897267, 7831.412644051719, 7879.763607091796, 7896.842063158705, 7914.722984695508, 5539.833804985857, 5601.439856014366, 5655.293088363955, 5727.198192253171, 5813.069908814569, 9226.35415520907, 9438.575264112995, 9458.858117128386, 9490.288228383037, 9496.952515237379, 9104.180623743894, 9282.118198771106, 9294.9535252326, 9303.86044209351, 9346.813063738824, 6644.235912869888, 6904.447644188554, 7058.54119482232, 7093.1488221413765, 7281.927180728125, 7942.682292708227, 7958.562279074707, 8006.0, 8022.237887400687, 8036.959815200887, 7118.715251389886, 7280.1435633913015, 7341.706331746884, 7448.217937116525, 7466.36535894455, 7119.82200444993, 7171.354578087997, 7194.928050719426, 7210.855782884208, 7222.783316500513, 6678.365555272241, 6729.293424190585, 6745.494087943326, 6747.730090796314, 6748.055272261985, 5019.32239147725, 5058.367704036996, 5115.283860259492, 5118.616103792305, 5121.8463446096675, 5080.314157588826, 5190.506901844319, 5190.714510701948, 5233.450487698737, 5246.213068039672], "value": 4335.861525340959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.0833582610431, 323.9983800080999, 325.6580590380101, 327.87049115599336, 328.87502748955393, 5069.21427178787, 5139.177731562951, 5246.658967167132, 5280.0, 5307.867303317415, 5207.5369879030495, 5217.608679349045, 5231.267622532849, 5240.842774716764, 5248.160294352904, 4007.5792041835625, 4014.478117844676, 4061.5735347788354, 4118.629323360897, 4123.587641235882, 3871.9419208711893, 3919.0, 4103.671706263507, 4130.483689538808, 4151.813168407414, 4040.717149799515, 4052.837886484537, 4094.6314831665145, 4105.3431450967855, 4131.297679394495, 4025.2955732746946, 4053.2298863215897, 4067.755934643916, 4094.6928980326593, 4100.077482566398, 3548.5741710994844, 3637.3086514770757, 3648.2521083177885, 3650.9269814603826, 3658.5243918290716, 5003.0, 5012.298278241049, 5027.522385373383, 5039.118154323016, 5045.873853153664, 4651.395318608559, 4656.3946686930485, 4665.696729712592, 4669.649776266793, 4669.6731228814, 5163.974180129113, 5399.271098401705, 5420.674759514442, 5420.7018613976215, 5473.890522189574, 3861.517310336208, 3886.358750806142, 3891.805409729502, 3900.395438707005, 3903.5706072332023, 5588.86027849307, 5631.915521267184, 5662.886742265173, 5683.971580142114, 5705.632162652453, 3842.1547259602844, 3939.3697008478507, 3941.2117576484816, 3963.048868271594, 3972.66232370246, 3988.960110398859, 3989.4414781930554, 4000.9199816003515, 4002.8799136025964, 4017.8593749218635, 4555.2256116460285, 4589.885252868705, 4592.632589392841, 4602.010567727954, 4635.791389387486, 5339.225812257201, 5445.264889239981, 5493.176023596413, 5497.972510137423, 5527.50252477279, 1433.9426422943175, 1446.616646588655, 1447.6815100678045, 1447.9276036198148, 1455.6360909772557, 946.8816397950256, 965.8406362950175, 976.038601977052, 978.3151793744265, 980.3382716666222, 5634.760352722395, 5660.801871934463, 5665.348484924204, 5679.375268720438, 5694.174344719992, 5991.490723288569, 6009.2188015557695, 6009.429104235091, 6022.156898034279, 6031.819045428644, 5497.285352904097, 5642.379338272786, 5671.801486947937, 5728.656280623176, 5730.08318669011, 3192.457282262021, 3208.5668434761474, 3215.903522894317, 3216.195951012247, 3219.6297425796333, 6001.3098493672915, 6180.721867515973, 6202.472789812917, 6210.882041232621, 6254.437100660872, 6026.6986650667295, 6044.9395506044375, 6052.880217159752, 6085.648761135809, 6103.3591472894705, 6119.2350956130485, 6204.7828326008375, 6247.250329960434, 6249.406306400975, 6258.9374106259265, 5792.797252096325, 5983.910241346296, 6007.789727359522, 6022.705118399565, 6026.216591843032, 5901.144334071621, 5936.732847021808, 5939.2575928009, 5947.9702601486715, 5954.851128721816, 5995.8008398319635, 6132.325444201224, 6176.930728205922, 6183.443490085734, 6239.126522286974, 3668.853245870242, 3754.0666556722763, 3774.150816066363, 3787.450819631193, 3877.1389732927787, 5597.6641401516035, 5629.4652008059165, 5631.070873306023, 5631.662100273997, 5650.152477128464, 5339.893202135858, 5473.151661492475, 5474.863128421821, 5491.835244942658, 5501.119820828648, 5453.372862120748, 5459.235707001102, 5488.286522752017, 5493.835184944458, 5500.477454641803, 5364.919526207188, 5366.731663416892, 5368.302120724437, 5416.322959630046, 5429.782808687766, 5268.841934741964, 5500.6347270674, 5519.951209270226, 5526.171074338881, 5587.469190426903, 5398.811041613525, 5446.237526746179, 5446.373667028342, 5458.972705136608, 5510.338759348743], "value": 4253.138509889218, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.3574168797953, 676.5771392879453, 721.7077083781068, 735.525585997032, 745.8684252343874, 12542.310172940484, 12861.807072893891, 12879.871201287984, 12892.0, 15147.318370673318, 14537.92731036346, 14605.780913286282, 14637.0, 14695.191764452951, 14716.411343546271, 641.8844607970564, 777.3159619534802, 795.4193438789687, 806.6289506826866, 806.9072056713466, 795.1968511803092, 807.8020884883182, 808.4502538273971, 808.4744915804715, 808.6926967752275, 834.7913021744564, 838.7106448275335, 841.7979684875617, 841.8400503904269, 842.0989541190928, 678.1319910514574, 810.7040930060485, 832.5337810825957, 832.8584140696096, 839.2404873589411, 613.7851751886803, 614.7540983606549, 615.1357342933186, 616.1158737212115, 616.3713012727038, 13502.93248533761, 13525.932370338085, 13529.255890925995, 13537.661558461117, 13561.389737461739, 10948.178886583539, 11335.37655428951, 11730.0, 11761.000314973238, 11792.764144717057, 10445.738856528571, 10626.30928989621, 10711.303765255234, 10775.946120269427, 11184.44077796115, 3638.43604241343, 3667.413213885792, 3693.686036686885, 3728.142527218755, 3804.8097595120134, 53667.463325367025, 54174.187387189224, 54649.0, 54775.72612136954, 57210.71394643, 8740.475571465733, 8842.115788421106, 9053.094690530894, 9120.81758364829, 9132.726018219464, 19033.238670453306, 19088.14103365352, 19146.0, 19150.233990640496, 19188.424347269603, 7434.442416818761, 7596.544207347577, 7598.164201937782, 7709.768706938801, 7727.49771264866, 4220.451341325608, 4224.4930608327195, 4232.0, 4341.869743907625, 4447.488538818077, 3220.3076338587316, 3261.2825178460703, 3280.3603297357263, 3287.983560082232, 3288.473844184919, 540.8269353806744, 586.2730214534032, 595.4402861310355, 597.8236420256035, 609.1563184988822, 559.3846768554639, 629.6159342800888, 699.8110510162329, 717.8872747241754, 740.2597402597403, 8209.38429617781, 8789.82985016652, 9039.367244292836, 9110.407823491585, 9177.495237761854, 579.5566391710345, 649.6524359467662, 666.3170250493283, 670.4569298867932, 698.1064237775655, 4225.661947044229, 4421.867343979686, 4430.734155950653, 4446.3552784846015, 4493.73037617744, 61773.382266177665, 61866.38133618696, 62019.0, 63452.0, 63690.681546592896, 58065.70967145222, 58437.12344314839, 58701.41298587045, 58967.70516147392, 60180.39819601835, 53240.73379633077, 53293.46706532963, 53985.46014539883, 54460.183097253575, 54916.45083549113, 8843.248323892542, 8986.775330616787, 9044.63821447161, 9079.636814527345, 9277.16505514507, 30119.0, 30922.0, 31035.68964310328, 32234.35531289408, 33199.66800332062, 42982.35526467168, 43081.353779692705, 43422.78288608537, 43444.56555434405, 44578.77710611426, 11921.0, 11948.820767688318, 12038.879611203776, 12089.0, 12382.690432738893, 11644.76710465769, 12456.626301210978, 12803.551875684307, 12898.290594017419, 12970.481180752664, 10907.781844363228, 11042.957003166728, 11287.0, 11418.942905285421, 11672.824907626222, 11775.587854425054, 11800.232984855957, 11948.76102477963, 12237.69405764863, 12279.815802762787, 11112.444377781241, 11428.657140285804, 11438.252074042635, 11545.191836571696, 11911.821322679993, 8838.823223535364, 8975.416597921114, 9083.409578377385, 9167.541622918961, 9258.166764991183, 9684.176844968257, 9731.41611503312, 9793.75515612087, 9815.705528834147, 9836.262280328861], "value": 6413.829490588859, "unit": "score"}], "name": "dromaeo_css", "value": 6826.213308414971, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 106.0, 110.0, 111.0, 111.0, 100.0, 110.0, 111.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 152.0, 192.0, 135.0, 152.0, 162.0, 126.0, 180.0, 127.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 160.0, 160.0, 161.0, 159.0, 161.0, 163.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 118.0, 108.0, 77.0, 72.0, 75.0, 127.0, 104.0, 73.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 148.0, 93.0, 94.0, 93.0, 160.0, 94.0, 94.0, 147.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 60.0, 59.0, 59.0, 62.0, 74.0, 57.0, 57.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 67.0, 62.0, 61.0, 61.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 76.0, 84.0, 78.0, 79.0, 78.0, 78.0, 79.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 131.0, 123.0, 131.0, 120.0, 121.0, 127.0, 122.0, 221.0, 137.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 172.0, 173.0, 173.0, 169.0, 173.0, 166.0, 166.0, 165.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 72.0, 67.0, 69.0, 67.0, 67.0, 68.0, 68.0, 69.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1555.5999999999997, "alertThreshold": 2.0}]} 19:15:02 INFO - Return code: 0 19:15:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:15:02 ERROR - # TBPL SUCCESS # 19:15:02 INFO - Running post-action listener: _resource_record_post_action 19:15:02 INFO - Running post-run listener: _resource_record_post_run 19:15:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284573696; Read time: 16; Write time: 177048 19:15:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 462848; Read time: 0; Write time: 44 19:15:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284110848; Read time: 16; Write time: 177004 19:15:03 INFO - Running post-run listener: _upload_blobber_files 19:15:03 INFO - Blob upload gear active. 19:15:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:15:03 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 19:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:15:04 INFO - (blobuploader) - INFO - Open directory for files ... 19:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:04 INFO - (blobuploader) - INFO - Done attempting. 19:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:15:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:05 INFO - (blobuploader) - INFO - Done attempting. 19:15:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:15:05 INFO - Return code: 0 19:15:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:15:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:15:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629dc511a559c31d1f7b5c40e5d17b3381e92a0901b31de6317ef728796001d57fd5cf7a207685c42fcbb61eff32dae999215817d554e1e37857fc1b52de4f62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/980431ce3b73e2edd68c9f497c4af3eee6e19fc112d82bad453705be5c4eae5233173f2e5b6b4133ce05eae1c13b55f7ab82090698027053194d41230d07b98b"} 19:15:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:15:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:15:05 INFO - Contents: 19:15:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629dc511a559c31d1f7b5c40e5d17b3381e92a0901b31de6317ef728796001d57fd5cf7a207685c42fcbb61eff32dae999215817d554e1e37857fc1b52de4f62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/980431ce3b73e2edd68c9f497c4af3eee6e19fc112d82bad453705be5c4eae5233173f2e5b6b4133ce05eae1c13b55f7ab82090698027053194d41230d07b98b"} 19:15:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:15:05 INFO - Copying logs to upload dir... 19:15:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:15:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.083097 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-25 19:15:05.872808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 19:15:05.876407) ========= 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=0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629dc511a559c31d1f7b5c40e5d17b3381e92a0901b31de6317ef728796001d57fd5cf7a207685c42fcbb61eff32dae999215817d554e1e37857fc1b52de4f62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/980431ce3b73e2edd68c9f497c4af3eee6e19fc112d82bad453705be5c4eae5233173f2e5b6b4133ce05eae1c13b55f7ab82090698027053194d41230d07b98b"} build_url:https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/SazbZHfQQ36JaFwoIvlLXg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629dc511a559c31d1f7b5c40e5d17b3381e92a0901b31de6317ef728796001d57fd5cf7a207685c42fcbb61eff32dae999215817d554e1e37857fc1b52de4f62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/980431ce3b73e2edd68c9f497c4af3eee6e19fc112d82bad453705be5c4eae5233173f2e5b6b4133ce05eae1c13b55f7ab82090698027053194d41230d07b98b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 19:15:05.901000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:15:05.901320) ========= 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=0e2a256762fed810e2f0f810000001b3-1461634873.885052-39933939 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-04-25 19:15:05.983599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 19:15:05.983907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 19:15:05.984198) ========= ========= Total master_lag: 0.17 =========