builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1461294325.56 results: success (0) buildid: 20160421173029 builduid: 62b745ca7e644f65a7621ca5830f3d3b revision: 467bd00c72db8f6f34c4d9740378abb90365269f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.563861) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.564384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.564683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.581384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.581660) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 20:05:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.5M=0s 2016-04-21 20:05:27 (69.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.355363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.950222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.950543) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022797 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.999810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 20:05:26.000180) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 467bd00c72db8f6f34c4d9740378abb90365269f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 467bd00c72db8f6f34c4d9740378abb90365269f --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=e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 20:05:27,450 truncating revision to first 12 chars 2016-04-21 20:05:27,450 Setting DEBUG logging. 2016-04-21 20:05:27,450 attempt 1/10 2016-04-21 20:05:27,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/467bd00c72db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 20:05:28,531 unpacking tar archive at: fx-team-467bd00c72db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.363657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 20:05:27.377866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:27.378177) ========= script_repo_revision: 467bd00c72db8f6f34c4d9740378abb90365269f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:27.378559) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:27.378828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:27.388678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-21 20:05:27.388969) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:28 INFO - MultiFileLogger online at 20160421 20:05:28 in /builds/slave/test 20:05:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:05:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:28 INFO - {'append_to_log': False, 20:05:28 INFO - 'base_work_dir': '/builds/slave/test', 20:05:28 INFO - 'blob_upload_branch': 'Fx-Team', 20:05:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:28 INFO - 'branch': 'Fx-Team', 20:05:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:28 INFO - 'config_files': ('talos/linux_config.py',), 20:05:28 INFO - 'default_actions': ('clobber', 20:05:28 INFO - 'read-buildbot-config', 20:05:28 INFO - 'download-and-extract', 20:05:28 INFO - 'populate-webroot', 20:05:28 INFO - 'create-virtualenv', 20:05:28 INFO - 'install', 20:05:28 INFO - 'run-tests'), 20:05:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:28 INFO - 'download_minidump_stackwalk': True, 20:05:28 INFO - 'download_symbols': 'ondemand', 20:05:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:28 INFO - 'installer_path': 'installer.exe', 20:05:28 INFO - 'log_level': 'info', 20:05:28 INFO - 'log_name': 'talos', 20:05:28 INFO - 'log_to_console': True, 20:05:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:28 INFO - 'opt_config_files': (), 20:05:28 INFO - 'pip_index': False, 20:05:28 INFO - 'sps_profile': False, 20:05:28 INFO - 'sps_profile_interval': 0, 20:05:28 INFO - 'suite': 'dromaeojs', 20:05:28 INFO - 'system_bits': '32', 20:05:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:28 INFO - 'title': 'talos-linux64-ix-067', 20:05:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:28 INFO - 'use_talos_json': True, 20:05:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:28 INFO - 'work_dir': 'build'} 20:05:28 INFO - ##### 20:05:28 INFO - ##### Running clobber step. 20:05:28 INFO - ##### 20:05:28 INFO - Running pre-action listener: _resource_record_pre_action 20:05:28 INFO - Running main action method: clobber 20:05:28 INFO - rmtree: /builds/slave/test/build 20:05:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:29 INFO - Running post-action listener: _resource_record_post_action 20:05:29 INFO - ##### 20:05:29 INFO - ##### Running read-buildbot-config step. 20:05:29 INFO - ##### 20:05:29 INFO - Running pre-action listener: _resource_record_pre_action 20:05:29 INFO - Running main action method: read_buildbot_config 20:05:29 INFO - Using buildbot properties: 20:05:29 INFO - { 20:05:29 INFO - "project": "", 20:05:29 INFO - "product": "firefox", 20:05:29 INFO - "script_repo_revision": "production", 20:05:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:05:29 INFO - "repository": "", 20:05:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:05:29 INFO - "buildid": "20160421173029", 20:05:29 INFO - "pgo_build": "True", 20:05:29 INFO - "basedir": "/builds/slave/test", 20:05:29 INFO - "buildnumber": 595, 20:05:29 INFO - "slavename": "talos-linux64-ix-067", 20:05:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:05:29 INFO - "platform": "ubuntu64_hw", 20:05:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:05:29 INFO - "branch": "fx-team", 20:05:29 INFO - "repo_path": "integration/fx-team", 20:05:29 INFO - "revision": "467bd00c72db8f6f34c4d9740378abb90365269f", 20:05:29 INFO - "stage_platform": "linux64-pgo", 20:05:29 INFO - "builduid": "62b745ca7e644f65a7621ca5830f3d3b", 20:05:29 INFO - "slavebuilddir": "test" 20:05:29 INFO - } 20:05:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:05:29 INFO - Running post-action listener: _resource_record_post_action 20:05:29 INFO - ##### 20:05:29 INFO - ##### Running download-and-extract step. 20:05:29 INFO - ##### 20:05:29 INFO - Running pre-action listener: _resource_record_pre_action 20:05:29 INFO - Running main action method: download_and_extract 20:05:29 INFO - mkdir: /builds/slave/test/build/tests 20:05: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')]} 20:05:29 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:05:32 INFO - Downloaded 1361 bytes. 20:05:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:05:32 INFO - Using the following test package requirements: 20:05:32 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:05:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'jsshell-linux-x86_64.zip'], 20:05:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:05:32 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:05:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05: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')]} 20:05:32 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:43 INFO - Downloaded 23853953 bytes. 20:05:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:45 INFO - Return code: 0 20:05:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:45 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:47 INFO - Downloaded 23853953 bytes. 20:05:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:48 INFO - Return code: 0 20:05: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')]} 20:05:48 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:05:49 INFO - Downloaded 10845952 bytes. 20:05:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:05:49 INFO - Return code: 0 20:05: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')]} 20:05:49 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:05:51 INFO - Downloaded 58331147 bytes. 20:05:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:51 INFO - mkdir: /builds/slave/test/properties 20:05:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:51 INFO - Contents: 20:05:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:52 INFO - Running post-action listener: _resource_record_post_action 20:05:52 INFO - Running post-action listener: set_extra_try_arguments 20:05:52 INFO - ##### 20:05:52 INFO - ##### Running populate-webroot step. 20:05:52 INFO - ##### 20:05:52 INFO - Running pre-action listener: _resource_record_pre_action 20:05:52 INFO - Running main action method: populate_webroot 20:05:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:52 INFO - '--tppagecycles', 20:05:52 INFO - '7'], 20:05:52 INFO - 'tests': ['tsvgm']}}, 20:05:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['damp', 'tps']}, 20:05:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'tests': ['damp', 'tps']}, 20:05:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['dromaeo_dom']}, 20:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['a11yr', 20:05:52 INFO - 'ts_paint', 20:05:52 INFO - 'tpaint', 20:05:52 INFO - 'sessionrestore', 20:05:52 INFO - 'sessionrestore_no_auto_restore', 20:05:52 INFO - 'tabpaint']}, 20:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:52 INFO - 'ts_paint', 20:05:52 INFO - 'tpaint', 20:05:52 INFO - 'sessionrestore', 20:05:52 INFO - 'sessionrestore_no_auto_restore', 20:05:52 INFO - 'tabpaint']}, 20:05:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:52 INFO - 'ts_paint', 20:05:52 INFO - 'tpaint', 20:05:52 INFO - 'sessionrestore', 20:05:52 INFO - 'sessionrestore_no_auto_restore', 20:05:52 INFO - 'tabpaint']}, 20:05:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:52 INFO - 'ts_paint', 20:05:52 INFO - 'tpaint', 20:05:52 INFO - 'sessionrestore', 20:05:52 INFO - 'sessionrestore_no_auto_restore', 20:05:52 INFO - 'tabpaint']}, 20:05:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['a11yr', 20:05:52 INFO - 'ts_paint', 20:05:52 INFO - 'tpaint', 20:05:52 INFO - 'sessionrestore', 20:05:52 INFO - 'sessionrestore_no_auto_restore', 20:05:52 INFO - 'tabpaint']}, 20:05:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['a11yr', 20:05:52 INFO - 'ts_paint', 20:05:52 INFO - 'tpaint', 20:05:52 INFO - 'sessionrestore', 20:05:52 INFO - 'sessionrestore_no_auto_restore', 20:05:52 INFO - 'tabpaint']}, 20:05:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['tsvgx', 20:05:52 INFO - 'tsvgr_opacity', 20:05:52 INFO - 'tart', 20:05:52 INFO - 'tscrollx', 20:05:52 INFO - 'cart']}, 20:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:52 INFO - 'tsvgr_opacity', 20:05:52 INFO - 'tart', 20:05:52 INFO - 'tscrollx', 20:05:52 INFO - 'cart']}, 20:05:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'talos_options': ['--disable-e10s'], 20:05:52 INFO - 'tests': ['tp5o']}, 20:05:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'tests': ['tp5o']}, 20:05:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'talos_options': ['--disable-e10s', 20:05:52 INFO - '--xperf_path', 20:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:52 INFO - 'tests': ['tp5n']}, 20:05:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:52 INFO - 'talos_options': ['--xperf_path', 20:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:52 INFO - 'tests': ['tp5n']}}, 20:05:52 INFO - 'talos.zip': {'path': '', 20:05:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:52 INFO - Running post-action listener: _resource_record_post_action 20:05:52 INFO - ##### 20:05:52 INFO - ##### Running create-virtualenv step. 20:05:52 INFO - ##### 20:05:52 INFO - Running pre-action listener: _resource_record_pre_action 20:05:52 INFO - Running main action method: create_virtualenv 20:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:52 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 20:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:52 INFO - Using real prefix '/usr' 20:05:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:54 INFO - Installing pip.................done. 20:05:54 INFO - Return code: 0 20:05:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:05:54 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 20:05:54 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 20:05:54 INFO - Using env: {'DISPLAY': ':0', 20:05:54 INFO - 'HOME': '/home/cltbld', 20:05:54 INFO - 'LANG': 'en_US.UTF-8', 20:05:54 INFO - 'LANGUAGE': 'en_US:en', 20:05:54 INFO - 'LOGNAME': 'cltbld', 20:05:54 INFO - 'MAIL': '/var/mail/cltbld', 20:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:54 INFO - 'MOZ_NO_REMOTE': '1', 20:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:54 INFO - 'NO_EM_RESTART': '1', 20:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:54 INFO - 'PWD': '/builds/slave/test', 20:05:54 INFO - 'SHELL': '/bin/bash', 20:05:54 INFO - 'SHLVL': '1', 20:05:54 INFO - 'TERM': 'linux', 20:05:54 INFO - 'TMOUT': '86400', 20:05:54 INFO - 'USER': 'cltbld', 20:05:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:54 INFO - '_': '/tools/buildbot/bin/python'} 20:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:54 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 20:05:54 INFO - Cleaning up... 20:05:54 INFO - Return code: 0 20:05:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:05:54 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 20:05:54 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 20:05:54 INFO - Using env: {'DISPLAY': ':0', 20:05:54 INFO - 'HOME': '/home/cltbld', 20:05:54 INFO - 'LANG': 'en_US.UTF-8', 20:05:54 INFO - 'LANGUAGE': 'en_US:en', 20:05:54 INFO - 'LOGNAME': 'cltbld', 20:05:54 INFO - 'MAIL': '/var/mail/cltbld', 20:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:54 INFO - 'MOZ_NO_REMOTE': '1', 20:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:54 INFO - 'NO_EM_RESTART': '1', 20:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:54 INFO - 'PWD': '/builds/slave/test', 20:05:54 INFO - 'SHELL': '/bin/bash', 20:05:54 INFO - 'SHLVL': '1', 20:05:54 INFO - 'TERM': 'linux', 20:05:54 INFO - 'TMOUT': '86400', 20:05:54 INFO - 'USER': 'cltbld', 20:05:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:54 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:55 INFO - Downloading/unpacking psutil>=0.7.1 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:57 INFO - Installing collected packages: psutil 20:05:57 INFO - Running setup.py install for psutil 20:05:57 INFO - building 'psutil._psutil_linux' extension 20:05:57 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 20:05:57 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 20:05:57 INFO - building 'psutil._psutil_posix' extension 20:05:57 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 20:05:57 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 20:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:57 INFO - Successfully installed psutil 20:05:57 INFO - Cleaning up... 20:05:57 INFO - Return code: 0 20:05:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:05:57 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 20:05:57 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 20:05:57 INFO - Using env: {'DISPLAY': ':0', 20:05:57 INFO - 'HOME': '/home/cltbld', 20:05:57 INFO - 'LANG': 'en_US.UTF-8', 20:05:57 INFO - 'LANGUAGE': 'en_US:en', 20:05:57 INFO - 'LOGNAME': 'cltbld', 20:05:57 INFO - 'MAIL': '/var/mail/cltbld', 20:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:57 INFO - 'MOZ_NO_REMOTE': '1', 20:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:57 INFO - 'NO_EM_RESTART': '1', 20:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:57 INFO - 'PWD': '/builds/slave/test', 20:05:57 INFO - 'SHELL': '/bin/bash', 20:05:57 INFO - 'SHLVL': '1', 20:05:57 INFO - 'TERM': 'linux', 20:05:57 INFO - 'TMOUT': '86400', 20:05:57 INFO - 'USER': 'cltbld', 20:05:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:57 INFO - '_': '/tools/buildbot/bin/python'} 20:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:05:59 INFO - Installing collected packages: mozsystemmonitor 20:05:59 INFO - Running setup.py install for mozsystemmonitor 20:05:59 INFO - Successfully installed mozsystemmonitor 20:05:59 INFO - Cleaning up... 20:05:59 INFO - Return code: 0 20:05:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:05:59 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')]} 20:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:59 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')]} 20:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:59 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:05:59 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 20:05:59 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 20:05:59 INFO - Using env: {'DISPLAY': ':0', 20:05:59 INFO - 'HOME': '/home/cltbld', 20:05:59 INFO - 'LANG': 'en_US.UTF-8', 20:05:59 INFO - 'LANGUAGE': 'en_US:en', 20:05:59 INFO - 'LOGNAME': 'cltbld', 20:05:59 INFO - 'MAIL': '/var/mail/cltbld', 20:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:59 INFO - 'MOZ_NO_REMOTE': '1', 20:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:59 INFO - 'NO_EM_RESTART': '1', 20:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:59 INFO - 'PWD': '/builds/slave/test', 20:05:59 INFO - 'SHELL': '/bin/bash', 20:05:59 INFO - 'SHLVL': '1', 20:05:59 INFO - 'TERM': 'linux', 20:05:59 INFO - 'TMOUT': '86400', 20:05:59 INFO - 'USER': 'cltbld', 20:05:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:59 INFO - '_': '/tools/buildbot/bin/python'} 20:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:02 INFO - Downloading docopt-0.6.1.tar.gz 20:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:02 INFO - Running setup.py install for blobuploader 20:06:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:02 INFO - Running setup.py install for requests 20:06:03 INFO - Running setup.py install for docopt 20:06:03 INFO - Successfully installed blobuploader requests docopt 20:06:03 INFO - Cleaning up... 20:06:03 INFO - Return code: 0 20:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:03 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:06:03 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 20:06:03 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 20:06:03 INFO - Using env: {'DISPLAY': ':0', 20:06:03 INFO - 'HOME': '/home/cltbld', 20:06:03 INFO - 'LANG': 'en_US.UTF-8', 20:06:03 INFO - 'LANGUAGE': 'en_US:en', 20:06:03 INFO - 'LOGNAME': 'cltbld', 20:06:03 INFO - 'MAIL': '/var/mail/cltbld', 20:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:03 INFO - 'MOZ_NO_REMOTE': '1', 20:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:03 INFO - 'NO_EM_RESTART': '1', 20:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:03 INFO - 'PWD': '/builds/slave/test', 20:06:03 INFO - 'SHELL': '/bin/bash', 20:06:03 INFO - 'SHLVL': '1', 20:06:03 INFO - 'TERM': 'linux', 20:06:03 INFO - 'TMOUT': '86400', 20:06:03 INFO - 'USER': 'cltbld', 20:06:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:03 INFO - '_': '/tools/buildbot/bin/python'} 20:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:03 INFO - Running setup.py (path:/tmp/pip-yPC2ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:03 INFO - Running setup.py (path:/tmp/pip-WP578a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:03 INFO - Running setup.py (path:/tmp/pip-Dc4Y4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:03 INFO - Running setup.py (path:/tmp/pip-RDQB1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:03 INFO - Running setup.py (path:/tmp/pip-GOy8Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:03 INFO - Running setup.py (path:/tmp/pip-y1oR_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:04 INFO - Running setup.py (path:/tmp/pip-jwBbZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:04 INFO - Running setup.py (path:/tmp/pip-vGxTQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:04 INFO - Running setup.py (path:/tmp/pip-WXeAF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:04 INFO - Running setup.py (path:/tmp/pip-pxHHhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:04 INFO - Running setup.py (path:/tmp/pip-lcExNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:04 INFO - Running setup.py (path:/tmp/pip-WqS1Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:04 INFO - Running setup.py (path:/tmp/pip-NCv4CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:04 INFO - Running setup.py (path:/tmp/pip-H2SL7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:04 INFO - Running setup.py (path:/tmp/pip-eZKebJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:04 INFO - Running setup.py (path:/tmp/pip-hKblL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:04 INFO - Running setup.py (path:/tmp/pip-pri7Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:04 INFO - Running setup.py install for manifestparser 20:06:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Running setup.py install for mozcrash 20:06:04 INFO - Running setup.py install for mozdebug 20:06:05 INFO - Running setup.py install for mozdevice 20:06:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozfile 20:06:05 INFO - Running setup.py install for mozhttpd 20:06:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozinfo 20:06:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozInstall 20:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozleak 20:06:05 INFO - Running setup.py install for mozlog 20:06:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for moznetwork 20:06:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozprocess 20:06:06 INFO - Running setup.py install for mozprofile 20:06:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozrunner 20:06:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozscreenshot 20:06:06 INFO - Running setup.py install for moztest 20:06:06 INFO - Running setup.py install for mozversion 20:06:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:06 INFO - Cleaning up... 20:06:06 INFO - Return code: 0 20:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:06 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:06:06 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 20:06:06 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 20:06:06 INFO - Using env: {'DISPLAY': ':0', 20:06:06 INFO - 'HOME': '/home/cltbld', 20:06:06 INFO - 'LANG': 'en_US.UTF-8', 20:06:06 INFO - 'LANGUAGE': 'en_US:en', 20:06:06 INFO - 'LOGNAME': 'cltbld', 20:06:06 INFO - 'MAIL': '/var/mail/cltbld', 20:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:06 INFO - 'MOZ_NO_REMOTE': '1', 20:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:06 INFO - 'NO_EM_RESTART': '1', 20:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:06 INFO - 'PWD': '/builds/slave/test', 20:06:06 INFO - 'SHELL': '/bin/bash', 20:06:06 INFO - 'SHLVL': '1', 20:06:06 INFO - 'TERM': 'linux', 20:06:06 INFO - 'TMOUT': '86400', 20:06:06 INFO - 'USER': 'cltbld', 20:06:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:06 INFO - '_': '/tools/buildbot/bin/python'} 20:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:06 INFO - Running setup.py (path:/tmp/pip-BcPGwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:06 INFO - Running setup.py (path:/tmp/pip-XAQL1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:06 INFO - Running setup.py (path:/tmp/pip-TasRGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:07 INFO - Running setup.py (path:/tmp/pip-vTjXWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:07 INFO - Running setup.py (path:/tmp/pip-VCqgml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:07 INFO - Running setup.py (path:/tmp/pip-xRnlZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:07 INFO - Running setup.py (path:/tmp/pip-3F4KNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:07 INFO - Running setup.py (path:/tmp/pip-Pxr6Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:07 INFO - Running setup.py (path:/tmp/pip-ROrJs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:07 INFO - Running setup.py (path:/tmp/pip-8cgSVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:07 INFO - Running setup.py (path:/tmp/pip-7NzG3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:07 INFO - Running setup.py (path:/tmp/pip-f42C5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:07 INFO - Running setup.py (path:/tmp/pip-0BDOF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:07 INFO - Running setup.py (path:/tmp/pip-SSYcPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:07 INFO - Running setup.py (path:/tmp/pip-Hi_OCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:07 INFO - Running setup.py (path:/tmp/pip-D_YFqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:07 INFO - Running setup.py (path:/tmp/pip-1BnJ6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:09 INFO - Downloading blessings-1.6.tar.gz 20:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:10 INFO - Installing collected packages: blessings 20:06:10 INFO - Running setup.py install for blessings 20:06:10 INFO - Successfully installed blessings 20:06:10 INFO - Cleaning up... 20:06:10 INFO - Return code: 0 20:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:10 INFO - Reading from file tmpfile_stdout 20:06:10 INFO - Current package versions: 20:06:10 INFO - argparse == 1.2.1 20:06:10 INFO - blessings == 1.6 20:06:10 INFO - blobuploader == 1.2.4 20:06:10 INFO - docopt == 0.6.1 20:06:10 INFO - manifestparser == 1.1 20:06:10 INFO - mozInstall == 1.12 20:06:10 INFO - mozcrash == 0.17 20:06:10 INFO - mozdebug == 0.1 20:06:10 INFO - mozdevice == 0.48 20:06:10 INFO - mozfile == 1.2 20:06:10 INFO - mozhttpd == 0.7 20:06:10 INFO - mozinfo == 0.9 20:06:10 INFO - mozleak == 0.1 20:06:10 INFO - mozlog == 3.1 20:06:10 INFO - moznetwork == 0.27 20:06:10 INFO - mozprocess == 0.22 20:06:10 INFO - mozprofile == 0.28 20:06:10 INFO - mozrunner == 6.11 20:06:10 INFO - mozscreenshot == 0.1 20:06:10 INFO - mozsystemmonitor == 0.0 20:06:10 INFO - moztest == 0.7 20:06:10 INFO - mozversion == 1.4 20:06:10 INFO - psutil == 3.1.1 20:06:10 INFO - requests == 1.2.3 20:06:10 INFO - wsgiref == 0.1.2 20:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:10 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')]} 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 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')]} 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:06:10 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 20:06:10 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 20:06:10 INFO - Using env: {'DISPLAY': ':0', 20:06:10 INFO - 'HOME': '/home/cltbld', 20:06:10 INFO - 'LANG': 'en_US.UTF-8', 20:06:10 INFO - 'LANGUAGE': 'en_US:en', 20:06:10 INFO - 'LOGNAME': 'cltbld', 20:06:10 INFO - 'MAIL': '/var/mail/cltbld', 20:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:10 INFO - 'MOZ_NO_REMOTE': '1', 20:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:10 INFO - 'NO_EM_RESTART': '1', 20:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:10 INFO - 'PWD': '/builds/slave/test', 20:06:10 INFO - 'SHELL': '/bin/bash', 20:06:10 INFO - 'SHLVL': '1', 20:06:10 INFO - 'TERM': 'linux', 20:06:10 INFO - 'TMOUT': '86400', 20:06:10 INFO - 'USER': 'cltbld', 20:06:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:10 INFO - '_': '/tools/buildbot/bin/python'} 20:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 INFO - Cleaning up... 20:06:10 INFO - Return code: 0 20:06:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:10 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')]} 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 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')]} 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:06:10 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 20:06:10 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 20:06:10 INFO - Using env: {'DISPLAY': ':0', 20:06:10 INFO - 'HOME': '/home/cltbld', 20:06:10 INFO - 'LANG': 'en_US.UTF-8', 20:06:10 INFO - 'LANGUAGE': 'en_US:en', 20:06:10 INFO - 'LOGNAME': 'cltbld', 20:06:10 INFO - 'MAIL': '/var/mail/cltbld', 20:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:10 INFO - 'MOZ_NO_REMOTE': '1', 20:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:10 INFO - 'NO_EM_RESTART': '1', 20:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:10 INFO - 'PWD': '/builds/slave/test', 20:06:10 INFO - 'SHELL': '/bin/bash', 20:06:10 INFO - 'SHLVL': '1', 20:06:10 INFO - 'TERM': 'linux', 20:06:10 INFO - 'TMOUT': '86400', 20:06:10 INFO - 'USER': 'cltbld', 20:06:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:10 INFO - '_': '/tools/buildbot/bin/python'} 20:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:10 INFO - Downloading/unpacking jsonschema 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:12 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:13 INFO - warning: no files found matching '*.txt' 20:06:13 INFO - no previously-included directories found matching 'build' 20:06:13 INFO - no previously-included directories found matching 'dist' 20:06:13 INFO - no previously-included directories found matching '.git*' 20:06:13 INFO - Installing collected packages: jsonschema, functools32 20:06:13 INFO - Running setup.py install for functools32 20:06:13 INFO - warning: no files found matching '*.txt' 20:06:13 INFO - no previously-included directories found matching 'build' 20:06:13 INFO - no previously-included directories found matching 'dist' 20:06:13 INFO - no previously-included directories found matching '.git*' 20:06:13 INFO - Successfully installed jsonschema functools32 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06:13 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')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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 0x7fcc20a80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23749a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', '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 20:06:13 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 20:06:13 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 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 INFO - Downloading/unpacking flake8 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:16 INFO - no previously-included directories found matching 'docs/_build' 20:06:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:16 INFO - Running setup.py install for pep8 20:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:16 INFO - no previously-included directories found matching 'docs/_build' 20:06:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:16 INFO - Cleaning up... 20:06:16 INFO - Return code: 0 20:06:16 INFO - Running post-action listener: _resource_record_post_action 20:06:16 INFO - Running post-action listener: _start_resource_monitoring 20:06:16 INFO - Starting resource monitoring. 20:06:16 INFO - ##### 20:06:16 INFO - ##### Running install step. 20:06:16 INFO - ##### 20:06:16 INFO - Running pre-action listener: _resource_record_pre_action 20:06:16 INFO - Running main action method: install 20:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:16 INFO - Reading from file tmpfile_stdout 20:06:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:16 INFO - Reading from file tmpfile_stdout 20:06:16 INFO - Output received: 20:06:16 INFO - Usage: mozinstall [options] installer 20:06:16 INFO - Options: 20:06:16 INFO - -h, --help show this help message and exit 20:06:16 INFO - -d DEST, --destination=DEST 20:06:16 INFO - Directory to install application into. [default: 20:06:16 INFO - "/builds/slave/test"] 20:06:16 INFO - --app=APP Application being installed. [default: firefox] 20:06:16 INFO - mkdir: /builds/slave/test/build/application 20:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:06:33 INFO - Reading from file tmpfile_stdout 20:06:33 INFO - Output received: 20:06:33 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:33 INFO - Running post-action listener: _resource_record_post_action 20:06:33 INFO - ##### 20:06:33 INFO - ##### Running run-tests step. 20:06:33 INFO - ##### 20:06:33 INFO - Running pre-action listener: _resource_record_pre_action 20:06:33 INFO - Running main action method: run_tests 20:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:33 INFO - Python 2.7.3 20:06:33 INFO - Return code: 0 20:06:33 INFO - grabbing minidump binary from tooltool 20:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:33 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 0x2403810>, '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 0x2404710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:33 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 20:06:33 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 20:06:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:33 INFO - Return code: 0 20:06:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:06:34 INFO - Return code: 0 20:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 20:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 20:06:34 INFO - Using env: {'DISPLAY': ':0', 20:06:34 INFO - 'HOME': '/home/cltbld', 20:06:34 INFO - 'LANG': 'en_US.UTF-8', 20:06:34 INFO - 'LANGUAGE': 'en_US:en', 20:06:34 INFO - 'LOGNAME': 'cltbld', 20:06:34 INFO - 'MAIL': '/var/mail/cltbld', 20:06:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:34 INFO - 'MOZ_NO_REMOTE': '1', 20:06:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:34 INFO - 'NO_EM_RESTART': '1', 20:06:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:34 INFO - 'PWD': '/builds/slave/test', 20:06:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:34 INFO - 'SHELL': '/bin/bash', 20:06:34 INFO - 'SHLVL': '1', 20:06:34 INFO - 'TERM': 'linux', 20:06:34 INFO - 'TMOUT': '86400', 20:06:34 INFO - 'USER': 'cltbld', 20:06:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749', 20:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:34 INFO - '_': '/tools/buildbot/bin/python'} 20:06:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 20:06:34 INFO - mozversion application_buildid: 20160421173029 20:06:34 INFO - mozversion application_changeset: 467bd00c72db8f6f34c4d9740378abb90365269f 20:06:34 INFO - mozversion application_display_name: Nightly 20:06:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:34 INFO - mozversion application_name: Firefox 20:06:34 INFO - mozversion application_remotingname: firefox 20:06:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:06:34 INFO - mozversion application_vendor: Mozilla 20:06:34 INFO - mozversion application_version: 48.0a1 20:06:34 INFO - mozversion platform_buildid: 20160421173029 20:06:34 INFO - mozversion platform_changeset: 467bd00c72db8f6f34c4d9740378abb90365269f 20:06:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:06:34 INFO - mozversion platform_version: 48.0a1 20:06:34 INFO - using testdate: 1461294394 20:06:34 INFO - actual date: 1461294394 20:06:34 INFO - starting webserver on 'localhost:43305' 20:06:34 INFO - SUITE-START | Running 2 tests 20:06:34 INFO - TEST-START | dromaeo_css 20:06:34 INFO - operating with platform_type : linux_ 20:06:34 INFO - Initialising browser for dromaeo_css test... 20:06:34 INFO - TEST-INFO | started process 16908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnRhRDE/profile http://localhost:43305/getInfo.html) 20:06:38 INFO - PROCESS | 16908 | __metrics Screen width/height:1600/1200 20:06:38 INFO - PROCESS | 16908 | colorDepth:24 20:06:38 INFO - PROCESS | 16908 | Browser inner width/height: 1024/697 20:06:38 INFO - PROCESS | 16908 | __metrics 20:06:39 ERROR - PROCESS | 16908 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:06:39 INFO - TEST-INFO | 16908: exit 0 20:06:39 INFO - Browser initialized. 20:06:39 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:39 INFO - TEST-INFO | started process 16993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnRhRDE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:51 INFO - PROCESS | 16993 | RSS: Main: 153280512 20:06:51 INFO - PROCESS | 16993 | 20:07:42 INFO - PROCESS | 16993 | 1461294462585 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] 20:09:49 INFO - PROCESS | 16993 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43305/tests/dromaeo/cssquery-ext.html) 20:09:50 INFO - PROCESS | 16993 | RSS: Main: 240852992 20:09:50 INFO - PROCESS | 16993 | 20:12:52 INFO - PROCESS | 16993 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-ext.html (next: http://localhost:43305/tests/dromaeo/cssquery-jquery.html) 20:12:53 INFO - PROCESS | 16993 | RSS: Main: 244654080 20:12:53 INFO - PROCESS | 16993 | 20:15:55 INFO - PROCESS | 16993 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43305/tests/dromaeo/cssquery-mootools.html) 20:15:56 INFO - PROCESS | 16993 | RSS: Main: 236826624 20:15:56 INFO - PROCESS | 16993 | 20:18:58 INFO - PROCESS | 16993 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43305/tests/dromaeo/cssquery-prototype.html) 20:18:58 INFO - PROCESS | 16993 | RSS: Main: 234594304 20:18:58 INFO - PROCESS | 16993 | 20:22:01 INFO - PROCESS | 16993 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43305/tests/dromaeo/cssquery-yui.html) 20:22:01 INFO - PROCESS | 16993 | RSS: Main: 226979840 20:22:01 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-yui.html (next: http://localhost:43305/tests/dromaeo/cssquery-dojo.html) 20:25:04 INFO - PROCESS | 16993 | RSS: Main: 277213184 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | __start_tp_report 20:25:04 INFO - PROCESS | 16993 | _x_x_mozilla_page_load 20:25:04 INFO - PROCESS | 16993 | _x_x_mozilla_page_load_details 20:25:04 INFO - PROCESS | 16993 | |i|pagename|runs| 20:25:04 INFO - PROCESS | 16993 | |0;dojo.html;3076.4616192166372;3124.843757812109;3157.873685052598;3159.4786860168074;3191.776575639705;5279.5512381447525;5317.494837990384;5333.2000199970025;5380.865478363038;5408.999999999995;5311.044012077825;5328.92006619901;5336.359636843575;5421.918671219935;5448.291722076135;4763.618910487153;4818.229083346657;4897.118518666639;4939.28380384844;4971.776270067856;4896.338994235786;4904.092742842586;4920.8031678732805;4932.112219800434;4942.802287908479;4787.569118779309;4844.152273352167;4866.07544566533;4927.359443272388;4948.307236986825;4850.684705494167;4862.513748625144;4864.78108485119;4876;4916.926246106311;4820.108279968217;4855.902881942341;4869.220924652074;4869.318295438641;4896.608271338285;5144.897102057976;5219.086659834514;5290.206469029637;5314.681119132864;5315.495027972336;5645.887082258373;5683;5686.09022556389;5688.60179787415;5690.9146362804595;5619.381867994517;5700.686462244575;5720.742566584514;5725.770969161229;5726.513246374063;5306.257124002643;5340.49265319794;5344.786208551614;5379.784808607651;5390.6226564140525;5777.942220577825;5781.913271300934;5792;5799.507041901401;5815.854603634943;5487.396386397493;5571.220029195916;5589.189567512688;5593.468620481048;5604.915926261027;5696.544276457957;5697.259356283656;5700.087985922232;5703.572232082527;5749.741261643236;5627.662340259598;5660.518855897295;5667.744951477193;5668.489835914705;5674.035413979634;5554.861128471821;5643.040683083886;5659.745311460994;5676.602637815396;5682.516986056232;4223;4229.6827737919775;4236.9364459533135;4263.531011588722;4283.121959998193;3786.469894214812;3806.352920003606;3820.083180036771;3846.6345697158727;3857.498525191707;5280.81517146898;5321.654092484054;5347.25138480613;5370.301860758076;5442.91835622466;5736.741846616912;5757.337906140764;5761.827145185651;5773.624714393551;5801;5415.079436495726;5415.593830462731;5422.566194704415;5423.647462914898;5426.701531415731;4768.666193366431;4855;4896.4858689837765;4930.506949305112;4936.160852655057;5763.827085187451;5767.509761670305;5769.711514424262;5819.79630712923;5841;5672.858178545569;5680.318361796611;5680.460356266148;5682.090865461506;5682.176084467646;5722.971385143214;5790.131480277823;5846.619969702126;5883.794067207627;5913.970430147821;5588.580856435702;5625.437456254342;5648.71756412186;5649.2373529574625;5651.6043876928225;5673.659580425023;5702.116171993348;5734.283214598176;5737.024705800108;5746.798862039808;5368.704721240213;5479.876625291726;5531.640443371168;5562.666240025612;5589.608727389043;5480.287562616834;5519.779208831763;5531.0873705839695;5533.5849811263515;5535.612507124462;5342.091844386541;5447.210154527651;5447.618666693452;5454.754536045808;5503.257060296809;5539.750711218086;5594.384617692132;5595.244641973281;5627;5637.069883469182;5452.182172674131;5457;5460.563154947674;5478.424765399575;5490.0941344677685 20:25:04 INFO - PROCESS | 16993 | |1;ext.html;615.3231445410048;627.7489004398241;634.9871954232999;636.554411911662;653.9607623542585;36866.63133368665;38353.42469862951;38396;38491.23017539648;38496.61503384965;39439.40840887389;39989.80005099971;40321.19357612846;40336.19327613446;40403.797981010124;8467.110953349902;8680.045195028573;8682.652693892236;8689;8689.56552172392;8438.493690378566;8558;8563.785905352384;8654.697085602005;8657.26413254874;8769.95615021924;8845;8847.690330838423;8849.734507964771;8856.114388561125;8738.038815730297;8753.7811554711;8802.163794439582;8803.471791692518;8807;8733.868991965126;8852;8853.513056781874;8853.778655533599;8859.06979767128;39329.60670393288;39682.206355872724;39684.60315396838;39751.80124099361;39861;3512.947305790415;3662.633736626343;3870.53553573573;3995.6603688686496;4184.121334519755;31832.522512162337;31945;32086.518702219484;32218.677813221802;32234.83882580572;4155.97922010391;4256.569641185023;4261.403403523509;4307.440032795716;4333.984697115825;290750;290918;291030;291817;292799.53600232076;55483.445165548634;56866;56906.430935690114;56907;56987;53581.73209133929;57383;60497.39502604918;62763.68618156971;63052.36947630557;15656.060636361855;15802;15825.68348633044;15826.60433489172;15871.52385428439;12840.678983025498;12860.807087893689;12887.291198984145;12898.484060637657;12900.677483062811;15516.370781068052;16122.677546449006;16687.249073791707;17401.91299043497;17482.912585436992;5870.970645146747;6017.398260174035;6027.578069535178;6105.511559075263;6155.537784886082;1043.3322673488974;1052.752603138262;1103.6854496468468;1130.5873356224918;1193.3317342288346;29637.555436668466;29991;30161.698383016326;30597;31439.37121257562;1079.2607064161075;1133.1161693878787;1201.963941081769;1209.2079687804326;1223.5717498875501;16451.177441127897;17042.23309951055;17185.226664800113;17243.22405491756;17345.2194651241;480071;480299;484042;485762;486774;54659.180112298345;55206.72396637991;55257.44742552523;55284.72357638267;55310.72344638251;1327.5950834995226;1366.064245991499;1372.6980064385818;1385.411200239894;1397.4410235905718;30691.69308306978;31349.686503134675;32078.839605801822;32237.51643725393;32329.676703232668;49304.75347623239;49657.75855603639;49681.25478117759;49702.502974971234;49788;403695;413081;414079;414233;415544;35720.285594288485;36811.447828282064;39571.48865632477;41079;41505;45780;45786.54213457956;46017.30974035459;46166.30750538677;46440.767796160806;38290.42564361593;38410.231795363376;38932.41601375925;39015.80492097521;39178.60821391863;38632.227355452174;39645.60354396534;43435.78282108569;43928.12143757043;43966.340504893094;39868.800655996536;39961;41014.79492602518;42324.78837605792;42454.78772606117;30968.225794355323;32367.190820229684;33466.665333346355;34761.304773903874;35330.470042948866;26776.19671409861;26906.865465672545;26945.461090778466;26997;27036.1889143326 20:25:04 INFO - PROCESS | 16993 | |2;jquery.html;367.7278813677879;371.67292782351524;384.6038580262329;387.763464286785;391.2728283861486;14968.925155374222;16949.572789439495;17770.289188432478;18041.188146533405;18116.27534898604;17366.913165434187;17415.564610884736;17914.910425447888;18178.909105454488;18207;5481.862953426166;5621.718914054301;5651.491365777079;5677.48902598766;5679.971600141994;3718.851245950172;5107.438181799999;5307.73461326934;5564.582656300773;5582.441755824426;5530.889382212354;5531.723413829292;5545.3622833374275;5561.054620714488;5570.275864137677;5465.508104270615;5501.174823776446;5525.834224973257;5545.889082218333;5547.750351234205;5234.0840352938085;5372.2210279509645;5376.731163441851;5393.649412788195;5399.7030163341;12045.457954392074;12496.687582810411;12560.937195314056;12571.685707857285;12584.559540416041;2217.7449593296815;2300.5283916797184;2534.809889258295;2543.580309248972;2896.362800183956;8971.327150463741;9014.774630634221;9211.493367864765;9220.308476864262;9410.200132988704;1767.7171652535533;1819.5542092187366;1872.691005984011;1882.802305757903;1969.5765410436825;77630.6118469404;79641;81035.5948220261;81108.18891811065;81442.59278703628;10186.388816671024;10406.687799366031;10429.426381549089;10432.68701938928;10458.372497650165;14671.266436678123;14861.256937153099;14898;14903;14909.478168264059;7749.651265693057;7916.722914697958;8021.5187088774865;8058.516489010678;8063.153368896299;7761.805954851174;7846.686132554748;7920.643571039317;7962;8005.039395272604;4477.171723231213;4501.549845015537;4522.683412161183;4542.091581683677;4664.300354946718;1728.585139566495;1828.9908550457428;1851.5093500222451;1880.69908814589;1925.4801203674929;961.2838435365697;966.1787480641399;1033.751899544119;1042.8279333909973;1105.15455676406;17499.737503937453;17821.10894455272;18090.18594163266;18124.365647202285;18426.262949481872;973.3235401395962;983.7884854756119;995.9601615935281;1021.116734025063;1072.2869291920786;9773.07155820196;9853.753656158653;10117.595296188218;10125.240606954509;10144.746381340377;486412;492809;500851;505027;510432;86512.56743716367;89435.55282223548;89767.55116224378;89812.75468113349;89892.10107898837;1002.869626948492;1034.2191645307894;1041.4688508860536;1044.1177205261542;1058.3596923861107;16125.11311877858;16216.918915405819;16277.59306017359;16322.102284374474;16352.67294654124;30941;33339.49990750092;37539.24921501609;38054.80972595119;38208.42687359636;54205.72897135489;54531.45468545423;55089;58766.41233587609;59205.40794591999;8058.597070146587;8396.454230475;8434.915650843413;8490.23587877094;8611.82776344482;9422.62309507612;13362.599122026355;13376.331183440983;13454.26001569923;13554.457821687021;11445.885541144482;11576.189666723249;11795.587154449553;11814.409279535817;11921.761564768829;11254.38100904458;11371;11710.063194944554;11883.346415947206;11927.284362938251;9212.30907681913;10751.892481075402;11456.599019034295;11577;12269.815952760895;8239.917600823916;8274.379421543288;8301.584920753818;8467.407281490237;8865.911340886767;11745.941270293593;11758.941205293919;12067.155299129328;12366.072544559014;12380.62858114258 20:25:04 INFO - PROCESS | 16993 | |3;mootools.html;1215.36800863551;1413.0744362442601;1451.5572750311155;1564.178806126784;1747.14342050747;7821.608919554021;8038.9196108038905;8071.91928080719;8079.3940454466;8079.636416361263;7861.135275119746;7943.285104340608;7996.400269979746;8000.91999080009;8009.118996910335;1996.161612122912;2233.519793244452;2272.1933713531666;2293.896774645145;2307.284741730069;2260.0394832196334;2269.035659844568;2276.5333106713083;2284.166279308049;2292.5529521743265;2175.2386664667397;2230.944226394337;2231.509068005036;2233.776622337761;2250.696156018941;1939.932102376417;2228.9888550557307;2285.931422057341;2290.3701482092392;2292.1289909834154;2149.376680762577;2153.8923053847243;2154.504463973279;2154.741431028271;2225.8553194042333;7941.047074351057;7953.363730901514;8017.318527925133;8017.518948863087;8028.598570071473;4901.387326584177;5046.167382381903;5051.090803655341;5069.112905241568;5188.870278243036;3147.134538002045;3147.464930961719;3174.206448387903;3200.855961481739;3214.5821043264227;1038.1279725030934;1050.1021626509378;1065.4140222877386;1070.3738313086853;1072.265498133781;11154.10767138627;11180.608678696206;11211.719707007309;11212.27120237182;11280.32318060919;4436.844710435119;4527.501974782771;4647.512011238839;4656.138614356355;4689.249720044776;9529.761755956019;9574.712758617114;9599.184069354043;9602.519874006271;9653.855192172123;4650.116477869194;5179.766910489037;5181.715005674724;5182.4299327073995;5189.221616757441;4589.33454649074;4691.319758634979;4697.342372067913;4701.2242979908615;4746.738929358849;3809.104860357814;3831.616838316146;3919.647231749156;3941.0935484838647;3969.821358038895;1240.0761432732672;1241.962741117768;1244.3964677131585;1244.7448273103992;1251.7934540800848;950.8383574792302;976.092234222166;1003.4932359158578;1009.7273736091214;1016.6746641074933;5865.296164460292;5876.236089308362;5910.290765108214;5910.586258961831;5963.701814909237;425.1497005988024;426.92742233820326;434.3961892968776;435.1232266982034;443.78476438927095;3912.7065470089856;3981.1639555693628;3990.7206495545033;4002.5797291284;4061.939070913939;9712.417254964725;10058.54736536843;10190.082892539707;10264.178865690876;10292.845607315896;9699.757506062404;10118.645847395306;10135.797284054424;10227.9488602558;10252.692419227435;7463.850722985619;7540.396768258526;7661.850722391686;7698.961505192438;7722.652480638385;5636.126400407943;5830;5838.5621078418435;5916.881662366814;5987.64074155552;9216.539173041456;9267.814643707223;9335.719928402159;9401.764955876159;9418.670346537838;9268;9504.904950950402;9615.5672994714;9647.1317581418;9654.855177172207;6663.433608143168;6994.160700715946;7144.714211431485;7286.526375785557;7407.555546667218;7624.656890439833;7682.8079298018;7761.223877612194;7765.767026988973;7774.572398518136;6690.732370705117;6798.048273241849;6838.897416538656;6898.896516552356;6962.164540255202;6915.550489218184;6916.619585922823;6961.37347638715;6976.407005404598;7038.648067596702;6471.579347342407;6503.414692677682;6542.051402546699;6648.16897887764;6666.466682665472;4958.305837182726;4979;5059.898802024012;5064.6961182327705;5083.034223497523;4759.714417134983;4771.5228477152;4775.6179505638775;4782.187028205144;4831.9275210872565 20:25:04 INFO - PROCESS | 16993 | |4;prototype.html;308.3693846084756;310.7451889450651;315.1899617981786;321.31239148222795;324.86031006667156;5511.917321240175;5638.915416268759;5703.543716502681;5705.115707065406;5770.730439303357;5660.179274005267;5701.429857014306;5710.543156547476;5717.3710891801975;5731.656100633965;4389.561043895616;4396.36252743352;4411.1177764447075;4416.624586910117;4422.425084738996;4209.095044565418;4382.320740285261;4384.364267181273;4433.778311084433;4435.667324950641;4300.1829652366105;4307.849225277116;4314.072474418;4332.06860524987;4346.261135606938;4276.144771045788;4281.892952676177;4309.913801723964;4315.848945286932;4319.265724826787;3674;3754.81225938702;3756.6806821420214;3770.3213421584105;3772.2832661794173;5429.294191755086;5444.673319600797;5481.75332110056;5494.450554944514;5496.780128794843;4820.686655367425;4919.434265059493;4934.679245849008;4937.654364194508;4940.357753492059;5770.682612456313;5861.794837180721;5880.764769409218;5892.381299963527;5931.940680593225;4107.938380924288;4131.97934010331;4134.028503301722;4138.255114079465;4141.875743727693;6119.479844213247;6145.139680444741;6146.924288249583;6182.907256391158;6210.937890621081;4127.332601536748;4143.047099167208;4212.810423530887;4239.448871646666;4251.702380833312;4267.146570685875;4275.444192254987;4287.356896465492;4287.506936702257;4291.334843099262;4953.2570114483115;4962.528559786814;4977.9751101244265;4981.476944920803;4981.601471882241;5725.484706376446;5965.194698715618;5989.191459153046;6054.51563874889;6057.121717350959;1457.4024649893493;1465.3625672832352;1470.522080323899;1480.2006916265311;1481.5629389330174;943.2925306020485;976.3702411944398;983.1299300119446;988.0366642523626;990.2424645146468;5731.111677689964;5733.627314224562;5749.425057494301;5752.626079304831;5754.798582049608;6058.697065146725;6061.4544690977145;6069.176418856093;6110.602810817282;6122.7244773984385;5556.944430555724;5751.568632352591;5761.818827140426;5763.135529670499;5775.335836378787;3246.8214248216573;3268.820214888204;3277.5903012123485;3278.327942771774;3286.4741641337273;6114.296855861544;6323.9051414228825;6326.2092238470195;6326.272478665012;6338.651374174372;6166.352532984062;6226.906596401058;6242.812715618538;6264.80731743886;6288.591241569375;6342.446100705264;6356.14192084072;6357.11000459936;6360.236771587347;6373.107764912916;5925.911111333419;6137.140800287874;6140.3245642978345;6161.9691901542;6195.907061394173;6051.606645568024;6091.878162436815;6133.785317514044;6136.140940268277;6155;6042.8791424170395;6233.532485063548;6275.152854364603;6360.4911607072245;6367.363263673781;4212.347086201644;4243.405923170697;4246.957530424656;4257.254980378483;4257.74453532789;6186.81439556814;6189.164462797465;6208.441240288395;6211.223597050369;6225.750969961151;5828.737706803119;6019.036954087325;6019.277686677627;6035.849103772265;6059.697015149313;5973.522118230618;5977.462028417463;5985.521158307238;5994.490468310242;6012.518998480198;5710.5717071219;5870.737791374875;5910.586258961831;5925.881482370414;5941.940580594139;6032.577719559588;6039.396060393926;6061.848453788691;6072.757089716361;6078.57449978515;5880.529557635294;5891.617044892068;5898.174255604305;5902.468777810018;5920.674362910081 20:25:04 INFO - PROCESS | 16993 | |5;yui.html;782.7064850680994;791.6239786101603;792.0693185507027;801.1027649033084;803.0884945586757;13158.671033224175;13426.932865335672;13452.05835591509;13454.394552245149;14147.080439771433;14165.504207352744;14380.712385752278;14395.352209150587;14396.49612263571;14406.063605865611;676.1851968378093;777.6733771815823;802.7551596762985;804.2158895077312;805.8871757953891;801.3869389916719;801.6232370785722;804.3163311185504;804.5293503300576;804.694216197844;850.6597361055566;853.1638993786094;853.1681610429812;853.5348235211793;854.1159899504015;702.8067281497604;820.1675299570941;840.7813968368207;842.5955541340161;842.8061545844429;614.8001899382718;615.8706671598969;616.46675625584;616.7779599344233;617.0774691835734;13198.340082995908;13309;13309.933450332686;13374.063815532916;13392.464301427932;13108.672283192902;13563.186208827501;13625.931870340584;13665.521706740217;13670.726585468334;10954.123670106372;11055.72360690981;11177.72055698614;11302.943485282522;11609.941950290278;3761.6426439488205;3796.487474191004;3862.903427414309;3888.358420860555;3968.7817170055637;51909.480905190845;52410.475895241325;61079.69460152671;61430.38569614291;61835.690821545606;10224.13094886928;10241.84637230442;10324.122449591869;10503.317284376491;10522.579096836194;19044.333448329242;19119.80880191208;19142.71285930712;19210.80789192118;19565.315213967442;7791.142974272825;7798.5710785906185;7918.089419716691;8133.146019667968;8269;4691.741954192552;4732.787024583902;4783.330333753277;4844.4186697596515;4882.536159064884;3256.739460843127;3285.3922024425556;3314.784539004957;3320.9169770755443;3321.236115693404;532.2601583798523;588.8439563515672;598.7156100852147;600.687642425936;602.7347966894553;739.7447880481226;770.5607803552034;774.3031271855375;793.087948858817;807.0718673525492;9270.953645231732;9343;9581.137697607248;9698.36960597559;9750.756231094138;631.6936285901335;665.3612531969267;712.1454254894147;714.3749219432996;727.131078361353;4511.233090374644;4549.499555048942;4571.885702857388;4608.28571571407;4662.044280922402;64389.35610643927;65217;67057.66471167613;67333.32666673369;67868.6606566964;57330;57421.425785742445;57628;58053;59759.70120149459;48910.510894891304;49444.258336124985;52953.47046529486;53598.46401536013;53629.19556206738;8875.33434992391;8913.598888049924;8936;8963.148500892405;9002;34667.653323466446;35075.82462087673;35281.647183527835;35295.470567942015;35397;45926.54073459356;46926;46969.765151174026;47386.763066184445;47472.52527474681;11432.771344573228;11512.884871151182;11573.710657233636;11584.247023943417;11769.058475322125;12375.195612285173;12549;12574.622761317176;12577.496900123893;12773.425195866022;11904.107191960464;12101.455434505644;12179.634610961686;12382.318972456242;12413.689657758629;11679.708007299885;11682.299062056303;11688.824667630162;11769.823452648046;11941.64175074749;11576;11653.6503904883;11990.940045300067;12010.519579216734;12200.389980500762;10014.248931330034;10071.546780394754;10116.696499105039;10291.176705863663;10353.534090965773;10043.69868903934;10250.53872575721;10385.584576616851;10390.272680912565;10459.215558832966 20:25:04 INFO - PROCESS | 16993 | __end_tp_report 20:25:04 INFO - PROCESS | 16993 | __start_cc_report 20:25:04 INFO - PROCESS | 16993 | _x_x_mozilla_cycle_collect,793 20:25:04 INFO - PROCESS | 16993 | __end_cc_report 20:25:04 INFO - PROCESS | 16993 | __startTimestamp1461295504356__endTimestamp 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | ------- Summary: start ------- 20:25:04 INFO - PROCESS | 16993 | Number of tests: 6 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | [#0] dojo.html Cycles:165 Average:5281.82 Median:5460.56 stddev:592.31 (10.8%) stddev-sans-first:568.30 20:25:04 INFO - PROCESS | 16993 | Values: 3076.5 3124.8 3157.9 3159.5 3191.8 5279.6 5317.5 5333.2 5380.9 5409.0 5311.0 5328.9 5336.4 5421.9 5448.3 4763.6 4818.2 4897.1 4939.3 4971.8 4896.3 4904.1 4920.8 4932.1 4942.8 4787.6 4844.2 4866.1 4927.4 4948.3 4850.7 4862.5 4864.8 4876.0 4916.9 4820.1 4855.9 4869.2 4869.3 4896.6 5144.9 5219.1 5290.2 5314.7 5315.5 5645.9 5683.0 5686.1 5688.6 5690.9 5619.4 5700.7 5720.7 5725.8 5726.5 5306.3 5340.5 5344.8 5379.8 5390.6 5777.9 5781.9 5792.0 5799.5 5815.9 5487.4 5571.2 5589.2 5593.5 5604.9 5696.5 5697.3 5700.1 5703.6 5749.7 5627.7 5660.5 5667.7 5668.5 5674.0 5554.9 5643.0 5659.7 5676.6 5682.5 4223.0 4229.7 4236.9 4263.5 4283.1 3786.5 3806.4 3820.1 3846.6 3857.5 5280.8 5321.7 5347.3 5370.3 5442.9 5736.7 5757.3 5761.8 5773.6 5801.0 5415.1 5415.6 5422.6 5423.6 5426.7 4768.7 4855.0 4896.5 4930.5 4936.2 5763.8 5767.5 5769.7 5819.8 5841.0 5672.9 5680.3 5680.5 5682.1 5682.2 5723.0 5790.1 5846.6 5883.8 5914.0 5588.6 5625.4 5648.7 5649.2 5651.6 5673.7 5702.1 5734.3 5737.0 5746.8 5368.7 5479.9 5531.6 5562.7 5589.6 5480.3 5519.8 5531.1 5533.6 5535.6 5342.1 5447.2 5447.6 5454.8 5503.3 5539.8 5594.4 5595.2 5627.0 5637.1 5452.2 5457.0 5460.6 5478.4 5490.1 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | [#1] ext.html Cycles:180 Average:55873.14 Median:21978.33 stddev:106733.89 (485.6%) stddev-sans-first:106952.67 20:25:04 INFO - PROCESS | 16993 | Values: 615.3 627.7 635.0 636.6 654.0 36866.6 38353.4 38396.0 38491.2 38496.6 39439.4 39989.8 40321.2 40336.2 40403.8 8467.1 8680.0 8682.7 8689.0 8689.6 8438.5 8558.0 8563.8 8654.7 8657.3 8770.0 8845.0 8847.7 8849.7 8856.1 8738.0 8753.8 8802.2 8803.5 8807.0 8733.9 8852.0 8853.5 8853.8 8859.1 39329.6 39682.2 39684.6 39751.8 39861.0 3512.9 3662.6 3870.5 3995.7 4184.1 31832.5 31945.0 32086.5 32218.7 32234.8 4156.0 4256.6 4261.4 4307.4 4334.0 290750.0 290918.0 291030.0 291817.0 292799.5 55483.4 56866.0 56906.4 56907.0 56987.0 53581.7 57383.0 60497.4 62763.7 63052.4 15656.1 15802.0 15825.7 15826.6 15871.5 12840.7 12860.8 12887.3 12898.5 12900.7 15516.4 16122.7 16687.2 17401.9 17482.9 5871.0 6017.4 6027.6 6105.5 6155.5 1043.3 1052.8 1103.7 1130.6 1193.3 29637.6 29991.0 30161.7 30597.0 31439.4 1079.3 1133.1 1202.0 1209.2 1223.6 16451.2 17042.2 17185.2 17243.2 17345.2 480071.0 480299.0 484042.0 485762.0 486774.0 54659.2 55206.7 55257.4 55284.7 55310.7 1327.6 1366.1 1372.7 1385.4 1397.4 30691.7 31349.7 32078.8 32237.5 32329.7 49304.8 49657.8 49681.3 49702.5 49788.0 403695.0 413081.0 414079.0 414233.0 415544.0 35720.3 36811.4 39571.5 41079.0 41505.0 45780.0 45786.5 46017.3 46166.3 46440.8 38290.4 38410.2 38932.4 39015.8 39178.6 38632.2 39645.6 43435.8 43928.1 43966.3 39868.8 39961.0 41014.8 42324.8 42454.8 30968.2 32367.2 33466.7 34761.3 35330.5 26776.2 26906.9 26945.5 26997.0 27036.2 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | [#2] jquery.html Cycles:180 Average:28319.45 Median:20629.05 stddev:82244.92 (398.7%) stddev-sans-first:82448.86 20:25:04 INFO - PROCESS | 16993 | Values: 367.7 371.7 384.6 387.8 391.3 14968.9 16949.6 17770.3 18041.2 18116.3 17366.9 17415.6 17914.9 18178.9 18207.0 5481.9 5621.7 5651.5 5677.5 5680.0 3718.9 5107.4 5307.7 5564.6 5582.4 5530.9 5531.7 5545.4 5561.1 5570.3 5465.5 5501.2 5525.8 5545.9 5547.8 5234.1 5372.2 5376.7 5393.6 5399.7 12045.5 12496.7 12560.9 12571.7 12584.6 2217.7 2300.5 2534.8 2543.6 2896.4 8971.3 9014.8 9211.5 9220.3 9410.2 1767.7 1819.6 1872.7 1882.8 1969.6 77630.6 79641.0 81035.6 81108.2 81442.6 10186.4 10406.7 10429.4 10432.7 10458.4 14671.3 14861.3 14898.0 14903.0 14909.5 7749.7 7916.7 8021.5 8058.5 8063.2 7761.8 7846.7 7920.6 7962.0 8005.0 4477.2 4501.5 4522.7 4542.1 4664.3 1728.6 1829.0 1851.5 1880.7 1925.5 961.3 966.2 1033.8 1042.8 1105.2 17499.7 17821.1 18090.2 18124.4 18426.3 973.3 983.8 996.0 1021.1 1072.3 9773.1 9853.8 10117.6 10125.2 10144.7 486412.0 492809.0 500851.0 505027.0 510432.0 86512.6 89435.6 89767.6 89812.8 89892.1 1002.9 1034.2 1041.5 1044.1 1058.4 16125.1 16216.9 16277.6 16322.1 16352.7 30941.0 33339.5 37539.2 38054.8 38208.4 54205.7 54531.5 55089.0 58766.4 59205.4 8058.6 8396.5 8434.9 8490.2 8611.8 9422.6 13362.6 13376.3 13454.3 13554.5 11445.9 11576.2 11795.6 11814.4 11921.8 11254.4 11371.0 11710.1 11883.3 11927.3 9212.3 10751.9 11456.6 11577.0 12269.8 8239.9 8274.4 8301.6 8467.4 8865.9 11745.9 11758.9 12067.2 12366.1 12380.6 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | [#3] mootools.html Cycles:180 Average:5415.61 Median:4807.06 stddev:3014.22 (62.7%) stddev-sans-first:3006.15 20:25:04 INFO - PROCESS | 16993 | Values: 1215.4 1413.1 1451.6 1564.2 1747.1 7821.6 8038.9 8071.9 8079.4 8079.6 7861.1 7943.3 7996.4 8000.9 8009.1 1996.2 2233.5 2272.2 2293.9 2307.3 2260.0 2269.0 2276.5 2284.2 2292.6 2175.2 2230.9 2231.5 2233.8 2250.7 1939.9 2229.0 2285.9 2290.4 2292.1 2149.4 2153.9 2154.5 2154.7 2225.9 7941.0 7953.4 8017.3 8017.5 8028.6 4901.4 5046.2 5051.1 5069.1 5188.9 3147.1 3147.5 3174.2 3200.9 3214.6 1038.1 1050.1 1065.4 1070.4 1072.3 11154.1 11180.6 11211.7 11212.3 11280.3 4436.8 4527.5 4647.5 4656.1 4689.2 9529.8 9574.7 9599.2 9602.5 9653.9 4650.1 5179.8 5181.7 5182.4 5189.2 4589.3 4691.3 4697.3 4701.2 4746.7 3809.1 3831.6 3919.6 3941.1 3969.8 1240.1 1242.0 1244.4 1244.7 1251.8 950.8 976.1 1003.5 1009.7 1016.7 5865.3 5876.2 5910.3 5910.6 5963.7 425.1 426.9 434.4 435.1 443.8 3912.7 3981.2 3990.7 4002.6 4061.9 9712.4 10058.5 10190.1 10264.2 10292.8 9699.8 10118.6 10135.8 10227.9 10252.7 7463.9 7540.4 7661.9 7699.0 7722.7 5636.1 5830.0 5838.6 5916.9 5987.6 9216.5 9267.8 9335.7 9401.8 9418.7 9268.0 9504.9 9615.6 9647.1 9654.9 6663.4 6994.2 7144.7 7286.5 7407.6 7624.7 7682.8 7761.2 7765.8 7774.6 6690.7 6798.0 6838.9 6898.9 6962.2 6915.6 6916.6 6961.4 6976.4 7038.6 6471.6 6503.4 6542.1 6648.2 6666.5 4958.3 4979.0 5059.9 5064.7 5083.0 4759.7 4771.5 4775.6 4782.2 4831.9 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | [#4] prototype.html Cycles:180 Average:4990.67 Median:5752.10 stddev:1504.69 (26.2%) stddev-sans-first:1467.29 20:25:04 INFO - PROCESS | 16993 | Values: 308.4 310.7 315.2 321.3 324.9 5511.9 5638.9 5703.5 5705.1 5770.7 5660.2 5701.4 5710.5 5717.4 5731.7 4389.6 4396.4 4411.1 4416.6 4422.4 4209.1 4382.3 4384.4 4433.8 4435.7 4300.2 4307.8 4314.1 4332.1 4346.3 4276.1 4281.9 4309.9 4315.8 4319.3 3674.0 3754.8 3756.7 3770.3 3772.3 5429.3 5444.7 5481.8 5494.5 5496.8 4820.7 4919.4 4934.7 4937.7 4940.4 5770.7 5861.8 5880.8 5892.4 5931.9 4107.9 4132.0 4134.0 4138.3 4141.9 6119.5 6145.1 6146.9 6182.9 6210.9 4127.3 4143.0 4212.8 4239.4 4251.7 4267.1 4275.4 4287.4 4287.5 4291.3 4953.3 4962.5 4978.0 4981.5 4981.6 5725.5 5965.2 5989.2 6054.5 6057.1 1457.4 1465.4 1470.5 1480.2 1481.6 943.3 976.4 983.1 988.0 990.2 5731.1 5733.6 5749.4 5752.6 5754.8 6058.7 6061.5 6069.2 6110.6 6122.7 5556.9 5751.6 5761.8 5763.1 5775.3 3246.8 3268.8 3277.6 3278.3 3286.5 6114.3 6323.9 6326.2 6326.3 6338.7 6166.4 6226.9 6242.8 6264.8 6288.6 6342.4 6356.1 6357.1 6360.2 6373.1 5925.9 6137.1 6140.3 6162.0 6195.9 6051.6 6091.9 6133.8 6136.1 6155.0 6042.9 6233.5 6275.2 6360.5 6367.4 4212.3 4243.4 4247.0 4257.3 4257.7 6186.8 6189.2 6208.4 6211.2 6225.8 5828.7 6019.0 6019.3 6035.8 6059.7 5973.5 5977.5 5985.5 5994.5 6012.5 5710.6 5870.7 5910.6 5925.9 5941.9 6032.6 6039.4 6061.8 6072.8 6078.6 5880.5 5891.6 5898.2 5902.5 5920.7 20:25:04 INFO - PROCESS | 16993 | 20:25:04 INFO - PROCESS | 16993 | [#5] yui.html Cycles:180 Average:15043.89 Median:4676.89 stddev:18070.69 (386.4%) stddev-sans-first:18089.65 20:25:04 INFO - PROCESS | 16993 | Values: 782.7 791.6 792.1 801.1 803.1 13158.7 13426.9 13452.1 13454.4 14147.1 14165.5 14380.7 14395.4 14396.5 14406.1 676.2 777.7 802.8 804.2 805.9 801.4 801.6 804.3 804.5 804.7 850.7 853.2 853.2 853.5 854.1 702.8 820.2 840.8 842.6 842.8 614.8 615.9 616.5 616.8 617.1 13198.3 13309.0 13309.9 13374.1 13392.5 13108.7 13563.2 13625.9 13665.5 13670.7 10954.1 11055.7 11177.7 11302.9 11609.9 3761.6 3796.5 3862.9 3888.4 3968.8 51909.5 52410.5 61079.7 61430.4 61835.7 10224.1 10241.8 10324.1 10503.3 10522.6 19044.3 19119.8 19142.7 19210.8 19565.3 7791.1 7798.6 7918.1 8133.1 8269.0 4691.7 4732.8 4783.3 4844.4 4882.5 3256.7 3285.4 3314.8 3320.9 3321.2 532.3 588.8 598.7 600.7 602.7 739.7 770.6 774.3 793.1 807.1 9271.0 9343.0 9581.1 9698.4 9750.8 631.7 665.4 712.1 714.4 727.1 4511.2 4549.5 4571.9 4608.3 4662.0 64389.4 65217.0 67057.7 67333.3 67868.7 57330.0 57421.4 57628.0 58053.0 59759.7 48910.5 49444.3 52953.5 53598.5 53629.2 8875.3 8913.6 8936.0 8963.1 9002.0 34667.7 35075.8 35281.6 35295.5 35397.0 45926.5 46926.0 46969.8 47386.8 47472.5 11432.8 11512.9 11573.7 11584.2 11769.1 12375.2 12549.0 12574.6 12577.5 12773.4 11904.1 12101.5 12179.6 12382.3 12413.7 11679.7 11682.3 11688.8 11769.8 11941.6 11576.0 11653.7 11990.9 12010.5 12200.4 10014.2 10071.5 10116.7 10291.2 10353.5 10043.7 10250.5 10385.6 10390.3 10459.2 20:25:04 INFO - PROCESS | 16993 | -------- Summary: end -------- 20:25:04 INFO - PROCESS | 16993 | 20:25:05 INFO - TEST-INFO | 16993: exit 0 20:25:05 INFO - TEST-OK | dromaeo_css | took 1110404ms 20:25:05 INFO - TEST-START | kraken 20:25:05 INFO - operating with platform_type : linux_ 20:25:05 INFO - Initialising browser for kraken test... 20:25:05 INFO - TEST-INFO | started process 17174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqUfkpA/profile http://localhost:43305/getInfo.html) 20:25:08 INFO - PROCESS | 17174 | __metrics Screen width/height:1600/1200 20:25:08 INFO - PROCESS | 17174 | colorDepth:24 20:25:08 INFO - PROCESS | 17174 | Browser inner width/height: 1024/697 20:25:08 INFO - PROCESS | 17174 | __metrics 20:25:09 ERROR - PROCESS | 17174 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:25:10 INFO - TEST-INFO | 17174: exit 0 20:25:10 INFO - Browser initialized. 20:25:10 INFO - Running cycle 1/1 for kraken test... 20:25:10 INFO - TEST-INFO | started process 17257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqUfkpA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:21 INFO - PROCESS | 17257 | RSS: Main: 153776128 20:25:21 INFO - PROCESS | 17257 | 20:25:24 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:25 INFO - PROCESS | 17257 | RSS: Main: 208818176 20:25:25 INFO - PROCESS | 17257 | 20:25:28 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-dft) 20:25:28 INFO - PROCESS | 17257 | RSS: Main: 193892352 20:25:28 INFO - PROCESS | 17257 | 20:25:31 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-fft) 20:25:32 INFO - PROCESS | 17257 | RSS: Main: 264536064 20:25:32 INFO - PROCESS | 17257 | 20:25:34 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-oscillator) 20:25:34 INFO - PROCESS | 17257 | RSS: Main: 173309952 20:25:34 INFO - PROCESS | 17257 | 20:25:37 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:37 INFO - PROCESS | 17257 | RSS: Main: 177610752 20:25:37 INFO - PROCESS | 17257 | 20:25:40 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43305/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:41 INFO - PROCESS | 17257 | RSS: Main: 213463040 20:25:41 INFO - PROCESS | 17257 | 20:25:44 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43305/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:45 INFO - PROCESS | 17257 | RSS: Main: 214384640 20:25:45 INFO - PROCESS | 17257 | 20:25:48 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43305/tests/kraken/driver.html?testName=json-parse-financial) 20:25:48 INFO - PROCESS | 17257 | RSS: Main: 214016000 20:25:48 INFO - PROCESS | 17257 | 20:25:50 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:50 INFO - PROCESS | 17257 | RSS: Main: 200699904 20:25:50 INFO - PROCESS | 17257 | 20:25:52 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:53 INFO - PROCESS | 17257 | RSS: Main: 202915840 20:25:53 INFO - PROCESS | 17257 | 20:25:55 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:55 INFO - PROCESS | 17257 | RSS: Main: 216346624 20:25:55 INFO - PROCESS | 17257 | 20:25:58 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:58 INFO - PROCESS | 17257 | RSS: Main: 224395264 20:25:58 INFO - PROCESS | 17257 | 20:26:01 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:02 INFO - PROCESS | 17257 | RSS: Main: 219308032 20:26:02 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43305/tests/kraken/driver.html?testName=ai-astar) 20:26:04 INFO - PROCESS | 17257 | RSS: Main: 283484160 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | __start_tp_report 20:26:04 INFO - PROCESS | 17257 | _x_x_mozilla_page_load 20:26:04 INFO - PROCESS | 17257 | _x_x_mozilla_page_load_details 20:26:04 INFO - PROCESS | 17257 | |i|pagename|runs| 20:26:04 INFO - PROCESS | 17257 | |0;ai-astar;110;109;105;111;112;112;99;110;111;109 20:26:04 INFO - PROCESS | 17257 | |1;audio-beat-detection;152;129;157;189;129;155;158;139;193;130 20:26:04 INFO - PROCESS | 17257 | |2;audio-dft;161;161;160;160;161;161;162;162;161;160 20:26:04 INFO - PROCESS | 17257 | |3;audio-fft;77;73;118;120;74;74;73;111;101;85 20:26:04 INFO - PROCESS | 17257 | |4;audio-oscillator;93;94;147;92;93;92;149;93;93;151 20:26:04 INFO - PROCESS | 17257 | |5;imaging-gaussian-blur;117;116;117;118;118;116;116;117;118;117 20:26:04 INFO - PROCESS | 17257 | |6;imaging-darkroom;147;146;147;145;146;146;146;149;145;145 20:26:04 INFO - PROCESS | 17257 | |7;imaging-desaturate;94;95;94;95;94;94;95;95;95;95 20:26:04 INFO - PROCESS | 17257 | |8;json-parse-financial;58;59;58;58;57;59;61;83;55;57 20:26:04 INFO - PROCESS | 17257 | |9;json-stringify-tinderbox;62;60;61;60;61;62;61;61;61;62 20:26:04 INFO - PROCESS | 17257 | |10;stanford-crypto-aes;77;78;76;77;77;78;79;78;85;79 20:26:04 INFO - PROCESS | 17257 | |11;stanford-crypto-ccm;126;126;128;126;125;126;123;125;165;141 20:26:04 INFO - PROCESS | 17257 | |12;stanford-crypto-pbkdf2;175;169;174;174;170;171;174;179;172;173 20:26:04 INFO - PROCESS | 17257 | |13;stanford-crypto-sha256-iterative;69;69;70;70;67;70;72;68;68;66 20:26:04 INFO - PROCESS | 17257 | __end_tp_report 20:26:04 INFO - PROCESS | 17257 | __start_cc_report 20:26:04 INFO - PROCESS | 17257 | _x_x_mozilla_cycle_collect,1628 20:26:04 INFO - PROCESS | 17257 | __end_cc_report 20:26:04 INFO - PROCESS | 17257 | __startTimestamp1461295564396__endTimestamp 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | ------- Summary: start ------- 20:26:04 INFO - PROCESS | 17257 | Number of tests: 14 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:3.99 (3.6%) stddev-sans-first:4.21 20:26:04 INFO - PROCESS | 17257 | Values: 110.0 109.0 105.0 111.0 112.0 112.0 99.0 110.0 111.0 109.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:156.00 stddev:23.14 (14.8%) stddev-sans-first:24.54 20:26:04 INFO - PROCESS | 17257 | Values: 152.0 129.0 157.0 189.0 129.0 155.0 158.0 139.0 193.0 130.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 20:26:04 INFO - PROCESS | 17257 | Values: 161.0 161.0 160.0 160.0 161.0 161.0 162.0 162.0 161.0 160.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#3] audio-fft Cycles:10 Average:90.60 Median:73.50 stddev:19.79 (26.9%) stddev-sans-first:20.37 20:26:04 INFO - PROCESS | 17257 | Values: 77.0 73.0 118.0 120.0 74.0 74.0 73.0 111.0 101.0 85.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.00 stddev:27.14 (29.2%) stddev-sans-first:28.11 20:26:04 INFO - PROCESS | 17257 | Values: 93.0 94.0 147.0 92.0 93.0 92.0 149.0 93.0 93.0 151.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 20:26:04 INFO - PROCESS | 17257 | Values: 117.0 116.0 117.0 118.0 118.0 116.0 116.0 117.0 118.0 117.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 20:26:04 INFO - PROCESS | 17257 | Values: 147.0 146.0 147.0 145.0 146.0 146.0 146.0 149.0 145.0 145.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:26:04 INFO - PROCESS | 17257 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:58.50 stddev:8.06 (13.8%) stddev-sans-first:8.50 20:26:04 INFO - PROCESS | 17257 | Values: 58.0 59.0 58.0 58.0 57.0 59.0 61.0 83.0 55.0 57.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 20:26:04 INFO - PROCESS | 17257 | Values: 62.0 60.0 61.0 60.0 61.0 62.0 61.0 61.0 61.0 62.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.50 (3.2%) stddev-sans-first:2.60 20:26:04 INFO - PROCESS | 17257 | Values: 77.0 78.0 76.0 77.0 77.0 78.0 79.0 78.0 85.0 79.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:126.00 stddev:12.91 (10.2%) stddev-sans-first:13.56 20:26:04 INFO - PROCESS | 17257 | Values: 126.0 126.0 128.0 126.0 125.0 126.0 123.0 125.0 165.0 141.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:174.00 stddev:2.85 (1.6%) stddev-sans-first:2.93 20:26:04 INFO - PROCESS | 17257 | Values: 175.0 169.0 174.0 174.0 170.0 171.0 174.0 179.0 172.0 173.0 20:26:04 INFO - PROCESS | 17257 | 20:26:04 INFO - PROCESS | 17257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.73 (2.5%) stddev-sans-first:1.83 20:26:04 INFO - PROCESS | 17257 | Values: 69.0 69.0 70.0 70.0 67.0 70.0 72.0 68.0 68.0 66.0 20:26:04 INFO - PROCESS | 17257 | -------- Summary: end -------- 20:26:04 INFO - PROCESS | 17257 | 20:26:05 INFO - TEST-INFO | 17257: exit 0 20:26:05 INFO - TEST-OK | kraken | took 60227ms 20:26:05 INFO - SUITE-END | took 1170s 20:26:05 INFO - Completed test suite (00:19:30) 20:26:05 INFO - javascript benchmark 20:26:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.4616192166372, 3124.843757812109, 3157.873685052598, 3159.4786860168074, 3191.776575639705, 5279.5512381447525, 5317.494837990384, 5333.2000199970025, 5380.865478363038, 5408.999999999995, 5311.044012077825, 5328.92006619901, 5336.359636843575, 5421.918671219935, 5448.291722076135, 4763.618910487153, 4818.229083346657, 4897.118518666639, 4939.28380384844, 4971.776270067856, 4896.338994235786, 4904.092742842586, 4920.8031678732805, 4932.112219800434, 4942.802287908479, 4787.569118779309, 4844.152273352167, 4866.07544566533, 4927.359443272388, 4948.307236986825, 4850.684705494167, 4862.513748625144, 4864.78108485119, 4876.0, 4916.926246106311, 4820.108279968217, 4855.902881942341, 4869.220924652074, 4869.318295438641, 4896.608271338285, 5144.897102057976, 5219.086659834514, 5290.206469029637, 5314.681119132864, 5315.495027972336, 5645.887082258373, 5683.0, 5686.09022556389, 5688.60179787415, 5690.9146362804595, 5619.381867994517, 5700.686462244575, 5720.742566584514, 5725.770969161229, 5726.513246374063, 5306.257124002643, 5340.49265319794, 5344.786208551614, 5379.784808607651, 5390.6226564140525, 5777.942220577825, 5781.913271300934, 5792.0, 5799.507041901401, 5815.854603634943, 5487.396386397493, 5571.220029195916, 5589.189567512688, 5593.468620481048, 5604.915926261027, 5696.544276457957, 5697.259356283656, 5700.087985922232, 5703.572232082527, 5749.741261643236, 5627.662340259598, 5660.518855897295, 5667.744951477193, 5668.489835914705, 5674.035413979634, 5554.861128471821, 5643.040683083886, 5659.745311460994, 5676.602637815396, 5682.516986056232, 4223.0, 4229.6827737919775, 4236.9364459533135, 4263.531011588722, 4283.121959998193, 3786.469894214812, 3806.352920003606, 3820.083180036771, 3846.6345697158727, 3857.498525191707, 5280.81517146898, 5321.654092484054, 5347.25138480613, 5370.301860758076, 5442.91835622466, 5736.741846616912, 5757.337906140764, 5761.827145185651, 5773.624714393551, 5801.0, 5415.079436495726, 5415.593830462731, 5422.566194704415, 5423.647462914898, 5426.701531415731, 4768.666193366431, 4855.0, 4896.4858689837765, 4930.506949305112, 4936.160852655057, 5763.827085187451, 5767.509761670305, 5769.711514424262, 5819.79630712923, 5841.0, 5672.858178545569, 5680.318361796611, 5680.460356266148, 5682.090865461506, 5682.176084467646, 5722.971385143214, 5790.131480277823, 5846.619969702126, 5883.794067207627, 5913.970430147821, 5588.580856435702, 5625.437456254342, 5648.71756412186, 5649.2373529574625, 5651.6043876928225, 5673.659580425023, 5702.116171993348, 5734.283214598176, 5737.024705800108, 5746.798862039808, 5368.704721240213, 5479.876625291726, 5531.640443371168, 5562.666240025612, 5589.608727389043, 5480.287562616834, 5519.779208831763, 5531.0873705839695, 5533.5849811263515, 5535.612507124462, 5342.091844386541, 5447.210154527651, 5447.618666693452, 5454.754536045808, 5503.257060296809, 5539.750711218086, 5594.384617692132, 5595.244641973281, 5627.0, 5637.069883469182, 5452.182172674131, 5457.0, 5460.563154947674, 5478.424765399575, 5490.0941344677685], "value": 5242.3159251375355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.3231445410048, 627.7489004398241, 634.9871954232999, 636.554411911662, 653.9607623542585, 36866.63133368665, 38353.42469862951, 38396.0, 38491.23017539648, 38496.61503384965, 39439.40840887389, 39989.80005099971, 40321.19357612846, 40336.19327613446, 40403.797981010124, 8467.110953349902, 8680.045195028573, 8682.652693892236, 8689.0, 8689.56552172392, 8438.493690378566, 8558.0, 8563.785905352384, 8654.697085602005, 8657.26413254874, 8769.95615021924, 8845.0, 8847.690330838423, 8849.734507964771, 8856.114388561125, 8738.038815730297, 8753.7811554711, 8802.163794439582, 8803.471791692518, 8807.0, 8733.868991965126, 8852.0, 8853.513056781874, 8853.778655533599, 8859.06979767128, 39329.60670393288, 39682.206355872724, 39684.60315396838, 39751.80124099361, 39861.0, 3512.947305790415, 3662.633736626343, 3870.53553573573, 3995.6603688686496, 4184.121334519755, 31832.522512162337, 31945.0, 32086.518702219484, 32218.677813221802, 32234.83882580572, 4155.97922010391, 4256.569641185023, 4261.403403523509, 4307.440032795716, 4333.984697115825, 290750.0, 290918.0, 291030.0, 291817.0, 292799.53600232076, 55483.445165548634, 56866.0, 56906.430935690114, 56907.0, 56987.0, 53581.73209133929, 57383.0, 60497.39502604918, 62763.68618156971, 63052.36947630557, 15656.060636361855, 15802.0, 15825.68348633044, 15826.60433489172, 15871.52385428439, 12840.678983025498, 12860.807087893689, 12887.291198984145, 12898.484060637657, 12900.677483062811, 15516.370781068052, 16122.677546449006, 16687.249073791707, 17401.91299043497, 17482.912585436992, 5870.970645146747, 6017.398260174035, 6027.578069535178, 6105.511559075263, 6155.537784886082, 1043.3322673488974, 1052.752603138262, 1103.6854496468468, 1130.5873356224918, 1193.3317342288346, 29637.555436668466, 29991.0, 30161.698383016326, 30597.0, 31439.37121257562, 1079.2607064161075, 1133.1161693878787, 1201.963941081769, 1209.2079687804326, 1223.5717498875501, 16451.177441127897, 17042.23309951055, 17185.226664800113, 17243.22405491756, 17345.2194651241, 480071.0, 480299.0, 484042.0, 485762.0, 486774.0, 54659.180112298345, 55206.72396637991, 55257.44742552523, 55284.72357638267, 55310.72344638251, 1327.5950834995226, 1366.064245991499, 1372.6980064385818, 1385.411200239894, 1397.4410235905718, 30691.69308306978, 31349.686503134675, 32078.839605801822, 32237.51643725393, 32329.676703232668, 49304.75347623239, 49657.75855603639, 49681.25478117759, 49702.502974971234, 49788.0, 403695.0, 413081.0, 414079.0, 414233.0, 415544.0, 35720.285594288485, 36811.447828282064, 39571.48865632477, 41079.0, 41505.0, 45780.0, 45786.54213457956, 46017.30974035459, 46166.30750538677, 46440.767796160806, 38290.42564361593, 38410.231795363376, 38932.41601375925, 39015.80492097521, 39178.60821391863, 38632.227355452174, 39645.60354396534, 43435.78282108569, 43928.12143757043, 43966.340504893094, 39868.800655996536, 39961.0, 41014.79492602518, 42324.78837605792, 42454.78772606117, 30968.225794355323, 32367.190820229684, 33466.665333346355, 34761.304773903874, 35330.470042948866, 26776.19671409861, 26906.865465672545, 26945.461090778466, 26997.0, 27036.1889143326], "value": 19632.38996482742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.7278813677879, 371.67292782351524, 384.6038580262329, 387.763464286785, 391.2728283861486, 14968.925155374222, 16949.572789439495, 17770.289188432478, 18041.188146533405, 18116.27534898604, 17366.913165434187, 17415.564610884736, 17914.910425447888, 18178.909105454488, 18207.0, 5481.862953426166, 5621.718914054301, 5651.491365777079, 5677.48902598766, 5679.971600141994, 3718.851245950172, 5107.438181799999, 5307.73461326934, 5564.582656300773, 5582.441755824426, 5530.889382212354, 5531.723413829292, 5545.3622833374275, 5561.054620714488, 5570.275864137677, 5465.508104270615, 5501.174823776446, 5525.834224973257, 5545.889082218333, 5547.750351234205, 5234.0840352938085, 5372.2210279509645, 5376.731163441851, 5393.649412788195, 5399.7030163341, 12045.457954392074, 12496.687582810411, 12560.937195314056, 12571.685707857285, 12584.559540416041, 2217.7449593296815, 2300.5283916797184, 2534.809889258295, 2543.580309248972, 2896.362800183956, 8971.327150463741, 9014.774630634221, 9211.493367864765, 9220.308476864262, 9410.200132988704, 1767.7171652535533, 1819.5542092187366, 1872.691005984011, 1882.802305757903, 1969.5765410436825, 77630.6118469404, 79641.0, 81035.5948220261, 81108.18891811065, 81442.59278703628, 10186.388816671024, 10406.687799366031, 10429.426381549089, 10432.68701938928, 10458.372497650165, 14671.266436678123, 14861.256937153099, 14898.0, 14903.0, 14909.478168264059, 7749.651265693057, 7916.722914697958, 8021.5187088774865, 8058.516489010678, 8063.153368896299, 7761.805954851174, 7846.686132554748, 7920.643571039317, 7962.0, 8005.039395272604, 4477.171723231213, 4501.549845015537, 4522.683412161183, 4542.091581683677, 4664.300354946718, 1728.585139566495, 1828.9908550457428, 1851.5093500222451, 1880.69908814589, 1925.4801203674929, 961.2838435365697, 966.1787480641399, 1033.751899544119, 1042.8279333909973, 1105.15455676406, 17499.737503937453, 17821.10894455272, 18090.18594163266, 18124.365647202285, 18426.262949481872, 973.3235401395962, 983.7884854756119, 995.9601615935281, 1021.116734025063, 1072.2869291920786, 9773.07155820196, 9853.753656158653, 10117.595296188218, 10125.240606954509, 10144.746381340377, 486412.0, 492809.0, 500851.0, 505027.0, 510432.0, 86512.56743716367, 89435.55282223548, 89767.55116224378, 89812.75468113349, 89892.10107898837, 1002.869626948492, 1034.2191645307894, 1041.4688508860536, 1044.1177205261542, 1058.3596923861107, 16125.11311877858, 16216.918915405819, 16277.59306017359, 16322.102284374474, 16352.67294654124, 30941.0, 33339.49990750092, 37539.24921501609, 38054.80972595119, 38208.42687359636, 54205.72897135489, 54531.45468545423, 55089.0, 58766.41233587609, 59205.40794591999, 8058.597070146587, 8396.454230475, 8434.915650843413, 8490.23587877094, 8611.82776344482, 9422.62309507612, 13362.599122026355, 13376.331183440983, 13454.26001569923, 13554.457821687021, 11445.885541144482, 11576.189666723249, 11795.587154449553, 11814.409279535817, 11921.761564768829, 11254.38100904458, 11371.0, 11710.063194944554, 11883.346415947206, 11927.284362938251, 9212.30907681913, 10751.892481075402, 11456.599019034295, 11577.0, 12269.815952760895, 8239.917600823916, 8274.379421543288, 8301.584920753818, 8467.407281490237, 8865.911340886767, 11745.941270293593, 11758.941205293919, 12067.155299129328, 12366.072544559014, 12380.62858114258], "value": 8760.99278302976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.36800863551, 1413.0744362442601, 1451.5572750311155, 1564.178806126784, 1747.14342050747, 7821.608919554021, 8038.9196108038905, 8071.91928080719, 8079.3940454466, 8079.636416361263, 7861.135275119746, 7943.285104340608, 7996.400269979746, 8000.91999080009, 8009.118996910335, 1996.161612122912, 2233.519793244452, 2272.1933713531666, 2293.896774645145, 2307.284741730069, 2260.0394832196334, 2269.035659844568, 2276.5333106713083, 2284.166279308049, 2292.5529521743265, 2175.2386664667397, 2230.944226394337, 2231.509068005036, 2233.776622337761, 2250.696156018941, 1939.932102376417, 2228.9888550557307, 2285.931422057341, 2290.3701482092392, 2292.1289909834154, 2149.376680762577, 2153.8923053847243, 2154.504463973279, 2154.741431028271, 2225.8553194042333, 7941.047074351057, 7953.363730901514, 8017.318527925133, 8017.518948863087, 8028.598570071473, 4901.387326584177, 5046.167382381903, 5051.090803655341, 5069.112905241568, 5188.870278243036, 3147.134538002045, 3147.464930961719, 3174.206448387903, 3200.855961481739, 3214.5821043264227, 1038.1279725030934, 1050.1021626509378, 1065.4140222877386, 1070.3738313086853, 1072.265498133781, 11154.10767138627, 11180.608678696206, 11211.719707007309, 11212.27120237182, 11280.32318060919, 4436.844710435119, 4527.501974782771, 4647.512011238839, 4656.138614356355, 4689.249720044776, 9529.761755956019, 9574.712758617114, 9599.184069354043, 9602.519874006271, 9653.855192172123, 4650.116477869194, 5179.766910489037, 5181.715005674724, 5182.4299327073995, 5189.221616757441, 4589.33454649074, 4691.319758634979, 4697.342372067913, 4701.2242979908615, 4746.738929358849, 3809.104860357814, 3831.616838316146, 3919.647231749156, 3941.0935484838647, 3969.821358038895, 1240.0761432732672, 1241.962741117768, 1244.3964677131585, 1244.7448273103992, 1251.7934540800848, 950.8383574792302, 976.092234222166, 1003.4932359158578, 1009.7273736091214, 1016.6746641074933, 5865.296164460292, 5876.236089308362, 5910.290765108214, 5910.586258961831, 5963.701814909237, 425.1497005988024, 426.92742233820326, 434.3961892968776, 435.1232266982034, 443.78476438927095, 3912.7065470089856, 3981.1639555693628, 3990.7206495545033, 4002.5797291284, 4061.939070913939, 9712.417254964725, 10058.54736536843, 10190.082892539707, 10264.178865690876, 10292.845607315896, 9699.757506062404, 10118.645847395306, 10135.797284054424, 10227.9488602558, 10252.692419227435, 7463.850722985619, 7540.396768258526, 7661.850722391686, 7698.961505192438, 7722.652480638385, 5636.126400407943, 5830.0, 5838.5621078418435, 5916.881662366814, 5987.64074155552, 9216.539173041456, 9267.814643707223, 9335.719928402159, 9401.764955876159, 9418.670346537838, 9268.0, 9504.904950950402, 9615.5672994714, 9647.1317581418, 9654.855177172207, 6663.433608143168, 6994.160700715946, 7144.714211431485, 7286.526375785557, 7407.555546667218, 7624.656890439833, 7682.8079298018, 7761.223877612194, 7765.767026988973, 7774.572398518136, 6690.732370705117, 6798.048273241849, 6838.897416538656, 6898.896516552356, 6962.164540255202, 6915.550489218184, 6916.619585922823, 6961.37347638715, 6976.407005404598, 7038.648067596702, 6471.579347342407, 6503.414692677682, 6542.051402546699, 6648.16897887764, 6666.466682665472, 4958.305837182726, 4979.0, 5059.898802024012, 5064.6961182327705, 5083.034223497523, 4759.714417134983, 4771.5228477152, 4775.6179505638775, 4782.187028205144, 4831.9275210872565], "value": 4304.597172263685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.3693846084756, 310.7451889450651, 315.1899617981786, 321.31239148222795, 324.86031006667156, 5511.917321240175, 5638.915416268759, 5703.543716502681, 5705.115707065406, 5770.730439303357, 5660.179274005267, 5701.429857014306, 5710.543156547476, 5717.3710891801975, 5731.656100633965, 4389.561043895616, 4396.36252743352, 4411.1177764447075, 4416.624586910117, 4422.425084738996, 4209.095044565418, 4382.320740285261, 4384.364267181273, 4433.778311084433, 4435.667324950641, 4300.1829652366105, 4307.849225277116, 4314.072474418, 4332.06860524987, 4346.261135606938, 4276.144771045788, 4281.892952676177, 4309.913801723964, 4315.848945286932, 4319.265724826787, 3674.0, 3754.81225938702, 3756.6806821420214, 3770.3213421584105, 3772.2832661794173, 5429.294191755086, 5444.673319600797, 5481.75332110056, 5494.450554944514, 5496.780128794843, 4820.686655367425, 4919.434265059493, 4934.679245849008, 4937.654364194508, 4940.357753492059, 5770.682612456313, 5861.794837180721, 5880.764769409218, 5892.381299963527, 5931.940680593225, 4107.938380924288, 4131.97934010331, 4134.028503301722, 4138.255114079465, 4141.875743727693, 6119.479844213247, 6145.139680444741, 6146.924288249583, 6182.907256391158, 6210.937890621081, 4127.332601536748, 4143.047099167208, 4212.810423530887, 4239.448871646666, 4251.702380833312, 4267.146570685875, 4275.444192254987, 4287.356896465492, 4287.506936702257, 4291.334843099262, 4953.2570114483115, 4962.528559786814, 4977.9751101244265, 4981.476944920803, 4981.601471882241, 5725.484706376446, 5965.194698715618, 5989.191459153046, 6054.51563874889, 6057.121717350959, 1457.4024649893493, 1465.3625672832352, 1470.522080323899, 1480.2006916265311, 1481.5629389330174, 943.2925306020485, 976.3702411944398, 983.1299300119446, 988.0366642523626, 990.2424645146468, 5731.111677689964, 5733.627314224562, 5749.425057494301, 5752.626079304831, 5754.798582049608, 6058.697065146725, 6061.4544690977145, 6069.176418856093, 6110.602810817282, 6122.7244773984385, 5556.944430555724, 5751.568632352591, 5761.818827140426, 5763.135529670499, 5775.335836378787, 3246.8214248216573, 3268.820214888204, 3277.5903012123485, 3278.327942771774, 3286.4741641337273, 6114.296855861544, 6323.9051414228825, 6326.2092238470195, 6326.272478665012, 6338.651374174372, 6166.352532984062, 6226.906596401058, 6242.812715618538, 6264.80731743886, 6288.591241569375, 6342.446100705264, 6356.14192084072, 6357.11000459936, 6360.236771587347, 6373.107764912916, 5925.911111333419, 6137.140800287874, 6140.3245642978345, 6161.9691901542, 6195.907061394173, 6051.606645568024, 6091.878162436815, 6133.785317514044, 6136.140940268277, 6155.0, 6042.8791424170395, 6233.532485063548, 6275.152854364603, 6360.4911607072245, 6367.363263673781, 4212.347086201644, 4243.405923170697, 4246.957530424656, 4257.254980378483, 4257.74453532789, 6186.81439556814, 6189.164462797465, 6208.441240288395, 6211.223597050369, 6225.750969961151, 5828.737706803119, 6019.036954087325, 6019.277686677627, 6035.849103772265, 6059.697015149313, 5973.522118230618, 5977.462028417463, 5985.521158307238, 5994.490468310242, 6012.518998480198, 5710.5717071219, 5870.737791374875, 5910.586258961831, 5925.881482370414, 5941.940580594139, 6032.577719559588, 6039.396060393926, 6061.848453788691, 6072.757089716361, 6078.57449978515, 5880.529557635294, 5891.617044892068, 5898.174255604305, 5902.468777810018, 5920.674362910081], "value": 4496.223732659848, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.7064850680994, 791.6239786101603, 792.0693185507027, 801.1027649033084, 803.0884945586757, 13158.671033224175, 13426.932865335672, 13452.05835591509, 13454.394552245149, 14147.080439771433, 14165.504207352744, 14380.712385752278, 14395.352209150587, 14396.49612263571, 14406.063605865611, 676.1851968378093, 777.6733771815823, 802.7551596762985, 804.2158895077312, 805.8871757953891, 801.3869389916719, 801.6232370785722, 804.3163311185504, 804.5293503300576, 804.694216197844, 850.6597361055566, 853.1638993786094, 853.1681610429812, 853.5348235211793, 854.1159899504015, 702.8067281497604, 820.1675299570941, 840.7813968368207, 842.5955541340161, 842.8061545844429, 614.8001899382718, 615.8706671598969, 616.46675625584, 616.7779599344233, 617.0774691835734, 13198.340082995908, 13309.0, 13309.933450332686, 13374.063815532916, 13392.464301427932, 13108.672283192902, 13563.186208827501, 13625.931870340584, 13665.521706740217, 13670.726585468334, 10954.123670106372, 11055.72360690981, 11177.72055698614, 11302.943485282522, 11609.941950290278, 3761.6426439488205, 3796.487474191004, 3862.903427414309, 3888.358420860555, 3968.7817170055637, 51909.480905190845, 52410.475895241325, 61079.69460152671, 61430.38569614291, 61835.690821545606, 10224.13094886928, 10241.84637230442, 10324.122449591869, 10503.317284376491, 10522.579096836194, 19044.333448329242, 19119.80880191208, 19142.71285930712, 19210.80789192118, 19565.315213967442, 7791.142974272825, 7798.5710785906185, 7918.089419716691, 8133.146019667968, 8269.0, 4691.741954192552, 4732.787024583902, 4783.330333753277, 4844.4186697596515, 4882.536159064884, 3256.739460843127, 3285.3922024425556, 3314.784539004957, 3320.9169770755443, 3321.236115693404, 532.2601583798523, 588.8439563515672, 598.7156100852147, 600.687642425936, 602.7347966894553, 739.7447880481226, 770.5607803552034, 774.3031271855375, 793.087948858817, 807.0718673525492, 9270.953645231732, 9343.0, 9581.137697607248, 9698.36960597559, 9750.756231094138, 631.6936285901335, 665.3612531969267, 712.1454254894147, 714.3749219432996, 727.131078361353, 4511.233090374644, 4549.499555048942, 4571.885702857388, 4608.28571571407, 4662.044280922402, 64389.35610643927, 65217.0, 67057.66471167613, 67333.32666673369, 67868.6606566964, 57330.0, 57421.425785742445, 57628.0, 58053.0, 59759.70120149459, 48910.510894891304, 49444.258336124985, 52953.47046529486, 53598.46401536013, 53629.19556206738, 8875.33434992391, 8913.598888049924, 8936.0, 8963.148500892405, 9002.0, 34667.653323466446, 35075.82462087673, 35281.647183527835, 35295.470567942015, 35397.0, 45926.54073459356, 46926.0, 46969.765151174026, 47386.763066184445, 47472.52527474681, 11432.771344573228, 11512.884871151182, 11573.710657233636, 11584.247023943417, 11769.058475322125, 12375.195612285173, 12549.0, 12574.622761317176, 12577.496900123893, 12773.425195866022, 11904.107191960464, 12101.455434505644, 12179.634610961686, 12382.318972456242, 12413.689657758629, 11679.708007299885, 11682.299062056303, 11688.824667630162, 11769.823452648046, 11941.64175074749, 11576.0, 11653.6503904883, 11990.940045300067, 12010.519579216734, 12200.389980500762, 10014.248931330034, 10071.546780394754, 10116.696499105039, 10291.176705863663, 10353.534090965773, 10043.69868903934, 10250.53872575721, 10385.584576616851, 10390.272680912565, 10459.215558832966], "value": 6677.427762003641, "unit": "score"}], "name": "dromaeo_css", "value": 6988.981966081809, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 105.0, 111.0, 112.0, 112.0, 99.0, 110.0, 111.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 157.0, 189.0, 129.0, 155.0, 158.0, 139.0, 193.0, 130.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 118.0, 120.0, 74.0, 74.0, 73.0, 111.0, 101.0, 85.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 147.0, 92.0, 93.0, 92.0, 149.0, 93.0, 93.0, 151.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 118.0, 116.0, 116.0, 117.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 149.0, 145.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 57.0, 59.0, 61.0, 83.0, 55.0, 57.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 60.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 77.0, 77.0, 78.0, 79.0, 78.0, 85.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 128.0, 126.0, 125.0, 126.0, 123.0, 125.0, 165.0, 141.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 174.0, 174.0, 170.0, 171.0, 174.0, 179.0, 172.0, 173.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 70.0, 67.0, 70.0, 72.0, 68.0, 68.0, 66.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1554.0, "alertThreshold": 2.0}]} 20:26:05 INFO - Return code: 0 20:26:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:26:05 ERROR - # TBPL SUCCESS # 20:26:05 INFO - Running post-action listener: _resource_record_post_action 20:26:05 INFO - Running post-run listener: _resource_record_post_run 20:26:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 538456064; Read time: 0; Write time: 480572 20:26:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244514816; Read time: 0; Write time: 288404 20:26:06 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 293941248; Read time: 0; Write time: 192168 20:26:06 INFO - Running post-run listener: _upload_blobber_files 20:26:06 INFO - Blob upload gear active. 20:26:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:06 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 20:26:06 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:06 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:07 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:07 INFO - (blobuploader) - INFO - Done attempting. 20:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:08 INFO - (blobuploader) - INFO - Done attempting. 20:26:08 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:08 INFO - Return code: 0 20:26:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fed3fd491a6ba07823720a106a41787558046e4c27caa2040696981630426025bfc9c9e93eb61536eadf2cbb4362b9ad7da1795e651e374cdb9517962ba52de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39820d99099f55bfde7c55da79fbf695a1a23439758dedf5125fc597a34efc489ccf5f6ef445f8a6ed9c41fbf718d4049df65c450c0b317117d1a3877dd789cb"} 20:26:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:08 INFO - Contents: 20:26:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fed3fd491a6ba07823720a106a41787558046e4c27caa2040696981630426025bfc9c9e93eb61536eadf2cbb4362b9ad7da1795e651e374cdb9517962ba52de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39820d99099f55bfde7c55da79fbf695a1a23439758dedf5125fc597a34efc489ccf5f6ef445f8a6ed9c41fbf718d4049df65c450c0b317117d1a3877dd789cb"} 20:26:08 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:08 INFO - Copying logs to upload dir... 20:26:08 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.084396 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-21 20:26:07.471398) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 20:26:07.477395) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fed3fd491a6ba07823720a106a41787558046e4c27caa2040696981630426025bfc9c9e93eb61536eadf2cbb4362b9ad7da1795e651e374cdb9517962ba52de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39820d99099f55bfde7c55da79fbf695a1a23439758dedf5125fc597a34efc489ccf5f6ef445f8a6ed9c41fbf718d4049df65c450c0b317117d1a3877dd789cb"} build_url:https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011100 build_url: 'https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fed3fd491a6ba07823720a106a41787558046e4c27caa2040696981630426025bfc9c9e93eb61536eadf2cbb4362b9ad7da1795e651e374cdb9517962ba52de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39820d99099f55bfde7c55da79fbf695a1a23439758dedf5125fc597a34efc489ccf5f6ef445f8a6ed9c41fbf718d4049df65c450c0b317117d1a3877dd789cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 20:26:07.501448) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:26:07.501735) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461291537.745015-1661757749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:26:07.585063) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 20:26:07.585426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 20:26:07.585774) ========= ========= Total master_lag: 0.14 =========