builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1462552431.9 results: success (0) buildid: 20160506065826 builduid: 4bfa9758e8bf4fe29c5d139221b96561 revision: ca9f8dc6b0307249e1d117df3f057f2634571c9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:51.902634) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:51.903117) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:51.903470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:51.916780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:51.917084) ========= 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=32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 09:33:52-- 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% 18.0M=0.001s 2016-05-06 09:33:52 (18.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:52.084801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:52.085146) ========= 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=32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019125 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:52.135719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 09:33:52.136070) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ca9f8dc6b0307249e1d117df3f057f2634571c9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ca9f8dc6b0307249e1d117df3f057f2634571c9a --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=32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 09:33:52,604 truncating revision to first 12 chars 2016-05-06 09:33:52,604 Setting DEBUG logging. 2016-05-06 09:33:52,605 attempt 1/10 2016-05-06 09:33:52,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ca9f8dc6b030?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 09:33:53,884 unpacking tar archive at: mozilla-beta-ca9f8dc6b030/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 09:33:53.731605) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:53.732151) ========= script_repo_revision: ca9f8dc6b0307249e1d117df3f057f2634571c9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:53.732663) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:53.733153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:33:53.743832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-06 09:33:53.744281) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:33:54 INFO - MultiFileLogger online at 20160506 09:33:54 in /builds/slave/test 09:33:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:33:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:54 INFO - {'append_to_log': False, 09:33:54 INFO - 'base_work_dir': '/builds/slave/test', 09:33:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:33:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:54 INFO - 'branch': 'Mozilla-Beta', 09:33:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:54 INFO - 'config_files': ('talos/linux_config.py',), 09:33:54 INFO - 'default_actions': ('clobber', 09:33:54 INFO - 'read-buildbot-config', 09:33:54 INFO - 'download-and-extract', 09:33:54 INFO - 'populate-webroot', 09:33:54 INFO - 'create-virtualenv', 09:33:54 INFO - 'install', 09:33:54 INFO - 'run-tests'), 09:33:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:54 INFO - 'download_minidump_stackwalk': True, 09:33:54 INFO - 'download_symbols': 'ondemand', 09:33:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:54 INFO - 'installer_path': 'installer.exe', 09:33:54 INFO - 'log_level': 'info', 09:33:54 INFO - 'log_name': 'talos', 09:33:54 INFO - 'log_to_console': True, 09:33:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:33:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:33:54 INFO - 'opt_config_files': (), 09:33:54 INFO - 'pip_index': False, 09:33:54 INFO - 'sps_profile': False, 09:33:54 INFO - 'sps_profile_interval': 0, 09:33:54 INFO - 'suite': 'dromaeojs', 09:33:54 INFO - 'system_bits': '32', 09:33:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:54 INFO - 'title': 'talos-linux64-ix-008', 09:33:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:54 INFO - 'use_talos_json': True, 09:33:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:54 INFO - 'work_dir': 'build'} 09:33:54 INFO - ##### 09:33:54 INFO - ##### Running clobber step. 09:33:54 INFO - ##### 09:33:54 INFO - Running pre-action listener: _resource_record_pre_action 09:33:54 INFO - Running main action method: clobber 09:33:54 INFO - rmtree: /builds/slave/test/build 09:33:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:55 INFO - Running post-action listener: _resource_record_post_action 09:33:55 INFO - ##### 09:33:55 INFO - ##### Running read-buildbot-config step. 09:33:55 INFO - ##### 09:33:55 INFO - Running pre-action listener: _resource_record_pre_action 09:33:55 INFO - Running main action method: read_buildbot_config 09:33:55 INFO - Using buildbot properties: 09:33:55 INFO - { 09:33:55 INFO - "project": "", 09:33:55 INFO - "product": "firefox", 09:33:55 INFO - "script_repo_revision": "production", 09:33:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:33:55 INFO - "repository": "", 09:33:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:33:55 INFO - "buildid": "20160506065826", 09:33:55 INFO - "pgo_build": "True", 09:33:55 INFO - "basedir": "/builds/slave/test", 09:33:55 INFO - "buildnumber": 70, 09:33:55 INFO - "slavename": "talos-linux64-ix-008", 09:33:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:33:55 INFO - "platform": "ubuntu64_hw", 09:33:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:33:55 INFO - "branch": "mozilla-beta", 09:33:55 INFO - "repo_path": "releases/mozilla-beta", 09:33:55 INFO - "revision": "ca9f8dc6b0307249e1d117df3f057f2634571c9a", 09:33:55 INFO - "stage_platform": "linux64-pgo", 09:33:55 INFO - "builduid": "4bfa9758e8bf4fe29c5d139221b96561", 09:33:55 INFO - "slavebuilddir": "test" 09:33:55 INFO - } 09:33:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 09:33:55 INFO - Running post-action listener: _resource_record_post_action 09:33:55 INFO - ##### 09:33:55 INFO - ##### Running download-and-extract step. 09:33:55 INFO - ##### 09:33:55 INFO - Running pre-action listener: _resource_record_pre_action 09:33:55 INFO - Running main action method: download_and_extract 09:33:55 INFO - mkdir: /builds/slave/test/build/tests 09:33:55 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')]} 09:33:55 INFO - https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:33:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:33:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:33:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:33:56 INFO - Downloaded 1412 bytes. 09:33:56 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:33:56 INFO - Using the following test package requirements: 09:33:56 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:33:56 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:33:56 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 09:33:56 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'jsshell-linux-x86_64.zip'], 09:33:56 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:33:56 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:33:56 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 09:33:56 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 09:33:56 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:33:56 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:33:56 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:33:56 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:33:56 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:33:56 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')]} 09:33:56 INFO - https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:33:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:33:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:57 INFO - Downloaded 23364814 bytes. 09:33:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:33:58 INFO - Return code: 0 09:33:58 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:58 INFO - https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:33:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:33:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:34:01 INFO - Downloaded 23364814 bytes. 09:34:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:34:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:34:02 INFO - Return code: 0 09:34:02 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')]} 09:34:02 INFO - https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:34:03 INFO - Downloaded 10845194 bytes. 09:34:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:34:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:34:03 INFO - Return code: 0 09:34:03 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')]} 09:34:03 INFO - https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:34:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:34:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:34:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:34:06 INFO - Downloaded 53794029 bytes. 09:34:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:34:06 INFO - mkdir: /builds/slave/test/properties 09:34:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:34:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:34:06 INFO - Contents: 09:34:06 INFO - build_url:https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:34:06 INFO - Running post-action listener: _resource_record_post_action 09:34:06 INFO - Running post-action listener: set_extra_try_arguments 09:34:06 INFO - ##### 09:34:06 INFO - ##### Running populate-webroot step. 09:34:06 INFO - ##### 09:34:06 INFO - Running pre-action listener: _resource_record_pre_action 09:34:06 INFO - Running main action method: populate_webroot 09:34:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:34:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:34:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:34:06 INFO - '--tppagecycles', 09:34:06 INFO - '7'], 09:34:06 INFO - 'tests': ['tsvgm']}}, 09:34:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:34:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:34:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:34:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:34:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:34:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:34:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'tests': ['damp', 'tps']}, 09:34:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['damp', 'tps']}, 09:34:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:34:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:34:06 INFO - 'other': {'tests': ['a11yr', 09:34:06 INFO - 'ts_paint', 09:34:06 INFO - 'tpaint', 09:34:06 INFO - 'sessionrestore', 09:34:06 INFO - 'sessionrestore_no_auto_restore', 09:34:06 INFO - 'tabpaint']}, 09:34:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['a11yr', 09:34:06 INFO - 'ts_paint', 09:34:06 INFO - 'tpaint', 09:34:06 INFO - 'sessionrestore', 09:34:06 INFO - 'sessionrestore_no_auto_restore', 09:34:06 INFO - 'tabpaint']}, 09:34:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['a11yr', 09:34:06 INFO - 'ts_paint', 09:34:06 INFO - 'tpaint', 09:34:06 INFO - 'sessionrestore', 09:34:06 INFO - 'sessionrestore_no_auto_restore', 09:34:06 INFO - 'tabpaint']}, 09:34:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['a11yr', 09:34:06 INFO - 'ts_paint', 09:34:06 INFO - 'tpaint', 09:34:06 INFO - 'sessionrestore', 09:34:06 INFO - 'sessionrestore_no_auto_restore', 09:34:06 INFO - 'tabpaint']}, 09:34:06 INFO - 'other_l64': {'tests': ['a11yr', 09:34:06 INFO - 'ts_paint', 09:34:06 INFO - 'tpaint', 09:34:06 INFO - 'sessionrestore', 09:34:06 INFO - 'sessionrestore_no_auto_restore', 09:34:06 INFO - 'tabpaint']}, 09:34:06 INFO - 'other_nol64': {'tests': ['a11yr', 09:34:06 INFO - 'ts_paint', 09:34:06 INFO - 'tpaint', 09:34:06 INFO - 'sessionrestore', 09:34:06 INFO - 'sessionrestore_no_auto_restore', 09:34:06 INFO - 'tabpaint']}, 09:34:06 INFO - 'svgr': {'tests': ['tsvgx', 09:34:06 INFO - 'tsvgr_opacity', 09:34:06 INFO - 'tart', 09:34:06 INFO - 'tscrollx', 09:34:06 INFO - 'cart']}, 09:34:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['tsvgx', 09:34:06 INFO - 'tsvgr_opacity', 09:34:06 INFO - 'tart', 09:34:06 INFO - 'tscrollx', 09:34:06 INFO - 'cart']}, 09:34:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'tests': ['tp5o']}, 09:34:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'talos_options': ['--e10s'], 09:34:06 INFO - 'tests': ['tp5o']}, 09:34:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'talos_options': ['--xperf_path', 09:34:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:34:06 INFO - 'tests': ['tp5n']}, 09:34:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:34:06 INFO - 'talos_options': ['--e10s', 09:34:06 INFO - '--xperf_path', 09:34:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:34:06 INFO - 'tests': ['tp5n']}}, 09:34:06 INFO - 'talos.zip': {'path': '', 09:34:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:34:06 INFO - Running post-action listener: _resource_record_post_action 09:34:06 INFO - ##### 09:34:06 INFO - ##### Running create-virtualenv step. 09:34:06 INFO - ##### 09:34:06 INFO - Running pre-action listener: _resource_record_pre_action 09:34:06 INFO - Running main action method: create_virtualenv 09:34:06 INFO - Creating virtualenv /builds/slave/test/build/venv 09:34:06 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 09:34:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:34:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:34:06 INFO - Using real prefix '/usr' 09:34:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:34:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:34:09 INFO - Installing pip.................done. 09:34:09 INFO - Return code: 0 09:34:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:09 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 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:09 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 09:34:09 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 09:34:09 INFO - Using env: {'DISPLAY': ':0', 09:34:09 INFO - 'HOME': '/home/cltbld', 09:34:09 INFO - 'LANG': 'en_US.UTF-8', 09:34:09 INFO - 'LANGUAGE': 'en_US:en', 09:34:09 INFO - 'LOGNAME': 'cltbld', 09:34:09 INFO - 'MAIL': '/var/mail/cltbld', 09:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:09 INFO - 'MOZ_NO_REMOTE': '1', 09:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:09 INFO - 'NO_EM_RESTART': '1', 09:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:09 INFO - 'PWD': '/builds/slave/test', 09:34:09 INFO - 'SHELL': '/bin/bash', 09:34:09 INFO - 'SHLVL': '1', 09:34:09 INFO - 'TERM': 'linux', 09:34:09 INFO - 'TMOUT': '86400', 09:34:09 INFO - 'USER': 'cltbld', 09:34:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:09 INFO - '_': '/tools/buildbot/bin/python'} 09:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:09 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 09:34:09 INFO - Cleaning up... 09:34:09 INFO - Return code: 0 09:34:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:09 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 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:09 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 09:34:09 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 09:34:09 INFO - Using env: {'DISPLAY': ':0', 09:34:09 INFO - 'HOME': '/home/cltbld', 09:34:09 INFO - 'LANG': 'en_US.UTF-8', 09:34:09 INFO - 'LANGUAGE': 'en_US:en', 09:34:09 INFO - 'LOGNAME': 'cltbld', 09:34:09 INFO - 'MAIL': '/var/mail/cltbld', 09:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:09 INFO - 'MOZ_NO_REMOTE': '1', 09:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:09 INFO - 'NO_EM_RESTART': '1', 09:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:09 INFO - 'PWD': '/builds/slave/test', 09:34:09 INFO - 'SHELL': '/bin/bash', 09:34:09 INFO - 'SHLVL': '1', 09:34:09 INFO - 'TERM': 'linux', 09:34:09 INFO - 'TMOUT': '86400', 09:34:09 INFO - 'USER': 'cltbld', 09:34:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:09 INFO - '_': '/tools/buildbot/bin/python'} 09:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:09 INFO - Downloading/unpacking psutil>=0.7.1 09:34:09 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 09:34:09 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 09:34:09 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 09:34:09 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 09:34:09 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 09:34:09 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 09:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:34:11 INFO - Installing collected packages: psutil 09:34:11 INFO - Running setup.py install for psutil 09:34:11 INFO - building 'psutil._psutil_linux' extension 09:34:11 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 09:34:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:34:12 INFO - building 'psutil._psutil_posix' extension 09:34:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:34:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:34:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:34:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:34:12 INFO - Successfully installed psutil 09:34:12 INFO - Cleaning up... 09:34:12 INFO - Return code: 0 09:34:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:12 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 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:12 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 09:34:12 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 09:34:12 INFO - Using env: {'DISPLAY': ':0', 09:34:12 INFO - 'HOME': '/home/cltbld', 09:34:12 INFO - 'LANG': 'en_US.UTF-8', 09:34:12 INFO - 'LANGUAGE': 'en_US:en', 09:34:12 INFO - 'LOGNAME': 'cltbld', 09:34:12 INFO - 'MAIL': '/var/mail/cltbld', 09:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:12 INFO - 'MOZ_NO_REMOTE': '1', 09:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:12 INFO - 'NO_EM_RESTART': '1', 09:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:12 INFO - 'PWD': '/builds/slave/test', 09:34:12 INFO - 'SHELL': '/bin/bash', 09:34:12 INFO - 'SHLVL': '1', 09:34:12 INFO - 'TERM': 'linux', 09:34:12 INFO - 'TMOUT': '86400', 09:34:12 INFO - 'USER': 'cltbld', 09:34:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:12 INFO - '_': '/tools/buildbot/bin/python'} 09:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:34:12 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 09:34:12 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 09:34:12 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 09:34:12 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 09:34:12 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 09:34:12 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 09:34:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:34:14 INFO - Installing collected packages: mozsystemmonitor 09:34:14 INFO - Running setup.py install for mozsystemmonitor 09:34:14 INFO - Successfully installed mozsystemmonitor 09:34:14 INFO - Cleaning up... 09:34:14 INFO - Return code: 0 09:34:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:14 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 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:14 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 09:34:14 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 09:34:14 INFO - Using env: {'DISPLAY': ':0', 09:34:14 INFO - 'HOME': '/home/cltbld', 09:34:14 INFO - 'LANG': 'en_US.UTF-8', 09:34:14 INFO - 'LANGUAGE': 'en_US:en', 09:34:14 INFO - 'LOGNAME': 'cltbld', 09:34:14 INFO - 'MAIL': '/var/mail/cltbld', 09:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:14 INFO - 'MOZ_NO_REMOTE': '1', 09:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:14 INFO - 'NO_EM_RESTART': '1', 09:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:14 INFO - 'PWD': '/builds/slave/test', 09:34:14 INFO - 'SHELL': '/bin/bash', 09:34:14 INFO - 'SHLVL': '1', 09:34:14 INFO - 'TERM': 'linux', 09:34:14 INFO - 'TMOUT': '86400', 09:34:14 INFO - 'USER': 'cltbld', 09:34:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:14 INFO - '_': '/tools/buildbot/bin/python'} 09:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:34:14 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 09:34:14 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 09:34:14 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 09:34:14 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 09:34:14 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 09:34:14 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 09:34:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:34:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:34:16 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 09:34:16 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 09:34:16 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 09:34:16 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 09:34:16 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 09:34:16 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 09:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:17 INFO - Downloading docopt-0.6.1.tar.gz 09:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:34:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:34:17 INFO - Running setup.py install for blobuploader 09:34:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:34:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:34:17 INFO - Running setup.py install for requests 09:34:17 INFO - Running setup.py install for docopt 09:34:18 INFO - Successfully installed blobuploader requests docopt 09:34:18 INFO - Cleaning up... 09:34:18 INFO - Return code: 0 09:34:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:18 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 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:18 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 09:34:18 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 09:34:18 INFO - Using env: {'DISPLAY': ':0', 09:34:18 INFO - 'HOME': '/home/cltbld', 09:34:18 INFO - 'LANG': 'en_US.UTF-8', 09:34:18 INFO - 'LANGUAGE': 'en_US:en', 09:34:18 INFO - 'LOGNAME': 'cltbld', 09:34:18 INFO - 'MAIL': '/var/mail/cltbld', 09:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:18 INFO - 'MOZ_NO_REMOTE': '1', 09:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:18 INFO - 'NO_EM_RESTART': '1', 09:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:18 INFO - 'PWD': '/builds/slave/test', 09:34:18 INFO - 'SHELL': '/bin/bash', 09:34:18 INFO - 'SHLVL': '1', 09:34:18 INFO - 'TERM': 'linux', 09:34:18 INFO - 'TMOUT': '86400', 09:34:18 INFO - 'USER': 'cltbld', 09:34:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:18 INFO - '_': '/tools/buildbot/bin/python'} 09:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:18 INFO - Running setup.py (path:/tmp/pip-BMmwst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:18 INFO - Running setup.py (path:/tmp/pip-xZUnQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:18 INFO - Running setup.py (path:/tmp/pip-GuZXrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:18 INFO - Running setup.py (path:/tmp/pip-lWpSfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:18 INFO - Running setup.py (path:/tmp/pip-YRapgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:18 INFO - Running setup.py (path:/tmp/pip-8SqdMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:18 INFO - Running setup.py (path:/tmp/pip-CRUtTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:18 INFO - Running setup.py (path:/tmp/pip-3LFf42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:18 INFO - Running setup.py (path:/tmp/pip-1dkON3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:18 INFO - Running setup.py (path:/tmp/pip-CMu6JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:19 INFO - Running setup.py (path:/tmp/pip-QvobQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:19 INFO - Running setup.py (path:/tmp/pip-y3cIzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:19 INFO - Running setup.py (path:/tmp/pip-vgTVpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:19 INFO - Running setup.py (path:/tmp/pip-j6mwOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:19 INFO - Running setup.py (path:/tmp/pip-KmD2fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:19 INFO - Running setup.py (path:/tmp/pip-zoO5vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:19 INFO - Running setup.py (path:/tmp/pip-crXmmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:34:19 INFO - Running setup.py install for manifestparser 09:34:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:34:19 INFO - Running setup.py install for mozcrash 09:34:19 INFO - Running setup.py install for mozdebug 09:34:19 INFO - Running setup.py install for mozdevice 09:34:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:34:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Running setup.py install for mozfile 09:34:20 INFO - Running setup.py install for mozhttpd 09:34:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Running setup.py install for mozinfo 09:34:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Running setup.py install for mozInstall 09:34:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Running setup.py install for mozleak 09:34:20 INFO - Running setup.py install for mozlog 09:34:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Running setup.py install for moznetwork 09:34:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Running setup.py install for mozprocess 09:34:20 INFO - Running setup.py install for mozprofile 09:34:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:34:20 INFO - Running setup.py install for mozrunner 09:34:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:34:21 INFO - Running setup.py install for mozscreenshot 09:34:21 INFO - Running setup.py install for moztest 09:34:21 INFO - Running setup.py install for mozversion 09:34:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:34:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:34:21 INFO - Cleaning up... 09:34:21 INFO - Return code: 0 09:34:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:21 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 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:21 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 09:34:21 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 09:34:21 INFO - Using env: {'DISPLAY': ':0', 09:34:21 INFO - 'HOME': '/home/cltbld', 09:34:21 INFO - 'LANG': 'en_US.UTF-8', 09:34:21 INFO - 'LANGUAGE': 'en_US:en', 09:34:21 INFO - 'LOGNAME': 'cltbld', 09:34:21 INFO - 'MAIL': '/var/mail/cltbld', 09:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:21 INFO - 'MOZ_NO_REMOTE': '1', 09:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:21 INFO - 'NO_EM_RESTART': '1', 09:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:21 INFO - 'PWD': '/builds/slave/test', 09:34:21 INFO - 'SHELL': '/bin/bash', 09:34:21 INFO - 'SHLVL': '1', 09:34:21 INFO - 'TERM': 'linux', 09:34:21 INFO - 'TMOUT': '86400', 09:34:21 INFO - 'USER': 'cltbld', 09:34:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:21 INFO - '_': '/tools/buildbot/bin/python'} 09:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:21 INFO - Running setup.py (path:/tmp/pip-nGkVG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:21 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)) 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:21 INFO - Running setup.py (path:/tmp/pip-CT18Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:21 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)) 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:21 INFO - Running setup.py (path:/tmp/pip-fBOfSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:21 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)) 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:21 INFO - Running setup.py (path:/tmp/pip-NW6HDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:21 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)) 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:21 INFO - Running setup.py (path:/tmp/pip-KxHyXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:21 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)) 09:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:21 INFO - Running setup.py (path:/tmp/pip-llbcll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:22 INFO - Running setup.py (path:/tmp/pip-o22UCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:22 INFO - Running setup.py (path:/tmp/pip-AZvYYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:22 INFO - Running setup.py (path:/tmp/pip-9YD6vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:22 INFO - Running setup.py (path:/tmp/pip-JbtgLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:22 INFO - Running setup.py (path:/tmp/pip-54BMtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:22 INFO - Running setup.py (path:/tmp/pip-Bab76O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:22 INFO - Running setup.py (path:/tmp/pip-zckwfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:22 INFO - Running setup.py (path:/tmp/pip-tTdRsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:22 INFO - Running setup.py (path:/tmp/pip-rtCSqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:22 INFO - Running setup.py (path:/tmp/pip-9cgPze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:22 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)) 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:22 INFO - Running setup.py (path:/tmp/pip-jTUum8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:22 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)) 09:34:22 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)) 09:34:22 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)) 09:34:22 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)) 09:34:22 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)) 09:34:22 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)) 09:34:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:22 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 09:34:22 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 09:34:22 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 09:34:22 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 09:34:22 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 09:34:22 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 09:34:24 INFO - Downloading blessings-1.6.tar.gz 09:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:34:24 INFO - Installing collected packages: blessings 09:34:24 INFO - Running setup.py install for blessings 09:34:24 INFO - Successfully installed blessings 09:34:24 INFO - Cleaning up... 09:34:24 INFO - Return code: 0 09:34:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:34:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:25 INFO - Reading from file tmpfile_stdout 09:34:25 INFO - Current package versions: 09:34:25 INFO - argparse == 1.2.1 09:34:25 INFO - blessings == 1.6 09:34:25 INFO - blobuploader == 1.2.4 09:34:25 INFO - docopt == 0.6.1 09:34:25 INFO - manifestparser == 1.1 09:34:25 INFO - mozInstall == 1.12 09:34:25 INFO - mozcrash == 0.17 09:34:25 INFO - mozdebug == 0.1 09:34:25 INFO - mozdevice == 0.48 09:34:25 INFO - mozfile == 1.2 09:34:25 INFO - mozhttpd == 0.7 09:34:25 INFO - mozinfo == 0.9 09:34:25 INFO - mozleak == 0.1 09:34:25 INFO - mozlog == 3.1 09:34:25 INFO - moznetwork == 0.27 09:34:25 INFO - mozprocess == 0.22 09:34:25 INFO - mozprofile == 0.28 09:34:25 INFO - mozrunner == 6.11 09:34:25 INFO - mozscreenshot == 0.1 09:34:25 INFO - mozsystemmonitor == 0.0 09:34:25 INFO - moztest == 0.7 09:34:25 INFO - mozversion == 1.4 09:34:25 INFO - psutil == 3.1.1 09:34:25 INFO - requests == 1.2.3 09:34:25 INFO - wsgiref == 0.1.2 09:34:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:25 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 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:25 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 09:34:25 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 09:34:25 INFO - Using env: {'DISPLAY': ':0', 09:34:25 INFO - 'HOME': '/home/cltbld', 09:34:25 INFO - 'LANG': 'en_US.UTF-8', 09:34:25 INFO - 'LANGUAGE': 'en_US:en', 09:34:25 INFO - 'LOGNAME': 'cltbld', 09:34:25 INFO - 'MAIL': '/var/mail/cltbld', 09:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:25 INFO - 'MOZ_NO_REMOTE': '1', 09:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:25 INFO - 'NO_EM_RESTART': '1', 09:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:25 INFO - 'PWD': '/builds/slave/test', 09:34:25 INFO - 'SHELL': '/bin/bash', 09:34:25 INFO - 'SHLVL': '1', 09:34:25 INFO - 'TERM': 'linux', 09:34:25 INFO - 'TMOUT': '86400', 09:34:25 INFO - 'USER': 'cltbld', 09:34:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:25 INFO - '_': '/tools/buildbot/bin/python'} 09:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 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)) 09:34:25 INFO - Cleaning up... 09:34:25 INFO - Return code: 0 09:34:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:34:25 INFO - Using env: {'DISPLAY': ':0', 09:34:25 INFO - 'HOME': '/home/cltbld', 09:34:25 INFO - 'LANG': 'en_US.UTF-8', 09:34:25 INFO - 'LANGUAGE': 'en_US:en', 09:34:25 INFO - 'LOGNAME': 'cltbld', 09:34:25 INFO - 'MAIL': '/var/mail/cltbld', 09:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:25 INFO - 'MOZ_NO_REMOTE': '1', 09:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:25 INFO - 'NO_EM_RESTART': '1', 09:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:25 INFO - 'PWD': '/builds/slave/test', 09:34:25 INFO - 'SHELL': '/bin/bash', 09:34:25 INFO - 'SHLVL': '1', 09:34:25 INFO - 'TERM': 'linux', 09:34:25 INFO - 'TMOUT': '86400', 09:34:25 INFO - 'USER': 'cltbld', 09:34:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:25 INFO - '_': '/tools/buildbot/bin/python'} 09:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:25 INFO - Downloading/unpacking jsonschema 09:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:34:27 INFO - Downloading/unpacking functools32 (from jsonschema) 09:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:34:27 INFO - warning: no files found matching '*.txt' 09:34:27 INFO - no previously-included directories found matching 'build' 09:34:27 INFO - no previously-included directories found matching 'dist' 09:34:27 INFO - no previously-included directories found matching '.git*' 09:34:27 INFO - Installing collected packages: jsonschema, functools32 09:34:27 INFO - Running setup.py install for functools32 09:34:27 INFO - warning: no files found matching '*.txt' 09:34:27 INFO - no previously-included directories found matching 'build' 09:34:27 INFO - no previously-included directories found matching 'dist' 09:34:27 INFO - no previously-included directories found matching '.git*' 09:34:27 INFO - Successfully installed jsonschema functools32 09:34:27 INFO - Cleaning up... 09:34:27 INFO - Return code: 0 09:34:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6794294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, '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': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', '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 09:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:34:27 INFO - Using env: {'DISPLAY': ':0', 09:34:27 INFO - 'HOME': '/home/cltbld', 09:34:27 INFO - 'LANG': 'en_US.UTF-8', 09:34:27 INFO - 'LANGUAGE': 'en_US:en', 09:34:27 INFO - 'LOGNAME': 'cltbld', 09:34:27 INFO - 'MAIL': '/var/mail/cltbld', 09:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:27 INFO - 'MOZ_NO_REMOTE': '1', 09:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:27 INFO - 'NO_EM_RESTART': '1', 09:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:27 INFO - 'PWD': '/builds/slave/test', 09:34:27 INFO - 'SHELL': '/bin/bash', 09:34:27 INFO - 'SHLVL': '1', 09:34:27 INFO - 'TERM': 'linux', 09:34:27 INFO - 'TMOUT': '86400', 09:34:27 INFO - 'USER': 'cltbld', 09:34:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:27 INFO - '_': '/tools/buildbot/bin/python'} 09:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:28 INFO - Downloading/unpacking flake8 09:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:34:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:34:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:34:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:34:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:34:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:34:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:34:30 INFO - no previously-included directories found matching 'docs/_build' 09:34:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:34:30 INFO - Running setup.py install for pep8 09:34:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:34:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:34:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:34:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:34:30 INFO - no previously-included directories found matching 'docs/_build' 09:34:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:34:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:34:30 INFO - Cleaning up... 09:34:31 INFO - Return code: 0 09:34:31 INFO - Running post-action listener: _resource_record_post_action 09:34:31 INFO - Running post-action listener: _start_resource_monitoring 09:34:31 INFO - Starting resource monitoring. 09:34:31 INFO - ##### 09:34:31 INFO - ##### Running install step. 09:34:31 INFO - ##### 09:34:31 INFO - Running pre-action listener: _resource_record_pre_action 09:34:31 INFO - Running main action method: install 09:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:31 INFO - Reading from file tmpfile_stdout 09:34:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:34:31 INFO - Reading from file tmpfile_stdout 09:34:31 INFO - Output received: 09:34:31 INFO - Usage: mozinstall [options] installer 09:34:31 INFO - Options: 09:34:31 INFO - -h, --help show this help message and exit 09:34:31 INFO - -d DEST, --destination=DEST 09:34:31 INFO - Directory to install application into. [default: 09:34:31 INFO - "/builds/slave/test"] 09:34:31 INFO - --app=APP Application being installed. [default: firefox] 09:34:31 INFO - mkdir: /builds/slave/test/build/application 09:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:34:44 INFO - Reading from file tmpfile_stdout 09:34:44 INFO - Output received: 09:34:44 INFO - /builds/slave/test/build/application/firefox/firefox 09:34:44 INFO - Running post-action listener: _resource_record_post_action 09:34:44 INFO - ##### 09:34:44 INFO - ##### Running run-tests step. 09:34:44 INFO - ##### 09:34:44 INFO - Running pre-action listener: _resource_record_pre_action 09:34:44 INFO - Running main action method: run_tests 09:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:44 INFO - Python 2.7.3 09:34:44 INFO - Return code: 0 09:34:44 INFO - grabbing minidump binary from tooltool 09:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:44 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 0x167e160>, '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 0x167f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:44 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 09:34:44 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 09:34:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:44 INFO - Return code: 0 09:34:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:34:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:34:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:34:45 INFO - Return code: 0 09:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 09:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 09:34:45 INFO - Using env: {'DISPLAY': ':0', 09:34:45 INFO - 'HOME': '/home/cltbld', 09:34:45 INFO - 'LANG': 'en_US.UTF-8', 09:34:45 INFO - 'LANGUAGE': 'en_US:en', 09:34:45 INFO - 'LOGNAME': 'cltbld', 09:34:45 INFO - 'MAIL': '/var/mail/cltbld', 09:34:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:45 INFO - 'MOZ_NO_REMOTE': '1', 09:34:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:45 INFO - 'NO_EM_RESTART': '1', 09:34:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:45 INFO - 'PWD': '/builds/slave/test', 09:34:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:45 INFO - 'SHELL': '/bin/bash', 09:34:45 INFO - 'SHLVL': '1', 09:34:45 INFO - 'TERM': 'linux', 09:34:45 INFO - 'TMOUT': '86400', 09:34:45 INFO - 'USER': 'cltbld', 09:34:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181', 09:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:45 INFO - '_': '/tools/buildbot/bin/python'} 09:34:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 09:34:45 INFO - mozversion application_buildid: 20160506065826 09:34:45 INFO - mozversion application_changeset: ca9f8dc6b0307249e1d117df3f057f2634571c9a 09:34:45 INFO - mozversion application_display_name: Firefox 09:34:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:45 INFO - mozversion application_name: Firefox 09:34:45 INFO - mozversion application_remotingname: firefox 09:34:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:34:45 INFO - mozversion application_vendor: Mozilla 09:34:45 INFO - mozversion application_version: 47.0 09:34:45 INFO - mozversion platform_buildid: 20160506065826 09:34:45 INFO - mozversion platform_changeset: ca9f8dc6b0307249e1d117df3f057f2634571c9a 09:34:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:34:45 INFO - mozversion platform_version: 47.0 09:34:45 INFO - using testdate: 1462552485 09:34:45 INFO - actual date: 1462552485 09:34:45 INFO - starting webserver on 'localhost:60451' 09:34:45 INFO - SUITE-START | Running 2 tests 09:34:45 INFO - TEST-START | dromaeo_css 09:34:45 INFO - operating with platform_type : linux_ 09:34:45 INFO - Initialising browser for dromaeo_css test... 09:34:45 INFO - TEST-INFO | started process 14210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptTxSTO/profile http://localhost:60451/getInfo.html) 09:34:49 INFO - PROCESS | 14210 | __metrics Screen width/height:1600/1200 09:34:49 INFO - PROCESS | 14210 | colorDepth:24 09:34:49 INFO - PROCESS | 14210 | Browser inner width/height: 1024/697 09:34:49 INFO - PROCESS | 14210 | __metrics 09:34:50 INFO - PROCESS | 14210 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:51 INFO - TEST-INFO | 14210: exit 0 09:34:51 INFO - Browser initialized. 09:34:51 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:51 INFO - TEST-INFO | started process 14301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptTxSTO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:02 INFO - PROCESS | 14301 | RSS: Main: 139792384 09:35:02 INFO - PROCESS | 14301 | 09:35:54 INFO - PROCESS | 14301 | 1462552553999 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] 09:38:01 INFO - PROCESS | 14301 | Cycle 1(1): loaded http://localhost:60451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60451/tests/dromaeo/cssquery-ext.html) 09:38:02 INFO - PROCESS | 14301 | RSS: Main: 255590400 09:38:02 INFO - PROCESS | 14301 | 09:41:04 INFO - PROCESS | 14301 | Cycle 1(1): loaded http://localhost:60451/tests/dromaeo/cssquery-ext.html (next: http://localhost:60451/tests/dromaeo/cssquery-jquery.html) 09:41:04 INFO - PROCESS | 14301 | RSS: Main: 226906112 09:41:04 INFO - PROCESS | 14301 | 09:44:06 INFO - PROCESS | 14301 | Cycle 1(1): loaded http://localhost:60451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60451/tests/dromaeo/cssquery-mootools.html) 09:44:07 INFO - PROCESS | 14301 | RSS: Main: 221589504 09:44:07 INFO - PROCESS | 14301 | 09:47:09 INFO - PROCESS | 14301 | Cycle 1(1): loaded http://localhost:60451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60451/tests/dromaeo/cssquery-prototype.html) 09:47:09 INFO - PROCESS | 14301 | RSS: Main: 211312640 09:47:09 INFO - PROCESS | 14301 | 09:50:12 INFO - PROCESS | 14301 | Cycle 1(1): loaded http://localhost:60451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60451/tests/dromaeo/cssquery-yui.html) 09:50:12 INFO - PROCESS | 14301 | RSS: Main: 212959232 09:50:12 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | Cycle 1(1): loaded http://localhost:60451/tests/dromaeo/cssquery-yui.html (next: http://localhost:60451/tests/dromaeo/cssquery-dojo.html) 09:53:15 INFO - PROCESS | 14301 | RSS: Main: 262340608 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | __start_tp_report 09:53:15 INFO - PROCESS | 14301 | _x_x_mozilla_page_load 09:53:15 INFO - PROCESS | 14301 | _x_x_mozilla_page_load_details 09:53:15 INFO - PROCESS | 14301 | |i|pagename|runs| 09:53:15 INFO - PROCESS | 14301 | |0;dojo.html;3249.545063691083;3291.522729204267;3305.9338813223735;3307.2393349529607;3349.782264152829;5260.368755749316;5260.86847828804;5267.631265811395;5273.789048438068;5309.097453432921;5251.081060814361;5275.551578115865;5281.841544753654;5282.049231138393;5299.788008479666;4719.07977944301;4787.066522028206;4813.927791083137;4864.610831133501;4895.388076490439;4848.248521479159;4854.87862803431;4862.513748625144;4894.388201474816;4907.75461226939;4830.2030165022725;4846.273059041137;4884.780184891671;4915.729634870081;4920.950790492103;4870.196417591093;4889.315495830587;4895.534924182197;4899.265110233458;4905.901881962359;4731.668783185179;4817.951820481785;4838.516148385169;4856.660033797635;4881.8535443936735;5091.23631455281;5109.9744501277255;5118.948810511922;5127.307813445174;5145.716985565792;5514.696691681956;5639.68981706006;5698.373178950312;5745.1669507921115;5746.051901436258;5736.827895163152;5752.8849423011725;5760.53915686744;5775.249217601727;5800.187973683687;5383.892322153535;5395.10980688186;5396.244525766396;5398.757055932492;5399.136138217867;5719.942800571941;5838.095095260242;5885.529157667376;5911.4975227105315;5928;5585.245991791137;5613.270274864323;5615.522680572197;5619.213310136584;5619.269494965628;5704.030314846486;5706.28671416073;5706.743196556165;5710.685912274865;5711.286089238845;5580.9441905580425;5662.433756624387;5697.7151142443545;5728.713564321767;5733.226014488074;5656.264685590847;5682.857928551819;5689.800856969986;5696.772129114789;5702;4285.442892423965;4372.9125417492105;4377.846775362847;4387.276099443556;4405.889852753707;3920.6471417572557;3956.4263181838473;3974.5429275633674;3978.5822488638855;4001.4998125234347;5407.351117865803;5424;5442.591805614595;5443.727813609304;5444.074507333763;5573.331200255995;5615.101583746581;5719.456651618089;5750.741216645261;5751.884962300731;5400.1899715043055;5425.348958125051;5442.292501974797;5444.292242008513;5475;4901.975490122598;4902.681325713817;4906.8773280668265;4909.189983652657;4935.3090567320605;5729.914051289234;5849.385814489502;5923.229980102559;5949.524038076944;5955.196048533479;5699.34457537372;5712.942870571241;5717.142428635571;5720.914186287126;5722.456366645162;5883.823485295448;5890.764369425175;5901.940980590139;5917.704114794329;5934.406559344031;5538.501534861882;5572.888542229214;5617.410171931889;5639.097744360883;5668.886622267449;5660.6037577370835;5664.660120392625;5664.886702266014;5668.773249069991;5672.347680016685;5539.446055394428;5540.445955404427;5541.750621221974;5546.58400619947;5550.75021624036;5442.891142177214;5446.836594902159;5480.369757477782;5502.477264659851;5532.6680399176175;5422.8373148805595;5454.754536045808;5454.863628409322;5456.317960254968;5458.563314934875;5515.117581186991;5517.44825517445;5564.944350556604;5565.55475561946;5608.495235428668;5351.812686556108;5428.7557059931605;5461.371942226695;5483.341998960151;5532.30846144232 09:53:15 INFO - PROCESS | 14301 | |1;ext.html;567.5091046245;567.9744411501482;583.5885700581091;588.5703436491361;590.492176728014;31124.99999999997;39349;39949.60050399499;40047.39928901069;40068.198636027264;44602.107957840904;45035.77482112585;45047.32429013567;45069;45143.77428112855;8853.822923541526;9002.414843035214;9053.09469053096;9056.230220431238;9057.909420905773;8925.152110549487;9020.503872287021;9031.23234525066;9045.683401080963;9288.3033772467;9269.953650231739;9355.251579873628;9360.719178424624;9364.625414983393;9365.438073715599;9215.21670657995;9226.308026897943;9245.676401325922;9270.397424167475;9301.488418137;9148.130927561871;9305.25557955362;9318.021607731227;9318.440893546409;9319.394239374487;43523.56476435227;44045;44052;44147.11705765899;44197.337039944425;3643.890683279506;3737.439384092381;4165.166966606661;4329.437173167468;4558.088382323515;34129.658703413144;34363;34702.82648586766;35095.64904350975;35354.646453535395;3989.3816458448696;4099.795010249505;4124.711270211086;4170.124273902484;4201.306784380604;247692;249058;250237;250959;251605;46116.7694161527;63487;64054.67972660107;64062;64162;43706.34440483395;43806.780966095605;43941.560584393745;43987.56012439899;44023.559764402584;16585.336586536643;16785.412510562073;16798.244079016473;16813.495595132164;16821;12978.935105324414;13043.28261945602;13044.086913916124;13049.151805132637;13050.412731427108;15459.92270038665;15536.45622403233;16039.438619648256;16057.795665325148;16066.518004459886;6042.274927008787;6062.272527296753;6119.737026157501;6153.569340110631;6376.681165941684;1069.8930106989394;1113.4488428228078;1150.0052454626855;1150.1195545283522;1169.7075731067234;29747.40505189884;29870.401129887206;30087.398252034836;30373.088807335815;30523.54214686737;1132.8583927009124;1191.7318603314186;1197.1500234833366;1198.3888217009387;1242.9937850310691;15621;15900;15919.124448155462;15937.36250549965;16325.83674163243;339207;342880;344470;345047;345992;59241.40758592445;59797.40202597919;59801.70099149476;59885.005749713215;60014.39985600176;1290.7934730443085;1447.1751101871832;1463.9341229644692;1465.7068586282787;1499.7825315329217;26715.599266010635;27445.725542744316;28887.7111228885;29060;29837.850810745807;46165;46422.767886160356;46522;46587.53412465832;46705.532944671475;201032;201610;202724;214426;215902;30442.543361850032;34971.30057398888;35143.64856351506;35182.47226291659;35738.8213058933;52196;52613;53626.73186634042;53747.46252537425;53752.73123634357;39115.804420977714;39575.2084958305;39958.800205998785;40907.59092409038;41030.58969410387;38231.617683822806;39173;39282.607173929035;39389.6061039386;40064.1987160261;39407.40888886726;39553.011174720865;42982;43484.130317394105;43543.346849796646;30985.53521697131;32959.176020598716;34358.65641343655;34876.65123348835;35074.64925350714;27034.45931081328;27338.316542086606;27574.310642233304;27833.16500504988;27873.16380508588 09:53:15 INFO - PROCESS | 14301 | |2;jquery.html;391.0809597446;391.08681229329517;394.56794809683385;396.37175077502155;405.1552513010373;15055.397784088624;15339.539813805575;18115.275388984443;18648.720269195957;18668.906655466722;17472.078071412136;18392;18682.719759203625;18693.065346732677;19263.42209733707;5737.454941780524;5825.184474173598;5884.735186916578;5913.083472061838;5919.348871624118;5687.744051517691;5821.155932389801;5857.121431785245;5858.886811505821;5880.911786323209;5779.422057794229;5786.103154011135;5789.073748200289;5807.04183809673;5824.796132135376;5594;5778.711064446782;5817.040188368914;5817.621854579439;5822.91265631018;5159.535641792219;5171.120909445366;5182.067227898977;5190.506901844319;5193.8961220775755;21526.78473215279;22008.44978875525;22980.310590682308;23002.884985574965;23037.30888073344;2319.826013049011;2359.775821296974;2455.1897873701637;2657.8139530232697;3029.3789773096464;13788.310584470737;14145.929270353583;14376.137431754023;14545.563633091024;14667.486637967726;1991.790861959488;2023.6155130525153;2035.7760646328893;2043.4176259766043;2072.2954195573425;66243.33756662419;66822.3317766821;66835.66582167106;67750.3224967749;68037.65981170112;10081.546330415149;10207.642732504326;10513.52689128991;11069.620031693225;11284.492197851116;14465.855341446451;14566.781498277534;14568.41726330935;14578.489752858599;14586;8319.750407487663;8560.957195213985;8600.1939592685;8658.696945606873;8737.475751454933;8571.185737354941;8580.742577722678;8624.741257762276;8718.86921696175;8739.038705742363;6158.969205153946;6327.873442531216;6328.525360597973;6330.936690633127;6442.130312407859;1943.5529828139324;1980.1584326661111;1988.09541658545;1990.0348331059424;2004.609101225247;1055.2771351624162;1069.9893001070045;1097.632293181793;1124.960626378073;1134.2967360236541;17956.820431795775;18284.63430731378;18304.816951830577;18479.260829566934;18672.159752811156;1012.9442880641635;1029.7322696099068;1040.8230600797883;1079.8920107989138;1085.3813326404031;10503.317284376491;10740.087092597218;10829.350238985686;10843.945780271048;10885.96583324583;435467;444681;447562;452997;460402;80329.19670803218;81054;83034.58482707548;84840;84876.57561712275;1098.4837126550508;1104.276698762312;1146.0545050333508;1148.1561052626314;1150.384544268829;16445.25996330192;16520.173991300147;16546.503604891874;16619.169041547633;17027.318907244065;36083.45874811932;37005.444918326786;37780.2443951114;37988.240235194586;38118;52279;52683.73658131685;52828.20757688561;52848.47151528436;53598.73200633972;8168.183181681784;8226.588670566329;8393.412461127662;8407.159284071544;8412.705555305534;9533.23734101284;12588.30764307972;13494.190348579117;13509.459621615026;13739;11105.561271889967;11452.656420307405;11545.36500492481;11805.452181765706;11859.822102668295;11232.494537745984;11513.88486115128;11570.421478925851;11587.713174428907;11600.94199528997;11598.884011160118;11760.176787624785;11902.285862848257;12047.156699031335;12188.390580471118;8286.958565207135;8306.70926517569;8384.580770961305;8467.576621168793;8548.401611887357;10858.2399232053;11473.36896470702;11664.825027624762;11710.94144529272;11857 09:53:15 INFO - PROCESS | 14301 | |3;mootools.html;1465.9853401465982;1565.1782814022636;1590.3956496531316;1835.5411147213197;1944.6305202011617;7606.5436073835535;7776.572288524129;7777.494462859917;7782.649780759865;7800.687972481101;7968.800779980504;8164.510129392241;8185.672573097084;8186.549739764326;8186.672533098684;2338.1232037985797;2362.3149286706835;2366.2546297916188;2367.171489978511;2367.846090004144;2426.2721183644926;2429.586970215059;2474.208253358926;2481.057198264657;2483.1060818105466;2384.1059602649007;2404.9398765030837;2408.7952524035477;2418.9758102419014;2438.5366780311774;2390.6772585700883;2423.672804171432;2426.9150579729626;2439.7926176275037;2445.596476581362;2379.1435083369975;2389.832711710181;2412.841835918769;2418.6130219165025;2430.684011078566;8135.3491720662205;8174.795630109235;8176.059753128407;8186.263236308701;8190.754277371689;5069.569086627641;5201.947980520222;5242.18746094356;5242.711650859202;5248.580113590941;3227.386796508656;3232.4666430039015;3237.093613788143;3257.1042963185077;3297.868085276586;1032.9431881246528;1883.9905800471047;1967.3606078024557;1971.2115153938396;1984.2459865251112;10821.188410869216;10893.346399216072;10914.017738403503;10940.945295273552;10946;4379.781010949503;4488.192125417391;4490.461144662661;4579.267317229227;4585.037142200175;8773.42972706772;8783.385163038525;8805.295576353876;8825.514596697114;8832.690855820016;5051.595872330205;5054.873628159252;5070.518300761496;5094.1849304111165;5102.668326558762;4031.596840315945;4146.958530414718;4653.302004699322;4716.834910778106;4782.258749893772;3607.6933460656137;3685.299793039314;3687.2625474905126;3702.185519185775;3717.052151701299;1117.5976648406568;1139.0716565998684;1139.8917102875214;1145.5508781391547;1145.7937571237092;1428.7999680044802;1434.5767998440485;1448.8116544849102;1454.6799704065088;1470.8970372074066;7478.102627684712;7543.886841697379;7565.470417070862;7587.165411804697;7588.127365353055;552.8369131106333;556.3824155187739;561.6152935239375;563.1861959468611;567.7104676614873;5738.254026976467;5761.654300741969;5778.16216648592;5807.796727114615;5863;9297.395669281475;9307;9311.534423278808;9318.86021709675;9448.196903263299;9204.95397523008;9249.722508324761;9250.259979201783;9279.072092790668;9322.720318390458;7430.888536671954;7685.538867667958;7687.577183254974;7750.689972401154;7782.999999999886;7229.710811567478;7374.483786134919;7374.483786134919;7377.225391333833;7423.665935032828;8634.352423568133;8714.564271786512;8838.513881736566;9022.684206052756;9024.458532488072;8861.911380886366;9061.818763624822;9095.408798428081;9289.581968811284;9295.488748118918;6313.08460273267;6915.101036865175;7013.438924886099;7274.090738657668;7384.889226661712;7596.772096837104;7604.12552556441;7627.656755445907;7649.04386951631;7653.119891212582;6773.661316934232;7033.472489563405;7040.859182816417;7109.573425594481;7143.071400717873;6852.280510546321;6859.588424694534;6924.930750692429;6939.271376505394;6941.895871562032;6813.318668133147;6970.302969702989;6974.965125174342;7172.641367931687;7214.098237720285;6476.093346931528;6507.967460162668;6508.381703738138;6510.7721229756735;6534.901976470262;6307.337729538516;6400.103985442135;6533.542652014314;6533.771318003847;6548.8362790930605 09:53:15 INFO - PROCESS | 14301 | |4;prototype.html;353.8319298333292;363.7980920589073;367.1262395498713;373.8859647807419;374.29445495241464;5912.083627037805;5916.230889984301;5919.644821310713;5932.9999999999945;5975.731092100855;5704.971475142618;5837.211976383187;5849.532037437006;5856.150858125569;5858.677772722499;4585.151746926821;4681.461631912322;4716.764161791897;4724.834630787923;4737.360456338385;4685.133250348679;4706.082313948781;4716.174669432853;4722.6221902247735;4725.1258517174265;4447.466304043519;4524.886877828048;4681.344611754357;4694.295855621667;4705.9058818823605;4651.558101980307;4658.208104622188;4665.766711664403;4676.0647870426055;4678.298255261704;4151.4395556599775;4154.127633197032;4159.292920203573;4159.417681524589;4162.771047592381;5685.630434021817;5691.430856914317;5699.2590963174935;5699.629524080963;5702.8289151325525;5463.426340234258;5467.753951072212;5472.616916815825;5484.341878974548;5487.64330318528;6234;6364.681765911732;6366.172397588284;6369;6390.93609063908;4610.5389461053965;4614.9077018459775;4619.16854966106;4627.907441851178;4631.675782695213;6621.569597976116;6648.235452922928;6654.767083152066;6661.233958094833;6667.666616669196;4738.47876733559;4741.525847415231;4741.786619602057;4747.596454301423;4750.287456881495;4810.63920205986;4810.7835147418455;4811.49479304675;4812.542808433193;4815.542523460265;5437.429069947678;5442.374126975369;5453.590980676465;5454.509094181463;5454.699991500505;6267.71795269214;6399.328070552618;6408.03879418091;6411.358864113551;6421.678916054178;1658.1211957662458;1685.9072750998569;1694.8474637282457;1699.226851782436;1700.413357391698;1082.107261509258;1144.742432952579;1175.5767923547517;1177.8527684039495;1183.8224266359944;6143.201383820164;6150.50795936324;6152.692365381713;6158.1686472326555;6159.014557670751;6507.926192178237;6511.15355003856;6531;6535.411812936859;6571.34286571339;6154.169187159676;6172;6172.969135154295;6181.752729890754;6187.381261873867;3508.754387192923;3520.06718219672;3549.9112522186633;3552.378333791576;3564.091156755011;6679.265280819203;6922.134733158356;6934.514583979174;6936.79189624312;6946.270641582561;6804.11546498952;6835.555688880207;6854.828629284308;6889.483288753364;6924.723011079601;6887.276835932255;6889.586624802428;6899.344562266577;6906.240313565504;6913.239543650195;6649.902766043549;6656.500762442739;6657.201135863727;6663.13379260693;6668.799936001928;6417.550771445954;6552.6723663815665;6560.442362399059;6560.803175904731;6566.9343306566325;6931.029655848286;6932.480063995321;6962.234154242928;6973.79078627642;6983.511154219156;4575.93136102952;4643.117807616542;4645.117427688729;4653.139169253699;4653.744044077608;6629.171353580802;6643.169603799525;6649.168853893263;6665.233498147775;6666.966665166643;6338.8732225354315;6488.610683359014;6492.058651495412;6504.772332968323;6505.674716264073;6473.77341793035;6485.675716214265;6492.967535162294;6493.805185844432;6505.674716264073;6336.809895703136;6344.841378965562;6353.459955903615;6361.363863613602;6361.904571431525;6503.869922601427;6514.57655252407;6525.64108973992;6527.771527996498;6528.510361722985;5971.462568368867;6035.637861728311;6222.977532301929;6339.4928405726505;6371.39471750183 09:53:15 INFO - PROCESS | 14301 | |5;yui.html;735.8675438421083;786.3512602103265;814.9283691945092;888.2272422991998;912.4069354919302;14936.850631493695;15127.924360378196;15241.085534867889;15245.771313430294;17448;16377.754333684974;16438.17809109546;16443.424480143196;16455.91772041138;16477.58806029847;783.6277768060182;955.0497255231038;974.5030034682328;976.506864033662;977.3207620703579;805.7904944714357;811.0348685064754;811.1037303779327;940.9200217981446;974.3910056214866;1019.6227395863541;1021.7139201023725;1023.3194925374617;1023.6621914768145;1023.8720159980003;1004.4726518577733;1006.4514839412537;1007.0282177698556;1007.3905287301187;1008.2135933971514;614.4439282449346;712.508369225233;733.3949491669395;736.1423941108602;736.4403053679189;14040.36818343177;14074.507392241325;14078.788818167735;14114.223717695522;14249.145051296851;13897.79153312701;14300.713985720331;14434.711305773932;14448.422063117463;14511.274436278249;11657.591984280509;12835.679108022281;12901.548445804445;12971;12996.155249908727;3940.960590394088;3942.448057271984;3962.306596345628;3980.8009599520196;3995.260876737813;49595;50640;50743.74628126873;50791.74604126956;50795.746021270024;10590.682279531626;11227.214095013434;11423.195807015147;11563.30620162793;11675.941620291844;20938.162473500888;21262.893685531784;21273.78726212718;21290.893545532173;21313.467163320733;8624.353173511887;8729.825403492021;8745.650173992968;8825.514596697243;8921.955390223007;4823.734694591761;4859.392575928009;4898.951010489921;4928.359313289321;4983.152864013126;3621.6016238213774;3635.472856435802;3641.9817900910325;3674.9081272968388;3675.044488433027;642.3736856564811;658.3745441830281;667.3726696904894;674.5514233034977;675.4798804920282;684.4011489946297;704.6652839901109;725.9310365515267;731.381982225019;739.3272122368619;8465.915340846514;8534.359923005799;8823.294136469067;8995.775105622412;9158.358914876027;585.2830282903409;592.4460629311608;630.4011189370025;677.8449888597148;690.6753825701912;4113.526944401372;4117.649999750055;4137.46212992309;4213.136307057046;4484.8430304939175;62171.68914155491;62892;62946.37053629497;63141.36858631447;63305.05042424275;56533.99999999918;56560.151597726064;57066.14400783992;57273.14090288649;57570;45077.323840142424;46589;48499.75750121227;48754.75622621935;50077.24884126814;9475.715728528156;9538.618455261712;9552.331336806357;9770.169535589555;10028.749281268027;35766.64233357633;37821;38514.80742596269;39200.80399597984;39895.2020959585;46570.301445479025;48616.5138348612;48866.267005994225;49584.75207623939;50656.240156398424;12542.686432838887;12560.246385216917;12687.873121269038;12822.422990965615;12826.294553799631;12750.68123296925;13637.931810340884;13657.317134143055;13707.109037912503;13984.230867302396;11664.183507154758;12734.299613521345;12944.546940857024;12990.675233119247;13504.257265850472;12349.93825030869;12448.128630995743;12463.5014599415;12729.745405092031;12767.744645107232;12267.325297108744;12651;12682.746345073232;12808.103432759617;12958.481660733465;10795;10846.45767711627;11068;11075.224734268524;11142.387168705474;10517.894821051692;10635.415052172204;10721.195910306602;10788.298760580537;10812.243142979916 09:53:15 INFO - PROCESS | 14301 | __end_tp_report 09:53:15 INFO - PROCESS | 14301 | __start_cc_report 09:53:15 INFO - PROCESS | 14301 | _x_x_mozilla_cycle_collect,876 09:53:15 INFO - PROCESS | 14301 | __end_cc_report 09:53:15 INFO - PROCESS | 14301 | __startTimestamp1462553595278__endTimestamp 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | ------- Summary: start ------- 09:53:15 INFO - PROCESS | 14301 | Number of tests: 6 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | [#0] dojo.html Cycles:165 Average:5293.30 Median:5458.56 stddev:568.11 (10.4%) stddev-sans-first:546.76 09:53:15 INFO - PROCESS | 14301 | Values: 3249.5 3291.5 3305.9 3307.2 3349.8 5260.4 5260.9 5267.6 5273.8 5309.1 5251.1 5275.6 5281.8 5282.0 5299.8 4719.1 4787.1 4813.9 4864.6 4895.4 4848.2 4854.9 4862.5 4894.4 4907.8 4830.2 4846.3 4884.8 4915.7 4921.0 4870.2 4889.3 4895.5 4899.3 4905.9 4731.7 4818.0 4838.5 4856.7 4881.9 5091.2 5110.0 5118.9 5127.3 5145.7 5514.7 5639.7 5698.4 5745.2 5746.1 5736.8 5752.9 5760.5 5775.2 5800.2 5383.9 5395.1 5396.2 5398.8 5399.1 5719.9 5838.1 5885.5 5911.5 5928.0 5585.2 5613.3 5615.5 5619.2 5619.3 5704.0 5706.3 5706.7 5710.7 5711.3 5580.9 5662.4 5697.7 5728.7 5733.2 5656.3 5682.9 5689.8 5696.8 5702.0 4285.4 4372.9 4377.8 4387.3 4405.9 3920.6 3956.4 3974.5 3978.6 4001.5 5407.4 5424.0 5442.6 5443.7 5444.1 5573.3 5615.1 5719.5 5750.7 5751.9 5400.2 5425.3 5442.3 5444.3 5475.0 4902.0 4902.7 4906.9 4909.2 4935.3 5729.9 5849.4 5923.2 5949.5 5955.2 5699.3 5712.9 5717.1 5720.9 5722.5 5883.8 5890.8 5901.9 5917.7 5934.4 5538.5 5572.9 5617.4 5639.1 5668.9 5660.6 5664.7 5664.9 5668.8 5672.3 5539.4 5540.4 5541.8 5546.6 5550.8 5442.9 5446.8 5480.4 5502.5 5532.7 5422.8 5454.8 5454.9 5456.3 5458.6 5515.1 5517.4 5564.9 5565.6 5608.5 5351.8 5428.8 5461.4 5483.3 5532.3 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | [#1] ext.html Cycles:180 Average:45205.32 Median:39564.11 stddev:71262.51 (180.1%) stddev-sans-first:71383.61 09:53:15 INFO - PROCESS | 14301 | Values: 567.5 568.0 583.6 588.6 590.5 31125.0 39349.0 39949.6 40047.4 40068.2 44602.1 45035.8 45047.3 45069.0 45143.8 8853.8 9002.4 9053.1 9056.2 9057.9 8925.2 9020.5 9031.2 9045.7 9288.3 9270.0 9355.3 9360.7 9364.6 9365.4 9215.2 9226.3 9245.7 9270.4 9301.5 9148.1 9305.3 9318.0 9318.4 9319.4 43523.6 44045.0 44052.0 44147.1 44197.3 3643.9 3737.4 4165.2 4329.4 4558.1 34129.7 34363.0 34702.8 35095.6 35354.6 3989.4 4099.8 4124.7 4170.1 4201.3 247692.0 249058.0 250237.0 250959.0 251605.0 46116.8 63487.0 64054.7 64062.0 64162.0 43706.3 43806.8 43941.6 43987.6 44023.6 16585.3 16785.4 16798.2 16813.5 16821.0 12978.9 13043.3 13044.1 13049.2 13050.4 15459.9 15536.5 16039.4 16057.8 16066.5 6042.3 6062.3 6119.7 6153.6 6376.7 1069.9 1113.4 1150.0 1150.1 1169.7 29747.4 29870.4 30087.4 30373.1 30523.5 1132.9 1191.7 1197.2 1198.4 1243.0 15621.0 15900.0 15919.1 15937.4 16325.8 339207.0 342880.0 344470.0 345047.0 345992.0 59241.4 59797.4 59801.7 59885.0 60014.4 1290.8 1447.2 1463.9 1465.7 1499.8 26715.6 27445.7 28887.7 29060.0 29837.9 46165.0 46422.8 46522.0 46587.5 46705.5 201032.0 201610.0 202724.0 214426.0 215902.0 30442.5 34971.3 35143.6 35182.5 35738.8 52196.0 52613.0 53626.7 53747.5 53752.7 39115.8 39575.2 39958.8 40907.6 41030.6 38231.6 39173.0 39282.6 39389.6 40064.2 39407.4 39553.0 42982.0 43484.1 43543.3 30985.5 32959.2 34358.7 34876.7 35074.6 27034.5 27338.3 27574.3 27833.2 27873.2 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | [#2] jquery.html Cycles:180 Average:26938.84 Median:22494.38 stddev:73618.65 (327.3%) stddev-sans-first:73798.18 09:53:15 INFO - PROCESS | 14301 | Values: 391.1 391.1 394.6 396.4 405.2 15055.4 15339.5 18115.3 18648.7 18668.9 17472.1 18392.0 18682.7 18693.1 19263.4 5737.5 5825.2 5884.7 5913.1 5919.3 5687.7 5821.2 5857.1 5858.9 5880.9 5779.4 5786.1 5789.1 5807.0 5824.8 5594.0 5778.7 5817.0 5817.6 5822.9 5159.5 5171.1 5182.1 5190.5 5193.9 21526.8 22008.4 22980.3 23002.9 23037.3 2319.8 2359.8 2455.2 2657.8 3029.4 13788.3 14145.9 14376.1 14545.6 14667.5 1991.8 2023.6 2035.8 2043.4 2072.3 66243.3 66822.3 66835.7 67750.3 68037.7 10081.5 10207.6 10513.5 11069.6 11284.5 14465.9 14566.8 14568.4 14578.5 14586.0 8319.8 8561.0 8600.2 8658.7 8737.5 8571.2 8580.7 8624.7 8718.9 8739.0 6159.0 6327.9 6328.5 6330.9 6442.1 1943.6 1980.2 1988.1 1990.0 2004.6 1055.3 1070.0 1097.6 1125.0 1134.3 17956.8 18284.6 18304.8 18479.3 18672.2 1012.9 1029.7 1040.8 1079.9 1085.4 10503.3 10740.1 10829.4 10843.9 10886.0 435467.0 444681.0 447562.0 452997.0 460402.0 80329.2 81054.0 83034.6 84840.0 84876.6 1098.5 1104.3 1146.1 1148.2 1150.4 16445.3 16520.2 16546.5 16619.2 17027.3 36083.5 37005.4 37780.2 37988.2 38118.0 52279.0 52683.7 52828.2 52848.5 53598.7 8168.2 8226.6 8393.4 8407.2 8412.7 9533.2 12588.3 13494.2 13509.5 13739.0 11105.6 11452.7 11545.4 11805.5 11859.8 11232.5 11513.9 11570.4 11587.7 11600.9 11598.9 11760.2 11902.3 12047.2 12188.4 8287.0 8306.7 8384.6 8467.6 8548.4 10858.2 11473.4 11664.8 11710.9 11857.0 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | [#3] mootools.html Cycles:180 Average:5612.84 Median:6310.21 stddev:2831.49 (44.9%) stddev-sans-first:2822.28 09:53:15 INFO - PROCESS | 14301 | Values: 1466.0 1565.2 1590.4 1835.5 1944.6 7606.5 7776.6 7777.5 7782.6 7800.7 7968.8 8164.5 8185.7 8186.5 8186.7 2338.1 2362.3 2366.3 2367.2 2367.8 2426.3 2429.6 2474.2 2481.1 2483.1 2384.1 2404.9 2408.8 2419.0 2438.5 2390.7 2423.7 2426.9 2439.8 2445.6 2379.1 2389.8 2412.8 2418.6 2430.7 8135.3 8174.8 8176.1 8186.3 8190.8 5069.6 5201.9 5242.2 5242.7 5248.6 3227.4 3232.5 3237.1 3257.1 3297.9 1032.9 1884.0 1967.4 1971.2 1984.2 10821.2 10893.3 10914.0 10940.9 10946.0 4379.8 4488.2 4490.5 4579.3 4585.0 8773.4 8783.4 8805.3 8825.5 8832.7 5051.6 5054.9 5070.5 5094.2 5102.7 4031.6 4147.0 4653.3 4716.8 4782.3 3607.7 3685.3 3687.3 3702.2 3717.1 1117.6 1139.1 1139.9 1145.6 1145.8 1428.8 1434.6 1448.8 1454.7 1470.9 7478.1 7543.9 7565.5 7587.2 7588.1 552.8 556.4 561.6 563.2 567.7 5738.3 5761.7 5778.2 5807.8 5863.0 9297.4 9307.0 9311.5 9318.9 9448.2 9205.0 9249.7 9250.3 9279.1 9322.7 7430.9 7685.5 7687.6 7750.7 7783.0 7229.7 7374.5 7374.5 7377.2 7423.7 8634.4 8714.6 8838.5 9022.7 9024.5 8861.9 9061.8 9095.4 9289.6 9295.5 6313.1 6915.1 7013.4 7274.1 7384.9 7596.8 7604.1 7627.7 7649.0 7653.1 6773.7 7033.5 7040.9 7109.6 7143.1 6852.3 6859.6 6924.9 6939.3 6941.9 6813.3 6970.3 6975.0 7172.6 7214.1 6476.1 6508.0 6508.4 6510.8 6534.9 6307.3 6400.1 6533.5 6533.8 6548.8 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | [#4] prototype.html Cycles:180 Average:5401.61 Median:6005.68 stddev:1597.10 (26.6%) stddev-sans-first:1555.99 09:53:15 INFO - PROCESS | 14301 | Values: 353.8 363.8 367.1 373.9 374.3 5912.1 5916.2 5919.6 5933.0 5975.7 5705.0 5837.2 5849.5 5856.2 5858.7 4585.2 4681.5 4716.8 4724.8 4737.4 4685.1 4706.1 4716.2 4722.6 4725.1 4447.5 4524.9 4681.3 4694.3 4705.9 4651.6 4658.2 4665.8 4676.1 4678.3 4151.4 4154.1 4159.3 4159.4 4162.8 5685.6 5691.4 5699.3 5699.6 5702.8 5463.4 5467.8 5472.6 5484.3 5487.6 6234.0 6364.7 6366.2 6369.0 6390.9 4610.5 4614.9 4619.2 4627.9 4631.7 6621.6 6648.2 6654.8 6661.2 6667.7 4738.5 4741.5 4741.8 4747.6 4750.3 4810.6 4810.8 4811.5 4812.5 4815.5 5437.4 5442.4 5453.6 5454.5 5454.7 6267.7 6399.3 6408.0 6411.4 6421.7 1658.1 1685.9 1694.8 1699.2 1700.4 1082.1 1144.7 1175.6 1177.9 1183.8 6143.2 6150.5 6152.7 6158.2 6159.0 6507.9 6511.2 6531.0 6535.4 6571.3 6154.2 6172.0 6173.0 6181.8 6187.4 3508.8 3520.1 3549.9 3552.4 3564.1 6679.3 6922.1 6934.5 6936.8 6946.3 6804.1 6835.6 6854.8 6889.5 6924.7 6887.3 6889.6 6899.3 6906.2 6913.2 6649.9 6656.5 6657.2 6663.1 6668.8 6417.6 6552.7 6560.4 6560.8 6566.9 6931.0 6932.5 6962.2 6973.8 6983.5 4575.9 4643.1 4645.1 4653.1 4653.7 6629.2 6643.2 6649.2 6665.2 6667.0 6338.9 6488.6 6492.1 6504.8 6505.7 6473.8 6485.7 6493.0 6493.8 6505.7 6336.8 6344.8 6353.5 6361.4 6361.9 6503.9 6514.6 6525.6 6527.8 6528.5 5971.5 6035.6 6223.0 6339.5 6371.4 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - PROCESS | 14301 | [#5] yui.html Cycles:180 Average:15228.07 Median:3941.70 stddev:17201.82 (436.4%) stddev-sans-first:17215.65 09:53:15 INFO - PROCESS | 14301 | Values: 735.9 786.4 814.9 888.2 912.4 14936.9 15127.9 15241.1 15245.8 17448.0 16377.8 16438.2 16443.4 16455.9 16477.6 783.6 955.0 974.5 976.5 977.3 805.8 811.0 811.1 940.9 974.4 1019.6 1021.7 1023.3 1023.7 1023.9 1004.5 1006.5 1007.0 1007.4 1008.2 614.4 712.5 733.4 736.1 736.4 14040.4 14074.5 14078.8 14114.2 14249.1 13897.8 14300.7 14434.7 14448.4 14511.3 11657.6 12835.7 12901.5 12971.0 12996.2 3941.0 3942.4 3962.3 3980.8 3995.3 49595.0 50640.0 50743.7 50791.7 50795.7 10590.7 11227.2 11423.2 11563.3 11675.9 20938.2 21262.9 21273.8 21290.9 21313.5 8624.4 8729.8 8745.7 8825.5 8922.0 4823.7 4859.4 4899.0 4928.4 4983.2 3621.6 3635.5 3642.0 3674.9 3675.0 642.4 658.4 667.4 674.6 675.5 684.4 704.7 725.9 731.4 739.3 8465.9 8534.4 8823.3 8995.8 9158.4 585.3 592.4 630.4 677.8 690.7 4113.5 4117.6 4137.5 4213.1 4484.8 62171.7 62892.0 62946.4 63141.4 63305.1 56534.0 56560.2 57066.1 57273.1 57570.0 45077.3 46589.0 48499.8 48754.8 50077.2 9475.7 9538.6 9552.3 9770.2 10028.7 35766.6 37821.0 38514.8 39200.8 39895.2 46570.3 48616.5 48866.3 49584.8 50656.2 12542.7 12560.2 12687.9 12822.4 12826.3 12750.7 13637.9 13657.3 13707.1 13984.2 11664.2 12734.3 12944.5 12990.7 13504.3 12349.9 12448.1 12463.5 12729.7 12767.7 12267.3 12651.0 12682.7 12808.1 12958.5 10795.0 10846.5 11068.0 11075.2 11142.4 10517.9 10635.4 10721.2 10788.3 10812.2 09:53:15 INFO - PROCESS | 14301 | -------- Summary: end -------- 09:53:15 INFO - PROCESS | 14301 | 09:53:15 INFO - TEST-INFO | 14301: exit 0 09:53:15 INFO - TEST-OK | dromaeo_css | took 1110645ms 09:53:15 INFO - TEST-START | kraken 09:53:15 INFO - operating with platform_type : linux_ 09:53:15 INFO - Initialising browser for kraken test... 09:53:16 INFO - TEST-INFO | started process 14493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHAmEkx/profile http://localhost:60451/getInfo.html) 09:53:20 INFO - PROCESS | 14493 | __metrics Screen width/height:1600/1200 09:53:20 INFO - PROCESS | 14493 | colorDepth:24 09:53:20 INFO - PROCESS | 14493 | Browser inner width/height: 1024/697 09:53:20 INFO - PROCESS | 14493 | __metrics 09:53:21 INFO - PROCESS | 14493 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:22 INFO - TEST-INFO | 14493: exit 0 09:53:22 INFO - Browser initialized. 09:53:22 INFO - Running cycle 1/1 for kraken test... 09:53:22 INFO - TEST-INFO | started process 14583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHAmEkx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:33 INFO - PROCESS | 14583 | RSS: Main: 139481088 09:53:33 INFO - PROCESS | 14583 | 09:53:36 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60451/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:37 INFO - PROCESS | 14583 | RSS: Main: 175337472 09:53:37 INFO - PROCESS | 14583 | 09:53:39 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60451/tests/kraken/driver.html?testName=audio-dft) 09:53:40 INFO - PROCESS | 14583 | RSS: Main: 171991040 09:53:40 INFO - PROCESS | 14583 | 09:53:43 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60451/tests/kraken/driver.html?testName=audio-fft) 09:53:43 INFO - PROCESS | 14583 | RSS: Main: 171155456 09:53:43 INFO - PROCESS | 14583 | 09:53:45 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60451/tests/kraken/driver.html?testName=audio-oscillator) 09:53:46 INFO - PROCESS | 14583 | RSS: Main: 172036096 09:53:46 INFO - PROCESS | 14583 | 09:53:48 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:49 INFO - PROCESS | 14583 | RSS: Main: 170041344 09:53:49 INFO - PROCESS | 14583 | 09:53:52 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60451/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:52 INFO - PROCESS | 14583 | RSS: Main: 169492480 09:53:52 INFO - PROCESS | 14583 | 09:53:55 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60451/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:56 INFO - PROCESS | 14583 | RSS: Main: 170491904 09:53:56 INFO - PROCESS | 14583 | 09:53:59 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60451/tests/kraken/driver.html?testName=json-parse-financial) 09:53:59 INFO - PROCESS | 14583 | RSS: Main: 170340352 09:53:59 INFO - PROCESS | 14583 | 09:54:01 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:54:01 INFO - PROCESS | 14583 | RSS: Main: 175742976 09:54:01 INFO - PROCESS | 14583 | 09:54:03 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:54:04 INFO - PROCESS | 14583 | RSS: Main: 172900352 09:54:04 INFO - PROCESS | 14583 | 09:54:06 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:54:06 INFO - PROCESS | 14583 | RSS: Main: 179507200 09:54:06 INFO - PROCESS | 14583 | 09:54:09 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:54:09 INFO - PROCESS | 14583 | RSS: Main: 183623680 09:54:09 INFO - PROCESS | 14583 | 09:54:12 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:54:13 INFO - PROCESS | 14583 | RSS: Main: 182751232 09:54:13 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | Cycle 1(1): loaded http://localhost:60451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60451/tests/kraken/driver.html?testName=ai-astar) 09:54:14 INFO - PROCESS | 14583 | RSS: Main: 244903936 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | __start_tp_report 09:54:14 INFO - PROCESS | 14583 | _x_x_mozilla_page_load 09:54:14 INFO - PROCESS | 14583 | _x_x_mozilla_page_load_details 09:54:14 INFO - PROCESS | 14583 | |i|pagename|runs| 09:54:14 INFO - PROCESS | 14583 | |0;ai-astar;109;112;105;111;111;111;100;110;111;112 09:54:14 INFO - PROCESS | 14583 | |1;audio-beat-detection;163;134;159;178;127;153;161;129;179;131 09:54:14 INFO - PROCESS | 14583 | |2;audio-dft;161;162;159;160;160;159;160;165;161;162 09:54:14 INFO - PROCESS | 14583 | |3;audio-fft;77;77;76;161;77;75;76;77;168;77 09:54:14 INFO - PROCESS | 14583 | |4;audio-oscillator;94;94;150;93;93;93;138;93;93;141 09:54:14 INFO - PROCESS | 14583 | |5;imaging-gaussian-blur;117;116;117;116;116;117;117;117;117;116 09:54:14 INFO - PROCESS | 14583 | |6;imaging-darkroom;145;144;146;145;145;145;146;146;145;146 09:54:14 INFO - PROCESS | 14583 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;96;95 09:54:14 INFO - PROCESS | 14583 | |8;json-parse-financial;54;55;55;54;55;55;56;56;56;55 09:54:14 INFO - PROCESS | 14583 | |9;json-stringify-tinderbox;71;72;72;72;73;72;72;71;71;72 09:54:14 INFO - PROCESS | 14583 | |10;stanford-crypto-aes;80;79;81;78;79;78;78;80;79;79 09:54:14 INFO - PROCESS | 14583 | |11;stanford-crypto-ccm;117;130;111;111;112;111;113;116;112;110 09:54:14 INFO - PROCESS | 14583 | |12;stanford-crypto-pbkdf2;146;144;143;145;142;138;144;141;135;148 09:54:14 INFO - PROCESS | 14583 | |13;stanford-crypto-sha256-iterative;68;66;67;67;66;67;67;67;65;65 09:54:14 INFO - PROCESS | 14583 | __end_tp_report 09:54:14 INFO - PROCESS | 14583 | __start_cc_report 09:54:14 INFO - PROCESS | 14583 | _x_x_mozilla_cycle_collect,1034 09:54:14 INFO - PROCESS | 14583 | __end_cc_report 09:54:14 INFO - PROCESS | 14583 | __startTimestamp1462553654911__endTimestamp 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | ------- Summary: start ------- 09:54:14 INFO - PROCESS | 14583 | Number of tests: 14 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.82 (3.4%) stddev-sans-first:4.06 09:54:14 INFO - PROCESS | 14583 | Values: 109.0 112.0 105.0 111.0 111.0 111.0 100.0 110.0 111.0 112.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:160.00 stddev:19.92 (12.5%) stddev-sans-first:20.68 09:54:14 INFO - PROCESS | 14583 | Values: 163.0 134.0 159.0 178.0 127.0 153.0 161.0 129.0 179.0 131.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 09:54:14 INFO - PROCESS | 14583 | Values: 161.0 162.0 159.0 160.0 160.0 159.0 160.0 165.0 161.0 162.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#3] audio-fft Cycles:10 Average:94.10 Median:77.00 stddev:37.15 (48.2%) stddev-sans-first:38.88 09:54:14 INFO - PROCESS | 14583 | Values: 77.0 77.0 76.0 161.0 77.0 75.0 76.0 77.0 168.0 77.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:93.00 stddev:24.20 (26.0%) stddev-sans-first:25.11 09:54:14 INFO - PROCESS | 14583 | Values: 94.0 94.0 150.0 93.0 93.0 93.0 138.0 93.0 93.0 141.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:54:14 INFO - PROCESS | 14583 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:54:14 INFO - PROCESS | 14583 | Values: 145.0 144.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:54:14 INFO - PROCESS | 14583 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 09:54:14 INFO - PROCESS | 14583 | Values: 54.0 55.0 55.0 54.0 55.0 55.0 56.0 56.0 56.0 55.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 09:54:14 INFO - PROCESS | 14583 | Values: 71.0 72.0 72.0 72.0 73.0 72.0 72.0 71.0 71.0 72.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:1.00 09:54:14 INFO - PROCESS | 14583 | Values: 80.0 79.0 81.0 78.0 79.0 78.0 78.0 80.0 79.0 79.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:112.50 stddev:5.96 (5.3%) stddev-sans-first:6.24 09:54:14 INFO - PROCESS | 14583 | Values: 117.0 130.0 111.0 111.0 112.0 111.0 113.0 116.0 112.0 110.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:144.00 stddev:3.84 (2.7%) stddev-sans-first:3.87 09:54:14 INFO - PROCESS | 14583 | Values: 146.0 144.0 143.0 145.0 142.0 138.0 144.0 141.0 135.0 148.0 09:54:14 INFO - PROCESS | 14583 | 09:54:14 INFO - PROCESS | 14583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:0.87 09:54:14 INFO - PROCESS | 14583 | Values: 68.0 66.0 67.0 67.0 66.0 67.0 67.0 67.0 65.0 65.0 09:54:14 INFO - PROCESS | 14583 | -------- Summary: end -------- 09:54:14 INFO - PROCESS | 14583 | 09:54:15 INFO - TEST-INFO | 14583: exit 0 09:54:15 INFO - TEST-OK | kraken | took 59996ms 09:54:15 INFO - SUITE-END | took 1170s 09:54:16 INFO - Completed test suite (00:19:30) 09:54:16 INFO - javascript benchmark 09:54:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3249.545063691083, 3291.522729204267, 3305.9338813223735, 3307.2393349529607, 3349.782264152829, 5260.368755749316, 5260.86847828804, 5267.631265811395, 5273.789048438068, 5309.097453432921, 5251.081060814361, 5275.551578115865, 5281.841544753654, 5282.049231138393, 5299.788008479666, 4719.07977944301, 4787.066522028206, 4813.927791083137, 4864.610831133501, 4895.388076490439, 4848.248521479159, 4854.87862803431, 4862.513748625144, 4894.388201474816, 4907.75461226939, 4830.2030165022725, 4846.273059041137, 4884.780184891671, 4915.729634870081, 4920.950790492103, 4870.196417591093, 4889.315495830587, 4895.534924182197, 4899.265110233458, 4905.901881962359, 4731.668783185179, 4817.951820481785, 4838.516148385169, 4856.660033797635, 4881.8535443936735, 5091.23631455281, 5109.9744501277255, 5118.948810511922, 5127.307813445174, 5145.716985565792, 5514.696691681956, 5639.68981706006, 5698.373178950312, 5745.1669507921115, 5746.051901436258, 5736.827895163152, 5752.8849423011725, 5760.53915686744, 5775.249217601727, 5800.187973683687, 5383.892322153535, 5395.10980688186, 5396.244525766396, 5398.757055932492, 5399.136138217867, 5719.942800571941, 5838.095095260242, 5885.529157667376, 5911.4975227105315, 5928.0, 5585.245991791137, 5613.270274864323, 5615.522680572197, 5619.213310136584, 5619.269494965628, 5704.030314846486, 5706.28671416073, 5706.743196556165, 5710.685912274865, 5711.286089238845, 5580.9441905580425, 5662.433756624387, 5697.7151142443545, 5728.713564321767, 5733.226014488074, 5656.264685590847, 5682.857928551819, 5689.800856969986, 5696.772129114789, 5702.0, 4285.442892423965, 4372.9125417492105, 4377.846775362847, 4387.276099443556, 4405.889852753707, 3920.6471417572557, 3956.4263181838473, 3974.5429275633674, 3978.5822488638855, 4001.4998125234347, 5407.351117865803, 5424.0, 5442.591805614595, 5443.727813609304, 5444.074507333763, 5573.331200255995, 5615.101583746581, 5719.456651618089, 5750.741216645261, 5751.884962300731, 5400.1899715043055, 5425.348958125051, 5442.292501974797, 5444.292242008513, 5475.0, 4901.975490122598, 4902.681325713817, 4906.8773280668265, 4909.189983652657, 4935.3090567320605, 5729.914051289234, 5849.385814489502, 5923.229980102559, 5949.524038076944, 5955.196048533479, 5699.34457537372, 5712.942870571241, 5717.142428635571, 5720.914186287126, 5722.456366645162, 5883.823485295448, 5890.764369425175, 5901.940980590139, 5917.704114794329, 5934.406559344031, 5538.501534861882, 5572.888542229214, 5617.410171931889, 5639.097744360883, 5668.886622267449, 5660.6037577370835, 5664.660120392625, 5664.886702266014, 5668.773249069991, 5672.347680016685, 5539.446055394428, 5540.445955404427, 5541.750621221974, 5546.58400619947, 5550.75021624036, 5442.891142177214, 5446.836594902159, 5480.369757477782, 5502.477264659851, 5532.6680399176175, 5422.8373148805595, 5454.754536045808, 5454.863628409322, 5456.317960254968, 5458.563314934875, 5515.117581186991, 5517.44825517445, 5564.944350556604, 5565.55475561946, 5608.495235428668, 5351.812686556108, 5428.7557059931605, 5461.371942226695, 5483.341998960151, 5532.30846144232], "unit": "score", "name": "dojo.html", "value": 5258.12738291143}, {"lowerIsBetter": false, "replicates": [567.5091046245, 567.9744411501482, 583.5885700581091, 588.5703436491361, 590.492176728014, 31124.99999999997, 39349.0, 39949.60050399499, 40047.39928901069, 40068.198636027264, 44602.107957840904, 45035.77482112585, 45047.32429013567, 45069.0, 45143.77428112855, 8853.822923541526, 9002.414843035214, 9053.09469053096, 9056.230220431238, 9057.909420905773, 8925.152110549487, 9020.503872287021, 9031.23234525066, 9045.683401080963, 9288.3033772467, 9269.953650231739, 9355.251579873628, 9360.719178424624, 9364.625414983393, 9365.438073715599, 9215.21670657995, 9226.308026897943, 9245.676401325922, 9270.397424167475, 9301.488418137, 9148.130927561871, 9305.25557955362, 9318.021607731227, 9318.440893546409, 9319.394239374487, 43523.56476435227, 44045.0, 44052.0, 44147.11705765899, 44197.337039944425, 3643.890683279506, 3737.439384092381, 4165.166966606661, 4329.437173167468, 4558.088382323515, 34129.658703413144, 34363.0, 34702.82648586766, 35095.64904350975, 35354.646453535395, 3989.3816458448696, 4099.795010249505, 4124.711270211086, 4170.124273902484, 4201.306784380604, 247692.0, 249058.0, 250237.0, 250959.0, 251605.0, 46116.7694161527, 63487.0, 64054.67972660107, 64062.0, 64162.0, 43706.34440483395, 43806.780966095605, 43941.560584393745, 43987.56012439899, 44023.559764402584, 16585.336586536643, 16785.412510562073, 16798.244079016473, 16813.495595132164, 16821.0, 12978.935105324414, 13043.28261945602, 13044.086913916124, 13049.151805132637, 13050.412731427108, 15459.92270038665, 15536.45622403233, 16039.438619648256, 16057.795665325148, 16066.518004459886, 6042.274927008787, 6062.272527296753, 6119.737026157501, 6153.569340110631, 6376.681165941684, 1069.8930106989394, 1113.4488428228078, 1150.0052454626855, 1150.1195545283522, 1169.7075731067234, 29747.40505189884, 29870.401129887206, 30087.398252034836, 30373.088807335815, 30523.54214686737, 1132.8583927009124, 1191.7318603314186, 1197.1500234833366, 1198.3888217009387, 1242.9937850310691, 15621.0, 15900.0, 15919.124448155462, 15937.36250549965, 16325.83674163243, 339207.0, 342880.0, 344470.0, 345047.0, 345992.0, 59241.40758592445, 59797.40202597919, 59801.70099149476, 59885.005749713215, 60014.39985600176, 1290.7934730443085, 1447.1751101871832, 1463.9341229644692, 1465.7068586282787, 1499.7825315329217, 26715.599266010635, 27445.725542744316, 28887.7111228885, 29060.0, 29837.850810745807, 46165.0, 46422.767886160356, 46522.0, 46587.53412465832, 46705.532944671475, 201032.0, 201610.0, 202724.0, 214426.0, 215902.0, 30442.543361850032, 34971.30057398888, 35143.64856351506, 35182.47226291659, 35738.8213058933, 52196.0, 52613.0, 53626.73186634042, 53747.46252537425, 53752.73123634357, 39115.804420977714, 39575.2084958305, 39958.800205998785, 40907.59092409038, 41030.58969410387, 38231.617683822806, 39173.0, 39282.607173929035, 39389.6061039386, 40064.1987160261, 39407.40888886726, 39553.011174720865, 42982.0, 43484.130317394105, 43543.346849796646, 30985.53521697131, 32959.176020598716, 34358.65641343655, 34876.65123348835, 35074.64925350714, 27034.45931081328, 27338.316542086606, 27574.310642233304, 27833.16500504988, 27873.16380508588], "unit": "score", "name": "ext.html", "value": 19123.488981768376}, {"lowerIsBetter": false, "replicates": [391.0809597446, 391.08681229329517, 394.56794809683385, 396.37175077502155, 405.1552513010373, 15055.397784088624, 15339.539813805575, 18115.275388984443, 18648.720269195957, 18668.906655466722, 17472.078071412136, 18392.0, 18682.719759203625, 18693.065346732677, 19263.42209733707, 5737.454941780524, 5825.184474173598, 5884.735186916578, 5913.083472061838, 5919.348871624118, 5687.744051517691, 5821.155932389801, 5857.121431785245, 5858.886811505821, 5880.911786323209, 5779.422057794229, 5786.103154011135, 5789.073748200289, 5807.04183809673, 5824.796132135376, 5594.0, 5778.711064446782, 5817.040188368914, 5817.621854579439, 5822.91265631018, 5159.535641792219, 5171.120909445366, 5182.067227898977, 5190.506901844319, 5193.8961220775755, 21526.78473215279, 22008.44978875525, 22980.310590682308, 23002.884985574965, 23037.30888073344, 2319.826013049011, 2359.775821296974, 2455.1897873701637, 2657.8139530232697, 3029.3789773096464, 13788.310584470737, 14145.929270353583, 14376.137431754023, 14545.563633091024, 14667.486637967726, 1991.790861959488, 2023.6155130525153, 2035.7760646328893, 2043.4176259766043, 2072.2954195573425, 66243.33756662419, 66822.3317766821, 66835.66582167106, 67750.3224967749, 68037.65981170112, 10081.546330415149, 10207.642732504326, 10513.52689128991, 11069.620031693225, 11284.492197851116, 14465.855341446451, 14566.781498277534, 14568.41726330935, 14578.489752858599, 14586.0, 8319.750407487663, 8560.957195213985, 8600.1939592685, 8658.696945606873, 8737.475751454933, 8571.185737354941, 8580.742577722678, 8624.741257762276, 8718.86921696175, 8739.038705742363, 6158.969205153946, 6327.873442531216, 6328.525360597973, 6330.936690633127, 6442.130312407859, 1943.5529828139324, 1980.1584326661111, 1988.09541658545, 1990.0348331059424, 2004.609101225247, 1055.2771351624162, 1069.9893001070045, 1097.632293181793, 1124.960626378073, 1134.2967360236541, 17956.820431795775, 18284.63430731378, 18304.816951830577, 18479.260829566934, 18672.159752811156, 1012.9442880641635, 1029.7322696099068, 1040.8230600797883, 1079.8920107989138, 1085.3813326404031, 10503.317284376491, 10740.087092597218, 10829.350238985686, 10843.945780271048, 10885.96583324583, 435467.0, 444681.0, 447562.0, 452997.0, 460402.0, 80329.19670803218, 81054.0, 83034.58482707548, 84840.0, 84876.57561712275, 1098.4837126550508, 1104.276698762312, 1146.0545050333508, 1148.1561052626314, 1150.384544268829, 16445.25996330192, 16520.173991300147, 16546.503604891874, 16619.169041547633, 17027.318907244065, 36083.45874811932, 37005.444918326786, 37780.2443951114, 37988.240235194586, 38118.0, 52279.0, 52683.73658131685, 52828.20757688561, 52848.47151528436, 53598.73200633972, 8168.183181681784, 8226.588670566329, 8393.412461127662, 8407.159284071544, 8412.705555305534, 9533.23734101284, 12588.30764307972, 13494.190348579117, 13509.459621615026, 13739.0, 11105.561271889967, 11452.656420307405, 11545.36500492481, 11805.452181765706, 11859.822102668295, 11232.494537745984, 11513.88486115128, 11570.421478925851, 11587.713174428907, 11600.94199528997, 11598.884011160118, 11760.176787624785, 11902.285862848257, 12047.156699031335, 12188.390580471118, 8286.958565207135, 8306.70926517569, 8384.580770961305, 8467.576621168793, 8548.401611887357, 10858.2399232053, 11473.36896470702, 11664.825027624762, 11710.94144529272, 11857.0], "unit": "score", "name": "jquery.html", "value": 9250.140220192705}, {"lowerIsBetter": false, "replicates": [1465.9853401465982, 1565.1782814022636, 1590.3956496531316, 1835.5411147213197, 1944.6305202011617, 7606.5436073835535, 7776.572288524129, 7777.494462859917, 7782.649780759865, 7800.687972481101, 7968.800779980504, 8164.510129392241, 8185.672573097084, 8186.549739764326, 8186.672533098684, 2338.1232037985797, 2362.3149286706835, 2366.2546297916188, 2367.171489978511, 2367.846090004144, 2426.2721183644926, 2429.586970215059, 2474.208253358926, 2481.057198264657, 2483.1060818105466, 2384.1059602649007, 2404.9398765030837, 2408.7952524035477, 2418.9758102419014, 2438.5366780311774, 2390.6772585700883, 2423.672804171432, 2426.9150579729626, 2439.7926176275037, 2445.596476581362, 2379.1435083369975, 2389.832711710181, 2412.841835918769, 2418.6130219165025, 2430.684011078566, 8135.3491720662205, 8174.795630109235, 8176.059753128407, 8186.263236308701, 8190.754277371689, 5069.569086627641, 5201.947980520222, 5242.18746094356, 5242.711650859202, 5248.580113590941, 3227.386796508656, 3232.4666430039015, 3237.093613788143, 3257.1042963185077, 3297.868085276586, 1032.9431881246528, 1883.9905800471047, 1967.3606078024557, 1971.2115153938396, 1984.2459865251112, 10821.188410869216, 10893.346399216072, 10914.017738403503, 10940.945295273552, 10946.0, 4379.781010949503, 4488.192125417391, 4490.461144662661, 4579.267317229227, 4585.037142200175, 8773.42972706772, 8783.385163038525, 8805.295576353876, 8825.514596697114, 8832.690855820016, 5051.595872330205, 5054.873628159252, 5070.518300761496, 5094.1849304111165, 5102.668326558762, 4031.596840315945, 4146.958530414718, 4653.302004699322, 4716.834910778106, 4782.258749893772, 3607.6933460656137, 3685.299793039314, 3687.2625474905126, 3702.185519185775, 3717.052151701299, 1117.5976648406568, 1139.0716565998684, 1139.8917102875214, 1145.5508781391547, 1145.7937571237092, 1428.7999680044802, 1434.5767998440485, 1448.8116544849102, 1454.6799704065088, 1470.8970372074066, 7478.102627684712, 7543.886841697379, 7565.470417070862, 7587.165411804697, 7588.127365353055, 552.8369131106333, 556.3824155187739, 561.6152935239375, 563.1861959468611, 567.7104676614873, 5738.254026976467, 5761.654300741969, 5778.16216648592, 5807.796727114615, 5863.0, 9297.395669281475, 9307.0, 9311.534423278808, 9318.86021709675, 9448.196903263299, 9204.95397523008, 9249.722508324761, 9250.259979201783, 9279.072092790668, 9322.720318390458, 7430.888536671954, 7685.538867667958, 7687.577183254974, 7750.689972401154, 7782.999999999886, 7229.710811567478, 7374.483786134919, 7374.483786134919, 7377.225391333833, 7423.665935032828, 8634.352423568133, 8714.564271786512, 8838.513881736566, 9022.684206052756, 9024.458532488072, 8861.911380886366, 9061.818763624822, 9095.408798428081, 9289.581968811284, 9295.488748118918, 6313.08460273267, 6915.101036865175, 7013.438924886099, 7274.090738657668, 7384.889226661712, 7596.772096837104, 7604.12552556441, 7627.656755445907, 7649.04386951631, 7653.119891212582, 6773.661316934232, 7033.472489563405, 7040.859182816417, 7109.573425594481, 7143.071400717873, 6852.280510546321, 6859.588424694534, 6924.930750692429, 6939.271376505394, 6941.895871562032, 6813.318668133147, 6970.302969702989, 6974.965125174342, 7172.641367931687, 7214.098237720285, 6476.093346931528, 6507.967460162668, 6508.381703738138, 6510.7721229756735, 6534.901976470262, 6307.337729538516, 6400.103985442135, 6533.542652014314, 6533.771318003847, 6548.8362790930605], "unit": "score", "name": "mootools.html", "value": 4631.690091863062}, {"lowerIsBetter": false, "replicates": [353.8319298333292, 363.7980920589073, 367.1262395498713, 373.8859647807419, 374.29445495241464, 5912.083627037805, 5916.230889984301, 5919.644821310713, 5932.9999999999945, 5975.731092100855, 5704.971475142618, 5837.211976383187, 5849.532037437006, 5856.150858125569, 5858.677772722499, 4585.151746926821, 4681.461631912322, 4716.764161791897, 4724.834630787923, 4737.360456338385, 4685.133250348679, 4706.082313948781, 4716.174669432853, 4722.6221902247735, 4725.1258517174265, 4447.466304043519, 4524.886877828048, 4681.344611754357, 4694.295855621667, 4705.9058818823605, 4651.558101980307, 4658.208104622188, 4665.766711664403, 4676.0647870426055, 4678.298255261704, 4151.4395556599775, 4154.127633197032, 4159.292920203573, 4159.417681524589, 4162.771047592381, 5685.630434021817, 5691.430856914317, 5699.2590963174935, 5699.629524080963, 5702.8289151325525, 5463.426340234258, 5467.753951072212, 5472.616916815825, 5484.341878974548, 5487.64330318528, 6234.0, 6364.681765911732, 6366.172397588284, 6369.0, 6390.93609063908, 4610.5389461053965, 4614.9077018459775, 4619.16854966106, 4627.907441851178, 4631.675782695213, 6621.569597976116, 6648.235452922928, 6654.767083152066, 6661.233958094833, 6667.666616669196, 4738.47876733559, 4741.525847415231, 4741.786619602057, 4747.596454301423, 4750.287456881495, 4810.63920205986, 4810.7835147418455, 4811.49479304675, 4812.542808433193, 4815.542523460265, 5437.429069947678, 5442.374126975369, 5453.590980676465, 5454.509094181463, 5454.699991500505, 6267.71795269214, 6399.328070552618, 6408.03879418091, 6411.358864113551, 6421.678916054178, 1658.1211957662458, 1685.9072750998569, 1694.8474637282457, 1699.226851782436, 1700.413357391698, 1082.107261509258, 1144.742432952579, 1175.5767923547517, 1177.8527684039495, 1183.8224266359944, 6143.201383820164, 6150.50795936324, 6152.692365381713, 6158.1686472326555, 6159.014557670751, 6507.926192178237, 6511.15355003856, 6531.0, 6535.411812936859, 6571.34286571339, 6154.169187159676, 6172.0, 6172.969135154295, 6181.752729890754, 6187.381261873867, 3508.754387192923, 3520.06718219672, 3549.9112522186633, 3552.378333791576, 3564.091156755011, 6679.265280819203, 6922.134733158356, 6934.514583979174, 6936.79189624312, 6946.270641582561, 6804.11546498952, 6835.555688880207, 6854.828629284308, 6889.483288753364, 6924.723011079601, 6887.276835932255, 6889.586624802428, 6899.344562266577, 6906.240313565504, 6913.239543650195, 6649.902766043549, 6656.500762442739, 6657.201135863727, 6663.13379260693, 6668.799936001928, 6417.550771445954, 6552.6723663815665, 6560.442362399059, 6560.803175904731, 6566.9343306566325, 6931.029655848286, 6932.480063995321, 6962.234154242928, 6973.79078627642, 6983.511154219156, 4575.93136102952, 4643.117807616542, 4645.117427688729, 4653.139169253699, 4653.744044077608, 6629.171353580802, 6643.169603799525, 6649.168853893263, 6665.233498147775, 6666.966665166643, 6338.8732225354315, 6488.610683359014, 6492.058651495412, 6504.772332968323, 6505.674716264073, 6473.77341793035, 6485.675716214265, 6492.967535162294, 6493.805185844432, 6505.674716264073, 6336.809895703136, 6344.841378965562, 6353.459955903615, 6361.363863613602, 6361.904571431525, 6503.869922601427, 6514.57655252407, 6525.64108973992, 6527.771527996498, 6528.510361722985, 5971.462568368867, 6035.637861728311, 6222.977532301929, 6339.4928405726505, 6371.39471750183], "unit": "score", "name": "prototype.html", "value": 4894.604685587715}, {"lowerIsBetter": false, "replicates": [735.8675438421083, 786.3512602103265, 814.9283691945092, 888.2272422991998, 912.4069354919302, 14936.850631493695, 15127.924360378196, 15241.085534867889, 15245.771313430294, 17448.0, 16377.754333684974, 16438.17809109546, 16443.424480143196, 16455.91772041138, 16477.58806029847, 783.6277768060182, 955.0497255231038, 974.5030034682328, 976.506864033662, 977.3207620703579, 805.7904944714357, 811.0348685064754, 811.1037303779327, 940.9200217981446, 974.3910056214866, 1019.6227395863541, 1021.7139201023725, 1023.3194925374617, 1023.6621914768145, 1023.8720159980003, 1004.4726518577733, 1006.4514839412537, 1007.0282177698556, 1007.3905287301187, 1008.2135933971514, 614.4439282449346, 712.508369225233, 733.3949491669395, 736.1423941108602, 736.4403053679189, 14040.36818343177, 14074.507392241325, 14078.788818167735, 14114.223717695522, 14249.145051296851, 13897.79153312701, 14300.713985720331, 14434.711305773932, 14448.422063117463, 14511.274436278249, 11657.591984280509, 12835.679108022281, 12901.548445804445, 12971.0, 12996.155249908727, 3940.960590394088, 3942.448057271984, 3962.306596345628, 3980.8009599520196, 3995.260876737813, 49595.0, 50640.0, 50743.74628126873, 50791.74604126956, 50795.746021270024, 10590.682279531626, 11227.214095013434, 11423.195807015147, 11563.30620162793, 11675.941620291844, 20938.162473500888, 21262.893685531784, 21273.78726212718, 21290.893545532173, 21313.467163320733, 8624.353173511887, 8729.825403492021, 8745.650173992968, 8825.514596697243, 8921.955390223007, 4823.734694591761, 4859.392575928009, 4898.951010489921, 4928.359313289321, 4983.152864013126, 3621.6016238213774, 3635.472856435802, 3641.9817900910325, 3674.9081272968388, 3675.044488433027, 642.3736856564811, 658.3745441830281, 667.3726696904894, 674.5514233034977, 675.4798804920282, 684.4011489946297, 704.6652839901109, 725.9310365515267, 731.381982225019, 739.3272122368619, 8465.915340846514, 8534.359923005799, 8823.294136469067, 8995.775105622412, 9158.358914876027, 585.2830282903409, 592.4460629311608, 630.4011189370025, 677.8449888597148, 690.6753825701912, 4113.526944401372, 4117.649999750055, 4137.46212992309, 4213.136307057046, 4484.8430304939175, 62171.68914155491, 62892.0, 62946.37053629497, 63141.36858631447, 63305.05042424275, 56533.99999999918, 56560.151597726064, 57066.14400783992, 57273.14090288649, 57570.0, 45077.323840142424, 46589.0, 48499.75750121227, 48754.75622621935, 50077.24884126814, 9475.715728528156, 9538.618455261712, 9552.331336806357, 9770.169535589555, 10028.749281268027, 35766.64233357633, 37821.0, 38514.80742596269, 39200.80399597984, 39895.2020959585, 46570.301445479025, 48616.5138348612, 48866.267005994225, 49584.75207623939, 50656.240156398424, 12542.686432838887, 12560.246385216917, 12687.873121269038, 12822.422990965615, 12826.294553799631, 12750.68123296925, 13637.931810340884, 13657.317134143055, 13707.109037912503, 13984.230867302396, 11664.183507154758, 12734.299613521345, 12944.546940857024, 12990.675233119247, 13504.257265850472, 12349.93825030869, 12448.128630995743, 12463.5014599415, 12729.745405092031, 12767.744645107232, 12267.325297108744, 12651.0, 12682.746345073232, 12808.103432759617, 12958.481660733465, 10795.0, 10846.45767711627, 11068.0, 11075.224734268524, 11142.387168705474, 10517.894821051692, 10635.415052172204, 10721.195910306602, 10788.298760580537, 10812.243142979916], "unit": "score", "name": "yui.html", "value": 7052.01500026777}], "name": "dromaeo_css", "value": 7278.790230737822}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 111.0, 111.0, 111.0, 100.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [163.0, 134.0, 159.0, 178.0, 127.0, 153.0, 161.0, 129.0, 179.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 160.0, 160.0, 159.0, 160.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 76.0, 161.0, 77.0, 75.0, 76.0, 77.0, 168.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 150.0, 93.0, 93.0, 93.0, 138.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 72.0, 73.0, 72.0, 72.0, 71.0, 71.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.8}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 81.0, 78.0, 79.0, 78.0, 78.0, 80.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [117.0, 130.0, 111.0, 111.0, 112.0, 111.0, 113.0, 116.0, 112.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.3}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 143.0, 145.0, 142.0, 138.0, 144.0, 141.0, 135.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1510.3999999999996}]} 09:54:16 INFO - Return code: 0 09:54:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:54:16 INFO - # TBPL SUCCESS # 09:54:16 INFO - Running post-action listener: _resource_record_post_action 09:54:16 INFO - Running post-run listener: _resource_record_post_run 09:54:17 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 458604544; Read time: 0; Write time: 398692 09:54:17 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237395968; Read time: 0; Write time: 254716 09:54:17 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 220827648; Read time: 0; Write time: 143948 09:54:17 INFO - Running post-run listener: _upload_blobber_files 09:54:17 INFO - Blob upload gear active. 09:54:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:54:17 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 09:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:54:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:54:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:54:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:54:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:18 INFO - (blobuploader) - INFO - Done attempting. 09:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:19 INFO - (blobuploader) - INFO - Done attempting. 09:54:19 INFO - (blobuploader) - INFO - Iteration through files over. 09:54:19 INFO - Return code: 0 09:54:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:54:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:54:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c8f710a120fb637c7e28a03b6bc777c354ba0d1e12e2d2710038aa7b980f0614e48edfec28303b0d577c2c5914dbe01f4ec91faf161d0e3eb73467065e88a90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe27b09d2ae681a0cc8aa25701ebcbeb68e787a925f4a4eaaac9f2fd733b3779deee6efed81bade3c05d741d196837f2ae0b67f38417b59ee4ad5222650017b"} 09:54:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:54:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:54:19 INFO - Contents: 09:54:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c8f710a120fb637c7e28a03b6bc777c354ba0d1e12e2d2710038aa7b980f0614e48edfec28303b0d577c2c5914dbe01f4ec91faf161d0e3eb73467065e88a90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe27b09d2ae681a0cc8aa25701ebcbeb68e787a925f4a4eaaac9f2fd733b3779deee6efed81bade3c05d741d196837f2ae0b67f38417b59ee4ad5222650017b"} 09:54:19 INFO - Running post-run listener: copy_logs_to_upload_dir 09:54:19 INFO - Copying logs to upload dir... 09:54:19 INFO - mkdir: /builds/slave/test/build/upload/logs 09:54:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.190686 ========= master_lag: 1.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-06 09:54:20.463060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:54:20.469879) ========= 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=32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c8f710a120fb637c7e28a03b6bc777c354ba0d1e12e2d2710038aa7b980f0614e48edfec28303b0d577c2c5914dbe01f4ec91faf161d0e3eb73467065e88a90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe27b09d2ae681a0cc8aa25701ebcbeb68e787a925f4a4eaaac9f2fd733b3779deee6efed81bade3c05d741d196837f2ae0b67f38417b59ee4ad5222650017b"} build_url:https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/C1dp0KOYTsyb6IT6fbX9vA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c8f710a120fb637c7e28a03b6bc777c354ba0d1e12e2d2710038aa7b980f0614e48edfec28303b0d577c2c5914dbe01f4ec91faf161d0e3eb73467065e88a90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe27b09d2ae681a0cc8aa25701ebcbeb68e787a925f4a4eaaac9f2fd733b3779deee6efed81bade3c05d741d196837f2ae0b67f38417b59ee4ad5222650017b"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:54:20.547325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:54:20.547699) ========= 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=32c5991c409366f7fec8a718000001d2-1462552431.703370-1203917181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.41 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:54:20.961135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:54:20.964476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:54:20.964805) ========= ========= Total master_lag: 2.06 =========