builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1467103889.98 results: success (0) buildid: 20160627144420 builduid: 4360f4d245a549be90444bafc60905d0 revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:29.981813) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:29.982254) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:29.982641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.028520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.028849) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 01:51:30-- 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% 165M=0s 2016-06-28 01:51:30 (165 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.392613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.440230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.440559) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020166 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.491840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.494254) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --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 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --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=2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 01:51:30,984 truncating revision to first 12 chars 2016-06-28 01:51:30,984 Setting DEBUG logging. 2016-06-28 01:51:30,985 attempt 1/10 2016-06-28 01:51:30,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/676a32cdd41f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 01:51:31,298 unpacking tar archive at: mozilla-beta-676a32cdd41f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637472 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.146521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.146883) ========= script_repo_revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.147438) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.147746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.158862) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-28 01:51:31.159216) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:51:31 INFO - MultiFileLogger online at 20160628 01:51:31 in /builds/slave/test 01:51:31 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 01:51:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:51:31 INFO - {'append_to_log': False, 01:51:31 INFO - 'base_work_dir': '/builds/slave/test', 01:51:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:51:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:51:31 INFO - 'branch': 'Mozilla-Beta', 01:51:31 INFO - 'buildbot_json_path': 'buildprops.json', 01:51:31 INFO - 'config_files': ('talos/linux_config.py',), 01:51:31 INFO - 'default_actions': ('clobber', 01:51:31 INFO - 'read-buildbot-config', 01:51:31 INFO - 'download-and-extract', 01:51:31 INFO - 'populate-webroot', 01:51:31 INFO - 'create-virtualenv', 01:51:31 INFO - 'install', 01:51:31 INFO - 'run-tests'), 01:51:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:51:31 INFO - 'download_minidump_stackwalk': True, 01:51:31 INFO - 'download_symbols': 'ondemand', 01:51:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:51:31 INFO - 'tooltool.py': '/tools/tooltool.py', 01:51:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:51:31 INFO - '/tools/misc-python/virtualenv.py')}, 01:51:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:51:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:51:31 INFO - 'installer_path': 'installer.exe', 01:51:31 INFO - 'log_level': 'info', 01:51:31 INFO - 'log_name': 'talos', 01:51:31 INFO - 'log_to_console': True, 01:51:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:51:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:51:31 INFO - 'opt_config_files': (), 01:51:31 INFO - 'pip_index': False, 01:51:31 INFO - 'sps_profile': False, 01:51:31 INFO - 'sps_profile_interval': 0, 01:51:31 INFO - 'suite': 'dromaeojs', 01:51:31 INFO - 'system_bits': '32', 01:51:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:51:31 INFO - 'title': 'talos-linux64-ix-012', 01:51:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:51:31 INFO - 'use_talos_json': True, 01:51:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:51:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:51:31 INFO - 'work_dir': 'build'} 01:51:31 INFO - ##### 01:51:31 INFO - ##### Running clobber step. 01:51:31 INFO - ##### 01:51:31 INFO - Running pre-action listener: _resource_record_pre_action 01:51:31 INFO - Running main action method: clobber 01:51:31 INFO - rmtree: /builds/slave/test/build 01:51:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:51:32 INFO - Running post-action listener: _resource_record_post_action 01:51:32 INFO - ##### 01:51:32 INFO - ##### Running read-buildbot-config step. 01:51:32 INFO - ##### 01:51:32 INFO - Running pre-action listener: _resource_record_pre_action 01:51:32 INFO - Running main action method: read_buildbot_config 01:51:32 INFO - Using buildbot properties: 01:51:32 INFO - { 01:51:32 INFO - "project": "", 01:51:32 INFO - "product": "firefox", 01:51:32 INFO - "script_repo_revision": "production", 01:51:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 01:51:32 INFO - "repository": "", 01:51:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 01:51:32 INFO - "buildid": "20160627144420", 01:51:32 INFO - "pgo_build": "True", 01:51:32 INFO - "basedir": "/builds/slave/test", 01:51:32 INFO - "buildnumber": 282, 01:51:32 INFO - "slavename": "talos-linux64-ix-012", 01:51:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:51:32 INFO - "platform": "ubuntu64_hw", 01:51:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:51:32 INFO - "branch": "mozilla-beta", 01:51:32 INFO - "repo_path": "releases/mozilla-beta", 01:51:32 INFO - "revision": "676a32cdd41fd372f4c6df3a4954939f73a6ef02", 01:51:32 INFO - "stage_platform": "linux64-pgo", 01:51:32 INFO - "builduid": "4360f4d245a549be90444bafc60905d0", 01:51:32 INFO - "slavebuilddir": "test" 01:51:32 INFO - } 01:51:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 01:51:32 INFO - Running post-action listener: _resource_record_post_action 01:51:32 INFO - ##### 01:51:32 INFO - ##### Running download-and-extract step. 01:51:32 INFO - ##### 01:51:32 INFO - Running pre-action listener: _resource_record_pre_action 01:51:32 INFO - Running main action method: download_and_extract 01:51:32 INFO - mkdir: /builds/slave/test/build/tests 01:51:32 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')]} 01:51:32 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:51:33 INFO - Downloaded 1327 bytes. 01:51:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:33 INFO - Using the following test package requirements: 01:51:33 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:51:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:51:33 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 01:51:33 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'jsshell-linux-x86_64.zip'], 01:51:33 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:51:33 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:51:33 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 01:51:33 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 01:51:33 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:51:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:33 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:51:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:33 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:51:34 INFO - Downloaded 24236181 bytes. 01:51:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:51:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:51:35 INFO - Return code: 0 01:51:35 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:35 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:51:36 INFO - Downloaded 24236181 bytes. 01:51:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:51:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:51:38 INFO - Return code: 0 01:51:38 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')]} 01:51:38 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:51:39 INFO - Downloaded 10840145 bytes. 01:51:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:51:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:51:39 INFO - Return code: 0 01:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:39 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:51:40 INFO - Downloaded 56013298 bytes. 01:51:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:40 INFO - mkdir: /builds/slave/test/properties 01:51:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:51:40 INFO - Writing to file /builds/slave/test/properties/build_url 01:51:40 INFO - Contents: 01:51:40 INFO - build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:41 INFO - Running post-action listener: _resource_record_post_action 01:51:41 INFO - Running post-action listener: set_extra_try_arguments 01:51:41 INFO - ##### 01:51:41 INFO - ##### Running populate-webroot step. 01:51:41 INFO - ##### 01:51:41 INFO - Running pre-action listener: _resource_record_pre_action 01:51:41 INFO - Running main action method: populate_webroot 01:51:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:51:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:51:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:51:41 INFO - '--tppagecycles', 01:51:41 INFO - '7'], 01:51:41 INFO - 'tests': ['tsvgm']}}, 01:51:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:51:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:51:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:51:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:51:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['damp', 'tps']}, 01:51:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'tests': ['damp', 'tps']}, 01:51:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['dromaeo_dom']}, 01:51:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:51:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['a11yr', 01:51:41 INFO - 'ts_paint', 01:51:41 INFO - 'tpaint', 01:51:41 INFO - 'sessionrestore', 01:51:41 INFO - 'sessionrestore_no_auto_restore', 01:51:41 INFO - 'tabpaint']}, 01:51:41 INFO - 'other-e10s': {'tests': ['a11yr', 01:51:41 INFO - 'ts_paint', 01:51:41 INFO - 'tpaint', 01:51:41 INFO - 'sessionrestore', 01:51:41 INFO - 'sessionrestore_no_auto_restore', 01:51:41 INFO - 'tabpaint']}, 01:51:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:51:41 INFO - 'ts_paint', 01:51:41 INFO - 'tpaint', 01:51:41 INFO - 'sessionrestore', 01:51:41 INFO - 'sessionrestore_no_auto_restore', 01:51:41 INFO - 'tabpaint']}, 01:51:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:51:41 INFO - 'ts_paint', 01:51:41 INFO - 'tpaint', 01:51:41 INFO - 'sessionrestore', 01:51:41 INFO - 'sessionrestore_no_auto_restore', 01:51:41 INFO - 'tabpaint']}, 01:51:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['a11yr', 01:51:41 INFO - 'ts_paint', 01:51:41 INFO - 'tpaint', 01:51:41 INFO - 'sessionrestore', 01:51:41 INFO - 'sessionrestore_no_auto_restore', 01:51:41 INFO - 'tabpaint']}, 01:51:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['a11yr', 01:51:41 INFO - 'ts_paint', 01:51:41 INFO - 'tpaint', 01:51:41 INFO - 'sessionrestore', 01:51:41 INFO - 'sessionrestore_no_auto_restore', 01:51:41 INFO - 'tabpaint']}, 01:51:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['tsvgx', 01:51:41 INFO - 'tsvgr_opacity', 01:51:41 INFO - 'tart', 01:51:41 INFO - 'tscrollx', 01:51:41 INFO - 'cart']}, 01:51:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:51:41 INFO - 'tsvgr_opacity', 01:51:41 INFO - 'tart', 01:51:41 INFO - 'tscrollx', 01:51:41 INFO - 'cart']}, 01:51:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'talos_options': ['--disable-e10s'], 01:51:41 INFO - 'tests': ['tp5o']}, 01:51:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'tests': ['tp5o']}, 01:51:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'talos_options': ['--disable-e10s', 01:51:41 INFO - '--xperf_path', 01:51:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:41 INFO - 'tests': ['tp5n']}, 01:51:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:41 INFO - 'talos_options': ['--xperf_path', 01:51:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:41 INFO - 'tests': ['tp5n']}}, 01:51:41 INFO - 'talos.zip': {'path': '', 01:51:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:51:41 INFO - Running post-action listener: _resource_record_post_action 01:51:41 INFO - ##### 01:51:41 INFO - ##### Running create-virtualenv step. 01:51:41 INFO - ##### 01:51:41 INFO - Running pre-action listener: _resource_record_pre_action 01:51:41 INFO - Running main action method: create_virtualenv 01:51:41 INFO - Creating virtualenv /builds/slave/test/build/venv 01:51:41 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 01:51:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:51:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:51:41 INFO - Using real prefix '/usr' 01:51:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:51:42 INFO - Installing distribute.............................................................................................................................................................................................done. 01:51:44 INFO - Installing pip.................done. 01:51:44 INFO - Return code: 0 01:51:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:51: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')]} 01:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51: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')]} 01:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:44 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:51:44 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 01:51:44 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 01:51:44 INFO - Using env: {'DISPLAY': ':0', 01:51:44 INFO - 'HOME': '/home/cltbld', 01:51:44 INFO - 'LANG': 'en_US.UTF-8', 01:51:44 INFO - 'LANGUAGE': 'en_US:en', 01:51:44 INFO - 'LOGNAME': 'cltbld', 01:51:44 INFO - 'MAIL': '/var/mail/cltbld', 01:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:44 INFO - 'MOZ_NO_REMOTE': '1', 01:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:44 INFO - 'NO_EM_RESTART': '1', 01:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:44 INFO - 'PWD': '/builds/slave/test', 01:51:44 INFO - 'SHELL': '/bin/bash', 01:51:44 INFO - 'SHLVL': '1', 01:51:44 INFO - 'TERM': 'linux', 01:51:44 INFO - 'TMOUT': '86400', 01:51:44 INFO - 'USER': 'cltbld', 01:51:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:44 INFO - '_': '/tools/buildbot/bin/python'} 01:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:44 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 01:51:44 INFO - Cleaning up... 01:51:44 INFO - Return code: 0 01:51:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:51: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')]} 01:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51: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')]} 01:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:44 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:51:44 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 01:51:44 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 01:51:44 INFO - Using env: {'DISPLAY': ':0', 01:51:44 INFO - 'HOME': '/home/cltbld', 01:51:44 INFO - 'LANG': 'en_US.UTF-8', 01:51:44 INFO - 'LANGUAGE': 'en_US:en', 01:51:44 INFO - 'LOGNAME': 'cltbld', 01:51:44 INFO - 'MAIL': '/var/mail/cltbld', 01:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:44 INFO - 'MOZ_NO_REMOTE': '1', 01:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:44 INFO - 'NO_EM_RESTART': '1', 01:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:44 INFO - 'PWD': '/builds/slave/test', 01:51:44 INFO - 'SHELL': '/bin/bash', 01:51:44 INFO - 'SHLVL': '1', 01:51:44 INFO - 'TERM': 'linux', 01:51:44 INFO - 'TMOUT': '86400', 01:51:44 INFO - 'USER': 'cltbld', 01:51:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:44 INFO - '_': '/tools/buildbot/bin/python'} 01:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:44 INFO - Downloading/unpacking psutil>=0.7.1 01:51:44 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 01:51:44 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 01:51:44 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 01:51:44 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 01:51:44 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 01:51:44 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 01:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:46 INFO - Installing collected packages: psutil 01:51:46 INFO - Running setup.py install for psutil 01:51:46 INFO - building 'psutil._psutil_linux' extension 01:51:46 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 01:51:46 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 01:51:47 INFO - building 'psutil._psutil_posix' extension 01:51:47 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 01:51:47 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 01:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:47 INFO - Successfully installed psutil 01:51:47 INFO - Cleaning up... 01:51:47 INFO - Return code: 0 01:51:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:51:47 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')]} 01:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:47 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')]} 01:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:47 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:51:47 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 01:51:47 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 01:51:47 INFO - Using env: {'DISPLAY': ':0', 01:51:47 INFO - 'HOME': '/home/cltbld', 01:51:47 INFO - 'LANG': 'en_US.UTF-8', 01:51:47 INFO - 'LANGUAGE': 'en_US:en', 01:51:47 INFO - 'LOGNAME': 'cltbld', 01:51:47 INFO - 'MAIL': '/var/mail/cltbld', 01:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:47 INFO - 'MOZ_NO_REMOTE': '1', 01:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:47 INFO - 'NO_EM_RESTART': '1', 01:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:47 INFO - 'PWD': '/builds/slave/test', 01:51:47 INFO - 'SHELL': '/bin/bash', 01:51:47 INFO - 'SHLVL': '1', 01:51:47 INFO - 'TERM': 'linux', 01:51:47 INFO - 'TMOUT': '86400', 01:51:47 INFO - 'USER': 'cltbld', 01:51:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:47 INFO - '_': '/tools/buildbot/bin/python'} 01:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:51:47 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 01:51:47 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 01:51:47 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 01:51:47 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 01:51:47 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 01:51:47 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 01:51:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:51:49 INFO - Installing collected packages: mozsystemmonitor 01:51:49 INFO - Running setup.py install for mozsystemmonitor 01:51:49 INFO - Successfully installed mozsystemmonitor 01:51:49 INFO - Cleaning up... 01:51:49 INFO - Return code: 0 01:51:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:51:49 INFO - Using env: {'DISPLAY': ':0', 01:51:49 INFO - 'HOME': '/home/cltbld', 01:51:49 INFO - 'LANG': 'en_US.UTF-8', 01:51:49 INFO - 'LANGUAGE': 'en_US:en', 01:51:49 INFO - 'LOGNAME': 'cltbld', 01:51:49 INFO - 'MAIL': '/var/mail/cltbld', 01:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:49 INFO - 'MOZ_NO_REMOTE': '1', 01:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:49 INFO - 'NO_EM_RESTART': '1', 01:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:49 INFO - 'PWD': '/builds/slave/test', 01:51:49 INFO - 'SHELL': '/bin/bash', 01:51:49 INFO - 'SHLVL': '1', 01:51:49 INFO - 'TERM': 'linux', 01:51:49 INFO - 'TMOUT': '86400', 01:51:49 INFO - 'USER': 'cltbld', 01:51:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:49 INFO - '_': '/tools/buildbot/bin/python'} 01:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:51 INFO - Downloading blobuploader-1.2.4.tar.gz 01:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:51:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:51:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:52 INFO - Downloading docopt-0.6.1.tar.gz 01:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:51:52 INFO - Installing collected packages: blobuploader, requests, docopt 01:51:52 INFO - Running setup.py install for blobuploader 01:51:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:51:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:51:52 INFO - Running setup.py install for requests 01:51:52 INFO - Running setup.py install for docopt 01:51:53 INFO - Successfully installed blobuploader requests docopt 01:51:53 INFO - Cleaning up... 01:51:53 INFO - Return code: 0 01:51:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:53 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:51:53 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 01:51:53 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 01:51:53 INFO - Using env: {'DISPLAY': ':0', 01:51:53 INFO - 'HOME': '/home/cltbld', 01:51:53 INFO - 'LANG': 'en_US.UTF-8', 01:51:53 INFO - 'LANGUAGE': 'en_US:en', 01:51:53 INFO - 'LOGNAME': 'cltbld', 01:51:53 INFO - 'MAIL': '/var/mail/cltbld', 01:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:53 INFO - 'MOZ_NO_REMOTE': '1', 01:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:53 INFO - 'NO_EM_RESTART': '1', 01:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:53 INFO - 'PWD': '/builds/slave/test', 01:51:53 INFO - 'SHELL': '/bin/bash', 01:51:53 INFO - 'SHLVL': '1', 01:51:53 INFO - 'TERM': 'linux', 01:51:53 INFO - 'TMOUT': '86400', 01:51:53 INFO - 'USER': 'cltbld', 01:51:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:53 INFO - '_': '/tools/buildbot/bin/python'} 01:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:51:53 INFO - Running setup.py (path:/tmp/pip-eLWJRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:51:53 INFO - Running setup.py (path:/tmp/pip-VIEzVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:51:53 INFO - Running setup.py (path:/tmp/pip-fLjQlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:51:53 INFO - Running setup.py (path:/tmp/pip-SZaXOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:51:53 INFO - Running setup.py (path:/tmp/pip-jaWPO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:51:53 INFO - Running setup.py (path:/tmp/pip-M0QFZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:51:53 INFO - Running setup.py (path:/tmp/pip-XDx0bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:51:53 INFO - Running setup.py (path:/tmp/pip-OBSTdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:51:53 INFO - Running setup.py (path:/tmp/pip-OmhmZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:51:54 INFO - Running setup.py (path:/tmp/pip-LPGUII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:51:54 INFO - Running setup.py (path:/tmp/pip-QOAEgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:51:54 INFO - Running setup.py (path:/tmp/pip-YIgbqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:51:54 INFO - Running setup.py (path:/tmp/pip-QI9xSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:51:54 INFO - Running setup.py (path:/tmp/pip-91ewnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:54 INFO - Running setup.py (path:/tmp/pip-jm_tyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:51:54 INFO - Running setup.py (path:/tmp/pip-sJPP2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:51:54 INFO - Running setup.py (path:/tmp/pip-XBtKCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:51:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:51:54 INFO - Running setup.py install for manifestparser 01:51:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:51:54 INFO - Running setup.py install for mozcrash 01:51:54 INFO - Running setup.py install for mozdebug 01:51:54 INFO - Running setup.py install for mozdevice 01:51:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for mozfile 01:51:55 INFO - Running setup.py install for mozhttpd 01:51:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for mozinfo 01:51:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for mozInstall 01:51:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for mozleak 01:51:55 INFO - Running setup.py install for mozlog 01:51:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for moznetwork 01:51:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for mozprocess 01:51:55 INFO - Running setup.py install for mozprofile 01:51:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for mozrunner 01:51:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Running setup.py install for mozscreenshot 01:51:56 INFO - Running setup.py install for moztest 01:51:56 INFO - Running setup.py install for mozversion 01:51:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:51:56 INFO - Cleaning up... 01:51:56 INFO - Return code: 0 01:51:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:51: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')]} 01:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51: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')]} 01:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:56 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:51:56 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 01:51:56 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 01:51:56 INFO - Using env: {'DISPLAY': ':0', 01:51:56 INFO - 'HOME': '/home/cltbld', 01:51:56 INFO - 'LANG': 'en_US.UTF-8', 01:51:56 INFO - 'LANGUAGE': 'en_US:en', 01:51:56 INFO - 'LOGNAME': 'cltbld', 01:51:56 INFO - 'MAIL': '/var/mail/cltbld', 01:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:56 INFO - 'MOZ_NO_REMOTE': '1', 01:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:56 INFO - 'NO_EM_RESTART': '1', 01:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:56 INFO - 'PWD': '/builds/slave/test', 01:51:56 INFO - 'SHELL': '/bin/bash', 01:51:56 INFO - 'SHLVL': '1', 01:51:56 INFO - 'TERM': 'linux', 01:51:56 INFO - 'TMOUT': '86400', 01:51:56 INFO - 'USER': 'cltbld', 01:51:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:56 INFO - '_': '/tools/buildbot/bin/python'} 01:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:51:56 INFO - Running setup.py (path:/tmp/pip-otyOqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:51:56 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)) 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:51:56 INFO - Running setup.py (path:/tmp/pip-9yqf00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:51:56 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)) 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:51:56 INFO - Running setup.py (path:/tmp/pip-6DR21S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:51:56 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)) 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:51:56 INFO - Running setup.py (path:/tmp/pip-9xAbca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:51:56 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)) 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:51:56 INFO - Running setup.py (path:/tmp/pip-HsLY2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:51:56 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)) 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:51:56 INFO - Running setup.py (path:/tmp/pip-AauFPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:51:57 INFO - Running setup.py (path:/tmp/pip-fQDvlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:51:57 INFO - Running setup.py (path:/tmp/pip-trTqJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:51:57 INFO - Running setup.py (path:/tmp/pip-vOXH6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:51:57 INFO - Running setup.py (path:/tmp/pip-zFLy5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:51:57 INFO - Running setup.py (path:/tmp/pip-ubukAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:51:57 INFO - Running setup.py (path:/tmp/pip-mKjzSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:51:57 INFO - Running setup.py (path:/tmp/pip-Uphi0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:51:57 INFO - Running setup.py (path:/tmp/pip-xnclOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:57 INFO - Running setup.py (path:/tmp/pip-vwpZbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:51:57 INFO - Running setup.py (path:/tmp/pip-pnhaUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:51:57 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)) 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:51:57 INFO - Running setup.py (path:/tmp/pip-NCGe4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:51:57 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)) 01:51:57 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)) 01:51:57 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)) 01:51:57 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)) 01:51:57 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)) 01:51:57 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)) 01:51:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:59 INFO - Downloading blessings-1.6.tar.gz 01:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:51:59 INFO - Installing collected packages: blessings 01:51:59 INFO - Running setup.py install for blessings 01:51:59 INFO - Successfully installed blessings 01:51:59 INFO - Cleaning up... 01:51:59 INFO - Return code: 0 01:51:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:00 INFO - Reading from file tmpfile_stdout 01:52:00 INFO - Current package versions: 01:52:00 INFO - argparse == 1.2.1 01:52:00 INFO - blessings == 1.6 01:52:00 INFO - blobuploader == 1.2.4 01:52:00 INFO - docopt == 0.6.1 01:52:00 INFO - manifestparser == 1.1 01:52:00 INFO - mozInstall == 1.12 01:52:00 INFO - mozcrash == 0.17 01:52:00 INFO - mozdebug == 0.1 01:52:00 INFO - mozdevice == 0.48 01:52:00 INFO - mozfile == 1.2 01:52:00 INFO - mozhttpd == 0.7 01:52:00 INFO - mozinfo == 0.9 01:52:00 INFO - mozleak == 0.1 01:52:00 INFO - mozlog == 3.1 01:52:00 INFO - moznetwork == 0.27 01:52:00 INFO - mozprocess == 0.22 01:52:00 INFO - mozprofile == 0.28 01:52:00 INFO - mozrunner == 6.11 01:52:00 INFO - mozscreenshot == 0.1 01:52:00 INFO - mozsystemmonitor == 0.0 01:52:00 INFO - moztest == 0.7 01:52:00 INFO - mozversion == 1.4 01:52:00 INFO - psutil == 3.1.1 01:52:00 INFO - requests == 1.2.3 01:52:00 INFO - wsgiref == 0.1.2 01:52:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:52:00 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 01:52:00 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 01:52:00 INFO - Using env: {'DISPLAY': ':0', 01:52:00 INFO - 'HOME': '/home/cltbld', 01:52:00 INFO - 'LANG': 'en_US.UTF-8', 01:52:00 INFO - 'LANGUAGE': 'en_US:en', 01:52:00 INFO - 'LOGNAME': 'cltbld', 01:52:00 INFO - 'MAIL': '/var/mail/cltbld', 01:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:00 INFO - 'MOZ_NO_REMOTE': '1', 01:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:00 INFO - 'NO_EM_RESTART': '1', 01:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:00 INFO - 'PWD': '/builds/slave/test', 01:52:00 INFO - 'SHELL': '/bin/bash', 01:52:00 INFO - 'SHLVL': '1', 01:52:00 INFO - 'TERM': 'linux', 01:52:00 INFO - 'TMOUT': '86400', 01:52:00 INFO - 'USER': 'cltbld', 01:52:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:00 INFO - '_': '/tools/buildbot/bin/python'} 01:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 INFO - Cleaning up... 01:52:00 INFO - Return code: 0 01:52:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:52:00 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 01:52:00 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 01:52:00 INFO - Using env: {'DISPLAY': ':0', 01:52:00 INFO - 'HOME': '/home/cltbld', 01:52:00 INFO - 'LANG': 'en_US.UTF-8', 01:52:00 INFO - 'LANGUAGE': 'en_US:en', 01:52:00 INFO - 'LOGNAME': 'cltbld', 01:52:00 INFO - 'MAIL': '/var/mail/cltbld', 01:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:00 INFO - 'MOZ_NO_REMOTE': '1', 01:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:00 INFO - 'NO_EM_RESTART': '1', 01:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:00 INFO - 'PWD': '/builds/slave/test', 01:52:00 INFO - 'SHELL': '/bin/bash', 01:52:00 INFO - 'SHLVL': '1', 01:52:00 INFO - 'TERM': 'linux', 01:52:00 INFO - 'TMOUT': '86400', 01:52:00 INFO - 'USER': 'cltbld', 01:52:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:00 INFO - '_': '/tools/buildbot/bin/python'} 01:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:00 INFO - Downloading/unpacking jsonschema 01:52:00 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 01:52:00 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 01:52:00 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 01:52:00 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 01:52:00 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 01:52:00 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 01:52:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:02 INFO - Downloading/unpacking functools32 (from jsonschema) 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:02 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:02 INFO - warning: no files found matching '*.txt' 01:52:02 INFO - no previously-included directories found matching 'build' 01:52:02 INFO - no previously-included directories found matching 'dist' 01:52:02 INFO - no previously-included directories found matching '.git*' 01:52:02 INFO - Installing collected packages: jsonschema, functools32 01:52:02 INFO - Running setup.py install for functools32 01:52:02 INFO - warning: no files found matching '*.txt' 01:52:02 INFO - no previously-included directories found matching 'build' 01:52:02 INFO - no previously-included directories found matching 'dist' 01:52:02 INFO - no previously-included directories found matching '.git*' 01:52:02 INFO - Successfully installed jsonschema functools32 01:52:02 INFO - Cleaning up... 01:52:03 INFO - Return code: 0 01:52:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:03 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 0x7ffe16baaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', '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 01:52:03 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 01:52:03 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 01:52:03 INFO - Using env: {'DISPLAY': ':0', 01:52:03 INFO - 'HOME': '/home/cltbld', 01:52:03 INFO - 'LANG': 'en_US.UTF-8', 01:52:03 INFO - 'LANGUAGE': 'en_US:en', 01:52:03 INFO - 'LOGNAME': 'cltbld', 01:52:03 INFO - 'MAIL': '/var/mail/cltbld', 01:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:03 INFO - 'MOZ_NO_REMOTE': '1', 01:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:03 INFO - 'NO_EM_RESTART': '1', 01:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:03 INFO - 'PWD': '/builds/slave/test', 01:52:03 INFO - 'SHELL': '/bin/bash', 01:52:03 INFO - 'SHLVL': '1', 01:52:03 INFO - 'TERM': 'linux', 01:52:03 INFO - 'TMOUT': '86400', 01:52:03 INFO - 'USER': 'cltbld', 01:52:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:03 INFO - '_': '/tools/buildbot/bin/python'} 01:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:03 INFO - Downloading/unpacking flake8 01:52:03 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 01:52:03 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 01:52:03 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 01:52:03 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 01:52:03 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 01:52:03 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 01:52:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:52:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:52:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:05 INFO - no previously-included directories found matching 'docs/_build' 01:52:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:52:05 INFO - Running setup.py install for pep8 01:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:05 INFO - no previously-included directories found matching 'docs/_build' 01:52:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:52:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:52:06 INFO - Cleaning up... 01:52:06 INFO - Return code: 0 01:52:06 INFO - Running post-action listener: _resource_record_post_action 01:52:06 INFO - Running post-action listener: _start_resource_monitoring 01:52:06 INFO - Starting resource monitoring. 01:52:06 INFO - ##### 01:52:06 INFO - ##### Running install step. 01:52:06 INFO - ##### 01:52:06 INFO - Running pre-action listener: _resource_record_pre_action 01:52:06 INFO - Running main action method: install 01:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:06 INFO - Reading from file tmpfile_stdout 01:52:06 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:52:06 INFO - Reading from file tmpfile_stdout 01:52:06 INFO - Output received: 01:52:06 INFO - Usage: mozinstall [options] installer 01:52:06 INFO - Options: 01:52:06 INFO - -h, --help show this help message and exit 01:52:06 INFO - -d DEST, --destination=DEST 01:52:06 INFO - Directory to install application into. [default: 01:52:06 INFO - "/builds/slave/test"] 01:52:06 INFO - --app=APP Application being installed. [default: firefox] 01:52:06 INFO - mkdir: /builds/slave/test/build/application 01:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:52:19 INFO - Reading from file tmpfile_stdout 01:52:19 INFO - Output received: 01:52:19 INFO - /builds/slave/test/build/application/firefox/firefox 01:52:19 INFO - Running post-action listener: _resource_record_post_action 01:52:19 INFO - ##### 01:52:19 INFO - ##### Running run-tests step. 01:52:19 INFO - ##### 01:52:19 INFO - Running pre-action listener: _resource_record_pre_action 01:52:19 INFO - Running main action method: run_tests 01:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:52:19 INFO - Python 2.7.3 01:52:19 INFO - Return code: 0 01:52:19 INFO - grabbing minidump binary from tooltool 01:52:19 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')]} 01:52:19 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 0x279a410>, '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 0x279b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:52:19 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 01:52:19 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 01:52:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:52:19 INFO - Return code: 0 01:52:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:52:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:52:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:52:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:52:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:52:20 INFO - Return code: 0 01:52:20 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/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:52:20 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/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 01:52:20 INFO - Using env: {'DISPLAY': ':0', 01:52:20 INFO - 'HOME': '/home/cltbld', 01:52:20 INFO - 'LANG': 'en_US.UTF-8', 01:52:20 INFO - 'LANGUAGE': 'en_US:en', 01:52:20 INFO - 'LOGNAME': 'cltbld', 01:52:20 INFO - 'MAIL': '/var/mail/cltbld', 01:52:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:52:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:20 INFO - 'MOZ_NO_REMOTE': '1', 01:52:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:20 INFO - 'NO_EM_RESTART': '1', 01:52:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:20 INFO - 'PWD': '/builds/slave/test', 01:52:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:52:20 INFO - 'SHELL': '/bin/bash', 01:52:20 INFO - 'SHLVL': '1', 01:52:20 INFO - 'TERM': 'linux', 01:52:20 INFO - 'TMOUT': '86400', 01:52:20 INFO - 'USER': 'cltbld', 01:52:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445', 01:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:20 INFO - '_': '/tools/buildbot/bin/python'} 01:52:20 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/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:52:20 INFO - mozversion application_buildid: 20160627144420 01:52:20 INFO - mozversion application_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 01:52:20 INFO - mozversion application_display_name: Firefox 01:52:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:52:20 INFO - mozversion application_name: Firefox 01:52:20 INFO - mozversion application_remotingname: firefox 01:52:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:52:20 INFO - mozversion application_vendor: Mozilla 01:52:20 INFO - mozversion application_version: 48.0 01:52:20 INFO - mozversion platform_buildid: 20160627144420 01:52:20 INFO - mozversion platform_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 01:52:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:52:20 INFO - mozversion platform_version: 48.0 01:52:20 INFO - using testdate: 1467103940 01:52:20 INFO - actual date: 1467103940 01:52:20 INFO - starting webserver on 'localhost:34351' 01:52:20 INFO - SUITE-START | Running 2 tests 01:52:20 INFO - TEST-START | dromaeo_css 01:52:20 INFO - operating with platform_type : linux_ 01:52:20 INFO - Initialising browser for dromaeo_css test... 01:52:20 INFO - TEST-INFO | started process 21606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNsP_qF/profile http://localhost:34351/getInfo.html) 01:52:24 INFO - PROCESS | 21606 | __metrics Screen width/height:1600/1200 01:52:24 INFO - PROCESS | 21606 | colorDepth:24 01:52:24 INFO - PROCESS | 21606 | Browser inner width/height: 1024/697 01:52:24 INFO - PROCESS | 21606 | __metrics 01:52:24 ERROR - PROCESS | 21606 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:52:25 INFO - TEST-INFO | 21606: exit 0 01:52:25 INFO - Browser initialized. 01:52:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:52:25 INFO - TEST-INFO | started process 21700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNsP_qF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:37 INFO - PROCESS | 21700 | RSS: Main: 139341824 01:52:37 INFO - PROCESS | 21700 | 01:53:28 INFO - PROCESS | 21700 | 1467104008337 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] 01:55:35 INFO - PROCESS | 21700 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34351/tests/dromaeo/cssquery-ext.html) 01:55:36 INFO - PROCESS | 21700 | RSS: Main: 249434112 01:55:36 INFO - PROCESS | 21700 | 01:58:38 INFO - PROCESS | 21700 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-ext.html (next: http://localhost:34351/tests/dromaeo/cssquery-jquery.html) 01:58:39 INFO - PROCESS | 21700 | RSS: Main: 222875648 01:58:39 INFO - PROCESS | 21700 | 02:01:41 INFO - PROCESS | 21700 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34351/tests/dromaeo/cssquery-mootools.html) 02:01:41 INFO - PROCESS | 21700 | RSS: Main: 215650304 02:01:41 INFO - PROCESS | 21700 | 02:04:43 INFO - PROCESS | 21700 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34351/tests/dromaeo/cssquery-prototype.html) 02:04:44 INFO - PROCESS | 21700 | RSS: Main: 215670784 02:04:44 INFO - PROCESS | 21700 | 02:07:46 INFO - PROCESS | 21700 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34351/tests/dromaeo/cssquery-yui.html) 02:07:47 INFO - PROCESS | 21700 | RSS: Main: 215228416 02:07:47 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | Cycle 1(1): loaded http://localhost:34351/tests/dromaeo/cssquery-yui.html (next: http://localhost:34351/tests/dromaeo/cssquery-dojo.html) 02:10:49 INFO - PROCESS | 21700 | RSS: Main: 253374464 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | __start_tp_report 02:10:49 INFO - PROCESS | 21700 | _x_x_mozilla_page_load 02:10:49 INFO - PROCESS | 21700 | _x_x_mozilla_page_load_details 02:10:49 INFO - PROCESS | 21700 | |i|pagename|runs| 02:10:49 INFO - PROCESS | 21700 | |0;dojo.html;3319.7510186735994;3387.4072037393435;3388.508666243394;3413.8634454621815;3431.0564594736443;5597.888042239153;5604.355499117602;5631.8310450686495;5637.267155269819;5642.2382978297965;5581.6371935824145;5591.189277554752;5594.58040646951;5627.831165065044;5641.717914104299;4935.284383764352;5078.847634570969;5156.639035267514;5210;5247;5033.572146367563;5082.136036873721;5112.003159383921;5121.334226550562;5123.410807757118;4966.453690094087;5035.320231768701;5055.797768089272;5056.620753443506;5072.365954255718;5083.288339632418;5105.33630628016;5106.183010718286;5107.872303192413;5110.64225504213;4887.951120488785;4973.701577905301;5027.974860125676;5047.369078865142;5052.393712754456;5393.352797664266;5442.755076021588;5452.809151679712;5462;5465.726713664301;5913.349531551526;5941.287045554561;5943.4056594340655;5943.821685349447;5946.821595352147;5945.910811337833;5972.611780234271;6080.612056351554;6099.6950152492645;6102.69486525672;5514.24287856072;5561.110222364402;5562.666240025612;5568.109102543614;5579.107342825169;5873.442023007808;6077.6353418795015;6079.300880398722;6082.665453400017;6087.66517841523;5759.1937128802;5837.124431335334;5841;5841.561882858802;5851;5999.5800293979;6025.758969641253;6028.668423236764;6030.849228769228;6033.336333003366;5702.885942281131;5822.854428639233;5947.107933809876;5962.791302304486;5972.731227094791;5936.376680448577;5948.791792287249;5956.970215148983;5959.493443057302;5997.0404735242155;4549.681522293407;4563.995920897397;4565.931511027337;4566.086782643484;4596.678232523691;3997.320455522568;4016.196760647882;4079.8164082616354;4093.5906409358827;4122.134351786159;5737.426257374313;5753.108268218432;5756.740946657411;5758.856028599319;5761.3950535194035;6025.939740602538;6047.606905551125;6051.7579296827635;6054.545909056838;6057.18228039209;5654.434556544313;5665.886682266331;5669.943300566942;5745.741441635137;5757.8560535986935;5124.436312005676;5152.7166005869285;5153.1497302945345;5154.226865970059;5156.329677142023;6264.498840092781;6290.842728931813;6291.905621415683;6297.96851015742;6315.400036996478;5846.327672317738;5968.104784282393;6031.819045428644;6069.36271691466;6075.878482430238;6224.356350640455;6246.281677607133;6247.531435142473;6260.217472815898;6266.185395898504;5791.710414479344;5889.499392551681;5897.233359663216;5903.498202652822;5940.287165540163;5889.146073819186;5941.970290148522;5950.880982380241;5982.7307771149535;5990.071538911476;5731.8853622928145;5766.596338256281;5778.133280008033;5781.335146458211;5786.855328616818;5705.743241554057;5725.885482290414;5748.137779333133;5766.221560089334;5773.509251713652;5700;5723.284589426322;5729.111987641755;5731.942680573141;5760.740766665594;5832.037713777179;5834.27071616048;5834.649921004753;5838.416158384128;5839.8832023358445;5515.558755299647;5629.408912064175;5710.5146062585145;5728.570357223141;5747.252857128714 02:10:49 INFO - PROCESS | 21700 | |1;ext.html;657.0308794528069;669.5380187670507;669.7890164598151;686.9695456814779;733.1495465260296;32348.67651323486;33312;33327.66672333276;33340.66659333412;33350.8332458338;33433.66566334336;40739.388909166315;41466;41622.58377416225;41647.791761041226;8688.174623410781;8836.248918841875;8844.292456603489;8849.646014159425;8855.690050848221;8126.918730812676;8765.649374025032;8887.911120888773;8892.59983300753;10688.786224275509;10624.30941988772;10723.678289651323;10736.194785391088;10739;10740.409277489734;10504.947475262652;10596.31123976943;10597.099246564052;10598.311109777916;10601.681949541526;10438.112760415373;10573.73565660857;10574.10120139789;10576.735581610521;10581.153507719364;39471.60528394708;43284.783576082235;43805.34291985623;43818;43847.34228986568;3776.131489757344;3811.790351530665;3829.329867273216;3956.6834653227675;4055.6755459563165;33665;33759.6624033759;34166.316673666384;34816.65183348159;35863.64136358629;4555.134524440379;4603.562661547147;4608.815647374101;4619.884502887421;4643.535646435364;339676;340095;340977;343064;343128;39101.6089839098;39846;60740.69629651823;61208;61334.38665613376;37838.24323513569;37865;37897.81051094727;37954;38004.8099759505;17345.913270433568;17509.124543773014;17531.561710957074;17533;17544.912275438543;14943.701125977419;15058.397664093533;15063.698726025417;15106.848931510543;15118.470853520073;8797.516136612549;9273.814523709489;9421.576029078708;9422.199113075329;9477.620895164255;3502.4746288056995;3522.9295414091575;3597.8201089945396;3601.099725068733;3648.087978005499;1127.5884302229626;1215.9574414895437;1238.7027113492877;1247.2391840976998;1256.145820841818;32613.184670382954;32704.509432358533;32868;33023;34742.30515389729;1171.5723760827236;1215.851020785367;1233.9321337326353;1241.8571864235548;1268.689171153055;16658.83341166597;16663.16684165787;16936.407225747287;16936.915315423343;17011.574710632332;498458;503185;505047;507039;507774;60234;61007.6949615258;61008;61110.694446528374;61216.387836121066;1401.810755547988;1535.9248526031822;1551.1003617901365;1622.529466454715;1637.5414883832545;30220.84889575538;31391;31677.20806979844;31968.36063278768;32450.513242301855;47770;59992.70003649954;61573.38426615676;61620.38379616146;62150.37849621446;319383;321965;323976;325079;325156;38299.44584080826;39025.6097439022;45354;46457;46571;44891.775541122086;44913.550864490935;45165.774171128935;45560;45699.543004570856;38212.808935955145;38532;38873.61126388813;38918.4162237561;39155.804220978716;37053.44419833651;37290;38449;39799.403008955465;41875;42134.78932605317;42562;42960.35559466673;43681.78159109184;43915.78042109769;35566.466503002994;35807;36864.26271474609;36871.078223043565;37228.81385593163;28780;28797.28006799847;29018.323103891493;29255.707442925297;29503.704962950953 02:10:49 INFO - PROCESS | 21700 | |2;jquery.html;427.28856454004074;431.4175862585509;439.8218721417825;443.2497776379995;444.3268448300823;18557.907210463945;18592.256309747594;18861.15124819383;19322.71015934762;19365.709514357295;18703.532411689714;18800.34198803042;19070.046497675095;19183;19185.424437266905;5678.176664383672;5748.5688573357165;5965.194698715662;5990.311114221855;5991.041433370661;5845.444682755132;5907.616004959686;5934.376890426508;5940.257467816523;5959.195508606326;5640.492355687988;5881.470667639912;5914.852128696795;5919.437653422918;5922.763089476416;5869.9706501467435;5876.588638795286;5903.49820265278;5921.940780592182;5938.287405511344;5338.866528336823;5350.38470575881;5365.731713414352;5607.663540187602;5662.433756624346;14368.20974846383;14504.854951450456;14579.19814410207;21849.344519664435;23290.417739556477;2415.1426243683413;2466.1245257933356;2536.213773730131;2756.462489814487;2816.324082220273;10264.486775661187;10290.79418411635;10445.79108417835;10483;10641;1943.4655469745933;2032.7560692716968;2085.687146927973;2118.5445129297123;2168.826493880486;74381;79032.20967790305;80456.59771701104;81150;82918.58540707258;11011.889881101086;11146.832797508045;11179.60871369498;11228.550857965753;11279.548818047351;16003;16017.839821601869;16094.114823684575;16120.838791612168;16163.191840407933;8857.64569417229;8888.511131887808;8902.599383027778;9032.8645070324;9113.225375842994;8903.643854245887;8948.955255223813;8957.641694332153;8962.731118066338;9043.77390565228;4932.1861892788;4965.106280869478;5011.57401620859;5045.5459008689395;5049.788050867765;2032.7560692716968;2044.7239622650752;2053.435305291027;2061.917523299051;2102.2957309301555;987.1757082835912;1056.0812093478569;1089.362722807151;1154.2382027861572;1182.899453546441;16628.6674266514;18651.16069776863;19486.902565487082;19620;19660;1030.2324768047702;1089.215764649451;1125.234840308598;1125.7410795517078;1197.6287350921243;8101.351891848638;10975.945120274348;11071.72320691989;11077.335359878432;11101.333919964827;492875;495508;520462;521726;527739;55809;57500.13749793756;64273.67863160654;87074.56462717646;89234;1125.7692173104658;1129.2941911305434;1176.7528818947947;1188.9762204755857;1224.2837939805313;12509.87490125087;16149.838501614833;16926.238319275417;17262.65474690474;17500.737488937422;37783.81108094552;38060.61939380682;38362;38434.6156538431;39873;51283.487165129365;51605.22592161196;51746.48253517567;52056.21915671192;52748.20877686761;8681.739547813575;8740.475571465733;8864.20222180007;8943.776405589912;9079;9290.95354523223;11534.192606517463;11550.595729149776;11683.532658693557;12098.516059357527;10498;10596;10741.677749667522;11076.889231107585;11106.055985241344;9982.201423886218;10624.893751062391;10634.680959571226;10745.194110441591;11020.283681560673;10309.690709278733;10790.514426850654;10862.293950893167;10958.917805616908;11151.442427878736;8177.4684645497855;8405.537695426565;8615.655373784979;8621.482711037357;8910.465372077697;8574.09971952961;10495.16038716916;11034.393108379116;11083.50124244427;11258.493367798304 02:10:49 INFO - PROCESS | 21700 | |3;mootools.html;1421.1118051217989;1550.5890938901189;1557.7741227522006;1796.7394727764474;1948.3862583286264;8221.09567947526;8459.23866851984;8486.44838085524;8490.490570565771;8508.191721786436;8230.218129277724;8466.534340611279;8470.28002619778;8481.406301558893;8488.108748581402;2389.366817793282;2411.0837881605053;2415.927522174338;2416.069813121952;2416.9758302417013;2411.638254261857;2436.2691192642224;2460.2619214235747;2473.6536884836137;2478.529079474894;2384.7972922301624;2407.16952651335;2412.7104747430335;2417.1177520205088;2424.709034915804;2374.2877136858874;2415.1546958564536;2418.2503423938633;2433.7809597136256;2437.5612389769744;2373.7982271506944;2423.7939775119135;2424.696912885889;2434.561778879801;2442.6336049592524;7065.505414620979;7208.675609597581;8578.957105214497;8657.134286571356;8663.870041949376;5186.818461353834;5257.553107985826;5294.391145018334;5299.5760339172775;5303.946960530422;3367.9158021049425;3390.983045084759;3418.384690755663;3459.3427248822895;3520.9823950880336;1121.624255874283;1137.2721458266633;1153.26191237608;1161.773454176436;1189.5301355964432;11786.88213117875;11966.34185119818;12006.759864802742;12341.629751107392;12350.62948111558;4672.813087476463;4731.95268047322;4762.357081793983;4789.8323558675975;4806.975965120152;10369.118624916966;10397.064264216257;10406.739831504121;10410.011048950337;10414.479276036167;5423.240746295522;5435.130379139318;5467.1799230115;5469.124940009579;5474.39781624021;4943.307936888838;4998.525140111684;5003.849884503471;5004.274380214922;5006.6495345325475;3883.2427676603356;3895.9610403896163;3910.7262491625884;3993.7603743775467;3996.18078293949;1158.6002829023973;1186.9287842729464;1187.26389638423;1192.1118766518998;1197.22180582622;939.196986576481;1082.5940272397852;1092.6776600902754;1098.2531878322818;1099.8405231241586;5980.132880732356;6088.482478989247;6094.8171554853425;6135.815925522242;6152.815415537541;958.5590628311055;989.618996686281;1052.8157572424795;1053.6628278950661;1089.0090018083506;3590.4793804898145;4206.0326124991425;4209.158168366339;4232.343986682069;4289.270823959934;9758.170555502862;9979.351342162736;9980.600775969026;9981.45102019396;9981.750456238507;9588.424694518351;9799.265055120895;9832.115109640166;9837.60649574009;9860.45767482781;7953.642086106139;7990.360771138178;8114.594270286462;8138;8153.22544358285;5767.307923049261;5887.4406931341455;5940.8811823764145;6025.125502634896;6081.209442772411;9142.405743626643;9191.908080919105;9481.905180948102;9506.096920792514;9506.096920792514;9572.56923438433;9630.296488985357;9662.420254784736;9878.407295562289;10141.898581014095;7590.506617069873;7603.9619801902845;7662.118856331594;7694.345980591713;7712.845743084995;8153.388495862715;8323.95838020806;8344.207300306462;8355.039170495227;8364.665413383396;7592.924070759443;7634.50375725576;7674.347680447225;7724.382049435919;7727.49771264866;7308.890366644611;7408.370288525536;7523.1348394935285;7525.3227209551405;7681;7028.226895041644;7153.3919616833155;7179.174394944648;7183.712651493882;7185.892211616934;5292.179712144623;5301.575873929999;5312.760925758427;5332.520073193431;5398.7300634967305;5336.412994570672;5341.7062061586985;5353.143497040455;5386.515213630635;5439.292891924025 02:10:49 INFO - PROCESS | 21700 | |4;prototype.html;355.030766008796;356.4546244246304;365.636191988971;367.1244082862373;371.38350338438187;6167.907481387771;6169.25968883734;6180.072989051644;6181.350958149397;6221.626702397859;6106.572539922207;6114.877702445949;6115.633062016271;6117.938820611793;6130.1111338855835;4563.840265590697;4629.745364004978;4693.249080147177;4714.198586240347;4721.669483136182;4685.484596694361;4706.5293470653005;4712.19892618254;4764.404449443819;4774.594159496447;4543.5002149763495;4724.90550188996;4742.90514189716;4746.5490778376;4747.786349614275;4623.352730617717;4640.535946405366;4712.363830882821;4760.880977975578;4814.06125805468;4231.640310573605;4249.766262855542;4250.744955302661;4256.382824490463;4266.2320782259185;5973.044312909957;5974.8506287342725;5987.461128498412;5991.221141251653;5994;5541.030319694038;5543.473370029841;5549.417311182348;5555.2222688823595;5559.305086864142;6366.427021568081;6500.512461565354;6502.804915852532;6503.869922601569;6512.674366281667;4677.087967846272;4678.1813182692895;4679.719216847;4685.250359942427;4686.9765651171865;6776;6793.966030169818;6801.081853949703;6810.5913645181445;6817.7954661359745;4802.471728109905;4805.038992201574;4805.255185446262;4805.519448055236;4810.7113573185725;4858.17411040124;4865.9756701216265;4876.341693871282;4876.658633895593;4879.878003049952;5532.197831314437;5532.972335138379;5535.7785688572;5540.722963851791;5543.556515478752;6409.839754006187;6569.80290591283;6571.507136964747;6584.637844918576;6587.176602924635;1696.2366934879353;1713.2718594597247;1718.8538974187084;1723.8965662060066;1726.3612463388627;1064.7338165458636;1128.2666266926399;1152.251036826053;1168.4975460551875;1172.6657902497748;6324.588901721373;6527.575707579087;6528.869422611521;6551.21385433751;6553.344665533408;6881.071055407556;6883.311668833177;6884.586924784428;6886.69009894556;6895.620740859301;6527.281998980108;6532.248791388956;6538.771143009972;6546.214454265423;6550.967245163743;3653.451982202691;3673;3688.704903607705;3694.538182727159;3695.0947017980766;6964.512484126164;7159.427245820322;7164.283571642898;7178.676959536833;7197.784066478014;6922.41159501438;6938.687759050855;6941.444684425234;6949.652517374111;6955.547889387173;7154.570725756471;7175.892361614476;7175.928240717631;7184.712611495482;7197.280271972865;6833.282505336868;6834.624095674786;6836.38472537474;6838.281980391987;6842.144731908512;6577.638229897401;6684.732610695518;6739.393454589111;6761.425278851353;6764.289749576224;7113.502054856111;7150.463715221275;7175.246599107228;7183.784486465414;7184.389326907271;4758.452777930583;4759.23852183649;4760.833370832004;4762.9285560715925;4764.285357196448;6808.795736127924;6819.965900170468;6821.590704557742;6826.078479405217;6832.760853370109;6490.545661803629;6617.43751781104;6632.204135503771;6649.767258145942;6664.466842652673;6586.176727909012;6624;6633.170853643294;6638.5684930479365;6639.966800165968;6503.057056726653;6520.021996700533;6523.7716679915975;6525.608463492205;6532.608043517404;6681.599104053772;6686.899696504459;6688.598684078971;6696.56023954852;6699.698513566804;6372.394622510854;6525.804225873231;6533.281339052795;6550.705218265094;6552.475801935739 02:10:49 INFO - PROCESS | 21700 | |5;yui.html;838.0739283092183;848.2577744473585;855.6406309350073;889.8220355928814;901.5086777706149;15128.546143615682;16719.916400417995;17178.742318865196;17305.826941730596;17306.307747690076;15810.288537015833;15862.84137158628;15867.365305387772;15888.046717196976;15919.44281950132;758.1887380502836;895.122779675918;901;915.0346384564282;921.7925966657516;900.1268769293807;906.8095699903029;910.6630546697731;911.4030310146832;912.4570880326195;928.0441145620022;928.340877976634;933.8459154239576;935.9344845860759;942.0955882352949;782.7573452229827;932.0586207929972;944.8724422203018;953.5518306395983;961.9855702164473;695.6452209373256;698.5668885291101;699.1295836683362;700.8668353012962;702.8594281143792;15082.170480623561;15264.923675381551;15293.923530382388;15294.541163765105;15301.770473442908;14499.347529361205;14838.406463741438;14897;14914.62713432162;14938.701225975528;12284.262944223286;12501.687457813536;12513.37433128349;12516.3741812909;12560.057995650362;4050.1494686115952;4060.614241647039;4063.8258531685406;4115.135821477494;4115.9588404115875;57944;58211;58374;58724;59634.40365596332;12046.879531204575;12089.455974481169;12203.20679155852;12405.875941240653;12412;21748.347549573537;21844.89077554602;21855.562888742137;21882.234121805977;21894.562108757735;8917.242034427016;8958.74068757273;9073.183413492818;9175.495347755937;9503.04969503058;4840.080384726891;4848.345473361122;4859.34398856157;4925.679830810986;5015.874603134878;3595.838187281526;3637.836297366625;3642.817859107087;3646.5624125105155;3652.981735091361;644.6003477843673;648.503894520692;651.5862427358661;663.3499170812535;664.02720015178;786.1862971824135;815.5595978171721;817.440053563311;821.8784234607062;838.1241602525254;10269.229807764448;10433.21750868688;10466.372017678963;10688.14494840411;10748.355098694103;759.5860256160406;855.2901092093548;861.0497223788125;864.9740507784777;869.2046777198918;4797.736124513115;4911.852644420673;4954.653174277766;4978.875528111754;4986.8753281168265;55471.44528554663;56358;56771;57172.42827571754;67561.3243867555;49101;49135.26297105546;49667;49693.503064968885;50066.499335006185;45690.77154614272;45784.54215457803;45870.770646147226;46058;46446;10230.335028223439;10294.330868493524;10357.987636406777;10396.896031039592;10449.21630877672;39100.217995640494;39791.403128953665;40041.398344065914;40055;40580.59419405886;46442;47832.52167478281;49866.25200622066;50132.248016280515;50823;13076.215427074407;13156.802647960098;13182.209067455984;13258.668533286746;13352;14250.283411632303;14378.568642940729;14472.342722347417;14561.635959101108;14712.264386780404;12844.10091293638;12999.1550549214;13284.202947823162;13321.267330296927;13360.732785344433;12975.416106275428;13255.536056237985;13301.600951971457;13369.465221391425;14507;13442.93278533601;13511.121777084458;13750.931245344109;13785.793213101611;13953.511627093003;11637.243579167327;11725.472353743931;11932.105092117952;12060.698482537655;12462.189957652723;11049.226554141133;11297.209195356574;11559.30644161353;11664.708382290171;11683.415829208676 02:10:49 INFO - PROCESS | 21700 | __end_tp_report 02:10:49 INFO - PROCESS | 21700 | __start_cc_report 02:10:49 INFO - PROCESS | 21700 | _x_x_mozilla_cycle_collect,852 02:10:49 INFO - PROCESS | 21700 | __end_cc_report 02:10:49 INFO - PROCESS | 21700 | __startTimestamp1467105049823__endTimestamp 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | ------- Summary: start ------- 02:10:49 INFO - PROCESS | 21700 | Number of tests: 6 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | [#0] dojo.html Cycles:165 Average:5547.96 Median:5747.25 stddev:617.48 (10.7%) stddev-sans-first:594.11 02:10:49 INFO - PROCESS | 21700 | Values: 3319.8 3387.4 3388.5 3413.9 3431.1 5597.9 5604.4 5631.8 5637.3 5642.2 5581.6 5591.2 5594.6 5627.8 5641.7 4935.3 5078.8 5156.6 5210.0 5247.0 5033.6 5082.1 5112.0 5121.3 5123.4 4966.5 5035.3 5055.8 5056.6 5072.4 5083.3 5105.3 5106.2 5107.9 5110.6 4888.0 4973.7 5028.0 5047.4 5052.4 5393.4 5442.8 5452.8 5462.0 5465.7 5913.3 5941.3 5943.4 5943.8 5946.8 5945.9 5972.6 6080.6 6099.7 6102.7 5514.2 5561.1 5562.7 5568.1 5579.1 5873.4 6077.6 6079.3 6082.7 6087.7 5759.2 5837.1 5841.0 5841.6 5851.0 5999.6 6025.8 6028.7 6030.8 6033.3 5702.9 5822.9 5947.1 5962.8 5972.7 5936.4 5948.8 5957.0 5959.5 5997.0 4549.7 4564.0 4565.9 4566.1 4596.7 3997.3 4016.2 4079.8 4093.6 4122.1 5737.4 5753.1 5756.7 5758.9 5761.4 6025.9 6047.6 6051.8 6054.5 6057.2 5654.4 5665.9 5669.9 5745.7 5757.9 5124.4 5152.7 5153.1 5154.2 5156.3 6264.5 6290.8 6291.9 6298.0 6315.4 5846.3 5968.1 6031.8 6069.4 6075.9 6224.4 6246.3 6247.5 6260.2 6266.2 5791.7 5889.5 5897.2 5903.5 5940.3 5889.1 5942.0 5950.9 5982.7 5990.1 5731.9 5766.6 5778.1 5781.3 5786.9 5705.7 5725.9 5748.1 5766.2 5773.5 5700.0 5723.3 5729.1 5731.9 5760.7 5832.0 5834.3 5834.6 5838.4 5839.9 5515.6 5629.4 5710.5 5728.6 5747.3 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | [#1] ext.html Cycles:180 Average:55372.11 Median:36962.26 stddev:105256.05 (284.8%) stddev-sans-first:105471.15 02:10:49 INFO - PROCESS | 21700 | Values: 657.0 669.5 669.8 687.0 733.1 32348.7 33312.0 33327.7 33340.7 33350.8 33433.7 40739.4 41466.0 41622.6 41647.8 8688.2 8836.2 8844.3 8849.6 8855.7 8126.9 8765.6 8887.9 8892.6 10688.8 10624.3 10723.7 10736.2 10739.0 10740.4 10504.9 10596.3 10597.1 10598.3 10601.7 10438.1 10573.7 10574.1 10576.7 10581.2 39471.6 43284.8 43805.3 43818.0 43847.3 3776.1 3811.8 3829.3 3956.7 4055.7 33665.0 33759.7 34166.3 34816.7 35863.6 4555.1 4603.6 4608.8 4619.9 4643.5 339676.0 340095.0 340977.0 343064.0 343128.0 39101.6 39846.0 60740.7 61208.0 61334.4 37838.2 37865.0 37897.8 37954.0 38004.8 17345.9 17509.1 17531.6 17533.0 17544.9 14943.7 15058.4 15063.7 15106.8 15118.5 8797.5 9273.8 9421.6 9422.2 9477.6 3502.5 3522.9 3597.8 3601.1 3648.1 1127.6 1216.0 1238.7 1247.2 1256.1 32613.2 32704.5 32868.0 33023.0 34742.3 1171.6 1215.9 1233.9 1241.9 1268.7 16658.8 16663.2 16936.4 16936.9 17011.6 498458.0 503185.0 505047.0 507039.0 507774.0 60234.0 61007.7 61008.0 61110.7 61216.4 1401.8 1535.9 1551.1 1622.5 1637.5 30220.8 31391.0 31677.2 31968.4 32450.5 47770.0 59992.7 61573.4 61620.4 62150.4 319383.0 321965.0 323976.0 325079.0 325156.0 38299.4 39025.6 45354.0 46457.0 46571.0 44891.8 44913.6 45165.8 45560.0 45699.5 38212.8 38532.0 38873.6 38918.4 39155.8 37053.4 37290.0 38449.0 39799.4 41875.0 42134.8 42562.0 42960.4 43681.8 43915.8 35566.5 35807.0 36864.3 36871.1 37228.8 28780.0 28797.3 29018.3 29255.7 29503.7 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | [#2] jquery.html Cycles:180 Average:28469.77 Median:2440.63 stddev:83890.27 (3437.2%) stddev-sans-first:84099.18 02:10:49 INFO - PROCESS | 21700 | Values: 427.3 431.4 439.8 443.2 444.3 18557.9 18592.3 18861.2 19322.7 19365.7 18703.5 18800.3 19070.0 19183.0 19185.4 5678.2 5748.6 5965.2 5990.3 5991.0 5845.4 5907.6 5934.4 5940.3 5959.2 5640.5 5881.5 5914.9 5919.4 5922.8 5870.0 5876.6 5903.5 5921.9 5938.3 5338.9 5350.4 5365.7 5607.7 5662.4 14368.2 14504.9 14579.2 21849.3 23290.4 2415.1 2466.1 2536.2 2756.5 2816.3 10264.5 10290.8 10445.8 10483.0 10641.0 1943.5 2032.8 2085.7 2118.5 2168.8 74381.0 79032.2 80456.6 81150.0 82918.6 11011.9 11146.8 11179.6 11228.6 11279.5 16003.0 16017.8 16094.1 16120.8 16163.2 8857.6 8888.5 8902.6 9032.9 9113.2 8903.6 8949.0 8957.6 8962.7 9043.8 4932.2 4965.1 5011.6 5045.5 5049.8 2032.8 2044.7 2053.4 2061.9 2102.3 987.2 1056.1 1089.4 1154.2 1182.9 16628.7 18651.2 19486.9 19620.0 19660.0 1030.2 1089.2 1125.2 1125.7 1197.6 8101.4 10975.9 11071.7 11077.3 11101.3 492875.0 495508.0 520462.0 521726.0 527739.0 55809.0 57500.1 64273.7 87074.6 89234.0 1125.8 1129.3 1176.8 1189.0 1224.3 12509.9 16149.8 16926.2 17262.7 17500.7 37783.8 38060.6 38362.0 38434.6 39873.0 51283.5 51605.2 51746.5 52056.2 52748.2 8681.7 8740.5 8864.2 8943.8 9079.0 9291.0 11534.2 11550.6 11683.5 12098.5 10498.0 10596.0 10741.7 11076.9 11106.1 9982.2 10624.9 10634.7 10745.2 11020.3 10309.7 10790.5 10862.3 10958.9 11151.4 8177.5 8405.5 8615.7 8621.5 8910.5 8574.1 10495.2 11034.4 11083.5 11258.5 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | [#3] mootools.html Cycles:180 Average:5706.79 Median:5322.64 stddev:3089.26 (58.0%) stddev-sans-first:3081.14 02:10:49 INFO - PROCESS | 21700 | Values: 1421.1 1550.6 1557.8 1796.7 1948.4 8221.1 8459.2 8486.4 8490.5 8508.2 8230.2 8466.5 8470.3 8481.4 8488.1 2389.4 2411.1 2415.9 2416.1 2417.0 2411.6 2436.3 2460.3 2473.7 2478.5 2384.8 2407.2 2412.7 2417.1 2424.7 2374.3 2415.2 2418.3 2433.8 2437.6 2373.8 2423.8 2424.7 2434.6 2442.6 7065.5 7208.7 8579.0 8657.1 8663.9 5186.8 5257.6 5294.4 5299.6 5303.9 3367.9 3391.0 3418.4 3459.3 3521.0 1121.6 1137.3 1153.3 1161.8 1189.5 11786.9 11966.3 12006.8 12341.6 12350.6 4672.8 4732.0 4762.4 4789.8 4807.0 10369.1 10397.1 10406.7 10410.0 10414.5 5423.2 5435.1 5467.2 5469.1 5474.4 4943.3 4998.5 5003.8 5004.3 5006.6 3883.2 3896.0 3910.7 3993.8 3996.2 1158.6 1186.9 1187.3 1192.1 1197.2 939.2 1082.6 1092.7 1098.3 1099.8 5980.1 6088.5 6094.8 6135.8 6152.8 958.6 989.6 1052.8 1053.7 1089.0 3590.5 4206.0 4209.2 4232.3 4289.3 9758.2 9979.4 9980.6 9981.5 9981.8 9588.4 9799.3 9832.1 9837.6 9860.5 7953.6 7990.4 8114.6 8138.0 8153.2 5767.3 5887.4 5940.9 6025.1 6081.2 9142.4 9191.9 9481.9 9506.1 9506.1 9572.6 9630.3 9662.4 9878.4 10141.9 7590.5 7604.0 7662.1 7694.3 7712.8 8153.4 8324.0 8344.2 8355.0 8364.7 7592.9 7634.5 7674.3 7724.4 7727.5 7308.9 7408.4 7523.1 7525.3 7681.0 7028.2 7153.4 7179.2 7183.7 7185.9 5292.2 5301.6 5312.8 5332.5 5398.7 5336.4 5341.7 5353.1 5386.5 5439.3 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | [#4] prototype.html Cycles:180 Average:5553.34 Median:6345.51 stddev:1665.55 (26.2%) stddev-sans-first:1623.88 02:10:49 INFO - PROCESS | 21700 | Values: 355.0 356.5 365.6 367.1 371.4 6167.9 6169.3 6180.1 6181.4 6221.6 6106.6 6114.9 6115.6 6117.9 6130.1 4563.8 4629.7 4693.2 4714.2 4721.7 4685.5 4706.5 4712.2 4764.4 4774.6 4543.5 4724.9 4742.9 4746.5 4747.8 4623.4 4640.5 4712.4 4760.9 4814.1 4231.6 4249.8 4250.7 4256.4 4266.2 5973.0 5974.9 5987.5 5991.2 5994.0 5541.0 5543.5 5549.4 5555.2 5559.3 6366.4 6500.5 6502.8 6503.9 6512.7 4677.1 4678.2 4679.7 4685.3 4687.0 6776.0 6794.0 6801.1 6810.6 6817.8 4802.5 4805.0 4805.3 4805.5 4810.7 4858.2 4866.0 4876.3 4876.7 4879.9 5532.2 5533.0 5535.8 5540.7 5543.6 6409.8 6569.8 6571.5 6584.6 6587.2 1696.2 1713.3 1718.9 1723.9 1726.4 1064.7 1128.3 1152.3 1168.5 1172.7 6324.6 6527.6 6528.9 6551.2 6553.3 6881.1 6883.3 6884.6 6886.7 6895.6 6527.3 6532.2 6538.8 6546.2 6551.0 3653.5 3673.0 3688.7 3694.5 3695.1 6964.5 7159.4 7164.3 7178.7 7197.8 6922.4 6938.7 6941.4 6949.7 6955.5 7154.6 7175.9 7175.9 7184.7 7197.3 6833.3 6834.6 6836.4 6838.3 6842.1 6577.6 6684.7 6739.4 6761.4 6764.3 7113.5 7150.5 7175.2 7183.8 7184.4 4758.5 4759.2 4760.8 4762.9 4764.3 6808.8 6820.0 6821.6 6826.1 6832.8 6490.5 6617.4 6632.2 6649.8 6664.5 6586.2 6624.0 6633.2 6638.6 6640.0 6503.1 6520.0 6523.8 6525.6 6532.6 6681.6 6686.9 6688.6 6696.6 6699.7 6372.4 6525.8 6533.3 6550.7 6552.5 02:10:49 INFO - PROCESS | 21700 | 02:10:49 INFO - PROCESS | 21700 | [#5] yui.html Cycles:180 Average:15482.43 Median:22320.60 stddev:16865.82 (75.6%) stddev-sans-first:16877.27 02:10:49 INFO - PROCESS | 21700 | Values: 838.1 848.3 855.6 889.8 901.5 15128.5 16719.9 17178.7 17305.8 17306.3 15810.3 15862.8 15867.4 15888.0 15919.4 758.2 895.1 901.0 915.0 921.8 900.1 906.8 910.7 911.4 912.5 928.0 928.3 933.8 935.9 942.1 782.8 932.1 944.9 953.6 962.0 695.6 698.6 699.1 700.9 702.9 15082.2 15264.9 15293.9 15294.5 15301.8 14499.3 14838.4 14897.0 14914.6 14938.7 12284.3 12501.7 12513.4 12516.4 12560.1 4050.1 4060.6 4063.8 4115.1 4116.0 57944.0 58211.0 58374.0 58724.0 59634.4 12046.9 12089.5 12203.2 12405.9 12412.0 21748.3 21844.9 21855.6 21882.2 21894.6 8917.2 8958.7 9073.2 9175.5 9503.0 4840.1 4848.3 4859.3 4925.7 5015.9 3595.8 3637.8 3642.8 3646.6 3653.0 644.6 648.5 651.6 663.3 664.0 786.2 815.6 817.4 821.9 838.1 10269.2 10433.2 10466.4 10688.1 10748.4 759.6 855.3 861.0 865.0 869.2 4797.7 4911.9 4954.7 4978.9 4986.9 55471.4 56358.0 56771.0 57172.4 67561.3 49101.0 49135.3 49667.0 49693.5 50066.5 45690.8 45784.5 45870.8 46058.0 46446.0 10230.3 10294.3 10358.0 10396.9 10449.2 39100.2 39791.4 40041.4 40055.0 40580.6 46442.0 47832.5 49866.3 50132.2 50823.0 13076.2 13156.8 13182.2 13258.7 13352.0 14250.3 14378.6 14472.3 14561.6 14712.3 12844.1 12999.2 13284.2 13321.3 13360.7 12975.4 13255.5 13301.6 13369.5 14507.0 13442.9 13511.1 13750.9 13785.8 13953.5 11637.2 11725.5 11932.1 12060.7 12462.2 11049.2 11297.2 11559.3 11664.7 11683.4 02:10:49 INFO - PROCESS | 21700 | -------- Summary: end -------- 02:10:49 INFO - PROCESS | 21700 | 02:10:50 INFO - TEST-INFO | 21700: exit 0 02:10:50 INFO - TEST-OK | dromaeo_css | took 1109568ms 02:10:50 INFO - TEST-START | kraken 02:10:50 INFO - operating with platform_type : linux_ 02:10:50 INFO - Initialising browser for kraken test... 02:10:50 INFO - TEST-INFO | started process 21889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAbK8I/profile http://localhost:34351/getInfo.html) 02:10:53 INFO - PROCESS | 21889 | __metrics Screen width/height:1600/1200 02:10:53 INFO - PROCESS | 21889 | colorDepth:24 02:10:53 INFO - PROCESS | 21889 | Browser inner width/height: 1024/697 02:10:53 INFO - PROCESS | 21889 | __metrics 02:10:54 ERROR - PROCESS | 21889 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:10:55 INFO - TEST-INFO | 21889: exit 0 02:10:55 INFO - Browser initialized. 02:10:55 INFO - Running cycle 1/1 for kraken test... 02:10:55 INFO - TEST-INFO | started process 21980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAbK8I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:07 INFO - PROCESS | 21980 | RSS: Main: 139534336 02:11:07 INFO - PROCESS | 21980 | 02:11:09 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-beat-detection) 02:11:10 INFO - PROCESS | 21980 | RSS: Main: 197660672 02:11:10 INFO - PROCESS | 21980 | 02:11:12 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-dft) 02:11:13 INFO - PROCESS | 21980 | RSS: Main: 184950784 02:11:13 INFO - PROCESS | 21980 | 02:11:16 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-fft) 02:11:16 INFO - PROCESS | 21980 | RSS: Main: 274538496 02:11:16 INFO - PROCESS | 21980 | 02:11:19 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34351/tests/kraken/driver.html?testName=audio-oscillator) 02:11:19 INFO - PROCESS | 21980 | RSS: Main: 180715520 02:11:19 INFO - PROCESS | 21980 | 02:11:21 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:11:22 INFO - PROCESS | 21980 | RSS: Main: 179318784 02:11:22 INFO - PROCESS | 21980 | 02:11:25 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34351/tests/kraken/driver.html?testName=imaging-darkroom) 02:11:25 INFO - PROCESS | 21980 | RSS: Main: 213381120 02:11:25 INFO - PROCESS | 21980 | 02:11:29 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34351/tests/kraken/driver.html?testName=imaging-desaturate) 02:11:29 INFO - PROCESS | 21980 | RSS: Main: 213680128 02:11:29 INFO - PROCESS | 21980 | 02:11:32 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34351/tests/kraken/driver.html?testName=json-parse-financial) 02:11:33 INFO - PROCESS | 21980 | RSS: Main: 212647936 02:11:33 INFO - PROCESS | 21980 | 02:11:34 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:11:35 INFO - PROCESS | 21980 | RSS: Main: 196517888 02:11:35 INFO - PROCESS | 21980 | 02:11:36 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:11:37 INFO - PROCESS | 21980 | RSS: Main: 200114176 02:11:37 INFO - PROCESS | 21980 | 02:11:39 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:11:40 INFO - PROCESS | 21980 | RSS: Main: 208994304 02:11:40 INFO - PROCESS | 21980 | 02:11:42 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:11:43 INFO - PROCESS | 21980 | RSS: Main: 216567808 02:11:43 INFO - PROCESS | 21980 | 02:11:45 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:11:46 INFO - PROCESS | 21980 | RSS: Main: 211251200 02:11:46 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | Cycle 1(1): loaded http://localhost:34351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34351/tests/kraken/driver.html?testName=ai-astar) 02:11:48 INFO - PROCESS | 21980 | RSS: Main: 271912960 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | __start_tp_report 02:11:48 INFO - PROCESS | 21980 | _x_x_mozilla_page_load 02:11:48 INFO - PROCESS | 21980 | _x_x_mozilla_page_load_details 02:11:48 INFO - PROCESS | 21980 | |i|pagename|runs| 02:11:48 INFO - PROCESS | 21980 | |0;ai-astar;110;111;111;113;111;110;104;111;110;110 02:11:48 INFO - PROCESS | 21980 | |1;audio-beat-detection;157;130;156;170;127;162;155;127;179;127 02:11:48 INFO - PROCESS | 21980 | |2;audio-dft;161;161;160;161;161;161;162;162;161;162 02:11:48 INFO - PROCESS | 21980 | |3;audio-fft;76;77;74;180;75;76;75;77;172;75 02:11:48 INFO - PROCESS | 21980 | |4;audio-oscillator;92;91;157;91;92;92;154;91;91;156 02:11:48 INFO - PROCESS | 21980 | |5;imaging-gaussian-blur;118;118;118;118;119;116;117;116;116;117 02:11:48 INFO - PROCESS | 21980 | |6;imaging-darkroom;145;146;145;146;145;146;145;145;145;145 02:11:48 INFO - PROCESS | 21980 | |7;imaging-desaturate;94;94;94;95;94;95;94;94;95;94 02:11:48 INFO - PROCESS | 21980 | |8;json-parse-financial;64;52;55;54;52;53;54;77;52;52 02:11:48 INFO - PROCESS | 21980 | |9;json-stringify-tinderbox;57;59;57;57;57;56;57;57;57;57 02:11:48 INFO - PROCESS | 21980 | |10;stanford-crypto-aes;72;79;72;72;75;73;72;74;73;74 02:11:48 INFO - PROCESS | 21980 | |11;stanford-crypto-ccm;117;115;112;114;113;113;115;112;130;136 02:11:48 INFO - PROCESS | 21980 | |12;stanford-crypto-pbkdf2;159;154;154;158;156;164;157;154;156;156 02:11:48 INFO - PROCESS | 21980 | |13;stanford-crypto-sha256-iterative;68;65;67;65;66;68;65;68;65;65 02:11:48 INFO - PROCESS | 21980 | __end_tp_report 02:11:48 INFO - PROCESS | 21980 | __start_cc_report 02:11:48 INFO - PROCESS | 21980 | _x_x_mozilla_cycle_collect,1577 02:11:48 INFO - PROCESS | 21980 | __end_cc_report 02:11:48 INFO - PROCESS | 21980 | __startTimestamp1467105108359__endTimestamp 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | ------- Summary: start ------- 02:11:48 INFO - PROCESS | 21980 | Number of tests: 14 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.33 (2.1%) stddev-sans-first:2.47 02:11:48 INFO - PROCESS | 21980 | Values: 110.0 111.0 111.0 113.0 111.0 110.0 104.0 111.0 110.0 110.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:156.50 stddev:19.64 (12.6%) stddev-sans-first:20.62 02:11:48 INFO - PROCESS | 21980 | Values: 157.0 130.0 156.0 170.0 127.0 162.0 155.0 127.0 179.0 127.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 02:11:48 INFO - PROCESS | 21980 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 162.0 162.0 161.0 162.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#3] audio-fft Cycles:10 Average:95.70 Median:75.50 stddev:42.37 (56.1%) stddev-sans-first:44.34 02:11:48 INFO - PROCESS | 21980 | Values: 76.0 77.0 74.0 180.0 75.0 76.0 75.0 77.0 172.0 75.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:91.00 stddev:31.04 (34.1%) stddev-sans-first:32.18 02:11:48 INFO - PROCESS | 21980 | Values: 92.0 91.0 157.0 91.0 92.0 92.0 154.0 91.0 91.0 156.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:118.00 stddev:1.06 (0.9%) stddev-sans-first:1.09 02:11:48 INFO - PROCESS | 21980 | Values: 118.0 118.0 118.0 118.0 119.0 116.0 117.0 116.0 116.0 117.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:11:48 INFO - PROCESS | 21980 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:11:48 INFO - PROCESS | 21980 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:54.00 stddev:8.06 (14.9%) stddev-sans-first:8.08 02:11:48 INFO - PROCESS | 21980 | Values: 64.0 52.0 55.0 54.0 52.0 53.0 54.0 77.0 52.0 52.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 02:11:48 INFO - PROCESS | 21980 | Values: 57.0 59.0 57.0 57.0 57.0 56.0 57.0 57.0 57.0 57.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.50 stddev:2.17 (3.0%) stddev-sans-first:2.22 02:11:48 INFO - PROCESS | 21980 | Values: 72.0 79.0 72.0 72.0 75.0 73.0 72.0 74.0 73.0 74.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:115.00 stddev:8.33 (7.2%) stddev-sans-first:8.83 02:11:48 INFO - PROCESS | 21980 | Values: 117.0 115.0 112.0 114.0 113.0 113.0 115.0 112.0 130.0 136.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:156.50 stddev:3.05 (1.9%) stddev-sans-first:3.13 02:11:48 INFO - PROCESS | 21980 | Values: 159.0 154.0 154.0 158.0 156.0 164.0 157.0 154.0 156.0 156.0 02:11:48 INFO - PROCESS | 21980 | 02:11:48 INFO - PROCESS | 21980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.40 (2.1%) stddev-sans-first:1.32 02:11:48 INFO - PROCESS | 21980 | Values: 68.0 65.0 67.0 65.0 66.0 68.0 65.0 68.0 65.0 65.0 02:11:48 INFO - PROCESS | 21980 | -------- Summary: end -------- 02:11:48 INFO - PROCESS | 21980 | 02:11:49 INFO - TEST-INFO | 21980: exit 0 02:11:49 INFO - TEST-OK | kraken | took 58800ms 02:11:49 INFO - SUITE-END | took 1168s 02:11:49 INFO - Completed test suite (00:19:28) 02:11:49 INFO - javascript benchmark 02:11:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.7510186735994, 3387.4072037393435, 3388.508666243394, 3413.8634454621815, 3431.0564594736443, 5597.888042239153, 5604.355499117602, 5631.8310450686495, 5637.267155269819, 5642.2382978297965, 5581.6371935824145, 5591.189277554752, 5594.58040646951, 5627.831165065044, 5641.717914104299, 4935.284383764352, 5078.847634570969, 5156.639035267514, 5210.0, 5247.0, 5033.572146367563, 5082.136036873721, 5112.003159383921, 5121.334226550562, 5123.410807757118, 4966.453690094087, 5035.320231768701, 5055.797768089272, 5056.620753443506, 5072.365954255718, 5083.288339632418, 5105.33630628016, 5106.183010718286, 5107.872303192413, 5110.64225504213, 4887.951120488785, 4973.701577905301, 5027.974860125676, 5047.369078865142, 5052.393712754456, 5393.352797664266, 5442.755076021588, 5452.809151679712, 5462.0, 5465.726713664301, 5913.349531551526, 5941.287045554561, 5943.4056594340655, 5943.821685349447, 5946.821595352147, 5945.910811337833, 5972.611780234271, 6080.612056351554, 6099.6950152492645, 6102.69486525672, 5514.24287856072, 5561.110222364402, 5562.666240025612, 5568.109102543614, 5579.107342825169, 5873.442023007808, 6077.6353418795015, 6079.300880398722, 6082.665453400017, 6087.66517841523, 5759.1937128802, 5837.124431335334, 5841.0, 5841.561882858802, 5851.0, 5999.5800293979, 6025.758969641253, 6028.668423236764, 6030.849228769228, 6033.336333003366, 5702.885942281131, 5822.854428639233, 5947.107933809876, 5962.791302304486, 5972.731227094791, 5936.376680448577, 5948.791792287249, 5956.970215148983, 5959.493443057302, 5997.0404735242155, 4549.681522293407, 4563.995920897397, 4565.931511027337, 4566.086782643484, 4596.678232523691, 3997.320455522568, 4016.196760647882, 4079.8164082616354, 4093.5906409358827, 4122.134351786159, 5737.426257374313, 5753.108268218432, 5756.740946657411, 5758.856028599319, 5761.3950535194035, 6025.939740602538, 6047.606905551125, 6051.7579296827635, 6054.545909056838, 6057.18228039209, 5654.434556544313, 5665.886682266331, 5669.943300566942, 5745.741441635137, 5757.8560535986935, 5124.436312005676, 5152.7166005869285, 5153.1497302945345, 5154.226865970059, 5156.329677142023, 6264.498840092781, 6290.842728931813, 6291.905621415683, 6297.96851015742, 6315.400036996478, 5846.327672317738, 5968.104784282393, 6031.819045428644, 6069.36271691466, 6075.878482430238, 6224.356350640455, 6246.281677607133, 6247.531435142473, 6260.217472815898, 6266.185395898504, 5791.710414479344, 5889.499392551681, 5897.233359663216, 5903.498202652822, 5940.287165540163, 5889.146073819186, 5941.970290148522, 5950.880982380241, 5982.7307771149535, 5990.071538911476, 5731.8853622928145, 5766.596338256281, 5778.133280008033, 5781.335146458211, 5786.855328616818, 5705.743241554057, 5725.885482290414, 5748.137779333133, 5766.221560089334, 5773.509251713652, 5700.0, 5723.284589426322, 5729.111987641755, 5731.942680573141, 5760.740766665594, 5832.037713777179, 5834.27071616048, 5834.649921004753, 5838.416158384128, 5839.8832023358445, 5515.558755299647, 5629.408912064175, 5710.5146062585145, 5728.570357223141, 5747.252857128714], "value": 5508.014363773234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.0308794528069, 669.5380187670507, 669.7890164598151, 686.9695456814779, 733.1495465260296, 32348.67651323486, 33312.0, 33327.66672333276, 33340.66659333412, 33350.8332458338, 33433.66566334336, 40739.388909166315, 41466.0, 41622.58377416225, 41647.791761041226, 8688.174623410781, 8836.248918841875, 8844.292456603489, 8849.646014159425, 8855.690050848221, 8126.918730812676, 8765.649374025032, 8887.911120888773, 8892.59983300753, 10688.786224275509, 10624.30941988772, 10723.678289651323, 10736.194785391088, 10739.0, 10740.409277489734, 10504.947475262652, 10596.31123976943, 10597.099246564052, 10598.311109777916, 10601.681949541526, 10438.112760415373, 10573.73565660857, 10574.10120139789, 10576.735581610521, 10581.153507719364, 39471.60528394708, 43284.783576082235, 43805.34291985623, 43818.0, 43847.34228986568, 3776.131489757344, 3811.790351530665, 3829.329867273216, 3956.6834653227675, 4055.6755459563165, 33665.0, 33759.6624033759, 34166.316673666384, 34816.65183348159, 35863.64136358629, 4555.134524440379, 4603.562661547147, 4608.815647374101, 4619.884502887421, 4643.535646435364, 339676.0, 340095.0, 340977.0, 343064.0, 343128.0, 39101.6089839098, 39846.0, 60740.69629651823, 61208.0, 61334.38665613376, 37838.24323513569, 37865.0, 37897.81051094727, 37954.0, 38004.8099759505, 17345.913270433568, 17509.124543773014, 17531.561710957074, 17533.0, 17544.912275438543, 14943.701125977419, 15058.397664093533, 15063.698726025417, 15106.848931510543, 15118.470853520073, 8797.516136612549, 9273.814523709489, 9421.576029078708, 9422.199113075329, 9477.620895164255, 3502.4746288056995, 3522.9295414091575, 3597.8201089945396, 3601.099725068733, 3648.087978005499, 1127.5884302229626, 1215.9574414895437, 1238.7027113492877, 1247.2391840976998, 1256.145820841818, 32613.184670382954, 32704.509432358533, 32868.0, 33023.0, 34742.30515389729, 1171.5723760827236, 1215.851020785367, 1233.9321337326353, 1241.8571864235548, 1268.689171153055, 16658.83341166597, 16663.16684165787, 16936.407225747287, 16936.915315423343, 17011.574710632332, 498458.0, 503185.0, 505047.0, 507039.0, 507774.0, 60234.0, 61007.6949615258, 61008.0, 61110.694446528374, 61216.387836121066, 1401.810755547988, 1535.9248526031822, 1551.1003617901365, 1622.529466454715, 1637.5414883832545, 30220.84889575538, 31391.0, 31677.20806979844, 31968.36063278768, 32450.513242301855, 47770.0, 59992.70003649954, 61573.38426615676, 61620.38379616146, 62150.37849621446, 319383.0, 321965.0, 323976.0, 325079.0, 325156.0, 38299.44584080826, 39025.6097439022, 45354.0, 46457.0, 46571.0, 44891.775541122086, 44913.550864490935, 45165.774171128935, 45560.0, 45699.543004570856, 38212.808935955145, 38532.0, 38873.61126388813, 38918.4162237561, 39155.804220978716, 37053.44419833651, 37290.0, 38449.0, 39799.403008955465, 41875.0, 42134.78932605317, 42562.0, 42960.35559466673, 43681.78159109184, 43915.78042109769, 35566.466503002994, 35807.0, 36864.26271474609, 36871.078223043565, 37228.81385593163, 28780.0, 28797.28006799847, 29018.323103891493, 29255.707442925297, 29503.704962950953], "value": 19743.184802329124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.28856454004074, 431.4175862585509, 439.8218721417825, 443.2497776379995, 444.3268448300823, 18557.907210463945, 18592.256309747594, 18861.15124819383, 19322.71015934762, 19365.709514357295, 18703.532411689714, 18800.34198803042, 19070.046497675095, 19183.0, 19185.424437266905, 5678.176664383672, 5748.5688573357165, 5965.194698715662, 5990.311114221855, 5991.041433370661, 5845.444682755132, 5907.616004959686, 5934.376890426508, 5940.257467816523, 5959.195508606326, 5640.492355687988, 5881.470667639912, 5914.852128696795, 5919.437653422918, 5922.763089476416, 5869.9706501467435, 5876.588638795286, 5903.49820265278, 5921.940780592182, 5938.287405511344, 5338.866528336823, 5350.38470575881, 5365.731713414352, 5607.663540187602, 5662.433756624346, 14368.20974846383, 14504.854951450456, 14579.19814410207, 21849.344519664435, 23290.417739556477, 2415.1426243683413, 2466.1245257933356, 2536.213773730131, 2756.462489814487, 2816.324082220273, 10264.486775661187, 10290.79418411635, 10445.79108417835, 10483.0, 10641.0, 1943.4655469745933, 2032.7560692716968, 2085.687146927973, 2118.5445129297123, 2168.826493880486, 74381.0, 79032.20967790305, 80456.59771701104, 81150.0, 82918.58540707258, 11011.889881101086, 11146.832797508045, 11179.60871369498, 11228.550857965753, 11279.548818047351, 16003.0, 16017.839821601869, 16094.114823684575, 16120.838791612168, 16163.191840407933, 8857.64569417229, 8888.511131887808, 8902.599383027778, 9032.8645070324, 9113.225375842994, 8903.643854245887, 8948.955255223813, 8957.641694332153, 8962.731118066338, 9043.77390565228, 4932.1861892788, 4965.106280869478, 5011.57401620859, 5045.5459008689395, 5049.788050867765, 2032.7560692716968, 2044.7239622650752, 2053.435305291027, 2061.917523299051, 2102.2957309301555, 987.1757082835912, 1056.0812093478569, 1089.362722807151, 1154.2382027861572, 1182.899453546441, 16628.6674266514, 18651.16069776863, 19486.902565487082, 19620.0, 19660.0, 1030.2324768047702, 1089.215764649451, 1125.234840308598, 1125.7410795517078, 1197.6287350921243, 8101.351891848638, 10975.945120274348, 11071.72320691989, 11077.335359878432, 11101.333919964827, 492875.0, 495508.0, 520462.0, 521726.0, 527739.0, 55809.0, 57500.13749793756, 64273.67863160654, 87074.56462717646, 89234.0, 1125.7692173104658, 1129.2941911305434, 1176.7528818947947, 1188.9762204755857, 1224.2837939805313, 12509.87490125087, 16149.838501614833, 16926.238319275417, 17262.65474690474, 17500.737488937422, 37783.81108094552, 38060.61939380682, 38362.0, 38434.6156538431, 39873.0, 51283.487165129365, 51605.22592161196, 51746.48253517567, 52056.21915671192, 52748.20877686761, 8681.739547813575, 8740.475571465733, 8864.20222180007, 8943.776405589912, 9079.0, 9290.95354523223, 11534.192606517463, 11550.595729149776, 11683.532658693557, 12098.516059357527, 10498.0, 10596.0, 10741.677749667522, 11076.889231107585, 11106.055985241344, 9982.201423886218, 10624.893751062391, 10634.680959571226, 10745.194110441591, 11020.283681560673, 10309.690709278733, 10790.514426850654, 10862.293950893167, 10958.917805616908, 11151.442427878736, 8177.4684645497855, 8405.537695426565, 8615.655373784979, 8621.482711037357, 8910.465372077697, 8574.09971952961, 10495.16038716916, 11034.393108379116, 11083.50124244427, 11258.493367798304], "value": 9168.238581352956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.1118051217989, 1550.5890938901189, 1557.7741227522006, 1796.7394727764474, 1948.3862583286264, 8221.09567947526, 8459.23866851984, 8486.44838085524, 8490.490570565771, 8508.191721786436, 8230.218129277724, 8466.534340611279, 8470.28002619778, 8481.406301558893, 8488.108748581402, 2389.366817793282, 2411.0837881605053, 2415.927522174338, 2416.069813121952, 2416.9758302417013, 2411.638254261857, 2436.2691192642224, 2460.2619214235747, 2473.6536884836137, 2478.529079474894, 2384.7972922301624, 2407.16952651335, 2412.7104747430335, 2417.1177520205088, 2424.709034915804, 2374.2877136858874, 2415.1546958564536, 2418.2503423938633, 2433.7809597136256, 2437.5612389769744, 2373.7982271506944, 2423.7939775119135, 2424.696912885889, 2434.561778879801, 2442.6336049592524, 7065.505414620979, 7208.675609597581, 8578.957105214497, 8657.134286571356, 8663.870041949376, 5186.818461353834, 5257.553107985826, 5294.391145018334, 5299.5760339172775, 5303.946960530422, 3367.9158021049425, 3390.983045084759, 3418.384690755663, 3459.3427248822895, 3520.9823950880336, 1121.624255874283, 1137.2721458266633, 1153.26191237608, 1161.773454176436, 1189.5301355964432, 11786.88213117875, 11966.34185119818, 12006.759864802742, 12341.629751107392, 12350.62948111558, 4672.813087476463, 4731.95268047322, 4762.357081793983, 4789.8323558675975, 4806.975965120152, 10369.118624916966, 10397.064264216257, 10406.739831504121, 10410.011048950337, 10414.479276036167, 5423.240746295522, 5435.130379139318, 5467.1799230115, 5469.124940009579, 5474.39781624021, 4943.307936888838, 4998.525140111684, 5003.849884503471, 5004.274380214922, 5006.6495345325475, 3883.2427676603356, 3895.9610403896163, 3910.7262491625884, 3993.7603743775467, 3996.18078293949, 1158.6002829023973, 1186.9287842729464, 1187.26389638423, 1192.1118766518998, 1197.22180582622, 939.196986576481, 1082.5940272397852, 1092.6776600902754, 1098.2531878322818, 1099.8405231241586, 5980.132880732356, 6088.482478989247, 6094.8171554853425, 6135.815925522242, 6152.815415537541, 958.5590628311055, 989.618996686281, 1052.8157572424795, 1053.6628278950661, 1089.0090018083506, 3590.4793804898145, 4206.0326124991425, 4209.158168366339, 4232.343986682069, 4289.270823959934, 9758.170555502862, 9979.351342162736, 9980.600775969026, 9981.45102019396, 9981.750456238507, 9588.424694518351, 9799.265055120895, 9832.115109640166, 9837.60649574009, 9860.45767482781, 7953.642086106139, 7990.360771138178, 8114.594270286462, 8138.0, 8153.22544358285, 5767.307923049261, 5887.4406931341455, 5940.8811823764145, 6025.125502634896, 6081.209442772411, 9142.405743626643, 9191.908080919105, 9481.905180948102, 9506.096920792514, 9506.096920792514, 9572.56923438433, 9630.296488985357, 9662.420254784736, 9878.407295562289, 10141.898581014095, 7590.506617069873, 7603.9619801902845, 7662.118856331594, 7694.345980591713, 7712.845743084995, 8153.388495862715, 8323.95838020806, 8344.207300306462, 8355.039170495227, 8364.665413383396, 7592.924070759443, 7634.50375725576, 7674.347680447225, 7724.382049435919, 7727.49771264866, 7308.890366644611, 7408.370288525536, 7523.1348394935285, 7525.3227209551405, 7681.0, 7028.226895041644, 7153.3919616833155, 7179.174394944648, 7183.712651493882, 7185.892211616934, 5292.179712144623, 5301.575873929999, 5312.760925758427, 5332.520073193431, 5398.7300634967305, 5336.412994570672, 5341.7062061586985, 5353.143497040455, 5386.515213630635, 5439.292891924025], "value": 4652.193512200685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.030766008796, 356.4546244246304, 365.636191988971, 367.1244082862373, 371.38350338438187, 6167.907481387771, 6169.25968883734, 6180.072989051644, 6181.350958149397, 6221.626702397859, 6106.572539922207, 6114.877702445949, 6115.633062016271, 6117.938820611793, 6130.1111338855835, 4563.840265590697, 4629.745364004978, 4693.249080147177, 4714.198586240347, 4721.669483136182, 4685.484596694361, 4706.5293470653005, 4712.19892618254, 4764.404449443819, 4774.594159496447, 4543.5002149763495, 4724.90550188996, 4742.90514189716, 4746.5490778376, 4747.786349614275, 4623.352730617717, 4640.535946405366, 4712.363830882821, 4760.880977975578, 4814.06125805468, 4231.640310573605, 4249.766262855542, 4250.744955302661, 4256.382824490463, 4266.2320782259185, 5973.044312909957, 5974.8506287342725, 5987.461128498412, 5991.221141251653, 5994.0, 5541.030319694038, 5543.473370029841, 5549.417311182348, 5555.2222688823595, 5559.305086864142, 6366.427021568081, 6500.512461565354, 6502.804915852532, 6503.869922601569, 6512.674366281667, 4677.087967846272, 4678.1813182692895, 4679.719216847, 4685.250359942427, 4686.9765651171865, 6776.0, 6793.966030169818, 6801.081853949703, 6810.5913645181445, 6817.7954661359745, 4802.471728109905, 4805.038992201574, 4805.255185446262, 4805.519448055236, 4810.7113573185725, 4858.17411040124, 4865.9756701216265, 4876.341693871282, 4876.658633895593, 4879.878003049952, 5532.197831314437, 5532.972335138379, 5535.7785688572, 5540.722963851791, 5543.556515478752, 6409.839754006187, 6569.80290591283, 6571.507136964747, 6584.637844918576, 6587.176602924635, 1696.2366934879353, 1713.2718594597247, 1718.8538974187084, 1723.8965662060066, 1726.3612463388627, 1064.7338165458636, 1128.2666266926399, 1152.251036826053, 1168.4975460551875, 1172.6657902497748, 6324.588901721373, 6527.575707579087, 6528.869422611521, 6551.21385433751, 6553.344665533408, 6881.071055407556, 6883.311668833177, 6884.586924784428, 6886.69009894556, 6895.620740859301, 6527.281998980108, 6532.248791388956, 6538.771143009972, 6546.214454265423, 6550.967245163743, 3653.451982202691, 3673.0, 3688.704903607705, 3694.538182727159, 3695.0947017980766, 6964.512484126164, 7159.427245820322, 7164.283571642898, 7178.676959536833, 7197.784066478014, 6922.41159501438, 6938.687759050855, 6941.444684425234, 6949.652517374111, 6955.547889387173, 7154.570725756471, 7175.892361614476, 7175.928240717631, 7184.712611495482, 7197.280271972865, 6833.282505336868, 6834.624095674786, 6836.38472537474, 6838.281980391987, 6842.144731908512, 6577.638229897401, 6684.732610695518, 6739.393454589111, 6761.425278851353, 6764.289749576224, 7113.502054856111, 7150.463715221275, 7175.246599107228, 7183.784486465414, 7184.389326907271, 4758.452777930583, 4759.23852183649, 4760.833370832004, 4762.9285560715925, 4764.285357196448, 6808.795736127924, 6819.965900170468, 6821.590704557742, 6826.078479405217, 6832.760853370109, 6490.545661803629, 6617.43751781104, 6632.204135503771, 6649.767258145942, 6664.466842652673, 6586.176727909012, 6624.0, 6633.170853643294, 6638.5684930479365, 6639.966800165968, 6503.057056726653, 6520.021996700533, 6523.7716679915975, 6525.608463492205, 6532.608043517404, 6681.599104053772, 6686.899696504459, 6688.598684078971, 6696.56023954852, 6699.698513566804, 6372.394622510854, 6525.804225873231, 6533.281339052795, 6550.705218265094, 6552.475801935739], "value": 5017.050997581649, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.0739283092183, 848.2577744473585, 855.6406309350073, 889.8220355928814, 901.5086777706149, 15128.546143615682, 16719.916400417995, 17178.742318865196, 17305.826941730596, 17306.307747690076, 15810.288537015833, 15862.84137158628, 15867.365305387772, 15888.046717196976, 15919.44281950132, 758.1887380502836, 895.122779675918, 901.0, 915.0346384564282, 921.7925966657516, 900.1268769293807, 906.8095699903029, 910.6630546697731, 911.4030310146832, 912.4570880326195, 928.0441145620022, 928.340877976634, 933.8459154239576, 935.9344845860759, 942.0955882352949, 782.7573452229827, 932.0586207929972, 944.8724422203018, 953.5518306395983, 961.9855702164473, 695.6452209373256, 698.5668885291101, 699.1295836683362, 700.8668353012962, 702.8594281143792, 15082.170480623561, 15264.923675381551, 15293.923530382388, 15294.541163765105, 15301.770473442908, 14499.347529361205, 14838.406463741438, 14897.0, 14914.62713432162, 14938.701225975528, 12284.262944223286, 12501.687457813536, 12513.37433128349, 12516.3741812909, 12560.057995650362, 4050.1494686115952, 4060.614241647039, 4063.8258531685406, 4115.135821477494, 4115.9588404115875, 57944.0, 58211.0, 58374.0, 58724.0, 59634.40365596332, 12046.879531204575, 12089.455974481169, 12203.20679155852, 12405.875941240653, 12412.0, 21748.347549573537, 21844.89077554602, 21855.562888742137, 21882.234121805977, 21894.562108757735, 8917.242034427016, 8958.74068757273, 9073.183413492818, 9175.495347755937, 9503.04969503058, 4840.080384726891, 4848.345473361122, 4859.34398856157, 4925.679830810986, 5015.874603134878, 3595.838187281526, 3637.836297366625, 3642.817859107087, 3646.5624125105155, 3652.981735091361, 644.6003477843673, 648.503894520692, 651.5862427358661, 663.3499170812535, 664.02720015178, 786.1862971824135, 815.5595978171721, 817.440053563311, 821.8784234607062, 838.1241602525254, 10269.229807764448, 10433.21750868688, 10466.372017678963, 10688.14494840411, 10748.355098694103, 759.5860256160406, 855.2901092093548, 861.0497223788125, 864.9740507784777, 869.2046777198918, 4797.736124513115, 4911.852644420673, 4954.653174277766, 4978.875528111754, 4986.8753281168265, 55471.44528554663, 56358.0, 56771.0, 57172.42827571754, 67561.3243867555, 49101.0, 49135.26297105546, 49667.0, 49693.503064968885, 50066.499335006185, 45690.77154614272, 45784.54215457803, 45870.770646147226, 46058.0, 46446.0, 10230.335028223439, 10294.330868493524, 10357.987636406777, 10396.896031039592, 10449.21630877672, 39100.217995640494, 39791.403128953665, 40041.398344065914, 40055.0, 40580.59419405886, 46442.0, 47832.52167478281, 49866.25200622066, 50132.248016280515, 50823.0, 13076.215427074407, 13156.802647960098, 13182.209067455984, 13258.668533286746, 13352.0, 14250.283411632303, 14378.568642940729, 14472.342722347417, 14561.635959101108, 14712.264386780404, 12844.10091293638, 12999.1550549214, 13284.202947823162, 13321.267330296927, 13360.732785344433, 12975.416106275428, 13255.536056237985, 13301.600951971457, 13369.465221391425, 14507.0, 13442.93278533601, 13511.121777084458, 13750.931245344109, 13785.793213101611, 13953.511627093003, 11637.243579167327, 11725.472353743931, 11932.105092117952, 12060.698482537655, 12462.189957652723, 11049.226554141133, 11297.209195356574, 11559.30644161353, 11664.708382290171, 11683.415829208676], "value": 7315.448122089221, "unit": "score"}], "name": "dromaeo_css", "value": 7444.6990417186125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 113.0, 111.0, 110.0, 104.0, 111.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 156.0, 170.0, 127.0, 162.0, 155.0, 127.0, 179.0, 127.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 180.0, 75.0, 76.0, 75.0, 77.0, 172.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 157.0, 91.0, 92.0, 92.0, 154.0, 91.0, 91.0, 156.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 52.0, 55.0, 54.0, 52.0, 53.0, 54.0, 77.0, 52.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 72.0, 72.0, 75.0, 73.0, 72.0, 74.0, 73.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 112.0, 114.0, 113.0, 113.0, 115.0, 112.0, 130.0, 136.0], "value": 117.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 154.0, 158.0, 156.0, 164.0, 157.0, 154.0, 156.0, 156.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 65.0, 66.0, 68.0, 65.0, 68.0, 65.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1511.4999999999998, "alertThreshold": 2.0}]} 02:11:49 INFO - Return code: 0 02:11:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:11:49 ERROR - # TBPL SUCCESS # 02:11:49 INFO - Running post-action listener: _resource_record_post_action 02:11:49 INFO - Running post-run listener: _resource_record_post_run 02:11:50 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 454467584; Read time: 0; Write time: 294996 02:11:50 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242421760; Read time: 0; Write time: 197168 02:11:50 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 211509248; Read time: 0; Write time: 97828 02:11:50 INFO - Running post-run listener: _upload_blobber_files 02:11:50 INFO - Blob upload gear active. 02:11:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:11:50 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 02:11:50 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'] 02:11:50 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 02:11:51 INFO - (blobuploader) - INFO - Open directory for files ... 02:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:51 INFO - (blobuploader) - INFO - Done attempting. 02:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:52 INFO - (blobuploader) - INFO - Done attempting. 02:11:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:11:52 INFO - Return code: 0 02:11:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:11:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:11:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bc71231d78abf214e4d51250b150624e60ab28c5d74ae673444c960f1e207f4ea43170954233e01b94d19082f50738ef95c573e5cfd23041034d2c97357b8d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63e6a51b971f3fda26b4d327c8d04726093ae9ecaabb05ff23d5350f9cc007a4967d48a32952eb7d3eef16f5a09c93fe8ab0cae6decb76088dd6cbb54718f0ff"} 02:11:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:11:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:11:52 INFO - Contents: 02:11:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bc71231d78abf214e4d51250b150624e60ab28c5d74ae673444c960f1e207f4ea43170954233e01b94d19082f50738ef95c573e5cfd23041034d2c97357b8d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63e6a51b971f3fda26b4d327c8d04726093ae9ecaabb05ff23d5350f9cc007a4967d48a32952eb7d3eef16f5a09c93fe8ab0cae6decb76088dd6cbb54718f0ff"} 02:11:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:11:52 INFO - Copying logs to upload dir... 02:11:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:11:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.089975 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-28 02:11:52.265536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:52.271633) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445 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/6bc71231d78abf214e4d51250b150624e60ab28c5d74ae673444c960f1e207f4ea43170954233e01b94d19082f50738ef95c573e5cfd23041034d2c97357b8d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63e6a51b971f3fda26b4d327c8d04726093ae9ecaabb05ff23d5350f9cc007a4967d48a32952eb7d3eef16f5a09c93fe8ab0cae6decb76088dd6cbb54718f0ff"} build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bc71231d78abf214e4d51250b150624e60ab28c5d74ae673444c960f1e207f4ea43170954233e01b94d19082f50738ef95c573e5cfd23041034d2c97357b8d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63e6a51b971f3fda26b4d327c8d04726093ae9ecaabb05ff23d5350f9cc007a4967d48a32952eb7d3eef16f5a09c93fe8ab0cae6decb76088dd6cbb54718f0ff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:52.297713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:52.298076) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467103581.501897-2042778445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:52.380370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:11:52.380697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:11:52.381232) ========= ========= Total master_lag: 0.17 =========