builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1464648648.54 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.538356) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.538956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.539271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.603919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.604165) ========= 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=db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 15:50:49-- 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% 226M=0s 2016-05-30 15:50:49 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.347432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.966285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.966651) ========= 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=db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022954 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.016355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.016731) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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=db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 15:50:49,635 truncating revision to first 12 chars 2016-05-30 15:50:49,635 Setting DEBUG logging. 2016-05-30 15:50:49,635 attempt 1/10 2016-05-30 15:50:49,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 15:50:49,938 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.658899) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.659632) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.660563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.661189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.672778) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 15:50:49.673044) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:50 INFO - MultiFileLogger online at 20160530 15:50:50 in /builds/slave/test 15:50:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:50:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:50 INFO - {'append_to_log': False, 15:50:50 INFO - 'base_work_dir': '/builds/slave/test', 15:50:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:50:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:50 INFO - 'branch': 'Mozilla-Aurora', 15:50:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:50 INFO - 'config_files': ('talos/linux_config.py',), 15:50:50 INFO - 'default_actions': ('clobber', 15:50:50 INFO - 'read-buildbot-config', 15:50:50 INFO - 'download-and-extract', 15:50:50 INFO - 'populate-webroot', 15:50:50 INFO - 'create-virtualenv', 15:50:50 INFO - 'install', 15:50:50 INFO - 'run-tests'), 15:50:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:50 INFO - 'download_minidump_stackwalk': True, 15:50:50 INFO - 'download_symbols': 'ondemand', 15:50:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:50 INFO - 'installer_path': 'installer.exe', 15:50:50 INFO - 'log_level': 'info', 15:50:50 INFO - 'log_name': 'talos', 15:50:50 INFO - 'log_to_console': True, 15:50:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:50 INFO - 'opt_config_files': (), 15:50:50 INFO - 'pip_index': False, 15:50:50 INFO - 'sps_profile': False, 15:50:50 INFO - 'sps_profile_interval': 0, 15:50:50 INFO - 'suite': 'dromaeojs', 15:50:50 INFO - 'system_bits': '32', 15:50:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:50 INFO - 'title': 'talos-linux64-ix-031', 15:50:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:50 INFO - 'use_talos_json': True, 15:50:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:50 INFO - 'work_dir': 'build'} 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running clobber step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: clobber 15:50:50 INFO - rmtree: /builds/slave/test/build 15:50:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:51 INFO - Running post-action listener: _resource_record_post_action 15:50:51 INFO - ##### 15:50:51 INFO - ##### Running read-buildbot-config step. 15:50:51 INFO - ##### 15:50:51 INFO - Running pre-action listener: _resource_record_pre_action 15:50:51 INFO - Running main action method: read_buildbot_config 15:50:51 INFO - Using buildbot properties: 15:50:51 INFO - { 15:50:51 INFO - "project": "", 15:50:51 INFO - "product": "firefox", 15:50:51 INFO - "script_repo_revision": "production", 15:50:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:50:51 INFO - "repository": "", 15:50:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:50:51 INFO - "buildid": "20160530120549", 15:50:51 INFO - "pgo_build": "True", 15:50:51 INFO - "basedir": "/builds/slave/test", 15:50:51 INFO - "buildnumber": 353, 15:50:51 INFO - "slavename": "talos-linux64-ix-031", 15:50:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:51 INFO - "platform": "ubuntu64_hw", 15:50:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:50:51 INFO - "branch": "mozilla-aurora", 15:50:51 INFO - "repo_path": "releases/mozilla-aurora", 15:50:51 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 15:50:51 INFO - "stage_platform": "linux64-pgo", 15:50:51 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 15:50:51 INFO - "slavebuilddir": "test" 15:50:51 INFO - } 15:50:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 15:50:51 INFO - Running post-action listener: _resource_record_post_action 15:50:51 INFO - ##### 15:50:51 INFO - ##### Running download-and-extract step. 15:50:51 INFO - ##### 15:50:51 INFO - Running pre-action listener: _resource_record_pre_action 15:50:51 INFO - Running main action method: download_and_extract 15:50:51 INFO - mkdir: /builds/slave/test/build/tests 15:50:51 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')]} 15:50:51 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:50:52 INFO - Downloaded 1361 bytes. 15:50:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:52 INFO - Using the following test package requirements: 15:50:52 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:52 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:52 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:50:52 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'jsshell-linux-x86_64.zip'], 15:50:52 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:52 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:52 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:50:52 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:50:52 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:52 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:52 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:52 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')]} 15:50:52 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:53 INFO - Downloaded 24173994 bytes. 15:50:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:50:54 INFO - Return code: 0 15:50:54 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:54 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:58 INFO - Downloaded 24173994 bytes. 15:50:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:51:00 INFO - Return code: 0 15:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:00 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:51:01 INFO - Downloaded 10840145 bytes. 15:51:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:51:01 INFO - Return code: 0 15: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')]} 15:51:01 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:51:03 INFO - Downloaded 62800628 bytes. 15:51:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:03 INFO - mkdir: /builds/slave/test/properties 15:51:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:03 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:03 INFO - Contents: 15:51:03 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:03 INFO - Running post-action listener: _resource_record_post_action 15:51:03 INFO - Running post-action listener: set_extra_try_arguments 15:51:03 INFO - ##### 15:51:03 INFO - ##### Running populate-webroot step. 15:51:03 INFO - ##### 15:51:03 INFO - Running pre-action listener: _resource_record_pre_action 15:51:03 INFO - Running main action method: populate_webroot 15:51:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:03 INFO - '--tppagecycles', 15:51:03 INFO - '7'], 15:51:03 INFO - 'tests': ['tsvgm']}}, 15:51:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['damp', 'tps']}, 15:51:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'tests': ['damp', 'tps']}, 15:51:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['dromaeo_dom']}, 15:51:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['a11yr', 15:51:03 INFO - 'ts_paint', 15:51:03 INFO - 'tpaint', 15:51:03 INFO - 'sessionrestore', 15:51:03 INFO - 'sessionrestore_no_auto_restore', 15:51:03 INFO - 'tabpaint']}, 15:51:03 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:03 INFO - 'ts_paint', 15:51:03 INFO - 'tpaint', 15:51:03 INFO - 'sessionrestore', 15:51:03 INFO - 'sessionrestore_no_auto_restore', 15:51:03 INFO - 'tabpaint']}, 15:51:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:03 INFO - 'ts_paint', 15:51:03 INFO - 'tpaint', 15:51:03 INFO - 'sessionrestore', 15:51:03 INFO - 'sessionrestore_no_auto_restore', 15:51:03 INFO - 'tabpaint']}, 15:51:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:03 INFO - 'ts_paint', 15:51:03 INFO - 'tpaint', 15:51:03 INFO - 'sessionrestore', 15:51:03 INFO - 'sessionrestore_no_auto_restore', 15:51:03 INFO - 'tabpaint']}, 15:51:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['a11yr', 15:51:03 INFO - 'ts_paint', 15:51:03 INFO - 'tpaint', 15:51:03 INFO - 'sessionrestore', 15:51:03 INFO - 'sessionrestore_no_auto_restore', 15:51:03 INFO - 'tabpaint']}, 15:51:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['a11yr', 15:51:03 INFO - 'ts_paint', 15:51:03 INFO - 'tpaint', 15:51:03 INFO - 'sessionrestore', 15:51:03 INFO - 'sessionrestore_no_auto_restore', 15:51:03 INFO - 'tabpaint']}, 15:51:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['tsvgx', 15:51:03 INFO - 'tsvgr_opacity', 15:51:03 INFO - 'tart', 15:51:03 INFO - 'tscrollx', 15:51:03 INFO - 'cart']}, 15:51:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:03 INFO - 'tsvgr_opacity', 15:51:03 INFO - 'tart', 15:51:03 INFO - 'tscrollx', 15:51:03 INFO - 'cart']}, 15:51:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'talos_options': ['--disable-e10s'], 15:51:03 INFO - 'tests': ['tp5o']}, 15:51:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'tests': ['tp5o']}, 15:51:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'talos_options': ['--disable-e10s', 15:51:03 INFO - '--xperf_path', 15:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:03 INFO - 'tests': ['tp5n']}, 15:51:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:03 INFO - 'talos_options': ['--xperf_path', 15:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:03 INFO - 'tests': ['tp5n']}}, 15:51:03 INFO - 'talos.zip': {'path': '', 15:51:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:03 INFO - Running post-action listener: _resource_record_post_action 15:51:03 INFO - ##### 15:51:03 INFO - ##### Running create-virtualenv step. 15:51:03 INFO - ##### 15:51:03 INFO - Running pre-action listener: _resource_record_pre_action 15:51:03 INFO - Running main action method: create_virtualenv 15:51:03 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:03 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 15:51:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:04 INFO - Using real prefix '/usr' 15:51:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:06 INFO - Installing pip.................done. 15:51:06 INFO - Return code: 0 15:51:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:06 INFO - Using env: {'DISPLAY': ':0', 15:51:06 INFO - 'HOME': '/home/cltbld', 15:51:06 INFO - 'LANG': 'en_US.UTF-8', 15:51:06 INFO - 'LANGUAGE': 'en_US:en', 15:51:06 INFO - 'LOGNAME': 'cltbld', 15:51:06 INFO - 'MAIL': '/var/mail/cltbld', 15:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:06 INFO - 'MOZ_NO_REMOTE': '1', 15:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:06 INFO - 'NO_EM_RESTART': '1', 15:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:06 INFO - 'PWD': '/builds/slave/test', 15:51:06 INFO - 'SHELL': '/bin/bash', 15:51:06 INFO - 'SHLVL': '1', 15:51:06 INFO - 'TERM': 'linux', 15:51:06 INFO - 'TMOUT': '86400', 15:51:06 INFO - 'USER': 'cltbld', 15:51:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:06 INFO - '_': '/tools/buildbot/bin/python'} 15:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:06 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 15:51:06 INFO - Cleaning up... 15:51:06 INFO - Return code: 0 15:51:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:51:06 INFO - Using env: {'DISPLAY': ':0', 15:51:06 INFO - 'HOME': '/home/cltbld', 15:51:06 INFO - 'LANG': 'en_US.UTF-8', 15:51:06 INFO - 'LANGUAGE': 'en_US:en', 15:51:06 INFO - 'LOGNAME': 'cltbld', 15:51:06 INFO - 'MAIL': '/var/mail/cltbld', 15:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:06 INFO - 'MOZ_NO_REMOTE': '1', 15:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:06 INFO - 'NO_EM_RESTART': '1', 15:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:06 INFO - 'PWD': '/builds/slave/test', 15:51:06 INFO - 'SHELL': '/bin/bash', 15:51:06 INFO - 'SHLVL': '1', 15:51:06 INFO - 'TERM': 'linux', 15:51:06 INFO - 'TMOUT': '86400', 15:51:06 INFO - 'USER': 'cltbld', 15:51:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:06 INFO - '_': '/tools/buildbot/bin/python'} 15:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:06 INFO - Downloading/unpacking psutil>=0.7.1 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:09 INFO - Installing collected packages: psutil 15:51:09 INFO - Running setup.py install for psutil 15:51:09 INFO - building 'psutil._psutil_linux' extension 15:51:09 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 15:51:09 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 15:51:09 INFO - building 'psutil._psutil_posix' extension 15:51:09 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 15:51:09 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 15:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:09 INFO - Successfully installed psutil 15:51:09 INFO - Cleaning up... 15:51:09 INFO - Return code: 0 15:51:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:09 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')]} 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:09 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')]} 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:09 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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:09 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 15:51:09 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 15:51:09 INFO - Using env: {'DISPLAY': ':0', 15:51:09 INFO - 'HOME': '/home/cltbld', 15:51:09 INFO - 'LANG': 'en_US.UTF-8', 15:51:09 INFO - 'LANGUAGE': 'en_US:en', 15:51:09 INFO - 'LOGNAME': 'cltbld', 15:51:09 INFO - 'MAIL': '/var/mail/cltbld', 15:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:09 INFO - 'MOZ_NO_REMOTE': '1', 15:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:09 INFO - 'NO_EM_RESTART': '1', 15:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:09 INFO - 'PWD': '/builds/slave/test', 15:51:09 INFO - 'SHELL': '/bin/bash', 15:51:09 INFO - 'SHLVL': '1', 15:51:09 INFO - 'TERM': 'linux', 15:51:09 INFO - 'TMOUT': '86400', 15:51:09 INFO - 'USER': 'cltbld', 15:51:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:09 INFO - '_': '/tools/buildbot/bin/python'} 15:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:11 INFO - Installing collected packages: mozsystemmonitor 15:51:11 INFO - Running setup.py install for mozsystemmonitor 15:51:11 INFO - Successfully installed mozsystemmonitor 15:51:11 INFO - Cleaning up... 15:51:11 INFO - Return code: 0 15:51:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:11 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')]} 15:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:11 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')]} 15:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:11 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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:11 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 15:51:11 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 15:51:11 INFO - Using env: {'DISPLAY': ':0', 15:51:11 INFO - 'HOME': '/home/cltbld', 15:51:11 INFO - 'LANG': 'en_US.UTF-8', 15:51:11 INFO - 'LANGUAGE': 'en_US:en', 15:51:11 INFO - 'LOGNAME': 'cltbld', 15:51:11 INFO - 'MAIL': '/var/mail/cltbld', 15:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:11 INFO - 'MOZ_NO_REMOTE': '1', 15:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:11 INFO - 'NO_EM_RESTART': '1', 15:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:11 INFO - 'PWD': '/builds/slave/test', 15:51:11 INFO - 'SHELL': '/bin/bash', 15:51:11 INFO - 'SHLVL': '1', 15:51:11 INFO - 'TERM': 'linux', 15:51:11 INFO - 'TMOUT': '86400', 15:51:11 INFO - 'USER': 'cltbld', 15:51:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:11 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15: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 15: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 15: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 15: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 15: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 15: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 15:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 INFO - Downloading docopt-0.6.1.tar.gz 15:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:14 INFO - Running setup.py install for blobuploader 15:51:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:14 INFO - Running setup.py install for requests 15:51:15 INFO - Running setup.py install for docopt 15:51:15 INFO - Successfully installed blobuploader requests docopt 15:51:15 INFO - Cleaning up... 15:51:15 INFO - Return code: 0 15:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15: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')]} 15:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:15 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 15:51:15 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 15:51:15 INFO - Using env: {'DISPLAY': ':0', 15:51:15 INFO - 'HOME': '/home/cltbld', 15:51:15 INFO - 'LANG': 'en_US.UTF-8', 15:51:15 INFO - 'LANGUAGE': 'en_US:en', 15:51:15 INFO - 'LOGNAME': 'cltbld', 15:51:15 INFO - 'MAIL': '/var/mail/cltbld', 15:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:15 INFO - 'MOZ_NO_REMOTE': '1', 15:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:15 INFO - 'NO_EM_RESTART': '1', 15:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:15 INFO - 'PWD': '/builds/slave/test', 15:51:15 INFO - 'SHELL': '/bin/bash', 15:51:15 INFO - 'SHLVL': '1', 15:51:15 INFO - 'TERM': 'linux', 15:51:15 INFO - 'TMOUT': '86400', 15:51:15 INFO - 'USER': 'cltbld', 15:51:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:15 INFO - '_': '/tools/buildbot/bin/python'} 15:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:15 INFO - Running setup.py (path:/tmp/pip-sjRq9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:15 INFO - Running setup.py (path:/tmp/pip-wOkSN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:15 INFO - Running setup.py (path:/tmp/pip-gWB_yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:15 INFO - Running setup.py (path:/tmp/pip-GEUyAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:15 INFO - Running setup.py (path:/tmp/pip-9l3TgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:15 INFO - Running setup.py (path:/tmp/pip-UJXgBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:15 INFO - Running setup.py (path:/tmp/pip-cOWkEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:16 INFO - Running setup.py (path:/tmp/pip-cUlUj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:16 INFO - Running setup.py (path:/tmp/pip-wtooIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:16 INFO - Running setup.py (path:/tmp/pip-9d9F58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:16 INFO - Running setup.py (path:/tmp/pip-rAM6ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:16 INFO - Running setup.py (path:/tmp/pip-DQk9T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:16 INFO - Running setup.py (path:/tmp/pip-mwKtws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:16 INFO - Running setup.py (path:/tmp/pip-BYpZXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:16 INFO - Running setup.py (path:/tmp/pip-ioK6y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:16 INFO - Running setup.py (path:/tmp/pip-iZOjKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:16 INFO - Running setup.py (path:/tmp/pip-s8VxsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:16 INFO - Running setup.py install for manifestparser 15:51:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:16 INFO - Running setup.py install for mozcrash 15:51:16 INFO - Running setup.py install for mozdebug 15:51:17 INFO - Running setup.py install for mozdevice 15:51:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozfile 15:51:17 INFO - Running setup.py install for mozhttpd 15:51:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozinfo 15:51:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozInstall 15:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozleak 15:51:17 INFO - Running setup.py install for mozlog 15:51:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for moznetwork 15:51:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozprocess 15:51:17 INFO - Running setup.py install for mozprofile 15:51:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for mozrunner 15:51:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for mozscreenshot 15:51:18 INFO - Running setup.py install for moztest 15:51:18 INFO - Running setup.py install for mozversion 15:51:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:18 INFO - Cleaning up... 15:51:18 INFO - Return code: 0 15:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15: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')]} 15:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:18 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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:18 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 15:51:18 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 15:51:18 INFO - Using env: {'DISPLAY': ':0', 15:51:18 INFO - 'HOME': '/home/cltbld', 15:51:18 INFO - 'LANG': 'en_US.UTF-8', 15:51:18 INFO - 'LANGUAGE': 'en_US:en', 15:51:18 INFO - 'LOGNAME': 'cltbld', 15:51:18 INFO - 'MAIL': '/var/mail/cltbld', 15:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:18 INFO - 'MOZ_NO_REMOTE': '1', 15:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:18 INFO - 'NO_EM_RESTART': '1', 15:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:18 INFO - 'PWD': '/builds/slave/test', 15:51:18 INFO - 'SHELL': '/bin/bash', 15:51:18 INFO - 'SHLVL': '1', 15:51:18 INFO - 'TERM': 'linux', 15:51:18 INFO - 'TMOUT': '86400', 15:51:18 INFO - 'USER': 'cltbld', 15:51:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:18 INFO - '_': '/tools/buildbot/bin/python'} 15:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:18 INFO - Running setup.py (path:/tmp/pip-g0fTD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:18 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)) 15:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:18 INFO - Running setup.py (path:/tmp/pip-Mfx7ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:18 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)) 15:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:18 INFO - Running setup.py (path:/tmp/pip-mZdCM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:18 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)) 15:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:18 INFO - Running setup.py (path:/tmp/pip-MZbCtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:19 INFO - Running setup.py (path:/tmp/pip-h_Kejt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:19 INFO - Running setup.py (path:/tmp/pip-0hna2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:19 INFO - Running setup.py (path:/tmp/pip-NgdTYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:19 INFO - Running setup.py (path:/tmp/pip-9tMCsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:19 INFO - Running setup.py (path:/tmp/pip-tC6Qkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:19 INFO - Running setup.py (path:/tmp/pip-bf9kzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:19 INFO - Running setup.py (path:/tmp/pip-hoBLNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:19 INFO - Running setup.py (path:/tmp/pip-niL32x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:19 INFO - Running setup.py (path:/tmp/pip-vGAp2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:19 INFO - Running setup.py (path:/tmp/pip-ymZlkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:19 INFO - Running setup.py (path:/tmp/pip-uJu_Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:19 INFO - Running setup.py (path:/tmp/pip-ObgyS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:19 INFO - Running setup.py (path:/tmp/pip-uESo38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:19 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)) 15:51:19 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)) 15:51:19 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)) 15:51:19 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)) 15:51:19 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)) 15:51:19 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)) 15:51:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:19 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 15:51:19 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 15:51:19 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 15:51:19 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 15:51:19 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 15:51:19 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 15:51:21 INFO - Downloading blessings-1.6.tar.gz 15:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:21 INFO - Installing collected packages: blessings 15:51:21 INFO - Running setup.py install for blessings 15:51:22 INFO - Successfully installed blessings 15:51:22 INFO - Cleaning up... 15:51:22 INFO - Return code: 0 15:51:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:22 INFO - Reading from file tmpfile_stdout 15:51:22 INFO - Current package versions: 15:51:22 INFO - argparse == 1.2.1 15:51:22 INFO - blessings == 1.6 15:51:22 INFO - blobuploader == 1.2.4 15:51:22 INFO - docopt == 0.6.1 15:51:22 INFO - manifestparser == 1.1 15:51:22 INFO - mozInstall == 1.12 15:51:22 INFO - mozcrash == 0.17 15:51:22 INFO - mozdebug == 0.1 15:51:22 INFO - mozdevice == 0.48 15:51:22 INFO - mozfile == 1.2 15:51:22 INFO - mozhttpd == 0.7 15:51:22 INFO - mozinfo == 0.9 15:51:22 INFO - mozleak == 0.1 15:51:22 INFO - mozlog == 3.1 15:51:22 INFO - moznetwork == 0.27 15:51:22 INFO - mozprocess == 0.22 15:51:22 INFO - mozprofile == 0.28 15:51:22 INFO - mozrunner == 6.11 15:51:22 INFO - mozscreenshot == 0.1 15:51:22 INFO - mozsystemmonitor == 0.0 15:51:22 INFO - moztest == 0.7 15:51:22 INFO - mozversion == 1.4 15:51:22 INFO - psutil == 3.1.1 15:51:22 INFO - requests == 1.2.3 15:51:22 INFO - wsgiref == 0.1.2 15:51:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15: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')]} 15:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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/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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:22 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 15:51:22 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 15:51:22 INFO - Using env: {'DISPLAY': ':0', 15:51:22 INFO - 'HOME': '/home/cltbld', 15:51:22 INFO - 'LANG': 'en_US.UTF-8', 15:51:22 INFO - 'LANGUAGE': 'en_US:en', 15:51:22 INFO - 'LOGNAME': 'cltbld', 15:51:22 INFO - 'MAIL': '/var/mail/cltbld', 15:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:22 INFO - 'MOZ_NO_REMOTE': '1', 15:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:22 INFO - 'NO_EM_RESTART': '1', 15:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:22 INFO - 'PWD': '/builds/slave/test', 15:51:22 INFO - 'SHELL': '/bin/bash', 15:51:22 INFO - 'SHLVL': '1', 15:51:22 INFO - 'TERM': 'linux', 15:51:22 INFO - 'TMOUT': '86400', 15:51:22 INFO - 'USER': 'cltbld', 15:51:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:22 INFO - '_': '/tools/buildbot/bin/python'} 15:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 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)) 15:51:22 INFO - Cleaning up... 15:51:22 INFO - Return code: 0 15:51:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15: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')]} 15:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:22 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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:22 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 15:51:22 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 15:51:22 INFO - Using env: {'DISPLAY': ':0', 15:51:22 INFO - 'HOME': '/home/cltbld', 15:51:22 INFO - 'LANG': 'en_US.UTF-8', 15:51:22 INFO - 'LANGUAGE': 'en_US:en', 15:51:22 INFO - 'LOGNAME': 'cltbld', 15:51:22 INFO - 'MAIL': '/var/mail/cltbld', 15:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:22 INFO - 'MOZ_NO_REMOTE': '1', 15:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:22 INFO - 'NO_EM_RESTART': '1', 15:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:22 INFO - 'PWD': '/builds/slave/test', 15:51:22 INFO - 'SHELL': '/bin/bash', 15:51:22 INFO - 'SHLVL': '1', 15:51:22 INFO - 'TERM': 'linux', 15:51:22 INFO - 'TMOUT': '86400', 15:51:22 INFO - 'USER': 'cltbld', 15:51:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:22 INFO - '_': '/tools/buildbot/bin/python'} 15:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:22 INFO - Downloading/unpacking jsonschema 15:51:22 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 15:51:22 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 15:51:22 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 15:51:22 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 15:51:22 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 15:51:22 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 15:51:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:24 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:24 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 15:51:24 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 15:51:24 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 15:51:24 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 15:51:24 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 15:51:24 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 15:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:24 INFO - warning: no files found matching '*.txt' 15:51:24 INFO - no previously-included directories found matching 'build' 15:51:24 INFO - no previously-included directories found matching 'dist' 15:51:24 INFO - no previously-included directories found matching '.git*' 15:51:24 INFO - Installing collected packages: jsonschema, functools32 15:51:24 INFO - Running setup.py install for functools32 15:51:25 INFO - warning: no files found matching '*.txt' 15:51:25 INFO - no previously-included directories found matching 'build' 15:51:25 INFO - no previously-included directories found matching 'dist' 15:51:25 INFO - no previously-included directories found matching '.git*' 15:51:25 INFO - Successfully installed jsonschema functools32 15:51:25 INFO - Cleaning up... 15:51:25 INFO - Return code: 0 15:51:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:25 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 0x7fe46aa34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', '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 15:51:25 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 15:51:25 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 15:51:25 INFO - Using env: {'DISPLAY': ':0', 15:51:25 INFO - 'HOME': '/home/cltbld', 15:51:25 INFO - 'LANG': 'en_US.UTF-8', 15:51:25 INFO - 'LANGUAGE': 'en_US:en', 15:51:25 INFO - 'LOGNAME': 'cltbld', 15:51:25 INFO - 'MAIL': '/var/mail/cltbld', 15:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:25 INFO - 'MOZ_NO_REMOTE': '1', 15:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:25 INFO - 'NO_EM_RESTART': '1', 15:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:25 INFO - 'PWD': '/builds/slave/test', 15:51:25 INFO - 'SHELL': '/bin/bash', 15:51:25 INFO - 'SHLVL': '1', 15:51:25 INFO - 'TERM': 'linux', 15:51:25 INFO - 'TMOUT': '86400', 15:51:25 INFO - 'USER': 'cltbld', 15:51:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:25 INFO - '_': '/tools/buildbot/bin/python'} 15:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:25 INFO - Downloading/unpacking flake8 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 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 15:51:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:27 INFO - no previously-included directories found matching 'docs/_build' 15:51:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:28 INFO - Running setup.py install for pep8 15:51:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:28 INFO - no previously-included directories found matching 'docs/_build' 15:51:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:28 INFO - Cleaning up... 15:51:28 INFO - Return code: 0 15:51:28 INFO - Running post-action listener: _resource_record_post_action 15:51:28 INFO - Running post-action listener: _start_resource_monitoring 15:51:28 INFO - Starting resource monitoring. 15:51:28 INFO - ##### 15:51:28 INFO - ##### Running install step. 15:51:28 INFO - ##### 15:51:28 INFO - Running pre-action listener: _resource_record_pre_action 15:51:28 INFO - Running main action method: install 15:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:28 INFO - Reading from file tmpfile_stdout 15:51:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:28 INFO - Reading from file tmpfile_stdout 15:51:28 INFO - Output received: 15:51:28 INFO - Usage: mozinstall [options] installer 15:51:28 INFO - Options: 15:51:28 INFO - -h, --help show this help message and exit 15:51:28 INFO - -d DEST, --destination=DEST 15:51:28 INFO - Directory to install application into. [default: 15:51:28 INFO - "/builds/slave/test"] 15:51:28 INFO - --app=APP Application being installed. [default: firefox] 15:51:28 INFO - mkdir: /builds/slave/test/build/application 15:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:51:44 INFO - Reading from file tmpfile_stdout 15:51:44 INFO - Output received: 15:51:44 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:44 INFO - Running post-action listener: _resource_record_post_action 15:51:44 INFO - ##### 15:51:44 INFO - ##### Running run-tests step. 15:51:44 INFO - ##### 15:51:44 INFO - Running pre-action listener: _resource_record_pre_action 15:51:44 INFO - Running main action method: run_tests 15:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:44 INFO - Python 2.7.3 15:51:44 INFO - Return code: 0 15:51:44 INFO - grabbing minidump binary from tooltool 15:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:44 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 0x2c68410>, '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 0x2c69310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c697a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:44 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 15:51:44 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 15:51:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:44 INFO - Return code: 0 15:51:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:51:45 INFO - Return code: 0 15:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 15:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 15:51:45 INFO - Using env: {'DISPLAY': ':0', 15:51:45 INFO - 'HOME': '/home/cltbld', 15:51:45 INFO - 'LANG': 'en_US.UTF-8', 15:51:45 INFO - 'LANGUAGE': 'en_US:en', 15:51:45 INFO - 'LOGNAME': 'cltbld', 15:51:45 INFO - 'MAIL': '/var/mail/cltbld', 15:51:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:45 INFO - 'MOZ_NO_REMOTE': '1', 15:51:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:45 INFO - 'NO_EM_RESTART': '1', 15:51:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:45 INFO - 'PWD': '/builds/slave/test', 15:51:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:45 INFO - 'SHELL': '/bin/bash', 15:51:45 INFO - 'SHLVL': '1', 15:51:45 INFO - 'TERM': 'linux', 15:51:45 INFO - 'TMOUT': '86400', 15:51:45 INFO - 'USER': 'cltbld', 15:51:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508', 15:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:45 INFO - '_': '/tools/buildbot/bin/python'} 15:51:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 15:51:45 INFO - mozversion application_buildid: 20160530120549 15:51:45 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:51:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:45 INFO - mozversion application_name: Firefox 15:51:45 INFO - mozversion application_remotingname: firefox-dev 15:51:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:45 INFO - mozversion application_vendor: Mozilla 15:51:45 INFO - mozversion application_version: 48.0a2 15:51:45 INFO - mozversion platform_buildid: 20160530120549 15:51:45 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:45 INFO - mozversion platform_version: 48.0a2 15:51:45 INFO - using testdate: 1464648705 15:51:45 INFO - actual date: 1464648705 15:51:45 INFO - starting webserver on 'localhost:51769' 15:51:45 INFO - SUITE-START | Running 2 tests 15:51:45 INFO - TEST-START | dromaeo_css 15:51:45 INFO - operating with platform_type : linux_ 15:51:45 INFO - Initialising browser for dromaeo_css test... 15:51:45 INFO - TEST-INFO | started process 7516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcl0EwI/profile http://localhost:51769/getInfo.html) 15:51:49 INFO - PROCESS | 7516 | __metrics Screen width/height:1600/1200 15:51:49 INFO - PROCESS | 7516 | colorDepth:24 15:51:49 INFO - PROCESS | 7516 | Browser inner width/height: 1024/697 15:51:49 INFO - PROCESS | 7516 | __metrics 15:51:50 ERROR - PROCESS | 7516 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:51:51 INFO - TEST-INFO | 7516: exit 0 15:51:51 INFO - Browser initialized. 15:51:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:51 INFO - TEST-INFO | started process 7609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcl0EwI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:02 INFO - PROCESS | 7609 | RSS: Main: 141754368 15:52:02 INFO - PROCESS | 7609 | 15:52:53 INFO - PROCESS | 7609 | 1464648773922 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] 15:55:01 INFO - PROCESS | 7609 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51769/tests/dromaeo/cssquery-ext.html) 15:55:02 INFO - PROCESS | 7609 | RSS: Main: 252592128 15:55:02 INFO - PROCESS | 7609 | 15:58:04 INFO - PROCESS | 7609 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-ext.html (next: http://localhost:51769/tests/dromaeo/cssquery-jquery.html) 15:58:05 INFO - PROCESS | 7609 | RSS: Main: 224509952 15:58:05 INFO - PROCESS | 7609 | 16:01:07 INFO - PROCESS | 7609 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51769/tests/dromaeo/cssquery-mootools.html) 16:01:07 INFO - PROCESS | 7609 | RSS: Main: 217829376 16:01:07 INFO - PROCESS | 7609 | 16:04:09 INFO - PROCESS | 7609 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51769/tests/dromaeo/cssquery-prototype.html) 16:04:10 INFO - PROCESS | 7609 | RSS: Main: 217821184 16:04:10 INFO - PROCESS | 7609 | 16:07:12 INFO - PROCESS | 7609 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51769/tests/dromaeo/cssquery-yui.html) 16:07:13 INFO - PROCESS | 7609 | RSS: Main: 212721664 16:07:13 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-yui.html (next: http://localhost:51769/tests/dromaeo/cssquery-dojo.html) 16:10:15 INFO - PROCESS | 7609 | RSS: Main: 253493248 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | __start_tp_report 16:10:15 INFO - PROCESS | 7609 | _x_x_mozilla_page_load 16:10:15 INFO - PROCESS | 7609 | _x_x_mozilla_page_load_details 16:10:15 INFO - PROCESS | 7609 | |i|pagename|runs| 16:10:15 INFO - PROCESS | 7609 | |0;dojo.html;3349.7990120592767;3373.139849338418;3400.5409269748584;3404.200012996947;3423.9657603423957;5556.583256255782;5562.499375056244;5568.49883510484;5597.048501754702;5599.972000139994;5546.639468434559;5559.305086864142;5593.077142271521;5596.244506991555;5638.520725738307;4932.605391568666;5016.297718319438;5123.487651234866;5173.172292433212;5197.922031169516;5105.795768169287;5179.197224430201;5185.818496352628;5190.974045129788;5192.1173400522;5079.847604571869;5116.744162791864;5143;5145;5173.844784656448;5132.178851383798;5136.229565565158;5143.12566863634;5147.794088236466;5177.508136726986;4948.87627809304;5000.149974504343;5042.722650254234;5046.545810877039;5060.240963855451;5412.377576578704;5464.781408743645;5465.480779325958;5470.972645136789;5481.040817856899;6009.248843894513;6021.397860213988;6044.788432404845;6045.33501314855;6045.6674882881425;6027.819165425044;6034.943884820139;6053.735855060381;6061.636301821904;6064.49686473576;5653.575981801381;5692.0608099663505;5696.743646535916;5703.144528320785;5708.885822283572;6018.803792562009;6200;6209.037599172136;6215;6218.968905155536;5924.081767326072;5985.371535988746;5987.1318658794235;5997.730102145414;6011.458968692838;6096.908546371808;6114.908276375858;6115.113308570232;6118.479929205978;6123.84690382744;5791.48070589295;5927.703614819242;6069.757209711562;6082.908756368658;6087.573869829158;5937.584369094122;5948.256467941507;5949.10763385487;5974.820755377345;5984.611000284967;4494.438195225597;4496.055828276033;4517.819287228474;4538.523455037173;4544.97727511367;3993.740406873544;4076.3274059780397;4079.7756123412905;4098.262312783668;4135.58644135584;5681.204631351531;5746.1093530502;5746.482816546531;5751.309842818889;5782;5958.940410595926;6027.427394397525;6028.457438830526;6028.758849646053;6040.275166979991;5511.559075273968;5647.265855438849;5709;5738.68437235956;5768.163616275617;5164.457731938092;5168.095583272912;5170.896582068338;5170.922436163461;5173.068847607392;6246.968765156145;6250.468710159687;6252.187215661935;6256.249250090018;6260.436560709558;5834.5624078194305;5983.162357270073;5992.850178745566;6049.66726830011;6062.454379105901;6210.596311239755;6242.812715618538;6255.030470277115;6261.65560894137;6264.749410023548;5771.538276937918;5915.733791979285;5920.200772895604;5920.911186332122;5965.224520812267;6059.272887253558;6118.101457354478;6118.755249789959;6119.136988619874;6127.097902969212;5848.356680765198;5848.385919478394;5849.064149736022;5851.61964472308;5855.560832937632;5703.971480142573;5763.279590051244;5812.244408226903;5831.620944638585;5841.357450680507;5737.684427356368;5753.942460575341;5759.625624334405;5781.075027995501;5789.478946894631;5855.882882342415;5860.267466566679;5882.088276317178;5891.823245302648;5898.469137777621;5601.747921343468;5760.8271751847515;5781.653100813965;5783.8554036149435;5845.41545845412 16:10:15 INFO - PROCESS | 7609 | |1;ext.html;668.0847239282183;680.4114441008526;682.2052309059945;684.1174884399123;754.8339365339623;31907.72369105236;39176.41235381468;39747.40378894312;39986.200275994466;39994.800025999866;42770;43526.12947741051;43550.782246088726;43654.345184822174;43688.34467482982;8098.433109682324;8680.218780309786;8906.465612063264;10310.175185985103;10544.894551054505;10304.227182961307;10436.478176091203;10438.478076096164;10460.476976151162;10463;10534.104601108915;10614.416207108607;10619.734506637318;10627.46862656868;10629.255952083357;8326.916730832674;10334.173266138729;10473.214508911786;10473.895261047368;10482.633107841266;10536.631217907414;10626.574937002511;10647.881972392943;10665.306755060896;10669.733256668567;40503;41218;41239;41299;41305.58694413077;3762.9463750150003;3790.1851102013197;3939.231849789292;4043.716939814214;4129.97935010326;34233.14417139567;35054.298914021834;35069;35239;35273;4571.497135315112;4577.793999270041;4680.789364478573;4685.812567497296;4697.295405689139;322835;329857;330472;331537;331615;39029.21941561153;40675.389869151986;69181.65409173022;70463.64768176229;70546.64726676334;39049.21901561953;39197.21605567873;39251.41122883159;39274;39296.60703392929;15776.76334854978;16729.665406691798;16999.830001700073;17017.659646806995;17019.82980170207;12736.172148810298;12828.871711282767;13784.104033237807;14025.649358765908;14028.789568156486;9211.861822072675;9314.115159059878;9402.623895044258;9442.38624489406;9444.48055356962;3639.6360363963922;3668.2846844864994;3746.83139258734;3753.174301653632;3774.1319496515957;1067.9519421626046;1153.5270539078938;1157.6006277834133;1174.2191442690687;1227.2084505494086;34364.82817585946;34382.82808585941;34727;34763.478547821804;35306.23365845578;1211.7213041000618;1230.9815352769715;1242.944067516964;1282.8774822030723;1306.79744639581;17758.733618995724;18105.094745262682;18433.631327373376;18437.81562184361;18585.628287434447;516811;520485;521995;523914;525557;65457.36356591028;65934.34065659282;66042;66086.66956665186;66305.33694663088;1449.7825326201155;1454.789055586934;1542.8225754038428;1551.4569900534948;1599.8560129588393;31870.840645796623;32362.35275294528;32919.83540082284;33621.49567756535;33632.65469381197;49451.752741236065;50359.24461133159;50447.24329135139;50483.495165047876;50498.49501504938;293610;300820;300987;300994;301982;28445.715542844307;30888.69111308948;31420.842895785376;31868.84065579657;31879.521807173376;47326.763366182946;49236.75381623212;50365.74817125891;50614.746926266605;51294.74352628362;41986.79006605069;42115.7894210527;42507;42508.78745606252;43513.34729978989;41606.37590436085;42456.78771606122;42491;42515.36226956536;43773.81130943504;43271.56728432675;43426.782866085465;44163.77918110389;44491.332630011224;44812.77593612011;34991.82504087463;37055.81489951696;37240.441393378576;37982.43026354552;38118.809405952794;28999.56500652534;29236.415271694023;29386.412271754874;29543.704562954095;29583.85208074032 16:10:15 INFO - PROCESS | 7609 | |2;jquery.html;427.37597130902583;428.2206384380425;438.38844811487985;442.31478068558783;446.78107727213654;19277.228910843565;19341.806581934175;20034.89982550087;20295.492612684655;20330;21261.130833151517;21289.57420851586;21361.465963350925;21501.892490537564;21507.67738483924;5510.669359838413;5706.65760054396;5751.166080918264;5755.510781583549;5759.078547432412;4353.412289340946;5931.762729490815;6020.4280593343565;6187.721552530124;6437.935620643781;6430.16407866979;6448.64532450715;6456.58032227906;6461.321561236073;6469.8706025879455;5538.6399884007615;5791.652500849962;5796.623219490762;5804.477597016267;6408.198975128109;3975.6421922027157;5629.915551266693;5646.830595082154;5657.8585535361535;5867.266591676041;14227.78658320126;14458.783118253235;14461.276936153256;14940.925295373563;23123;2512.2839990602592;2576.716561178269;2630.579107342835;2743.231895069384;2987.4771914914804;10294.639687610897;10307.381557106597;10774.35353878762;12717.809232861515;13886.750192482625;1999.7701413630657;2087.1129769847907;2119.046429106908;2151.634222182233;2161.4164175672636;83143.58428207881;83430;86424;86594;87740.56129719438;11658.70853228676;12003.219790713576;12235.510579576718;12550.874491255154;12754.234745915275;16589.83410165907;16647.50057498277;16674.83325166757;16681;16686.33254669824;8486.915130848736;8703.564821758886;8786.16531429526;8797.604107815163;8872.201501864734;8261.297789687824;8276.917230827736;8325.791855203548;8409.201125893152;8563.100874408223;5158.535731784157;5160.92258616121;5173.379194496684;5215.947840521546;5287.286216360742;1814.1148183914524;2006.3880516442334;2035.5013021809752;2053.938381848547;2162.1135334512774;998.6804222648828;1140.8688000879838;1196.7008247938015;1198.1373411143963;1199.4422593493894;18172.000539970166;19329;19699;19879.801201988084;20064.416553764197;1084.219362059316;1101.7410908436511;1135.7047167736448;1150.235093662705;1160.4371879638368;11412.771744565061;11422.885771142348;11477.885221147848;11513.53945842157;11540.076793856471;513951;515542;519200;524946;528205;103420;105339.47330263453;105460;106267.46866265619;109925;1123.5393488669606;1142.765733024728;1154.6189757379877;1166.276908316849;1171.9296842189497;18137.727934080736;18236.142078301706;18403.723944141115;18592;18921.337753178574;41322.79338603288;41424.792876036634;42019.7899010503;42321;43630.78184609057;61886.381136188065;62254.37745622486;62495;63064;63127.36872631215;8370;8630.180132887366;8971.50656713887;9184.21934135606;9271.907280927104;13409.128406653535;13546;13617.931910340385;13732.038757286895;13929.512467063603;5923.229980102559;8215.507069575844;10869.130469562575;11667.6499705009;12411.131220814455;12032.398380080786;12232.860743855146;12302;12444.377781111089;12565.560205392767;11720.472578733807;12142.878571214529;12361.567345142877;12761.106722529334;12872.292023938398;8844.967621012169;9153.816923661356;9218.078192180728;9261.259099272176;9349.158575728217;11858.584949526725;12435;12511.499540018662;12521.686957826127;12678.492860285485 16:10:15 INFO - PROCESS | 7609 | |3;mootools.html;1406.3460490871742;1578.6921550297689;1591.2918751155737;1806.7922188948266;1925.6630089734292;7669.309762121408;8108.189181081896;8253.050899146592;8261.463004904677;8270.090290068103;8475.279601233902;8632.136786321365;8647.69733059343;8657.177568131034;8662.133786621334;2102.6845973104005;2150.9139634414605;2415;2458.8401753885987;2489.950200995979;2465.7287698353166;2485.962710559343;2489.166129346671;2489.850608963459;2490.987545062272;2367.597508423572;2369.858731411051;2374.442006128567;2379.0840526397287;2380.238323736405;2117.4071260047135;2347.0729062020578;2395.4011497125543;2470.22188010776;2478.4051827561434;2365.31405892291;2381.357033600935;2391.5097405031925;2391.928242152738;2396.101461951768;8440.029396619406;8483.490990540588;8506.319494440491;8508.532030738306;8519.957400213021;5238.371395432572;5317.202419637047;5421.051316019681;5436.2661040759385;5437.537809286216;3391.2200193955528;3544.0608238816735;3576.678098971105;3579.319929213441;3583.964160358389;1111.8443417921496;1117.932924024561;1144.301975794773;1146.3122126723981;1167.4221260476033;11738.237014594024;11750.764984700258;11769.88230117705;11778.293302401884;11779.116566257479;4769.403824521934;4800.73595952219;4819.879503012383;4889.779959901813;4907.779149938261;9652.951735241279;9661.13049825505;9714.465704386326;9736.367136136128;9747.31768776193;5340.118880384693;5394.460553944574;5394.946050539523;5409.24270602116;5409.513143817076;4381.211381951216;4460.330950357407;4496.842610508616;4912.484189160086;5045.192769156991;4240.321548552217;4320.200762858881;4329.891752706208;4380.759058251827;4518.864434066983;1393.5819254223693;1426.6576021754704;1431.8926080543793;1432.5988723157532;1444.3933547909903;1085.2294870641774;1093.0981939899614;1095.6767753512734;1102.327580176092;1103.0183137008069;5973.432523910222;6094.360092190344;6095.177151084636;6139.508839292846;6147.569670123048;470.1967952900664;476.1405662778649;476.8664773863324;477.5797298377475;479.9136155492045;4148.2947898857265;4156.231097247019;4242.8727138185905;4309.913801723948;4347.108842687241;9629.229661627052;9770.804583908282;9841.606335746634;9866.112049915399;9874;9536.380135291183;9575.521223938775;9689.41863488193;9693.903060969442;9699.369540979813;7858.803529911684;8008.399370047153;8031.477953932976;8036.397270204758;8041.597920103972;6086.72609732572;6193.163922870355;6243.157173781663;6276.843078923063;6414.583052101599;9326.860097098684;9395.684604155287;9416.387934784218;9448.385854919408;9455.19630831387;8990.190882820578;9228.077192280718;9232.769180770265;9370.67202647904;9397.483138427453;6558.278589355072;7248.927510725036;7418.18399976013;7424.96287518559;7564.432667550066;7997.800054998439;8013.439059265796;8043.19568043191;8060.879086813819;8079.555624440713;7095.751648692271;7205.135383753983;7251.492395532473;7366.152892417226;7568.167501574712;7112.928870711434;7162.319579639926;7281.599512026889;7697.191794861459;7791.844163116819;7227.7831665050135;7235.457340699574;7279.563226206445;7295.4528410368375;7296.817579560554;5003.3245511856885;5164.586833053271;5240.2663627093;5563.1655251710945;5737.995850726023;5075.11185542536;5122.231665250242;5128.435872053997;5173.04189435343;5215.843524694265 16:10:15 INFO - PROCESS | 7609 | |4;prototype.html;348.6513486513487;348.80815551446705;358.7184060512498;359.72840505418407;359.7805338743366;6287.402696743813;6302.873942521147;6326.746930122796;6364.268109167447;6372.171617689705;6267.40459656333;6273.529485288599;6280.591761535508;6295.401936815995;6302.275238347592;4554.863354099382;4676.251799712047;4800.111979283826;4811;4818.421789385278;4763.952360476403;4794.616430685537;4809.495003024685;4811.158047341719;4812;4593.73672240135;4763.166445871959;4772.594329481981;4774.069056533977;4774.832880849171;4654.557817007396;4772.737499437564;4778.976105119452;4796.904061918777;4802.927956080662;4197.874063778091;4200.810963506649;4201.34879093741;4203.873883783492;4227.302495088306;6054.364291749391;6059.515238780887;6062.090686397031;6065.302490213594;6081.483073938721;5518.889622207574;5522.641028333186;5531.529819965308;5532.585056120807;5542.8337149885565;6475.4819614430735;6614.702338394735;6628.767993120217;6638.4689224861895;6642.468602511787;4590.173768721629;4598.126355992385;4607.562281583244;4610.561996610317;4610.585047345721;6842.384185423336;6897.068895699117;6909.067275917737;6910.3089691031;6914.06660100885;4688.882777930579;4691.179043667345;4696.319033740157;4700.764961751899;4702.623790096784;4733.739644319596;4736.976315118402;4740.459350711033;4743.667943244009;4743.715377077387;5475.890482190334;5495;5511.5039646432015;5520;5525.060739674265;6501.382368674968;6668.83327916806;6670.533062685662;6676.232233293136;6679.76620818269;1649.4556796257446;1668.507790201869;1674.8660107191395;1676.5892356372767;1678.420944774051;1058.2433560004479;1077.5312738958578;1098.9725256868483;1113.5768408004906;1125.3416751200475;6242.469390101802;6292.370762923671;6293.590916590407;6307.621542707452;6440.838979025468;6825.795226143224;6847.965760171167;6863.519553631198;6868.484863635247;6880.105586273852;6415.1981002374705;6417.74329026843;6419.293877673452;6433.517486188554;6436.066770318278;3659.3779057560278;3698.1863989922176;3701.5002974598083;3708.8145592720257;3710.350688629533;7021.89467157993;7232.891506627405;7253.419726421874;7253.455990800606;7259.346658800733;7054.506184567031;7077;7083.5041547091205;7091.149062112477;7092.219855815856;7206.423486121098;7215.160134165754;7228.56628602275;7228.819279518054;7236.34872861445;6778.525503214925;6950.235474097744;6962.651867406711;6966;6969.128858892638;6810.114685090906;6836.726530938906;6837.384635382839;6842.315768423118;6857.5199736018;7154.713811447692;7174.713011479483;7199.1001124859395;7204.027456293334;7204.423646108404;4628;4662.836800711959;4665.883352916204;4666.183417901786;4669.9533004670875;6885.311468853075;6891.069705589681;6904.654767261717;6912.066870972555;6915.412189963909;6449.774257900951;6600.504962127956;6609.8432774265275;6626.171728533934;6702.899456508058;6652.73389064432;6689.331066893272;6719.395254427125;6780.25417204117;6810.727570897108;6615.900761488678;6623.4038936495945;6623.536352455282;6627.569208001464;6632;6777.762778302736;6784.830379240559;6786.728530858908;6787.524873258824;6795.116634837637;6409.71156297977;6601.438877695257;6609.966950165219;6619.801405957829;6623.569467984566 16:10:15 INFO - PROCESS | 7609 | |5;yui.html;827.7806381308955;892.2505095719598;916.9913095594846;949.4018768176048;962.9470379129153;15188.088714677113;15523.068615883041;15644.374225030984;15912.204389780523;16243.83756162438;13908.443662253523;13914.860851391482;13972.790408143886;14051.227182504957;14072.085314454578;766.8236305649704;892.5894088719197;919.0717375450793;926.305271046715;935.714607044851;924.856647219682;929.0152438415302;930.3580529434702;930.6882194464829;930.7766136127349;937.4656445825882;942.0814705661993;946.4652471353663;947.1002547579827;951.9333646644737;789.0964845252183;802.5184889066543;942.9292803039765;945.5697657565792;959.0265880131672;698.441247002396;700.1737949219919;701.7999870037015;702.4766548921086;703.359942452371;14734.18961957092;14971.625709357244;14977.026493277903;14982.925085374613;14994.775078373834;14924.70150596982;14936.850631493655;15060.774088388684;15297.388104475807;15437.459688910834;12333.876661233453;12607.243565386107;12704.745905081847;12715.554955576603;12877.291748953803;4077.429159917614;4080.979595102035;4092.7135100542973;4123.381492776108;4167;57457.71271143617;58638;58841.7057914712;59417;59536;11442.542298307975;11731.47208375625;12028.939855300667;12044.277343359427;12203.02375809933;20867.1653133876;20933.581328373348;21438.57122857534;22084.227052053102;22158.88920555387;9098.408603440756;9160.633574657073;9168.770780730401;9199.586018629177;9213.861792073125;5045.646804723634;5047.16721740916;5056.646034777604;5092.26162206478;5109.4379618241965;3694;3768.4724138620613;3770.2271034437877;3774.54705435344;3781.262653782541;709.6522703875064;713.6859781696037;716.0405057223346;721.3111478537984;738.7155944961229;635.5836926812945;764.9655765490567;780.2704471319335;791.4836360758283;823.9093699693029;10024.448655323882;10308.410196459225;10363.170946324275;10396.324238924446;10504.369737815756;727.2763600217817;813.7884150121012;826.277007618334;828.6519661742083;837.0917554453487;4715.269133284346;4717.622590192776;4738.526147385234;4800.919793046606;4820.39745031871;61124.694376527834;62509.374906250356;62641;62651;62883;54620.72689636526;54851;55843.44156558464;56247.43752562422;56253.71873140608;50662.240066399034;50752.238716419284;50958;51568.96862062738;52471.73764131155;8995.77510562215;9080.500572468578;9145.679901203426;9348.018458061806;9450.149486546245;38249.426258605585;39273.214535708554;39486.40770388389;39739.60260397359;40582.594174059064;45863.54136458593;49154;49286.75356623194;49366;50053.74973125111;11456.427178640868;11518.193726439069;11644.068474522188;11687.649370518899;11692.415379230833;12306.630801075624;12669.239845609292;12746.298953557643;12779.169353991962;12836;12467.688307792016;12641.304728239667;12666.620001399973;12672.936635316764;12692.238465692088;12457.937710311391;12460.875391246334;12497.375131243583;12663;12680.6829829255;12040.337781422106;12191.75616487683;12470.376481176087;12515.311657858541;12656.17734847232;10497.9475102624;10730.785384292427;10760.784784304113;10874.67375978722;10918.399488028235;10025.398476091457;10517.737056573647;10530;10643.361398316125;10652.8934710655 16:10:15 INFO - PROCESS | 7609 | __end_tp_report 16:10:15 INFO - PROCESS | 7609 | __start_cc_report 16:10:15 INFO - PROCESS | 7609 | _x_x_mozilla_cycle_collect,851 16:10:15 INFO - PROCESS | 7609 | __end_cc_report 16:10:15 INFO - PROCESS | 7609 | __startTimestamp1464649815811__endTimestamp 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | ------- Summary: start ------- 16:10:15 INFO - PROCESS | 7609 | Number of tests: 6 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | [#0] dojo.html Cycles:165 Average:5584.53 Median:5781.08 stddev:630.39 (10.9%) stddev-sans-first:607.45 16:10:15 INFO - PROCESS | 7609 | Values: 3349.8 3373.1 3400.5 3404.2 3424.0 5556.6 5562.5 5568.5 5597.0 5600.0 5546.6 5559.3 5593.1 5596.2 5638.5 4932.6 5016.3 5123.5 5173.2 5197.9 5105.8 5179.2 5185.8 5191.0 5192.1 5079.8 5116.7 5143.0 5145.0 5173.8 5132.2 5136.2 5143.1 5147.8 5177.5 4948.9 5000.1 5042.7 5046.5 5060.2 5412.4 5464.8 5465.5 5471.0 5481.0 6009.2 6021.4 6044.8 6045.3 6045.7 6027.8 6034.9 6053.7 6061.6 6064.5 5653.6 5692.1 5696.7 5703.1 5708.9 6018.8 6200.0 6209.0 6215.0 6219.0 5924.1 5985.4 5987.1 5997.7 6011.5 6096.9 6114.9 6115.1 6118.5 6123.8 5791.5 5927.7 6069.8 6082.9 6087.6 5937.6 5948.3 5949.1 5974.8 5984.6 4494.4 4496.1 4517.8 4538.5 4545.0 3993.7 4076.3 4079.8 4098.3 4135.6 5681.2 5746.1 5746.5 5751.3 5782.0 5958.9 6027.4 6028.5 6028.8 6040.3 5511.6 5647.3 5709.0 5738.7 5768.2 5164.5 5168.1 5170.9 5170.9 5173.1 6247.0 6250.5 6252.2 6256.2 6260.4 5834.6 5983.2 5992.9 6049.7 6062.5 6210.6 6242.8 6255.0 6261.7 6264.7 5771.5 5915.7 5920.2 5920.9 5965.2 6059.3 6118.1 6118.8 6119.1 6127.1 5848.4 5848.4 5849.1 5851.6 5855.6 5704.0 5763.3 5812.2 5831.6 5841.4 5737.7 5753.9 5759.6 5781.1 5789.5 5855.9 5860.3 5882.1 5891.8 5898.5 5601.7 5760.8 5781.7 5783.9 5845.4 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | [#1] ext.html Cycles:180 Average:55314.36 Median:37148.13 stddev:104850.52 (282.2%) stddev-sans-first:105064.38 16:10:15 INFO - PROCESS | 7609 | Values: 668.1 680.4 682.2 684.1 754.8 31907.7 39176.4 39747.4 39986.2 39994.8 42770.0 43526.1 43550.8 43654.3 43688.3 8098.4 8680.2 8906.5 10310.2 10544.9 10304.2 10436.5 10438.5 10460.5 10463.0 10534.1 10614.4 10619.7 10627.5 10629.3 8326.9 10334.2 10473.2 10473.9 10482.6 10536.6 10626.6 10647.9 10665.3 10669.7 40503.0 41218.0 41239.0 41299.0 41305.6 3762.9 3790.2 3939.2 4043.7 4130.0 34233.1 35054.3 35069.0 35239.0 35273.0 4571.5 4577.8 4680.8 4685.8 4697.3 322835.0 329857.0 330472.0 331537.0 331615.0 39029.2 40675.4 69181.7 70463.6 70546.6 39049.2 39197.2 39251.4 39274.0 39296.6 15776.8 16729.7 16999.8 17017.7 17019.8 12736.2 12828.9 13784.1 14025.6 14028.8 9211.9 9314.1 9402.6 9442.4 9444.5 3639.6 3668.3 3746.8 3753.2 3774.1 1068.0 1153.5 1157.6 1174.2 1227.2 34364.8 34382.8 34727.0 34763.5 35306.2 1211.7 1231.0 1242.9 1282.9 1306.8 17758.7 18105.1 18433.6 18437.8 18585.6 516811.0 520485.0 521995.0 523914.0 525557.0 65457.4 65934.3 66042.0 66086.7 66305.3 1449.8 1454.8 1542.8 1551.5 1599.9 31870.8 32362.4 32919.8 33621.5 33632.7 49451.8 50359.2 50447.2 50483.5 50498.5 293610.0 300820.0 300987.0 300994.0 301982.0 28445.7 30888.7 31420.8 31868.8 31879.5 47326.8 49236.8 50365.7 50614.7 51294.7 41986.8 42115.8 42507.0 42508.8 43513.3 41606.4 42456.8 42491.0 42515.4 43773.8 43271.6 43426.8 44163.8 44491.3 44812.8 34991.8 37055.8 37240.4 37982.4 38118.8 28999.6 29236.4 29386.4 29543.7 29583.9 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | [#2] jquery.html Cycles:180 Average:30685.87 Median:21431.68 stddev:86034.52 (401.4%) stddev-sans-first:86245.87 16:10:15 INFO - PROCESS | 7609 | Values: 427.4 428.2 438.4 442.3 446.8 19277.2 19341.8 20034.9 20295.5 20330.0 21261.1 21289.6 21361.5 21501.9 21507.7 5510.7 5706.7 5751.2 5755.5 5759.1 4353.4 5931.8 6020.4 6187.7 6437.9 6430.2 6448.6 6456.6 6461.3 6469.9 5538.6 5791.7 5796.6 5804.5 6408.2 3975.6 5629.9 5646.8 5657.9 5867.3 14227.8 14458.8 14461.3 14940.9 23123.0 2512.3 2576.7 2630.6 2743.2 2987.5 10294.6 10307.4 10774.4 12717.8 13886.8 1999.8 2087.1 2119.0 2151.6 2161.4 83143.6 83430.0 86424.0 86594.0 87740.6 11658.7 12003.2 12235.5 12550.9 12754.2 16589.8 16647.5 16674.8 16681.0 16686.3 8486.9 8703.6 8786.2 8797.6 8872.2 8261.3 8276.9 8325.8 8409.2 8563.1 5158.5 5160.9 5173.4 5215.9 5287.3 1814.1 2006.4 2035.5 2053.9 2162.1 998.7 1140.9 1196.7 1198.1 1199.4 18172.0 19329.0 19699.0 19879.8 20064.4 1084.2 1101.7 1135.7 1150.2 1160.4 11412.8 11422.9 11477.9 11513.5 11540.1 513951.0 515542.0 519200.0 524946.0 528205.0 103420.0 105339.5 105460.0 106267.5 109925.0 1123.5 1142.8 1154.6 1166.3 1171.9 18137.7 18236.1 18403.7 18592.0 18921.3 41322.8 41424.8 42019.8 42321.0 43630.8 61886.4 62254.4 62495.0 63064.0 63127.4 8370.0 8630.2 8971.5 9184.2 9271.9 13409.1 13546.0 13617.9 13732.0 13929.5 5923.2 8215.5 10869.1 11667.6 12411.1 12032.4 12232.9 12302.0 12444.4 12565.6 11720.5 12142.9 12361.6 12761.1 12872.3 8845.0 9153.8 9218.1 9261.3 9349.2 11858.6 12435.0 12511.5 12521.7 12678.5 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | [#3] mootools.html Cycles:180 Average:5637.70 Median:5367.29 stddev:3014.67 (56.2%) stddev-sans-first:3006.35 16:10:15 INFO - PROCESS | 7609 | Values: 1406.3 1578.7 1591.3 1806.8 1925.7 7669.3 8108.2 8253.1 8261.5 8270.1 8475.3 8632.1 8647.7 8657.2 8662.1 2102.7 2150.9 2415.0 2458.8 2490.0 2465.7 2486.0 2489.2 2489.9 2491.0 2367.6 2369.9 2374.4 2379.1 2380.2 2117.4 2347.1 2395.4 2470.2 2478.4 2365.3 2381.4 2391.5 2391.9 2396.1 8440.0 8483.5 8506.3 8508.5 8520.0 5238.4 5317.2 5421.1 5436.3 5437.5 3391.2 3544.1 3576.7 3579.3 3584.0 1111.8 1117.9 1144.3 1146.3 1167.4 11738.2 11750.8 11769.9 11778.3 11779.1 4769.4 4800.7 4819.9 4889.8 4907.8 9653.0 9661.1 9714.5 9736.4 9747.3 5340.1 5394.5 5394.9 5409.2 5409.5 4381.2 4460.3 4496.8 4912.5 5045.2 4240.3 4320.2 4329.9 4380.8 4518.9 1393.6 1426.7 1431.9 1432.6 1444.4 1085.2 1093.1 1095.7 1102.3 1103.0 5973.4 6094.4 6095.2 6139.5 6147.6 470.2 476.1 476.9 477.6 479.9 4148.3 4156.2 4242.9 4309.9 4347.1 9629.2 9770.8 9841.6 9866.1 9874.0 9536.4 9575.5 9689.4 9693.9 9699.4 7858.8 8008.4 8031.5 8036.4 8041.6 6086.7 6193.2 6243.2 6276.8 6414.6 9326.9 9395.7 9416.4 9448.4 9455.2 8990.2 9228.1 9232.8 9370.7 9397.5 6558.3 7248.9 7418.2 7425.0 7564.4 7997.8 8013.4 8043.2 8060.9 8079.6 7095.8 7205.1 7251.5 7366.2 7568.2 7112.9 7162.3 7281.6 7697.2 7791.8 7227.8 7235.5 7279.6 7295.5 7296.8 5003.3 5164.6 5240.3 5563.2 5738.0 5075.1 5122.2 5128.4 5173.0 5215.8 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | [#4] prototype.html Cycles:180 Average:5579.49 Median:6317.18 stddev:1700.26 (26.9%) stddev-sans-first:1659.09 16:10:15 INFO - PROCESS | 7609 | Values: 348.7 348.8 358.7 359.7 359.8 6287.4 6302.9 6326.7 6364.3 6372.2 6267.4 6273.5 6280.6 6295.4 6302.3 4554.9 4676.3 4800.1 4811.0 4818.4 4764.0 4794.6 4809.5 4811.2 4812.0 4593.7 4763.2 4772.6 4774.1 4774.8 4654.6 4772.7 4779.0 4796.9 4802.9 4197.9 4200.8 4201.3 4203.9 4227.3 6054.4 6059.5 6062.1 6065.3 6081.5 5518.9 5522.6 5531.5 5532.6 5542.8 6475.5 6614.7 6628.8 6638.5 6642.5 4590.2 4598.1 4607.6 4610.6 4610.6 6842.4 6897.1 6909.1 6910.3 6914.1 4688.9 4691.2 4696.3 4700.8 4702.6 4733.7 4737.0 4740.5 4743.7 4743.7 5475.9 5495.0 5511.5 5520.0 5525.1 6501.4 6668.8 6670.5 6676.2 6679.8 1649.5 1668.5 1674.9 1676.6 1678.4 1058.2 1077.5 1099.0 1113.6 1125.3 6242.5 6292.4 6293.6 6307.6 6440.8 6825.8 6848.0 6863.5 6868.5 6880.1 6415.2 6417.7 6419.3 6433.5 6436.1 3659.4 3698.2 3701.5 3708.8 3710.4 7021.9 7232.9 7253.4 7253.5 7259.3 7054.5 7077.0 7083.5 7091.1 7092.2 7206.4 7215.2 7228.6 7228.8 7236.3 6778.5 6950.2 6962.7 6966.0 6969.1 6810.1 6836.7 6837.4 6842.3 6857.5 7154.7 7174.7 7199.1 7204.0 7204.4 4628.0 4662.8 4665.9 4666.2 4670.0 6885.3 6891.1 6904.7 6912.1 6915.4 6449.8 6600.5 6609.8 6626.2 6702.9 6652.7 6689.3 6719.4 6780.3 6810.7 6615.9 6623.4 6623.5 6627.6 6632.0 6777.8 6784.8 6786.7 6787.5 6795.1 6409.7 6601.4 6610.0 6619.8 6623.6 16:10:15 INFO - PROCESS | 7609 | 16:10:15 INFO - PROCESS | 7609 | [#5] yui.html Cycles:180 Average:15526.85 Median:25289.41 stddev:17790.08 (70.3%) stddev-sans-first:17805.74 16:10:15 INFO - PROCESS | 7609 | Values: 827.8 892.3 917.0 949.4 962.9 15188.1 15523.1 15644.4 15912.2 16243.8 13908.4 13914.9 13972.8 14051.2 14072.1 766.8 892.6 919.1 926.3 935.7 924.9 929.0 930.4 930.7 930.8 937.5 942.1 946.5 947.1 951.9 789.1 802.5 942.9 945.6 959.0 698.4 700.2 701.8 702.5 703.4 14734.2 14971.6 14977.0 14982.9 14994.8 14924.7 14936.9 15060.8 15297.4 15437.5 12333.9 12607.2 12704.7 12715.6 12877.3 4077.4 4081.0 4092.7 4123.4 4167.0 57457.7 58638.0 58841.7 59417.0 59536.0 11442.5 11731.5 12028.9 12044.3 12203.0 20867.2 20933.6 21438.6 22084.2 22158.9 9098.4 9160.6 9168.8 9199.6 9213.9 5045.6 5047.2 5056.6 5092.3 5109.4 3694.0 3768.5 3770.2 3774.5 3781.3 709.7 713.7 716.0 721.3 738.7 635.6 765.0 780.3 791.5 823.9 10024.4 10308.4 10363.2 10396.3 10504.4 727.3 813.8 826.3 828.7 837.1 4715.3 4717.6 4738.5 4800.9 4820.4 61124.7 62509.4 62641.0 62651.0 62883.0 54620.7 54851.0 55843.4 56247.4 56253.7 50662.2 50752.2 50958.0 51569.0 52471.7 8995.8 9080.5 9145.7 9348.0 9450.1 38249.4 39273.2 39486.4 39739.6 40582.6 45863.5 49154.0 49286.8 49366.0 50053.7 11456.4 11518.2 11644.1 11687.6 11692.4 12306.6 12669.2 12746.3 12779.2 12836.0 12467.7 12641.3 12666.6 12672.9 12692.2 12457.9 12460.9 12497.4 12663.0 12680.7 12040.3 12191.8 12470.4 12515.3 12656.2 10497.9 10730.8 10760.8 10874.7 10918.4 10025.4 10517.7 10530.0 10643.4 10652.9 16:10:15 INFO - PROCESS | 7609 | -------- Summary: end -------- 16:10:15 INFO - PROCESS | 7609 | 16:10:16 INFO - TEST-INFO | 7609: exit 0 16:10:16 INFO - TEST-OK | dromaeo_css | took 1111164ms 16:10:16 INFO - TEST-START | kraken 16:10:16 INFO - operating with platform_type : linux_ 16:10:16 INFO - Initialising browser for kraken test... 16:10:16 INFO - TEST-INFO | started process 7801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGWeH7c/profile http://localhost:51769/getInfo.html) 16:10:20 INFO - PROCESS | 7801 | __metrics Screen width/height:1600/1200 16:10:20 INFO - PROCESS | 7801 | colorDepth:24 16:10:20 INFO - PROCESS | 7801 | Browser inner width/height: 1024/697 16:10:20 INFO - PROCESS | 7801 | __metrics 16:10:21 ERROR - PROCESS | 7801 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:10:22 INFO - TEST-INFO | 7801: exit 0 16:10:22 INFO - Browser initialized. 16:10:22 INFO - Running cycle 1/1 for kraken test... 16:10:22 INFO - TEST-INFO | started process 7890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGWeH7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:34 INFO - PROCESS | 7890 | RSS: Main: 141672448 16:10:34 INFO - PROCESS | 7890 | 16:10:36 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:37 INFO - PROCESS | 7890 | RSS: Main: 196816896 16:10:37 INFO - PROCESS | 7890 | 16:10:40 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-dft) 16:10:40 INFO - PROCESS | 7890 | RSS: Main: 181596160 16:10:40 INFO - PROCESS | 7890 | 16:10:43 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-fft) 16:10:44 INFO - PROCESS | 7890 | RSS: Main: 272134144 16:10:44 INFO - PROCESS | 7890 | 16:10:46 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-oscillator) 16:10:46 INFO - PROCESS | 7890 | RSS: Main: 177545216 16:10:46 INFO - PROCESS | 7890 | 16:10:48 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:49 INFO - PROCESS | 7890 | RSS: Main: 176365568 16:10:49 INFO - PROCESS | 7890 | 16:10:52 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:53 INFO - PROCESS | 7890 | RSS: Main: 211247104 16:10:53 INFO - PROCESS | 7890 | 16:10:56 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:57 INFO - PROCESS | 7890 | RSS: Main: 211275776 16:10:57 INFO - PROCESS | 7890 | 16:10:59 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51769/tests/kraken/driver.html?testName=json-parse-financial) 16:11:00 INFO - PROCESS | 7890 | RSS: Main: 211968000 16:11:00 INFO - PROCESS | 7890 | 16:11:01 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:02 INFO - PROCESS | 7890 | RSS: Main: 190877696 16:11:02 INFO - PROCESS | 7890 | 16:11:04 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:04 INFO - PROCESS | 7890 | RSS: Main: 195297280 16:11:04 INFO - PROCESS | 7890 | 16:11:06 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:07 INFO - PROCESS | 7890 | RSS: Main: 206950400 16:11:07 INFO - PROCESS | 7890 | 16:11:09 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:10 INFO - PROCESS | 7890 | RSS: Main: 211091456 16:11:10 INFO - PROCESS | 7890 | 16:11:13 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:13 INFO - PROCESS | 7890 | RSS: Main: 208130048 16:11:13 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51769/tests/kraken/driver.html?testName=ai-astar) 16:11:15 INFO - PROCESS | 7890 | RSS: Main: 272601088 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | __start_tp_report 16:11:15 INFO - PROCESS | 7890 | _x_x_mozilla_page_load 16:11:15 INFO - PROCESS | 7890 | _x_x_mozilla_page_load_details 16:11:15 INFO - PROCESS | 7890 | |i|pagename|runs| 16:11:15 INFO - PROCESS | 7890 | |0;ai-astar;111;110;111;111;112;112;105;110;111;110 16:11:15 INFO - PROCESS | 7890 | |1;audio-beat-detection;165;125;156;166;128;153;153;127;184;139 16:11:15 INFO - PROCESS | 7890 | |2;audio-dft;161;160;161;160;160;161;161;160;160;161 16:11:15 INFO - PROCESS | 7890 | |3;audio-fft;74;76;73;168;77;77;76;75;173;76 16:11:15 INFO - PROCESS | 7890 | |4;audio-oscillator;92;91;155;93;92;93;151;102;93;143 16:11:15 INFO - PROCESS | 7890 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;116 16:11:15 INFO - PROCESS | 7890 | |6;imaging-darkroom;145;145;146;145;145;146;145;146;145;146 16:11:15 INFO - PROCESS | 7890 | |7;imaging-desaturate;95;96;95;95;94;94;95;95;95;94 16:11:15 INFO - PROCESS | 7890 | |8;json-parse-financial;53;54;55;53;53;53;54;74;54;53 16:11:15 INFO - PROCESS | 7890 | |9;json-stringify-tinderbox;57;57;58;57;58;57;57;59;58;58 16:11:15 INFO - PROCESS | 7890 | |10;stanford-crypto-aes;80;72;71;74;73;73;74;73;73;73 16:11:15 INFO - PROCESS | 7890 | |11;stanford-crypto-ccm;114;112;110;110;119;119;114;112;133;141 16:11:15 INFO - PROCESS | 7890 | |12;stanford-crypto-pbkdf2;158;155;158;165;157;158;154;160;152;156 16:11:15 INFO - PROCESS | 7890 | |13;stanford-crypto-sha256-iterative;65;73;66;66;67;64;68;66;66;66 16:11:15 INFO - PROCESS | 7890 | __end_tp_report 16:11:15 INFO - PROCESS | 7890 | __start_cc_report 16:11:15 INFO - PROCESS | 7890 | _x_x_mozilla_cycle_collect,1618 16:11:15 INFO - PROCESS | 7890 | __end_cc_report 16:11:15 INFO - PROCESS | 7890 | __startTimestamp1464649875633__endTimestamp 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | ------- Summary: start ------- 16:11:15 INFO - PROCESS | 7890 | Number of tests: 14 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.00 (1.8%) stddev-sans-first:2.11 16:11:15 INFO - PROCESS | 7890 | Values: 111.0 110.0 111.0 111.0 112.0 112.0 105.0 110.0 111.0 110.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:154.50 stddev:19.57 (12.7%) stddev-sans-first:19.95 16:11:15 INFO - PROCESS | 7890 | Values: 165.0 125.0 156.0 166.0 128.0 153.0 153.0 127.0 184.0 139.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 16:11:15 INFO - PROCESS | 7890 | Values: 161.0 160.0 161.0 160.0 160.0 161.0 161.0 160.0 160.0 161.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:40.09 (52.8%) stddev-sans-first:41.83 16:11:15 INFO - PROCESS | 7890 | Values: 74.0 76.0 73.0 168.0 77.0 77.0 76.0 75.0 173.0 76.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:27.35 (29.7%) stddev-sans-first:28.18 16:11:15 INFO - PROCESS | 7890 | Values: 92.0 91.0 155.0 93.0 92.0 93.0 151.0 102.0 93.0 143.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:11:15 INFO - PROCESS | 7890 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:11:15 INFO - PROCESS | 7890 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:11:15 INFO - PROCESS | 7890 | Values: 95.0 96.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.00 stddev:6.50 (12.0%) stddev-sans-first:6.83 16:11:15 INFO - PROCESS | 7890 | Values: 53.0 54.0 55.0 53.0 53.0 53.0 54.0 74.0 54.0 53.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 16:11:15 INFO - PROCESS | 7890 | Values: 57.0 57.0 58.0 57.0 58.0 57.0 57.0 59.0 58.0 58.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:2.41 (3.3%) stddev-sans-first:0.93 16:11:15 INFO - PROCESS | 7890 | Values: 80.0 72.0 71.0 74.0 73.0 73.0 74.0 73.0 73.0 73.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:116.50 stddev:10.47 (9.0%) stddev-sans-first:10.98 16:11:15 INFO - PROCESS | 7890 | Values: 114.0 112.0 110.0 110.0 119.0 119.0 114.0 112.0 133.0 141.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:158.00 stddev:3.56 (2.3%) stddev-sans-first:3.77 16:11:15 INFO - PROCESS | 7890 | Values: 158.0 155.0 158.0 165.0 157.0 158.0 154.0 160.0 152.0 156.0 16:11:15 INFO - PROCESS | 7890 | 16:11:15 INFO - PROCESS | 7890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:2.45 (3.7%) stddev-sans-first:2.52 16:11:15 INFO - PROCESS | 7890 | Values: 65.0 73.0 66.0 66.0 67.0 64.0 68.0 66.0 66.0 66.0 16:11:15 INFO - PROCESS | 7890 | -------- Summary: end -------- 16:11:15 INFO - PROCESS | 7890 | 16:11:16 INFO - TEST-INFO | 7890: exit 0 16:11:16 INFO - TEST-OK | kraken | took 60108ms 16:11:16 INFO - SUITE-END | took 1171s 16:11:16 INFO - Completed test suite (00:19:31) 16:11:16 INFO - javascript benchmark 16:11:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.7990120592767, 3373.139849338418, 3400.5409269748584, 3404.200012996947, 3423.9657603423957, 5556.583256255782, 5562.499375056244, 5568.49883510484, 5597.048501754702, 5599.972000139994, 5546.639468434559, 5559.305086864142, 5593.077142271521, 5596.244506991555, 5638.520725738307, 4932.605391568666, 5016.297718319438, 5123.487651234866, 5173.172292433212, 5197.922031169516, 5105.795768169287, 5179.197224430201, 5185.818496352628, 5190.974045129788, 5192.1173400522, 5079.847604571869, 5116.744162791864, 5143.0, 5145.0, 5173.844784656448, 5132.178851383798, 5136.229565565158, 5143.12566863634, 5147.794088236466, 5177.508136726986, 4948.87627809304, 5000.149974504343, 5042.722650254234, 5046.545810877039, 5060.240963855451, 5412.377576578704, 5464.781408743645, 5465.480779325958, 5470.972645136789, 5481.040817856899, 6009.248843894513, 6021.397860213988, 6044.788432404845, 6045.33501314855, 6045.6674882881425, 6027.819165425044, 6034.943884820139, 6053.735855060381, 6061.636301821904, 6064.49686473576, 5653.575981801381, 5692.0608099663505, 5696.743646535916, 5703.144528320785, 5708.885822283572, 6018.803792562009, 6200.0, 6209.037599172136, 6215.0, 6218.968905155536, 5924.081767326072, 5985.371535988746, 5987.1318658794235, 5997.730102145414, 6011.458968692838, 6096.908546371808, 6114.908276375858, 6115.113308570232, 6118.479929205978, 6123.84690382744, 5791.48070589295, 5927.703614819242, 6069.757209711562, 6082.908756368658, 6087.573869829158, 5937.584369094122, 5948.256467941507, 5949.10763385487, 5974.820755377345, 5984.611000284967, 4494.438195225597, 4496.055828276033, 4517.819287228474, 4538.523455037173, 4544.97727511367, 3993.740406873544, 4076.3274059780397, 4079.7756123412905, 4098.262312783668, 4135.58644135584, 5681.204631351531, 5746.1093530502, 5746.482816546531, 5751.309842818889, 5782.0, 5958.940410595926, 6027.427394397525, 6028.457438830526, 6028.758849646053, 6040.275166979991, 5511.559075273968, 5647.265855438849, 5709.0, 5738.68437235956, 5768.163616275617, 5164.457731938092, 5168.095583272912, 5170.896582068338, 5170.922436163461, 5173.068847607392, 6246.968765156145, 6250.468710159687, 6252.187215661935, 6256.249250090018, 6260.436560709558, 5834.5624078194305, 5983.162357270073, 5992.850178745566, 6049.66726830011, 6062.454379105901, 6210.596311239755, 6242.812715618538, 6255.030470277115, 6261.65560894137, 6264.749410023548, 5771.538276937918, 5915.733791979285, 5920.200772895604, 5920.911186332122, 5965.224520812267, 6059.272887253558, 6118.101457354478, 6118.755249789959, 6119.136988619874, 6127.097902969212, 5848.356680765198, 5848.385919478394, 5849.064149736022, 5851.61964472308, 5855.560832937632, 5703.971480142573, 5763.279590051244, 5812.244408226903, 5831.620944638585, 5841.357450680507, 5737.684427356368, 5753.942460575341, 5759.625624334405, 5781.075027995501, 5789.478946894631, 5855.882882342415, 5860.267466566679, 5882.088276317178, 5891.823245302648, 5898.469137777621, 5601.747921343468, 5760.8271751847515, 5781.653100813965, 5783.8554036149435, 5845.41545845412], "value": 5543.067653343652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.0847239282183, 680.4114441008526, 682.2052309059945, 684.1174884399123, 754.8339365339623, 31907.72369105236, 39176.41235381468, 39747.40378894312, 39986.200275994466, 39994.800025999866, 42770.0, 43526.12947741051, 43550.782246088726, 43654.345184822174, 43688.34467482982, 8098.433109682324, 8680.218780309786, 8906.465612063264, 10310.175185985103, 10544.894551054505, 10304.227182961307, 10436.478176091203, 10438.478076096164, 10460.476976151162, 10463.0, 10534.104601108915, 10614.416207108607, 10619.734506637318, 10627.46862656868, 10629.255952083357, 8326.916730832674, 10334.173266138729, 10473.214508911786, 10473.895261047368, 10482.633107841266, 10536.631217907414, 10626.574937002511, 10647.881972392943, 10665.306755060896, 10669.733256668567, 40503.0, 41218.0, 41239.0, 41299.0, 41305.58694413077, 3762.9463750150003, 3790.1851102013197, 3939.231849789292, 4043.716939814214, 4129.97935010326, 34233.14417139567, 35054.298914021834, 35069.0, 35239.0, 35273.0, 4571.497135315112, 4577.793999270041, 4680.789364478573, 4685.812567497296, 4697.295405689139, 322835.0, 329857.0, 330472.0, 331537.0, 331615.0, 39029.21941561153, 40675.389869151986, 69181.65409173022, 70463.64768176229, 70546.64726676334, 39049.21901561953, 39197.21605567873, 39251.41122883159, 39274.0, 39296.60703392929, 15776.76334854978, 16729.665406691798, 16999.830001700073, 17017.659646806995, 17019.82980170207, 12736.172148810298, 12828.871711282767, 13784.104033237807, 14025.649358765908, 14028.789568156486, 9211.861822072675, 9314.115159059878, 9402.623895044258, 9442.38624489406, 9444.48055356962, 3639.6360363963922, 3668.2846844864994, 3746.83139258734, 3753.174301653632, 3774.1319496515957, 1067.9519421626046, 1153.5270539078938, 1157.6006277834133, 1174.2191442690687, 1227.2084505494086, 34364.82817585946, 34382.82808585941, 34727.0, 34763.478547821804, 35306.23365845578, 1211.7213041000618, 1230.9815352769715, 1242.944067516964, 1282.8774822030723, 1306.79744639581, 17758.733618995724, 18105.094745262682, 18433.631327373376, 18437.81562184361, 18585.628287434447, 516811.0, 520485.0, 521995.0, 523914.0, 525557.0, 65457.36356591028, 65934.34065659282, 66042.0, 66086.66956665186, 66305.33694663088, 1449.7825326201155, 1454.789055586934, 1542.8225754038428, 1551.4569900534948, 1599.8560129588393, 31870.840645796623, 32362.35275294528, 32919.83540082284, 33621.49567756535, 33632.65469381197, 49451.752741236065, 50359.24461133159, 50447.24329135139, 50483.495165047876, 50498.49501504938, 293610.0, 300820.0, 300987.0, 300994.0, 301982.0, 28445.715542844307, 30888.69111308948, 31420.842895785376, 31868.84065579657, 31879.521807173376, 47326.763366182946, 49236.75381623212, 50365.74817125891, 50614.746926266605, 51294.74352628362, 41986.79006605069, 42115.7894210527, 42507.0, 42508.78745606252, 43513.34729978989, 41606.37590436085, 42456.78771606122, 42491.0, 42515.36226956536, 43773.81130943504, 43271.56728432675, 43426.782866085465, 44163.77918110389, 44491.332630011224, 44812.77593612011, 34991.82504087463, 37055.81489951696, 37240.441393378576, 37982.43026354552, 38118.809405952794, 28999.56500652534, 29236.415271694023, 29386.412271754874, 29543.704562954095, 29583.85208074032], "value": 19942.288242249724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.37597130902583, 428.2206384380425, 438.38844811487985, 442.31478068558783, 446.78107727213654, 19277.228910843565, 19341.806581934175, 20034.89982550087, 20295.492612684655, 20330.0, 21261.130833151517, 21289.57420851586, 21361.465963350925, 21501.892490537564, 21507.67738483924, 5510.669359838413, 5706.65760054396, 5751.166080918264, 5755.510781583549, 5759.078547432412, 4353.412289340946, 5931.762729490815, 6020.4280593343565, 6187.721552530124, 6437.935620643781, 6430.16407866979, 6448.64532450715, 6456.58032227906, 6461.321561236073, 6469.8706025879455, 5538.6399884007615, 5791.652500849962, 5796.623219490762, 5804.477597016267, 6408.198975128109, 3975.6421922027157, 5629.915551266693, 5646.830595082154, 5657.8585535361535, 5867.266591676041, 14227.78658320126, 14458.783118253235, 14461.276936153256, 14940.925295373563, 23123.0, 2512.2839990602592, 2576.716561178269, 2630.579107342835, 2743.231895069384, 2987.4771914914804, 10294.639687610897, 10307.381557106597, 10774.35353878762, 12717.809232861515, 13886.750192482625, 1999.7701413630657, 2087.1129769847907, 2119.046429106908, 2151.634222182233, 2161.4164175672636, 83143.58428207881, 83430.0, 86424.0, 86594.0, 87740.56129719438, 11658.70853228676, 12003.219790713576, 12235.510579576718, 12550.874491255154, 12754.234745915275, 16589.83410165907, 16647.50057498277, 16674.83325166757, 16681.0, 16686.33254669824, 8486.915130848736, 8703.564821758886, 8786.16531429526, 8797.604107815163, 8872.201501864734, 8261.297789687824, 8276.917230827736, 8325.791855203548, 8409.201125893152, 8563.100874408223, 5158.535731784157, 5160.92258616121, 5173.379194496684, 5215.947840521546, 5287.286216360742, 1814.1148183914524, 2006.3880516442334, 2035.5013021809752, 2053.938381848547, 2162.1135334512774, 998.6804222648828, 1140.8688000879838, 1196.7008247938015, 1198.1373411143963, 1199.4422593493894, 18172.000539970166, 19329.0, 19699.0, 19879.801201988084, 20064.416553764197, 1084.219362059316, 1101.7410908436511, 1135.7047167736448, 1150.235093662705, 1160.4371879638368, 11412.771744565061, 11422.885771142348, 11477.885221147848, 11513.53945842157, 11540.076793856471, 513951.0, 515542.0, 519200.0, 524946.0, 528205.0, 103420.0, 105339.47330263453, 105460.0, 106267.46866265619, 109925.0, 1123.5393488669606, 1142.765733024728, 1154.6189757379877, 1166.276908316849, 1171.9296842189497, 18137.727934080736, 18236.142078301706, 18403.723944141115, 18592.0, 18921.337753178574, 41322.79338603288, 41424.792876036634, 42019.7899010503, 42321.0, 43630.78184609057, 61886.381136188065, 62254.37745622486, 62495.0, 63064.0, 63127.36872631215, 8370.0, 8630.180132887366, 8971.50656713887, 9184.21934135606, 9271.907280927104, 13409.128406653535, 13546.0, 13617.931910340385, 13732.038757286895, 13929.512467063603, 5923.229980102559, 8215.507069575844, 10869.130469562575, 11667.6499705009, 12411.131220814455, 12032.398380080786, 12232.860743855146, 12302.0, 12444.377781111089, 12565.560205392767, 11720.472578733807, 12142.878571214529, 12361.567345142877, 12761.106722529334, 12872.292023938398, 8844.967621012169, 9153.816923661356, 9218.078192180728, 9261.259099272176, 9349.158575728217, 11858.584949526725, 12435.0, 12511.499540018662, 12521.686957826127, 12678.492860285485], "value": 9692.73235294584, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.3460490871742, 1578.6921550297689, 1591.2918751155737, 1806.7922188948266, 1925.6630089734292, 7669.309762121408, 8108.189181081896, 8253.050899146592, 8261.463004904677, 8270.090290068103, 8475.279601233902, 8632.136786321365, 8647.69733059343, 8657.177568131034, 8662.133786621334, 2102.6845973104005, 2150.9139634414605, 2415.0, 2458.8401753885987, 2489.950200995979, 2465.7287698353166, 2485.962710559343, 2489.166129346671, 2489.850608963459, 2490.987545062272, 2367.597508423572, 2369.858731411051, 2374.442006128567, 2379.0840526397287, 2380.238323736405, 2117.4071260047135, 2347.0729062020578, 2395.4011497125543, 2470.22188010776, 2478.4051827561434, 2365.31405892291, 2381.357033600935, 2391.5097405031925, 2391.928242152738, 2396.101461951768, 8440.029396619406, 8483.490990540588, 8506.319494440491, 8508.532030738306, 8519.957400213021, 5238.371395432572, 5317.202419637047, 5421.051316019681, 5436.2661040759385, 5437.537809286216, 3391.2200193955528, 3544.0608238816735, 3576.678098971105, 3579.319929213441, 3583.964160358389, 1111.8443417921496, 1117.932924024561, 1144.301975794773, 1146.3122126723981, 1167.4221260476033, 11738.237014594024, 11750.764984700258, 11769.88230117705, 11778.293302401884, 11779.116566257479, 4769.403824521934, 4800.73595952219, 4819.879503012383, 4889.779959901813, 4907.779149938261, 9652.951735241279, 9661.13049825505, 9714.465704386326, 9736.367136136128, 9747.31768776193, 5340.118880384693, 5394.460553944574, 5394.946050539523, 5409.24270602116, 5409.513143817076, 4381.211381951216, 4460.330950357407, 4496.842610508616, 4912.484189160086, 5045.192769156991, 4240.321548552217, 4320.200762858881, 4329.891752706208, 4380.759058251827, 4518.864434066983, 1393.5819254223693, 1426.6576021754704, 1431.8926080543793, 1432.5988723157532, 1444.3933547909903, 1085.2294870641774, 1093.0981939899614, 1095.6767753512734, 1102.327580176092, 1103.0183137008069, 5973.432523910222, 6094.360092190344, 6095.177151084636, 6139.508839292846, 6147.569670123048, 470.1967952900664, 476.1405662778649, 476.8664773863324, 477.5797298377475, 479.9136155492045, 4148.2947898857265, 4156.231097247019, 4242.8727138185905, 4309.913801723948, 4347.108842687241, 9629.229661627052, 9770.804583908282, 9841.606335746634, 9866.112049915399, 9874.0, 9536.380135291183, 9575.521223938775, 9689.41863488193, 9693.903060969442, 9699.369540979813, 7858.803529911684, 8008.399370047153, 8031.477953932976, 8036.397270204758, 8041.597920103972, 6086.72609732572, 6193.163922870355, 6243.157173781663, 6276.843078923063, 6414.583052101599, 9326.860097098684, 9395.684604155287, 9416.387934784218, 9448.385854919408, 9455.19630831387, 8990.190882820578, 9228.077192280718, 9232.769180770265, 9370.67202647904, 9397.483138427453, 6558.278589355072, 7248.927510725036, 7418.18399976013, 7424.96287518559, 7564.432667550066, 7997.800054998439, 8013.439059265796, 8043.19568043191, 8060.879086813819, 8079.555624440713, 7095.751648692271, 7205.135383753983, 7251.492395532473, 7366.152892417226, 7568.167501574712, 7112.928870711434, 7162.319579639926, 7281.599512026889, 7697.191794861459, 7791.844163116819, 7227.7831665050135, 7235.457340699574, 7279.563226206445, 7295.4528410368375, 7296.817579560554, 5003.3245511856885, 5164.586833053271, 5240.2663627093, 5563.1655251710945, 5737.995850726023, 5075.11185542536, 5122.231665250242, 5128.435872053997, 5173.04189435343, 5215.843524694265], "value": 4551.406417750407, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6513486513487, 348.80815551446705, 358.7184060512498, 359.72840505418407, 359.7805338743366, 6287.402696743813, 6302.873942521147, 6326.746930122796, 6364.268109167447, 6372.171617689705, 6267.40459656333, 6273.529485288599, 6280.591761535508, 6295.401936815995, 6302.275238347592, 4554.863354099382, 4676.251799712047, 4800.111979283826, 4811.0, 4818.421789385278, 4763.952360476403, 4794.616430685537, 4809.495003024685, 4811.158047341719, 4812.0, 4593.73672240135, 4763.166445871959, 4772.594329481981, 4774.069056533977, 4774.832880849171, 4654.557817007396, 4772.737499437564, 4778.976105119452, 4796.904061918777, 4802.927956080662, 4197.874063778091, 4200.810963506649, 4201.34879093741, 4203.873883783492, 4227.302495088306, 6054.364291749391, 6059.515238780887, 6062.090686397031, 6065.302490213594, 6081.483073938721, 5518.889622207574, 5522.641028333186, 5531.529819965308, 5532.585056120807, 5542.8337149885565, 6475.4819614430735, 6614.702338394735, 6628.767993120217, 6638.4689224861895, 6642.468602511787, 4590.173768721629, 4598.126355992385, 4607.562281583244, 4610.561996610317, 4610.585047345721, 6842.384185423336, 6897.068895699117, 6909.067275917737, 6910.3089691031, 6914.06660100885, 4688.882777930579, 4691.179043667345, 4696.319033740157, 4700.764961751899, 4702.623790096784, 4733.739644319596, 4736.976315118402, 4740.459350711033, 4743.667943244009, 4743.715377077387, 5475.890482190334, 5495.0, 5511.5039646432015, 5520.0, 5525.060739674265, 6501.382368674968, 6668.83327916806, 6670.533062685662, 6676.232233293136, 6679.76620818269, 1649.4556796257446, 1668.507790201869, 1674.8660107191395, 1676.5892356372767, 1678.420944774051, 1058.2433560004479, 1077.5312738958578, 1098.9725256868483, 1113.5768408004906, 1125.3416751200475, 6242.469390101802, 6292.370762923671, 6293.590916590407, 6307.621542707452, 6440.838979025468, 6825.795226143224, 6847.965760171167, 6863.519553631198, 6868.484863635247, 6880.105586273852, 6415.1981002374705, 6417.74329026843, 6419.293877673452, 6433.517486188554, 6436.066770318278, 3659.3779057560278, 3698.1863989922176, 3701.5002974598083, 3708.8145592720257, 3710.350688629533, 7021.89467157993, 7232.891506627405, 7253.419726421874, 7253.455990800606, 7259.346658800733, 7054.506184567031, 7077.0, 7083.5041547091205, 7091.149062112477, 7092.219855815856, 7206.423486121098, 7215.160134165754, 7228.56628602275, 7228.819279518054, 7236.34872861445, 6778.525503214925, 6950.235474097744, 6962.651867406711, 6966.0, 6969.128858892638, 6810.114685090906, 6836.726530938906, 6837.384635382839, 6842.315768423118, 6857.5199736018, 7154.713811447692, 7174.713011479483, 7199.1001124859395, 7204.027456293334, 7204.423646108404, 4628.0, 4662.836800711959, 4665.883352916204, 4666.183417901786, 4669.9533004670875, 6885.311468853075, 6891.069705589681, 6904.654767261717, 6912.066870972555, 6915.412189963909, 6449.774257900951, 6600.504962127956, 6609.8432774265275, 6626.171728533934, 6702.899456508058, 6652.73389064432, 6689.331066893272, 6719.395254427125, 6780.25417204117, 6810.727570897108, 6615.900761488678, 6623.4038936495945, 6623.536352455282, 6627.569208001464, 6632.0, 6777.762778302736, 6784.830379240559, 6786.728530858908, 6787.524873258824, 6795.116634837637, 6409.71156297977, 6601.438877695257, 6609.966950165219, 6619.801405957829, 6623.569467984566], "value": 5024.339196432739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.7806381308955, 892.2505095719598, 916.9913095594846, 949.4018768176048, 962.9470379129153, 15188.088714677113, 15523.068615883041, 15644.374225030984, 15912.204389780523, 16243.83756162438, 13908.443662253523, 13914.860851391482, 13972.790408143886, 14051.227182504957, 14072.085314454578, 766.8236305649704, 892.5894088719197, 919.0717375450793, 926.305271046715, 935.714607044851, 924.856647219682, 929.0152438415302, 930.3580529434702, 930.6882194464829, 930.7766136127349, 937.4656445825882, 942.0814705661993, 946.4652471353663, 947.1002547579827, 951.9333646644737, 789.0964845252183, 802.5184889066543, 942.9292803039765, 945.5697657565792, 959.0265880131672, 698.441247002396, 700.1737949219919, 701.7999870037015, 702.4766548921086, 703.359942452371, 14734.18961957092, 14971.625709357244, 14977.026493277903, 14982.925085374613, 14994.775078373834, 14924.70150596982, 14936.850631493655, 15060.774088388684, 15297.388104475807, 15437.459688910834, 12333.876661233453, 12607.243565386107, 12704.745905081847, 12715.554955576603, 12877.291748953803, 4077.429159917614, 4080.979595102035, 4092.7135100542973, 4123.381492776108, 4167.0, 57457.71271143617, 58638.0, 58841.7057914712, 59417.0, 59536.0, 11442.542298307975, 11731.47208375625, 12028.939855300667, 12044.277343359427, 12203.02375809933, 20867.1653133876, 20933.581328373348, 21438.57122857534, 22084.227052053102, 22158.88920555387, 9098.408603440756, 9160.633574657073, 9168.770780730401, 9199.586018629177, 9213.861792073125, 5045.646804723634, 5047.16721740916, 5056.646034777604, 5092.26162206478, 5109.4379618241965, 3694.0, 3768.4724138620613, 3770.2271034437877, 3774.54705435344, 3781.262653782541, 709.6522703875064, 713.6859781696037, 716.0405057223346, 721.3111478537984, 738.7155944961229, 635.5836926812945, 764.9655765490567, 780.2704471319335, 791.4836360758283, 823.9093699693029, 10024.448655323882, 10308.410196459225, 10363.170946324275, 10396.324238924446, 10504.369737815756, 727.2763600217817, 813.7884150121012, 826.277007618334, 828.6519661742083, 837.0917554453487, 4715.269133284346, 4717.622590192776, 4738.526147385234, 4800.919793046606, 4820.39745031871, 61124.694376527834, 62509.374906250356, 62641.0, 62651.0, 62883.0, 54620.72689636526, 54851.0, 55843.44156558464, 56247.43752562422, 56253.71873140608, 50662.240066399034, 50752.238716419284, 50958.0, 51568.96862062738, 52471.73764131155, 8995.77510562215, 9080.500572468578, 9145.679901203426, 9348.018458061806, 9450.149486546245, 38249.426258605585, 39273.214535708554, 39486.40770388389, 39739.60260397359, 40582.594174059064, 45863.54136458593, 49154.0, 49286.75356623194, 49366.0, 50053.74973125111, 11456.427178640868, 11518.193726439069, 11644.068474522188, 11687.649370518899, 11692.415379230833, 12306.630801075624, 12669.239845609292, 12746.298953557643, 12779.169353991962, 12836.0, 12467.688307792016, 12641.304728239667, 12666.620001399973, 12672.936635316764, 12692.238465692088, 12457.937710311391, 12460.875391246334, 12497.375131243583, 12663.0, 12680.6829829255, 12040.337781422106, 12191.75616487683, 12470.376481176087, 12515.311657858541, 12656.17734847232, 10497.9475102624, 10730.785384292427, 10760.784784304113, 10874.67375978722, 10918.399488028235, 10025.398476091457, 10517.737056573647, 10530.0, 10643.361398316125, 10652.8934710655], "value": 7181.511777687453, "unit": "score"}], "name": "dromaeo_css", "value": 7485.862280181217, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 111.0, 112.0, 112.0, 105.0, 110.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 125.0, 156.0, 166.0, 128.0, 153.0, 153.0, 127.0, 184.0, 139.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 168.0, 77.0, 77.0, 76.0, 75.0, 173.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 155.0, 93.0, 92.0, 93.0, 151.0, 102.0, 93.0, 143.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 53.0, 53.0, 53.0, 54.0, 74.0, 54.0, 53.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 58.0, 57.0, 57.0, 59.0, 58.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 72.0, 71.0, 74.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 110.0, 110.0, 119.0, 119.0, 114.0, 112.0, 133.0, 141.0], "value": 118.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 158.0, 165.0, 157.0, 158.0, 154.0, 160.0, 152.0, 156.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 66.0, 66.0, 67.0, 64.0, 68.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1511.3999999999999, "alertThreshold": 2.0}]} 16:11:16 INFO - Return code: 0 16:11:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:16 ERROR - # TBPL SUCCESS # 16:11:16 INFO - Running post-action listener: _resource_record_post_action 16:11:16 INFO - Running post-run listener: _resource_record_post_run 16:11:17 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 516022272; Read time: 0; Write time: 544144 16:11:17 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243118080; Read time: 0; Write time: 378776 16:11:18 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 250175488; Read time: 0; Write time: 159860 16:11:18 INFO - Running post-run listener: _upload_blobber_files 16:11:18 INFO - Blob upload gear active. 16:11:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:18 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 16:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:11:18 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:19 INFO - (blobuploader) - INFO - Done attempting. 16:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:20 INFO - (blobuploader) - INFO - Done attempting. 16:11:20 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:20 INFO - Return code: 0 16:11:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc558d34d99834f3adf8354cad3095e0e4c2061640b6f01cb3e38808fff0b86a8fd94491a9e5ed16228926610e879973d76da505bf827c6f1715861b032d66ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acd9f583d834b861b4d5bcab68873cd709a1536214fc85dc741972df1092ed7f4eda59561c5634bdb340889c439932b2792f2187615f128739937d7b011deef5"} 16:11:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:20 INFO - Contents: 16:11:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc558d34d99834f3adf8354cad3095e0e4c2061640b6f01cb3e38808fff0b86a8fd94491a9e5ed16228926610e879973d76da505bf827c6f1715861b032d66ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acd9f583d834b861b4d5bcab68873cd709a1536214fc85dc741972df1092ed7f4eda59561c5634bdb340889c439932b2792f2187615f128739937d7b011deef5"} 16:11:20 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:20 INFO - Copying logs to upload dir... 16:11:20 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.882911 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 16:11:19.579182) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:19.582878) ========= 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=db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc558d34d99834f3adf8354cad3095e0e4c2061640b6f01cb3e38808fff0b86a8fd94491a9e5ed16228926610e879973d76da505bf827c6f1715861b032d66ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acd9f583d834b861b4d5bcab68873cd709a1536214fc85dc741972df1092ed7f4eda59561c5634bdb340889c439932b2792f2187615f128739937d7b011deef5"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc558d34d99834f3adf8354cad3095e0e4c2061640b6f01cb3e38808fff0b86a8fd94491a9e5ed16228926610e879973d76da505bf827c6f1715861b032d66ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acd9f583d834b861b4d5bcab68873cd709a1536214fc85dc741972df1092ed7f4eda59561c5634bdb340889c439932b2792f2187615f128739937d7b011deef5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:19.611176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:19.611801) ========= 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=db0483c52d987ecb441a263b000001ad-1464648326.917084-1428360508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:19.692262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:19.692586) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:19.692868) ========= ========= Total master_lag: 0.17 =========