builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1465277005.51 results: success (0) buildid: 20160606194329 builduid: 3d31ab4f42854c829e06ac6160cc676b revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.508393) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.508842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.509117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.566015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.566270) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 22:23:25-- 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.7M=0s 2016-06-06 22:23:25 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140680 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.746367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.746684) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.107877 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.866407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:25.866809) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --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 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --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=516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 22:23:26,134 truncating revision to first 12 chars 2016-06-06 22:23:26,134 Setting DEBUG logging. 2016-06-06 22:23:26,134 attempt 1/10 2016-06-06 22:23:26,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1f9f6bdee31c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 22:23:26,521 unpacking tar archive at: mozilla-beta-1f9f6bdee31c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:26.636217) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:26.636541) ========= script_repo_revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:26.636936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:26.637206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 22:23:26.644995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-06 22:23:26.645259) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:23:27 INFO - MultiFileLogger online at 20160606 22:23:27 in /builds/slave/test 22:23:27 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 22:23:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:23:27 INFO - {'append_to_log': False, 22:23:27 INFO - 'base_work_dir': '/builds/slave/test', 22:23:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:23:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:23:27 INFO - 'branch': 'Mozilla-Beta', 22:23:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:23:27 INFO - 'config_files': ('talos/linux_config.py',), 22:23:27 INFO - 'default_actions': ('clobber', 22:23:27 INFO - 'read-buildbot-config', 22:23:27 INFO - 'download-and-extract', 22:23:27 INFO - 'populate-webroot', 22:23:27 INFO - 'create-virtualenv', 22:23:27 INFO - 'install', 22:23:27 INFO - 'run-tests'), 22:23:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:23:27 INFO - 'download_minidump_stackwalk': True, 22:23:27 INFO - 'download_symbols': 'ondemand', 22:23:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:23:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:23:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:23:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:23:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:23:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:23:27 INFO - 'installer_path': 'installer.exe', 22:23:27 INFO - 'log_level': 'info', 22:23:27 INFO - 'log_name': 'talos', 22:23:27 INFO - 'log_to_console': True, 22:23:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:23:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:23:27 INFO - 'opt_config_files': (), 22:23:27 INFO - 'pip_index': False, 22:23:27 INFO - 'sps_profile': False, 22:23:27 INFO - 'sps_profile_interval': 0, 22:23:27 INFO - 'suite': 'dromaeojs', 22:23:27 INFO - 'system_bits': '32', 22:23:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:23:27 INFO - 'title': 'talos-linux64-ix-061', 22:23:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:23:27 INFO - 'use_talos_json': True, 22:23:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:23:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:23:27 INFO - 'work_dir': 'build'} 22:23:27 INFO - ##### 22:23:27 INFO - ##### Running clobber step. 22:23:27 INFO - ##### 22:23:27 INFO - Running pre-action listener: _resource_record_pre_action 22:23:27 INFO - Running main action method: clobber 22:23:27 INFO - rmtree: /builds/slave/test/build 22:23:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:23:29 INFO - Running post-action listener: _resource_record_post_action 22:23:29 INFO - ##### 22:23:29 INFO - ##### Running read-buildbot-config step. 22:23:29 INFO - ##### 22:23:29 INFO - Running pre-action listener: _resource_record_pre_action 22:23:29 INFO - Running main action method: read_buildbot_config 22:23:29 INFO - Using buildbot properties: 22:23:29 INFO - { 22:23:29 INFO - "project": "", 22:23:29 INFO - "product": "firefox", 22:23:29 INFO - "script_repo_revision": "production", 22:23:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 22:23:29 INFO - "repository": "", 22:23:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 22:23:29 INFO - "buildid": "20160606194329", 22:23:29 INFO - "pgo_build": "True", 22:23:29 INFO - "basedir": "/builds/slave/test", 22:23:29 INFO - "buildnumber": 34, 22:23:29 INFO - "slavename": "talos-linux64-ix-061", 22:23:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:23:29 INFO - "platform": "ubuntu64_hw", 22:23:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:23:29 INFO - "branch": "mozilla-beta", 22:23:29 INFO - "repo_path": "releases/mozilla-beta", 22:23:29 INFO - "revision": "1f9f6bdee31c14fd5a39485e8ae326de2928ef7d", 22:23:29 INFO - "stage_platform": "linux64-pgo", 22:23:29 INFO - "builduid": "3d31ab4f42854c829e06ac6160cc676b", 22:23:29 INFO - "slavebuilddir": "test" 22:23:29 INFO - } 22:23:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 22:23:29 INFO - Running post-action listener: _resource_record_post_action 22:23:29 INFO - ##### 22:23:29 INFO - ##### Running download-and-extract step. 22:23:29 INFO - ##### 22:23:29 INFO - Running pre-action listener: _resource_record_pre_action 22:23:29 INFO - Running main action method: download_and_extract 22:23:29 INFO - mkdir: /builds/slave/test/build/tests 22:23:29 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')]} 22:23:29 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:23:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:23:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:23:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:32 INFO - Downloaded 1327 bytes. 22:23:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:23:32 INFO - Using the following test package requirements: 22:23:32 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:23:32 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:23:32 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 22:23:32 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'jsshell-linux-x86_64.zip'], 22:23:32 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:23:32 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:23:32 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 22:23:32 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 22:23:32 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:23:32 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:23:32 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:23:32 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:23: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')]} 22:23:32 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:23:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:23:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:23:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:36 INFO - Downloaded 24176679 bytes. 22:23:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:23:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:23:38 INFO - Return code: 0 22:23:38 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 22:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:38 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:23:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:23:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:23:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:40 INFO - Downloaded 24176679 bytes. 22:23:40 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'] 22:23:40 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 22:23:42 INFO - Return code: 0 22:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:42 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:43 INFO - Downloaded 10840145 bytes. 22:23:43 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'] 22:23:43 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 22:23:43 INFO - Return code: 0 22:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:43 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 22:23:44 INFO - Downloaded 55996763 bytes. 22:23:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:23:44 INFO - mkdir: /builds/slave/test/properties 22:23:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:23:44 INFO - Writing to file /builds/slave/test/properties/build_url 22:23:44 INFO - Contents: 22:23:44 INFO - build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:23:45 INFO - Running post-action listener: _resource_record_post_action 22:23:45 INFO - Running post-action listener: set_extra_try_arguments 22:23:45 INFO - ##### 22:23:45 INFO - ##### Running populate-webroot step. 22:23:45 INFO - ##### 22:23:45 INFO - Running pre-action listener: _resource_record_pre_action 22:23:45 INFO - Running main action method: populate_webroot 22:23:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:23:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:23:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:23:45 INFO - '--tppagecycles', 22:23:45 INFO - '7'], 22:23:45 INFO - 'tests': ['tsvgm']}}, 22:23:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:23:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:23:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:23:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:23:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:23:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:23:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['damp', 'tps']}, 22:23:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'tests': ['damp', 'tps']}, 22:23:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['dromaeo_dom']}, 22:23:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:23:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['a11yr', 22:23:45 INFO - 'ts_paint', 22:23:45 INFO - 'tpaint', 22:23:45 INFO - 'sessionrestore', 22:23:45 INFO - 'sessionrestore_no_auto_restore', 22:23:45 INFO - 'tabpaint']}, 22:23:45 INFO - 'other-e10s': {'tests': ['a11yr', 22:23:45 INFO - 'ts_paint', 22:23:45 INFO - 'tpaint', 22:23:45 INFO - 'sessionrestore', 22:23:45 INFO - 'sessionrestore_no_auto_restore', 22:23:45 INFO - 'tabpaint']}, 22:23:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:23:45 INFO - 'ts_paint', 22:23:45 INFO - 'tpaint', 22:23:45 INFO - 'sessionrestore', 22:23:45 INFO - 'sessionrestore_no_auto_restore', 22:23:45 INFO - 'tabpaint']}, 22:23:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:23:45 INFO - 'ts_paint', 22:23:45 INFO - 'tpaint', 22:23:45 INFO - 'sessionrestore', 22:23:45 INFO - 'sessionrestore_no_auto_restore', 22:23:45 INFO - 'tabpaint']}, 22:23:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['a11yr', 22:23:45 INFO - 'ts_paint', 22:23:45 INFO - 'tpaint', 22:23:45 INFO - 'sessionrestore', 22:23:45 INFO - 'sessionrestore_no_auto_restore', 22:23:45 INFO - 'tabpaint']}, 22:23:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['a11yr', 22:23:45 INFO - 'ts_paint', 22:23:45 INFO - 'tpaint', 22:23:45 INFO - 'sessionrestore', 22:23:45 INFO - 'sessionrestore_no_auto_restore', 22:23:45 INFO - 'tabpaint']}, 22:23:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['tsvgx', 22:23:45 INFO - 'tsvgr_opacity', 22:23:45 INFO - 'tart', 22:23:45 INFO - 'tscrollx', 22:23:45 INFO - 'cart']}, 22:23:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:23:45 INFO - 'tsvgr_opacity', 22:23:45 INFO - 'tart', 22:23:45 INFO - 'tscrollx', 22:23:45 INFO - 'cart']}, 22:23:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'talos_options': ['--disable-e10s'], 22:23:45 INFO - 'tests': ['tp5o']}, 22:23:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'tests': ['tp5o']}, 22:23:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'talos_options': ['--disable-e10s', 22:23:45 INFO - '--xperf_path', 22:23:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:23:45 INFO - 'tests': ['tp5n']}, 22:23:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:45 INFO - 'talos_options': ['--xperf_path', 22:23:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:23:45 INFO - 'tests': ['tp5n']}}, 22:23:45 INFO - 'talos.zip': {'path': '', 22:23:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:23:45 INFO - Running post-action listener: _resource_record_post_action 22:23:45 INFO - ##### 22:23:45 INFO - ##### Running create-virtualenv step. 22:23:45 INFO - ##### 22:23:45 INFO - Running pre-action listener: _resource_record_pre_action 22:23:45 INFO - Running main action method: create_virtualenv 22:23:45 INFO - Creating virtualenv /builds/slave/test/build/venv 22:23:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:23:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:23:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:23:45 INFO - Using real prefix '/usr' 22:23:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:23:46 INFO - Installing distribute.............................................................................................................................................................................................done. 22:23:48 INFO - Installing pip.................done. 22:23:48 INFO - Return code: 0 22:23:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:23: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')]} 22:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23: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')]} 22:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:23:48 INFO - Using env: {'DISPLAY': ':0', 22:23:48 INFO - 'HOME': '/home/cltbld', 22:23:48 INFO - 'LANG': 'en_US.UTF-8', 22:23:48 INFO - 'LANGUAGE': 'en_US:en', 22:23:48 INFO - 'LOGNAME': 'cltbld', 22:23:48 INFO - 'MAIL': '/var/mail/cltbld', 22:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:48 INFO - 'MOZ_NO_REMOTE': '1', 22:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:48 INFO - 'NO_EM_RESTART': '1', 22:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:48 INFO - 'PWD': '/builds/slave/test', 22:23:48 INFO - 'SHELL': '/bin/bash', 22:23:48 INFO - 'SHLVL': '1', 22:23:48 INFO - 'TERM': 'linux', 22:23:48 INFO - 'TMOUT': '86400', 22:23:48 INFO - 'USER': 'cltbld', 22:23:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:48 INFO - '_': '/tools/buildbot/bin/python'} 22:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:23:49 INFO - Cleaning up... 22:23:49 INFO - Return code: 0 22:23:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:23:49 INFO - Using env: {'DISPLAY': ':0', 22:23:49 INFO - 'HOME': '/home/cltbld', 22:23:49 INFO - 'LANG': 'en_US.UTF-8', 22:23:49 INFO - 'LANGUAGE': 'en_US:en', 22:23:49 INFO - 'LOGNAME': 'cltbld', 22:23:49 INFO - 'MAIL': '/var/mail/cltbld', 22:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:49 INFO - 'MOZ_NO_REMOTE': '1', 22:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:49 INFO - 'NO_EM_RESTART': '1', 22:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:49 INFO - 'PWD': '/builds/slave/test', 22:23:49 INFO - 'SHELL': '/bin/bash', 22:23:49 INFO - 'SHLVL': '1', 22:23:49 INFO - 'TERM': 'linux', 22:23:49 INFO - 'TMOUT': '86400', 22:23:49 INFO - 'USER': 'cltbld', 22:23:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:49 INFO - '_': '/tools/buildbot/bin/python'} 22:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:49 INFO - Downloading/unpacking psutil>=0.7.1 22:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:23:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:51 INFO - Installing collected packages: psutil 22:23:51 INFO - Running setup.py install for psutil 22:23:51 INFO - building 'psutil._psutil_linux' extension 22:23:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:23:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:23:52 INFO - building 'psutil._psutil_posix' extension 22:23:52 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 22:23:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:52 INFO - Successfully installed psutil 22:23:52 INFO - Cleaning up... 22:23:53 INFO - Return code: 0 22:23:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:23:53 INFO - Using env: {'DISPLAY': ':0', 22:23:53 INFO - 'HOME': '/home/cltbld', 22:23:53 INFO - 'LANG': 'en_US.UTF-8', 22:23:53 INFO - 'LANGUAGE': 'en_US:en', 22:23:53 INFO - 'LOGNAME': 'cltbld', 22:23:53 INFO - 'MAIL': '/var/mail/cltbld', 22:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:53 INFO - 'MOZ_NO_REMOTE': '1', 22:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:53 INFO - 'NO_EM_RESTART': '1', 22:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:53 INFO - 'PWD': '/builds/slave/test', 22:23:53 INFO - 'SHELL': '/bin/bash', 22:23:53 INFO - 'SHLVL': '1', 22:23:53 INFO - 'TERM': 'linux', 22:23:53 INFO - 'TMOUT': '86400', 22:23:53 INFO - 'USER': 'cltbld', 22:23:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:53 INFO - '_': '/tools/buildbot/bin/python'} 22:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:23:55 INFO - Installing collected packages: mozsystemmonitor 22:23:55 INFO - Running setup.py install for mozsystemmonitor 22:23:55 INFO - Successfully installed mozsystemmonitor 22:23:55 INFO - Cleaning up... 22:23:55 INFO - Return code: 0 22:23:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:55 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 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:23:55 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 22:23:55 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 22:23:55 INFO - Using env: {'DISPLAY': ':0', 22:23:55 INFO - 'HOME': '/home/cltbld', 22:23:55 INFO - 'LANG': 'en_US.UTF-8', 22:23:55 INFO - 'LANGUAGE': 'en_US:en', 22:23:55 INFO - 'LOGNAME': 'cltbld', 22:23:55 INFO - 'MAIL': '/var/mail/cltbld', 22:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:55 INFO - 'MOZ_NO_REMOTE': '1', 22:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:55 INFO - 'NO_EM_RESTART': '1', 22:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:55 INFO - 'PWD': '/builds/slave/test', 22:23:55 INFO - 'SHELL': '/bin/bash', 22:23:55 INFO - 'SHLVL': '1', 22:23:55 INFO - 'TERM': 'linux', 22:23:55 INFO - 'TMOUT': '86400', 22:23:55 INFO - 'USER': 'cltbld', 22:23:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:55 INFO - '_': '/tools/buildbot/bin/python'} 22:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:55 INFO - Downloading/unpacking blobuploader==1.2.4 22:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:57 INFO - Downloading blobuploader-1.2.4.tar.gz 22:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:23:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:23:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23:58 INFO - Downloading docopt-0.6.1.tar.gz 22:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:23:58 INFO - Installing collected packages: blobuploader, requests, docopt 22:23:58 INFO - Running setup.py install for blobuploader 22:23:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:23:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:23:58 INFO - Running setup.py install for requests 22:23:58 INFO - Running setup.py install for docopt 22:23:58 INFO - Successfully installed blobuploader requests docopt 22:23:58 INFO - Cleaning up... 22:23:58 INFO - Return code: 0 22:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:23:58 INFO - Using env: {'DISPLAY': ':0', 22:23:58 INFO - 'HOME': '/home/cltbld', 22:23:58 INFO - 'LANG': 'en_US.UTF-8', 22:23:58 INFO - 'LANGUAGE': 'en_US:en', 22:23:58 INFO - 'LOGNAME': 'cltbld', 22:23:58 INFO - 'MAIL': '/var/mail/cltbld', 22:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:58 INFO - 'MOZ_NO_REMOTE': '1', 22:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:58 INFO - 'NO_EM_RESTART': '1', 22:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:58 INFO - 'PWD': '/builds/slave/test', 22:23:58 INFO - 'SHELL': '/bin/bash', 22:23:58 INFO - 'SHLVL': '1', 22:23:58 INFO - 'TERM': 'linux', 22:23:58 INFO - 'TMOUT': '86400', 22:23:58 INFO - 'USER': 'cltbld', 22:23:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:58 INFO - '_': '/tools/buildbot/bin/python'} 22:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:23:59 INFO - Running setup.py (path:/tmp/pip-zQjrLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:23:59 INFO - Running setup.py (path:/tmp/pip-U7lqVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:23:59 INFO - Running setup.py (path:/tmp/pip-fCm3hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:23:59 INFO - Running setup.py (path:/tmp/pip-Z4sysu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:23:59 INFO - Running setup.py (path:/tmp/pip-34JcQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:23:59 INFO - Running setup.py (path:/tmp/pip-6h0KUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:23:59 INFO - Running setup.py (path:/tmp/pip-rmpYi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:23:59 INFO - Running setup.py (path:/tmp/pip-vHjyyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:23:59 INFO - Running setup.py (path:/tmp/pip-Ml24BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:23:59 INFO - Running setup.py (path:/tmp/pip-umVYGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:23:59 INFO - Running setup.py (path:/tmp/pip-SbeDnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:23:59 INFO - Running setup.py (path:/tmp/pip-aao1dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:00 INFO - Running setup.py (path:/tmp/pip-nbzl1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:00 INFO - Running setup.py (path:/tmp/pip-KDqsJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:00 INFO - Running setup.py (path:/tmp/pip-Yf8X7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:00 INFO - Running setup.py (path:/tmp/pip-TNx2hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:00 INFO - Running setup.py (path:/tmp/pip-59bvd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:24:00 INFO - Running setup.py install for manifestparser 22:24:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Running setup.py install for mozcrash 22:24:00 INFO - Running setup.py install for mozdebug 22:24:00 INFO - Running setup.py install for mozdevice 22:24:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Running setup.py install for mozfile 22:24:00 INFO - Running setup.py install for mozhttpd 22:24:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Running setup.py install for mozinfo 22:24:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Running setup.py install for mozInstall 22:24:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Running setup.py install for mozleak 22:24:01 INFO - Running setup.py install for mozlog 22:24:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Running setup.py install for moznetwork 22:24:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Running setup.py install for mozprocess 22:24:01 INFO - Running setup.py install for mozprofile 22:24:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Running setup.py install for mozrunner 22:24:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:24:01 INFO - Running setup.py install for mozscreenshot 22:24:01 INFO - Running setup.py install for moztest 22:24:02 INFO - Running setup.py install for mozversion 22:24:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:24:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:02 INFO - Cleaning up... 22:24:02 INFO - Return code: 0 22:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:02 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 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:24:02 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 22:24:02 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 22:24:02 INFO - Using env: {'DISPLAY': ':0', 22:24:02 INFO - 'HOME': '/home/cltbld', 22:24:02 INFO - 'LANG': 'en_US.UTF-8', 22:24:02 INFO - 'LANGUAGE': 'en_US:en', 22:24:02 INFO - 'LOGNAME': 'cltbld', 22:24:02 INFO - 'MAIL': '/var/mail/cltbld', 22:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:02 INFO - 'MOZ_NO_REMOTE': '1', 22:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:02 INFO - 'NO_EM_RESTART': '1', 22:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:02 INFO - 'PWD': '/builds/slave/test', 22:24:02 INFO - 'SHELL': '/bin/bash', 22:24:02 INFO - 'SHLVL': '1', 22:24:02 INFO - 'TERM': 'linux', 22:24:02 INFO - 'TMOUT': '86400', 22:24:02 INFO - 'USER': 'cltbld', 22:24:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:02 INFO - '_': '/tools/buildbot/bin/python'} 22:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:02 INFO - Running setup.py (path:/tmp/pip-y9n5bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:02 INFO - Running setup.py (path:/tmp/pip-EzHA6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:02 INFO - Running setup.py (path:/tmp/pip-rR8yrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:02 INFO - Running setup.py (path:/tmp/pip-ZKnwZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:02 INFO - Running setup.py (path:/tmp/pip-CjXBw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:02 INFO - Running setup.py (path:/tmp/pip-JEMG1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:02 INFO - Running setup.py (path:/tmp/pip-pl6yuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:02 INFO - Running setup.py (path:/tmp/pip-X0Z_Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:02 INFO - Running setup.py (path:/tmp/pip-WUdfaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:03 INFO - Running setup.py (path:/tmp/pip-Fo2tyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:03 INFO - Running setup.py (path:/tmp/pip-XEw6Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:03 INFO - Running setup.py (path:/tmp/pip-78d8ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:03 INFO - Running setup.py (path:/tmp/pip-EeVVvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:03 INFO - Running setup.py (path:/tmp/pip-qLzKMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:03 INFO - Running setup.py (path:/tmp/pip-JqdwGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:03 INFO - Running setup.py (path:/tmp/pip-8T5mVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:03 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)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:03 INFO - Running setup.py (path:/tmp/pip-3x0KeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:03 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)) 22:24:03 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)) 22:24:03 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)) 22:24:03 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)) 22:24:03 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)) 22:24:03 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)) 22:24:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24:05 INFO - Downloading blessings-1.6.tar.gz 22:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:05 INFO - Installing collected packages: blessings 22:24:05 INFO - Running setup.py install for blessings 22:24:05 INFO - Successfully installed blessings 22:24:05 INFO - Cleaning up... 22:24:05 INFO - Return code: 0 22:24:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:06 INFO - Reading from file tmpfile_stdout 22:24:06 INFO - Current package versions: 22:24:06 INFO - argparse == 1.2.1 22:24:06 INFO - blessings == 1.6 22:24:06 INFO - blobuploader == 1.2.4 22:24:06 INFO - docopt == 0.6.1 22:24:06 INFO - manifestparser == 1.1 22:24:06 INFO - mozInstall == 1.12 22:24:06 INFO - mozcrash == 0.17 22:24:06 INFO - mozdebug == 0.1 22:24:06 INFO - mozdevice == 0.48 22:24:06 INFO - mozfile == 1.2 22:24:06 INFO - mozhttpd == 0.7 22:24:06 INFO - mozinfo == 0.9 22:24:06 INFO - mozleak == 0.1 22:24:06 INFO - mozlog == 3.1 22:24:06 INFO - moznetwork == 0.27 22:24:06 INFO - mozprocess == 0.22 22:24:06 INFO - mozprofile == 0.28 22:24:06 INFO - mozrunner == 6.11 22:24:06 INFO - mozscreenshot == 0.1 22:24:06 INFO - mozsystemmonitor == 0.0 22:24:06 INFO - moztest == 0.7 22:24:06 INFO - mozversion == 1.4 22:24:06 INFO - psutil == 3.1.1 22:24:06 INFO - requests == 1.2.3 22:24:06 INFO - wsgiref == 0.1.2 22:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:06 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')]} 22:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 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')]} 22:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 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 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:24:06 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 22:24:06 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 22:24:06 INFO - Using env: {'DISPLAY': ':0', 22:24:06 INFO - 'HOME': '/home/cltbld', 22:24:06 INFO - 'LANG': 'en_US.UTF-8', 22:24:06 INFO - 'LANGUAGE': 'en_US:en', 22:24:06 INFO - 'LOGNAME': 'cltbld', 22:24:06 INFO - 'MAIL': '/var/mail/cltbld', 22:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:06 INFO - 'MOZ_NO_REMOTE': '1', 22:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:06 INFO - 'NO_EM_RESTART': '1', 22:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:06 INFO - 'PWD': '/builds/slave/test', 22:24:06 INFO - 'SHELL': '/bin/bash', 22:24:06 INFO - 'SHLVL': '1', 22:24:06 INFO - 'TERM': 'linux', 22:24:06 INFO - 'TMOUT': '86400', 22:24:06 INFO - 'USER': 'cltbld', 22:24:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:06 INFO - '_': '/tools/buildbot/bin/python'} 22:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 INFO - Cleaning up... 22:24:06 INFO - Return code: 0 22:24:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:24:06 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')]} 22:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 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')]} 22:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 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 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:24:06 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 22:24:06 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 22:24:06 INFO - Using env: {'DISPLAY': ':0', 22:24:06 INFO - 'HOME': '/home/cltbld', 22:24:06 INFO - 'LANG': 'en_US.UTF-8', 22:24:06 INFO - 'LANGUAGE': 'en_US:en', 22:24:06 INFO - 'LOGNAME': 'cltbld', 22:24:06 INFO - 'MAIL': '/var/mail/cltbld', 22:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:06 INFO - 'MOZ_NO_REMOTE': '1', 22:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:06 INFO - 'NO_EM_RESTART': '1', 22:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:06 INFO - 'PWD': '/builds/slave/test', 22:24:06 INFO - 'SHELL': '/bin/bash', 22:24:06 INFO - 'SHLVL': '1', 22:24:06 INFO - 'TERM': 'linux', 22:24:06 INFO - 'TMOUT': '86400', 22:24:06 INFO - 'USER': 'cltbld', 22:24:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:06 INFO - '_': '/tools/buildbot/bin/python'} 22:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:06 INFO - Downloading/unpacking jsonschema 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:24:08 INFO - Downloading/unpacking functools32 (from jsonschema) 22:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:08 INFO - Downloading functools32-3.2.3-2.tar.gz 22:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:24:08 INFO - warning: no files found matching '*.txt' 22:24:08 INFO - no previously-included directories found matching 'build' 22:24:08 INFO - no previously-included directories found matching 'dist' 22:24:08 INFO - no previously-included directories found matching '.git*' 22:24:08 INFO - Installing collected packages: jsonschema, functools32 22:24:08 INFO - Running setup.py install for functools32 22:24:08 INFO - warning: no files found matching '*.txt' 22:24:08 INFO - no previously-included directories found matching 'build' 22:24:08 INFO - no previously-included directories found matching 'dist' 22:24:08 INFO - no previously-included directories found matching '.git*' 22:24:08 INFO - Successfully installed jsonschema functools32 22:24:08 INFO - Cleaning up... 22:24:08 INFO - Return code: 0 22:24:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', '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 22:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:24:08 INFO - Using env: {'DISPLAY': ':0', 22:24:08 INFO - 'HOME': '/home/cltbld', 22:24:08 INFO - 'LANG': 'en_US.UTF-8', 22:24:08 INFO - 'LANGUAGE': 'en_US:en', 22:24:08 INFO - 'LOGNAME': 'cltbld', 22:24:08 INFO - 'MAIL': '/var/mail/cltbld', 22:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:08 INFO - 'MOZ_NO_REMOTE': '1', 22:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:08 INFO - 'NO_EM_RESTART': '1', 22:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:08 INFO - 'PWD': '/builds/slave/test', 22:24:08 INFO - 'SHELL': '/bin/bash', 22:24:08 INFO - 'SHLVL': '1', 22:24:08 INFO - 'TERM': 'linux', 22:24:08 INFO - 'TMOUT': '86400', 22:24:08 INFO - 'USER': 'cltbld', 22:24:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:08 INFO - '_': '/tools/buildbot/bin/python'} 22:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:09 INFO - Downloading/unpacking flake8 22:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:24:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:24:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 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 22:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:11 INFO - no previously-included directories found matching 'docs/_build' 22:24:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:24:11 INFO - Running setup.py install for pep8 22:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:11 INFO - no previously-included directories found matching 'docs/_build' 22:24:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:24:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:24:11 INFO - Cleaning up... 22:24:11 INFO - Return code: 0 22:24:11 INFO - Running post-action listener: _resource_record_post_action 22:24:11 INFO - Running post-action listener: _start_resource_monitoring 22:24:11 INFO - Starting resource monitoring. 22:24:12 INFO - ##### 22:24:12 INFO - ##### Running install step. 22:24:12 INFO - ##### 22:24:12 INFO - Running pre-action listener: _resource_record_pre_action 22:24:12 INFO - Running main action method: install 22:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:12 INFO - Reading from file tmpfile_stdout 22:24:12 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:24:12 INFO - Reading from file tmpfile_stdout 22:24:12 INFO - Output received: 22:24:12 INFO - Usage: mozinstall [options] installer 22:24:12 INFO - Options: 22:24:12 INFO - -h, --help show this help message and exit 22:24:12 INFO - -d DEST, --destination=DEST 22:24:12 INFO - Directory to install application into. [default: 22:24:12 INFO - "/builds/slave/test"] 22:24:12 INFO - --app=APP Application being installed. [default: firefox] 22:24:12 INFO - mkdir: /builds/slave/test/build/application 22:24:12 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'] 22:24:12 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 22:24:25 INFO - Reading from file tmpfile_stdout 22:24:25 INFO - Output received: 22:24:25 INFO - /builds/slave/test/build/application/firefox/firefox 22:24:25 INFO - Running post-action listener: _resource_record_post_action 22:24:25 INFO - ##### 22:24:25 INFO - ##### Running run-tests step. 22:24:25 INFO - ##### 22:24:25 INFO - Running pre-action listener: _resource_record_pre_action 22:24:25 INFO - Running main action method: run_tests 22:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:24:25 INFO - Python 2.7.3 22:24:25 INFO - Return code: 0 22:24:25 INFO - grabbing minidump binary from tooltool 22:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:25 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 0x1d83410>, '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 0x1d84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d847a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:24:25 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 22:24:25 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 22:24:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:24:25 INFO - Return code: 0 22:24:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:24:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:24:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:24:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:24:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:24:26 INFO - Return code: 0 22:24:26 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/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 22:24:26 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/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 22:24:26 INFO - Using env: {'DISPLAY': ':0', 22:24:26 INFO - 'HOME': '/home/cltbld', 22:24:26 INFO - 'LANG': 'en_US.UTF-8', 22:24:26 INFO - 'LANGUAGE': 'en_US:en', 22:24:26 INFO - 'LOGNAME': 'cltbld', 22:24:26 INFO - 'MAIL': '/var/mail/cltbld', 22:24:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:24:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:26 INFO - 'MOZ_NO_REMOTE': '1', 22:24:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:26 INFO - 'NO_EM_RESTART': '1', 22:24:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:26 INFO - 'PWD': '/builds/slave/test', 22:24:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:24:26 INFO - 'SHELL': '/bin/bash', 22:24:26 INFO - 'SHLVL': '1', 22:24:26 INFO - 'TERM': 'linux', 22:24:26 INFO - 'TMOUT': '86400', 22:24:26 INFO - 'USER': 'cltbld', 22:24:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229', 22:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:26 INFO - '_': '/tools/buildbot/bin/python'} 22:24:26 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/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 22:24:26 INFO - mozversion application_buildid: 20160606194329 22:24:26 INFO - mozversion application_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 22:24:26 INFO - mozversion application_display_name: Firefox 22:24:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:24:26 INFO - mozversion application_name: Firefox 22:24:26 INFO - mozversion application_remotingname: firefox 22:24:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:24:26 INFO - mozversion application_vendor: Mozilla 22:24:26 INFO - mozversion application_version: 48.0 22:24:26 INFO - mozversion platform_buildid: 20160606194329 22:24:26 INFO - mozversion platform_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 22:24:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:24:26 INFO - mozversion platform_version: 48.0 22:24:26 INFO - using testdate: 1465277066 22:24:26 INFO - actual date: 1465277066 22:24:26 INFO - starting webserver on 'localhost:58851' 22:24:26 INFO - SUITE-START | Running 2 tests 22:24:26 INFO - TEST-START | dromaeo_css 22:24:26 INFO - operating with platform_type : linux_ 22:24:26 INFO - Initialising browser for dromaeo_css test... 22:24:26 INFO - TEST-INFO | started process 3295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYo7DvH/profile http://localhost:58851/getInfo.html) 22:24:31 INFO - PROCESS | 3295 | __metrics Screen width/height:1600/1200 22:24:31 INFO - PROCESS | 3295 | colorDepth:24 22:24:31 INFO - PROCESS | 3295 | Browser inner width/height: 1024/697 22:24:31 INFO - PROCESS | 3295 | __metrics 22:24:32 ERROR - PROCESS | 3295 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:24:32 INFO - TEST-INFO | 3295: exit 0 22:24:32 INFO - Browser initialized. 22:24:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:24:32 INFO - TEST-INFO | started process 3385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYo7DvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:24:44 INFO - PROCESS | 3385 | RSS: Main: 140787712 22:24:44 INFO - PROCESS | 3385 | 22:25:35 INFO - PROCESS | 3385 | 1465277135772 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] 22:27:43 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58851/tests/dromaeo/cssquery-ext.html) 22:27:44 INFO - PROCESS | 3385 | RSS: Main: 250896384 22:27:44 INFO - PROCESS | 3385 | 22:30:46 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-ext.html (next: http://localhost:58851/tests/dromaeo/cssquery-jquery.html) 22:30:47 INFO - PROCESS | 3385 | RSS: Main: 223469568 22:30:47 INFO - PROCESS | 3385 | 22:33:49 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58851/tests/dromaeo/cssquery-mootools.html) 22:33:49 INFO - PROCESS | 3385 | RSS: Main: 218718208 22:33:49 INFO - PROCESS | 3385 | 22:36:51 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58851/tests/dromaeo/cssquery-prototype.html) 22:36:52 INFO - PROCESS | 3385 | RSS: Main: 222711808 22:36:52 INFO - PROCESS | 3385 | 22:39:54 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58851/tests/dromaeo/cssquery-yui.html) 22:39:55 INFO - PROCESS | 3385 | RSS: Main: 209678336 22:39:55 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-yui.html (next: http://localhost:58851/tests/dromaeo/cssquery-dojo.html) 22:42:57 INFO - PROCESS | 3385 | RSS: Main: 256266240 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | __start_tp_report 22:42:57 INFO - PROCESS | 3385 | _x_x_mozilla_page_load 22:42:57 INFO - PROCESS | 3385 | _x_x_mozilla_page_load_details 22:42:57 INFO - PROCESS | 3385 | |i|pagename|runs| 22:42:57 INFO - PROCESS | 3385 | |0;dojo.html;3267.1178781728936;3328.850201740923;3336.8331583420836;3360.5799275090612;3371.3931492331385;5585.888282234353;5588.86027849304;5597.63615365002;5607.130894711321;5623.550115990721;5565.1374037024225;5586.6368686035485;5614.157876318554;5617.466340697627;5650.660960342372;5005.424376196747;5066.746662666852;5078.162103252959;5154.587632989352;5229.843104706865;5078.187490001582;5165.66423182492;5165.767540460688;5169.483051694838;5171.7414129293575;4994.325766021595;5048.772805223755;5053.317802096725;5059.696418214919;5071.797128114889;5133.050385678662;5163.8192663256605;5165.121929272014;5166.095933211692;5172.534471897509;4943.505649435064;5025.748712564357;5086.084504789136;5096.184610462308;5104.310918026056;5438.401775804658;5477.096279113942;5505.642133261325;5509.724513774336;5511.283533140706;5933.584649074566;5944.464998150187;5949.077892926603;5968.791092311748;5969.074793406985;5868.9413105868825;5911.940880591225;5918.970405147947;5956.761729530814;5988.131720900445;5585.357683866367;5625.746841392065;5636.04187288162;5640.915386269209;5653.010723123478;5994.67029313392;6101.664408457577;6145.569810113249;6163.075538669235;6164.383561643889;5937.821865344046;5997.220361353084;6025.246844144482;6049.909251361233;6050.6672133032225;5950.940490595039;5954.404559544011;5973.551983601247;5987.31145918225;5998.190244317048;5742.770289188469;5958.761649534057;5986.5809393342915;5987.790427335022;5995.430434108753;5968.224130863046;6005.939940600625;6011.0382338825575;6017.338092809788;6081.361457046946;4418.668599855024;4511.684182107287;4513.345564893072;4516.232240519054;4538.092381523643;3924.4309575111447;3960.4653371795016;3987.202559488114;4048.554658987509;4076.8369265229057;5732.971335143297;5764.106563482667;5772.365039845614;5774.2782152230975;5788.073908174756;6039.305479869871;6048.153258543807;6056.06131049688;6057.121717350959;6060.787872424532;5510.393856675762;5648.15277708347;5673.574481913873;5785.756062446594;5805.10020946754;4826.975865120652;5010.64925455222;5011.34852469184;5021.121303771825;5041.899162016813;5990.880182396415;6168.153349781739;6179.104029915637;6196.318404975449;6216.689165541705;5936.7922122725495;5945.286565612154;5975.133605627073;6017.879642407215;6035.6076855004285;6097.5731698780655;6123.540734445023;6127.785527506516;6128.693565321627;6199.876002480015;5787.334456537552;5888.735006924613;5895.263092113486;5911.349751527243;5912.260967379078;5993.250843644544;6049.697515124314;6055.485283750931;6062.060380641008;6072.210612620331;5833.82498525045;5870.5010074142465;5889.852753681193;5908.497777688773;5910.320313163869;5592.7762889483965;5857.765689372377;5864.149698293809;5902.1146827976145;5922.674252916131;5771.422857714195;5774.913376299275;5784.652920824764;5793.594448388572;5804.738786754522;5854.385289544536;5869.090291004901;5878.353381127987;5894.852628684145;5913.172155898092;5670.914936275876;5779.653220806765;5782.797602083907;5796.797112101225;5848.824535263949 22:42:57 INFO - PROCESS | 3385 | |1;ext.html;601.6720887116521;656.1568384625756;666.1639642248977;673.0913267089433;679.3715812873094;32333.51499727503;32996.835015824916;39101.413478797804;39498.21003579934;39686.40470392947;42278.154436911245;42421;42581.57418425815;42607;42753.78623106888;8131.7560473185895;8866.999999999984;9035.051319611412;9054;9058.23005044572;10749.570017199303;11031.951964563354;11055.557777688882;11057.778844423106;11058.668239952814;10836.566537338536;10904.34573925563;10915.890841091566;10928.289661171999;10951.671449856518;10715.035646791786;10808.297460665031;10812.72968175794;10815.35107893529;10815.459227038617;10576.788464230749;10664.200184986079;10673.573057077707;10676.466176691212;10683.30558513694;43204.567954320366;43216.351754723706;43263.35104973428;43633.781831090644;43660.690179294674;3830.6743926766258;4261.228376448168;4401.383806267125;4518.277075667877;4626.699264547794;32587.348253035045;33286.50070248924;33301.6669833301;33448.66551334504;35142.82428587866;4107;4151.813168407429;4194.203101410722;4199.4330765346895;4305.698601097924;321483;322646;323227;324516;325568;67754.66122669356;67756.32243677501;68298.31701683019;68352.31647683459;68381;69582;71664.64167679232;72993.6350318245;73189.6340518294;73218;17603.471895843144;17855.107244637715;17895.194716237802;17900.55248618795;17906.28374865017;12774.936125319315;13349.866501335056;13531.32343382827;13646.454141834414;13920.095193812369;20361.287354942506;20465.2837150699;20620.896895515725;20635.793642063687;20703.896480517804;7282.198958114604;7369.336759691546;7455.291747283999;7455.776326710207;7501.174870764212;1105.911527077848;1107.6732363952653;1113.6158025481195;1125.6510481750684;1138.7779383020231;35172.824135879666;35348.646513534535;35545.28909421797;35691.64308356935;36465;1218.8415505984165;1271.4786937355639;1275.9744805103846;1324.741675373293;1329.3286890120621;17987.910060449874;18382.172802223933;18466.722999155023;18531.351402700842;19033.238670453306;522729;532957;535740;535883;535985;66046;66747.66626166838;66893.33106668871;67125.32874671288;67147.32852671508;1330.7737684593449;1412.2310362170442;1507.713534428455;1584.0891487394795;1585.0410501646568;32582.67417325891;34239.31521369509;34916.30167396587;34947;35117;53072.73463632657;53477.73261133825;53559.732201338746;53636.46363536315;53690.73154634202;312043;316248;316485;319606;320102;30266.54600180955;31667.52498712567;31752.206194845312;32513.187170320933;32661.71368004217;47020.29469557891;47434.76282618565;48241.035179296916;48301.27548086852;48901;42033;43064.35403468888;43090.56909430865;43969.34045989377;44839.32741008822;42117.57882421136;42760;43108.353374698774;43211.783941080095;44137.77931110324;42955.35566966561;43603.78198109116;44316.55683443124;44919.55080449153;44939.55060449354;36776.26447471089;37837.24325513529;38101.61898381091;39224.411633824944;39465;29409.264768380963;29788.255293617833;29857.095778783205;29939;30172.54741178928 22:42:57 INFO - PROCESS | 3385 | |2;jquery.html;385.2622228432552;387.7518388231532;393.5022196920894;401.59639562239965;417.1635870080488;15504.922475387608;16439.91780041098;19264.614707705856;19790.90104549477;19914.800851991477;16848.326066957306;19220.71168932467;20066.69899951498;20121.899390503062;20453.079611417485;5622.212890195366;5839.970800146015;5844.2402487676545;5847.210626565402;5852.853678658046;5705.343885453164;5791.507721843627;5797.043487824525;5800.7679692812235;5801;5699.515541179005;5730.616078699798;5785.681787501707;5792.015357389254;5861.032929566616;5772.191893134965;5790.7683692652245;5817.912731309034;5836.358000619928;5844.649321040752;5170.069387510247;5210.687358758449;5221.373435187802;5227.26818245446;5244.370675518924;24301.27096187117;25041.12356067547;25364.746352536422;25688.229353119248;25698;2550.6939167300043;2668.706442291366;2750.22993561803;2911.097559756482;3075;15018;15051.172185529791;15088.39646414142;15139.470118545798;15450.768238476432;1966.822985931273;2000.9399718008483;2019.3840878532042;2040.9387718368473;2060.5054786851197;80138;81124.18875811226;81342.9999999994;83246.58376708138;83264;10813.729656758644;10836.72908177286;11032.724181895517;11044.944775276233;11161.218714689894;15008.324625391884;15191.240437978056;15441.382344706086;15478.148701821283;15483.612909677347;8185.345172386314;8235.876461853077;8372.832543349221;8528.701495447629;8555.529445880537;8156.796080097926;8211.83576328482;8253;8340.332773378115;8372.455790373606;6190.783322583778;6780.966095169492;6965.920282356243;7002.684879180449;7039;1831.3032492949862;1940.4566721318054;1966.4199061276959;1969.1729473621112;2012.6880333548324;1077.876044254905;1088.820344643125;1110.2228440091967;1130.2314426190105;1190.5356910804794;19351.51621209481;20133.39599812008;20220.797792022186;20435.693464598044;20481;1087.4780105549223;1102.96139635114;1106.1427393769893;1109.983350249747;1118.066414543865;10640.946795265974;11925;11925.284482931052;11959.820602690967;11985.700357490958;400130;402348;402516;403996;561884;94628.52685736527;99790.5010474943;99851;100021.49989250007;100243;1117.8155604325357;1150.7180740718577;1157.9710507237387;1158.9826152607718;1164.2083383299268;17941.282348705907;18120.18459169367;18123.36568220106;18175.636487270443;18744.812551874853;40129;40682.389764154155;40724.59275407208;41038.79480602578;41895.371569427094;59662.40337596568;60236.39763602308;60915.69542152261;61201.38798611957;61355.386446134966;8666.566671666518;8805;8951.507667078373;9101.77245568866;9144.085591440802;11596.76806463849;13716.24560649134;13974.860251397762;14113.2943352834;14279.500217492337;12480.188787728768;12527.93736031314;12630.810537842124;12839.935800320938;12891.41988610496;11902.880971190178;12345.259284442604;12457.626271211879;12805.359732013176;12806.67983300425;12497.062720296197;12587.811182832447;12693.301868397326;12732.936335318263;12808.871911280768;8686.956565217133;8880.73357799267;9112.817743644957;9122.315826313186;9151.496667683341;9250;11756.470958807045;12188.390580471118;12331.753364932472;12443.128980971607 22:42:57 INFO - PROCESS | 3385 | |3;mootools.html;1397.5388121919768;1584.8811339149563;1608.5576466471719;1834.3671433355496;1943.9708404373937;7502.174760776317;8318.584070796458;8454.87317690235;8475.152484751521;8477.067522572512;8230.465019773725;8317.500949943007;8361.498310101382;8380.874286885686;8401.747947561567;2406.4104294447884;2436.61014237722;2438.061346381647;2438.5244877248942;2441.316431399202;2363.95272094558;2387.641853721947;2403.4111642647576;2406.4104294447884;2421.2615152378607;2389.3787615219994;2411.2043025801445;2418.3712234818986;2420.9636855447184;2426.9029238830426;2367.8460900041614;2397.508510755291;2405.1822380390663;2405.855648661086;2407.2056221447056;2321.2223904991847;2365.1840115160244;2368.3131891751545;2371;2376.6435034744754;7375.926240737577;8084.070331911787;8593.570321483901;8663.35024873137;8664;5085.694858308513;5200.739963001834;5210.739463026872;5212.843614691566;5213.7393130343335;3393.694567488938;3439.793612383265;3450.1547120955524;3462.549868517102;3509.5788505379264;1086.3481910853504;1098.6813823991033;1113.565709373345;1116.553378648539;1126.6282126898186;11574.305541667527;12118.151729378947;12126.636200913987;12127.514899404014;12134.150609457341;4567.748773817472;4595.37962375075;4648.465426475931;4682.344471773954;4694.530546945278;10345.43100129485;10360.119389851947;10371.118454931415;10376.066154046172;10385.896141038644;5308.946910530923;5311.362636483569;5314.654547454403;5319.7340132993195;5321.627486075938;4853.02939412119;4906.852794416173;4912;4915.3855768029;4916.803327866917;3756.229972855558;3983.402489626579;3988.680905527609;4001.5398229204015;4014.5182578090817;1242.8011518157052;1242.9813552796716;1247.8065899785547;1254.5734450286764;1262.5391732017747;1003.6888564545014;1040.8750949886062;1058.99470502647;1059.279689810936;1073.1414868105485;6109.633421994695;6111.113888486234;6127.816165515042;6246.781362652286;6335.906796736238;459.7149767144325;465.550743532486;468.7820163623931;470.21943573667545;479.2762927978777;4170.457840480779;4174.83300667976;4199.91600167995;4259.574042595777;4263.957360426356;10203.540840662188;10513.684589462327;10614.787704245871;10617.416042117758;10631.096356809603;10407.635732749317;10449.164066874631;10456.424896630606;10467.214958878114;10477;7852.803679908048;8047.074586422519;8050.677972881136;8066.717664881819;8138.145494723087;6147.231596050494;6221.875562488634;6293.244810622755;6303.558750887394;6328.493720502441;9444.52777361143;9450.669226577036;9536.523173841142;9616.423014619146;9725.708228753148;9580.712578622653;9853.704388868346;9877.753056173653;9975.700728978143;10098.19214462856;7818.140004599376;7889.171636978034;7890.289873911375;7900.762977110696;7911.208879112043;8284.71003514874;8302.958485207535;8373.95325584302;8375.623096960773;8380.371472139735;7466.402687785073;7614.086309642878;7645.426593005435;7731.0336207974005;7849.686012559434;7205.279472052753;7283.344498995116;7371.189169191492;7399.038125043709;7550.282723141293;6965.33829286217;6971.2331643518155;7001.509894307554;7013.929860701328;7019.754308599175;4363.759993200404;4883.755812209446;5039.143345631325;5099;5156.484351564814;5115.411727651368;5119.308893299357;5227.137522308929;5261.079311120615;5289.973550132225 22:42:57 INFO - PROCESS | 3385 | |4;prototype.html;336.25650999567245;341.2288228603356;341.3548393536216;345.4973014264246;347.47531227845946;6277.583130494758;6341.112244285798;6410.262819775728;6477.2551156617;6479.514036447274;6306.873862522747;6342.524310676707;6384.840378990516;6392.456641185493;6396.328385519511;4823.372961514998;4827.63792715546;4830.97584512077;4832.855014349575;4835.661503694751;4561.7262964222255;4666.253399456088;4760.190767569521;4763.737994410306;4774.880627984311;4705.717656940577;4738.360321356625;4748.857534273978;4761.0953918755495;4762.523747625227;4552.271636538138;4742.715437073786;4760.523947605247;4765.833195838146;4767.070421267854;3991.980040099781;4095.0786073133604;4097.426360309559;4098.918021639581;4101.507819061701;5986.3714309997695;5986.610870293417;6053.69731513427;6057.787977420813;6059.878802423971;5522;5533.08704063833;5534.4742249486235;5535.252740880011;5535.308086489189;6632.834179145511;6634.668266586651;6639.701213445406;6643.701033453506;6644.43522300605;4496.910061798779;4598.218302888517;4599.402077729874;4604.286335617984;4605.700629459075;6896.379325860697;6959.338862808076;6983.336583024605;6999;7000.754973575951;4677.6257899367965;4695.812167513262;4696.5303469653445;4701;4704.341392205094;4759.0719809637485;4761.904761904742;4764.737939413296;4766;4766.046790641885;5514.531264842453;5517.420670829585;5520.447955204528;5523.061079616475;5534.944650553523;6571.57284776488;6720.764773232913;6720.764773232913;6726;6733.124693789776;1642.1871173768823;1672.222416576298;1674.3972170018783;1674.6483238519804;1674.8911320764355;1063.3247887591435;1087.2932593813925;1102.2614848051824;1105.5080489182396;1107.0147568663895;6382.808515744535;6409.583377080475;6551.737930482823;6554.8361290968105;6567.376099270562;6973.686184121727;6988.056612357368;6995.580265184105;7002.824929376705;7006.649667516604;6605.636689982001;6606.174228221473;6610.975298828689;6611.570247933965;6614.305497922649;3721.813909304524;3747.775133491999;3752.7373083884413;3757.2861156380745;3757.8538545743263;7054.470914681419;7268.345848873627;7277.2722727726805;7282.271772822675;7286.70853165878;7110.3600675939415;7113.82215444618;7114.750983715545;7116.323949224816;7125.1093613298335;7284.927150728531;7318.451116166309;7344.485885988036;7352.338289553966;7364;6964.303569642995;6971.058907047483;6971.5468494547695;6973.930260697328;6979.965100174467;6665.700043497957;6839.897401538881;6864;6866.965665171642;6883.449324053963;7204.675789589376;7232.276772322725;7240.384567311838;7246.492745507764;7256.673449694671;4664.813407463799;4675.602573781267;4678.485366609602;4686.906261874811;4686.92969605463;6909.550879192836;6910.447164226749;6916.3429474199875;6922;6930.237673855972;6540.869182616416;6729.663516824237;6731.629760363227;6742.4943129266485;6803.149606299213;6758.729650814109;6763.5603685762235;6770.830729231611;6787.626680532618;6799.014142949146;6646.069550263063;6648.335166483313;6667.033280174444;6669.0663307136065;6670.9332906670315;6805.455563555002;6816.318368163144;6817.454603631797;6826.795196144124;6829.795106146824;6329.145565348619;6377.266614339224;6563.9343606563325;6632.938729803208;6636.402723754885 22:42:57 INFO - PROCESS | 3385 | |5;yui.html;874.1957399192742;874.820661764338;926.4858003807884;929.272584963133;937.8030613571152;15130.697386052287;15227.314770835312;15260.542183734491;15270.770938435933;15970.281337339818;15701.136437495934;15722.37110515581;15785.842141578582;15788.921055394736;15792.131432771193;769.9846003079936;903.5482258870582;904.9909500904972;913.5295322908707;914.3279689428265;902.4134312696767;903.3856977255464;904.0281697175529;906.6509393883337;913.3423934766957;955.813616344813;959.5538074795219;960.2126256469663;961.4567769210408;963.4267610771615;806.5805780993909;929.4794914847639;932.2262522106636;951.8952915179325;959.0553304994575;683.5795985468901;686.7493364921818;689.9310068993111;695.5061906046712;701.9859602807916;15101.924490377587;15105.3202605883;15113.39546418142;15200.16399098049;15213.087214767149;14311.427542898271;14714.632134196623;14827.481038163613;14872;14960.476383326532;11490.655280341603;11711.824322635168;11736.765264694659;11796.587119450778;11991.64025079249;4052.331365324718;4087.3664581989838;4120.649744771698;4137.462129923121;4142.275101857163;55627;56279.155812662844;57394.71302643502;57456;57475.999999999585;11911.463984120735;11954.222975506738;12039.518419263306;12256.325902075472;12449.813252801216;19983.000849957443;20199.293024744064;20211.494712632008;20225.29211477591;20248.190072397232;8485.363597730071;8495.575221238912;8586.055533891267;8628.309735221168;9042.864357034518;4706.835260765857;4724.943293701212;4759.38128043359;4865.343178670905;4935.506449355035;3672.889813305605;3691.8523259069875;3719.237556300952;3721.776693398405;3725.4970578972034;590.4626789621424;664.5348256220665;666.8699603577256;679.4292794053019;687.4843867099676;774.3572834547425;806.8023334283138;828.9544075075808;829.307528213936;842.7471758472557;9904.653337133166;10051.145652619463;10163.459135216195;10250.333728307636;10366.429846358373;744.8584768893893;752.5672738175571;761.162721006888;819.6844214977276;833.6832003838624;4567.474740404829;4856.223004319292;4858.58702010333;4896.68171568854;4987.900241995139;61798;62087.6895615519;63058;64383.35616643867;64520.677396612715;55371.723141384035;56608;56816.71591642015;56928;57071;51131;51610.74194629003;51836.74081629568;52535.47464525306;52916.73541632267;9702.417854928726;9778.364406313567;9813;9816.509174541387;9825.557849896915;36667.26665466622;37698.43452348272;38083.428748568236;38313.23373532458;38371.80814095912;44120.779396102815;44329.77835110804;48976.51023489719;49289;50518.74740626274;11880.881191187977;11942.820857687315;11987.460564274454;12044.51821927113;12073.69815754578;13368.465261389436;13371.933140334626;13564.521573377155;13843.100198487065;14638.634034149232;12900.870991290343;12945.09384343087;12965.222086674452;13063.542776002794;13374.598762037154;13246.139000964906;13494.73010539764;13866.861331386961;14208.431662733376;14248.501302454364;12745.681357965754;12954.93522532419;12975.286359249954;13050.934745326213;13819.447222111405;11745.706357341134;11784;11929;12111.091668124749;12275.754484910072;11372.171114069568;11496.597619083292;11687.76624467523;11782.705432364259;11795.823062653895 22:42:57 INFO - PROCESS | 3385 | __end_tp_report 22:42:57 INFO - PROCESS | 3385 | __start_cc_report 22:42:57 INFO - PROCESS | 3385 | _x_x_mozilla_cycle_collect,863 22:42:57 INFO - PROCESS | 3385 | __end_cc_report 22:42:57 INFO - PROCESS | 3385 | __startTimestamp1465278177685__endTimestamp 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | ------- Summary: start ------- 22:42:57 INFO - PROCESS | 3385 | Number of tests: 6 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | [#0] dojo.html Cycles:165 Average:5558.64 Median:5788.07 stddev:634.53 (11.0%) stddev-sans-first:610.48 22:42:57 INFO - PROCESS | 3385 | Values: 3267.1 3328.9 3336.8 3360.6 3371.4 5585.9 5588.9 5597.6 5607.1 5623.6 5565.1 5586.6 5614.2 5617.5 5650.7 5005.4 5066.7 5078.2 5154.6 5229.8 5078.2 5165.7 5165.8 5169.5 5171.7 4994.3 5048.8 5053.3 5059.7 5071.8 5133.1 5163.8 5165.1 5166.1 5172.5 4943.5 5025.7 5086.1 5096.2 5104.3 5438.4 5477.1 5505.6 5509.7 5511.3 5933.6 5944.5 5949.1 5968.8 5969.1 5868.9 5911.9 5919.0 5956.8 5988.1 5585.4 5625.7 5636.0 5640.9 5653.0 5994.7 6101.7 6145.6 6163.1 6164.4 5937.8 5997.2 6025.2 6049.9 6050.7 5950.9 5954.4 5973.6 5987.3 5998.2 5742.8 5958.8 5986.6 5987.8 5995.4 5968.2 6005.9 6011.0 6017.3 6081.4 4418.7 4511.7 4513.3 4516.2 4538.1 3924.4 3960.5 3987.2 4048.6 4076.8 5733.0 5764.1 5772.4 5774.3 5788.1 6039.3 6048.2 6056.1 6057.1 6060.8 5510.4 5648.2 5673.6 5785.8 5805.1 4827.0 5010.6 5011.3 5021.1 5041.9 5990.9 6168.2 6179.1 6196.3 6216.7 5936.8 5945.3 5975.1 6017.9 6035.6 6097.6 6123.5 6127.8 6128.7 6199.9 5787.3 5888.7 5895.3 5911.3 5912.3 5993.3 6049.7 6055.5 6062.1 6072.2 5833.8 5870.5 5889.9 5908.5 5910.3 5592.8 5857.8 5864.1 5902.1 5922.7 5771.4 5774.9 5784.7 5793.6 5804.7 5854.4 5869.1 5878.4 5894.9 5913.2 5670.9 5779.7 5782.8 5796.8 5848.8 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | [#1] ext.html Cycles:180 Average:57811.39 Median:36078.32 stddev:106699.41 (295.7%) stddev-sans-first:106912.27 22:42:57 INFO - PROCESS | 3385 | Values: 601.7 656.2 666.2 673.1 679.4 32333.5 32996.8 39101.4 39498.2 39686.4 42278.2 42421.0 42581.6 42607.0 42753.8 8131.8 8867.0 9035.1 9054.0 9058.2 10749.6 11032.0 11055.6 11057.8 11058.7 10836.6 10904.3 10915.9 10928.3 10951.7 10715.0 10808.3 10812.7 10815.4 10815.5 10576.8 10664.2 10673.6 10676.5 10683.3 43204.6 43216.4 43263.4 43633.8 43660.7 3830.7 4261.2 4401.4 4518.3 4626.7 32587.3 33286.5 33301.7 33448.7 35142.8 4107.0 4151.8 4194.2 4199.4 4305.7 321483.0 322646.0 323227.0 324516.0 325568.0 67754.7 67756.3 68298.3 68352.3 68381.0 69582.0 71664.6 72993.6 73189.6 73218.0 17603.5 17855.1 17895.2 17900.6 17906.3 12774.9 13349.9 13531.3 13646.5 13920.1 20361.3 20465.3 20620.9 20635.8 20703.9 7282.2 7369.3 7455.3 7455.8 7501.2 1105.9 1107.7 1113.6 1125.7 1138.8 35172.8 35348.6 35545.3 35691.6 36465.0 1218.8 1271.5 1276.0 1324.7 1329.3 17987.9 18382.2 18466.7 18531.4 19033.2 522729.0 532957.0 535740.0 535883.0 535985.0 66046.0 66747.7 66893.3 67125.3 67147.3 1330.8 1412.2 1507.7 1584.1 1585.0 32582.7 34239.3 34916.3 34947.0 35117.0 53072.7 53477.7 53559.7 53636.5 53690.7 312043.0 316248.0 316485.0 319606.0 320102.0 30266.5 31667.5 31752.2 32513.2 32661.7 47020.3 47434.8 48241.0 48301.3 48901.0 42033.0 43064.4 43090.6 43969.3 44839.3 42117.6 42760.0 43108.4 43211.8 44137.8 42955.4 43603.8 44316.6 44919.6 44939.6 36776.3 37837.2 38101.6 39224.4 39465.0 29409.3 29788.3 29857.1 29939.0 30172.5 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | [#2] jquery.html Cycles:180 Average:28163.84 Median:13180.89 stddev:72850.52 (552.7%) stddev-sans-first:73025.03 22:42:57 INFO - PROCESS | 3385 | Values: 385.3 387.8 393.5 401.6 417.2 15504.9 16439.9 19264.6 19790.9 19914.8 16848.3 19220.7 20066.7 20121.9 20453.1 5622.2 5840.0 5844.2 5847.2 5852.9 5705.3 5791.5 5797.0 5800.8 5801.0 5699.5 5730.6 5785.7 5792.0 5861.0 5772.2 5790.8 5817.9 5836.4 5844.6 5170.1 5210.7 5221.4 5227.3 5244.4 24301.3 25041.1 25364.7 25688.2 25698.0 2550.7 2668.7 2750.2 2911.1 3075.0 15018.0 15051.2 15088.4 15139.5 15450.8 1966.8 2000.9 2019.4 2040.9 2060.5 80138.0 81124.2 81343.0 83246.6 83264.0 10813.7 10836.7 11032.7 11044.9 11161.2 15008.3 15191.2 15441.4 15478.1 15483.6 8185.3 8235.9 8372.8 8528.7 8555.5 8156.8 8211.8 8253.0 8340.3 8372.5 6190.8 6781.0 6965.9 7002.7 7039.0 1831.3 1940.5 1966.4 1969.2 2012.7 1077.9 1088.8 1110.2 1130.2 1190.5 19351.5 20133.4 20220.8 20435.7 20481.0 1087.5 1103.0 1106.1 1110.0 1118.1 10640.9 11925.0 11925.3 11959.8 11985.7 400130.0 402348.0 402516.0 403996.0 561884.0 94628.5 99790.5 99851.0 100021.5 100243.0 1117.8 1150.7 1158.0 1159.0 1164.2 17941.3 18120.2 18123.4 18175.6 18744.8 40129.0 40682.4 40724.6 41038.8 41895.4 59662.4 60236.4 60915.7 61201.4 61355.4 8666.6 8805.0 8951.5 9101.8 9144.1 11596.8 13716.2 13974.9 14113.3 14279.5 12480.2 12527.9 12630.8 12839.9 12891.4 11902.9 12345.3 12457.6 12805.4 12806.7 12497.1 12587.8 12693.3 12732.9 12808.9 8687.0 8880.7 9112.8 9122.3 9151.5 9250.0 11756.5 12188.4 12331.8 12443.1 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | [#3] mootools.html Cycles:180 Average:5713.16 Median:474.75 stddev:3173.36 (668.4%) stddev-sans-first:3165.69 22:42:57 INFO - PROCESS | 3385 | Values: 1397.5 1584.9 1608.6 1834.4 1944.0 7502.2 8318.6 8454.9 8475.2 8477.1 8230.5 8317.5 8361.5 8380.9 8401.7 2406.4 2436.6 2438.1 2438.5 2441.3 2364.0 2387.6 2403.4 2406.4 2421.3 2389.4 2411.2 2418.4 2421.0 2426.9 2367.8 2397.5 2405.2 2405.9 2407.2 2321.2 2365.2 2368.3 2371.0 2376.6 7375.9 8084.1 8593.6 8663.4 8664.0 5085.7 5200.7 5210.7 5212.8 5213.7 3393.7 3439.8 3450.2 3462.5 3509.6 1086.3 1098.7 1113.6 1116.6 1126.6 11574.3 12118.2 12126.6 12127.5 12134.2 4567.7 4595.4 4648.5 4682.3 4694.5 10345.4 10360.1 10371.1 10376.1 10385.9 5308.9 5311.4 5314.7 5319.7 5321.6 4853.0 4906.9 4912.0 4915.4 4916.8 3756.2 3983.4 3988.7 4001.5 4014.5 1242.8 1243.0 1247.8 1254.6 1262.5 1003.7 1040.9 1059.0 1059.3 1073.1 6109.6 6111.1 6127.8 6246.8 6335.9 459.7 465.6 468.8 470.2 479.3 4170.5 4174.8 4199.9 4259.6 4264.0 10203.5 10513.7 10614.8 10617.4 10631.1 10407.6 10449.2 10456.4 10467.2 10477.0 7852.8 8047.1 8050.7 8066.7 8138.1 6147.2 6221.9 6293.2 6303.6 6328.5 9444.5 9450.7 9536.5 9616.4 9725.7 9580.7 9853.7 9877.8 9975.7 10098.2 7818.1 7889.2 7890.3 7900.8 7911.2 8284.7 8303.0 8374.0 8375.6 8380.4 7466.4 7614.1 7645.4 7731.0 7849.7 7205.3 7283.3 7371.2 7399.0 7550.3 6965.3 6971.2 7001.5 7013.9 7019.8 4363.8 4883.8 5039.1 5099.0 5156.5 5115.4 5119.3 5227.1 5261.1 5290.0 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | [#4] prototype.html Cycles:180 Average:5610.84 Median:6409.92 stddev:1726.34 (26.9%) stddev-sans-first:1685.17 22:42:57 INFO - PROCESS | 3385 | Values: 336.3 341.2 341.4 345.5 347.5 6277.6 6341.1 6410.3 6477.3 6479.5 6306.9 6342.5 6384.8 6392.5 6396.3 4823.4 4827.6 4831.0 4832.9 4835.7 4561.7 4666.3 4760.2 4763.7 4774.9 4705.7 4738.4 4748.9 4761.1 4762.5 4552.3 4742.7 4760.5 4765.8 4767.1 3992.0 4095.1 4097.4 4098.9 4101.5 5986.4 5986.6 6053.7 6057.8 6059.9 5522.0 5533.1 5534.5 5535.3 5535.3 6632.8 6634.7 6639.7 6643.7 6644.4 4496.9 4598.2 4599.4 4604.3 4605.7 6896.4 6959.3 6983.3 6999.0 7000.8 4677.6 4695.8 4696.5 4701.0 4704.3 4759.1 4761.9 4764.7 4766.0 4766.0 5514.5 5517.4 5520.4 5523.1 5534.9 6571.6 6720.8 6720.8 6726.0 6733.1 1642.2 1672.2 1674.4 1674.6 1674.9 1063.3 1087.3 1102.3 1105.5 1107.0 6382.8 6409.6 6551.7 6554.8 6567.4 6973.7 6988.1 6995.6 7002.8 7006.6 6605.6 6606.2 6611.0 6611.6 6614.3 3721.8 3747.8 3752.7 3757.3 3757.9 7054.5 7268.3 7277.3 7282.3 7286.7 7110.4 7113.8 7114.8 7116.3 7125.1 7284.9 7318.5 7344.5 7352.3 7364.0 6964.3 6971.1 6971.5 6973.9 6980.0 6665.7 6839.9 6864.0 6867.0 6883.4 7204.7 7232.3 7240.4 7246.5 7256.7 4664.8 4675.6 4678.5 4686.9 4686.9 6909.6 6910.4 6916.3 6922.0 6930.2 6540.9 6729.7 6731.6 6742.5 6803.1 6758.7 6763.6 6770.8 6787.6 6799.0 6646.1 6648.3 6667.0 6669.1 6670.9 6805.5 6816.3 6817.5 6826.8 6829.8 6329.1 6377.3 6563.9 6632.9 6636.4 22:42:57 INFO - PROCESS | 3385 | 22:42:57 INFO - PROCESS | 3385 | [#5] yui.html Cycles:180 Average:15604.71 Median:24448.63 stddev:17669.23 (72.3%) stddev-sans-first:17684.16 22:42:57 INFO - PROCESS | 3385 | Values: 874.2 874.8 926.5 929.3 937.8 15130.7 15227.3 15260.5 15270.8 15970.3 15701.1 15722.4 15785.8 15788.9 15792.1 770.0 903.5 905.0 913.5 914.3 902.4 903.4 904.0 906.7 913.3 955.8 959.6 960.2 961.5 963.4 806.6 929.5 932.2 951.9 959.1 683.6 686.7 689.9 695.5 702.0 15101.9 15105.3 15113.4 15200.2 15213.1 14311.4 14714.6 14827.5 14872.0 14960.5 11490.7 11711.8 11736.8 11796.6 11991.6 4052.3 4087.4 4120.6 4137.5 4142.3 55627.0 56279.2 57394.7 57456.0 57476.0 11911.5 11954.2 12039.5 12256.3 12449.8 19983.0 20199.3 20211.5 20225.3 20248.2 8485.4 8495.6 8586.1 8628.3 9042.9 4706.8 4724.9 4759.4 4865.3 4935.5 3672.9 3691.9 3719.2 3721.8 3725.5 590.5 664.5 666.9 679.4 687.5 774.4 806.8 829.0 829.3 842.7 9904.7 10051.1 10163.5 10250.3 10366.4 744.9 752.6 761.2 819.7 833.7 4567.5 4856.2 4858.6 4896.7 4987.9 61798.0 62087.7 63058.0 64383.4 64520.7 55371.7 56608.0 56816.7 56928.0 57071.0 51131.0 51610.7 51836.7 52535.5 52916.7 9702.4 9778.4 9813.0 9816.5 9825.6 36667.3 37698.4 38083.4 38313.2 38371.8 44120.8 44329.8 48976.5 49289.0 50518.7 11880.9 11942.8 11987.5 12044.5 12073.7 13368.5 13371.9 13564.5 13843.1 14638.6 12900.9 12945.1 12965.2 13063.5 13374.6 13246.1 13494.7 13866.9 14208.4 14248.5 12745.7 12954.9 12975.3 13050.9 13819.4 11745.7 11784.0 11929.0 12111.1 12275.8 11372.2 11496.6 11687.8 11782.7 11795.8 22:42:57 INFO - PROCESS | 3385 | -------- Summary: end -------- 22:42:57 INFO - PROCESS | 3385 | 22:42:58 INFO - TEST-INFO | 3385: exit 0 22:42:58 INFO - TEST-OK | dromaeo_css | took 1111583ms 22:42:58 INFO - TEST-START | kraken 22:42:58 INFO - operating with platform_type : linux_ 22:42:58 INFO - Initialising browser for kraken test... 22:42:58 INFO - TEST-INFO | started process 3576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHqEXij/profile http://localhost:58851/getInfo.html) 22:43:02 INFO - PROCESS | 3576 | __metrics Screen width/height:1600/1200 22:43:02 INFO - PROCESS | 3576 | colorDepth:24 22:43:02 INFO - PROCESS | 3576 | Browser inner width/height: 1024/697 22:43:02 INFO - PROCESS | 3576 | __metrics 22:43:03 ERROR - PROCESS | 3576 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:43:04 INFO - TEST-INFO | 3576: exit 0 22:43:04 INFO - Browser initialized. 22:43:04 INFO - Running cycle 1/1 for kraken test... 22:43:04 INFO - TEST-INFO | started process 3667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHqEXij/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:15 INFO - PROCESS | 3667 | RSS: Main: 141598720 22:43:15 INFO - PROCESS | 3667 | 22:43:18 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-beat-detection) 22:43:19 INFO - PROCESS | 3667 | RSS: Main: 197877760 22:43:19 INFO - PROCESS | 3667 | 22:43:21 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-dft) 22:43:22 INFO - PROCESS | 3667 | RSS: Main: 184238080 22:43:22 INFO - PROCESS | 3667 | 22:43:25 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-fft) 22:43:25 INFO - PROCESS | 3667 | RSS: Main: 272711680 22:43:25 INFO - PROCESS | 3667 | 22:43:27 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-oscillator) 22:43:28 INFO - PROCESS | 3667 | RSS: Main: 179318784 22:43:28 INFO - PROCESS | 3667 | 22:43:30 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:43:31 INFO - PROCESS | 3667 | RSS: Main: 177766400 22:43:31 INFO - PROCESS | 3667 | 22:43:34 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-darkroom) 22:43:34 INFO - PROCESS | 3667 | RSS: Main: 212578304 22:43:34 INFO - PROCESS | 3667 | 22:43:38 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-desaturate) 22:43:38 INFO - PROCESS | 3667 | RSS: Main: 212631552 22:43:38 INFO - PROCESS | 3667 | 22:43:41 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58851/tests/kraken/driver.html?testName=json-parse-financial) 22:43:42 INFO - PROCESS | 3667 | RSS: Main: 212258816 22:43:42 INFO - PROCESS | 3667 | 22:43:43 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:43:44 INFO - PROCESS | 3667 | RSS: Main: 192057344 22:43:44 INFO - PROCESS | 3667 | 22:43:45 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:43:46 INFO - PROCESS | 3667 | RSS: Main: 196145152 22:43:46 INFO - PROCESS | 3667 | 22:43:49 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:43:49 INFO - PROCESS | 3667 | RSS: Main: 209702912 22:43:49 INFO - PROCESS | 3667 | 22:43:51 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:43:52 INFO - PROCESS | 3667 | RSS: Main: 218628096 22:43:52 INFO - PROCESS | 3667 | 22:43:54 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:43:55 INFO - PROCESS | 3667 | RSS: Main: 215764992 22:43:55 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58851/tests/kraken/driver.html?testName=ai-astar) 22:43:57 INFO - PROCESS | 3667 | RSS: Main: 276127744 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | __start_tp_report 22:43:57 INFO - PROCESS | 3667 | _x_x_mozilla_page_load 22:43:57 INFO - PROCESS | 3667 | _x_x_mozilla_page_load_details 22:43:57 INFO - PROCESS | 3667 | |i|pagename|runs| 22:43:57 INFO - PROCESS | 3667 | |0;ai-astar;110;111;109;111;112;110;106;109;108;109 22:43:57 INFO - PROCESS | 3667 | |1;audio-beat-detection;153;135;153;177;129;154;150;126;180;125 22:43:57 INFO - PROCESS | 3667 | |2;audio-dft;163;161;159;158;158;161;160;160;158;159 22:43:57 INFO - PROCESS | 3667 | |3;audio-fft;72;76;76;166;75;74;76;77;166;74 22:43:57 INFO - PROCESS | 3667 | |4;audio-oscillator;91;92;154;92;92;94;152;92;92;148 22:43:57 INFO - PROCESS | 3667 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 22:43:57 INFO - PROCESS | 3667 | |6;imaging-darkroom;146;145;145;145;145;146;146;146;145;145 22:43:57 INFO - PROCESS | 3667 | |7;imaging-desaturate;94;95;96;95;95;95;95;95;95;95 22:43:57 INFO - PROCESS | 3667 | |8;json-parse-financial;55;54;54;53;53;54;55;73;53;51 22:43:57 INFO - PROCESS | 3667 | |9;json-stringify-tinderbox;58;59;60;60;59;59;58;60;60;59 22:43:57 INFO - PROCESS | 3667 | |10;stanford-crypto-aes;72;72;73;74;76;75;74;81;73;80 22:43:57 INFO - PROCESS | 3667 | |11;stanford-crypto-ccm;117;119;114;112;112;119;114;115;129;133 22:43:57 INFO - PROCESS | 3667 | |12;stanford-crypto-pbkdf2;162;161;163;160;159;160;163;165;158;162 22:43:57 INFO - PROCESS | 3667 | |13;stanford-crypto-sha256-iterative;68;67;65;66;66;68;66;66;67;65 22:43:57 INFO - PROCESS | 3667 | __end_tp_report 22:43:57 INFO - PROCESS | 3667 | __start_cc_report 22:43:57 INFO - PROCESS | 3667 | _x_x_mozilla_cycle_collect,1561 22:43:57 INFO - PROCESS | 3667 | __end_cc_report 22:43:57 INFO - PROCESS | 3667 | __startTimestamp1465278237369__endTimestamp 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | ------- Summary: start ------- 22:43:57 INFO - PROCESS | 3667 | Number of tests: 14 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.72 (1.6%) stddev-sans-first:1.81 22:43:57 INFO - PROCESS | 3667 | Values: 110.0 111.0 109.0 111.0 112.0 110.0 106.0 109.0 108.0 109.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:153.00 stddev:19.71 (12.9%) stddev-sans-first:20.83 22:43:57 INFO - PROCESS | 3667 | Values: 153.0 135.0 153.0 177.0 129.0 154.0 150.0 126.0 180.0 125.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:1.64 (1.0%) stddev-sans-first:1.22 22:43:57 INFO - PROCESS | 3667 | Values: 163.0 161.0 159.0 158.0 158.0 161.0 160.0 160.0 158.0 159.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:38.40 (50.9%) stddev-sans-first:39.95 22:43:57 INFO - PROCESS | 3667 | Values: 72.0 76.0 76.0 166.0 75.0 74.0 76.0 77.0 166.0 74.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.64 (31.1%) stddev-sans-first:29.55 22:43:57 INFO - PROCESS | 3667 | Values: 91.0 92.0 154.0 92.0 92.0 94.0 152.0 92.0 92.0 148.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:43:57 INFO - PROCESS | 3667 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:43:57 INFO - PROCESS | 3667 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 22:43:57 INFO - PROCESS | 3667 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:6.26 (11.6%) stddev-sans-first:6.64 22:43:57 INFO - PROCESS | 3667 | Values: 55.0 54.0 54.0 53.0 53.0 54.0 55.0 73.0 53.0 51.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 22:43:57 INFO - PROCESS | 3667 | Values: 58.0 59.0 60.0 60.0 59.0 59.0 58.0 60.0 60.0 59.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:3.16 (4.2%) stddev-sans-first:3.16 22:43:57 INFO - PROCESS | 3667 | Values: 72.0 72.0 73.0 74.0 76.0 75.0 74.0 81.0 73.0 80.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:118.00 stddev:7.15 (6.1%) stddev-sans-first:7.57 22:43:57 INFO - PROCESS | 3667 | Values: 117.0 119.0 114.0 112.0 112.0 119.0 114.0 115.0 129.0 133.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:2.11 (1.3%) stddev-sans-first:2.22 22:43:57 INFO - PROCESS | 3667 | Values: 162.0 161.0 163.0 160.0 159.0 160.0 163.0 165.0 158.0 162.0 22:43:57 INFO - PROCESS | 3667 | 22:43:57 INFO - PROCESS | 3667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:0.97 22:43:57 INFO - PROCESS | 3667 | Values: 68.0 67.0 65.0 66.0 66.0 68.0 66.0 66.0 67.0 65.0 22:43:57 INFO - PROCESS | 3667 | -------- Summary: end -------- 22:43:57 INFO - PROCESS | 3667 | 22:43:58 INFO - TEST-INFO | 3667: exit 0 22:43:58 INFO - TEST-OK | kraken | took 59909ms 22:43:58 INFO - SUITE-END | took 1171s 22:43:58 INFO - Completed test suite (00:19:31) 22:43:58 INFO - javascript benchmark 22:43:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.1178781728936, 3328.850201740923, 3336.8331583420836, 3360.5799275090612, 3371.3931492331385, 5585.888282234353, 5588.86027849304, 5597.63615365002, 5607.130894711321, 5623.550115990721, 5565.1374037024225, 5586.6368686035485, 5614.157876318554, 5617.466340697627, 5650.660960342372, 5005.424376196747, 5066.746662666852, 5078.162103252959, 5154.587632989352, 5229.843104706865, 5078.187490001582, 5165.66423182492, 5165.767540460688, 5169.483051694838, 5171.7414129293575, 4994.325766021595, 5048.772805223755, 5053.317802096725, 5059.696418214919, 5071.797128114889, 5133.050385678662, 5163.8192663256605, 5165.121929272014, 5166.095933211692, 5172.534471897509, 4943.505649435064, 5025.748712564357, 5086.084504789136, 5096.184610462308, 5104.310918026056, 5438.401775804658, 5477.096279113942, 5505.642133261325, 5509.724513774336, 5511.283533140706, 5933.584649074566, 5944.464998150187, 5949.077892926603, 5968.791092311748, 5969.074793406985, 5868.9413105868825, 5911.940880591225, 5918.970405147947, 5956.761729530814, 5988.131720900445, 5585.357683866367, 5625.746841392065, 5636.04187288162, 5640.915386269209, 5653.010723123478, 5994.67029313392, 6101.664408457577, 6145.569810113249, 6163.075538669235, 6164.383561643889, 5937.821865344046, 5997.220361353084, 6025.246844144482, 6049.909251361233, 6050.6672133032225, 5950.940490595039, 5954.404559544011, 5973.551983601247, 5987.31145918225, 5998.190244317048, 5742.770289188469, 5958.761649534057, 5986.5809393342915, 5987.790427335022, 5995.430434108753, 5968.224130863046, 6005.939940600625, 6011.0382338825575, 6017.338092809788, 6081.361457046946, 4418.668599855024, 4511.684182107287, 4513.345564893072, 4516.232240519054, 4538.092381523643, 3924.4309575111447, 3960.4653371795016, 3987.202559488114, 4048.554658987509, 4076.8369265229057, 5732.971335143297, 5764.106563482667, 5772.365039845614, 5774.2782152230975, 5788.073908174756, 6039.305479869871, 6048.153258543807, 6056.06131049688, 6057.121717350959, 6060.787872424532, 5510.393856675762, 5648.15277708347, 5673.574481913873, 5785.756062446594, 5805.10020946754, 4826.975865120652, 5010.64925455222, 5011.34852469184, 5021.121303771825, 5041.899162016813, 5990.880182396415, 6168.153349781739, 6179.104029915637, 6196.318404975449, 6216.689165541705, 5936.7922122725495, 5945.286565612154, 5975.133605627073, 6017.879642407215, 6035.6076855004285, 6097.5731698780655, 6123.540734445023, 6127.785527506516, 6128.693565321627, 6199.876002480015, 5787.334456537552, 5888.735006924613, 5895.263092113486, 5911.349751527243, 5912.260967379078, 5993.250843644544, 6049.697515124314, 6055.485283750931, 6062.060380641008, 6072.210612620331, 5833.82498525045, 5870.5010074142465, 5889.852753681193, 5908.497777688773, 5910.320313163869, 5592.7762889483965, 5857.765689372377, 5864.149698293809, 5902.1146827976145, 5922.674252916131, 5771.422857714195, 5774.913376299275, 5784.652920824764, 5793.594448388572, 5804.738786754522, 5854.385289544536, 5869.090291004901, 5878.353381127987, 5894.852628684145, 5913.172155898092, 5670.914936275876, 5779.653220806765, 5782.797602083907, 5796.797112101225, 5848.824535263949], "value": 5516.029494745315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.6720887116521, 656.1568384625756, 666.1639642248977, 673.0913267089433, 679.3715812873094, 32333.51499727503, 32996.835015824916, 39101.413478797804, 39498.21003579934, 39686.40470392947, 42278.154436911245, 42421.0, 42581.57418425815, 42607.0, 42753.78623106888, 8131.7560473185895, 8866.999999999984, 9035.051319611412, 9054.0, 9058.23005044572, 10749.570017199303, 11031.951964563354, 11055.557777688882, 11057.778844423106, 11058.668239952814, 10836.566537338536, 10904.34573925563, 10915.890841091566, 10928.289661171999, 10951.671449856518, 10715.035646791786, 10808.297460665031, 10812.72968175794, 10815.35107893529, 10815.459227038617, 10576.788464230749, 10664.200184986079, 10673.573057077707, 10676.466176691212, 10683.30558513694, 43204.567954320366, 43216.351754723706, 43263.35104973428, 43633.781831090644, 43660.690179294674, 3830.6743926766258, 4261.228376448168, 4401.383806267125, 4518.277075667877, 4626.699264547794, 32587.348253035045, 33286.50070248924, 33301.6669833301, 33448.66551334504, 35142.82428587866, 4107.0, 4151.813168407429, 4194.203101410722, 4199.4330765346895, 4305.698601097924, 321483.0, 322646.0, 323227.0, 324516.0, 325568.0, 67754.66122669356, 67756.32243677501, 68298.31701683019, 68352.31647683459, 68381.0, 69582.0, 71664.64167679232, 72993.6350318245, 73189.6340518294, 73218.0, 17603.471895843144, 17855.107244637715, 17895.194716237802, 17900.55248618795, 17906.28374865017, 12774.936125319315, 13349.866501335056, 13531.32343382827, 13646.454141834414, 13920.095193812369, 20361.287354942506, 20465.2837150699, 20620.896895515725, 20635.793642063687, 20703.896480517804, 7282.198958114604, 7369.336759691546, 7455.291747283999, 7455.776326710207, 7501.174870764212, 1105.911527077848, 1107.6732363952653, 1113.6158025481195, 1125.6510481750684, 1138.7779383020231, 35172.824135879666, 35348.646513534535, 35545.28909421797, 35691.64308356935, 36465.0, 1218.8415505984165, 1271.4786937355639, 1275.9744805103846, 1324.741675373293, 1329.3286890120621, 17987.910060449874, 18382.172802223933, 18466.722999155023, 18531.351402700842, 19033.238670453306, 522729.0, 532957.0, 535740.0, 535883.0, 535985.0, 66046.0, 66747.66626166838, 66893.33106668871, 67125.32874671288, 67147.32852671508, 1330.7737684593449, 1412.2310362170442, 1507.713534428455, 1584.0891487394795, 1585.0410501646568, 32582.67417325891, 34239.31521369509, 34916.30167396587, 34947.0, 35117.0, 53072.73463632657, 53477.73261133825, 53559.732201338746, 53636.46363536315, 53690.73154634202, 312043.0, 316248.0, 316485.0, 319606.0, 320102.0, 30266.54600180955, 31667.52498712567, 31752.206194845312, 32513.187170320933, 32661.71368004217, 47020.29469557891, 47434.76282618565, 48241.035179296916, 48301.27548086852, 48901.0, 42033.0, 43064.35403468888, 43090.56909430865, 43969.34045989377, 44839.32741008822, 42117.57882421136, 42760.0, 43108.353374698774, 43211.783941080095, 44137.77931110324, 42955.35566966561, 43603.78198109116, 44316.55683443124, 44919.55080449153, 44939.55060449354, 36776.26447471089, 37837.24325513529, 38101.61898381091, 39224.411633824944, 39465.0, 29409.264768380963, 29788.255293617833, 29857.095778783205, 29939.0, 30172.54741178928], "value": 21412.223461060374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2622228432552, 387.7518388231532, 393.5022196920894, 401.59639562239965, 417.1635870080488, 15504.922475387608, 16439.91780041098, 19264.614707705856, 19790.90104549477, 19914.800851991477, 16848.326066957306, 19220.71168932467, 20066.69899951498, 20121.899390503062, 20453.079611417485, 5622.212890195366, 5839.970800146015, 5844.2402487676545, 5847.210626565402, 5852.853678658046, 5705.343885453164, 5791.507721843627, 5797.043487824525, 5800.7679692812235, 5801.0, 5699.515541179005, 5730.616078699798, 5785.681787501707, 5792.015357389254, 5861.032929566616, 5772.191893134965, 5790.7683692652245, 5817.912731309034, 5836.358000619928, 5844.649321040752, 5170.069387510247, 5210.687358758449, 5221.373435187802, 5227.26818245446, 5244.370675518924, 24301.27096187117, 25041.12356067547, 25364.746352536422, 25688.229353119248, 25698.0, 2550.6939167300043, 2668.706442291366, 2750.22993561803, 2911.097559756482, 3075.0, 15018.0, 15051.172185529791, 15088.39646414142, 15139.470118545798, 15450.768238476432, 1966.822985931273, 2000.9399718008483, 2019.3840878532042, 2040.9387718368473, 2060.5054786851197, 80138.0, 81124.18875811226, 81342.9999999994, 83246.58376708138, 83264.0, 10813.729656758644, 10836.72908177286, 11032.724181895517, 11044.944775276233, 11161.218714689894, 15008.324625391884, 15191.240437978056, 15441.382344706086, 15478.148701821283, 15483.612909677347, 8185.345172386314, 8235.876461853077, 8372.832543349221, 8528.701495447629, 8555.529445880537, 8156.796080097926, 8211.83576328482, 8253.0, 8340.332773378115, 8372.455790373606, 6190.783322583778, 6780.966095169492, 6965.920282356243, 7002.684879180449, 7039.0, 1831.3032492949862, 1940.4566721318054, 1966.4199061276959, 1969.1729473621112, 2012.6880333548324, 1077.876044254905, 1088.820344643125, 1110.2228440091967, 1130.2314426190105, 1190.5356910804794, 19351.51621209481, 20133.39599812008, 20220.797792022186, 20435.693464598044, 20481.0, 1087.4780105549223, 1102.96139635114, 1106.1427393769893, 1109.983350249747, 1118.066414543865, 10640.946795265974, 11925.0, 11925.284482931052, 11959.820602690967, 11985.700357490958, 400130.0, 402348.0, 402516.0, 403996.0, 561884.0, 94628.52685736527, 99790.5010474943, 99851.0, 100021.49989250007, 100243.0, 1117.8155604325357, 1150.7180740718577, 1157.9710507237387, 1158.9826152607718, 1164.2083383299268, 17941.282348705907, 18120.18459169367, 18123.36568220106, 18175.636487270443, 18744.812551874853, 40129.0, 40682.389764154155, 40724.59275407208, 41038.79480602578, 41895.371569427094, 59662.40337596568, 60236.39763602308, 60915.69542152261, 61201.38798611957, 61355.386446134966, 8666.566671666518, 8805.0, 8951.507667078373, 9101.77245568866, 9144.085591440802, 11596.76806463849, 13716.24560649134, 13974.860251397762, 14113.2943352834, 14279.500217492337, 12480.188787728768, 12527.93736031314, 12630.810537842124, 12839.935800320938, 12891.41988610496, 11902.880971190178, 12345.259284442604, 12457.626271211879, 12805.359732013176, 12806.67983300425, 12497.062720296197, 12587.811182832447, 12693.301868397326, 12732.936335318263, 12808.871911280768, 8686.956565217133, 8880.73357799267, 9112.817743644957, 9122.315826313186, 9151.496667683341, 9250.0, 11756.470958807045, 12188.390580471118, 12331.753364932472, 12443.128980971607], "value": 9724.257487107123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.5388121919768, 1584.8811339149563, 1608.5576466471719, 1834.3671433355496, 1943.9708404373937, 7502.174760776317, 8318.584070796458, 8454.87317690235, 8475.152484751521, 8477.067522572512, 8230.465019773725, 8317.500949943007, 8361.498310101382, 8380.874286885686, 8401.747947561567, 2406.4104294447884, 2436.61014237722, 2438.061346381647, 2438.5244877248942, 2441.316431399202, 2363.95272094558, 2387.641853721947, 2403.4111642647576, 2406.4104294447884, 2421.2615152378607, 2389.3787615219994, 2411.2043025801445, 2418.3712234818986, 2420.9636855447184, 2426.9029238830426, 2367.8460900041614, 2397.508510755291, 2405.1822380390663, 2405.855648661086, 2407.2056221447056, 2321.2223904991847, 2365.1840115160244, 2368.3131891751545, 2371.0, 2376.6435034744754, 7375.926240737577, 8084.070331911787, 8593.570321483901, 8663.35024873137, 8664.0, 5085.694858308513, 5200.739963001834, 5210.739463026872, 5212.843614691566, 5213.7393130343335, 3393.694567488938, 3439.793612383265, 3450.1547120955524, 3462.549868517102, 3509.5788505379264, 1086.3481910853504, 1098.6813823991033, 1113.565709373345, 1116.553378648539, 1126.6282126898186, 11574.305541667527, 12118.151729378947, 12126.636200913987, 12127.514899404014, 12134.150609457341, 4567.748773817472, 4595.37962375075, 4648.465426475931, 4682.344471773954, 4694.530546945278, 10345.43100129485, 10360.119389851947, 10371.118454931415, 10376.066154046172, 10385.896141038644, 5308.946910530923, 5311.362636483569, 5314.654547454403, 5319.7340132993195, 5321.627486075938, 4853.02939412119, 4906.852794416173, 4912.0, 4915.3855768029, 4916.803327866917, 3756.229972855558, 3983.402489626579, 3988.680905527609, 4001.5398229204015, 4014.5182578090817, 1242.8011518157052, 1242.9813552796716, 1247.8065899785547, 1254.5734450286764, 1262.5391732017747, 1003.6888564545014, 1040.8750949886062, 1058.99470502647, 1059.279689810936, 1073.1414868105485, 6109.633421994695, 6111.113888486234, 6127.816165515042, 6246.781362652286, 6335.906796736238, 459.7149767144325, 465.550743532486, 468.7820163623931, 470.21943573667545, 479.2762927978777, 4170.457840480779, 4174.83300667976, 4199.91600167995, 4259.574042595777, 4263.957360426356, 10203.540840662188, 10513.684589462327, 10614.787704245871, 10617.416042117758, 10631.096356809603, 10407.635732749317, 10449.164066874631, 10456.424896630606, 10467.214958878114, 10477.0, 7852.803679908048, 8047.074586422519, 8050.677972881136, 8066.717664881819, 8138.145494723087, 6147.231596050494, 6221.875562488634, 6293.244810622755, 6303.558750887394, 6328.493720502441, 9444.52777361143, 9450.669226577036, 9536.523173841142, 9616.423014619146, 9725.708228753148, 9580.712578622653, 9853.704388868346, 9877.753056173653, 9975.700728978143, 10098.19214462856, 7818.140004599376, 7889.171636978034, 7890.289873911375, 7900.762977110696, 7911.208879112043, 8284.71003514874, 8302.958485207535, 8373.95325584302, 8375.623096960773, 8380.371472139735, 7466.402687785073, 7614.086309642878, 7645.426593005435, 7731.0336207974005, 7849.686012559434, 7205.279472052753, 7283.344498995116, 7371.189169191492, 7399.038125043709, 7550.282723141293, 6965.33829286217, 6971.2331643518155, 7001.509894307554, 7013.929860701328, 7019.754308599175, 4363.759993200404, 4883.755812209446, 5039.143345631325, 5099.0, 5156.484351564814, 5115.411727651368, 5119.308893299357, 5227.137522308929, 5261.079311120615, 5289.973550132225], "value": 4551.900709516812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.25650999567245, 341.2288228603356, 341.3548393536216, 345.4973014264246, 347.47531227845946, 6277.583130494758, 6341.112244285798, 6410.262819775728, 6477.2551156617, 6479.514036447274, 6306.873862522747, 6342.524310676707, 6384.840378990516, 6392.456641185493, 6396.328385519511, 4823.372961514998, 4827.63792715546, 4830.97584512077, 4832.855014349575, 4835.661503694751, 4561.7262964222255, 4666.253399456088, 4760.190767569521, 4763.737994410306, 4774.880627984311, 4705.717656940577, 4738.360321356625, 4748.857534273978, 4761.0953918755495, 4762.523747625227, 4552.271636538138, 4742.715437073786, 4760.523947605247, 4765.833195838146, 4767.070421267854, 3991.980040099781, 4095.0786073133604, 4097.426360309559, 4098.918021639581, 4101.507819061701, 5986.3714309997695, 5986.610870293417, 6053.69731513427, 6057.787977420813, 6059.878802423971, 5522.0, 5533.08704063833, 5534.4742249486235, 5535.252740880011, 5535.308086489189, 6632.834179145511, 6634.668266586651, 6639.701213445406, 6643.701033453506, 6644.43522300605, 4496.910061798779, 4598.218302888517, 4599.402077729874, 4604.286335617984, 4605.700629459075, 6896.379325860697, 6959.338862808076, 6983.336583024605, 6999.0, 7000.754973575951, 4677.6257899367965, 4695.812167513262, 4696.5303469653445, 4701.0, 4704.341392205094, 4759.0719809637485, 4761.904761904742, 4764.737939413296, 4766.0, 4766.046790641885, 5514.531264842453, 5517.420670829585, 5520.447955204528, 5523.061079616475, 5534.944650553523, 6571.57284776488, 6720.764773232913, 6720.764773232913, 6726.0, 6733.124693789776, 1642.1871173768823, 1672.222416576298, 1674.3972170018783, 1674.6483238519804, 1674.8911320764355, 1063.3247887591435, 1087.2932593813925, 1102.2614848051824, 1105.5080489182396, 1107.0147568663895, 6382.808515744535, 6409.583377080475, 6551.737930482823, 6554.8361290968105, 6567.376099270562, 6973.686184121727, 6988.056612357368, 6995.580265184105, 7002.824929376705, 7006.649667516604, 6605.636689982001, 6606.174228221473, 6610.975298828689, 6611.570247933965, 6614.305497922649, 3721.813909304524, 3747.775133491999, 3752.7373083884413, 3757.2861156380745, 3757.8538545743263, 7054.470914681419, 7268.345848873627, 7277.2722727726805, 7282.271772822675, 7286.70853165878, 7110.3600675939415, 7113.82215444618, 7114.750983715545, 7116.323949224816, 7125.1093613298335, 7284.927150728531, 7318.451116166309, 7344.485885988036, 7352.338289553966, 7364.0, 6964.303569642995, 6971.058907047483, 6971.5468494547695, 6973.930260697328, 6979.965100174467, 6665.700043497957, 6839.897401538881, 6864.0, 6866.965665171642, 6883.449324053963, 7204.675789589376, 7232.276772322725, 7240.384567311838, 7246.492745507764, 7256.673449694671, 4664.813407463799, 4675.602573781267, 4678.485366609602, 4686.906261874811, 4686.92969605463, 6909.550879192836, 6910.447164226749, 6916.3429474199875, 6922.0, 6930.237673855972, 6540.869182616416, 6729.663516824237, 6731.629760363227, 6742.4943129266485, 6803.149606299213, 6758.729650814109, 6763.5603685762235, 6770.830729231611, 6787.626680532618, 6799.014142949146, 6646.069550263063, 6648.335166483313, 6667.033280174444, 6669.0663307136065, 6670.9332906670315, 6805.455563555002, 6816.318368163144, 6817.454603631797, 6826.795196144124, 6829.795106146824, 6329.145565348619, 6377.266614339224, 6563.9343606563325, 6632.938729803208, 6636.402723754885], "value": 5041.749268034984, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [874.1957399192742, 874.820661764338, 926.4858003807884, 929.272584963133, 937.8030613571152, 15130.697386052287, 15227.314770835312, 15260.542183734491, 15270.770938435933, 15970.281337339818, 15701.136437495934, 15722.37110515581, 15785.842141578582, 15788.921055394736, 15792.131432771193, 769.9846003079936, 903.5482258870582, 904.9909500904972, 913.5295322908707, 914.3279689428265, 902.4134312696767, 903.3856977255464, 904.0281697175529, 906.6509393883337, 913.3423934766957, 955.813616344813, 959.5538074795219, 960.2126256469663, 961.4567769210408, 963.4267610771615, 806.5805780993909, 929.4794914847639, 932.2262522106636, 951.8952915179325, 959.0553304994575, 683.5795985468901, 686.7493364921818, 689.9310068993111, 695.5061906046712, 701.9859602807916, 15101.924490377587, 15105.3202605883, 15113.39546418142, 15200.16399098049, 15213.087214767149, 14311.427542898271, 14714.632134196623, 14827.481038163613, 14872.0, 14960.476383326532, 11490.655280341603, 11711.824322635168, 11736.765264694659, 11796.587119450778, 11991.64025079249, 4052.331365324718, 4087.3664581989838, 4120.649744771698, 4137.462129923121, 4142.275101857163, 55627.0, 56279.155812662844, 57394.71302643502, 57456.0, 57475.999999999585, 11911.463984120735, 11954.222975506738, 12039.518419263306, 12256.325902075472, 12449.813252801216, 19983.000849957443, 20199.293024744064, 20211.494712632008, 20225.29211477591, 20248.190072397232, 8485.363597730071, 8495.575221238912, 8586.055533891267, 8628.309735221168, 9042.864357034518, 4706.835260765857, 4724.943293701212, 4759.38128043359, 4865.343178670905, 4935.506449355035, 3672.889813305605, 3691.8523259069875, 3719.237556300952, 3721.776693398405, 3725.4970578972034, 590.4626789621424, 664.5348256220665, 666.8699603577256, 679.4292794053019, 687.4843867099676, 774.3572834547425, 806.8023334283138, 828.9544075075808, 829.307528213936, 842.7471758472557, 9904.653337133166, 10051.145652619463, 10163.459135216195, 10250.333728307636, 10366.429846358373, 744.8584768893893, 752.5672738175571, 761.162721006888, 819.6844214977276, 833.6832003838624, 4567.474740404829, 4856.223004319292, 4858.58702010333, 4896.68171568854, 4987.900241995139, 61798.0, 62087.6895615519, 63058.0, 64383.35616643867, 64520.677396612715, 55371.723141384035, 56608.0, 56816.71591642015, 56928.0, 57071.0, 51131.0, 51610.74194629003, 51836.74081629568, 52535.47464525306, 52916.73541632267, 9702.417854928726, 9778.364406313567, 9813.0, 9816.509174541387, 9825.557849896915, 36667.26665466622, 37698.43452348272, 38083.428748568236, 38313.23373532458, 38371.80814095912, 44120.779396102815, 44329.77835110804, 48976.51023489719, 49289.0, 50518.74740626274, 11880.881191187977, 11942.820857687315, 11987.460564274454, 12044.51821927113, 12073.69815754578, 13368.465261389436, 13371.933140334626, 13564.521573377155, 13843.100198487065, 14638.634034149232, 12900.870991290343, 12945.09384343087, 12965.222086674452, 13063.542776002794, 13374.598762037154, 13246.139000964906, 13494.73010539764, 13866.861331386961, 14208.431662733376, 14248.501302454364, 12745.681357965754, 12954.93522532419, 12975.286359249954, 13050.934745326213, 13819.447222111405, 11745.706357341134, 11784.0, 11929.0, 12111.091668124749, 12275.754484910072, 11372.171114069568, 11496.597619083292, 11687.76624467523, 11782.705432364259, 11795.823062653895], "value": 7242.763033570021, "unit": "score"}], "name": "dromaeo_css", "value": 7588.293968974008, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 111.0, 112.0, 110.0, 106.0, 109.0, 108.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 135.0, 153.0, 177.0, 129.0, 154.0, 150.0, 126.0, 180.0, 125.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 159.0, 158.0, 158.0, 161.0, 160.0, 160.0, 158.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 76.0, 166.0, 75.0, 74.0, 76.0, 77.0, 166.0, 74.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 154.0, 92.0, 92.0, 94.0, 152.0, 92.0, 92.0, 148.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 53.0, 54.0, 55.0, 73.0, 53.0, 51.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 60.0, 59.0, 59.0, 58.0, 60.0, 60.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 74.0, 76.0, 75.0, 74.0, 81.0, 73.0, 80.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 114.0, 112.0, 112.0, 119.0, 114.0, 115.0, 129.0, 133.0], "value": 118.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 159.0, 160.0, 163.0, 165.0, 158.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 66.0, 66.0, 68.0, 66.0, 66.0, 67.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1513.5, "alertThreshold": 2.0}]} 22:43:58 INFO - Return code: 0 22:43:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:43:58 ERROR - # TBPL SUCCESS # 22:43:58 INFO - Running post-action listener: _resource_record_post_action 22:43:58 INFO - Running post-run listener: _resource_record_post_run 22:43:59 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 7684096; Write bytes: 355225600; Read time: 1476; Write time: 310280 22:43:59 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 11964416; Read time: 0; Write time: 13256 22:43:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5922816; Write bytes: 343261184; Read time: 1424; Write time: 297024 22:43:59 INFO - Running post-run listener: _upload_blobber_files 22:43:59 INFO - Blob upload gear active. 22:43:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:43:59 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 22:43:59 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'] 22:43:59 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 22:44:00 INFO - (blobuploader) - INFO - Open directory for files ... 22:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:44:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:01 INFO - (blobuploader) - INFO - Done attempting. 22:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:44:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:01 INFO - (blobuploader) - INFO - Done attempting. 22:44:01 INFO - (blobuploader) - INFO - Iteration through files over. 22:44:01 INFO - Return code: 0 22:44:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:44:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:44:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/735bd5519798d5b597f9c4a8ad0abcbc19e760b797369d2806b6467f02d1706788465b6a3ac9daf16ee9b2e697b6d5e7aebb6e87c60a814486e209266ce69537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90823559f50cdc63a2f55c9ad7a9905d13043e8d47e65f3551a7b334c6df0fe0b83f69c9ce1a76a649c335ed47a70b0897659c93f424e83bd5b165b18cde9906"} 22:44:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:44:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:44:01 INFO - Contents: 22:44:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/735bd5519798d5b597f9c4a8ad0abcbc19e760b797369d2806b6467f02d1706788465b6a3ac9daf16ee9b2e697b6d5e7aebb6e87c60a814486e209266ce69537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90823559f50cdc63a2f55c9ad7a9905d13043e8d47e65f3551a7b334c6df0fe0b83f69c9ce1a76a649c335ed47a70b0897659c93f424e83bd5b165b18cde9906"} 22:44:01 INFO - Running post-run listener: copy_logs_to_upload_dir 22:44:01 INFO - Copying logs to upload dir... 22:44:01 INFO - mkdir: /builds/slave/test/build/upload/logs 22:44:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.883210 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-06 22:44:01.802987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 22:44:01.806969) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229 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/735bd5519798d5b597f9c4a8ad0abcbc19e760b797369d2806b6467f02d1706788465b6a3ac9daf16ee9b2e697b6d5e7aebb6e87c60a814486e209266ce69537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90823559f50cdc63a2f55c9ad7a9905d13043e8d47e65f3551a7b334c6df0fe0b83f69c9ce1a76a649c335ed47a70b0897659c93f424e83bd5b165b18cde9906"} build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/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/735bd5519798d5b597f9c4a8ad0abcbc19e760b797369d2806b6467f02d1706788465b6a3ac9daf16ee9b2e697b6d5e7aebb6e87c60a814486e209266ce69537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90823559f50cdc63a2f55c9ad7a9905d13043e8d47e65f3551a7b334c6df0fe0b83f69c9ce1a76a649c335ed47a70b0897659c93f424e83bd5b165b18cde9906"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 22:44:01.835630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:44:01.835993) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465276685.507881-689356229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:44:01.920494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 22:44:01.921055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 22:44:01.921384) ========= ========= Total master_lag: 0.44 =========