builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1461333056.12 results: success (0) buildid: 20160422034513 builduid: 2a195d8e435249048de903b1fb9dcb25 revision: 005449bf12df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.118709) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.119209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.119581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.196312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.196653) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:50:56-- 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% 12.8M=0.001s 2016-04-22 06:50:56 (12.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.297960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.298312) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.348078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:56.348426) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 005449bf12df --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 005449bf12df --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=5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:50:56,746 Setting DEBUG logging. 2016-04-22 06:50:56,746 attempt 1/10 2016-04-22 06:50:56,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/005449bf12df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:50:57,362 unpacking tar archive at: fx-team-005449bf12df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:57.273680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:57.274001) ========= script_repo_revision: 005449bf12df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:57.274413) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:57.274684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:57.282709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-22 06:50:57.282977) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:50:57 INFO - MultiFileLogger online at 20160422 06:50:57 in /builds/slave/test 06:50:57 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 06:50:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:57 INFO - {'append_to_log': False, 06:50:57 INFO - 'base_work_dir': '/builds/slave/test', 06:50:57 INFO - 'blob_upload_branch': 'Fx-Team', 06:50:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:57 INFO - 'branch': 'Fx-Team', 06:50:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:57 INFO - 'config_files': ('talos/linux_config.py',), 06:50:57 INFO - 'default_actions': ('clobber', 06:50:57 INFO - 'read-buildbot-config', 06:50:57 INFO - 'download-and-extract', 06:50:57 INFO - 'populate-webroot', 06:50:57 INFO - 'create-virtualenv', 06:50:57 INFO - 'install', 06:50:57 INFO - 'run-tests'), 06:50:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:57 INFO - 'download_minidump_stackwalk': True, 06:50:57 INFO - 'download_symbols': 'ondemand', 06:50:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:57 INFO - 'installer_path': 'installer.exe', 06:50:57 INFO - 'log_level': 'info', 06:50:57 INFO - 'log_name': 'talos', 06:50:57 INFO - 'log_to_console': True, 06:50:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:50:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:50:57 INFO - 'opt_config_files': (), 06:50:57 INFO - 'pip_index': False, 06:50:57 INFO - 'sps_profile': False, 06:50:57 INFO - 'sps_profile_interval': 0, 06:50:57 INFO - 'suite': 'dromaeojs', 06:50:57 INFO - 'system_bits': '32', 06:50:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:57 INFO - 'title': 'talos-linux64-ix-051', 06:50:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:57 INFO - 'use_talos_json': True, 06:50:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:57 INFO - 'work_dir': 'build'} 06:50:57 INFO - ##### 06:50:57 INFO - ##### Running clobber step. 06:50:57 INFO - ##### 06:50:57 INFO - Running pre-action listener: _resource_record_pre_action 06:50:57 INFO - Running main action method: clobber 06:50:57 INFO - rmtree: /builds/slave/test/build 06:50:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:58 INFO - Running post-action listener: _resource_record_post_action 06:50:58 INFO - ##### 06:50:58 INFO - ##### Running read-buildbot-config step. 06:50:58 INFO - ##### 06:50:58 INFO - Running pre-action listener: _resource_record_pre_action 06:50:58 INFO - Running main action method: read_buildbot_config 06:50:58 INFO - Using buildbot properties: 06:50:58 INFO - { 06:50:58 INFO - "project": "", 06:50:58 INFO - "product": "firefox", 06:50:58 INFO - "script_repo_revision": "production", 06:50:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:50:58 INFO - "repository": "", 06:50:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:50:58 INFO - "buildid": "20160422034513", 06:50:58 INFO - "pgo_build": "True", 06:50:58 INFO - "basedir": "/builds/slave/test", 06:50:58 INFO - "buildnumber": 1109, 06:50:58 INFO - "slavename": "talos-linux64-ix-051", 06:50:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:50:58 INFO - "platform": "ubuntu64_hw", 06:50:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:50:58 INFO - "branch": "fx-team", 06:50:58 INFO - "repo_path": "integration/fx-team", 06:50:58 INFO - "revision": "005449bf12df", 06:50:58 INFO - "stage_platform": "linux64-pgo", 06:50:58 INFO - "builduid": "2a195d8e435249048de903b1fb9dcb25", 06:50:58 INFO - "slavebuilddir": "test" 06:50:58 INFO - } 06:50:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:50:58 INFO - Running post-action listener: _resource_record_post_action 06:50:58 INFO - ##### 06:50:58 INFO - ##### Running download-and-extract step. 06:50:58 INFO - ##### 06:50:58 INFO - Running pre-action listener: _resource_record_pre_action 06:50:58 INFO - Running main action method: download_and_extract 06:50:58 INFO - mkdir: /builds/slave/test/build/tests 06:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:58 INFO - https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:50:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:50:58 INFO - Downloaded 1361 bytes. 06:50:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:50:58 INFO - Using the following test package requirements: 06:50:58 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:58 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:50:58 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:50:58 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'jsshell-linux-x86_64.zip'], 06:50:58 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:50:58 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:58 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:50:58 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:50:58 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:50:58 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:50:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:58 INFO - https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:51:00 INFO - Downloaded 23853508 bytes. 06:51:00 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'] 06:51:00 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 06:51:01 INFO - Return code: 0 06:51:01 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 06:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:01 INFO - https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:51:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:51:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:51:02 INFO - Downloaded 23853508 bytes. 06:51:02 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'] 06:51:02 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 06:51:03 INFO - Return code: 0 06:51: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')]} 06:51:03 INFO - https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:51:05 INFO - Downloaded 10845952 bytes. 06:51:05 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'] 06:51:05 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 06:51:05 INFO - Return code: 0 06:51:05 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')]} 06:51:05 INFO - https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBGr38raRgmq9jUcIuy1YQ/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 06:51:06 INFO - Downloaded 58338855 bytes. 06:51:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:51:06 INFO - mkdir: /builds/slave/test/properties 06:51:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:51:06 INFO - Writing to file /builds/slave/test/properties/build_url 06:51:06 INFO - Contents: 06:51:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:51:07 INFO - Running post-action listener: _resource_record_post_action 06:51:07 INFO - Running post-action listener: set_extra_try_arguments 06:51:07 INFO - ##### 06:51:07 INFO - ##### Running populate-webroot step. 06:51:07 INFO - ##### 06:51:07 INFO - Running pre-action listener: _resource_record_pre_action 06:51:07 INFO - Running main action method: populate_webroot 06:51:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:07 INFO - '--tppagecycles', 06:51:07 INFO - '7'], 06:51:07 INFO - 'tests': ['tsvgm']}}, 06:51:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:51:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:51:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:51:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['damp', 'tps']}, 06:51:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'tests': ['damp', 'tps']}, 06:51:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['dromaeo_dom']}, 06:51:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['a11yr', 06:51:07 INFO - 'ts_paint', 06:51:07 INFO - 'tpaint', 06:51:07 INFO - 'sessionrestore', 06:51:07 INFO - 'sessionrestore_no_auto_restore', 06:51:07 INFO - 'tabpaint']}, 06:51:07 INFO - 'other-e10s': {'tests': ['a11yr', 06:51:07 INFO - 'ts_paint', 06:51:07 INFO - 'tpaint', 06:51:07 INFO - 'sessionrestore', 06:51:07 INFO - 'sessionrestore_no_auto_restore', 06:51:07 INFO - 'tabpaint']}, 06:51:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:51:07 INFO - 'ts_paint', 06:51:07 INFO - 'tpaint', 06:51:07 INFO - 'sessionrestore', 06:51:07 INFO - 'sessionrestore_no_auto_restore', 06:51:07 INFO - 'tabpaint']}, 06:51:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:51:07 INFO - 'ts_paint', 06:51:07 INFO - 'tpaint', 06:51:07 INFO - 'sessionrestore', 06:51:07 INFO - 'sessionrestore_no_auto_restore', 06:51:07 INFO - 'tabpaint']}, 06:51:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['a11yr', 06:51:07 INFO - 'ts_paint', 06:51:07 INFO - 'tpaint', 06:51:07 INFO - 'sessionrestore', 06:51:07 INFO - 'sessionrestore_no_auto_restore', 06:51:07 INFO - 'tabpaint']}, 06:51:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['a11yr', 06:51:07 INFO - 'ts_paint', 06:51:07 INFO - 'tpaint', 06:51:07 INFO - 'sessionrestore', 06:51:07 INFO - 'sessionrestore_no_auto_restore', 06:51:07 INFO - 'tabpaint']}, 06:51:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['tsvgx', 06:51:07 INFO - 'tsvgr_opacity', 06:51:07 INFO - 'tart', 06:51:07 INFO - 'tscrollx', 06:51:07 INFO - 'cart']}, 06:51:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:51:07 INFO - 'tsvgr_opacity', 06:51:07 INFO - 'tart', 06:51:07 INFO - 'tscrollx', 06:51:07 INFO - 'cart']}, 06:51:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'talos_options': ['--disable-e10s'], 06:51:07 INFO - 'tests': ['tp5o']}, 06:51:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'tests': ['tp5o']}, 06:51:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'talos_options': ['--disable-e10s', 06:51:07 INFO - '--xperf_path', 06:51:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:07 INFO - 'tests': ['tp5n']}, 06:51:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:07 INFO - 'talos_options': ['--xperf_path', 06:51:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:07 INFO - 'tests': ['tp5n']}}, 06:51:07 INFO - 'talos.zip': {'path': '', 06:51:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:07 INFO - Running post-action listener: _resource_record_post_action 06:51:07 INFO - ##### 06:51:07 INFO - ##### Running create-virtualenv step. 06:51:07 INFO - ##### 06:51:07 INFO - Running pre-action listener: _resource_record_pre_action 06:51:07 INFO - Running main action method: create_virtualenv 06:51:07 INFO - Creating virtualenv /builds/slave/test/build/venv 06:51:07 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 06:51:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:51:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:07 INFO - Using real prefix '/usr' 06:51:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:51:08 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:10 INFO - Installing pip.................done. 06:51:10 INFO - Return code: 0 06:51:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51: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', 'pip>=1.5'] in /builds/slave/test/build 06:51: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 pip>=1.5 06:51:10 INFO - Using env: {'DISPLAY': ':0', 06:51:10 INFO - 'HOME': '/home/cltbld', 06:51:10 INFO - 'LANG': 'en_US.UTF-8', 06:51:10 INFO - 'LANGUAGE': 'en_US:en', 06:51:10 INFO - 'LOGNAME': 'cltbld', 06:51:10 INFO - 'MAIL': '/var/mail/cltbld', 06:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:10 INFO - 'MOZ_NO_REMOTE': '1', 06:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:10 INFO - 'NO_EM_RESTART': '1', 06:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:10 INFO - 'PWD': '/builds/slave/test', 06:51:10 INFO - 'SHELL': '/bin/bash', 06:51:10 INFO - 'SHLVL': '1', 06:51:10 INFO - 'TERM': 'linux', 06:51:10 INFO - 'TMOUT': '86400', 06:51:10 INFO - 'USER': 'cltbld', 06:51:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:10 INFO - '_': '/tools/buildbot/bin/python'} 06:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:10 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 06:51:10 INFO - Cleaning up... 06:51:10 INFO - Return code: 0 06:51:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', '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 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:51: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 psutil>=0.7.1 06:51:10 INFO - Using env: {'DISPLAY': ':0', 06:51:10 INFO - 'HOME': '/home/cltbld', 06:51:10 INFO - 'LANG': 'en_US.UTF-8', 06:51:10 INFO - 'LANGUAGE': 'en_US:en', 06:51:10 INFO - 'LOGNAME': 'cltbld', 06:51:10 INFO - 'MAIL': '/var/mail/cltbld', 06:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:10 INFO - 'MOZ_NO_REMOTE': '1', 06:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:10 INFO - 'NO_EM_RESTART': '1', 06:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:10 INFO - 'PWD': '/builds/slave/test', 06:51:10 INFO - 'SHELL': '/bin/bash', 06:51:10 INFO - 'SHLVL': '1', 06:51:10 INFO - 'TERM': 'linux', 06:51:10 INFO - 'TMOUT': '86400', 06:51:10 INFO - 'USER': 'cltbld', 06:51:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:10 INFO - '_': '/tools/buildbot/bin/python'} 06:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:10 INFO - Downloading/unpacking psutil>=0.7.1 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:12 INFO - Installing collected packages: psutil 06:51:12 INFO - Running setup.py install for psutil 06:51:12 INFO - building 'psutil._psutil_linux' extension 06:51:12 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 06:51:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:51:12 INFO - building 'psutil._psutil_posix' extension 06:51:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:51:13 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 06:51:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:13 INFO - Successfully installed psutil 06:51:13 INFO - Cleaning up... 06:51:13 INFO - Return code: 0 06:51:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', '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 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:51: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 mozsystemmonitor==0.0.0 06:51:13 INFO - Using env: {'DISPLAY': ':0', 06:51:13 INFO - 'HOME': '/home/cltbld', 06:51:13 INFO - 'LANG': 'en_US.UTF-8', 06:51:13 INFO - 'LANGUAGE': 'en_US:en', 06:51:13 INFO - 'LOGNAME': 'cltbld', 06:51:13 INFO - 'MAIL': '/var/mail/cltbld', 06:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:13 INFO - 'MOZ_NO_REMOTE': '1', 06:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:13 INFO - 'NO_EM_RESTART': '1', 06:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:13 INFO - 'PWD': '/builds/slave/test', 06:51:13 INFO - 'SHELL': '/bin/bash', 06:51:13 INFO - 'SHLVL': '1', 06:51:13 INFO - 'TERM': 'linux', 06:51:13 INFO - 'TMOUT': '86400', 06:51:13 INFO - 'USER': 'cltbld', 06:51:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:13 INFO - '_': '/tools/buildbot/bin/python'} 06:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:51:15 INFO - Installing collected packages: mozsystemmonitor 06:51:15 INFO - Running setup.py install for mozsystemmonitor 06:51:15 INFO - Successfully installed mozsystemmonitor 06:51:15 INFO - Cleaning up... 06:51:15 INFO - Return code: 0 06:51:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51:15 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')]} 06:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:15 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')]} 06:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:15 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 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51:15 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 06:51:15 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 06:51:15 INFO - Using env: {'DISPLAY': ':0', 06:51:15 INFO - 'HOME': '/home/cltbld', 06:51:15 INFO - 'LANG': 'en_US.UTF-8', 06:51:15 INFO - 'LANGUAGE': 'en_US:en', 06:51:15 INFO - 'LOGNAME': 'cltbld', 06:51:15 INFO - 'MAIL': '/var/mail/cltbld', 06:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:15 INFO - 'MOZ_NO_REMOTE': '1', 06:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:15 INFO - 'NO_EM_RESTART': '1', 06:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:15 INFO - 'PWD': '/builds/slave/test', 06:51:15 INFO - 'SHELL': '/bin/bash', 06:51:15 INFO - 'SHLVL': '1', 06:51:15 INFO - 'TERM': 'linux', 06:51:15 INFO - 'TMOUT': '86400', 06:51:15 INFO - 'USER': 'cltbld', 06:51:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:15 INFO - '_': '/tools/buildbot/bin/python'} 06:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:15 INFO - Downloading/unpacking blobuploader==1.2.4 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:17 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:18 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 06:51:18 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 06:51:18 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 06:51:18 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 06:51:18 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 06:51:18 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 06:51:18 INFO - Downloading docopt-0.6.1.tar.gz 06:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:18 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:18 INFO - Running setup.py install for blobuploader 06:51:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:18 INFO - Running setup.py install for requests 06:51:18 INFO - Running setup.py install for docopt 06:51:18 INFO - Successfully installed blobuploader requests docopt 06:51:18 INFO - Cleaning up... 06:51:18 INFO - Return code: 0 06:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:18 INFO - Using env: {'DISPLAY': ':0', 06:51:18 INFO - 'HOME': '/home/cltbld', 06:51:18 INFO - 'LANG': 'en_US.UTF-8', 06:51:18 INFO - 'LANGUAGE': 'en_US:en', 06:51:18 INFO - 'LOGNAME': 'cltbld', 06:51:18 INFO - 'MAIL': '/var/mail/cltbld', 06:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:18 INFO - 'MOZ_NO_REMOTE': '1', 06:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:18 INFO - 'NO_EM_RESTART': '1', 06:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:18 INFO - 'PWD': '/builds/slave/test', 06:51:18 INFO - 'SHELL': '/bin/bash', 06:51:18 INFO - 'SHLVL': '1', 06:51:18 INFO - 'TERM': 'linux', 06:51:18 INFO - 'TMOUT': '86400', 06:51:18 INFO - 'USER': 'cltbld', 06:51:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:18 INFO - '_': '/tools/buildbot/bin/python'} 06:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:19 INFO - Running setup.py (path:/tmp/pip-XlzgRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:19 INFO - Running setup.py (path:/tmp/pip-XRJElg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:19 INFO - Running setup.py (path:/tmp/pip-CLLrLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:19 INFO - Running setup.py (path:/tmp/pip-YsEr9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:19 INFO - Running setup.py (path:/tmp/pip-y05eug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:19 INFO - Running setup.py (path:/tmp/pip-L7_Xub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:19 INFO - Running setup.py (path:/tmp/pip-9Dn1eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:19 INFO - Running setup.py (path:/tmp/pip-8VZpT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:19 INFO - Running setup.py (path:/tmp/pip-hKMzZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:19 INFO - Running setup.py (path:/tmp/pip-nHx5fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:19 INFO - Running setup.py (path:/tmp/pip-_GhwZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:19 INFO - Running setup.py (path:/tmp/pip-n9hVTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:20 INFO - Running setup.py (path:/tmp/pip-TkSghw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:20 INFO - Running setup.py (path:/tmp/pip-WBXBU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:20 INFO - Running setup.py (path:/tmp/pip-Dh31ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:20 INFO - Running setup.py (path:/tmp/pip-eG9iOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:20 INFO - Running setup.py (path:/tmp/pip-ZuVHaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:20 INFO - Running setup.py install for manifestparser 06:51:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:51:20 INFO - Running setup.py install for mozcrash 06:51:20 INFO - Running setup.py install for mozdebug 06:51:20 INFO - Running setup.py install for mozdevice 06:51:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:51:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:51:20 INFO - Running setup.py install for mozfile 06:51:20 INFO - Running setup.py install for mozhttpd 06:51:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:51:20 INFO - Running setup.py install for mozinfo 06:51:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Running setup.py install for mozInstall 06:51:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Running setup.py install for mozleak 06:51:21 INFO - Running setup.py install for mozlog 06:51:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Running setup.py install for moznetwork 06:51:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Running setup.py install for mozprocess 06:51:21 INFO - Running setup.py install for mozprofile 06:51:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Running setup.py install for mozrunner 06:51:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:51:21 INFO - Running setup.py install for mozscreenshot 06:51:21 INFO - Running setup.py install for moztest 06:51:22 INFO - Running setup.py install for mozversion 06:51:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:51:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:22 INFO - Cleaning up... 06:51:22 INFO - Return code: 0 06:51:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:22 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')]} 06:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:22 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')]} 06:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:22 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 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51:22 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 06:51:22 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 06:51:22 INFO - Using env: {'DISPLAY': ':0', 06:51:22 INFO - 'HOME': '/home/cltbld', 06:51:22 INFO - 'LANG': 'en_US.UTF-8', 06:51:22 INFO - 'LANGUAGE': 'en_US:en', 06:51:22 INFO - 'LOGNAME': 'cltbld', 06:51:22 INFO - 'MAIL': '/var/mail/cltbld', 06:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:22 INFO - 'MOZ_NO_REMOTE': '1', 06:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:22 INFO - 'NO_EM_RESTART': '1', 06:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:22 INFO - 'PWD': '/builds/slave/test', 06:51:22 INFO - 'SHELL': '/bin/bash', 06:51:22 INFO - 'SHLVL': '1', 06:51:22 INFO - 'TERM': 'linux', 06:51:22 INFO - 'TMOUT': '86400', 06:51:22 INFO - 'USER': 'cltbld', 06:51:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:22 INFO - '_': '/tools/buildbot/bin/python'} 06:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:22 INFO - Running setup.py (path:/tmp/pip-RoCU1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:22 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)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:22 INFO - Running setup.py (path:/tmp/pip-KC4ZXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:22 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)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:22 INFO - Running setup.py (path:/tmp/pip-tKuo2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:22 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)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:22 INFO - Running setup.py (path:/tmp/pip-B7b0V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:22 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)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:22 INFO - Running setup.py (path:/tmp/pip-ESCIjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:22 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)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:22 INFO - Running setup.py (path:/tmp/pip-1fAM4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:22 INFO - Running setup.py (path:/tmp/pip-uGYO95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:22 INFO - Running setup.py (path:/tmp/pip-5qT5cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:22 INFO - Running setup.py (path:/tmp/pip-WI_y47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:23 INFO - Running setup.py (path:/tmp/pip-7YL7GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:23 INFO - Running setup.py (path:/tmp/pip-El9ooQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:23 INFO - Running setup.py (path:/tmp/pip-VxpYkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:23 INFO - Running setup.py (path:/tmp/pip-jp59rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:23 INFO - Running setup.py (path:/tmp/pip-5aJkcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:23 INFO - Running setup.py (path:/tmp/pip-OiBdE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:23 INFO - Running setup.py (path:/tmp/pip-4NCgsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:23 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)) 06:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:23 INFO - Running setup.py (path:/tmp/pip-1L2Wnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:23 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)) 06:51:23 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)) 06:51:23 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)) 06:51:23 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)) 06:51:23 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)) 06:51:23 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)) 06:51:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:23 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 06:51:23 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 06:51:23 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 06:51:23 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 06:51:23 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 06:51:23 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 06:51:25 INFO - Downloading blessings-1.6.tar.gz 06:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:25 INFO - Installing collected packages: blessings 06:51:25 INFO - Running setup.py install for blessings 06:51:25 INFO - Successfully installed blessings 06:51:25 INFO - Cleaning up... 06:51:25 INFO - Return code: 0 06:51:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:25 INFO - Reading from file tmpfile_stdout 06:51:25 INFO - Current package versions: 06:51:25 INFO - argparse == 1.2.1 06:51:25 INFO - blessings == 1.6 06:51:25 INFO - blobuploader == 1.2.4 06:51:25 INFO - docopt == 0.6.1 06:51:25 INFO - manifestparser == 1.1 06:51:25 INFO - mozInstall == 1.12 06:51:25 INFO - mozcrash == 0.17 06:51:25 INFO - mozdebug == 0.1 06:51:25 INFO - mozdevice == 0.48 06:51:25 INFO - mozfile == 1.2 06:51:25 INFO - mozhttpd == 0.7 06:51:25 INFO - mozinfo == 0.9 06:51:25 INFO - mozleak == 0.1 06:51:25 INFO - mozlog == 3.1 06:51:25 INFO - moznetwork == 0.27 06:51:25 INFO - mozprocess == 0.22 06:51:25 INFO - mozprofile == 0.28 06:51:25 INFO - mozrunner == 6.11 06:51:25 INFO - mozscreenshot == 0.1 06:51:25 INFO - mozsystemmonitor == 0.0 06:51:25 INFO - moztest == 0.7 06:51:25 INFO - mozversion == 1.4 06:51:25 INFO - psutil == 3.1.1 06:51:25 INFO - requests == 1.2.3 06:51:25 INFO - wsgiref == 0.1.2 06:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:25 INFO - Using env: {'DISPLAY': ':0', 06:51:25 INFO - 'HOME': '/home/cltbld', 06:51:25 INFO - 'LANG': 'en_US.UTF-8', 06:51:25 INFO - 'LANGUAGE': 'en_US:en', 06:51:25 INFO - 'LOGNAME': 'cltbld', 06:51:25 INFO - 'MAIL': '/var/mail/cltbld', 06:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:25 INFO - 'MOZ_NO_REMOTE': '1', 06:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:25 INFO - 'NO_EM_RESTART': '1', 06:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:25 INFO - 'PWD': '/builds/slave/test', 06:51:25 INFO - 'SHELL': '/bin/bash', 06:51:25 INFO - 'SHLVL': '1', 06:51:25 INFO - 'TERM': 'linux', 06:51:25 INFO - 'TMOUT': '86400', 06:51:25 INFO - 'USER': 'cltbld', 06:51:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:25 INFO - '_': '/tools/buildbot/bin/python'} 06:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 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)) 06:51:26 INFO - Cleaning up... 06:51:26 INFO - Return code: 0 06:51:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51:26 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')]} 06:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:26 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')]} 06:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:26 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 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51:26 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 06:51:26 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 06:51:26 INFO - Using env: {'DISPLAY': ':0', 06:51:26 INFO - 'HOME': '/home/cltbld', 06:51:26 INFO - 'LANG': 'en_US.UTF-8', 06:51:26 INFO - 'LANGUAGE': 'en_US:en', 06:51:26 INFO - 'LOGNAME': 'cltbld', 06:51:26 INFO - 'MAIL': '/var/mail/cltbld', 06:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:26 INFO - 'MOZ_NO_REMOTE': '1', 06:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:26 INFO - 'NO_EM_RESTART': '1', 06:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:26 INFO - 'PWD': '/builds/slave/test', 06:51:26 INFO - 'SHELL': '/bin/bash', 06:51:26 INFO - 'SHLVL': '1', 06:51:26 INFO - 'TERM': 'linux', 06:51:26 INFO - 'TMOUT': '86400', 06:51:26 INFO - 'USER': 'cltbld', 06:51:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:26 INFO - '_': '/tools/buildbot/bin/python'} 06:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:26 INFO - Downloading/unpacking jsonschema 06:51:26 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 06:51:26 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 06:51:26 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 06:51:26 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 06:51:26 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 06:51:26 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 06:51:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:28 INFO - Downloading/unpacking functools32 (from jsonschema) 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:28 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:28 INFO - warning: no files found matching '*.txt' 06:51:28 INFO - no previously-included directories found matching 'build' 06:51:28 INFO - no previously-included directories found matching 'dist' 06:51:28 INFO - no previously-included directories found matching '.git*' 06:51:28 INFO - Installing collected packages: jsonschema, functools32 06:51:28 INFO - Running setup.py install for functools32 06:51:28 INFO - warning: no files found matching '*.txt' 06:51:28 INFO - no previously-included directories found matching 'build' 06:51:28 INFO - no previously-included directories found matching 'dist' 06:51:28 INFO - no previously-included directories found matching '.git*' 06:51:28 INFO - Successfully installed jsonschema functools32 06:51:28 INFO - Cleaning up... 06:51:28 INFO - Return code: 0 06:51:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:51:28 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')]} 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 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')]} 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 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 0x7f8099630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', '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 06:51:28 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 06:51:28 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 06:51:28 INFO - Using env: {'DISPLAY': ':0', 06:51:28 INFO - 'HOME': '/home/cltbld', 06:51:28 INFO - 'LANG': 'en_US.UTF-8', 06:51:28 INFO - 'LANGUAGE': 'en_US:en', 06:51:28 INFO - 'LOGNAME': 'cltbld', 06:51:28 INFO - 'MAIL': '/var/mail/cltbld', 06:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:28 INFO - 'MOZ_NO_REMOTE': '1', 06:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:28 INFO - 'NO_EM_RESTART': '1', 06:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:28 INFO - 'PWD': '/builds/slave/test', 06:51:28 INFO - 'SHELL': '/bin/bash', 06:51:28 INFO - 'SHLVL': '1', 06:51:28 INFO - 'TERM': 'linux', 06:51:28 INFO - 'TMOUT': '86400', 06:51:28 INFO - 'USER': 'cltbld', 06:51:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:28 INFO - '_': '/tools/buildbot/bin/python'} 06:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:28 INFO - Downloading/unpacking flake8 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:51:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:51:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:31 INFO - no previously-included directories found matching 'docs/_build' 06:51:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:51:31 INFO - Running setup.py install for pep8 06:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:31 INFO - no previously-included directories found matching 'docs/_build' 06:51:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:51:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:51:31 INFO - Cleaning up... 06:51:31 INFO - Return code: 0 06:51:31 INFO - Running post-action listener: _resource_record_post_action 06:51:31 INFO - Running post-action listener: _start_resource_monitoring 06:51:31 INFO - Starting resource monitoring. 06:51:31 INFO - ##### 06:51:31 INFO - ##### Running install step. 06:51:31 INFO - ##### 06:51:31 INFO - Running pre-action listener: _resource_record_pre_action 06:51:31 INFO - Running main action method: install 06:51:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:32 INFO - Reading from file tmpfile_stdout 06:51:32 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:32 INFO - Reading from file tmpfile_stdout 06:51:32 INFO - Output received: 06:51:32 INFO - Usage: mozinstall [options] installer 06:51:32 INFO - Options: 06:51:32 INFO - -h, --help show this help message and exit 06:51:32 INFO - -d DEST, --destination=DEST 06:51:32 INFO - Directory to install application into. [default: 06:51:32 INFO - "/builds/slave/test"] 06:51:32 INFO - --app=APP Application being installed. [default: firefox] 06:51:32 INFO - mkdir: /builds/slave/test/build/application 06:51:32 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'] 06:51:32 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 06:51:48 INFO - Reading from file tmpfile_stdout 06:51:48 INFO - Output received: 06:51:48 INFO - /builds/slave/test/build/application/firefox/firefox 06:51:48 INFO - Running post-action listener: _resource_record_post_action 06:51:48 INFO - ##### 06:51:48 INFO - ##### Running run-tests step. 06:51:48 INFO - ##### 06:51:48 INFO - Running pre-action listener: _resource_record_pre_action 06:51:48 INFO - Running main action method: run_tests 06:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:51:48 INFO - Python 2.7.3 06:51:48 INFO - Return code: 0 06:51:48 INFO - grabbing minidump binary from tooltool 06:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:48 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 0x2025810>, '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 0x2026710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:51:48 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 06:51:48 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 06:51:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:48 INFO - Return code: 0 06:51:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:51:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:51:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:51:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:51:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:51:49 INFO - Return code: 0 06:51:49 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/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 06:51:49 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/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 06:51:49 INFO - Using env: {'DISPLAY': ':0', 06:51:49 INFO - 'HOME': '/home/cltbld', 06:51:49 INFO - 'LANG': 'en_US.UTF-8', 06:51:49 INFO - 'LANGUAGE': 'en_US:en', 06:51:49 INFO - 'LOGNAME': 'cltbld', 06:51:49 INFO - 'MAIL': '/var/mail/cltbld', 06:51:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:49 INFO - 'MOZ_NO_REMOTE': '1', 06:51:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:49 INFO - 'NO_EM_RESTART': '1', 06:51:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:49 INFO - 'PWD': '/builds/slave/test', 06:51:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:49 INFO - 'SHELL': '/bin/bash', 06:51:49 INFO - 'SHLVL': '1', 06:51:49 INFO - 'TERM': 'linux', 06:51:49 INFO - 'TMOUT': '86400', 06:51:49 INFO - 'USER': 'cltbld', 06:51:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002', 06:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:49 INFO - '_': '/tools/buildbot/bin/python'} 06:51:49 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/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 06:51:49 INFO - mozversion application_buildid: 20160422034513 06:51:49 INFO - mozversion application_changeset: 005449bf12df9fa386f1644823961cebd94ed0e7 06:51:49 INFO - mozversion application_display_name: Nightly 06:51:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:49 INFO - mozversion application_name: Firefox 06:51:49 INFO - mozversion application_remotingname: firefox 06:51:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:51:49 INFO - mozversion application_vendor: Mozilla 06:51:49 INFO - mozversion application_version: 48.0a1 06:51:49 INFO - mozversion platform_buildid: 20160422034513 06:51:49 INFO - mozversion platform_changeset: 005449bf12df9fa386f1644823961cebd94ed0e7 06:51:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:51:49 INFO - mozversion platform_version: 48.0a1 06:51:49 INFO - using testdate: 1461333109 06:51:49 INFO - actual date: 1461333109 06:51:49 INFO - starting webserver on 'localhost:49924' 06:51:49 INFO - SUITE-START | Running 2 tests 06:51:49 INFO - TEST-START | dromaeo_css 06:51:49 INFO - operating with platform_type : linux_ 06:51:49 INFO - Initialising browser for dromaeo_css test... 06:51:49 INFO - TEST-INFO | started process 10838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG6a492/profile http://localhost:49924/getInfo.html) 06:51:53 INFO - PROCESS | 10838 | __metrics Screen width/height:1600/1200 06:51:53 INFO - PROCESS | 10838 | colorDepth:24 06:51:53 INFO - PROCESS | 10838 | Browser inner width/height: 1024/697 06:51:53 INFO - PROCESS | 10838 | __metrics 06:51:54 ERROR - PROCESS | 10838 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:51:55 INFO - TEST-INFO | 10838: exit 0 06:51:55 INFO - Browser initialized. 06:51:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:51:55 INFO - TEST-INFO | started process 10921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG6a492/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:07 INFO - PROCESS | 10921 | RSS: Main: 153792512 06:52:07 INFO - PROCESS | 10921 | 06:52:58 INFO - PROCESS | 10921 | 1461333178466 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] 06:55:06 INFO - PROCESS | 10921 | Cycle 1(1): loaded http://localhost:49924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49924/tests/dromaeo/cssquery-ext.html) 06:55:07 INFO - PROCESS | 10921 | RSS: Main: 242024448 06:55:07 INFO - PROCESS | 10921 | 06:58:09 INFO - PROCESS | 10921 | Cycle 1(1): loaded http://localhost:49924/tests/dromaeo/cssquery-ext.html (next: http://localhost:49924/tests/dromaeo/cssquery-jquery.html) 06:58:09 INFO - PROCESS | 10921 | RSS: Main: 239165440 06:58:09 INFO - PROCESS | 10921 | 07:01:11 INFO - PROCESS | 10921 | Cycle 1(1): loaded http://localhost:49924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49924/tests/dromaeo/cssquery-mootools.html) 07:01:12 INFO - PROCESS | 10921 | RSS: Main: 245178368 07:01:12 INFO - PROCESS | 10921 | 07:04:14 INFO - PROCESS | 10921 | Cycle 1(1): loaded http://localhost:49924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49924/tests/dromaeo/cssquery-prototype.html) 07:04:14 INFO - PROCESS | 10921 | RSS: Main: 239226880 07:04:14 INFO - PROCESS | 10921 | 07:07:17 INFO - PROCESS | 10921 | Cycle 1(1): loaded http://localhost:49924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49924/tests/dromaeo/cssquery-yui.html) 07:07:18 INFO - PROCESS | 10921 | RSS: Main: 219901952 07:07:18 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | Cycle 1(1): loaded http://localhost:49924/tests/dromaeo/cssquery-yui.html (next: http://localhost:49924/tests/dromaeo/cssquery-dojo.html) 07:10:20 INFO - PROCESS | 10921 | RSS: Main: 275390464 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | __start_tp_report 07:10:20 INFO - PROCESS | 10921 | _x_x_mozilla_page_load 07:10:20 INFO - PROCESS | 10921 | _x_x_mozilla_page_load_details 07:10:20 INFO - PROCESS | 10921 | |i|pagename|runs| 07:10:20 INFO - PROCESS | 10921 | |0;dojo.html;3069.309405383788;3137.560741496191;3143.4498962681523;3187.82466964317;3217.7425805935527;5259.737013149346;5345.866353341168;5374.865628359288;5376.274202982601;5476.698781567017;5310.4424035476295;5330.333708286465;5366.141417373211;5390.029794636964;5414.0254754144335;4838.758062096898;4899.265110233467;4989.251612258172;5027.09512287788;5037.773300201499;4963.106640804672;4972.477889821571;4982.800687972477;5021.447640759532;5032.974835125838;4756.143894099061;4847.878803029935;4912.36139301892;4988.950110498921;5003.324551185579;4892.143874821928;4894.898647804215;4904.117258893398;4909.116359055369;4947.82682606107;4860.100881336929;4879.804807807684;4908.288298196777;4909.042736666352;4927.5811556017425;5148.922766158511;5314.813981510667;5363.517283444469;5397.055515284809;5423.2949716537;5721.170430287627;5725.055365864628;5727.770889164429;5728.341240757324;5743;5611.66330020196;5762.769489220468;5768.682722450264;5770.019096753562;5781.421857814227;5333.386660534011;5387.568994480433;5394.136938089926;5429.647072940285;5439.428859969726;5867.14926335679;5873.972054890377;5874.471297583238;5878.265216847894;5914.260717410324;5519.061759500894;5641.52047075995;5644.633098848643;5662.122371032414;5710.543156547466;5737.569682273846;5739.540836733051;5746.396628354046;5784.681842498703;5791.88416231673;5716.971415142898;5729.1119876419225;5757.827265181967;5763.394843541451;5771.105478650816;5526.613137080446;5609.354924183771;5698.116791897262;5765.596408251382;5779.88440231193;4285.7000009999;4331.4152589400655;4336.436263285753;4342.848000319974;4372.6939114261695;3858.7298889078056;3879.631435013669;3883.0292426893275;3904.511936007999;3910.159315747128;5400.162974738843;5400.567954563626;5407.215953686772;5481.945180548223;5493.121100623961;5692.288463942007;5710.200571919934;5712.057510510802;5714.485696287354;5725.370209277059;5309.628326017141;5309.920351194735;5310.6813591184655;5310.6813591184655;5364.678119312854;4829.9034019319415;4847.127517046965;4902.0441014002645;4972.477889821589;4974.651774375759;5925.170476133345;5933.584649074523;5939.524838012949;5942.435468630473;5947.791827286024;5761.452661997104;5774.451427114417;5774.769009239583;5778.248827652546;5778.56660750437;5876.559258055578;5898.4101589840675;5929.762809487572;5942.881142377042;5978.910316345346;5658.151277308437;5662.85842853932;5667.574931880208;5667.688277144796;5668.206451096932;5703.20155178267;5712.0860662293835;5762.078067509178;5766.942330576809;5771.989901767258;5544.251526044094;5599.04816181242;5640.774369025357;5681.147827825859;5690.516306113861;5539;5557.638753481011;5558.333000040021;5563.471470210324;5573.052581061148;5453.590980676545;5459.508644222039;5477.917831232455;5480.479354461319;5516.448355164452;5640.71796410186;5687.9431205687415;5691.686957217227;5715.028445164416;5751.511121554548;5439.891202175855;5446.645968012067;5447.046766815871;5450.5367043801725;5487.725613719378 07:10:20 INFO - PROCESS | 10921 | |1;ext.html;636.7994081864213;640.4684112186883;647.6405594894834;650.5673726971563;656.5535435903583;35885.64114358859;36968.630313696856;37180.81409592952;37227.81386093073;37280;39800.40299395504;40305.39541906874;40413.59586404135;40487.392689109685;40499.19001619966;8609.56952152393;8802.955985220065;8808.73573792784;8812.8678069829;8824.911750882473;8657.26413254874;8769.517676527788;8772.254358379545;8790.560471976407;8793;8752.387332886701;8820;8839.823203535925;8850.778730531723;8851.513166775825;8756.956215218916;8826.382153249275;8838.027816940132;8843.557822108933;8844.55777211137;8615.827683446296;8735.388522803407;8799.516026618534;8804.679298105271;8806.075362086953;39749.80125099385;39999;40166.397504037464;40199.59800401988;40216.59783402158;3495.6504349565093;3694.0949467380397;3703.0742314421395;3916.236333914888;4131.400946862688;28736;30273.69726302731;30701.846490767628;30788.384232315453;30939;4287.528371879091;4333.696641235115;4351.129774045172;4428.070105277896;4444.533324000966;312755;313289;314161;314229;315260;53673.46326536763;55119.448805511434;55170.44829551653;55208.72395637996;55269.44730552723;52377.7381113092;57769.42230577725;58455.70772146112;60302;60401.69799150976;16047.839521604868;16187.271572779018;16281.755773663404;16286.26711797972;16294.34822607106;11970;11970.22193557416;11975.880241197476;11979.52081916731;11985.22096063753;14328.49850255236;15608.29762660683;15932.442364517186;15989.760153597705;16183.595410114842;5984.910226346608;5994.3705910878725;6036.909446358308;6075.3924607539775;6111;1060.3637817309552;1106.5739690219164;1110.7945030169444;1134.4044376702132;1146.31221267239;30295.394092118033;31436.685633143832;31491;31504.369912601618;31888.521672174935;1125.6791814332876;1141.8116010858116;1218.1655565937185;1222.1322860768776;1292.6509842342514;16547;16956.15219239033;16981.915090424467;16985.15074246283;17031.574210644587;447726;453764;454179;454261;454672;55491.445085549436;55882;55902.440975590536;55988.44011559832;56023.719881400335;1356.3625096204964;1368.0902200036865;1405.8875289976777;1461.2401551193532;1516.416179770774;27901;28650;28678.569821452278;29186.854065729534;29550.704492955654;41816;42249.577504224566;42256;42286.57713422826;42325.36511952385;224785;225741;225893;226425;226544;31601.683983159874;40926.386104207864;41089.58910410858;41370.58629413667;41537.58462415458;42087.158256835304;42593.78703106465;42914;43035.569644303156;43403.348949765146;35888.641113589576;38349.424758629204;39573.40639890346;39617.80191099142;39906.80046599865;38986.6101338983;39081.413778792776;39282.410763837994;39956;40041.39937900992;39641.2071758569;39744.230692317105;41614;42686.78656606697;42837.35743963781;31535.211619708774;33650.66349336573;34105.31789364248;34222.65777342294;34240.486392704624;26581.734182657925;26975.865120674272;27044.59433108544;27101.457970840867;27749.583756244076 07:10:20 INFO - PROCESS | 10921 | |2;jquery.html;382.3652736457481;384.54431498674063;387.8836349095271;399.7541511970139;401.3337859153804;17177;18305.176267067982;18607.255709771594;18647.627047459042;18648.06759662018;17003.82996170038;17208.225629846656;17410.303587856502;17801.910990445063;17847.73228401575;5606.971965140179;5791.652500849941;5796.710164491779;5885.7351419186025;5893.145493903381;5623.971880140593;5787.739551720161;5789.7684092636455;5816.738246778884;5827.213326200972;5684.914726279088;5763.769449222026;5771.653700777946;5774.566907481934;5781.046127388997;5606.439356064402;5708.828735137952;5731.398203188689;5741.3110426748635;5747.885042299152;5104.770285337132;5105.846824595268;5109.6167787415725;5173.948260517384;5470.370907345667;12424.56514022005;12758.170718903242;12769.297688627123;12926.482940682361;12951.935240323832;2273.4089136824377;2367.443650742074;2427.8786060696893;2478.6529885816;2856.685764565896;9835.852462213072;10698.090662293715;13409.329533523285;13672.111312764739;14352.282385880768;1917.808219178085;1927.171316333976;1964.9803501965084;1984.851136164779;2049.7847725988854;67442.3255767441;69954;72532.63733681351;73933.63033184799;73953.26046739517;10240.692779216635;10370.688879333633;10559;10894.891051089546;11382.715432114097;15176.924115379352;15375.38498460049;15382.077075375513;15384.846151538566;15388.846111538965;8061.1938806118915;8124.715634952749;8287.668493260322;8324;8362.958185209034;8063.677452901936;8066.628306117217;8174.100848906615;8257;8381.07808141104;4694.389729335233;4700.341952126705;4710.858674239778;4711.316859055486;4728.3143944127905;1923.1922592511178;1933.5359513716608;1934.4196740977932;1964.2535836382083;1971.1819594868257;924.4176169013479;1025.8459233362466;1055.3140458701753;1063.7393838509615;1102.2669924500117;18384.81615183858;18729.81270187308;19082.427527174208;19205.71191432102;19217.980848917956;972.7665360313615;998.4708104704519;1001.1990407673832;1007.1942446043137;1011.2112552209288;10404;10760.19298552596;10793.56825726962;10814.56741730322;10929.234953553176;173545;352693;353490;356998;359379;60764.69617651972;77969.22030779619;82896.58551707203;93874.53062734642;99863.00136998537;1052.315994603514;1077.2405454154803;1080.670395529371;1096.0190629386814;1101.11910471624;15949.601259968593;16061.437849675673;16097.678046438772;16109.355625774837;16270;35247;35668;36330.27339453249;38745.4188187183;40195;47285;48336;51059.63873793198;51866.48133518767;53402.46597533975;12233.816492752794;12310.753784924073;12416.565420210249;12503;12535.93732031334;13200.471981120647;13437.193768373929;13689.247091410069;13761.105528140639;13838.65403364924;6109.541784366102;8507.744767656981;11738.94130529342;12059.879401205875;12224.327661978321;10725.624603139166;11460.770784584429;11612.129090318429;11693;11959.581414650445;11315.943420283174;11652.766944660889;11795.52817887275;12024.819627705416;12358.62924112278;12145.574904878287;12186.57346992851;12211.69470763238;12251.754964900474;12435.440405181607;11040.730316013762;11064.28082174656;11067.059299959594;11112.944435278096;11142.721431964266 07:10:20 INFO - PROCESS | 10921 | |3;mootools.html;1372.2521225931878;1487.0631502153644;1539.8075240594926;1657.7927759030122;1805.1425572852897;7209.711611535538;7804.1025282092505;7984.680612775496;8000.119986801455;8007.879881801778;7679.961600191991;7788.376929845613;7810.453268271223;7845.607719614025;7850.685972561091;2015.3147929703898;2076.750789905206;2078.615456140611;2252.1104163855307;2306.1582522379376;2289.7824706652923;2380.642903564462;2383.9284821455385;2385.6183010718287;2388.128333158393;2238.6530087836413;2267.3651377614297;2267.965980510294;2274.5109801392696;2274.601944659686;1960.6274807786617;2228.6545585434123;2264.547090581882;2274.9545009099807;2276.430892276931;2321.616933206019;2340.485093279493;2342.23877239896;2342.297310806768;2343.8124950003958;7941.64262608184;7985.640646170937;7992.480488768211;7995.44031917766;7995.480293780885;4914.262860570943;5011.874703132451;5058.367704036996;5059.924101138486;5063.240513922904;3093.3040065985197;3213.389456003352;3326.6673332666783;3355.5470011548373;3360.327934413127;1130.129800053962;1150.585789115926;1178.3342411537453;1186.4660902593866;1190.6428071578578;11223.438828058564;11240.718982025433;11272.041876440513;11280.210385273034;11298.096152307795;4460.799264033061;4505.301678239878;4510.8421205257655;4560.8175672973375;4578.35902973584;9535.046495350409;9576.138147566753;9581.904180958241;9620.3746756462;9629.422234665943;5100.48995100487;5102.081625307406;5102.132637451642;5105.285260063594;5145.485451454824;4011.5186177658866;4481.955180448219;4697.530246975343;4728.692634978715;4736.502667219961;3790.241951609634;3913.5890731473355;3916.804159791999;3927.7643341399607;3983.6215559521797;1240.925544467335;1277.1060257819563;1277.8849903508542;1281.923084614926;1293.9676508087373;997.8602995580625;1000.2847963705985;1001.6494227020485;1004.8593196952432;1005.1757558801859;5681.0910254359105;5728.398518155534;5785.768569257267;5806.875886928121;5881.5000724938;445.08979137663556;449.317038102083;450.84896559652884;452.82339887443925;472.91487532244525;4138.772367519755;4246.702730808814;4273.465816772903;4321.978390108092;4349.673774466928;9475.810483790285;9899.752506187258;9943.651972180938;10025.548850301753;10052.296339256181;9673.613055477843;9680.854787178198;9718.902810971942;9746.415215087118;9835.311528192959;7292.307230813064;7314.3782778463365;7371.741989030358;7410.592417416986;7449.441291903129;5674.602777805514;5836.212111364912;5870.26621672291;5936.614120082181;6042.516598672184;9127.726168214964;9134.086591341078;9146.451212927246;9196.494192819191;9307.348485605942;8967.955160224417;9168.862467062865;9371;9474.4315341077;9596.856047159437;6622.801315960529;6830.31696830313;6836.042953986346;7445.181030086795;7550.7734767957045;7342.339189472973;7762.689492420466;7869.842603148019;7978.880316795369;7997.560134192675;7225.602591857499;7414.369778568882;7425.628718563942;7536.547807131589;7644.12092609357;7088.645567721696;7191.42468602521;7220.241874603301;7290.125184977836;7366.594837284001;6721.361470660279;6801.18385793708;6804.149481314836;6812.250652428328;6833.624150671562;4882.829100981448;5015.498450154955;5075.137226671401;5085.5931525477135;5133.024725302181;5024;5057.949420505748;5080.542751152266;5080.796768129381;5223 07:10:20 INFO - PROCESS | 10921 | |4;prototype.html;311.8253777884385;318.4411358066593;319.9104250809774;328.94901290300004;329.65550999205834;5512.972435137819;5637.21079048933;5645.983722929871;5651.660900345977;5730.312362516499;5639.661620302784;5657.32112146543;5667.574931880115;5685.289338832646;5685.943140568593;4396.89007774805;4404.471463424377;4415.359772832953;4419;4438.668399480159;4210.24215641186;4347.434833471644;4356.1723272578265;4371.300591905296;4421.425214722081;4280.486341639008;4284.464441944757;4293.012607100369;4301.548337424572;4318.330658747899;4268.9573104268875;4283.336082907154;4297.656187504992;4300.182965236626;4304.720193187432;3706.4810926470313;3752.061984503874;3758.229562939618;3760.6803421709187;3760.699144068468;5414.453532935894;5448.447192550104;5466.125419932831;5469.234307196995;5470.370907345627;4969.453360130383;4971.850844474671;4976.2038073908;4981.327520784684;4990.725510096943;5661.857668993707;5930.644161350289;5935.109733540004;5939.732712027969;5972.701364931736;4160.50073991123;4186.644135248507;4188.518320393163;4194.727342722713;4199.4330765346895;6157.415045570664;6198.597091189058;6213.751449942042;6215.347388524185;6228.408301211378;4164.354525048622;4229.196452673982;4266.360045993126;4268.829246830154;4294.0767734937135;4226.2392769301205;4282.871513854527;4288.4210631564965;4295.78521073945;4309.944063704413;4972.254161875748;4988.226824842155;4990.72551009698;4993.525615066563;5017.272495488134;5877.153999410834;5982.192404025401;5991.221141251609;6011.669358185254;6033.42682445167;1474.3733913086894;1476.1069552920544;1483.7922690823293;1496.5809573319489;1496.7081419123167;960.7982323711959;975.1808480876098;985.9704208873602;986.3736527305069;993.4684943555163;5750.137479378043;5773.595848290579;5787.681677507778;5797.101449275369;5807.796727114531;6120.17377654011;6145.033589251486;6150.77084530625;6154.19995400604;6171.660558669317;5556.805511807067;5747.281589801275;5759.510441612426;5770.365259821417;5790.392008839095;3248.8213148277073;3254.723348515403;3269.2644155065395;3279.7048265656204;3284.1132894118455;6121.479674227651;6346.555741098171;6355.1420558224045;6360.427561519486;6437.130987316746;6309.400606942333;6317.399847014526;6317.6209427434505;6323.9683801580695;6329.3354197809485;6285.340039295899;6348.841278968062;6351.269603995507;6424.38968298011;6454.741810327534;6177.62934223948;6214.067889816563;6216.875662486816;6227.937720622917;6229.283632382153;6142.262928448615;6148.9692551536955;6149.477294430024;6194.907076393948;6195.0263873340145;6108.144859719554;6207.162033125651;6398.424141827258;6403.487720982217;6413.583117097373;4078.9796051019557;4170.645495132948;4171.457710497616;4178.7283826551175;4198.769067701183;6096.390360964046;6142.600730952474;6145.170401995673;6153.353897840662;6173.444390004921;5791.13133030032;5944.227250457413;5975.790847320323;5992.8501787453915;5993.572603095753;5818.156367326798;5926.644401335933;5966.433188847052;5967.6419414835245;5969.940300597113;5830.47525722687;5852.853678658068;5865.706714664335;5871.6183448075735;5873.324567674772;5720.8569785754025;5989.311229208697;6067.605605635619;6082.482988945989;6098.75604975796;5888.882222355443;5890.558208134321;5906.350301466921;5908.9068522323505;5951.285845698544 07:10:20 INFO - PROCESS | 10921 | |5;yui.html;809.9311558517526;825.0965193113539;827.0736774812209;828.2007862412767;845.1717317029307;13800.585982420518;13815.1020183688;13895.79156312656;13997.580072597813;14215.218163001031;13634;13655.86344136561;13705.3832577534;13728.176309421442;13767.65580860479;664.372168300957;790.7904405332591;818.9303909167699;826.6321486938315;827.1645637905698;819.5041999590252;822.2558584481025;823.6622984576325;824.2787560884226;826.2274773087153;707.2750430808437;865.9177378149066;866.6576702202626;867.4795122926257;867.5228624256665;830.5265998380926;846.1284876577135;846.8899043124416;847.4533925617973;847.9321654267644;617.0251003414639;618.2951435363689;618.4434009391539;618.7246675229479;619.1053927075378;13192.6701832454;13208.537701180412;13290.867091329157;13300.201987880759;13310;13259.73480530384;13354.933225333909;13371.933140334333;13800.792988105086;13917.791233131511;11149;11169.329840209613;11227.045701115416;11411.714707132305;11598.536058557647;4462.509123996358;4512.932306015412;4583.0604726031415;4688.601468875149;4696.248600223982;50091.24863127056;50736.49263507355;50811.491885081414;52073.21890171613;52216.47783522154;10274.691759247235;10376.066154046172;10719.732006699738;10733.302335348177;10889;18127;18469.445916622524;18916.24335026611;18950.147243374082;19194.616107677768;7782.961085194538;7835.177306382861;7838;7900.960495197487;8054.194580542016;4776.689515181502;4878.146324393217;4887.437944636412;4901.877453063702;5079.898402032012;3165.8733650653717;3180.507021411685;3197.4564324064963;3201.599800024997;3216.710496055366;562.8142712904731;575.3096284458667;575.7581815637442;580.5819809737067;595.8033848829963;724.583364565377;749.9287567681062;770.6146926536732;789.8459800338878;791.8060075281593;8499.575021248913;8643.178898004806;8802.207801297915;8853.73438796837;9044.683436079706;705.8776743816036;745.1616930952679;755.3730403764972;759.3545486336681;765.7396485195061;3822.7706337619834;3977.76133431995;4005.4792876925812;4040.41413994975;4114.979425102855;56950.14574781382;57209;58294.708526457944;58489.4151058484;58744;50568.747156263984;51622.74188629033;51907.48092519102;52091;52650.47349526532;41739;42542.361864572056;48115.75942120267;48243.51756482461;49128.7543562287;8742.213200811957;8749.518776467356;8799.824003519765;8987.236084932854;9201.602269051984;30830;31467;31797.841010794797;32037.199070023435;32097.839510802296;40008.79995600003;42081.36877946772;42735.572644274405;43864.780676096416;44147.558524414344;11027.17296202772;11183.32900026001;11406.372649504357;11704.94147529257;11838;11242.381669008282;12217.694557635774;12454.735706472578;12869.227846328875;12999.805002925154;12343.567975120828;12810.423530941316;12846.935765321114;12888.355582220664;13357.866421335662;12391.690207744517;12595;12701.920336771109;12727.872721272668;12778.169418987736;12363.505459781509;12606.117571769888;12625.242485450903;12711.427985740478;13153.736925261632;9576.377535460173;9647.179989700953;9760.023997600183;9866.85199722019;9998.150157236716;10185.134263587677;10398.376097434179;10458.320209186379;10463.215258855464;10508.159347252049 07:10:20 INFO - PROCESS | 10921 | __end_tp_report 07:10:20 INFO - PROCESS | 10921 | __start_cc_report 07:10:20 INFO - PROCESS | 10921 | _x_x_mozilla_cycle_collect,745 07:10:20 INFO - PROCESS | 10921 | __end_cc_report 07:10:20 INFO - PROCESS | 10921 | __startTimestamp1461334220806__endTimestamp 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | ------- Summary: start ------- 07:10:20 INFO - PROCESS | 10921 | Number of tests: 6 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | [#0] dojo.html Cycles:165 Average:5330.15 Median:5487.73 stddev:598.62 (10.9%) stddev-sans-first:573.58 07:10:20 INFO - PROCESS | 10921 | Values: 3069.3 3137.6 3143.4 3187.8 3217.7 5259.7 5345.9 5374.9 5376.3 5476.7 5310.4 5330.3 5366.1 5390.0 5414.0 4838.8 4899.3 4989.3 5027.1 5037.8 4963.1 4972.5 4982.8 5021.4 5033.0 4756.1 4847.9 4912.4 4989.0 5003.3 4892.1 4894.9 4904.1 4909.1 4947.8 4860.1 4879.8 4908.3 4909.0 4927.6 5148.9 5314.8 5363.5 5397.1 5423.3 5721.2 5725.1 5727.8 5728.3 5743.0 5611.7 5762.8 5768.7 5770.0 5781.4 5333.4 5387.6 5394.1 5429.6 5439.4 5867.1 5874.0 5874.5 5878.3 5914.3 5519.1 5641.5 5644.6 5662.1 5710.5 5737.6 5739.5 5746.4 5784.7 5791.9 5717.0 5729.1 5757.8 5763.4 5771.1 5526.6 5609.4 5698.1 5765.6 5779.9 4285.7 4331.4 4336.4 4342.8 4372.7 3858.7 3879.6 3883.0 3904.5 3910.2 5400.2 5400.6 5407.2 5481.9 5493.1 5692.3 5710.2 5712.1 5714.5 5725.4 5309.6 5309.9 5310.7 5310.7 5364.7 4829.9 4847.1 4902.0 4972.5 4974.7 5925.2 5933.6 5939.5 5942.4 5947.8 5761.5 5774.5 5774.8 5778.2 5778.6 5876.6 5898.4 5929.8 5942.9 5978.9 5658.2 5662.9 5667.6 5667.7 5668.2 5703.2 5712.1 5762.1 5766.9 5772.0 5544.3 5599.0 5640.8 5681.1 5690.5 5539.0 5557.6 5558.3 5563.5 5573.1 5453.6 5459.5 5477.9 5480.5 5516.4 5640.7 5687.9 5691.7 5715.0 5751.5 5439.9 5446.6 5447.0 5450.5 5487.7 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | [#1] ext.html Cycles:180 Average:49905.93 Median:39853.60 stddev:90785.77 (227.8%) stddev-sans-first:90965.09 07:10:20 INFO - PROCESS | 10921 | Values: 636.8 640.5 647.6 650.6 656.6 35885.6 36968.6 37180.8 37227.8 37280.0 39800.4 40305.4 40413.6 40487.4 40499.2 8609.6 8803.0 8808.7 8812.9 8824.9 8657.3 8769.5 8772.3 8790.6 8793.0 8752.4 8820.0 8839.8 8850.8 8851.5 8757.0 8826.4 8838.0 8843.6 8844.6 8615.8 8735.4 8799.5 8804.7 8806.1 39749.8 39999.0 40166.4 40199.6 40216.6 3495.7 3694.1 3703.1 3916.2 4131.4 28736.0 30273.7 30701.8 30788.4 30939.0 4287.5 4333.7 4351.1 4428.1 4444.5 312755.0 313289.0 314161.0 314229.0 315260.0 53673.5 55119.4 55170.4 55208.7 55269.4 52377.7 57769.4 58455.7 60302.0 60401.7 16047.8 16187.3 16281.8 16286.3 16294.3 11970.0 11970.2 11975.9 11979.5 11985.2 14328.5 15608.3 15932.4 15989.8 16183.6 5984.9 5994.4 6036.9 6075.4 6111.0 1060.4 1106.6 1110.8 1134.4 1146.3 30295.4 31436.7 31491.0 31504.4 31888.5 1125.7 1141.8 1218.2 1222.1 1292.7 16547.0 16956.2 16981.9 16985.2 17031.6 447726.0 453764.0 454179.0 454261.0 454672.0 55491.4 55882.0 55902.4 55988.4 56023.7 1356.4 1368.1 1405.9 1461.2 1516.4 27901.0 28650.0 28678.6 29186.9 29550.7 41816.0 42249.6 42256.0 42286.6 42325.4 224785.0 225741.0 225893.0 226425.0 226544.0 31601.7 40926.4 41089.6 41370.6 41537.6 42087.2 42593.8 42914.0 43035.6 43403.3 35888.6 38349.4 39573.4 39617.8 39906.8 38986.6 39081.4 39282.4 39956.0 40041.4 39641.2 39744.2 41614.0 42686.8 42837.4 31535.2 33650.7 34105.3 34222.7 34240.5 26581.7 26975.9 27044.6 27101.5 27749.6 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | [#2] jquery.html Cycles:180 Average:23227.31 Median:10570.59 stddev:54748.32 (517.9%) stddev-sans-first:54875.03 07:10:20 INFO - PROCESS | 10921 | Values: 382.4 384.5 387.9 399.8 401.3 17177.0 18305.2 18607.3 18647.6 18648.1 17003.8 17208.2 17410.3 17801.9 17847.7 5607.0 5791.7 5796.7 5885.7 5893.1 5624.0 5787.7 5789.8 5816.7 5827.2 5684.9 5763.8 5771.7 5774.6 5781.0 5606.4 5708.8 5731.4 5741.3 5747.9 5104.8 5105.8 5109.6 5173.9 5470.4 12424.6 12758.2 12769.3 12926.5 12951.9 2273.4 2367.4 2427.9 2478.7 2856.7 9835.9 10698.1 13409.3 13672.1 14352.3 1917.8 1927.2 1965.0 1984.9 2049.8 67442.3 69954.0 72532.6 73933.6 73953.3 10240.7 10370.7 10559.0 10894.9 11382.7 15176.9 15375.4 15382.1 15384.8 15388.8 8061.2 8124.7 8287.7 8324.0 8363.0 8063.7 8066.6 8174.1 8257.0 8381.1 4694.4 4700.3 4710.9 4711.3 4728.3 1923.2 1933.5 1934.4 1964.3 1971.2 924.4 1025.8 1055.3 1063.7 1102.3 18384.8 18729.8 19082.4 19205.7 19218.0 972.8 998.5 1001.2 1007.2 1011.2 10404.0 10760.2 10793.6 10814.6 10929.2 173545.0 352693.0 353490.0 356998.0 359379.0 60764.7 77969.2 82896.6 93874.5 99863.0 1052.3 1077.2 1080.7 1096.0 1101.1 15949.6 16061.4 16097.7 16109.4 16270.0 35247.0 35668.0 36330.3 38745.4 40195.0 47285.0 48336.0 51059.6 51866.5 53402.5 12233.8 12310.8 12416.6 12503.0 12535.9 13200.5 13437.2 13689.2 13761.1 13838.7 6109.5 8507.7 11738.9 12059.9 12224.3 10725.6 11460.8 11612.1 11693.0 11959.6 11315.9 11652.8 11795.5 12024.8 12358.6 12145.6 12186.6 12211.7 12251.8 12435.4 11040.7 11064.3 11067.1 11112.9 11142.7 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | [#3] mootools.html Cycles:180 Average:5428.44 Median:5077.84 stddev:2961.51 (58.3%) stddev-sans-first:2954.13 07:10:20 INFO - PROCESS | 10921 | Values: 1372.3 1487.1 1539.8 1657.8 1805.1 7209.7 7804.1 7984.7 8000.1 8007.9 7680.0 7788.4 7810.5 7845.6 7850.7 2015.3 2076.8 2078.6 2252.1 2306.2 2289.8 2380.6 2383.9 2385.6 2388.1 2238.7 2267.4 2268.0 2274.5 2274.6 1960.6 2228.7 2264.5 2275.0 2276.4 2321.6 2340.5 2342.2 2342.3 2343.8 7941.6 7985.6 7992.5 7995.4 7995.5 4914.3 5011.9 5058.4 5059.9 5063.2 3093.3 3213.4 3326.7 3355.5 3360.3 1130.1 1150.6 1178.3 1186.5 1190.6 11223.4 11240.7 11272.0 11280.2 11298.1 4460.8 4505.3 4510.8 4560.8 4578.4 9535.0 9576.1 9581.9 9620.4 9629.4 5100.5 5102.1 5102.1 5105.3 5145.5 4011.5 4482.0 4697.5 4728.7 4736.5 3790.2 3913.6 3916.8 3927.8 3983.6 1240.9 1277.1 1277.9 1281.9 1294.0 997.9 1000.3 1001.6 1004.9 1005.2 5681.1 5728.4 5785.8 5806.9 5881.5 445.1 449.3 450.8 452.8 472.9 4138.8 4246.7 4273.5 4322.0 4349.7 9475.8 9899.8 9943.7 10025.5 10052.3 9673.6 9680.9 9718.9 9746.4 9835.3 7292.3 7314.4 7371.7 7410.6 7449.4 5674.6 5836.2 5870.3 5936.6 6042.5 9127.7 9134.1 9146.5 9196.5 9307.3 8968.0 9168.9 9371.0 9474.4 9596.9 6622.8 6830.3 6836.0 7445.2 7550.8 7342.3 7762.7 7869.8 7978.9 7997.6 7225.6 7414.4 7425.6 7536.5 7644.1 7088.6 7191.4 7220.2 7290.1 7366.6 6721.4 6801.2 6804.1 6812.3 6833.6 4882.8 5015.5 5075.1 5085.6 5133.0 5024.0 5057.9 5080.5 5080.8 5223.0 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | [#4] prototype.html Cycles:180 Average:4998.41 Median:5764.94 stddev:1509.05 (26.2%) stddev-sans-first:1471.71 07:10:20 INFO - PROCESS | 10921 | Values: 311.8 318.4 319.9 328.9 329.7 5513.0 5637.2 5646.0 5651.7 5730.3 5639.7 5657.3 5667.6 5685.3 5685.9 4396.9 4404.5 4415.4 4419.0 4438.7 4210.2 4347.4 4356.2 4371.3 4421.4 4280.5 4284.5 4293.0 4301.5 4318.3 4269.0 4283.3 4297.7 4300.2 4304.7 3706.5 3752.1 3758.2 3760.7 3760.7 5414.5 5448.4 5466.1 5469.2 5470.4 4969.5 4971.9 4976.2 4981.3 4990.7 5661.9 5930.6 5935.1 5939.7 5972.7 4160.5 4186.6 4188.5 4194.7 4199.4 6157.4 6198.6 6213.8 6215.3 6228.4 4164.4 4229.2 4266.4 4268.8 4294.1 4226.2 4282.9 4288.4 4295.8 4309.9 4972.3 4988.2 4990.7 4993.5 5017.3 5877.2 5982.2 5991.2 6011.7 6033.4 1474.4 1476.1 1483.8 1496.6 1496.7 960.8 975.2 986.0 986.4 993.5 5750.1 5773.6 5787.7 5797.1 5807.8 6120.2 6145.0 6150.8 6154.2 6171.7 5556.8 5747.3 5759.5 5770.4 5790.4 3248.8 3254.7 3269.3 3279.7 3284.1 6121.5 6346.6 6355.1 6360.4 6437.1 6309.4 6317.4 6317.6 6324.0 6329.3 6285.3 6348.8 6351.3 6424.4 6454.7 6177.6 6214.1 6216.9 6227.9 6229.3 6142.3 6149.0 6149.5 6194.9 6195.0 6108.1 6207.2 6398.4 6403.5 6413.6 4079.0 4170.6 4171.5 4178.7 4198.8 6096.4 6142.6 6145.2 6153.4 6173.4 5791.1 5944.2 5975.8 5992.9 5993.6 5818.2 5926.6 5966.4 5967.6 5969.9 5830.5 5852.9 5865.7 5871.6 5873.3 5720.9 5989.3 6067.6 6082.5 6098.8 5888.9 5890.6 5906.4 5908.9 5951.3 07:10:20 INFO - PROCESS | 10921 | 07:10:20 INFO - PROCESS | 10921 | [#5] yui.html Cycles:180 Average:14092.61 Median:4692.43 stddev:15897.21 (338.8%) stddev-sans-first:15910.51 07:10:20 INFO - PROCESS | 10921 | Values: 809.9 825.1 827.1 828.2 845.2 13800.6 13815.1 13895.8 13997.6 14215.2 13634.0 13655.9 13705.4 13728.2 13767.7 664.4 790.8 818.9 826.6 827.2 819.5 822.3 823.7 824.3 826.2 707.3 865.9 866.7 867.5 867.5 830.5 846.1 846.9 847.5 847.9 617.0 618.3 618.4 618.7 619.1 13192.7 13208.5 13290.9 13300.2 13310.0 13259.7 13354.9 13371.9 13800.8 13917.8 11149.0 11169.3 11227.0 11411.7 11598.5 4462.5 4512.9 4583.1 4688.6 4696.2 50091.2 50736.5 50811.5 52073.2 52216.5 10274.7 10376.1 10719.7 10733.3 10889.0 18127.0 18469.4 18916.2 18950.1 19194.6 7783.0 7835.2 7838.0 7901.0 8054.2 4776.7 4878.1 4887.4 4901.9 5079.9 3165.9 3180.5 3197.5 3201.6 3216.7 562.8 575.3 575.8 580.6 595.8 724.6 749.9 770.6 789.8 791.8 8499.6 8643.2 8802.2 8853.7 9044.7 705.9 745.2 755.4 759.4 765.7 3822.8 3977.8 4005.5 4040.4 4115.0 56950.1 57209.0 58294.7 58489.4 58744.0 50568.7 51622.7 51907.5 52091.0 52650.5 41739.0 42542.4 48115.8 48243.5 49128.8 8742.2 8749.5 8799.8 8987.2 9201.6 30830.0 31467.0 31797.8 32037.2 32097.8 40008.8 42081.4 42735.6 43864.8 44147.6 11027.2 11183.3 11406.4 11704.9 11838.0 11242.4 12217.7 12454.7 12869.2 12999.8 12343.6 12810.4 12846.9 12888.4 13357.9 12391.7 12595.0 12701.9 12727.9 12778.2 12363.5 12606.1 12625.2 12711.4 13153.7 9576.4 9647.2 9760.0 9866.9 9998.2 10185.1 10398.4 10458.3 10463.2 10508.2 07:10:20 INFO - PROCESS | 10921 | -------- Summary: end -------- 07:10:20 INFO - PROCESS | 10921 | 07:10:21 INFO - TEST-INFO | 10921: exit 0 07:10:21 INFO - TEST-OK | dromaeo_css | took 1111608ms 07:10:21 INFO - TEST-START | kraken 07:10:21 INFO - operating with platform_type : linux_ 07:10:21 INFO - Initialising browser for kraken test... 07:10:21 INFO - TEST-INFO | started process 11097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZhGw6/profile http://localhost:49924/getInfo.html) 07:10:25 INFO - PROCESS | 11097 | __metrics Screen width/height:1600/1200 07:10:25 INFO - PROCESS | 11097 | colorDepth:24 07:10:25 INFO - PROCESS | 11097 | Browser inner width/height: 1024/697 07:10:25 INFO - PROCESS | 11097 | __metrics 07:10:26 ERROR - PROCESS | 11097 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:10:27 INFO - TEST-INFO | 11097: exit 0 07:10:27 INFO - Browser initialized. 07:10:27 INFO - Running cycle 1/1 for kraken test... 07:10:27 INFO - TEST-INFO | started process 11178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZhGw6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:38 INFO - PROCESS | 11178 | RSS: Main: 153042944 07:10:38 INFO - PROCESS | 11178 | 07:10:41 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49924/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:42 INFO - PROCESS | 11178 | RSS: Main: 209260544 07:10:42 INFO - PROCESS | 11178 | 07:10:44 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49924/tests/kraken/driver.html?testName=audio-dft) 07:10:45 INFO - PROCESS | 11178 | RSS: Main: 193728512 07:10:45 INFO - PROCESS | 11178 | 07:10:48 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49924/tests/kraken/driver.html?testName=audio-fft) 07:10:49 INFO - PROCESS | 11178 | RSS: Main: 265248768 07:10:49 INFO - PROCESS | 11178 | 07:10:51 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49924/tests/kraken/driver.html?testName=audio-oscillator) 07:10:51 INFO - PROCESS | 11178 | RSS: Main: 173309952 07:10:51 INFO - PROCESS | 11178 | 07:10:54 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:54 INFO - PROCESS | 11178 | RSS: Main: 177590272 07:10:54 INFO - PROCESS | 11178 | 07:10:57 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49924/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:58 INFO - PROCESS | 11178 | RSS: Main: 213512192 07:10:58 INFO - PROCESS | 11178 | 07:11:01 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49924/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:02 INFO - PROCESS | 11178 | RSS: Main: 213962752 07:11:02 INFO - PROCESS | 11178 | 07:11:04 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49924/tests/kraken/driver.html?testName=json-parse-financial) 07:11:05 INFO - PROCESS | 11178 | RSS: Main: 214503424 07:11:05 INFO - PROCESS | 11178 | 07:11:07 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:07 INFO - PROCESS | 11178 | RSS: Main: 201777152 07:11:07 INFO - PROCESS | 11178 | 07:11:09 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:10 INFO - PROCESS | 11178 | RSS: Main: 201457664 07:11:10 INFO - PROCESS | 11178 | 07:11:11 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:12 INFO - PROCESS | 11178 | RSS: Main: 216342528 07:11:12 INFO - PROCESS | 11178 | 07:11:15 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:15 INFO - PROCESS | 11178 | RSS: Main: 219480064 07:11:15 INFO - PROCESS | 11178 | 07:11:18 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:19 INFO - PROCESS | 11178 | RSS: Main: 216727552 07:11:19 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | Cycle 1(1): loaded http://localhost:49924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49924/tests/kraken/driver.html?testName=ai-astar) 07:11:21 INFO - PROCESS | 11178 | RSS: Main: 281247744 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | __start_tp_report 07:11:21 INFO - PROCESS | 11178 | _x_x_mozilla_page_load 07:11:21 INFO - PROCESS | 11178 | _x_x_mozilla_page_load_details 07:11:21 INFO - PROCESS | 11178 | |i|pagename|runs| 07:11:21 INFO - PROCESS | 11178 | |0;ai-astar;111;113;107;111;112;113;101;112;112;111 07:11:21 INFO - PROCESS | 11178 | |1;audio-beat-detection;151;124;153;194;129;156;151;136;175;137 07:11:21 INFO - PROCESS | 11178 | |2;audio-dft;161;163;161;160;161;161;160;162;162;161 07:11:21 INFO - PROCESS | 11178 | |3;audio-fft;77;73;114;106;73;72;73;135;100;74 07:11:21 INFO - PROCESS | 11178 | |4;audio-oscillator;92;92;160;93;93;93;151;92;93;144 07:11:21 INFO - PROCESS | 11178 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;116;116;117 07:11:21 INFO - PROCESS | 11178 | |6;imaging-darkroom;145;145;146;146;146;146;146;146;145;145 07:11:21 INFO - PROCESS | 11178 | |7;imaging-desaturate;94;94;94;95;94;95;94;95;95;94 07:11:21 INFO - PROCESS | 11178 | |8;json-parse-financial;56;57;56;57;58;57;57;69;55;55 07:11:21 INFO - PROCESS | 11178 | |9;json-stringify-tinderbox;61;61;61;61;62;62;61;62;62;61 07:11:21 INFO - PROCESS | 11178 | |10;stanford-crypto-aes;77;88;76;83;77;77;77;77;77;77 07:11:21 INFO - PROCESS | 11178 | |11;stanford-crypto-ccm;132;128;129;125;136;128;127;123;207;123 07:11:21 INFO - PROCESS | 11178 | |12;stanford-crypto-pbkdf2;166;164;175;163;168;165;165;167;170;168 07:11:21 INFO - PROCESS | 11178 | |13;stanford-crypto-sha256-iterative;68;69;69;67;66;66;65;67;67;66 07:11:21 INFO - PROCESS | 11178 | __end_tp_report 07:11:21 INFO - PROCESS | 11178 | __start_cc_report 07:11:21 INFO - PROCESS | 11178 | _x_x_mozilla_cycle_collect,1606 07:11:21 INFO - PROCESS | 11178 | __end_cc_report 07:11:21 INFO - PROCESS | 11178 | __startTimestamp1461334281256__endTimestamp 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | ------- Summary: start ------- 07:11:21 INFO - PROCESS | 11178 | Number of tests: 14 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.68 (3.3%) stddev-sans-first:3.90 07:11:21 INFO - PROCESS | 11178 | Values: 111.0 113.0 107.0 111.0 112.0 113.0 101.0 112.0 112.0 111.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:152.00 stddev:21.31 (14.0%) stddev-sans-first:22.60 07:11:21 INFO - PROCESS | 11178 | Values: 151.0 124.0 153.0 194.0 129.0 156.0 151.0 136.0 175.0 137.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:11:21 INFO - PROCESS | 11178 | Values: 161.0 163.0 161.0 160.0 161.0 161.0 160.0 162.0 162.0 161.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#3] audio-fft Cycles:10 Average:89.70 Median:73.00 stddev:22.54 (30.9%) stddev-sans-first:23.43 07:11:21 INFO - PROCESS | 11178 | Values: 77.0 73.0 114.0 106.0 73.0 72.0 73.0 135.0 100.0 74.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.50 stddev:28.80 (31.1%) stddev-sans-first:29.77 07:11:21 INFO - PROCESS | 11178 | Values: 92.0 92.0 160.0 93.0 93.0 93.0 151.0 92.0 93.0 144.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:11:21 INFO - PROCESS | 11178 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:11:21 INFO - PROCESS | 11178 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:11:21 INFO - PROCESS | 11178 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:4.08 (7.2%) stddev-sans-first:4.28 07:11:21 INFO - PROCESS | 11178 | Values: 56.0 57.0 56.0 57.0 58.0 57.0 57.0 69.0 55.0 55.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:11:21 INFO - PROCESS | 11178 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 61.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.00 stddev:3.84 (5.0%) stddev-sans-first:4.02 07:11:21 INFO - PROCESS | 11178 | Values: 77.0 88.0 76.0 83.0 77.0 77.0 77.0 77.0 77.0 77.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:128.50 stddev:25.33 (19.7%) stddev-sans-first:26.83 07:11:21 INFO - PROCESS | 11178 | Values: 132.0 128.0 129.0 125.0 136.0 128.0 127.0 123.0 207.0 123.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.50 stddev:3.48 (2.1%) stddev-sans-first:3.67 07:11:21 INFO - PROCESS | 11178 | Values: 166.0 164.0 175.0 163.0 168.0 165.0 165.0 167.0 170.0 168.0 07:11:21 INFO - PROCESS | 11178 | 07:11:21 INFO - PROCESS | 11178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 07:11:21 INFO - PROCESS | 11178 | Values: 68.0 69.0 69.0 67.0 66.0 66.0 65.0 67.0 67.0 66.0 07:11:21 INFO - PROCESS | 11178 | -------- Summary: end -------- 07:11:21 INFO - PROCESS | 11178 | 07:11:22 INFO - TEST-INFO | 11178: exit 0 07:11:22 INFO - TEST-OK | kraken | took 60622ms 07:11:22 INFO - SUITE-END | took 1172s 07:11:22 INFO - Completed test suite (00:19:32) 07:11:22 INFO - javascript benchmark 07:11:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.309405383788, 3137.560741496191, 3143.4498962681523, 3187.82466964317, 3217.7425805935527, 5259.737013149346, 5345.866353341168, 5374.865628359288, 5376.274202982601, 5476.698781567017, 5310.4424035476295, 5330.333708286465, 5366.141417373211, 5390.029794636964, 5414.0254754144335, 4838.758062096898, 4899.265110233467, 4989.251612258172, 5027.09512287788, 5037.773300201499, 4963.106640804672, 4972.477889821571, 4982.800687972477, 5021.447640759532, 5032.974835125838, 4756.143894099061, 4847.878803029935, 4912.36139301892, 4988.950110498921, 5003.324551185579, 4892.143874821928, 4894.898647804215, 4904.117258893398, 4909.116359055369, 4947.82682606107, 4860.100881336929, 4879.804807807684, 4908.288298196777, 4909.042736666352, 4927.5811556017425, 5148.922766158511, 5314.813981510667, 5363.517283444469, 5397.055515284809, 5423.2949716537, 5721.170430287627, 5725.055365864628, 5727.770889164429, 5728.341240757324, 5743.0, 5611.66330020196, 5762.769489220468, 5768.682722450264, 5770.019096753562, 5781.421857814227, 5333.386660534011, 5387.568994480433, 5394.136938089926, 5429.647072940285, 5439.428859969726, 5867.14926335679, 5873.972054890377, 5874.471297583238, 5878.265216847894, 5914.260717410324, 5519.061759500894, 5641.52047075995, 5644.633098848643, 5662.122371032414, 5710.543156547466, 5737.569682273846, 5739.540836733051, 5746.396628354046, 5784.681842498703, 5791.88416231673, 5716.971415142898, 5729.1119876419225, 5757.827265181967, 5763.394843541451, 5771.105478650816, 5526.613137080446, 5609.354924183771, 5698.116791897262, 5765.596408251382, 5779.88440231193, 4285.7000009999, 4331.4152589400655, 4336.436263285753, 4342.848000319974, 4372.6939114261695, 3858.7298889078056, 3879.631435013669, 3883.0292426893275, 3904.511936007999, 3910.159315747128, 5400.162974738843, 5400.567954563626, 5407.215953686772, 5481.945180548223, 5493.121100623961, 5692.288463942007, 5710.200571919934, 5712.057510510802, 5714.485696287354, 5725.370209277059, 5309.628326017141, 5309.920351194735, 5310.6813591184655, 5310.6813591184655, 5364.678119312854, 4829.9034019319415, 4847.127517046965, 4902.0441014002645, 4972.477889821589, 4974.651774375759, 5925.170476133345, 5933.584649074523, 5939.524838012949, 5942.435468630473, 5947.791827286024, 5761.452661997104, 5774.451427114417, 5774.769009239583, 5778.248827652546, 5778.56660750437, 5876.559258055578, 5898.4101589840675, 5929.762809487572, 5942.881142377042, 5978.910316345346, 5658.151277308437, 5662.85842853932, 5667.574931880208, 5667.688277144796, 5668.206451096932, 5703.20155178267, 5712.0860662293835, 5762.078067509178, 5766.942330576809, 5771.989901767258, 5544.251526044094, 5599.04816181242, 5640.774369025357, 5681.147827825859, 5690.516306113861, 5539.0, 5557.638753481011, 5558.333000040021, 5563.471470210324, 5573.052581061148, 5453.590980676545, 5459.508644222039, 5477.917831232455, 5480.479354461319, 5516.448355164452, 5640.71796410186, 5687.9431205687415, 5691.686957217227, 5715.028445164416, 5751.511121554548, 5439.891202175855, 5446.645968012067, 5447.046766815871, 5450.5367043801725, 5487.725613719378], "value": 5290.248395007677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.7994081864213, 640.4684112186883, 647.6405594894834, 650.5673726971563, 656.5535435903583, 35885.64114358859, 36968.630313696856, 37180.81409592952, 37227.81386093073, 37280.0, 39800.40299395504, 40305.39541906874, 40413.59586404135, 40487.392689109685, 40499.19001619966, 8609.56952152393, 8802.955985220065, 8808.73573792784, 8812.8678069829, 8824.911750882473, 8657.26413254874, 8769.517676527788, 8772.254358379545, 8790.560471976407, 8793.0, 8752.387332886701, 8820.0, 8839.823203535925, 8850.778730531723, 8851.513166775825, 8756.956215218916, 8826.382153249275, 8838.027816940132, 8843.557822108933, 8844.55777211137, 8615.827683446296, 8735.388522803407, 8799.516026618534, 8804.679298105271, 8806.075362086953, 39749.80125099385, 39999.0, 40166.397504037464, 40199.59800401988, 40216.59783402158, 3495.6504349565093, 3694.0949467380397, 3703.0742314421395, 3916.236333914888, 4131.400946862688, 28736.0, 30273.69726302731, 30701.846490767628, 30788.384232315453, 30939.0, 4287.528371879091, 4333.696641235115, 4351.129774045172, 4428.070105277896, 4444.533324000966, 312755.0, 313289.0, 314161.0, 314229.0, 315260.0, 53673.46326536763, 55119.448805511434, 55170.44829551653, 55208.72395637996, 55269.44730552723, 52377.7381113092, 57769.42230577725, 58455.70772146112, 60302.0, 60401.69799150976, 16047.839521604868, 16187.271572779018, 16281.755773663404, 16286.26711797972, 16294.34822607106, 11970.0, 11970.22193557416, 11975.880241197476, 11979.52081916731, 11985.22096063753, 14328.49850255236, 15608.29762660683, 15932.442364517186, 15989.760153597705, 16183.595410114842, 5984.910226346608, 5994.3705910878725, 6036.909446358308, 6075.3924607539775, 6111.0, 1060.3637817309552, 1106.5739690219164, 1110.7945030169444, 1134.4044376702132, 1146.31221267239, 30295.394092118033, 31436.685633143832, 31491.0, 31504.369912601618, 31888.521672174935, 1125.6791814332876, 1141.8116010858116, 1218.1655565937185, 1222.1322860768776, 1292.6509842342514, 16547.0, 16956.15219239033, 16981.915090424467, 16985.15074246283, 17031.574210644587, 447726.0, 453764.0, 454179.0, 454261.0, 454672.0, 55491.445085549436, 55882.0, 55902.440975590536, 55988.44011559832, 56023.719881400335, 1356.3625096204964, 1368.0902200036865, 1405.8875289976777, 1461.2401551193532, 1516.416179770774, 27901.0, 28650.0, 28678.569821452278, 29186.854065729534, 29550.704492955654, 41816.0, 42249.577504224566, 42256.0, 42286.57713422826, 42325.36511952385, 224785.0, 225741.0, 225893.0, 226425.0, 226544.0, 31601.683983159874, 40926.386104207864, 41089.58910410858, 41370.58629413667, 41537.58462415458, 42087.158256835304, 42593.78703106465, 42914.0, 43035.569644303156, 43403.348949765146, 35888.641113589576, 38349.424758629204, 39573.40639890346, 39617.80191099142, 39906.80046599865, 38986.6101338983, 39081.413778792776, 39282.410763837994, 39956.0, 40041.39937900992, 39641.2071758569, 39744.230692317105, 41614.0, 42686.78656606697, 42837.35743963781, 31535.211619708774, 33650.66349336573, 34105.31789364248, 34222.65777342294, 34240.486392704624, 26581.734182657925, 26975.865120674272, 27044.59433108544, 27101.457970840867, 27749.583756244076], "value": 19072.955054321686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.3652736457481, 384.54431498674063, 387.8836349095271, 399.7541511970139, 401.3337859153804, 17177.0, 18305.176267067982, 18607.255709771594, 18647.627047459042, 18648.06759662018, 17003.82996170038, 17208.225629846656, 17410.303587856502, 17801.910990445063, 17847.73228401575, 5606.971965140179, 5791.652500849941, 5796.710164491779, 5885.7351419186025, 5893.145493903381, 5623.971880140593, 5787.739551720161, 5789.7684092636455, 5816.738246778884, 5827.213326200972, 5684.914726279088, 5763.769449222026, 5771.653700777946, 5774.566907481934, 5781.046127388997, 5606.439356064402, 5708.828735137952, 5731.398203188689, 5741.3110426748635, 5747.885042299152, 5104.770285337132, 5105.846824595268, 5109.6167787415725, 5173.948260517384, 5470.370907345667, 12424.56514022005, 12758.170718903242, 12769.297688627123, 12926.482940682361, 12951.935240323832, 2273.4089136824377, 2367.443650742074, 2427.8786060696893, 2478.6529885816, 2856.685764565896, 9835.852462213072, 10698.090662293715, 13409.329533523285, 13672.111312764739, 14352.282385880768, 1917.808219178085, 1927.171316333976, 1964.9803501965084, 1984.851136164779, 2049.7847725988854, 67442.3255767441, 69954.0, 72532.63733681351, 73933.63033184799, 73953.26046739517, 10240.692779216635, 10370.688879333633, 10559.0, 10894.891051089546, 11382.715432114097, 15176.924115379352, 15375.38498460049, 15382.077075375513, 15384.846151538566, 15388.846111538965, 8061.1938806118915, 8124.715634952749, 8287.668493260322, 8324.0, 8362.958185209034, 8063.677452901936, 8066.628306117217, 8174.100848906615, 8257.0, 8381.07808141104, 4694.389729335233, 4700.341952126705, 4710.858674239778, 4711.316859055486, 4728.3143944127905, 1923.1922592511178, 1933.5359513716608, 1934.4196740977932, 1964.2535836382083, 1971.1819594868257, 924.4176169013479, 1025.8459233362466, 1055.3140458701753, 1063.7393838509615, 1102.2669924500117, 18384.81615183858, 18729.81270187308, 19082.427527174208, 19205.71191432102, 19217.980848917956, 972.7665360313615, 998.4708104704519, 1001.1990407673832, 1007.1942446043137, 1011.2112552209288, 10404.0, 10760.19298552596, 10793.56825726962, 10814.56741730322, 10929.234953553176, 173545.0, 352693.0, 353490.0, 356998.0, 359379.0, 60764.69617651972, 77969.22030779619, 82896.58551707203, 93874.53062734642, 99863.00136998537, 1052.315994603514, 1077.2405454154803, 1080.670395529371, 1096.0190629386814, 1101.11910471624, 15949.601259968593, 16061.437849675673, 16097.678046438772, 16109.355625774837, 16270.0, 35247.0, 35668.0, 36330.27339453249, 38745.4188187183, 40195.0, 47285.0, 48336.0, 51059.63873793198, 51866.48133518767, 53402.46597533975, 12233.816492752794, 12310.753784924073, 12416.565420210249, 12503.0, 12535.93732031334, 13200.471981120647, 13437.193768373929, 13689.247091410069, 13761.105528140639, 13838.65403364924, 6109.541784366102, 8507.744767656981, 11738.94130529342, 12059.879401205875, 12224.327661978321, 10725.624603139166, 11460.770784584429, 11612.129090318429, 11693.0, 11959.581414650445, 11315.943420283174, 11652.766944660889, 11795.52817887275, 12024.819627705416, 12358.62924112278, 12145.574904878287, 12186.57346992851, 12211.69470763238, 12251.754964900474, 12435.440405181607, 11040.730316013762, 11064.28082174656, 11067.059299959594, 11112.944435278096, 11142.721431964266], "value": 9004.459547931046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.2521225931878, 1487.0631502153644, 1539.8075240594926, 1657.7927759030122, 1805.1425572852897, 7209.711611535538, 7804.1025282092505, 7984.680612775496, 8000.119986801455, 8007.879881801778, 7679.961600191991, 7788.376929845613, 7810.453268271223, 7845.607719614025, 7850.685972561091, 2015.3147929703898, 2076.750789905206, 2078.615456140611, 2252.1104163855307, 2306.1582522379376, 2289.7824706652923, 2380.642903564462, 2383.9284821455385, 2385.6183010718287, 2388.128333158393, 2238.6530087836413, 2267.3651377614297, 2267.965980510294, 2274.5109801392696, 2274.601944659686, 1960.6274807786617, 2228.6545585434123, 2264.547090581882, 2274.9545009099807, 2276.430892276931, 2321.616933206019, 2340.485093279493, 2342.23877239896, 2342.297310806768, 2343.8124950003958, 7941.64262608184, 7985.640646170937, 7992.480488768211, 7995.44031917766, 7995.480293780885, 4914.262860570943, 5011.874703132451, 5058.367704036996, 5059.924101138486, 5063.240513922904, 3093.3040065985197, 3213.389456003352, 3326.6673332666783, 3355.5470011548373, 3360.327934413127, 1130.129800053962, 1150.585789115926, 1178.3342411537453, 1186.4660902593866, 1190.6428071578578, 11223.438828058564, 11240.718982025433, 11272.041876440513, 11280.210385273034, 11298.096152307795, 4460.799264033061, 4505.301678239878, 4510.8421205257655, 4560.8175672973375, 4578.35902973584, 9535.046495350409, 9576.138147566753, 9581.904180958241, 9620.3746756462, 9629.422234665943, 5100.48995100487, 5102.081625307406, 5102.132637451642, 5105.285260063594, 5145.485451454824, 4011.5186177658866, 4481.955180448219, 4697.530246975343, 4728.692634978715, 4736.502667219961, 3790.241951609634, 3913.5890731473355, 3916.804159791999, 3927.7643341399607, 3983.6215559521797, 1240.925544467335, 1277.1060257819563, 1277.8849903508542, 1281.923084614926, 1293.9676508087373, 997.8602995580625, 1000.2847963705985, 1001.6494227020485, 1004.8593196952432, 1005.1757558801859, 5681.0910254359105, 5728.398518155534, 5785.768569257267, 5806.875886928121, 5881.5000724938, 445.08979137663556, 449.317038102083, 450.84896559652884, 452.82339887443925, 472.91487532244525, 4138.772367519755, 4246.702730808814, 4273.465816772903, 4321.978390108092, 4349.673774466928, 9475.810483790285, 9899.752506187258, 9943.651972180938, 10025.548850301753, 10052.296339256181, 9673.613055477843, 9680.854787178198, 9718.902810971942, 9746.415215087118, 9835.311528192959, 7292.307230813064, 7314.3782778463365, 7371.741989030358, 7410.592417416986, 7449.441291903129, 5674.602777805514, 5836.212111364912, 5870.26621672291, 5936.614120082181, 6042.516598672184, 9127.726168214964, 9134.086591341078, 9146.451212927246, 9196.494192819191, 9307.348485605942, 8967.955160224417, 9168.862467062865, 9371.0, 9474.4315341077, 9596.856047159437, 6622.801315960529, 6830.31696830313, 6836.042953986346, 7445.181030086795, 7550.7734767957045, 7342.339189472973, 7762.689492420466, 7869.842603148019, 7978.880316795369, 7997.560134192675, 7225.602591857499, 7414.369778568882, 7425.628718563942, 7536.547807131589, 7644.12092609357, 7088.645567721696, 7191.42468602521, 7220.241874603301, 7290.125184977836, 7366.594837284001, 6721.361470660279, 6801.18385793708, 6804.149481314836, 6812.250652428328, 6833.624150671562, 4882.829100981448, 5015.498450154955, 5075.137226671401, 5085.5931525477135, 5133.024725302181, 5024.0, 5057.949420505748, 5080.542751152266, 5080.796768129381, 5223.0], "value": 4354.948407980769, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.8253777884385, 318.4411358066593, 319.9104250809774, 328.94901290300004, 329.65550999205834, 5512.972435137819, 5637.21079048933, 5645.983722929871, 5651.660900345977, 5730.312362516499, 5639.661620302784, 5657.32112146543, 5667.574931880115, 5685.289338832646, 5685.943140568593, 4396.89007774805, 4404.471463424377, 4415.359772832953, 4419.0, 4438.668399480159, 4210.24215641186, 4347.434833471644, 4356.1723272578265, 4371.300591905296, 4421.425214722081, 4280.486341639008, 4284.464441944757, 4293.012607100369, 4301.548337424572, 4318.330658747899, 4268.9573104268875, 4283.336082907154, 4297.656187504992, 4300.182965236626, 4304.720193187432, 3706.4810926470313, 3752.061984503874, 3758.229562939618, 3760.6803421709187, 3760.699144068468, 5414.453532935894, 5448.447192550104, 5466.125419932831, 5469.234307196995, 5470.370907345627, 4969.453360130383, 4971.850844474671, 4976.2038073908, 4981.327520784684, 4990.725510096943, 5661.857668993707, 5930.644161350289, 5935.109733540004, 5939.732712027969, 5972.701364931736, 4160.50073991123, 4186.644135248507, 4188.518320393163, 4194.727342722713, 4199.4330765346895, 6157.415045570664, 6198.597091189058, 6213.751449942042, 6215.347388524185, 6228.408301211378, 4164.354525048622, 4229.196452673982, 4266.360045993126, 4268.829246830154, 4294.0767734937135, 4226.2392769301205, 4282.871513854527, 4288.4210631564965, 4295.78521073945, 4309.944063704413, 4972.254161875748, 4988.226824842155, 4990.72551009698, 4993.525615066563, 5017.272495488134, 5877.153999410834, 5982.192404025401, 5991.221141251609, 6011.669358185254, 6033.42682445167, 1474.3733913086894, 1476.1069552920544, 1483.7922690823293, 1496.5809573319489, 1496.7081419123167, 960.7982323711959, 975.1808480876098, 985.9704208873602, 986.3736527305069, 993.4684943555163, 5750.137479378043, 5773.595848290579, 5787.681677507778, 5797.101449275369, 5807.796727114531, 6120.17377654011, 6145.033589251486, 6150.77084530625, 6154.19995400604, 6171.660558669317, 5556.805511807067, 5747.281589801275, 5759.510441612426, 5770.365259821417, 5790.392008839095, 3248.8213148277073, 3254.723348515403, 3269.2644155065395, 3279.7048265656204, 3284.1132894118455, 6121.479674227651, 6346.555741098171, 6355.1420558224045, 6360.427561519486, 6437.130987316746, 6309.400606942333, 6317.399847014526, 6317.6209427434505, 6323.9683801580695, 6329.3354197809485, 6285.340039295899, 6348.841278968062, 6351.269603995507, 6424.38968298011, 6454.741810327534, 6177.62934223948, 6214.067889816563, 6216.875662486816, 6227.937720622917, 6229.283632382153, 6142.262928448615, 6148.9692551536955, 6149.477294430024, 6194.907076393948, 6195.0263873340145, 6108.144859719554, 6207.162033125651, 6398.424141827258, 6403.487720982217, 6413.583117097373, 4078.9796051019557, 4170.645495132948, 4171.457710497616, 4178.7283826551175, 4198.769067701183, 6096.390360964046, 6142.600730952474, 6145.170401995673, 6153.353897840662, 6173.444390004921, 5791.13133030032, 5944.227250457413, 5975.790847320323, 5992.8501787453915, 5993.572603095753, 5818.156367326798, 5926.644401335933, 5966.433188847052, 5967.6419414835245, 5969.940300597113, 5830.47525722687, 5852.853678658068, 5865.706714664335, 5871.6183448075735, 5873.324567674772, 5720.8569785754025, 5989.311229208697, 6067.605605635619, 6082.482988945989, 6098.75604975796, 5888.882222355443, 5890.558208134321, 5906.350301466921, 5908.9068522323505, 5951.285845698544], "value": 4505.2248614149075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.9311558517526, 825.0965193113539, 827.0736774812209, 828.2007862412767, 845.1717317029307, 13800.585982420518, 13815.1020183688, 13895.79156312656, 13997.580072597813, 14215.218163001031, 13634.0, 13655.86344136561, 13705.3832577534, 13728.176309421442, 13767.65580860479, 664.372168300957, 790.7904405332591, 818.9303909167699, 826.6321486938315, 827.1645637905698, 819.5041999590252, 822.2558584481025, 823.6622984576325, 824.2787560884226, 826.2274773087153, 707.2750430808437, 865.9177378149066, 866.6576702202626, 867.4795122926257, 867.5228624256665, 830.5265998380926, 846.1284876577135, 846.8899043124416, 847.4533925617973, 847.9321654267644, 617.0251003414639, 618.2951435363689, 618.4434009391539, 618.7246675229479, 619.1053927075378, 13192.6701832454, 13208.537701180412, 13290.867091329157, 13300.201987880759, 13310.0, 13259.73480530384, 13354.933225333909, 13371.933140334333, 13800.792988105086, 13917.791233131511, 11149.0, 11169.329840209613, 11227.045701115416, 11411.714707132305, 11598.536058557647, 4462.509123996358, 4512.932306015412, 4583.0604726031415, 4688.601468875149, 4696.248600223982, 50091.24863127056, 50736.49263507355, 50811.491885081414, 52073.21890171613, 52216.47783522154, 10274.691759247235, 10376.066154046172, 10719.732006699738, 10733.302335348177, 10889.0, 18127.0, 18469.445916622524, 18916.24335026611, 18950.147243374082, 19194.616107677768, 7782.961085194538, 7835.177306382861, 7838.0, 7900.960495197487, 8054.194580542016, 4776.689515181502, 4878.146324393217, 4887.437944636412, 4901.877453063702, 5079.898402032012, 3165.8733650653717, 3180.507021411685, 3197.4564324064963, 3201.599800024997, 3216.710496055366, 562.8142712904731, 575.3096284458667, 575.7581815637442, 580.5819809737067, 595.8033848829963, 724.583364565377, 749.9287567681062, 770.6146926536732, 789.8459800338878, 791.8060075281593, 8499.575021248913, 8643.178898004806, 8802.207801297915, 8853.73438796837, 9044.683436079706, 705.8776743816036, 745.1616930952679, 755.3730403764972, 759.3545486336681, 765.7396485195061, 3822.7706337619834, 3977.76133431995, 4005.4792876925812, 4040.41413994975, 4114.979425102855, 56950.14574781382, 57209.0, 58294.708526457944, 58489.4151058484, 58744.0, 50568.747156263984, 51622.74188629033, 51907.48092519102, 52091.0, 52650.47349526532, 41739.0, 42542.361864572056, 48115.75942120267, 48243.51756482461, 49128.7543562287, 8742.213200811957, 8749.518776467356, 8799.824003519765, 8987.236084932854, 9201.602269051984, 30830.0, 31467.0, 31797.841010794797, 32037.199070023435, 32097.839510802296, 40008.79995600003, 42081.36877946772, 42735.572644274405, 43864.780676096416, 44147.558524414344, 11027.17296202772, 11183.32900026001, 11406.372649504357, 11704.94147529257, 11838.0, 11242.381669008282, 12217.694557635774, 12454.735706472578, 12869.227846328875, 12999.805002925154, 12343.567975120828, 12810.423530941316, 12846.935765321114, 12888.355582220664, 13357.866421335662, 12391.690207744517, 12595.0, 12701.920336771109, 12727.872721272668, 12778.169418987736, 12363.505459781509, 12606.117571769888, 12625.242485450903, 12711.427985740478, 13153.736925261632, 9576.377535460173, 9647.179989700953, 9760.023997600183, 9866.85199722019, 9998.150157236716, 10185.134263587677, 10398.376097434179, 10458.320209186379, 10463.215258855464, 10508.159347252049], "value": 6586.772604351392, "unit": "score"}], "name": "dromaeo_css", "value": 6997.793210034155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 107.0, 111.0, 112.0, 113.0, 101.0, 112.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 153.0, 194.0, 129.0, 156.0, 151.0, 136.0, 175.0, 137.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 114.0, 106.0, 73.0, 72.0, 73.0, 135.0, 100.0, 74.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 160.0, 93.0, 93.0, 93.0, 151.0, 92.0, 93.0, 144.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 57.0, 58.0, 57.0, 57.0, 69.0, 55.0, 55.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 88.0, 76.0, 83.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 129.0, 125.0, 136.0, 128.0, 127.0, 123.0, 207.0, 123.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 175.0, 163.0, 168.0, 165.0, 165.0, 167.0, 170.0, 168.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 67.0, 66.0, 66.0, 65.0, 67.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1546.2999999999997, "alertThreshold": 2.0}]} 07:11:22 INFO - Return code: 0 07:11:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:22 ERROR - # TBPL SUCCESS # 07:11:22 INFO - Running post-action listener: _resource_record_post_action 07:11:22 INFO - Running post-run listener: _resource_record_post_run 07:11:23 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543444992; Read time: 8; Write time: 655076 07:11:23 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 256724992; Read time: 0; Write time: 444428 07:11:23 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286515200; Read time: 8; Write time: 210168 07:11:23 INFO - Running post-run listener: _upload_blobber_files 07:11:23 INFO - Blob upload gear active. 07:11:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:23 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 07:11:23 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'] 07:11:23 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 07:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:24 INFO - (blobuploader) - INFO - Done attempting. 07:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:25 INFO - (blobuploader) - INFO - Done attempting. 07:11:25 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:25 INFO - Return code: 0 07:11:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85d203a7a821bedd75ec27d9d7a162bf98c398362797cb2f3a57e7a892e292f3107b21a79109a91440c951e6819c53bf83e0fd03a59870fd022f15d2a408898b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0299fc1c535fbe79e139bef742df1fd8755e3bc5d391c89ce996b0b913f7414a213409d7985373376fb7662e7cbfd48e4a8077eefdc68f8353c37735ff9f33a3"} 07:11:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:25 INFO - Contents: 07:11:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85d203a7a821bedd75ec27d9d7a162bf98c398362797cb2f3a57e7a892e292f3107b21a79109a91440c951e6819c53bf83e0fd03a59870fd022f15d2a408898b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0299fc1c535fbe79e139bef742df1fd8755e3bc5d391c89ce996b0b913f7414a213409d7985373376fb7662e7cbfd48e4a8077eefdc68f8353c37735ff9f33a3"} 07:11:25 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:25 INFO - Copying logs to upload dir... 07:11:25 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.177996 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-22 07:11:25.620339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 07:11:25.624477) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002 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/85d203a7a821bedd75ec27d9d7a162bf98c398362797cb2f3a57e7a892e292f3107b21a79109a91440c951e6819c53bf83e0fd03a59870fd022f15d2a408898b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0299fc1c535fbe79e139bef742df1fd8755e3bc5d391c89ce996b0b913f7414a213409d7985373376fb7662e7cbfd48e4a8077eefdc68f8353c37735ff9f33a3"} build_url:https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/JBGr38raRgmq9jUcIuy1YQ/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/85d203a7a821bedd75ec27d9d7a162bf98c398362797cb2f3a57e7a892e292f3107b21a79109a91440c951e6819c53bf83e0fd03a59870fd022f15d2a408898b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0299fc1c535fbe79e139bef742df1fd8755e3bc5d391c89ce996b0b913f7414a213409d7985373376fb7662e7cbfd48e4a8077eefdc68f8353c37735ff9f33a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 07:11:25.649361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 07:11:25.649700) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461333050.711617-2030875002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 07:11:25.736244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 07:11:25.736556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 07:11:25.736877) ========= ========= Total master_lag: 0.31 =========