builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1467103889.95 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.954093) ========= 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.954500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:29.954809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.017196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.017496) ========= 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=232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-06-28 01:51:30 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077047 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.190153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.190489) ========= 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=232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017404 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.254620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.258308) ========= 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=232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 01:51:30,798 truncating revision to first 12 chars 2016-06-28 01:51:30,798 Setting DEBUG logging. 2016-06-28 01:51:30,798 attempt 1/10 2016-06-28 01:51:30,798 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,119 unpacking tar archive at: mozilla-beta-676a32cdd41f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.971544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.971879) ========= script_repo_revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.972308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.972608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.989978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-28 01:51:30.990316) ========= /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=232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339 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-025', 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": 280, 01:51:32 INFO - "slavename": "talos-linux64-ix-025", 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:34 INFO - Downloaded 1327 bytes. 01:51:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:34 INFO - Using the following test package requirements: 01:51:34 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:51:34 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:51:34 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 01:51:34 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'jsshell-linux-x86_64.zip'], 01:51:34 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:51:34 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:51:34 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 01:51:34 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 01:51:34 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:51:34 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:34 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:51:34 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:34 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:34 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:34 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:34 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:34 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:35 INFO - Downloaded 24236181 bytes. 01:51:35 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:35 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:36 INFO - Return code: 0 01:51:36 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:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:36 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:36 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:36 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:36 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:36 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:38 INFO - Downloaded 24236181 bytes. 01:51:38 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:38 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: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:51:39 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:40 INFO - Downloaded 10840145 bytes. 01:51:40 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:40 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:40 INFO - Return code: 0 01:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:40 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:40 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:40 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:40 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:40 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:41 INFO - Downloaded 56013298 bytes. 01:51:41 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:41 INFO - mkdir: /builds/slave/test/properties 01:51:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:51:41 INFO - Writing to file /builds/slave/test/properties/build_url 01:51:41 INFO - Contents: 01:51:41 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:42 INFO - Running post-action listener: _resource_record_post_action 01:51:42 INFO - Running post-action listener: set_extra_try_arguments 01:51:42 INFO - ##### 01:51:42 INFO - ##### Running populate-webroot step. 01:51:42 INFO - ##### 01:51:42 INFO - Running pre-action listener: _resource_record_pre_action 01:51:42 INFO - Running main action method: populate_webroot 01:51:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:51:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:51:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:51:42 INFO - '--tppagecycles', 01:51:42 INFO - '7'], 01:51:42 INFO - 'tests': ['tsvgm']}}, 01:51:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:51:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:51:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:51:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:51:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['damp', 'tps']}, 01:51:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'tests': ['damp', 'tps']}, 01:51:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['dromaeo_dom']}, 01:51:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:51:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['a11yr', 01:51:42 INFO - 'ts_paint', 01:51:42 INFO - 'tpaint', 01:51:42 INFO - 'sessionrestore', 01:51:42 INFO - 'sessionrestore_no_auto_restore', 01:51:42 INFO - 'tabpaint']}, 01:51:42 INFO - 'other-e10s': {'tests': ['a11yr', 01:51:42 INFO - 'ts_paint', 01:51:42 INFO - 'tpaint', 01:51:42 INFO - 'sessionrestore', 01:51:42 INFO - 'sessionrestore_no_auto_restore', 01:51:42 INFO - 'tabpaint']}, 01:51:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:51:42 INFO - 'ts_paint', 01:51:42 INFO - 'tpaint', 01:51:42 INFO - 'sessionrestore', 01:51:42 INFO - 'sessionrestore_no_auto_restore', 01:51:42 INFO - 'tabpaint']}, 01:51:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:51:42 INFO - 'ts_paint', 01:51:42 INFO - 'tpaint', 01:51:42 INFO - 'sessionrestore', 01:51:42 INFO - 'sessionrestore_no_auto_restore', 01:51:42 INFO - 'tabpaint']}, 01:51:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['a11yr', 01:51:42 INFO - 'ts_paint', 01:51:42 INFO - 'tpaint', 01:51:42 INFO - 'sessionrestore', 01:51:42 INFO - 'sessionrestore_no_auto_restore', 01:51:42 INFO - 'tabpaint']}, 01:51:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['a11yr', 01:51:42 INFO - 'ts_paint', 01:51:42 INFO - 'tpaint', 01:51:42 INFO - 'sessionrestore', 01:51:42 INFO - 'sessionrestore_no_auto_restore', 01:51:42 INFO - 'tabpaint']}, 01:51:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['tsvgx', 01:51:42 INFO - 'tsvgr_opacity', 01:51:42 INFO - 'tart', 01:51:42 INFO - 'tscrollx', 01:51:42 INFO - 'cart']}, 01:51:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:51:42 INFO - 'tsvgr_opacity', 01:51:42 INFO - 'tart', 01:51:42 INFO - 'tscrollx', 01:51:42 INFO - 'cart']}, 01:51:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'talos_options': ['--disable-e10s'], 01:51:42 INFO - 'tests': ['tp5o']}, 01:51:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'tests': ['tp5o']}, 01:51:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'talos_options': ['--disable-e10s', 01:51:42 INFO - '--xperf_path', 01:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:42 INFO - 'tests': ['tp5n']}, 01:51:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:42 INFO - 'talos_options': ['--xperf_path', 01:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:42 INFO - 'tests': ['tp5n']}}, 01:51:42 INFO - 'talos.zip': {'path': '', 01:51:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:51:42 INFO - Running post-action listener: _resource_record_post_action 01:51:42 INFO - ##### 01:51:42 INFO - ##### Running create-virtualenv step. 01:51:42 INFO - ##### 01:51:42 INFO - Running pre-action listener: _resource_record_pre_action 01:51:42 INFO - Running main action method: create_virtualenv 01:51:42 INFO - Creating virtualenv /builds/slave/test/build/venv 01:51:42 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:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:51:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:51:42 INFO - Using real prefix '/usr' 01:51:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:51:43 INFO - Installing distribute.............................................................................................................................................................................................done. 01:51:45 INFO - Installing pip.................done. 01:51:45 INFO - Return code: 0 01:51:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:51:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:45 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 01:51:45 INFO - 'HOME': '/home/cltbld', 01:51:45 INFO - 'LANG': 'en_US.UTF-8', 01:51:45 INFO - 'LANGUAGE': 'en_US:en', 01:51:45 INFO - 'LOGNAME': 'cltbld', 01:51:45 INFO - 'MAIL': '/var/mail/cltbld', 01:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:45 INFO - 'MOZ_NO_REMOTE': '1', 01:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:45 INFO - 'NO_EM_RESTART': '1', 01:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:45 INFO - 'PWD': '/builds/slave/test', 01:51:45 INFO - 'SHELL': '/bin/bash', 01:51:45 INFO - 'SHLVL': '1', 01:51:45 INFO - 'TERM': 'linux', 01:51:45 INFO - 'TMOUT': '86400', 01:51:45 INFO - 'USER': 'cltbld', 01:51:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:45 INFO - '_': '/tools/buildbot/bin/python'} 01:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:45 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:45 INFO - Cleaning up... 01:51:45 INFO - Return code: 0 01:51:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:51:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:45 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 01:51:45 INFO - 'HOME': '/home/cltbld', 01:51:45 INFO - 'LANG': 'en_US.UTF-8', 01:51:45 INFO - 'LANGUAGE': 'en_US:en', 01:51:45 INFO - 'LOGNAME': 'cltbld', 01:51:45 INFO - 'MAIL': '/var/mail/cltbld', 01:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:45 INFO - 'MOZ_NO_REMOTE': '1', 01:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:45 INFO - 'NO_EM_RESTART': '1', 01:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:45 INFO - 'PWD': '/builds/slave/test', 01:51:45 INFO - 'SHELL': '/bin/bash', 01:51:45 INFO - 'SHLVL': '1', 01:51:45 INFO - 'TERM': 'linux', 01:51:45 INFO - 'TMOUT': '86400', 01:51:45 INFO - 'USER': 'cltbld', 01:51:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:45 INFO - '_': '/tools/buildbot/bin/python'} 01:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:45 INFO - Downloading/unpacking psutil>=0.7.1 01:51:45 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:45 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:45 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:45 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:45 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:45 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 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 - Installing collected packages: psutil 01:51:47 INFO - Running setup.py install for psutil 01:51:47 INFO - building 'psutil._psutil_linux' extension 01:51:47 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:48 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:48 INFO - building 'psutil._psutil_posix' extension 01:51:48 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:48 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:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:48 INFO - Successfully installed psutil 01:51:48 INFO - Cleaning up... 01:51:48 INFO - Return code: 0 01:51:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:51:48 INFO - Using env: {'DISPLAY': ':0', 01:51:48 INFO - 'HOME': '/home/cltbld', 01:51:48 INFO - 'LANG': 'en_US.UTF-8', 01:51:48 INFO - 'LANGUAGE': 'en_US:en', 01:51:48 INFO - 'LOGNAME': 'cltbld', 01:51:48 INFO - 'MAIL': '/var/mail/cltbld', 01:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:48 INFO - 'MOZ_NO_REMOTE': '1', 01:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:48 INFO - 'NO_EM_RESTART': '1', 01:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:48 INFO - 'PWD': '/builds/slave/test', 01:51:48 INFO - 'SHELL': '/bin/bash', 01:51:48 INFO - 'SHLVL': '1', 01:51:48 INFO - 'TERM': 'linux', 01:51:48 INFO - 'TMOUT': '86400', 01:51:48 INFO - 'USER': 'cltbld', 01:51:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:48 INFO - '_': '/tools/buildbot/bin/python'} 01:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:51:50 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:50 INFO - Installing collected packages: mozsystemmonitor 01:51:50 INFO - Running setup.py install for mozsystemmonitor 01:51:50 INFO - Successfully installed mozsystemmonitor 01:51:50 INFO - Cleaning up... 01:51:50 INFO - Return code: 0 01:51:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:51:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:50 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 01:51:50 INFO - 'HOME': '/home/cltbld', 01:51:50 INFO - 'LANG': 'en_US.UTF-8', 01:51:50 INFO - 'LANGUAGE': 'en_US:en', 01:51:50 INFO - 'LOGNAME': 'cltbld', 01:51:50 INFO - 'MAIL': '/var/mail/cltbld', 01:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:50 INFO - 'MOZ_NO_REMOTE': '1', 01:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:50 INFO - 'NO_EM_RESTART': '1', 01:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:50 INFO - 'PWD': '/builds/slave/test', 01:51:50 INFO - 'SHELL': '/bin/bash', 01:51:50 INFO - 'SHLVL': '1', 01:51:50 INFO - 'TERM': 'linux', 01:51:50 INFO - 'TMOUT': '86400', 01:51:50 INFO - 'USER': 'cltbld', 01:51:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:50 INFO - '_': '/tools/buildbot/bin/python'} 01:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:51:50 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:50 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:50 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:50 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:50 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:50 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 blobuploader-1.2.4.tar.gz 01:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:51:52 INFO - Downloading/unpacking requests==1.2.3. (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:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:51:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:51:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading docopt-0.6.1.tar.gz 01:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:51:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:51:53 INFO - Running setup.py install for blobuploader 01:51:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:51:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:51:53 INFO - Running setup.py install for requests 01:51:53 INFO - Running setup.py install for docopt 01:51:53 INFO - Successfully installed blobuploader requests docopt 01:51:53 INFO - Cleaning up... 01:51:54 INFO - Return code: 0 01:51:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:54 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 01:51:54 INFO - 'HOME': '/home/cltbld', 01:51:54 INFO - 'LANG': 'en_US.UTF-8', 01:51:54 INFO - 'LANGUAGE': 'en_US:en', 01:51:54 INFO - 'LOGNAME': 'cltbld', 01:51:54 INFO - 'MAIL': '/var/mail/cltbld', 01:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:54 INFO - 'MOZ_NO_REMOTE': '1', 01:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:54 INFO - 'NO_EM_RESTART': '1', 01:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:54 INFO - 'PWD': '/builds/slave/test', 01:51:54 INFO - 'SHELL': '/bin/bash', 01:51:54 INFO - 'SHLVL': '1', 01:51:54 INFO - 'TERM': 'linux', 01:51:54 INFO - 'TMOUT': '86400', 01:51:54 INFO - 'USER': 'cltbld', 01:51:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:54 INFO - '_': '/tools/buildbot/bin/python'} 01:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:51:54 INFO - Running setup.py (path:/tmp/pip-9enTuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:51:54 INFO - Running setup.py (path:/tmp/pip-RXUFeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:51:54 INFO - Running setup.py (path:/tmp/pip-dG3vUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:51:54 INFO - Running setup.py (path:/tmp/pip-iLkB2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:51:54 INFO - Running setup.py (path:/tmp/pip-EgaZGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:51:54 INFO - Running setup.py (path:/tmp/pip-gJp2VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:51:54 INFO - Running setup.py (path:/tmp/pip-8iQ98w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:51:54 INFO - Running setup.py (path:/tmp/pip-21wVlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:51:54 INFO - Running setup.py (path:/tmp/pip-aEohTn-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-4YVaOm-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-4Lj12N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:51:55 INFO - Running setup.py (path:/tmp/pip-yD6lMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:51:55 INFO - Running setup.py (path:/tmp/pip-JK4eWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:51:55 INFO - Running setup.py (path:/tmp/pip-8PAW8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:55 INFO - Running setup.py (path:/tmp/pip-FHqGfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:51:55 INFO - Running setup.py (path:/tmp/pip-SeiSrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:51:55 INFO - Running setup.py (path:/tmp/pip-16iK_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:51:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:51:55 INFO - Running setup.py install for manifestparser 01:51:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:51:55 INFO - Running setup.py install for mozcrash 01:51:55 INFO - Running setup.py install for mozdebug 01:51:55 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:56 INFO - Running setup.py install for mozhttpd 01:51:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Running setup.py install for mozinfo 01:51:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Running setup.py install for mozInstall 01:51:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Running setup.py install for mozleak 01:51:56 INFO - Running setup.py install for mozlog 01:51:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Running setup.py install for moznetwork 01:51:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Running setup.py install for mozprocess 01:51:56 INFO - Running setup.py install for mozprofile 01:51:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:51:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:51:56 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:57 INFO - Running setup.py install for moztest 01:51:57 INFO - Running setup.py install for mozversion 01:51:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:51:57 INFO - Cleaning up... 01:51:57 INFO - Return code: 0 01:51:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:57 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 01:51:57 INFO - 'HOME': '/home/cltbld', 01:51:57 INFO - 'LANG': 'en_US.UTF-8', 01:51:57 INFO - 'LANGUAGE': 'en_US:en', 01:51:57 INFO - 'LOGNAME': 'cltbld', 01:51:57 INFO - 'MAIL': '/var/mail/cltbld', 01:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:57 INFO - 'MOZ_NO_REMOTE': '1', 01:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:57 INFO - 'NO_EM_RESTART': '1', 01:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:57 INFO - 'PWD': '/builds/slave/test', 01:51:57 INFO - 'SHELL': '/bin/bash', 01:51:57 INFO - 'SHLVL': '1', 01:51:57 INFO - 'TERM': 'linux', 01:51:57 INFO - 'TMOUT': '86400', 01:51:57 INFO - 'USER': 'cltbld', 01:51:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:57 INFO - '_': '/tools/buildbot/bin/python'} 01:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:51:57 INFO - Running setup.py (path:/tmp/pip-AnO680-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:51:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:51:57 INFO - Running setup.py (path:/tmp/pip-bqnUsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:51:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:51:57 INFO - Running setup.py (path:/tmp/pip-vuA9zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:51:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:51:57 INFO - Running setup.py (path:/tmp/pip-pceFn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:51:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:51:57 INFO - Running setup.py (path:/tmp/pip-33EEPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:51:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:51:57 INFO - Running setup.py (path:/tmp/pip-yxEuAR-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-GR4RAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:51:58 INFO - Running setup.py (path:/tmp/pip-_4XbEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:51:58 INFO - Running setup.py (path:/tmp/pip-2UN3bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:51:58 INFO - Running setup.py (path:/tmp/pip-7P_ic4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:51:58 INFO - Running setup.py (path:/tmp/pip-iEI8p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:51:58 INFO - Running setup.py (path:/tmp/pip-FZtimh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:51:58 INFO - Running setup.py (path:/tmp/pip-S9X17p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:51:58 INFO - Running setup.py (path:/tmp/pip-EYT1Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:58 INFO - Running setup.py (path:/tmp/pip-uCgw_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:51:58 INFO - Running setup.py (path:/tmp/pip-JcLNyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:51:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:51:58 INFO - Running setup.py (path:/tmp/pip-gLOSHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:51:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:51:58 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:58 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:58 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:58 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:58 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:58 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 - Downloading blessings-1.6.tar.gz 01:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:00 INFO - Installing collected packages: blessings 01:52:00 INFO - Running setup.py install for blessings 01:52:00 INFO - Successfully installed blessings 01:52:00 INFO - Cleaning up... 01:52:00 INFO - Return code: 0 01:52:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:52:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:01 INFO - Reading from file tmpfile_stdout 01:52:01 INFO - Current package versions: 01:52:01 INFO - argparse == 1.2.1 01:52:01 INFO - blessings == 1.6 01:52:01 INFO - blobuploader == 1.2.4 01:52:01 INFO - docopt == 0.6.1 01:52:01 INFO - manifestparser == 1.1 01:52:01 INFO - mozInstall == 1.12 01:52:01 INFO - mozcrash == 0.17 01:52:01 INFO - mozdebug == 0.1 01:52:01 INFO - mozdevice == 0.48 01:52:01 INFO - mozfile == 1.2 01:52:01 INFO - mozhttpd == 0.7 01:52:01 INFO - mozinfo == 0.9 01:52:01 INFO - mozleak == 0.1 01:52:01 INFO - mozlog == 3.1 01:52:01 INFO - moznetwork == 0.27 01:52:01 INFO - mozprocess == 0.22 01:52:01 INFO - mozprofile == 0.28 01:52:01 INFO - mozrunner == 6.11 01:52:01 INFO - mozscreenshot == 0.1 01:52:01 INFO - mozsystemmonitor == 0.0 01:52:01 INFO - moztest == 0.7 01:52:01 INFO - mozversion == 1.4 01:52:01 INFO - psutil == 3.1.1 01:52:01 INFO - requests == 1.2.3 01:52:01 INFO - wsgiref == 0.1.2 01:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:01 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 01:52:01 INFO - 'HOME': '/home/cltbld', 01:52:01 INFO - 'LANG': 'en_US.UTF-8', 01:52:01 INFO - 'LANGUAGE': 'en_US:en', 01:52:01 INFO - 'LOGNAME': 'cltbld', 01:52:01 INFO - 'MAIL': '/var/mail/cltbld', 01:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:01 INFO - 'MOZ_NO_REMOTE': '1', 01:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:01 INFO - 'NO_EM_RESTART': '1', 01:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:01 INFO - 'PWD': '/builds/slave/test', 01:52:01 INFO - 'SHELL': '/bin/bash', 01:52:01 INFO - 'SHLVL': '1', 01:52:01 INFO - 'TERM': 'linux', 01:52:01 INFO - 'TMOUT': '86400', 01:52:01 INFO - 'USER': 'cltbld', 01:52:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:01 INFO - '_': '/tools/buildbot/bin/python'} 01:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:01 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:01 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:01 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:01 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:01 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:01 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:01 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:01 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:01 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:01 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:01 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:01 INFO - Cleaning up... 01:52:01 INFO - Return code: 0 01:52:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:01 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 01:52:01 INFO - 'HOME': '/home/cltbld', 01:52:01 INFO - 'LANG': 'en_US.UTF-8', 01:52:01 INFO - 'LANGUAGE': 'en_US:en', 01:52:01 INFO - 'LOGNAME': 'cltbld', 01:52:01 INFO - 'MAIL': '/var/mail/cltbld', 01:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:01 INFO - 'MOZ_NO_REMOTE': '1', 01:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:01 INFO - 'NO_EM_RESTART': '1', 01:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:01 INFO - 'PWD': '/builds/slave/test', 01:52:01 INFO - 'SHELL': '/bin/bash', 01:52:01 INFO - 'SHLVL': '1', 01:52:01 INFO - 'TERM': 'linux', 01:52:01 INFO - 'TMOUT': '86400', 01:52:01 INFO - 'USER': 'cltbld', 01:52:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:01 INFO - '_': '/tools/buildbot/bin/python'} 01:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:01 INFO - Downloading/unpacking jsonschema 01:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:03 INFO - Downloading/unpacking functools32 (from jsonschema) 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:03 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:03 INFO - warning: no files found matching '*.txt' 01:52:03 INFO - no previously-included directories found matching 'build' 01:52:03 INFO - no previously-included directories found matching 'dist' 01:52:03 INFO - no previously-included directories found matching '.git*' 01:52:03 INFO - Installing collected packages: jsonschema, functools32 01:52:03 INFO - Running setup.py install for functools32 01:52:03 INFO - warning: no files found matching '*.txt' 01:52:03 INFO - no previously-included directories found matching 'build' 01:52:03 INFO - no previously-included directories found matching 'dist' 01:52:03 INFO - no previously-included directories found matching '.git*' 01:52:03 INFO - Successfully installed jsonschema functools32 01:52:03 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 0x7f4b48a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', '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': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:03 INFO - '_': '/tools/buildbot/bin/python'} 01:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:04 INFO - Downloading/unpacking flake8 01:52:04 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:04 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:04 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:04 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:04 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:04 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:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:52:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:52:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:52:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:52:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:52:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:06 INFO - no previously-included directories found matching 'docs/_build' 01:52:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:52:06 INFO - Running setup.py install for pep8 01:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:06 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:07 INFO - Return code: 0 01:52:07 INFO - Running post-action listener: _resource_record_post_action 01:52:07 INFO - Running post-action listener: _start_resource_monitoring 01:52:07 INFO - Starting resource monitoring. 01:52:07 INFO - ##### 01:52:07 INFO - ##### Running install step. 01:52:07 INFO - ##### 01:52:07 INFO - Running pre-action listener: _resource_record_pre_action 01:52:07 INFO - Running main action method: install 01:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:07 INFO - Reading from file tmpfile_stdout 01:52:07 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:52:07 INFO - Reading from file tmpfile_stdout 01:52:07 INFO - Output received: 01:52:07 INFO - Usage: mozinstall [options] installer 01:52:07 INFO - Options: 01:52:07 INFO - -h, --help show this help message and exit 01:52:07 INFO - -d DEST, --destination=DEST 01:52:07 INFO - Directory to install application into. [default: 01:52:07 INFO - "/builds/slave/test"] 01:52:07 INFO - --app=APP Application being installed. [default: firefox] 01:52:07 INFO - mkdir: /builds/slave/test/build/application 01:52:07 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:07 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:20 INFO - Reading from file tmpfile_stdout 01:52:20 INFO - Output received: 01:52:20 INFO - /builds/slave/test/build/application/firefox/firefox 01:52:20 INFO - Running post-action listener: _resource_record_post_action 01:52:20 INFO - ##### 01:52:20 INFO - ##### Running run-tests step. 01:52:20 INFO - ##### 01:52:20 INFO - Running pre-action listener: _resource_record_pre_action 01:52:20 INFO - Running main action method: run_tests 01:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:52:20 INFO - Python 2.7.3 01:52:20 INFO - Return code: 0 01:52:20 INFO - grabbing minidump binary from tooltool 01:52:20 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:20 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 0xf62410>, '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 0xf63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf637a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:52:20 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:20 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:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:52:20 INFO - Return code: 0 01:52:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:52:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:52:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:52:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:52:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:52:21 INFO - Return code: 0 01:52:21 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-025', '--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:21 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-025 --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:21 INFO - Using env: {'DISPLAY': ':0', 01:52:21 INFO - 'HOME': '/home/cltbld', 01:52:21 INFO - 'LANG': 'en_US.UTF-8', 01:52:21 INFO - 'LANGUAGE': 'en_US:en', 01:52:21 INFO - 'LOGNAME': 'cltbld', 01:52:21 INFO - 'MAIL': '/var/mail/cltbld', 01:52:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:52:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:21 INFO - 'MOZ_NO_REMOTE': '1', 01:52:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:21 INFO - 'NO_EM_RESTART': '1', 01:52:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:21 INFO - 'PWD': '/builds/slave/test', 01:52:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:52:21 INFO - 'SHELL': '/bin/bash', 01:52:21 INFO - 'SHLVL': '1', 01:52:21 INFO - 'TERM': 'linux', 01:52:21 INFO - 'TMOUT': '86400', 01:52:21 INFO - 'USER': 'cltbld', 01:52:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339', 01:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:21 INFO - '_': '/tools/buildbot/bin/python'} 01:52:21 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-025', '--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:21 INFO - mozversion application_buildid: 20160627144420 01:52:21 INFO - mozversion application_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 01:52:21 INFO - mozversion application_display_name: Firefox 01:52:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:52:21 INFO - mozversion application_name: Firefox 01:52:21 INFO - mozversion application_remotingname: firefox 01:52:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:52:21 INFO - mozversion application_vendor: Mozilla 01:52:21 INFO - mozversion application_version: 48.0 01:52:21 INFO - mozversion platform_buildid: 20160627144420 01:52:21 INFO - mozversion platform_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 01:52:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:52:21 INFO - mozversion platform_version: 48.0 01:52:21 INFO - using testdate: 1467103941 01:52:21 INFO - actual date: 1467103941 01:52:21 INFO - starting webserver on 'localhost:37444' 01:52:21 INFO - SUITE-START | Running 2 tests 01:52:21 INFO - TEST-START | dromaeo_css 01:52:21 INFO - operating with platform_type : linux_ 01:52:21 INFO - Initialising browser for dromaeo_css test... 01:52:21 INFO - TEST-INFO | started process 29041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptC2hOT/profile http://localhost:37444/getInfo.html) 01:52:25 INFO - PROCESS | 29041 | __metrics Screen width/height:1600/1200 01:52:25 INFO - PROCESS | 29041 | colorDepth:24 01:52:25 INFO - PROCESS | 29041 | Browser inner width/height: 1024/697 01:52:25 INFO - PROCESS | 29041 | __metrics 01:52:26 ERROR - PROCESS | 29041 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:52:27 INFO - TEST-INFO | 29041: exit 0 01:52:27 INFO - Browser initialized. 01:52:27 INFO - Running cycle 1/1 for dromaeo_css test... 01:52:27 INFO - TEST-INFO | started process 29131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptC2hOT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:39 INFO - PROCESS | 29131 | RSS: Main: 139427840 01:52:39 INFO - PROCESS | 29131 | 01:53:30 INFO - PROCESS | 29131 | 1467104010116 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:37 INFO - PROCESS | 29131 | Cycle 1(1): loaded http://localhost:37444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37444/tests/dromaeo/cssquery-ext.html) 01:55:38 INFO - PROCESS | 29131 | RSS: Main: 251502592 01:55:38 INFO - PROCESS | 29131 | 01:58:40 INFO - PROCESS | 29131 | Cycle 1(1): loaded http://localhost:37444/tests/dromaeo/cssquery-ext.html (next: http://localhost:37444/tests/dromaeo/cssquery-jquery.html) 01:58:41 INFO - PROCESS | 29131 | RSS: Main: 230359040 01:58:41 INFO - PROCESS | 29131 | 02:01:42 INFO - PROCESS | 29131 | Cycle 1(1): loaded http://localhost:37444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37444/tests/dromaeo/cssquery-mootools.html) 02:01:43 INFO - PROCESS | 29131 | RSS: Main: 216068096 02:01:43 INFO - PROCESS | 29131 | 02:04:45 INFO - PROCESS | 29131 | Cycle 1(1): loaded http://localhost:37444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37444/tests/dromaeo/cssquery-prototype.html) 02:04:45 INFO - PROCESS | 29131 | RSS: Main: 219099136 02:04:45 INFO - PROCESS | 29131 | 02:07:48 INFO - PROCESS | 29131 | Cycle 1(1): loaded http://localhost:37444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37444/tests/dromaeo/cssquery-yui.html) 02:07:49 INFO - PROCESS | 29131 | RSS: Main: 210001920 02:07:49 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | Cycle 1(1): loaded http://localhost:37444/tests/dromaeo/cssquery-yui.html (next: http://localhost:37444/tests/dromaeo/cssquery-dojo.html) 02:10:51 INFO - PROCESS | 29131 | RSS: Main: 251981824 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | __start_tp_report 02:10:51 INFO - PROCESS | 29131 | _x_x_mozilla_page_load 02:10:51 INFO - PROCESS | 29131 | _x_x_mozilla_page_load_details 02:10:51 INFO - PROCESS | 29131 | |i|pagename|runs| 02:10:51 INFO - PROCESS | 29131 | |0;dojo.html;3283.2776789106397;3349.397108520466;3352.664733526646;3371.9157021074484;3394.8302584870767;5545.694986775731;5563.888722225558;5564.387917329091;5566.165075238716;5587.944120558788;5563.638363506369;5600.747966341514;5602.971985140079;5610.915836262459;5642.956053130174;4961.3798275215595;5038.143515602356;5136.178211486163;5181.818636347729;5205.687658740469;4996.925046124311;5124.487551244864;5148.485151484841;5156.071907056728;5161.3806343238675;5024.974875125619;5088.160453525164;5108.233764935271;5113.335266415361;5136.64043516954;5085.1863701807715;5108.872278193037;5117.797317630354;5119.0273847968765;5156.974215128937;4937.987712518925;4964.578010869081;5024.472430394792;5024.824131155392;5031.974840125776;5540.86147846303;5546.889062218774;5603.523700485463;5607.439256074401;5609.3268807742925;5881.588288819784;5888.205092312526;5889.234399528034;5892.381299963527;5895.145203945447;5848.649081055108;5922.437368450033;5937.643741375488;5979.162917191553;5997.730102145414;5513.5864810139;5516.14499752539;5518.448155184489;5533.059379905426;5555.472230138131;5907;6040.395960403925;6041.2750469943885;6048.788292409832;6051;5881.029630110984;5952.9107063394085;5965.731542080617;5982.670953097534;5983.1623572699855;5996.5502587305255;6032.638041717511;6035.094735789667;6039.275286965592;6042.184305118841;5729.140628905614;5896.410358964069;5965.313988891333;5989.760409583655;5993.790217342372;5965;5975.581709280309;5981.730822113015;5983.401659833982;6001.159837622737;4556.476005259371;4564.863054108382;4567.885802854955;4571.954280457153;4596.678232523758;4035.4955630546183;4041;4096.221717873595;4112.732672376286;4133.008078061243;5558.166275058774;5572;5582.0789569721355;5584.022796010682;5638.4925356718095;5867.237259156368;5872.471477567039;5876.177335173079;5896.262967129109;5898.469137777621;5572;5600.775968961278;5706.115552089433;5808.82573522795;5818.5636077294375;5048.066107770074;5054.848354549369;5060.367454068241;5066.341375621219;5073.239014147834;6170.598911070766;6173.753049878044;6178.598391104564;6182;6186.381361863778;5774.162746401832;5943.138244954544;6028.367021462684;6062.787802426894;6070.150178974859;6159.315653723893;6180.81457556274;6187.350328215653;6200.937990620036;6201.658908760061;5732.885342293047;5800.622959507618;5836.095405212199;5852.648841069549;5896.941030589639;5856.3558008618165;5914.4381283777975;5918.112283157561;5935.940640593712;5939.46544810969;5809;5837.474627283395;5848.210491583752;5866.208061911588;5884.911726324023;5683.090705487102;5805.738741756715;5812;5847.1229315603;5869.266341707286;5784.7107644618445;5807.564432667482;5809.419058094326;5815.5929084963645;5857.326407463026;5918.7928422505;5935.495482884004;5943;5947.464728174485;5949.167116603766;5634.464725851038;5735.512481438957;5815.563832712479;5819.272590926134;5843.094320380348 02:10:51 INFO - PROCESS | 29131 | |1;ext.html;640.1837656987337;657.385344702703;683.6957553888519;726.8364617960956;752.116263390516;31626;32292;32331.191720207007;32376.67623323766;32379.190520237007;32820.67179328206;39583;39876.202475950464;40132.19735605294;40382.59617403825;8711.564421778901;8864.867026994569;8879.644814207424;8885.200331970122;8886.377953543255;8683;8774.473531588093;8795.868061979043;8806.20744133028;8808.64765409386;8791.12088791119;8886.333524985619;8886.422382545114;8889.466632002068;8893.244074253696;8976.59605317759;9016.774580635503;9028.77428064297;9036.502992335387;9037.548122593844;8856.778580535474;8940.061293564147;8962;8962.14859588338;8962.193402593733;43700.12599748019;44212;44248.3362749559;44251.557484425386;44293;3702.082359144768;3744.344739670574;3887.1836914248042;4165.312723400635;4468.352088947117;33065;33104.17239569006;33201.3359732804;33273;33435.83282083598;4483.30508771141;4513.796879140446;4555.567221113989;4562.520935301779;4577.29051996941;314051;314231;315359;315691;315947;62466;62516.37483625196;62908.68545657334;62911.685441572496;63018.36981630217;65129.67435162794;65520;68744;69042.65478672575;69741.30258697449;18780.624387512173;18922.24311027571;18969.715454268196;18983;18986.62026759457;15383.538493845203;15389.153596552296;15452.84547154514;15517.068975861259;15523;20806.375808725763;21126.57746845085;21167;21186.093251607123;21192.78807211908;7371.926280737124;7482.656837626117;7633.6564854581675;7766;7768.145503994556;1151.117788102794;1156.6587856582328;1195.4261954262004;1206.8913797758069;1283.3006011723633;34581.654183457846;34644.30711385758;34761.82619086889;35181;35513.46729799055;1204.7771162334996;1220.0422668205417;1299.811527328532;1316.1971197569476;1322.4710115953503;17643.20605572752;18396.63206735858;18406.539836504195;18478.815211847977;18525.258989640533;486599;530160;540211;540371;541398;64411.355886440535;64897.35102648913;65245.347546523924;65445.67277163584;65566.34433655602;1402.8386735525546;1497.4833682379563;1501.5795577238391;1518.5975716435153;1557.6962492314117;31352.37295254128;32010;32232.677673223905;32731.836340818143;32865;48223.5177648219;49102.50897491122;49161;49174.75412622914;49223.507764921895;272349;276491;277506;277637;278212;28024.29939251535;31222.843885780425;31429.68570314359;31458.685413145577;32105.518417223295;45320.32019519776;53856;54164.72917635387;54381.45618543922;54885.1767223484;39334.213315734094;39795.60204397919;40071;40314.596854031086;40707.38938915859;38066.42900356552;40978.79510602428;42623.360649590904;43081.353779693956;43538;43332.26670933127;44065.77967110272;44502;44606;44691.776541117084;36553.63446365609;37714.811425942695;38020.42969355406;38064.42903356397;38254.61745382511;29102.417951640426;29644.55533167047;29918.25204369908;29968.25079373033;30237.697623023487 02:10:51 INFO - PROCESS | 29131 | |2;jquery.html;407.7370096287893;408.86303088465365;419.8341655046257;433.20074462616464;441.3606632338615;17694.82305176948;18212.544686382847;18707.906460467697;18751.62496750066;18808;18070.186841592127;18373.356932507333;18417.17122729477;19097.331593394232;19224.61550768984;5689.118186681061;5813.389594092623;5866.626689653445;5953.077273022688;5979.372165922581;5751.281089863767;5773;5821.09772985188;5827.446392592697;5834.21238132853;5708.628939118944;5735.426457354273;5804.187413762077;5805.10020946754;5810.680412577307;5810.099434587646;5835.474807267324;5850.385709500484;5855.151003104547;5867.8533036674;5137.3064636274;5249.396319423277;5263.921041184385;5272.393674727378;5273.419923808378;21759.564808703897;22889.77110228893;23215.419614509603;23237.419064523354;23339;2457.8893949772305;2719.8912043518235;2828.3494796196783;2880.5823155642524;3161.193895556641;10011.399316041061;10250.897491025069;10272.28094033418;10309.948450257776;10752;2023.251396983111;2054.3323419888447;2070.3167954575106;2100.3488918435182;2166.5991791518463;73682;74975.6514479934;75352;76971.61514192449;78570.60714696447;11205.495752691148;11357.318560886373;11439.542418303341;11466.140039497071;11665.65003049893;16143.434979775886;16224.756628650579;16342.346306147858;16385.50843474698;16398.426055088014;8833;8847.159519845733;8863.183047475251;8901.73294801157;8979.640814367483;8711.47731136134;8728.519931403707;8772.298216142693;8849.070847560914;8900.510471924106;4889.926651100236;4944.3572335596145;4960.355153829979;4964.776585053609;4973.477784832613;1978.4855937456366;1984.3154111831395;2082.91668333268;2119.63966125759;2132.5521640455368;499.71016810249967;517.3378076062646;986.3342243985425;1107.4352080439035;1178.9941050294694;17825.643487130186;19144.712829307573;19206;19585.60828783445;20174.394768156977;1100.4167791070745;1109.0739232740752;1113.2708076210095;1142;1149.3908228638834;10907.236493445542;10920.2901811382;10925.672229833117;11012.944935275273;11056.447177641086;485845;506404;508038;511030;524850;65604.67197664076;81354;83379;92270.53864730634;95654.52172739092;1096.8263957565327;1150.4765331773856;1161.814948752268;1162.1922763679163;1170.0288760328906;16662.66674666524;17197.398091066752;17331.480055598353;17452.21465034102;17763.20065597077;38437.80781096077;38594;38875;38959.2208155841;39415;54732.726336369655;57145.71427142838;57546.7122664384;58218.12672809996;58611.413885860595;11484.449599303987;11828.408579570814;12357.567485137977;12435.626931191717;12544.686382840502;13656.453741850215;13753.793693094813;13795.862041379458;13872.514461993782;14024;12233.571824986082;12273.815892761795;12542.686432839251;12550.497980080694;12765;12005.459754311252;12028.458719357825;12057.899427877184;12518.248905065726;12665.561260163606;6386.840328991627;8457.492550446992;9160.404573702688;11272.774544509228;12644.620661380173;12689.048321375749;12694.428750706056;12839.229646221256;12852.807207892076;12876.034297427543;12473.812892806796;12560.937195313965;12639.810402844148;12780;13039.282839443542 02:10:51 INFO - PROCESS | 29131 | |3;mootools.html;1426.5078547900985;1594.561495588713;1600.9839901600983;1842.3920106364892;1933.3040105561995;8013.278804907557;8115.107338192802;8120.187981201877;8135.105138434782;8138.226868447496;8114.594270286491;8279.586020698956;8288.751337459886;8289.58552072397;8293.419460637759;2314.0975019742314;2339.847909885852;2345.0268138722495;2345.2026311054237;2347.8708671023087;2375.6911601491784;2428.9757102429016;2431.7932975697;2447.865367404792;2451.117597664839;2294.1511640692966;2315.733690625574;2322.7328857181474;2324.3491822289784;2326.0230703104653;2357.4106473381653;2378.52429514097;2386.188695843413;2390.1156572068444;2399.844010139344;2342.8711420871846;2405.542946840095;2413.4931664350506;2413.710354757423;2414.167112346238;7425.888611670829;8183;8435.451695639826;8471.534065626389;8483.321334293303;5248.6588371755715;5347.037533244014;5383.569314454834;5387.326584176978;5406.783728650849;3428.6914177724125;3437.6906078453057;3450.6549345065546;3491.877784277538;3506.9649303506894;1095.4632230207142;1096.0847692177042;1106.7675788084512;1112.8775834658181;1127.577158565538;11812.881871181264;12279.201851879689;12288.754224915452;12291.754164916652;12293.877061229363;4760.690555113906;4821.9035619287415;4860.3681521401995;4874.707517548958;4904.901901961941;10504.317219380715;10537.525811338508;10545.367277963347;10548.683539493828;10569.312994655324;5502.2296878437055;5533.501984821385;5536.141898005815;5537.058700021006;5554.1113421853115;5006.023825354021;5061.215511595708;5061.240813877947;5069.822556210515;5070.518300761421;3915.275674000319;4003.6596889264156;4031.7580945143386;4044.312466880637;4048.109415928491;1277.150694787974;1287.5171810571037;1293.715382615823;1298.8766067223598;1303.3418123847587;964.5755867418313;1031.242037102729;1045.6026709850207;1053.9209559283083;1087.2009073331096;5826.76692932278;5906.2912450505355;5919.881602367928;6096.177016102858;6100;960.9039096090335;1008.9192864570816;1010.3079390617451;1029.3000759483623;1088.9564417423373;4114.403411505315;4134.751914885116;4138.565450627701;4138.813753381105;4151.626353628188;10520.26358154937;10931.45342732876;10998.175136864767;11001.834972475419;11005.284656497302;10794;10826.350418974887;10830.783384332426;10836.133109351233;10845.349279043283;8294.751157465285;8342.874856877152;8355.623996920032;8459.365547583955;8512.106228846005;5987.6108052976415;6022.277326720821;6038.305594856648;6058.515318774399;6210.906836397548;8886.200241978253;9080.40977336471;9209.401388909699;9250.814983700153;9341.205997490018;9172.587233574639;9176.862347064665;9370.718878433658;9376.718698439057;9390.014048524807;7453.664585093576;7820.335271501986;7825.217478252129;7829.960850195713;7843.137254902071;8239.588020599065;8254.504729716236;8270.751877443687;8349.54077525742;8361.707340243061;7708.730194443392;7749.573773442515;7768.961155194188;7787.844243115219;7826.569538675428;7375.631218438949;7522.097348318237;7562.395008399425;7644.847103058019;7658.119316278699;7263.382612477999;7391.741289054858;7441.4046876248685;7448.73929412468;7450.664720087718;5471.452854714496;5492.258545096361;5522.5858060646415;5620.915686264628;5652.802151924663;5291.411808140161;5299;5310.707911064774;5328.57371410294;5494.752736126804 02:10:51 INFO - PROCESS | 29131 | |4;prototype.html;367.46717259973036;368.80821972574245;369.7153192042128;375.3281625889657;378.02658155250236;6065.181200537926;6073.969630151854;6083.239595050619;6103.267607887049;6122.663253521055;5890.204822348982;6066.30237522685;6067.605605635631;6069.57512974092;6071.969640151793;4668.85993420198;4724.433068031841;4757.500462451445;4761.785719642625;4767.618590512768;4720.787564559586;4754.6434017448655;4785.736784476852;4797.2324428091515;4806.9038619227595;4506.459224893001;4604.424446944132;4778.80884764609;4779.498152693969;4782.1153086678905;4681.946562023518;4693.366395536593;4694.037722266927;4696.342512048316;4729.787159577827;4175.789021183853;4178.289690752549;4183;4188.183304255671;4192.874213773592;5859.1797148399255;5895.29256489224;5900.734466948998;5902.881942361171;5910.497607703351;5487.945120548823;5492.395836457987;5495;5500.22996780451;5502.394736579013;6209.968950155266;6418.967905160491;6461.6123032617725;6464.773732919372;6471.579347342407;4540.364348991144;4542.818287268506;4558.042811009692;4566.634669226454;4585.3122031695175;6693.196816382017;6755.290694477058;6763.932360676428;6770.086038384804;6775.051492791063;4682.719036857731;4683.110209060268;4683.431050598019;4686.203345431217;4687.9765601171775;4734.0058587696285;4739.170645137087;4739.478657347689;4742.4309082909585;4745.264484004916;5404.243405923174;5448.509634132947;5455.318085239345;5455.699936503451;5463.48096930791;6330.873382532323;6485.643289619116;6502.577332473374;6505.4795616350575;6512.6092434454085;1627.2026706913528;1631.217015832407;1635.051670031379;1638.4019832761194;1641.8686505079565;1015.1523477896039;1056.487603512296;1083.1659622091104;1084.414416215235;1107.6621630402803;6214.25428948529;6217.564770466024;6218.9378106218355;6259.874802504016;6276.403741644536;6578.967105164539;6632.071509988606;6636.83407914806;6639.767608133692;6642.63465509392;6172.105044768484;6174.8147555573405;6181.320054793969;6188.504919606421;6232.470240029557;3532.929341413209;3580.0870777951454;3586.372384832644;3589.7128229741556;3592.4072528033103;6689.4982876284475;6912.688928998207;6923.6884340204815;6930.237673855871;6938.722451102;6692.933070669328;6707.966460167766;6725.2602213756445;6730.293319201512;6737.562058466184;6913.2049814272;6913.51605387618;6915.654217289115;6920.30796920304;6923;6620.900686489803;6626.337366263335;6631.104800851823;6632.2372927114;6640.83397915056;6391.296957334783;6508.869822603616;6669.53313268086;6673.699683514351;6678.365555272241;7034.437245020488;7058.400035996792;7066.505344625827;7066.7173313066905;7069.893951590833;4557.430321209848;4590.324531546028;4598.678092533491;4599.931001035054;4603.056373443503;6728.529002969745;6740.6966686498245;6741.2921643226755;6746.730130794714;6748.561343512656;6369.363063693593;6536.8365790855605;6540.476761858945;6549.934500654933;6550.508711846535;6478.611283323015;6521.119648847345;6530.771423000172;6531.987541931008;6532.640704761284;6417.8716425672155;6424.839379015375;6430.356964303533;6436.712657468432;6438.67806609677;6579.374959379043;6580.80257592273;6581.934180658132;6585.242697089896;6589.769358072444;5971.880562388815;6126;6297.1813664223355;6335.809925702236;6430.967845160744 02:10:51 INFO - PROCESS | 29131 | |5;yui.html;835.1564919431372;847.0428415890043;890.8619164029574;913.2602193419741;937.0535758883526;14219.71560568788;14365.425382984668;14372.712545749106;14416.423343066277;14440.927795361009;14103.78844317336;15105.697886042273;15216.619584510392;15234;15243.618909527268;765.4412279036306;889.1020069729587;894.9105089491047;903.9141281578239;912.5209265135791;898.3711402018613;909.295296145486;912.3841407050247;913.8309412758628;914.021996463784;939.1876027236459;940.4498368454463;943.8961714211431;946.8059047895199;949.710338346804;774;930.6928713524588;932.6129656192672;941.9387739796891;949.4730424614336;686.7218776395567;689.0663151429791;691.1464341538197;692.0622556436057;692.8926016467456;14781.630459238497;14800.333984970703;14815.703685926328;14828.851711482856;14856.702865942729;14400.855991440056;14975.625609359744;15077.773833392508;15104.697906041927;15139.318730657147;12220.388980551026;12262.325572093532;12454.190477618926;12456.439460224221;12507.249565026037;4073.144639625682;4116.341385378355;4121.814518346681;4127.8968025799295;4169.4162817205315;52466;52522;52531.47468525304;52685.20972185459;52710.47289527133;10519.737006574744;10897.618583349546;11239.60661376848;11315.094792416587;11529.423528823525;19205.32781352646;19287;19464.610707785763;19536.60926781485;19583.412497625093;8145.307648849915;8289.461185022954;8385.6226469809;8598.011228708654;8626;4664.673472856935;4710.152172608895;4774.594159496412;4789.688670236424;4871.244957031666;3470.0804286864;3571.821408929543;3574.7855128692363;3585.1933315003917;3675;664.6510581944518;673.3367632881608;673.4208580620663;675.0582936803132;677.2584020497547;622.2097935621736;756.2059837170948;765.7281665008842;767.6392095715005;776.2974508070206;9604.423734575808;9814;9931.255155863339;9969.30214884951;10047.24645651579;777.8716511775493;792.4928046050533;792.84935862186;814.6011537696486;817.235884448043;4594.908101837945;4649.279361698942;4679.883002924954;4708.976455117771;4718.31584420264;63295;63662.36337636657;64368.781560921765;64377.356226438074;64498.67750661217;54517.1822422664;56519;56804.43195568074;56976.14535781967;57221.427785722444;49154.26268605974;49551.50448495469;49769.75115124401;50510.24234636484;50746.746266268434;9301.906980930375;9365.484898330657;9454.290928180551;9488;9517.095875891779;38998.4150237741;39107.80446097865;40444;40503.59496405116;40593.1881362377;43070.138597228506;44477.33284000678;48239.5176048235;48280.7585962082;48578.75710621566;12909.483620655068;12944.870551294367;13186.208827470382;13227.867721322664;13327.400266988203;14305.71388572202;14455.277236138361;14535.345909434312;14564.635884102981;14565.635859103608;13389.598312050653;13405.195688258736;13435.193888366339;13525.864741352854;13812.240326782123;13652.522161724291;13804.93097534506;14048.859511404755;14199.29003549839;14466.27668616586;12922;13035.348232588522;13782.517611883937;13799.310034498034;13833.377498012413;11105.666829995112;11316;11412.201145919706;11558;11571.007083984148;10595.417252051211;11139.665810025712;11191.32852028881;11238.83141752858;11290 02:10:51 INFO - PROCESS | 29131 | __end_tp_report 02:10:51 INFO - PROCESS | 29131 | __start_cc_report 02:10:51 INFO - PROCESS | 29131 | _x_x_mozilla_cycle_collect,849 02:10:51 INFO - PROCESS | 29131 | __end_cc_report 02:10:51 INFO - PROCESS | 29131 | __startTimestamp1467105051571__endTimestamp 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | ------- Summary: start ------- 02:10:51 INFO - PROCESS | 29131 | Number of tests: 6 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | [#0] dojo.html Cycles:165 Average:5543.07 Median:5807.56 stddev:612.17 (10.5%) stddev-sans-first:587.82 02:10:51 INFO - PROCESS | 29131 | Values: 3283.3 3349.4 3352.7 3371.9 3394.8 5545.7 5563.9 5564.4 5566.2 5587.9 5563.6 5600.7 5603.0 5610.9 5643.0 4961.4 5038.1 5136.2 5181.8 5205.7 4996.9 5124.5 5148.5 5156.1 5161.4 5025.0 5088.2 5108.2 5113.3 5136.6 5085.2 5108.9 5117.8 5119.0 5157.0 4938.0 4964.6 5024.5 5024.8 5032.0 5540.9 5546.9 5603.5 5607.4 5609.3 5881.6 5888.2 5889.2 5892.4 5895.1 5848.6 5922.4 5937.6 5979.2 5997.7 5513.6 5516.1 5518.4 5533.1 5555.5 5907.0 6040.4 6041.3 6048.8 6051.0 5881.0 5952.9 5965.7 5982.7 5983.2 5996.6 6032.6 6035.1 6039.3 6042.2 5729.1 5896.4 5965.3 5989.8 5993.8 5965.0 5975.6 5981.7 5983.4 6001.2 4556.5 4564.9 4567.9 4572.0 4596.7 4035.5 4041.0 4096.2 4112.7 4133.0 5558.2 5572.0 5582.1 5584.0 5638.5 5867.2 5872.5 5876.2 5896.3 5898.5 5572.0 5600.8 5706.1 5808.8 5818.6 5048.1 5054.8 5060.4 5066.3 5073.2 6170.6 6173.8 6178.6 6182.0 6186.4 5774.2 5943.1 6028.4 6062.8 6070.2 6159.3 6180.8 6187.4 6200.9 6201.7 5732.9 5800.6 5836.1 5852.6 5896.9 5856.4 5914.4 5918.1 5935.9 5939.5 5809.0 5837.5 5848.2 5866.2 5884.9 5683.1 5805.7 5812.0 5847.1 5869.3 5784.7 5807.6 5809.4 5815.6 5857.3 5918.8 5935.5 5943.0 5947.5 5949.2 5634.5 5735.5 5815.6 5819.3 5843.1 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | [#1] ext.html Cycles:180 Average:55412.19 Median:40223.40 stddev:103069.05 (256.2%) stddev-sans-first:103276.15 02:10:51 INFO - PROCESS | 29131 | Values: 640.2 657.4 683.7 726.8 752.1 31626.0 32292.0 32331.2 32376.7 32379.2 32820.7 39583.0 39876.2 40132.2 40382.6 8711.6 8864.9 8879.6 8885.2 8886.4 8683.0 8774.5 8795.9 8806.2 8808.6 8791.1 8886.3 8886.4 8889.5 8893.2 8976.6 9016.8 9028.8 9036.5 9037.5 8856.8 8940.1 8962.0 8962.1 8962.2 43700.1 44212.0 44248.3 44251.6 44293.0 3702.1 3744.3 3887.2 4165.3 4468.4 33065.0 33104.2 33201.3 33273.0 33435.8 4483.3 4513.8 4555.6 4562.5 4577.3 314051.0 314231.0 315359.0 315691.0 315947.0 62466.0 62516.4 62908.7 62911.7 63018.4 65129.7 65520.0 68744.0 69042.7 69741.3 18780.6 18922.2 18969.7 18983.0 18986.6 15383.5 15389.2 15452.8 15517.1 15523.0 20806.4 21126.6 21167.0 21186.1 21192.8 7371.9 7482.7 7633.7 7766.0 7768.1 1151.1 1156.7 1195.4 1206.9 1283.3 34581.7 34644.3 34761.8 35181.0 35513.5 1204.8 1220.0 1299.8 1316.2 1322.5 17643.2 18396.6 18406.5 18478.8 18525.3 486599.0 530160.0 540211.0 540371.0 541398.0 64411.4 64897.4 65245.3 65445.7 65566.3 1402.8 1497.5 1501.6 1518.6 1557.7 31352.4 32010.0 32232.7 32731.8 32865.0 48223.5 49102.5 49161.0 49174.8 49223.5 272349.0 276491.0 277506.0 277637.0 278212.0 28024.3 31222.8 31429.7 31458.7 32105.5 45320.3 53856.0 54164.7 54381.5 54885.2 39334.2 39795.6 40071.0 40314.6 40707.4 38066.4 40978.8 42623.4 43081.4 43538.0 43332.3 44065.8 44502.0 44606.0 44691.8 36553.6 37714.8 38020.4 38064.4 38254.6 29102.4 29644.6 29918.3 29968.3 30237.7 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | [#2] jquery.html Cycles:180 Average:29326.08 Median:2109.99 stddev:83243.59 (3945.2%) stddev-sans-first:83448.79 02:10:51 INFO - PROCESS | 29131 | Values: 407.7 408.9 419.8 433.2 441.4 17694.8 18212.5 18707.9 18751.6 18808.0 18070.2 18373.4 18417.2 19097.3 19224.6 5689.1 5813.4 5866.6 5953.1 5979.4 5751.3 5773.0 5821.1 5827.4 5834.2 5708.6 5735.4 5804.2 5805.1 5810.7 5810.1 5835.5 5850.4 5855.2 5867.9 5137.3 5249.4 5263.9 5272.4 5273.4 21759.6 22889.8 23215.4 23237.4 23339.0 2457.9 2719.9 2828.3 2880.6 3161.2 10011.4 10250.9 10272.3 10309.9 10752.0 2023.3 2054.3 2070.3 2100.3 2166.6 73682.0 74975.7 75352.0 76971.6 78570.6 11205.5 11357.3 11439.5 11466.1 11665.7 16143.4 16224.8 16342.3 16385.5 16398.4 8833.0 8847.2 8863.2 8901.7 8979.6 8711.5 8728.5 8772.3 8849.1 8900.5 4889.9 4944.4 4960.4 4964.8 4973.5 1978.5 1984.3 2082.9 2119.6 2132.6 499.7 517.3 986.3 1107.4 1179.0 17825.6 19144.7 19206.0 19585.6 20174.4 1100.4 1109.1 1113.3 1142.0 1149.4 10907.2 10920.3 10925.7 11012.9 11056.4 485845.0 506404.0 508038.0 511030.0 524850.0 65604.7 81354.0 83379.0 92270.5 95654.5 1096.8 1150.5 1161.8 1162.2 1170.0 16662.7 17197.4 17331.5 17452.2 17763.2 38437.8 38594.0 38875.0 38959.2 39415.0 54732.7 57145.7 57546.7 58218.1 58611.4 11484.4 11828.4 12357.6 12435.6 12544.7 13656.5 13753.8 13795.9 13872.5 14024.0 12233.6 12273.8 12542.7 12550.5 12765.0 12005.5 12028.5 12057.9 12518.2 12665.6 6386.8 8457.5 9160.4 11272.8 12644.6 12689.0 12694.4 12839.2 12852.8 12876.0 12473.8 12560.9 12639.8 12780.0 13039.3 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | [#3] mootools.html Cycles:180 Average:5776.24 Median:5065.53 stddev:3166.31 (62.5%) stddev-sans-first:3158.31 02:10:51 INFO - PROCESS | 29131 | Values: 1426.5 1594.6 1601.0 1842.4 1933.3 8013.3 8115.1 8120.2 8135.1 8138.2 8114.6 8279.6 8288.8 8289.6 8293.4 2314.1 2339.8 2345.0 2345.2 2347.9 2375.7 2429.0 2431.8 2447.9 2451.1 2294.2 2315.7 2322.7 2324.3 2326.0 2357.4 2378.5 2386.2 2390.1 2399.8 2342.9 2405.5 2413.5 2413.7 2414.2 7425.9 8183.0 8435.5 8471.5 8483.3 5248.7 5347.0 5383.6 5387.3 5406.8 3428.7 3437.7 3450.7 3491.9 3507.0 1095.5 1096.1 1106.8 1112.9 1127.6 11812.9 12279.2 12288.8 12291.8 12293.9 4760.7 4821.9 4860.4 4874.7 4904.9 10504.3 10537.5 10545.4 10548.7 10569.3 5502.2 5533.5 5536.1 5537.1 5554.1 5006.0 5061.2 5061.2 5069.8 5070.5 3915.3 4003.7 4031.8 4044.3 4048.1 1277.2 1287.5 1293.7 1298.9 1303.3 964.6 1031.2 1045.6 1053.9 1087.2 5826.8 5906.3 5919.9 6096.2 6100.0 960.9 1008.9 1010.3 1029.3 1089.0 4114.4 4134.8 4138.6 4138.8 4151.6 10520.3 10931.5 10998.2 11001.8 11005.3 10794.0 10826.4 10830.8 10836.1 10845.3 8294.8 8342.9 8355.6 8459.4 8512.1 5987.6 6022.3 6038.3 6058.5 6210.9 8886.2 9080.4 9209.4 9250.8 9341.2 9172.6 9176.9 9370.7 9376.7 9390.0 7453.7 7820.3 7825.2 7830.0 7843.1 8239.6 8254.5 8270.8 8349.5 8361.7 7708.7 7749.6 7769.0 7787.8 7826.6 7375.6 7522.1 7562.4 7644.8 7658.1 7263.4 7391.7 7441.4 7448.7 7450.7 5471.5 5492.3 5522.6 5620.9 5652.8 5291.4 5299.0 5310.7 5328.6 5494.8 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | [#4] prototype.html Cycles:180 Average:5437.41 Median:6124.33 stddev:1624.49 (26.5%) stddev-sans-first:1583.85 02:10:51 INFO - PROCESS | 29131 | Values: 367.5 368.8 369.7 375.3 378.0 6065.2 6074.0 6083.2 6103.3 6122.7 5890.2 6066.3 6067.6 6069.6 6072.0 4668.9 4724.4 4757.5 4761.8 4767.6 4720.8 4754.6 4785.7 4797.2 4806.9 4506.5 4604.4 4778.8 4779.5 4782.1 4681.9 4693.4 4694.0 4696.3 4729.8 4175.8 4178.3 4183.0 4188.2 4192.9 5859.2 5895.3 5900.7 5902.9 5910.5 5487.9 5492.4 5495.0 5500.2 5502.4 6210.0 6419.0 6461.6 6464.8 6471.6 4540.4 4542.8 4558.0 4566.6 4585.3 6693.2 6755.3 6763.9 6770.1 6775.1 4682.7 4683.1 4683.4 4686.2 4688.0 4734.0 4739.2 4739.5 4742.4 4745.3 5404.2 5448.5 5455.3 5455.7 5463.5 6330.9 6485.6 6502.6 6505.5 6512.6 1627.2 1631.2 1635.1 1638.4 1641.9 1015.2 1056.5 1083.2 1084.4 1107.7 6214.3 6217.6 6218.9 6259.9 6276.4 6579.0 6632.1 6636.8 6639.8 6642.6 6172.1 6174.8 6181.3 6188.5 6232.5 3532.9 3580.1 3586.4 3589.7 3592.4 6689.5 6912.7 6923.7 6930.2 6938.7 6692.9 6708.0 6725.3 6730.3 6737.6 6913.2 6913.5 6915.7 6920.3 6923.0 6620.9 6626.3 6631.1 6632.2 6640.8 6391.3 6508.9 6669.5 6673.7 6678.4 7034.4 7058.4 7066.5 7066.7 7069.9 4557.4 4590.3 4598.7 4599.9 4603.1 6728.5 6740.7 6741.3 6746.7 6748.6 6369.4 6536.8 6540.5 6549.9 6550.5 6478.6 6521.1 6530.8 6532.0 6532.6 6417.9 6424.8 6430.4 6436.7 6438.7 6579.4 6580.8 6581.9 6585.2 6589.8 5971.9 6126.0 6297.2 6335.8 6431.0 02:10:51 INFO - PROCESS | 29131 | 02:10:51 INFO - PROCESS | 29131 | [#5] yui.html Cycles:180 Average:15411.02 Median:4672.28 stddev:17385.29 (372.1%) stddev-sans-first:17399.60 02:10:51 INFO - PROCESS | 29131 | Values: 835.2 847.0 890.9 913.3 937.1 14219.7 14365.4 14372.7 14416.4 14440.9 14103.8 15105.7 15216.6 15234.0 15243.6 765.4 889.1 894.9 903.9 912.5 898.4 909.3 912.4 913.8 914.0 939.2 940.4 943.9 946.8 949.7 774.0 930.7 932.6 941.9 949.5 686.7 689.1 691.1 692.1 692.9 14781.6 14800.3 14815.7 14828.9 14856.7 14400.9 14975.6 15077.8 15104.7 15139.3 12220.4 12262.3 12454.2 12456.4 12507.2 4073.1 4116.3 4121.8 4127.9 4169.4 52466.0 52522.0 52531.5 52685.2 52710.5 10519.7 10897.6 11239.6 11315.1 11529.4 19205.3 19287.0 19464.6 19536.6 19583.4 8145.3 8289.5 8385.6 8598.0 8626.0 4664.7 4710.2 4774.6 4789.7 4871.2 3470.1 3571.8 3574.8 3585.2 3675.0 664.7 673.3 673.4 675.1 677.3 622.2 756.2 765.7 767.6 776.3 9604.4 9814.0 9931.3 9969.3 10047.2 777.9 792.5 792.8 814.6 817.2 4594.9 4649.3 4679.9 4709.0 4718.3 63295.0 63662.4 64368.8 64377.4 64498.7 54517.2 56519.0 56804.4 56976.1 57221.4 49154.3 49551.5 49769.8 50510.2 50746.7 9301.9 9365.5 9454.3 9488.0 9517.1 38998.4 39107.8 40444.0 40503.6 40593.2 43070.1 44477.3 48239.5 48280.8 48578.8 12909.5 12944.9 13186.2 13227.9 13327.4 14305.7 14455.3 14535.3 14564.6 14565.6 13389.6 13405.2 13435.2 13525.9 13812.2 13652.5 13804.9 14048.9 14199.3 14466.3 12922.0 13035.3 13782.5 13799.3 13833.4 11105.7 11316.0 11412.2 11558.0 11571.0 10595.4 11139.7 11191.3 11238.8 11290.0 02:10:51 INFO - PROCESS | 29131 | -------- Summary: end -------- 02:10:51 INFO - PROCESS | 29131 | 02:10:52 INFO - TEST-INFO | 29131: exit 0 02:10:52 INFO - TEST-OK | dromaeo_css | took 1110451ms 02:10:52 INFO - TEST-START | kraken 02:10:52 INFO - operating with platform_type : linux_ 02:10:52 INFO - Initialising browser for kraken test... 02:10:52 INFO - TEST-INFO | started process 29324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1W4Die/profile http://localhost:37444/getInfo.html) 02:10:55 INFO - PROCESS | 29324 | __metrics Screen width/height:1600/1200 02:10:55 INFO - PROCESS | 29324 | colorDepth:24 02:10:55 INFO - PROCESS | 29324 | Browser inner width/height: 1024/697 02:10:55 INFO - PROCESS | 29324 | __metrics 02:10:56 ERROR - PROCESS | 29324 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:10:57 INFO - TEST-INFO | 29324: exit 0 02:10:57 INFO - Browser initialized. 02:10:57 INFO - Running cycle 1/1 for kraken test... 02:10:57 INFO - TEST-INFO | started process 29416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1W4Die/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:09 INFO - PROCESS | 29416 | RSS: Main: 139857920 02:11:09 INFO - PROCESS | 29416 | 02:11:11 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37444/tests/kraken/driver.html?testName=audio-beat-detection) 02:11:12 INFO - PROCESS | 29416 | RSS: Main: 197455872 02:11:12 INFO - PROCESS | 29416 | 02:11:15 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37444/tests/kraken/driver.html?testName=audio-dft) 02:11:16 INFO - PROCESS | 29416 | RSS: Main: 185294848 02:11:16 INFO - PROCESS | 29416 | 02:11:18 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37444/tests/kraken/driver.html?testName=audio-fft) 02:11:19 INFO - PROCESS | 29416 | RSS: Main: 273850368 02:11:19 INFO - PROCESS | 29416 | 02:11:21 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37444/tests/kraken/driver.html?testName=audio-oscillator) 02:11:22 INFO - PROCESS | 29416 | RSS: Main: 180690944 02:11:22 INFO - PROCESS | 29416 | 02:11:24 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:11:24 INFO - PROCESS | 29416 | RSS: Main: 178970624 02:11:24 INFO - PROCESS | 29416 | 02:11:27 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37444/tests/kraken/driver.html?testName=imaging-darkroom) 02:11:28 INFO - PROCESS | 29416 | RSS: Main: 213274624 02:11:28 INFO - PROCESS | 29416 | 02:11:31 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37444/tests/kraken/driver.html?testName=imaging-desaturate) 02:11:32 INFO - PROCESS | 29416 | RSS: Main: 213946368 02:11:32 INFO - PROCESS | 29416 | 02:11:35 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37444/tests/kraken/driver.html?testName=json-parse-financial) 02:11:35 INFO - PROCESS | 29416 | RSS: Main: 213721088 02:11:35 INFO - PROCESS | 29416 | 02:11:37 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:11:37 INFO - PROCESS | 29416 | RSS: Main: 193581056 02:11:37 INFO - PROCESS | 29416 | 02:11:39 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:11:40 INFO - PROCESS | 29416 | RSS: Main: 196694016 02:11:40 INFO - PROCESS | 29416 | 02:11:41 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:11:42 INFO - PROCESS | 29416 | RSS: Main: 209489920 02:11:42 INFO - PROCESS | 29416 | 02:11:45 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:11:45 INFO - PROCESS | 29416 | RSS: Main: 217186304 02:11:45 INFO - PROCESS | 29416 | 02:11:48 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:11:48 INFO - PROCESS | 29416 | RSS: Main: 214712320 02:11:48 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:37444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37444/tests/kraken/driver.html?testName=ai-astar) 02:11:50 INFO - PROCESS | 29416 | RSS: Main: 274599936 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | __start_tp_report 02:11:50 INFO - PROCESS | 29416 | _x_x_mozilla_page_load 02:11:50 INFO - PROCESS | 29416 | _x_x_mozilla_page_load_details 02:11:50 INFO - PROCESS | 29416 | |i|pagename|runs| 02:11:50 INFO - PROCESS | 29416 | |0;ai-astar;110;110;110;111;112;112;104;110;109;109 02:11:50 INFO - PROCESS | 29416 | |1;audio-beat-detection;154;125;155;177;134;158;154;133;186;132 02:11:50 INFO - PROCESS | 29416 | |2;audio-dft;160;161;161;160;159;160;162;161;161;159 02:11:50 INFO - PROCESS | 29416 | |3;audio-fft;77;77;74;177;77;74;77;75;159;75 02:11:50 INFO - PROCESS | 29416 | |4;audio-oscillator;91;92;153;91;93;93;146;91;93;146 02:11:50 INFO - PROCESS | 29416 | |5;imaging-gaussian-blur;116;117;117;117;116;116;116;116;117;116 02:11:50 INFO - PROCESS | 29416 | |6;imaging-darkroom;147;147;148;147;147;147;147;147;148;146 02:11:50 INFO - PROCESS | 29416 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 02:11:50 INFO - PROCESS | 29416 | |8;json-parse-financial;53;54;54;55;54;53;55;73;51;52 02:11:50 INFO - PROCESS | 29416 | |9;json-stringify-tinderbox;57;58;57;57;58;57;57;57;58;58 02:11:50 INFO - PROCESS | 29416 | |10;stanford-crypto-aes;71;72;71;72;74;73;73;73;73;73 02:11:50 INFO - PROCESS | 29416 | |11;stanford-crypto-ccm;123;113;116;111;120;111;113;114;139;122 02:11:50 INFO - PROCESS | 29416 | |12;stanford-crypto-pbkdf2;161;160;159;156;156;157;156;159;155;156 02:11:50 INFO - PROCESS | 29416 | |13;stanford-crypto-sha256-iterative;65;68;72;64;66;65;75;65;65;64 02:11:50 INFO - PROCESS | 29416 | __end_tp_report 02:11:50 INFO - PROCESS | 29416 | __start_cc_report 02:11:50 INFO - PROCESS | 29416 | _x_x_mozilla_cycle_collect,1589 02:11:50 INFO - PROCESS | 29416 | __end_cc_report 02:11:50 INFO - PROCESS | 29416 | __startTimestamp1467105110893__endTimestamp 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | ------- Summary: start ------- 02:11:50 INFO - PROCESS | 29416 | Number of tests: 14 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.26 (2.1%) stddev-sans-first:2.40 02:11:50 INFO - PROCESS | 29416 | Values: 110.0 110.0 110.0 111.0 112.0 112.0 104.0 110.0 109.0 109.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:154.50 stddev:20.09 (13.0%) stddev-sans-first:21.28 02:11:50 INFO - PROCESS | 29416 | Values: 154.0 125.0 155.0 177.0 134.0 158.0 154.0 133.0 186.0 132.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:11:50 INFO - PROCESS | 29416 | Values: 160.0 161.0 161.0 160.0 159.0 160.0 162.0 161.0 161.0 159.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:39.15 (51.5%) stddev-sans-first:41.02 02:11:50 INFO - PROCESS | 29416 | Values: 77.0 77.0 74.0 177.0 77.0 74.0 77.0 75.0 159.0 75.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:91.50 stddev:27.29 (29.8%) stddev-sans-first:28.17 02:11:50 INFO - PROCESS | 29416 | Values: 91.0 92.0 153.0 91.0 93.0 93.0 146.0 91.0 93.0 146.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:11:50 INFO - PROCESS | 29416 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:11:50 INFO - PROCESS | 29416 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:11:50 INFO - PROCESS | 29416 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:6.31 (11.7%) stddev-sans-first:6.63 02:11:50 INFO - PROCESS | 29416 | Values: 53.0 54.0 54.0 55.0 54.0 53.0 55.0 73.0 51.0 52.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 02:11:50 INFO - PROCESS | 29416 | Values: 57.0 58.0 57.0 57.0 58.0 57.0 57.0 57.0 58.0 58.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:0.87 02:11:50 INFO - PROCESS | 29416 | Values: 71.0 72.0 71.0 72.0 74.0 73.0 73.0 73.0 73.0 73.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.00 stddev:8.52 (7.2%) stddev-sans-first:8.86 02:11:50 INFO - PROCESS | 29416 | Values: 123.0 113.0 116.0 111.0 120.0 111.0 113.0 114.0 139.0 122.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:158.00 stddev:2.07 (1.3%) stddev-sans-first:1.76 02:11:50 INFO - PROCESS | 29416 | Values: 161.0 160.0 159.0 156.0 156.0 157.0 156.0 159.0 155.0 156.0 02:11:50 INFO - PROCESS | 29416 | 02:11:50 INFO - PROCESS | 29416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:65.50 stddev:3.73 (5.7%) stddev-sans-first:3.89 02:11:50 INFO - PROCESS | 29416 | Values: 65.0 68.0 72.0 64.0 66.0 65.0 75.0 65.0 65.0 64.0 02:11:50 INFO - PROCESS | 29416 | -------- Summary: end -------- 02:11:50 INFO - PROCESS | 29416 | 02:11:51 INFO - TEST-INFO | 29416: exit 0 02:11:51 INFO - TEST-OK | kraken | took 59610ms 02:11:51 INFO - SUITE-END | took 1170s 02:11:52 INFO - Completed test suite (00:19:30) 02:11:52 INFO - javascript benchmark 02:11:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.2776789106397, 3349.397108520466, 3352.664733526646, 3371.9157021074484, 3394.8302584870767, 5545.694986775731, 5563.888722225558, 5564.387917329091, 5566.165075238716, 5587.944120558788, 5563.638363506369, 5600.747966341514, 5602.971985140079, 5610.915836262459, 5642.956053130174, 4961.3798275215595, 5038.143515602356, 5136.178211486163, 5181.818636347729, 5205.687658740469, 4996.925046124311, 5124.487551244864, 5148.485151484841, 5156.071907056728, 5161.3806343238675, 5024.974875125619, 5088.160453525164, 5108.233764935271, 5113.335266415361, 5136.64043516954, 5085.1863701807715, 5108.872278193037, 5117.797317630354, 5119.0273847968765, 5156.974215128937, 4937.987712518925, 4964.578010869081, 5024.472430394792, 5024.824131155392, 5031.974840125776, 5540.86147846303, 5546.889062218774, 5603.523700485463, 5607.439256074401, 5609.3268807742925, 5881.588288819784, 5888.205092312526, 5889.234399528034, 5892.381299963527, 5895.145203945447, 5848.649081055108, 5922.437368450033, 5937.643741375488, 5979.162917191553, 5997.730102145414, 5513.5864810139, 5516.14499752539, 5518.448155184489, 5533.059379905426, 5555.472230138131, 5907.0, 6040.395960403925, 6041.2750469943885, 6048.788292409832, 6051.0, 5881.029630110984, 5952.9107063394085, 5965.731542080617, 5982.670953097534, 5983.1623572699855, 5996.5502587305255, 6032.638041717511, 6035.094735789667, 6039.275286965592, 6042.184305118841, 5729.140628905614, 5896.410358964069, 5965.313988891333, 5989.760409583655, 5993.790217342372, 5965.0, 5975.581709280309, 5981.730822113015, 5983.401659833982, 6001.159837622737, 4556.476005259371, 4564.863054108382, 4567.885802854955, 4571.954280457153, 4596.678232523758, 4035.4955630546183, 4041.0, 4096.221717873595, 4112.732672376286, 4133.008078061243, 5558.166275058774, 5572.0, 5582.0789569721355, 5584.022796010682, 5638.4925356718095, 5867.237259156368, 5872.471477567039, 5876.177335173079, 5896.262967129109, 5898.469137777621, 5572.0, 5600.775968961278, 5706.115552089433, 5808.82573522795, 5818.5636077294375, 5048.066107770074, 5054.848354549369, 5060.367454068241, 5066.341375621219, 5073.239014147834, 6170.598911070766, 6173.753049878044, 6178.598391104564, 6182.0, 6186.381361863778, 5774.162746401832, 5943.138244954544, 6028.367021462684, 6062.787802426894, 6070.150178974859, 6159.315653723893, 6180.81457556274, 6187.350328215653, 6200.937990620036, 6201.658908760061, 5732.885342293047, 5800.622959507618, 5836.095405212199, 5852.648841069549, 5896.941030589639, 5856.3558008618165, 5914.4381283777975, 5918.112283157561, 5935.940640593712, 5939.46544810969, 5809.0, 5837.474627283395, 5848.210491583752, 5866.208061911588, 5884.911726324023, 5683.090705487102, 5805.738741756715, 5812.0, 5847.1229315603, 5869.266341707286, 5784.7107644618445, 5807.564432667482, 5809.419058094326, 5815.5929084963645, 5857.326407463026, 5918.7928422505, 5935.495482884004, 5943.0, 5947.464728174485, 5949.167116603766, 5634.464725851038, 5735.512481438957, 5815.563832712479, 5819.272590926134, 5843.094320380348], "value": 5503.44323217704, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.1837656987337, 657.385344702703, 683.6957553888519, 726.8364617960956, 752.116263390516, 31626.0, 32292.0, 32331.191720207007, 32376.67623323766, 32379.190520237007, 32820.67179328206, 39583.0, 39876.202475950464, 40132.19735605294, 40382.59617403825, 8711.564421778901, 8864.867026994569, 8879.644814207424, 8885.200331970122, 8886.377953543255, 8683.0, 8774.473531588093, 8795.868061979043, 8806.20744133028, 8808.64765409386, 8791.12088791119, 8886.333524985619, 8886.422382545114, 8889.466632002068, 8893.244074253696, 8976.59605317759, 9016.774580635503, 9028.77428064297, 9036.502992335387, 9037.548122593844, 8856.778580535474, 8940.061293564147, 8962.0, 8962.14859588338, 8962.193402593733, 43700.12599748019, 44212.0, 44248.3362749559, 44251.557484425386, 44293.0, 3702.082359144768, 3744.344739670574, 3887.1836914248042, 4165.312723400635, 4468.352088947117, 33065.0, 33104.17239569006, 33201.3359732804, 33273.0, 33435.83282083598, 4483.30508771141, 4513.796879140446, 4555.567221113989, 4562.520935301779, 4577.29051996941, 314051.0, 314231.0, 315359.0, 315691.0, 315947.0, 62466.0, 62516.37483625196, 62908.68545657334, 62911.685441572496, 63018.36981630217, 65129.67435162794, 65520.0, 68744.0, 69042.65478672575, 69741.30258697449, 18780.624387512173, 18922.24311027571, 18969.715454268196, 18983.0, 18986.62026759457, 15383.538493845203, 15389.153596552296, 15452.84547154514, 15517.068975861259, 15523.0, 20806.375808725763, 21126.57746845085, 21167.0, 21186.093251607123, 21192.78807211908, 7371.926280737124, 7482.656837626117, 7633.6564854581675, 7766.0, 7768.145503994556, 1151.117788102794, 1156.6587856582328, 1195.4261954262004, 1206.8913797758069, 1283.3006011723633, 34581.654183457846, 34644.30711385758, 34761.82619086889, 35181.0, 35513.46729799055, 1204.7771162334996, 1220.0422668205417, 1299.811527328532, 1316.1971197569476, 1322.4710115953503, 17643.20605572752, 18396.63206735858, 18406.539836504195, 18478.815211847977, 18525.258989640533, 486599.0, 530160.0, 540211.0, 540371.0, 541398.0, 64411.355886440535, 64897.35102648913, 65245.347546523924, 65445.67277163584, 65566.34433655602, 1402.8386735525546, 1497.4833682379563, 1501.5795577238391, 1518.5975716435153, 1557.6962492314117, 31352.37295254128, 32010.0, 32232.677673223905, 32731.836340818143, 32865.0, 48223.5177648219, 49102.50897491122, 49161.0, 49174.75412622914, 49223.507764921895, 272349.0, 276491.0, 277506.0, 277637.0, 278212.0, 28024.29939251535, 31222.843885780425, 31429.68570314359, 31458.685413145577, 32105.518417223295, 45320.32019519776, 53856.0, 54164.72917635387, 54381.45618543922, 54885.1767223484, 39334.213315734094, 39795.60204397919, 40071.0, 40314.596854031086, 40707.38938915859, 38066.42900356552, 40978.79510602428, 42623.360649590904, 43081.353779693956, 43538.0, 43332.26670933127, 44065.77967110272, 44502.0, 44606.0, 44691.776541117084, 36553.63446365609, 37714.811425942695, 38020.42969355406, 38064.42903356397, 38254.61745382511, 29102.417951640426, 29644.55533167047, 29918.25204369908, 29968.25079373033, 30237.697623023487], "value": 20693.312364456982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.7370096287893, 408.86303088465365, 419.8341655046257, 433.20074462616464, 441.3606632338615, 17694.82305176948, 18212.544686382847, 18707.906460467697, 18751.62496750066, 18808.0, 18070.186841592127, 18373.356932507333, 18417.17122729477, 19097.331593394232, 19224.61550768984, 5689.118186681061, 5813.389594092623, 5866.626689653445, 5953.077273022688, 5979.372165922581, 5751.281089863767, 5773.0, 5821.09772985188, 5827.446392592697, 5834.21238132853, 5708.628939118944, 5735.426457354273, 5804.187413762077, 5805.10020946754, 5810.680412577307, 5810.099434587646, 5835.474807267324, 5850.385709500484, 5855.151003104547, 5867.8533036674, 5137.3064636274, 5249.396319423277, 5263.921041184385, 5272.393674727378, 5273.419923808378, 21759.564808703897, 22889.77110228893, 23215.419614509603, 23237.419064523354, 23339.0, 2457.8893949772305, 2719.8912043518235, 2828.3494796196783, 2880.5823155642524, 3161.193895556641, 10011.399316041061, 10250.897491025069, 10272.28094033418, 10309.948450257776, 10752.0, 2023.251396983111, 2054.3323419888447, 2070.3167954575106, 2100.3488918435182, 2166.5991791518463, 73682.0, 74975.6514479934, 75352.0, 76971.61514192449, 78570.60714696447, 11205.495752691148, 11357.318560886373, 11439.542418303341, 11466.140039497071, 11665.65003049893, 16143.434979775886, 16224.756628650579, 16342.346306147858, 16385.50843474698, 16398.426055088014, 8833.0, 8847.159519845733, 8863.183047475251, 8901.73294801157, 8979.640814367483, 8711.47731136134, 8728.519931403707, 8772.298216142693, 8849.070847560914, 8900.510471924106, 4889.926651100236, 4944.3572335596145, 4960.355153829979, 4964.776585053609, 4973.477784832613, 1978.4855937456366, 1984.3154111831395, 2082.91668333268, 2119.63966125759, 2132.5521640455368, 499.71016810249967, 517.3378076062646, 986.3342243985425, 1107.4352080439035, 1178.9941050294694, 17825.643487130186, 19144.712829307573, 19206.0, 19585.60828783445, 20174.394768156977, 1100.4167791070745, 1109.0739232740752, 1113.2708076210095, 1142.0, 1149.3908228638834, 10907.236493445542, 10920.2901811382, 10925.672229833117, 11012.944935275273, 11056.447177641086, 485845.0, 506404.0, 508038.0, 511030.0, 524850.0, 65604.67197664076, 81354.0, 83379.0, 92270.53864730634, 95654.52172739092, 1096.8263957565327, 1150.4765331773856, 1161.814948752268, 1162.1922763679163, 1170.0288760328906, 16662.66674666524, 17197.398091066752, 17331.480055598353, 17452.21465034102, 17763.20065597077, 38437.80781096077, 38594.0, 38875.0, 38959.2208155841, 39415.0, 54732.726336369655, 57145.71427142838, 57546.7122664384, 58218.12672809996, 58611.413885860595, 11484.449599303987, 11828.408579570814, 12357.567485137977, 12435.626931191717, 12544.686382840502, 13656.453741850215, 13753.793693094813, 13795.862041379458, 13872.514461993782, 14024.0, 12233.571824986082, 12273.815892761795, 12542.686432839251, 12550.497980080694, 12765.0, 12005.459754311252, 12028.458719357825, 12057.899427877184, 12518.248905065726, 12665.561260163606, 6386.840328991627, 8457.492550446992, 9160.404573702688, 11272.774544509228, 12644.620661380173, 12689.048321375749, 12694.428750706056, 12839.229646221256, 12852.807207892076, 12876.034297427543, 12473.812892806796, 12560.937195313965, 12639.810402844148, 12780.0, 13039.282839443542], "value": 9571.16144412848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.5078547900985, 1594.561495588713, 1600.9839901600983, 1842.3920106364892, 1933.3040105561995, 8013.278804907557, 8115.107338192802, 8120.187981201877, 8135.105138434782, 8138.226868447496, 8114.594270286491, 8279.586020698956, 8288.751337459886, 8289.58552072397, 8293.419460637759, 2314.0975019742314, 2339.847909885852, 2345.0268138722495, 2345.2026311054237, 2347.8708671023087, 2375.6911601491784, 2428.9757102429016, 2431.7932975697, 2447.865367404792, 2451.117597664839, 2294.1511640692966, 2315.733690625574, 2322.7328857181474, 2324.3491822289784, 2326.0230703104653, 2357.4106473381653, 2378.52429514097, 2386.188695843413, 2390.1156572068444, 2399.844010139344, 2342.8711420871846, 2405.542946840095, 2413.4931664350506, 2413.710354757423, 2414.167112346238, 7425.888611670829, 8183.0, 8435.451695639826, 8471.534065626389, 8483.321334293303, 5248.6588371755715, 5347.037533244014, 5383.569314454834, 5387.326584176978, 5406.783728650849, 3428.6914177724125, 3437.6906078453057, 3450.6549345065546, 3491.877784277538, 3506.9649303506894, 1095.4632230207142, 1096.0847692177042, 1106.7675788084512, 1112.8775834658181, 1127.577158565538, 11812.881871181264, 12279.201851879689, 12288.754224915452, 12291.754164916652, 12293.877061229363, 4760.690555113906, 4821.9035619287415, 4860.3681521401995, 4874.707517548958, 4904.901901961941, 10504.317219380715, 10537.525811338508, 10545.367277963347, 10548.683539493828, 10569.312994655324, 5502.2296878437055, 5533.501984821385, 5536.141898005815, 5537.058700021006, 5554.1113421853115, 5006.023825354021, 5061.215511595708, 5061.240813877947, 5069.822556210515, 5070.518300761421, 3915.275674000319, 4003.6596889264156, 4031.7580945143386, 4044.312466880637, 4048.109415928491, 1277.150694787974, 1287.5171810571037, 1293.715382615823, 1298.8766067223598, 1303.3418123847587, 964.5755867418313, 1031.242037102729, 1045.6026709850207, 1053.9209559283083, 1087.2009073331096, 5826.76692932278, 5906.2912450505355, 5919.881602367928, 6096.177016102858, 6100.0, 960.9039096090335, 1008.9192864570816, 1010.3079390617451, 1029.3000759483623, 1088.9564417423373, 4114.403411505315, 4134.751914885116, 4138.565450627701, 4138.813753381105, 4151.626353628188, 10520.26358154937, 10931.45342732876, 10998.175136864767, 11001.834972475419, 11005.284656497302, 10794.0, 10826.350418974887, 10830.783384332426, 10836.133109351233, 10845.349279043283, 8294.751157465285, 8342.874856877152, 8355.623996920032, 8459.365547583955, 8512.106228846005, 5987.6108052976415, 6022.277326720821, 6038.305594856648, 6058.515318774399, 6210.906836397548, 8886.200241978253, 9080.40977336471, 9209.401388909699, 9250.814983700153, 9341.205997490018, 9172.587233574639, 9176.862347064665, 9370.718878433658, 9376.718698439057, 9390.014048524807, 7453.664585093576, 7820.335271501986, 7825.217478252129, 7829.960850195713, 7843.137254902071, 8239.588020599065, 8254.504729716236, 8270.751877443687, 8349.54077525742, 8361.707340243061, 7708.730194443392, 7749.573773442515, 7768.961155194188, 7787.844243115219, 7826.569538675428, 7375.631218438949, 7522.097348318237, 7562.395008399425, 7644.847103058019, 7658.119316278699, 7263.382612477999, 7391.741289054858, 7441.4046876248685, 7448.73929412468, 7450.664720087718, 5471.452854714496, 5492.258545096361, 5522.5858060646415, 5620.915686264628, 5652.802151924663, 5291.411808140161, 5299.0, 5310.707911064774, 5328.57371410294, 5494.752736126804], "value": 4686.939641140436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.46717259973036, 368.80821972574245, 369.7153192042128, 375.3281625889657, 378.02658155250236, 6065.181200537926, 6073.969630151854, 6083.239595050619, 6103.267607887049, 6122.663253521055, 5890.204822348982, 6066.30237522685, 6067.605605635631, 6069.57512974092, 6071.969640151793, 4668.85993420198, 4724.433068031841, 4757.500462451445, 4761.785719642625, 4767.618590512768, 4720.787564559586, 4754.6434017448655, 4785.736784476852, 4797.2324428091515, 4806.9038619227595, 4506.459224893001, 4604.424446944132, 4778.80884764609, 4779.498152693969, 4782.1153086678905, 4681.946562023518, 4693.366395536593, 4694.037722266927, 4696.342512048316, 4729.787159577827, 4175.789021183853, 4178.289690752549, 4183.0, 4188.183304255671, 4192.874213773592, 5859.1797148399255, 5895.29256489224, 5900.734466948998, 5902.881942361171, 5910.497607703351, 5487.945120548823, 5492.395836457987, 5495.0, 5500.22996780451, 5502.394736579013, 6209.968950155266, 6418.967905160491, 6461.6123032617725, 6464.773732919372, 6471.579347342407, 4540.364348991144, 4542.818287268506, 4558.042811009692, 4566.634669226454, 4585.3122031695175, 6693.196816382017, 6755.290694477058, 6763.932360676428, 6770.086038384804, 6775.051492791063, 4682.719036857731, 4683.110209060268, 4683.431050598019, 4686.203345431217, 4687.9765601171775, 4734.0058587696285, 4739.170645137087, 4739.478657347689, 4742.4309082909585, 4745.264484004916, 5404.243405923174, 5448.509634132947, 5455.318085239345, 5455.699936503451, 5463.48096930791, 6330.873382532323, 6485.643289619116, 6502.577332473374, 6505.4795616350575, 6512.6092434454085, 1627.2026706913528, 1631.217015832407, 1635.051670031379, 1638.4019832761194, 1641.8686505079565, 1015.1523477896039, 1056.487603512296, 1083.1659622091104, 1084.414416215235, 1107.6621630402803, 6214.25428948529, 6217.564770466024, 6218.9378106218355, 6259.874802504016, 6276.403741644536, 6578.967105164539, 6632.071509988606, 6636.83407914806, 6639.767608133692, 6642.63465509392, 6172.105044768484, 6174.8147555573405, 6181.320054793969, 6188.504919606421, 6232.470240029557, 3532.929341413209, 3580.0870777951454, 3586.372384832644, 3589.7128229741556, 3592.4072528033103, 6689.4982876284475, 6912.688928998207, 6923.6884340204815, 6930.237673855871, 6938.722451102, 6692.933070669328, 6707.966460167766, 6725.2602213756445, 6730.293319201512, 6737.562058466184, 6913.2049814272, 6913.51605387618, 6915.654217289115, 6920.30796920304, 6923.0, 6620.900686489803, 6626.337366263335, 6631.104800851823, 6632.2372927114, 6640.83397915056, 6391.296957334783, 6508.869822603616, 6669.53313268086, 6673.699683514351, 6678.365555272241, 7034.437245020488, 7058.400035996792, 7066.505344625827, 7066.7173313066905, 7069.893951590833, 4557.430321209848, 4590.324531546028, 4598.678092533491, 4599.931001035054, 4603.056373443503, 6728.529002969745, 6740.6966686498245, 6741.2921643226755, 6746.730130794714, 6748.561343512656, 6369.363063693593, 6536.8365790855605, 6540.476761858945, 6549.934500654933, 6550.508711846535, 6478.611283323015, 6521.119648847345, 6530.771423000172, 6531.987541931008, 6532.640704761284, 6417.8716425672155, 6424.839379015375, 6430.356964303533, 6436.712657468432, 6438.67806609677, 6579.374959379043, 6580.80257592273, 6581.934180658132, 6585.242697089896, 6589.769358072444, 5971.880562388815, 6126.0, 6297.1813664223355, 6335.809925702236, 6430.967845160744], "value": 4913.841120636957, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.1564919431372, 847.0428415890043, 890.8619164029574, 913.2602193419741, 937.0535758883526, 14219.71560568788, 14365.425382984668, 14372.712545749106, 14416.423343066277, 14440.927795361009, 14103.78844317336, 15105.697886042273, 15216.619584510392, 15234.0, 15243.618909527268, 765.4412279036306, 889.1020069729587, 894.9105089491047, 903.9141281578239, 912.5209265135791, 898.3711402018613, 909.295296145486, 912.3841407050247, 913.8309412758628, 914.021996463784, 939.1876027236459, 940.4498368454463, 943.8961714211431, 946.8059047895199, 949.710338346804, 774.0, 930.6928713524588, 932.6129656192672, 941.9387739796891, 949.4730424614336, 686.7218776395567, 689.0663151429791, 691.1464341538197, 692.0622556436057, 692.8926016467456, 14781.630459238497, 14800.333984970703, 14815.703685926328, 14828.851711482856, 14856.702865942729, 14400.855991440056, 14975.625609359744, 15077.773833392508, 15104.697906041927, 15139.318730657147, 12220.388980551026, 12262.325572093532, 12454.190477618926, 12456.439460224221, 12507.249565026037, 4073.144639625682, 4116.341385378355, 4121.814518346681, 4127.8968025799295, 4169.4162817205315, 52466.0, 52522.0, 52531.47468525304, 52685.20972185459, 52710.47289527133, 10519.737006574744, 10897.618583349546, 11239.60661376848, 11315.094792416587, 11529.423528823525, 19205.32781352646, 19287.0, 19464.610707785763, 19536.60926781485, 19583.412497625093, 8145.307648849915, 8289.461185022954, 8385.6226469809, 8598.011228708654, 8626.0, 4664.673472856935, 4710.152172608895, 4774.594159496412, 4789.688670236424, 4871.244957031666, 3470.0804286864, 3571.821408929543, 3574.7855128692363, 3585.1933315003917, 3675.0, 664.6510581944518, 673.3367632881608, 673.4208580620663, 675.0582936803132, 677.2584020497547, 622.2097935621736, 756.2059837170948, 765.7281665008842, 767.6392095715005, 776.2974508070206, 9604.423734575808, 9814.0, 9931.255155863339, 9969.30214884951, 10047.24645651579, 777.8716511775493, 792.4928046050533, 792.84935862186, 814.6011537696486, 817.235884448043, 4594.908101837945, 4649.279361698942, 4679.883002924954, 4708.976455117771, 4718.31584420264, 63295.0, 63662.36337636657, 64368.781560921765, 64377.356226438074, 64498.67750661217, 54517.1822422664, 56519.0, 56804.43195568074, 56976.14535781967, 57221.427785722444, 49154.26268605974, 49551.50448495469, 49769.75115124401, 50510.24234636484, 50746.746266268434, 9301.906980930375, 9365.484898330657, 9454.290928180551, 9488.0, 9517.095875891779, 38998.4150237741, 39107.80446097865, 40444.0, 40503.59496405116, 40593.1881362377, 43070.138597228506, 44477.33284000678, 48239.5176048235, 48280.7585962082, 48578.75710621566, 12909.483620655068, 12944.870551294367, 13186.208827470382, 13227.867721322664, 13327.400266988203, 14305.71388572202, 14455.277236138361, 14535.345909434312, 14564.635884102981, 14565.635859103608, 13389.598312050653, 13405.195688258736, 13435.193888366339, 13525.864741352854, 13812.240326782123, 13652.522161724291, 13804.93097534506, 14048.859511404755, 14199.29003549839, 14466.27668616586, 12922.0, 13035.348232588522, 13782.517611883937, 13799.310034498034, 13833.377498012413, 11105.666829995112, 11316.0, 11412.201145919706, 11558.0, 11571.007083984148, 10595.417252051211, 11139.665810025712, 11191.32852028881, 11238.83141752858, 11290.0], "value": 7155.430299583857, "unit": "score"}], "name": "dromaeo_css", "value": 7511.659843723773, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 111.0, 112.0, 112.0, 104.0, 110.0, 109.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 155.0, 177.0, 134.0, 158.0, 154.0, 133.0, 186.0, 132.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 159.0, 160.0, 162.0, 161.0, 161.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 74.0, 177.0, 77.0, 74.0, 77.0, 75.0, 159.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 153.0, 91.0, 93.0, 93.0, 146.0, 91.0, 93.0, 146.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 54.0, 53.0, 55.0, 73.0, 51.0, 52.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 72.0, 74.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 113.0, 116.0, 111.0, 120.0, 111.0, 113.0, 114.0, 139.0, 122.0], "value": 118.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 156.0, 156.0, 157.0, 156.0, 159.0, 155.0, 156.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 72.0, 64.0, 66.0, 65.0, 75.0, 65.0, 65.0, 64.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1510.3000000000002, "alertThreshold": 2.0}]} 02:11:52 INFO - Return code: 0 02:11:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:11:52 ERROR - # TBPL SUCCESS # 02:11:52 INFO - Running post-action listener: _resource_record_post_action 02:11:52 INFO - Running post-run listener: _resource_record_post_run 02:11:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 481464320; Read time: 0; Write time: 466196 02:11:53 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 242548736; Read time: 0; Write time: 330512 02:11:53 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 221696000; Read time: 0; Write time: 127988 02:11:53 INFO - Running post-run listener: _upload_blobber_files 02:11:53 INFO - Blob upload gear active. 02:11:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:11:53 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:53 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:53 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:53 INFO - (blobuploader) - INFO - Open directory for files ... 02:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:54 INFO - (blobuploader) - INFO - Done attempting. 02:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:55 INFO - (blobuploader) - INFO - Done attempting. 02:11:55 INFO - (blobuploader) - INFO - Iteration through files over. 02:11:55 INFO - Return code: 0 02:11:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:11:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:11:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/843ac333fa1f5d1c57b0797422f04bc7dd22356f499925078dfdea22a0fa7ea7b9799d1a15fc05bb0f6ee7b1637af01e3f96f0153f3e0946790cd26153575024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cbb9f0fcb265545e9456c02e1129b47d9e953d4489092df28ca39839cf035682b082d5046419c0a9fea4210b80d4a7703703accfd3891c0a000e473c65b7396"} 02:11:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:11:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:11:55 INFO - Contents: 02:11:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/843ac333fa1f5d1c57b0797422f04bc7dd22356f499925078dfdea22a0fa7ea7b9799d1a15fc05bb0f6ee7b1637af01e3f96f0153f3e0946790cd26153575024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cbb9f0fcb265545e9456c02e1129b47d9e953d4489092df28ca39839cf035682b082d5046419c0a9fea4210b80d4a7703703accfd3891c0a000e473c65b7396"} 02:11:55 INFO - Running post-run listener: copy_logs_to_upload_dir 02:11:55 INFO - Copying logs to upload dir... 02:11:55 INFO - mkdir: /builds/slave/test/build/upload/logs 02:11:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.183905 ========= master_lag: 0.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-28 02:11:55.961980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:55.970488) ========= 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=232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339 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/843ac333fa1f5d1c57b0797422f04bc7dd22356f499925078dfdea22a0fa7ea7b9799d1a15fc05bb0f6ee7b1637af01e3f96f0153f3e0946790cd26153575024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cbb9f0fcb265545e9456c02e1129b47d9e953d4489092df28ca39839cf035682b082d5046419c0a9fea4210b80d4a7703703accfd3891c0a000e473c65b7396"} 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.011082 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/843ac333fa1f5d1c57b0797422f04bc7dd22356f499925078dfdea22a0fa7ea7b9799d1a15fc05bb0f6ee7b1637af01e3f96f0153f3e0946790cd26153575024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cbb9f0fcb265545e9456c02e1129b47d9e953d4489092df28ca39839cf035682b082d5046419c0a9fea4210b80d4a7703703accfd3891c0a000e473c65b7396"}' ========= master_lag: 0.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:56.540337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:56.540674) ========= 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=232498196343f89f466a4a9a000001c8-1467103603.944046-1432829339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:56.624893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:11:56.625235) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:11:56.660445) ========= ========= Total master_lag: 1.59 =========