builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1460717538.4 results: success (0) buildid: 20160415013015 builduid: 31d261bc141e48d4acd785813464dbb4 revision: 8ed65e8e9c754ea6dbef9f9df94cef89f670c628 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.401844) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.402270) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.402601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.421262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.421970) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 03:52:18-- 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% 46.7M=0s 2016-04-15 03:52:18 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.518096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.518524) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.571232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:18.572048) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8ed65e8e9c754ea6dbef9f9df94cef89f670c628 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8ed65e8e9c754ea6dbef9f9df94cef89f670c628 --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=337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 03:52:18,698 truncating revision to first 12 chars 2016-04-15 03:52:18,698 Setting DEBUG logging. 2016-04-15 03:52:18,698 attempt 1/10 2016-04-15 03:52:18,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8ed65e8e9c75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 03:52:18,945 unpacking tar archive at: mozilla-inbound-8ed65e8e9c75/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510172 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:19.096838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:19.097193) ========= script_repo_revision: 8ed65e8e9c754ea6dbef9f9df94cef89f670c628 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:19.097681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:19.098004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:52:19.107819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-15 03:52:19.108133) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:19 INFO - MultiFileLogger online at 20160415 03:52:19 in /builds/slave/test 03:52:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:52:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:19 INFO - {'append_to_log': False, 03:52:19 INFO - 'base_work_dir': '/builds/slave/test', 03:52:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:52:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:19 INFO - 'branch': 'Mozilla-Inbound', 03:52:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:19 INFO - 'config_files': ('talos/linux_config.py',), 03:52:19 INFO - 'default_actions': ('clobber', 03:52:19 INFO - 'read-buildbot-config', 03:52:19 INFO - 'download-and-extract', 03:52:19 INFO - 'populate-webroot', 03:52:19 INFO - 'create-virtualenv', 03:52:19 INFO - 'install', 03:52:19 INFO - 'run-tests'), 03:52:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:19 INFO - 'download_minidump_stackwalk': True, 03:52:19 INFO - 'download_symbols': 'ondemand', 03:52:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:19 INFO - 'installer_path': 'installer.exe', 03:52:19 INFO - 'log_level': 'info', 03:52:19 INFO - 'log_name': 'talos', 03:52:19 INFO - 'log_to_console': True, 03:52:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:19 INFO - 'opt_config_files': (), 03:52:19 INFO - 'pip_index': False, 03:52:19 INFO - 'sps_profile': False, 03:52:19 INFO - 'sps_profile_interval': 0, 03:52:19 INFO - 'suite': 'dromaeojs', 03:52:19 INFO - 'system_bits': '32', 03:52:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:19 INFO - 'title': 'talos-linux64-ix-060', 03:52:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:19 INFO - 'use_talos_json': True, 03:52:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:19 INFO - 'work_dir': 'build'} 03:52:19 INFO - ##### 03:52:19 INFO - ##### Running clobber step. 03:52:19 INFO - ##### 03:52:19 INFO - Running pre-action listener: _resource_record_pre_action 03:52:19 INFO - Running main action method: clobber 03:52:19 INFO - rmtree: /builds/slave/test/build 03:52:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:19 INFO - Running post-action listener: _resource_record_post_action 03:52:19 INFO - ##### 03:52:19 INFO - ##### Running read-buildbot-config step. 03:52:19 INFO - ##### 03:52:19 INFO - Running pre-action listener: _resource_record_pre_action 03:52:19 INFO - Running main action method: read_buildbot_config 03:52:19 INFO - Using buildbot properties: 03:52:19 INFO - { 03:52:19 INFO - "project": "", 03:52:19 INFO - "product": "firefox", 03:52:19 INFO - "script_repo_revision": "production", 03:52:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:52:19 INFO - "repository": "", 03:52:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:52:19 INFO - "buildid": "20160415013015", 03:52:19 INFO - "pgo_build": "True", 03:52:19 INFO - "basedir": "/builds/slave/test", 03:52:19 INFO - "buildnumber": 854, 03:52:19 INFO - "slavename": "talos-linux64-ix-060", 03:52:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:52:19 INFO - "platform": "ubuntu64_hw", 03:52:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:52:19 INFO - "branch": "mozilla-inbound", 03:52:19 INFO - "repo_path": "integration/mozilla-inbound", 03:52:19 INFO - "revision": "8ed65e8e9c754ea6dbef9f9df94cef89f670c628", 03:52:19 INFO - "stage_platform": "linux64-pgo", 03:52:19 INFO - "builduid": "31d261bc141e48d4acd785813464dbb4", 03:52:19 INFO - "slavebuilddir": "test" 03:52:19 INFO - } 03:52:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:52:19 INFO - Running post-action listener: _resource_record_post_action 03:52:19 INFO - ##### 03:52:19 INFO - ##### Running download-and-extract step. 03:52:19 INFO - ##### 03:52:19 INFO - Running pre-action listener: _resource_record_pre_action 03:52:19 INFO - Running main action method: download_and_extract 03:52:19 INFO - mkdir: /builds/slave/test/build/tests 03:52:19 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')]} 03:52:19 INFO - https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:52:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:52:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:52:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:52:30 INFO - Downloaded 1361 bytes. 03:52:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:52:30 INFO - Using the following test package requirements: 03:52:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:52:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:52:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:52:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'jsshell-linux-x86_64.zip'], 03:52:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:52:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:52:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:52:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:52:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:52:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:52:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:52:30 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')]} 03:52:30 INFO - https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:52:32 INFO - Downloaded 23779844 bytes. 03:52:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:52:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:52:33 INFO - Return code: 0 03:52:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:33 INFO - https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:52:35 INFO - Downloaded 23779844 bytes. 03:52:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:52:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:52:37 INFO - Return code: 0 03:52:37 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')]} 03:52:37 INFO - https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:52:38 INFO - Downloaded 10841076 bytes. 03:52:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:52:38 INFO - Return code: 0 03:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:38 INFO - https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:52:39 INFO - Downloaded 58170050 bytes. 03:52:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:39 INFO - mkdir: /builds/slave/test/properties 03:52:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:39 INFO - Contents: 03:52:39 INFO - build_url:https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:40 INFO - Running post-action listener: _resource_record_post_action 03:52:40 INFO - Running post-action listener: set_extra_try_arguments 03:52:40 INFO - ##### 03:52:40 INFO - ##### Running populate-webroot step. 03:52:40 INFO - ##### 03:52:40 INFO - Running pre-action listener: _resource_record_pre_action 03:52:40 INFO - Running main action method: populate_webroot 03:52:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:40 INFO - '--tppagecycles', 03:52:40 INFO - '7'], 03:52:40 INFO - 'tests': ['tsvgm']}}, 03:52:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['damp', 'tps']}, 03:52:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'tests': ['damp', 'tps']}, 03:52:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['dromaeo_dom']}, 03:52:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['a11yr', 03:52:40 INFO - 'ts_paint', 03:52:40 INFO - 'tpaint', 03:52:40 INFO - 'sessionrestore', 03:52:40 INFO - 'sessionrestore_no_auto_restore', 03:52:40 INFO - 'tabpaint']}, 03:52:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:40 INFO - 'ts_paint', 03:52:40 INFO - 'tpaint', 03:52:40 INFO - 'sessionrestore', 03:52:40 INFO - 'sessionrestore_no_auto_restore', 03:52:40 INFO - 'tabpaint']}, 03:52:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:40 INFO - 'ts_paint', 03:52:40 INFO - 'tpaint', 03:52:40 INFO - 'sessionrestore', 03:52:40 INFO - 'sessionrestore_no_auto_restore', 03:52:40 INFO - 'tabpaint']}, 03:52:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:40 INFO - 'ts_paint', 03:52:40 INFO - 'tpaint', 03:52:40 INFO - 'sessionrestore', 03:52:40 INFO - 'sessionrestore_no_auto_restore', 03:52:40 INFO - 'tabpaint']}, 03:52:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['a11yr', 03:52:40 INFO - 'ts_paint', 03:52:40 INFO - 'tpaint', 03:52:40 INFO - 'sessionrestore', 03:52:40 INFO - 'sessionrestore_no_auto_restore', 03:52:40 INFO - 'tabpaint']}, 03:52:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['a11yr', 03:52:40 INFO - 'ts_paint', 03:52:40 INFO - 'tpaint', 03:52:40 INFO - 'sessionrestore', 03:52:40 INFO - 'sessionrestore_no_auto_restore', 03:52:40 INFO - 'tabpaint']}, 03:52:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['tsvgx', 03:52:40 INFO - 'tsvgr_opacity', 03:52:40 INFO - 'tart', 03:52:40 INFO - 'tscrollx', 03:52:40 INFO - 'cart']}, 03:52:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:40 INFO - 'tsvgr_opacity', 03:52:40 INFO - 'tart', 03:52:40 INFO - 'tscrollx', 03:52:40 INFO - 'cart']}, 03:52:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'talos_options': ['--disable-e10s'], 03:52:40 INFO - 'tests': ['tp5o']}, 03:52:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'tests': ['tp5o']}, 03:52:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'talos_options': ['--disable-e10s', 03:52:40 INFO - '--xperf_path', 03:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:40 INFO - 'tests': ['tp5n']}, 03:52:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:40 INFO - 'talos_options': ['--xperf_path', 03:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:40 INFO - 'tests': ['tp5n']}}, 03:52:40 INFO - 'talos.zip': {'path': '', 03:52:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:40 INFO - Running post-action listener: _resource_record_post_action 03:52:40 INFO - ##### 03:52:40 INFO - ##### Running create-virtualenv step. 03:52:40 INFO - ##### 03:52:40 INFO - Running pre-action listener: _resource_record_pre_action 03:52:40 INFO - Running main action method: create_virtualenv 03:52:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:40 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 03:52:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:40 INFO - Using real prefix '/usr' 03:52:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:43 INFO - Installing pip.................done. 03:52:43 INFO - Return code: 0 03:52:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:43 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 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:43 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 03:52:43 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 03:52:43 INFO - Using env: {'DISPLAY': ':0', 03:52:43 INFO - 'HOME': '/home/cltbld', 03:52:43 INFO - 'LANG': 'en_US.UTF-8', 03:52:43 INFO - 'LANGUAGE': 'en_US:en', 03:52:43 INFO - 'LOGNAME': 'cltbld', 03:52:43 INFO - 'MAIL': '/var/mail/cltbld', 03:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:43 INFO - 'MOZ_NO_REMOTE': '1', 03:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:43 INFO - 'NO_EM_RESTART': '1', 03:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:43 INFO - 'PWD': '/builds/slave/test', 03:52:43 INFO - 'SHELL': '/bin/bash', 03:52:43 INFO - 'SHLVL': '1', 03:52:43 INFO - 'TERM': 'linux', 03:52:43 INFO - 'TMOUT': '86400', 03:52:43 INFO - 'USER': 'cltbld', 03:52:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:43 INFO - '_': '/tools/buildbot/bin/python'} 03:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:43 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 03:52:43 INFO - Cleaning up... 03:52:43 INFO - Return code: 0 03:52:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:43 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 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:43 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 03:52:43 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 03:52:43 INFO - Using env: {'DISPLAY': ':0', 03:52:43 INFO - 'HOME': '/home/cltbld', 03:52:43 INFO - 'LANG': 'en_US.UTF-8', 03:52:43 INFO - 'LANGUAGE': 'en_US:en', 03:52:43 INFO - 'LOGNAME': 'cltbld', 03:52:43 INFO - 'MAIL': '/var/mail/cltbld', 03:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:43 INFO - 'MOZ_NO_REMOTE': '1', 03:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:43 INFO - 'NO_EM_RESTART': '1', 03:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:43 INFO - 'PWD': '/builds/slave/test', 03:52:43 INFO - 'SHELL': '/bin/bash', 03:52:43 INFO - 'SHLVL': '1', 03:52:43 INFO - 'TERM': 'linux', 03:52:43 INFO - 'TMOUT': '86400', 03:52:43 INFO - 'USER': 'cltbld', 03:52:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:43 INFO - '_': '/tools/buildbot/bin/python'} 03:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:43 INFO - Downloading/unpacking psutil>=0.7.1 03:52:43 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 03:52:43 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 03:52:43 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 03:52:43 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 03:52:43 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 03:52:43 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 03:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:45 INFO - Installing collected packages: psutil 03:52:45 INFO - Running setup.py install for psutil 03:52:45 INFO - building 'psutil._psutil_linux' extension 03:52:45 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 03:52:45 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 03:52:45 INFO - building 'psutil._psutil_posix' extension 03:52:45 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 03:52:46 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 03:52:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:46 INFO - Successfully installed psutil 03:52:46 INFO - Cleaning up... 03:52:46 INFO - Return code: 0 03:52:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:52:46 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')]} 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:46 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')]} 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:46 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 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:46 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 03:52:46 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 03:52:46 INFO - Using env: {'DISPLAY': ':0', 03:52:46 INFO - 'HOME': '/home/cltbld', 03:52:46 INFO - 'LANG': 'en_US.UTF-8', 03:52:46 INFO - 'LANGUAGE': 'en_US:en', 03:52:46 INFO - 'LOGNAME': 'cltbld', 03:52:46 INFO - 'MAIL': '/var/mail/cltbld', 03:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:46 INFO - 'MOZ_NO_REMOTE': '1', 03:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:46 INFO - 'NO_EM_RESTART': '1', 03:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:46 INFO - 'PWD': '/builds/slave/test', 03:52:46 INFO - 'SHELL': '/bin/bash', 03:52:46 INFO - 'SHLVL': '1', 03:52:46 INFO - 'TERM': 'linux', 03:52:46 INFO - 'TMOUT': '86400', 03:52:46 INFO - 'USER': 'cltbld', 03:52:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:46 INFO - '_': '/tools/buildbot/bin/python'} 03:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:52:46 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 03:52:46 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 03:52:46 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 03:52:46 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 03:52:46 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 03:52:46 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 03:52:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:52:48 INFO - Installing collected packages: mozsystemmonitor 03:52:48 INFO - Running setup.py install for mozsystemmonitor 03:52:48 INFO - Successfully installed mozsystemmonitor 03:52:48 INFO - Cleaning up... 03:52:48 INFO - Return code: 0 03:52:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:48 INFO - Using env: {'DISPLAY': ':0', 03:52:48 INFO - 'HOME': '/home/cltbld', 03:52:48 INFO - 'LANG': 'en_US.UTF-8', 03:52:48 INFO - 'LANGUAGE': 'en_US:en', 03:52:48 INFO - 'LOGNAME': 'cltbld', 03:52:48 INFO - 'MAIL': '/var/mail/cltbld', 03:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:48 INFO - 'MOZ_NO_REMOTE': '1', 03:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:48 INFO - 'NO_EM_RESTART': '1', 03:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:48 INFO - 'PWD': '/builds/slave/test', 03:52:48 INFO - 'SHELL': '/bin/bash', 03:52:48 INFO - 'SHLVL': '1', 03:52:48 INFO - 'TERM': 'linux', 03:52:48 INFO - 'TMOUT': '86400', 03:52:48 INFO - 'USER': 'cltbld', 03:52:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:48 INFO - '_': '/tools/buildbot/bin/python'} 03:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:51 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 03:52:51 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 03:52:51 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 03:52:51 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 03:52:51 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 03:52:51 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 03:52:51 INFO - Downloading docopt-0.6.1.tar.gz 03:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:51 INFO - Running setup.py install for blobuploader 03:52:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:51 INFO - Running setup.py install for requests 03:52:51 INFO - Running setup.py install for docopt 03:52:51 INFO - Successfully installed blobuploader requests docopt 03:52:51 INFO - Cleaning up... 03:52:51 INFO - Return code: 0 03:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:51 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 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:51 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 03:52:51 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 03:52:51 INFO - Using env: {'DISPLAY': ':0', 03:52:51 INFO - 'HOME': '/home/cltbld', 03:52:51 INFO - 'LANG': 'en_US.UTF-8', 03:52:51 INFO - 'LANGUAGE': 'en_US:en', 03:52:51 INFO - 'LOGNAME': 'cltbld', 03:52:51 INFO - 'MAIL': '/var/mail/cltbld', 03:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:51 INFO - 'MOZ_NO_REMOTE': '1', 03:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:51 INFO - 'NO_EM_RESTART': '1', 03:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:51 INFO - 'PWD': '/builds/slave/test', 03:52:51 INFO - 'SHELL': '/bin/bash', 03:52:51 INFO - 'SHLVL': '1', 03:52:51 INFO - 'TERM': 'linux', 03:52:51 INFO - 'TMOUT': '86400', 03:52:51 INFO - 'USER': 'cltbld', 03:52:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:51 INFO - '_': '/tools/buildbot/bin/python'} 03:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:52 INFO - Running setup.py (path:/tmp/pip-rWMAFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:52 INFO - Running setup.py (path:/tmp/pip-I4YE6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:52 INFO - Running setup.py (path:/tmp/pip-YDiwbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:52 INFO - Running setup.py (path:/tmp/pip-ss_I17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:52 INFO - Running setup.py (path:/tmp/pip-d6ZlSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:52 INFO - Running setup.py (path:/tmp/pip-5AiHTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:52 INFO - Running setup.py (path:/tmp/pip-qZbS_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:52 INFO - Running setup.py (path:/tmp/pip-mzE83T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:52 INFO - Running setup.py (path:/tmp/pip-GFzJhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:52 INFO - Running setup.py (path:/tmp/pip-Cg9zNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:52 INFO - Running setup.py (path:/tmp/pip-eg3MfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:52 INFO - Running setup.py (path:/tmp/pip-cHN_K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:52 INFO - Running setup.py (path:/tmp/pip-HaB_oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:53 INFO - Running setup.py (path:/tmp/pip-wtzlTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:53 INFO - Running setup.py (path:/tmp/pip-MHno9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:53 INFO - Running setup.py (path:/tmp/pip-pRS5Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:53 INFO - Running setup.py (path:/tmp/pip-66ZYk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:53 INFO - Running setup.py install for manifestparser 03:52:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:53 INFO - Running setup.py install for mozcrash 03:52:53 INFO - Running setup.py install for mozdebug 03:52:53 INFO - Running setup.py install for mozdevice 03:52:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:53 INFO - Running setup.py install for mozfile 03:52:53 INFO - Running setup.py install for mozhttpd 03:52:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:53 INFO - Running setup.py install for mozinfo 03:52:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozInstall 03:52:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozleak 03:52:54 INFO - Running setup.py install for mozlog 03:52:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for moznetwork 03:52:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozprocess 03:52:54 INFO - Running setup.py install for mozprofile 03:52:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozrunner 03:52:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozscreenshot 03:52:54 INFO - Running setup.py install for moztest 03:52:55 INFO - Running setup.py install for mozversion 03:52:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:55 INFO - Cleaning up... 03:52:55 INFO - Return code: 0 03:52:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:55 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 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:55 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 03:52:55 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 03:52:55 INFO - Using env: {'DISPLAY': ':0', 03:52:55 INFO - 'HOME': '/home/cltbld', 03:52:55 INFO - 'LANG': 'en_US.UTF-8', 03:52:55 INFO - 'LANGUAGE': 'en_US:en', 03:52:55 INFO - 'LOGNAME': 'cltbld', 03:52:55 INFO - 'MAIL': '/var/mail/cltbld', 03:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:55 INFO - 'MOZ_NO_REMOTE': '1', 03:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:55 INFO - 'NO_EM_RESTART': '1', 03:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:55 INFO - 'PWD': '/builds/slave/test', 03:52:55 INFO - 'SHELL': '/bin/bash', 03:52:55 INFO - 'SHLVL': '1', 03:52:55 INFO - 'TERM': 'linux', 03:52:55 INFO - 'TMOUT': '86400', 03:52:55 INFO - 'USER': 'cltbld', 03:52:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:55 INFO - '_': '/tools/buildbot/bin/python'} 03:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:55 INFO - Running setup.py (path:/tmp/pip-ZI1O9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:55 INFO - Running setup.py (path:/tmp/pip-_dATx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:55 INFO - Running setup.py (path:/tmp/pip-5vkMAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:55 INFO - Running setup.py (path:/tmp/pip-iQG6tF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:55 INFO - Running setup.py (path:/tmp/pip-d4WguC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:55 INFO - Running setup.py (path:/tmp/pip-Vpv3Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:55 INFO - Running setup.py (path:/tmp/pip-iVu_QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:55 INFO - Running setup.py (path:/tmp/pip-DYPg2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:55 INFO - Running setup.py (path:/tmp/pip-s2ImKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:55 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)) 03:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:55 INFO - Running setup.py (path:/tmp/pip-dp8XuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:56 INFO - Running setup.py (path:/tmp/pip-cVLPbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:56 INFO - Running setup.py (path:/tmp/pip-yg7Iim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:56 INFO - Running setup.py (path:/tmp/pip-UYCUww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:56 INFO - Running setup.py (path:/tmp/pip-Diyyok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:56 INFO - Running setup.py (path:/tmp/pip-1ApC__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:56 INFO - Running setup.py (path:/tmp/pip-3tSjhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:56 INFO - Running setup.py (path:/tmp/pip-4LstLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:56 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)) 03:52:56 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)) 03:52:56 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)) 03:52:56 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)) 03:52:56 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)) 03:52:56 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)) 03:52:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:56 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 03:52:56 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 03:52:56 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 03:52:56 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 03:52:56 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 03:52:56 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 03:52:58 INFO - Downloading blessings-1.6.tar.gz 03:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:58 INFO - Installing collected packages: blessings 03:52:58 INFO - Running setup.py install for blessings 03:52:58 INFO - Successfully installed blessings 03:52:58 INFO - Cleaning up... 03:52:58 INFO - Return code: 0 03:52:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:58 INFO - Reading from file tmpfile_stdout 03:52:58 INFO - Current package versions: 03:52:58 INFO - argparse == 1.2.1 03:52:58 INFO - blessings == 1.6 03:52:58 INFO - blobuploader == 1.2.4 03:52:58 INFO - docopt == 0.6.1 03:52:58 INFO - manifestparser == 1.1 03:52:58 INFO - mozInstall == 1.12 03:52:58 INFO - mozcrash == 0.17 03:52:58 INFO - mozdebug == 0.1 03:52:58 INFO - mozdevice == 0.48 03:52:58 INFO - mozfile == 1.2 03:52:58 INFO - mozhttpd == 0.7 03:52:58 INFO - mozinfo == 0.9 03:52:58 INFO - mozleak == 0.1 03:52:58 INFO - mozlog == 3.1 03:52:58 INFO - moznetwork == 0.27 03:52:58 INFO - mozprocess == 0.22 03:52:58 INFO - mozprofile == 0.28 03:52:58 INFO - mozrunner == 6.11 03:52:58 INFO - mozscreenshot == 0.1 03:52:58 INFO - mozsystemmonitor == 0.0 03:52:58 INFO - moztest == 0.7 03:52:58 INFO - mozversion == 1.4 03:52:58 INFO - psutil == 3.1.1 03:52:58 INFO - requests == 1.2.3 03:52:58 INFO - wsgiref == 0.1.2 03:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:58 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 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:58 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 03:52:58 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 03:52:58 INFO - Using env: {'DISPLAY': ':0', 03:52:58 INFO - 'HOME': '/home/cltbld', 03:52:58 INFO - 'LANG': 'en_US.UTF-8', 03:52:58 INFO - 'LANGUAGE': 'en_US:en', 03:52:58 INFO - 'LOGNAME': 'cltbld', 03:52:58 INFO - 'MAIL': '/var/mail/cltbld', 03:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:58 INFO - 'MOZ_NO_REMOTE': '1', 03:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:58 INFO - 'NO_EM_RESTART': '1', 03:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:58 INFO - 'PWD': '/builds/slave/test', 03:52:58 INFO - 'SHELL': '/bin/bash', 03:52:58 INFO - 'SHLVL': '1', 03:52:58 INFO - 'TERM': 'linux', 03:52:58 INFO - 'TMOUT': '86400', 03:52:58 INFO - 'USER': 'cltbld', 03:52:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:58 INFO - '_': '/tools/buildbot/bin/python'} 03:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 INFO - Cleaning up... 03:52:59 INFO - Return code: 0 03:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:59 INFO - Using env: {'DISPLAY': ':0', 03:52:59 INFO - 'HOME': '/home/cltbld', 03:52:59 INFO - 'LANG': 'en_US.UTF-8', 03:52:59 INFO - 'LANGUAGE': 'en_US:en', 03:52:59 INFO - 'LOGNAME': 'cltbld', 03:52:59 INFO - 'MAIL': '/var/mail/cltbld', 03:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:59 INFO - 'MOZ_NO_REMOTE': '1', 03:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:59 INFO - 'NO_EM_RESTART': '1', 03:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:59 INFO - 'PWD': '/builds/slave/test', 03:52:59 INFO - 'SHELL': '/bin/bash', 03:52:59 INFO - 'SHLVL': '1', 03:52:59 INFO - 'TERM': 'linux', 03:52:59 INFO - 'TMOUT': '86400', 03:52:59 INFO - 'USER': 'cltbld', 03:52:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:59 INFO - '_': '/tools/buildbot/bin/python'} 03:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:59 INFO - Downloading/unpacking jsonschema 03:52:59 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 03:52:59 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 03:52:59 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 03:52:59 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 03:52:59 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 03:52:59 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 03:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:53:01 INFO - Downloading/unpacking functools32 (from jsonschema) 03:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:53:01 INFO - warning: no files found matching '*.txt' 03:53:01 INFO - no previously-included directories found matching 'build' 03:53:01 INFO - no previously-included directories found matching 'dist' 03:53:01 INFO - no previously-included directories found matching '.git*' 03:53:01 INFO - Installing collected packages: jsonschema, functools32 03:53:01 INFO - Running setup.py install for functools32 03:53:01 INFO - warning: no files found matching '*.txt' 03:53:01 INFO - no previously-included directories found matching 'build' 03:53:01 INFO - no previously-included directories found matching 'dist' 03:53:01 INFO - no previously-included directories found matching '.git*' 03:53:01 INFO - Successfully installed jsonschema functools32 03:53:01 INFO - Cleaning up... 03:53:01 INFO - Return code: 0 03:53:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53: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')]} 03:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f047112af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', '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 03:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:53:01 INFO - Using env: {'DISPLAY': ':0', 03:53:01 INFO - 'HOME': '/home/cltbld', 03:53:01 INFO - 'LANG': 'en_US.UTF-8', 03:53:01 INFO - 'LANGUAGE': 'en_US:en', 03:53:01 INFO - 'LOGNAME': 'cltbld', 03:53:01 INFO - 'MAIL': '/var/mail/cltbld', 03:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:01 INFO - 'MOZ_NO_REMOTE': '1', 03:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:01 INFO - 'NO_EM_RESTART': '1', 03:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:01 INFO - 'PWD': '/builds/slave/test', 03:53:01 INFO - 'SHELL': '/bin/bash', 03:53:01 INFO - 'SHLVL': '1', 03:53:01 INFO - 'TERM': 'linux', 03:53:01 INFO - 'TMOUT': '86400', 03:53:01 INFO - 'USER': 'cltbld', 03:53:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:01 INFO - '_': '/tools/buildbot/bin/python'} 03:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:01 INFO - Downloading/unpacking flake8 03:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:53:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:53:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:53:04 INFO - no previously-included directories found matching 'docs/_build' 03:53:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:53:04 INFO - Running setup.py install for pep8 03:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:53:04 INFO - no previously-included directories found matching 'docs/_build' 03:53:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:53:04 INFO - Cleaning up... 03:53:04 INFO - Return code: 0 03:53:04 INFO - Running post-action listener: _resource_record_post_action 03:53:04 INFO - Running post-action listener: _start_resource_monitoring 03:53:04 INFO - Starting resource monitoring. 03:53:04 INFO - ##### 03:53:04 INFO - ##### Running install step. 03:53:04 INFO - ##### 03:53:04 INFO - Running pre-action listener: _resource_record_pre_action 03:53:04 INFO - Running main action method: install 03:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:04 INFO - Reading from file tmpfile_stdout 03:53:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:05 INFO - Reading from file tmpfile_stdout 03:53:05 INFO - Output received: 03:53:05 INFO - Usage: mozinstall [options] installer 03:53:05 INFO - Options: 03:53:05 INFO - -h, --help show this help message and exit 03:53:05 INFO - -d DEST, --destination=DEST 03:53:05 INFO - Directory to install application into. [default: 03:53:05 INFO - "/builds/slave/test"] 03:53:05 INFO - --app=APP Application being installed. [default: firefox] 03:53:05 INFO - mkdir: /builds/slave/test/build/application 03:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:53:21 INFO - Reading from file tmpfile_stdout 03:53:21 INFO - Output received: 03:53:21 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:21 INFO - Running post-action listener: _resource_record_post_action 03:53:21 INFO - ##### 03:53:21 INFO - ##### Running run-tests step. 03:53:21 INFO - ##### 03:53:21 INFO - Running pre-action listener: _resource_record_pre_action 03:53:21 INFO - Running main action method: run_tests 03:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:21 INFO - Python 2.7.3 03:53:21 INFO - Return code: 0 03:53:21 INFO - grabbing minidump binary from tooltool 03:53:21 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')]} 03:53:21 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 0x2389410>, '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 0x238a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:21 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 03:53:21 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 03:53:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:21 INFO - Return code: 0 03:53:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:53:22 INFO - Return code: 0 03:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 03:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 03:53:22 INFO - Using env: {'DISPLAY': ':0', 03:53:22 INFO - 'HOME': '/home/cltbld', 03:53:22 INFO - 'LANG': 'en_US.UTF-8', 03:53:22 INFO - 'LANGUAGE': 'en_US:en', 03:53:22 INFO - 'LOGNAME': 'cltbld', 03:53:22 INFO - 'MAIL': '/var/mail/cltbld', 03:53:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:22 INFO - 'MOZ_NO_REMOTE': '1', 03:53:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:22 INFO - 'NO_EM_RESTART': '1', 03:53:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:22 INFO - 'PWD': '/builds/slave/test', 03:53:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:22 INFO - 'SHELL': '/bin/bash', 03:53:22 INFO - 'SHLVL': '1', 03:53:22 INFO - 'TERM': 'linux', 03:53:22 INFO - 'TMOUT': '86400', 03:53:22 INFO - 'USER': 'cltbld', 03:53:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605', 03:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:22 INFO - '_': '/tools/buildbot/bin/python'} 03:53:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 03:53:22 INFO - mozversion application_buildid: 20160415013015 03:53:22 INFO - mozversion application_changeset: 8ed65e8e9c754ea6dbef9f9df94cef89f670c628 03:53:22 INFO - mozversion application_display_name: Nightly 03:53:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:22 INFO - mozversion application_name: Firefox 03:53:22 INFO - mozversion application_remotingname: firefox 03:53:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:53:22 INFO - mozversion application_vendor: Mozilla 03:53:22 INFO - mozversion application_version: 48.0a1 03:53:22 INFO - mozversion platform_buildid: 20160415013015 03:53:22 INFO - mozversion platform_changeset: 8ed65e8e9c754ea6dbef9f9df94cef89f670c628 03:53:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:53:22 INFO - mozversion platform_version: 48.0a1 03:53:22 INFO - using testdate: 1460717602 03:53:22 INFO - actual date: 1460717602 03:53:22 INFO - starting webserver on 'localhost:51613' 03:53:22 INFO - SUITE-START | Running 2 tests 03:53:22 INFO - TEST-START | dromaeo_css 03:53:22 INFO - operating with platform_type : linux_ 03:53:22 INFO - Initialising browser for dromaeo_css test... 03:53:22 INFO - TEST-INFO | started process 12068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2DuQj/profile http://localhost:51613/getInfo.html) 03:53:27 INFO - PROCESS | 12068 | __metrics Screen width/height:1600/1200 03:53:27 INFO - PROCESS | 12068 | colorDepth:24 03:53:27 INFO - PROCESS | 12068 | Browser inner width/height: 1024/697 03:53:27 INFO - PROCESS | 12068 | __metrics 03:53:28 ERROR - PROCESS | 12068 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:53:28 INFO - TEST-INFO | 12068: exit 0 03:53:28 INFO - Browser initialized. 03:53:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:28 INFO - TEST-INFO | started process 12149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2DuQj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:40 INFO - PROCESS | 12149 | RSS: Main: 153210880 03:53:40 INFO - PROCESS | 12149 | 03:54:31 INFO - PROCESS | 12149 | 1460717671589 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] 03:56:38 INFO - PROCESS | 12149 | Cycle 1(1): loaded http://localhost:51613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51613/tests/dromaeo/cssquery-ext.html) 03:56:39 INFO - PROCESS | 12149 | RSS: Main: 252518400 03:56:39 INFO - PROCESS | 12149 | 03:59:42 INFO - PROCESS | 12149 | Cycle 1(1): loaded http://localhost:51613/tests/dromaeo/cssquery-ext.html (next: http://localhost:51613/tests/dromaeo/cssquery-jquery.html) 03:59:42 INFO - PROCESS | 12149 | RSS: Main: 231464960 03:59:42 INFO - PROCESS | 12149 | 04:02:44 INFO - PROCESS | 12149 | Cycle 1(1): loaded http://localhost:51613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51613/tests/dromaeo/cssquery-mootools.html) 04:02:45 INFO - PROCESS | 12149 | RSS: Main: 222150656 04:02:45 INFO - PROCESS | 12149 | 04:05:47 INFO - PROCESS | 12149 | Cycle 1(1): loaded http://localhost:51613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51613/tests/dromaeo/cssquery-prototype.html) 04:05:47 INFO - PROCESS | 12149 | RSS: Main: 226291712 04:05:47 INFO - PROCESS | 12149 | 04:08:50 INFO - PROCESS | 12149 | Cycle 1(1): loaded http://localhost:51613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51613/tests/dromaeo/cssquery-yui.html) 04:08:51 INFO - PROCESS | 12149 | RSS: Main: 224317440 04:08:51 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | Cycle 1(1): loaded http://localhost:51613/tests/dromaeo/cssquery-yui.html (next: http://localhost:51613/tests/dromaeo/cssquery-dojo.html) 04:11:53 INFO - PROCESS | 12149 | RSS: Main: 261898240 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | __start_tp_report 04:11:53 INFO - PROCESS | 12149 | _x_x_mozilla_page_load 04:11:53 INFO - PROCESS | 12149 | _x_x_mozilla_page_load_details 04:11:53 INFO - PROCESS | 12149 | |i|pagename|runs| 04:11:53 INFO - PROCESS | 12149 | |0;dojo.html;3048.6189226346705;3114.6573876873526;3154.7160755532;3156.542301366302;3183.395154920566;5304.761285742141;5307.1243244864645;5379.623426360156;5392.352917649882;5395.352557693072;5344.22508736233;5362.490563396481;5416.1063424535005;5477.287952566161;5490.094134467808;4775.856724298276;4822.638302127328;4902.803887844482;4905.190643543811;4946.629002824785;4839.7338146401935;4872.6101911847145;4907.631927605426;4908.8281910133155;4925.113479573675;4784.90430191396;4798.304245884345;4798.448178459487;4839.612830973531;4874.610031197496;4831.879203019917;4837.395325584302;4839.540243676845;4840.733759643218;4881.389826271716;4753.9762301188275;4796.952030479721;4824.927626085611;4850.6362022848425;4877;5226.242194881759;5312.495312945264;5321.627486075976;5350.839474815762;5352.304200453955;5624.803131890405;5630.971845140789;5634.154876768476;5638.154276858463;5643.463870932255;5654.971725141348;5687.658740475585;5689.118186681071;5689.687067211302;5692.8861422771315;5355.946440535584;5358.973205133989;5375.032494151052;5380.704061276629;5405.972970135203;5736.541076713853;5742.885142297131;5743.167240750068;5753.367129615823;5783.595148339576;5483;5541.473560011793;5549.72251387429;5578;5641.605087643826;5546.7781288748;5547.528460080938;5548.91676624851;5552.52803511706;5587.497125258747;5522.420145884705;5523.917141242885;5523.944760552343;5526.198701188305;5534.363548191929;5457.945420545823;5595.7481913313995;5609.1305847593685;5650.886982260414;5730.77076916927;4329.220740266782;4333.891652708708;4338.783060846945;4339.218940590724;4373.278409062469;3868.2843673920415;3873.770231672458;3881.6700580450415;3888.9805550972064;3911.647951684362;5377.7311134443125;5386.649867758583;5448.727563621803;5462.890742185134;5470;5743.310802703619;5746.798862039808;5759.568032397503;5767.711614419262;5768.596198266081;5412.621116521885;5437.374701909252;5439.184122381675;5449.754761035763;5451.236826844245;4677.672562920631;4691.577758001797;4748.572628463386;4764.356811830358;4787.42550893895;5920;5952.642841429528;5953.642781433128;5957.582969192115;5960.135780311917;5672.886542269049;5729.1119876419225;5746.683932383759;5746.913796292975;5751.712414379348;5958;6013.759449621966;6014.729337179925;6045.395460454095;6058.4244496772735;5592.133219351007;5600.187972743848;5602.691851948182;5606.411326810626;5608;5620.213170156263;5644.435556444323;5667.659940403589;5673.574481913955;5678.829635110953;5553;5564.248826408545;5566.860828479321;5570.359408668055;5612;5494.670319780826;5511.311086114236;5533.6956467393065;5542.445755424586;5543.279373681396;5382.03123437785;5419.187121931742;5423.159410291411;5475.780968761205;5526.22632831412;5547.389787123494;5556.055470570093;5556.416576259596;5559.249501317432;5600.747966341443;5456.154296084113;5457.481539253765;5461;5464.3442786865835;5466.34403871538 04:11:53 INFO - PROCESS | 12149 | |1;ext.html;591.4706337827645;638.894582393905;644.1400730025416;647.7344288841574;662.036736548322;30417;36617.63382366175;37433.06417339564;37450;37530.249395012084;42515.57484425155;43361;43418;43511.129777404436;43649.78175109128;7841.215878412142;8783.78040548985;8965.417247878899;8979.551022448852;9911.851322230172;10227.744306392362;10464.372137671764;10502.842457363146;10514.053735163834;10516.053555180033;10457.424841633707;10533.578656853717;10543.420111893844;10543.894561054407;10550.314229575053;8027.438079334478;10280.640177593748;10436.165106791439;10659.84010239847;10668.306560073648;10146.188304935587;10286.588536458532;10290.691279261635;10315.1747860171;10339.896601033968;38939.41590876139;39125.41311880324;39512;39547.40678889819;39550.406743898864;3303.8182899940493;3849.903752406184;3928.64642182205;3968.940465893014;4301.913961720779;31291.687083129105;31344.529832052536;31662.208444789063;31735;32143.678563214304;4224.78876056196;4290.14197160566;4353.5428779977965;4396.538363471821;4431.423914891076;292390;292422;292942;293741;294568;55125;55201.72399137979;55340.72329638326;55811.72094139503;55886.16170757442;59163;59226;59415;59428.70285648544;59443.40556594379;15453.072815631098;15740.527784166494;15894.60263493422;15897.443589474313;15964.201789910458;12604.369781510888;12717.109802313935;12746.745065098647;12753.171043882117;12767.297798620979;16059.43791967299;16096.11471369086;16254.431094911857;16320.265588048565;16524.586885327964;5467.398586155519;6278.623282603058;6576.80269591913;6629.767958121539;6665.733370665216;1102.862142232221;1122.865256169265;1129.4691494997337;1138.6697857621364;1140.3386036099043;29708.55437168444;29760.92291850963;29942;30229.244268893453;30604.98928452468;1116.8659760828752;1134.1493879590307;1150.4132892225025;1153.700037990112;1163.7672465506932;16871.240794164292;17169.31322747101;17185;17238;17316.63970925934;385752;390305;391900;392992;399122;55237.72381138149;56203.156952645746;56287.99999999918;56414.71792641011;56417.717911411004;1282.5446966327006;1390.860913908601;1399.846016938136;1404.1855723680242;1509.584864162364;25581;26624.33439163959;27241.45517089687;27653.723462765116;27670;43660.78169609132;44864.77567612141;45028;45283.54716452925;45489.09021819479;265105;267274;267554;267557;267895;35348;39856.20287594174;41359.793201033805;41390.1721965553;41608;42314.57685423106;44308.556914431734;44653.330200046374;45301.773491132335;45572.54427455683;38016.239675206896;38322.42516362313;38648.80675596604;38767.6123238764;39125.80437097796;38221.42667859929;39109;39523.80238098791;39532.40701389539;39603;39586.40620390639;39653.206935860544;39976.8001160004;40424;40437.79781101076;32679.22226610765;34061.82969085139;34951.650483495854;35286.47070293896;35310.646893530735;27050;27131.72868271292;27264.454710905273;27456.176314710592;27577.310567235978 04:11:53 INFO - PROCESS | 12149 | |2;jquery.html;382.20882772660593;382.5466821816148;393.89955561331857;399.7441637352095;406.21194881929074;14725.631859203526;16307.266173022213;17683.29266829327;20015.799842001594;20016.799832001674;14911.77632335513;17259.654806903887;17827.853602631458;18069.90965045173;18367.448976530693;5416.891662166754;5674.546036317085;5713.6000479966415;5737.627054241482;5749.65502069875;4041.636252737253;5556.86107847303;5614.045612245928;5618.325800903876;5859.414058594128;6134.478569321613;6174.722137503823;6176.660283684396;6182.659953702567;6186.072089186613;5980.983232850404;6155.630662160284;6191;6240.219972503437;6254;5406.864828379283;5438.320209973754;5439.0209762242785;5472.20653005312;5473.616846820724;21119.260825871173;21606.351809445743;22434.87825608713;22435.102595896144;22649.320520384415;2325.0118699552622;2348.518553696488;2412.2763171048614;2469.493753780471;2544.2875994721508;13927.442902283896;14150.716985660229;14380.64048398788;14473.276336183255;14611.050281731654;1875.6717574424558;1921.5580416504283;1921.769387673474;1943.5918457124021;1959.3240332085409;75727;76253.61873190654;76586.6170669143;76679;78642.21357786407;9459.38513996588;9619.230461563058;9736.853947190797;9867.717196764375;10273.989691081606;13002.219866807833;13079.607611771662;13083.08418410721;13103.344832758514;13108.80336794949;6904.896426553606;6923.6192009439965;7258.782236532912;7313.268673132644;7924;7799.298063174341;7813.726519571787;7829.45193836426;7937.801554961056;7945.48354356965;6135.5398345124295;6234.314225435199;6254.186955695731;6262.12330273762;6302.180716506825;1694.517062637167;1720.0711615727616;1739.3303578122513;1749.4314347837003;1772.485979066082;454.46146316614255;462.9031777409122;463.74494028284306;475.46747642639775;1029.7271223125877;10684.94657526723;11182.21724479295;11186.496607652674;11247.381394023243;11261.32432054063;473.74654559811023;473.8673171511982;477.05066916835943;479.08494774979624;482.2645465664889;5154.819581314711;6083.11794789753;6191.226096737908;6269.8746025079245;6284.717187726564;456763;461585;482676;483635;487457;90434;93986;94802.525987371;95770;96985;445.2475316714677;468.981240750373;472.38825720691784;472.8486884197093;475.2324995132836;10297.588096476056;10828.079613232963;10980.450977451255;11030.227884048361;11069.335839849635;32540.83729581337;33914.66085339115;34640.82679586586;35194.82402587971;35465.822670887515;41346.79326603348;42750.78624606857;48899.75550122369;50188.498115019844;57911.420885792286;7089.397401220954;7437.851242975218;8402.663893444194;8502.659893604186;8689.695860644848;12490.562830300896;13442.596722098353;13591.388387522784;13768.173909565458;13844.723105538034;11735.354555499189;12085.939570302093;12103.455344509694;12260.754784904073;12520.248785072925;11575.073994080622;11631.360275184608;11641.359725214856;11777.646670599896;11880.643580692593;12222.816657749963;12241.387930603612;12399.690007749878;12406.503739850305;12425.62723118308;8008.279254866857;8592.871106933277;8675.34934879874;8735.912640873765;8758;11708.47311870985;12037.337946413032;12234.143609947574;12263.325517096646;12429.44067516982 04:11:53 INFO - PROCESS | 12149 | |3;mootools.html;1324.5761356365954;1477.99261003695;1509.9547013589593;1646.4648989078546;1784.8309357370917;7329.706811727531;8089.352851771859;8239.87640185397;8265.752027439186;8301.91698083019;8023.157568455301;8141.43009989301;8147;8152.877706834387;8160.428769986089;2039.9184032638677;2108.114591871418;2111.050027487629;2297.5404919016223;2313.6760853480528;2303.0442366418;2373.738888722239;2375.536770329778;2376.7147942246957;2380.9642855357097;2229.6989906362596;2237.65316375962;2238.630625946717;2249.1003598560624;2280.304507125326;2036.1549956767924;2106.410205142547;2274.454131008554;2283.6460348645905;2287.839851210416;2030.7867673894177;2237.2393386248755;2330.1378489958656;2332.755060718634;2334.2997100869843;8015.4389192756535;8042.356611471068;8071.394645401619;8073.515589064675;8084.231997960184;4921.8523444296725;5038.445770965191;5052.57053150479;5058.064258112224;5072.72100034498;3309.321589074234;3329.400707872582;3366.5791776027995;3387.068556147079;3440.0367896988632;1139.0147522393154;1152.8270759386075;1157;1186.5075993462704;1216.6289281769057;11421.714457138554;11438;11446.542138314457;11453.828192577119;11456.739758626545;4279.679024073207;4498.032922921522;4518;4666.066786642685;4674.719516829001;9664.130228279488;9668.613255469843;9673.12941835224;9680.709578712649;9692.369995950241;5075;5102;5118.206677964921;5127.410347809975;5134.101532231844;4314.7626880521875;4672.299155126758;4715.717056976592;4750.976245118753;4836.903261934812;3753.474513568103;3801.4867992820614;3838.7696738195796;3847.249786291646;3931.5085614298214;1215.6474622359594;1275.5790589105573;1282.7178020835402;1291.5673249461347;1307.2156705976338;869.8390797702318;883.1124719656704;883.9160279773412;897.3583887520455;910.2672348759312;5670.092785154356;5736.942630573641;5744.511716504144;5790.913136302959;5892.558058145656;941.3316545252948;944.4663764972769;948.6821914658528;957.6217394129419;1013.1692012549786;4027.375756757707;4078.5105787305715;4084.7549147051272;4093.1404405074672;4095.201435720006;10134.391936483835;10439.843402348972;10496;10515.526801293807;10516.263861529773;10183.643572474928;10276.332038417479;10304.278700490893;10348.016938390841;10357.4303413313;7243.601601911945;7848.843023139505;7936.4047696423;7974.5215287082965;7980.3615710743;5666.433356664301;5735.913961290667;5737.713114344183;5757.424257574209;5857.8535536610225;9187;9280.72157835266;9405.20055795265;9421.152096311365;9422.95288523553;9426.340156189;9503.66737164196;9514.85727714071;9614;9641.084097010773;6733.326667333227;6840.863182736218;6938.5143039986715;6940.375366216863;7140.85718285621;7969.3226075784205;8225.095239523767;8234.547099909563;8250.339972802281;8278.130796266305;7356.595387253752;7399.926000739923;7565.243475652391;7569.1673915870315;7591.658375373011;7304.671289792079;7337.339639432476;7362.006129172493;7395.8151046224275;7443.292887175709;6850.177978642595;6857.55425897315;6907.34380233877;6916.170059592881;6921.169459664671;5089.745512724423;5171.379434467888;5181.093308670892;5330.387005494418;5363.624546281723;5025.673331233458;5033.672811267256;5062.898742025212;5075.568576671024;5123.436421993503 04:11:53 INFO - PROCESS | 12149 | |4;prototype.html;301.32954176956264;310.93004074083336;311.53425628685113;316.3720015768699;319.19085119222774;5612.298462692163;5664.546836253095;5747.36200182948;5748.885022299557;5763.1355296705415;5322.281491998579;5460.150593831349;5669.015844454439;5699.31870098321;5701.2018317435595;4291.35629655551;4317.503487098977;4341.110072435144;4342.934855977162;4347.760873151976;4275.722078064931;4328.2209202343565;4340.631046361047;4342.891427714317;4351.369051487548;4117.982188727517;4186.141840922619;4305.67707421943;4307.763073030982;4327.242732521812;4294.763787991659;4299.161663475624;4303.763293018883;4317.935230971538;4318.524962254165;3773.2830762155377;3780.6030366811638;3792.6207379262128;3796.468494410785;3797.829097690583;5195.116830138885;5419.83740487786;5425.562226010111;5426;5474.09677403228;4945.975270123662;4953.4303555091265;4955.141821816818;4972.577330926875;4984.077945580043;5877.882442351129;5885.499197704601;5891.351951285355;5903.911441328383;5915.970420147872;3855.094052897595;4041.191761647682;4041.8787436376956;4052.250333688277;4077.143799802045;6134.78528251509;6198.4731297839735;6220.129181914535;6227.734002208502;6252.3122456529745;4088.7342322748927;4111.362738775495;4114.403411505315;4123.773192474443;4146.295129827937;4122.175564887035;4190.5180904195795;4191.098913733562;4198.118395136994;4210.578942105765;4884.975575122173;4901.730404827768;4909.091818013608;4909.533594308535;4912.926306105412;5971.4327138921735;5975.551833612496;5977.22296101504;5988.371221021817;6009;1376.8141300924447;1403.7506619109001;1409.5489443378021;1465.8167729033871;1472.8158980127484;938.6573900526396;939.6100618243353;957.2772556719632;962.956666949989;968.1770495079127;5709.486146246858;5720.48515633595;5736.856578585569;5753.51095156908;5761.337446193657;6098;6109.5112391008615;6110.297315808739;6112.663803490851;6122.8876037766895;5612.35457922336;5728.598998070179;5751.597388182787;5839.620424672383;5884.264466941632;3299.1752061984503;3299.2411745298236;3310.503424486298;3311.503274508843;3329.5338652588657;6168.444839964424;6433.356664333623;6434.967825160844;6442.420182183626;6447.742090316428;6336.809895703136;6346.841328966812;6356.77751278703;6361.872762544724;6380.033284522719;6400.551961362753;6444.742210311535;6462;6467.579607325509;6467.838304042342;5936.436038576328;6261.092141639528;6267.2165979252595;6295.150154729236;6308.243010838545;6077.270727512727;6161.784337548164;6171.228596425447;6199.535034872493;6217.253929528486;6240.344763799736;6304;6359.523035772429;6428.742850285937;6434.453071488976;4134.1524987376915;4137.15188386374;4143.1713657269265;4159.313713237403;4169.8957526062095;5919;6250.812475625738;6267.373262673696;6268.247810262797;6290.0879372491645;5904.439078287556;6054.212952316171;6071.574989750852;6089.482393996383;6090;6017.428344307284;6027.3726093955265;6028.87942241144;6032.698365081641;6060.333363330118;5766.654000759968;5913.142594323885;5923.881522369442;5931.614445061057;5959.4934430573885;5966.850828729316;6027.939720602913;6047.425494578008;6062.272527296753;6069.969650151721;5745.741441635053;5921.3782552831335;5934.525237980864;5944.6433214005565;5945.791897283747 04:11:53 INFO - PROCESS | 12149 | |5;yui.html;752.4544705088808;814.1532805881882;830.9833803323932;846.957652117394;852.936029797765;14424.062435941656;14598.270086495686;14604.123752574853;14626;14688.192149431778;13092.869071309284;13268;13283.667908302274;13284.667883302922;13310.866891331083;662.5262937000056;677.566357531178;678.0304165043985;678.9321067893196;777.1800750208528;791.1534657916033;792.2988155482411;794.0788685125256;798.8881556582054;801.1867954026668;840.4327079221532;843.2579330189425;843.8987321521427;845.5856630251163;846.1834329871673;708.0794966543473;842.8019415437428;842.9789255268606;843.7257891185359;844.1558441558442;600.26467577218;611.1810174366326;613.745295702283;614.1340709599443;614.1586027142798;14176.787348189786;14261.073030253001;14267.500637477742;14274.3576539056;14292.499762508261;13742.93128534361;14121.293935303296;14139.858601413956;14221.715565688628;14297.356618952172;11595.652130436101;11604.883951160466;11605.245659032136;11628.302301861831;11715.472803723853;3783.1109689223013;3839.0978120141745;3844.596317386662;3887.1253967857288;3891.6692081173132;49746;54673;56013.71993140008;56427.71786141043;56583.151252731244;10125.64560240388;10162.4918754062;10173.237007224488;10312.484375781181;10363.481825908675;18487.075646217636;18921.432357029313;18962;18970;19086.618267634847;8441.802872709262;8504.53225072627;8535;8747.562621868881;8854.734357969272;4929.580985616263;4941.72820494869;4945.703257804544;4974.477679843637;5052.469490703424;3373.4433818420175;3487.3199726053685;3489.5986961499752;3492.441209406483;3493.039414161126;654.2704884054245;662.5792621685168;664.0305154474424;678.1523096129838;681.0397339751026;623.6912728199479;624.865653884408;722.4762047515509;734.229059487536;738.7931379213828;8639.78400539979;8787.604557794915;9020.8646870297;9524.761880952892;9576.186024188022;722.6459035072777;727.0257854474924;737.9262073792578;746.6042997211377;776.1850057439666;4156.480439945007;4185.455890734185;4250.617444430016;4292.5492823253735;4406.361077643724;57573.56066098297;59620;59820.401795982354;60013.39986600165;60561;51640.19259325905;51910.22134667983;52612.47387526152;52641.7367913158;53278.99999999922;47702.5229747705;48209.276860847116;49024.264636030486;49210.50789492059;49925.25112123321;8199.79500512468;8223.794405139919;8332.791680207802;8366.748997530083;8408;28450.85774571114;30105.69894301029;31732.365352692355;32497.675023249463;33075.50386744153;40819;41434;41821.37267940922;42295;43210;12217.389130543259;12347.75304493923;12376.62870113898;12449.439775209956;12489.93755031219;13525.2561109136;13612.795808062689;13655.317234138054;14080.647983800487;14111.576652700436;11115.944420277847;13076.215427074407;13324.200547967153;13591.592252232449;13591.86408135906;12580.937095314464;12958.935205324291;13080.345982700637;13159.342032898125;13625.931870340584;12307.261564305812;12353.691157721129;12495.062870284946;12733.55432559856;13565.728685426038;10333;10412.583496660049;10832.67501974942;11207.943960280472;11240.156988225752;10903.34579925207;11149.940755628202;11376.203665743318;11573.537058517903;11645.359505226956 04:11:53 INFO - PROCESS | 12149 | __end_tp_report 04:11:53 INFO - PROCESS | 12149 | __start_cc_report 04:11:53 INFO - PROCESS | 12149 | _x_x_mozilla_cycle_collect,801 04:11:53 INFO - PROCESS | 12149 | __end_cc_report 04:11:53 INFO - PROCESS | 12149 | __startTimestamp1460718713833__endTimestamp 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | ------- Summary: start ------- 04:11:53 INFO - PROCESS | 12149 | Number of tests: 6 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | [#0] dojo.html Cycles:165 Average:5280.92 Median:5475.78 stddev:594.15 (10.9%) stddev-sans-first:569.58 04:11:53 INFO - PROCESS | 12149 | Values: 3048.6 3114.7 3154.7 3156.5 3183.4 5304.8 5307.1 5379.6 5392.4 5395.4 5344.2 5362.5 5416.1 5477.3 5490.1 4775.9 4822.6 4902.8 4905.2 4946.6 4839.7 4872.6 4907.6 4908.8 4925.1 4784.9 4798.3 4798.4 4839.6 4874.6 4831.9 4837.4 4839.5 4840.7 4881.4 4754.0 4797.0 4824.9 4850.6 4877.0 5226.2 5312.5 5321.6 5350.8 5352.3 5624.8 5631.0 5634.2 5638.2 5643.5 5655.0 5687.7 5689.1 5689.7 5692.9 5355.9 5359.0 5375.0 5380.7 5406.0 5736.5 5742.9 5743.2 5753.4 5783.6 5483.0 5541.5 5549.7 5578.0 5641.6 5546.8 5547.5 5548.9 5552.5 5587.5 5522.4 5523.9 5523.9 5526.2 5534.4 5457.9 5595.7 5609.1 5650.9 5730.8 4329.2 4333.9 4338.8 4339.2 4373.3 3868.3 3873.8 3881.7 3889.0 3911.6 5377.7 5386.6 5448.7 5462.9 5470.0 5743.3 5746.8 5759.6 5767.7 5768.6 5412.6 5437.4 5439.2 5449.8 5451.2 4677.7 4691.6 4748.6 4764.4 4787.4 5920.0 5952.6 5953.6 5957.6 5960.1 5672.9 5729.1 5746.7 5746.9 5751.7 5958.0 6013.8 6014.7 6045.4 6058.4 5592.1 5600.2 5602.7 5606.4 5608.0 5620.2 5644.4 5667.7 5673.6 5678.8 5553.0 5564.2 5566.9 5570.4 5612.0 5494.7 5511.3 5533.7 5542.4 5543.3 5382.0 5419.2 5423.2 5475.8 5526.2 5547.4 5556.1 5556.4 5559.2 5600.7 5456.2 5457.5 5461.0 5464.3 5466.3 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | [#1] ext.html Cycles:180 Average:49167.79 Median:35329.32 stddev:84358.84 (238.8%) stddev-sans-first:84516.64 04:11:53 INFO - PROCESS | 12149 | Values: 591.5 638.9 644.1 647.7 662.0 30417.0 36617.6 37433.1 37450.0 37530.2 42515.6 43361.0 43418.0 43511.1 43649.8 7841.2 8783.8 8965.4 8979.6 9911.9 10227.7 10464.4 10502.8 10514.1 10516.1 10457.4 10533.6 10543.4 10543.9 10550.3 8027.4 10280.6 10436.2 10659.8 10668.3 10146.2 10286.6 10290.7 10315.2 10339.9 38939.4 39125.4 39512.0 39547.4 39550.4 3303.8 3849.9 3928.6 3968.9 4301.9 31291.7 31344.5 31662.2 31735.0 32143.7 4224.8 4290.1 4353.5 4396.5 4431.4 292390.0 292422.0 292942.0 293741.0 294568.0 55125.0 55201.7 55340.7 55811.7 55886.2 59163.0 59226.0 59415.0 59428.7 59443.4 15453.1 15740.5 15894.6 15897.4 15964.2 12604.4 12717.1 12746.7 12753.2 12767.3 16059.4 16096.1 16254.4 16320.3 16524.6 5467.4 6278.6 6576.8 6629.8 6665.7 1102.9 1122.9 1129.5 1138.7 1140.3 29708.6 29760.9 29942.0 30229.2 30605.0 1116.9 1134.1 1150.4 1153.7 1163.8 16871.2 17169.3 17185.0 17238.0 17316.6 385752.0 390305.0 391900.0 392992.0 399122.0 55237.7 56203.2 56288.0 56414.7 56417.7 1282.5 1390.9 1399.8 1404.2 1509.6 25581.0 26624.3 27241.5 27653.7 27670.0 43660.8 44864.8 45028.0 45283.5 45489.1 265105.0 267274.0 267554.0 267557.0 267895.0 35348.0 39856.2 41359.8 41390.2 41608.0 42314.6 44308.6 44653.3 45301.8 45572.5 38016.2 38322.4 38648.8 38767.6 39125.8 38221.4 39109.0 39523.8 39532.4 39603.0 39586.4 39653.2 39976.8 40424.0 40437.8 32679.2 34061.8 34951.7 35286.5 35310.6 27050.0 27131.7 27264.5 27456.2 27577.3 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | [#2] jquery.html Cycles:180 Average:27412.24 Median:449.85 stddev:78325.72 (17411.3%) stddev-sans-first:78519.15 04:11:53 INFO - PROCESS | 12149 | Values: 382.2 382.5 393.9 399.7 406.2 14725.6 16307.3 17683.3 20015.8 20016.8 14911.8 17259.7 17827.9 18069.9 18367.4 5416.9 5674.5 5713.6 5737.6 5749.7 4041.6 5556.9 5614.0 5618.3 5859.4 6134.5 6174.7 6176.7 6182.7 6186.1 5981.0 6155.6 6191.0 6240.2 6254.0 5406.9 5438.3 5439.0 5472.2 5473.6 21119.3 21606.4 22434.9 22435.1 22649.3 2325.0 2348.5 2412.3 2469.5 2544.3 13927.4 14150.7 14380.6 14473.3 14611.1 1875.7 1921.6 1921.8 1943.6 1959.3 75727.0 76253.6 76586.6 76679.0 78642.2 9459.4 9619.2 9736.9 9867.7 10274.0 13002.2 13079.6 13083.1 13103.3 13108.8 6904.9 6923.6 7258.8 7313.3 7924.0 7799.3 7813.7 7829.5 7937.8 7945.5 6135.5 6234.3 6254.2 6262.1 6302.2 1694.5 1720.1 1739.3 1749.4 1772.5 454.5 462.9 463.7 475.5 1029.7 10684.9 11182.2 11186.5 11247.4 11261.3 473.7 473.9 477.1 479.1 482.3 5154.8 6083.1 6191.2 6269.9 6284.7 456763.0 461585.0 482676.0 483635.0 487457.0 90434.0 93986.0 94802.5 95770.0 96985.0 445.2 469.0 472.4 472.8 475.2 10297.6 10828.1 10980.5 11030.2 11069.3 32540.8 33914.7 34640.8 35194.8 35465.8 41346.8 42750.8 48899.8 50188.5 57911.4 7089.4 7437.9 8402.7 8502.7 8689.7 12490.6 13442.6 13591.4 13768.2 13844.7 11735.4 12085.9 12103.5 12260.8 12520.2 11575.1 11631.4 11641.4 11777.6 11880.6 12222.8 12241.4 12399.7 12406.5 12425.6 8008.3 8592.9 8675.3 8735.9 8758.0 11708.5 12037.3 12234.1 12263.3 12429.4 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | [#3] mootools.html Cycles:180 Average:5530.46 Median:5082.66 stddev:3054.94 (60.1%) stddev-sans-first:3047.16 04:11:53 INFO - PROCESS | 12149 | Values: 1324.6 1478.0 1510.0 1646.5 1784.8 7329.7 8089.4 8239.9 8265.8 8301.9 8023.2 8141.4 8147.0 8152.9 8160.4 2039.9 2108.1 2111.1 2297.5 2313.7 2303.0 2373.7 2375.5 2376.7 2381.0 2229.7 2237.7 2238.6 2249.1 2280.3 2036.2 2106.4 2274.5 2283.6 2287.8 2030.8 2237.2 2330.1 2332.8 2334.3 8015.4 8042.4 8071.4 8073.5 8084.2 4921.9 5038.4 5052.6 5058.1 5072.7 3309.3 3329.4 3366.6 3387.1 3440.0 1139.0 1152.8 1157.0 1186.5 1216.6 11421.7 11438.0 11446.5 11453.8 11456.7 4279.7 4498.0 4518.0 4666.1 4674.7 9664.1 9668.6 9673.1 9680.7 9692.4 5075.0 5102.0 5118.2 5127.4 5134.1 4314.8 4672.3 4715.7 4751.0 4836.9 3753.5 3801.5 3838.8 3847.2 3931.5 1215.6 1275.6 1282.7 1291.6 1307.2 869.8 883.1 883.9 897.4 910.3 5670.1 5736.9 5744.5 5790.9 5892.6 941.3 944.5 948.7 957.6 1013.2 4027.4 4078.5 4084.8 4093.1 4095.2 10134.4 10439.8 10496.0 10515.5 10516.3 10183.6 10276.3 10304.3 10348.0 10357.4 7243.6 7848.8 7936.4 7974.5 7980.4 5666.4 5735.9 5737.7 5757.4 5857.9 9187.0 9280.7 9405.2 9421.2 9423.0 9426.3 9503.7 9514.9 9614.0 9641.1 6733.3 6840.9 6938.5 6940.4 7140.9 7969.3 8225.1 8234.5 8250.3 8278.1 7356.6 7399.9 7565.2 7569.2 7591.7 7304.7 7337.3 7362.0 7395.8 7443.3 6850.2 6857.6 6907.3 6916.2 6921.2 5089.7 5171.4 5181.1 5330.4 5363.6 5025.7 5033.7 5062.9 5075.6 5123.4 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | [#4] prototype.html Cycles:180 Average:4992.22 Median:5752.55 stddev:1532.31 (26.6%) stddev-sans-first:1495.61 04:11:53 INFO - PROCESS | 12149 | Values: 301.3 310.9 311.5 316.4 319.2 5612.3 5664.5 5747.4 5748.9 5763.1 5322.3 5460.2 5669.0 5699.3 5701.2 4291.4 4317.5 4341.1 4342.9 4347.8 4275.7 4328.2 4340.6 4342.9 4351.4 4118.0 4186.1 4305.7 4307.8 4327.2 4294.8 4299.2 4303.8 4317.9 4318.5 3773.3 3780.6 3792.6 3796.5 3797.8 5195.1 5419.8 5425.6 5426.0 5474.1 4946.0 4953.4 4955.1 4972.6 4984.1 5877.9 5885.5 5891.4 5903.9 5916.0 3855.1 4041.2 4041.9 4052.3 4077.1 6134.8 6198.5 6220.1 6227.7 6252.3 4088.7 4111.4 4114.4 4123.8 4146.3 4122.2 4190.5 4191.1 4198.1 4210.6 4885.0 4901.7 4909.1 4909.5 4912.9 5971.4 5975.6 5977.2 5988.4 6009.0 1376.8 1403.8 1409.5 1465.8 1472.8 938.7 939.6 957.3 963.0 968.2 5709.5 5720.5 5736.9 5753.5 5761.3 6098.0 6109.5 6110.3 6112.7 6122.9 5612.4 5728.6 5751.6 5839.6 5884.3 3299.2 3299.2 3310.5 3311.5 3329.5 6168.4 6433.4 6435.0 6442.4 6447.7 6336.8 6346.8 6356.8 6361.9 6380.0 6400.6 6444.7 6462.0 6467.6 6467.8 5936.4 6261.1 6267.2 6295.2 6308.2 6077.3 6161.8 6171.2 6199.5 6217.3 6240.3 6304.0 6359.5 6428.7 6434.5 4134.2 4137.2 4143.2 4159.3 4169.9 5919.0 6250.8 6267.4 6268.2 6290.1 5904.4 6054.2 6071.6 6089.5 6090.0 6017.4 6027.4 6028.9 6032.7 6060.3 5766.7 5913.1 5923.9 5931.6 5959.5 5966.9 6027.9 6047.4 6062.3 6070.0 5745.7 5921.4 5934.5 5944.6 5945.8 04:11:53 INFO - PROCESS | 12149 | 04:11:53 INFO - PROCESS | 12149 | [#5] yui.html Cycles:180 Average:14492.78 Median:23272.81 stddev:16393.16 (70.4%) stddev-sans-first:16406.67 04:11:53 INFO - PROCESS | 12149 | Values: 752.5 814.2 831.0 847.0 852.9 14424.1 14598.3 14604.1 14626.0 14688.2 13092.9 13268.0 13283.7 13284.7 13310.9 662.5 677.6 678.0 678.9 777.2 791.2 792.3 794.1 798.9 801.2 840.4 843.3 843.9 845.6 846.2 708.1 842.8 843.0 843.7 844.2 600.3 611.2 613.7 614.1 614.2 14176.8 14261.1 14267.5 14274.4 14292.5 13742.9 14121.3 14139.9 14221.7 14297.4 11595.7 11604.9 11605.2 11628.3 11715.5 3783.1 3839.1 3844.6 3887.1 3891.7 49746.0 54673.0 56013.7 56427.7 56583.2 10125.6 10162.5 10173.2 10312.5 10363.5 18487.1 18921.4 18962.0 18970.0 19086.6 8441.8 8504.5 8535.0 8747.6 8854.7 4929.6 4941.7 4945.7 4974.5 5052.5 3373.4 3487.3 3489.6 3492.4 3493.0 654.3 662.6 664.0 678.2 681.0 623.7 624.9 722.5 734.2 738.8 8639.8 8787.6 9020.9 9524.8 9576.2 722.6 727.0 737.9 746.6 776.2 4156.5 4185.5 4250.6 4292.5 4406.4 57573.6 59620.0 59820.4 60013.4 60561.0 51640.2 51910.2 52612.5 52641.7 53279.0 47702.5 48209.3 49024.3 49210.5 49925.3 8199.8 8223.8 8332.8 8366.7 8408.0 28450.9 30105.7 31732.4 32497.7 33075.5 40819.0 41434.0 41821.4 42295.0 43210.0 12217.4 12347.8 12376.6 12449.4 12489.9 13525.3 13612.8 13655.3 14080.6 14111.6 11115.9 13076.2 13324.2 13591.6 13591.9 12580.9 12958.9 13080.3 13159.3 13625.9 12307.3 12353.7 12495.1 12733.6 13565.7 10333.0 10412.6 10832.7 11207.9 11240.2 10903.3 11149.9 11376.2 11573.5 11645.4 04:11:53 INFO - PROCESS | 12149 | -------- Summary: end -------- 04:11:53 INFO - PROCESS | 12149 | 04:11:54 INFO - TEST-INFO | 12149: exit 0 04:11:54 INFO - TEST-OK | dromaeo_css | took 1111685ms 04:11:54 INFO - TEST-START | kraken 04:11:54 INFO - operating with platform_type : linux_ 04:11:54 INFO - Initialising browser for kraken test... 04:11:54 INFO - TEST-INFO | started process 12331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6dKZZH/profile http://localhost:51613/getInfo.html) 04:11:58 INFO - PROCESS | 12331 | __metrics Screen width/height:1600/1200 04:11:58 INFO - PROCESS | 12331 | colorDepth:24 04:11:58 INFO - PROCESS | 12331 | Browser inner width/height: 1024/697 04:11:58 INFO - PROCESS | 12331 | __metrics 04:11:59 ERROR - PROCESS | 12331 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:12:00 INFO - TEST-INFO | 12331: exit 0 04:12:00 INFO - Browser initialized. 04:12:00 INFO - Running cycle 1/1 for kraken test... 04:12:00 INFO - TEST-INFO | started process 12411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6dKZZH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:12 INFO - PROCESS | 12411 | RSS: Main: 153825280 04:12:12 INFO - PROCESS | 12411 | 04:12:14 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51613/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:15 INFO - PROCESS | 12411 | RSS: Main: 208060416 04:12:15 INFO - PROCESS | 12411 | 04:12:18 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51613/tests/kraken/driver.html?testName=audio-dft) 04:12:19 INFO - PROCESS | 12411 | RSS: Main: 194330624 04:12:19 INFO - PROCESS | 12411 | 04:12:22 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51613/tests/kraken/driver.html?testName=audio-fft) 04:12:22 INFO - PROCESS | 12411 | RSS: Main: 264781824 04:12:22 INFO - PROCESS | 12411 | 04:12:24 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51613/tests/kraken/driver.html?testName=audio-oscillator) 04:12:25 INFO - PROCESS | 12411 | RSS: Main: 172810240 04:12:25 INFO - PROCESS | 12411 | 04:12:27 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:28 INFO - PROCESS | 12411 | RSS: Main: 177295360 04:12:28 INFO - PROCESS | 12411 | 04:12:31 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51613/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:31 INFO - PROCESS | 12411 | RSS: Main: 213389312 04:12:31 INFO - PROCESS | 12411 | 04:12:35 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51613/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:35 INFO - PROCESS | 12411 | RSS: Main: 212770816 04:12:35 INFO - PROCESS | 12411 | 04:12:38 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51613/tests/kraken/driver.html?testName=json-parse-financial) 04:12:39 INFO - PROCESS | 12411 | RSS: Main: 214192128 04:12:39 INFO - PROCESS | 12411 | 04:12:40 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:41 INFO - PROCESS | 12411 | RSS: Main: 201736192 04:12:41 INFO - PROCESS | 12411 | 04:12:43 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:43 INFO - PROCESS | 12411 | RSS: Main: 203776000 04:12:43 INFO - PROCESS | 12411 | 04:12:45 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:46 INFO - PROCESS | 12411 | RSS: Main: 214007808 04:12:46 INFO - PROCESS | 12411 | 04:12:48 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:49 INFO - PROCESS | 12411 | RSS: Main: 222113792 04:12:49 INFO - PROCESS | 12411 | 04:12:52 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:52 INFO - PROCESS | 12411 | RSS: Main: 217833472 04:12:52 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:51613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51613/tests/kraken/driver.html?testName=ai-astar) 04:12:54 INFO - PROCESS | 12411 | RSS: Main: 280793088 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | __start_tp_report 04:12:54 INFO - PROCESS | 12411 | _x_x_mozilla_page_load 04:12:54 INFO - PROCESS | 12411 | _x_x_mozilla_page_load_details 04:12:54 INFO - PROCESS | 12411 | |i|pagename|runs| 04:12:54 INFO - PROCESS | 12411 | |0;ai-astar;110;112;107;111;112;112;100;112;111;112 04:12:54 INFO - PROCESS | 12411 | |1;audio-beat-detection;160;132;154;179;129;157;162;128;190;126 04:12:54 INFO - PROCESS | 12411 | |2;audio-dft;162;164;162;162;163;164;163;164;164;163 04:12:54 INFO - PROCESS | 12411 | |3;audio-fft;73;77;113;111;76;76;76;126;102;78 04:12:54 INFO - PROCESS | 12411 | |4;audio-oscillator;93;91;155;93;93;93;152;92;92;155 04:12:54 INFO - PROCESS | 12411 | |5;imaging-gaussian-blur;116;117;117;116;117;116;119;117;116;117 04:12:54 INFO - PROCESS | 12411 | |6;imaging-darkroom;146;145;146;145;146;146;145;146;146;147 04:12:54 INFO - PROCESS | 12411 | |7;imaging-desaturate;95;95;94;95;94;94;95;95;95;95 04:12:54 INFO - PROCESS | 12411 | |8;json-parse-financial;56;56;56;56;56;56;56;72;56;55 04:12:54 INFO - PROCESS | 12411 | |9;json-stringify-tinderbox;61;60;61;61;61;61;61;61;61;61 04:12:54 INFO - PROCESS | 12411 | |10;stanford-crypto-aes;78;76;74;76;75;77;88;76;78;85 04:12:54 INFO - PROCESS | 12411 | |11;stanford-crypto-ccm;127;134;126;122;121;124;120;133;169;127 04:12:54 INFO - PROCESS | 12411 | |12;stanford-crypto-pbkdf2;180;165;162;160;161;163;166;167;163;166 04:12:54 INFO - PROCESS | 12411 | |13;stanford-crypto-sha256-iterative;68;69;69;67;67;67;68;67;68;67 04:12:54 INFO - PROCESS | 12411 | __end_tp_report 04:12:54 INFO - PROCESS | 12411 | __start_cc_report 04:12:54 INFO - PROCESS | 12411 | _x_x_mozilla_cycle_collect,1606 04:12:54 INFO - PROCESS | 12411 | __end_cc_report 04:12:54 INFO - PROCESS | 12411 | __startTimestamp1460718774795__endTimestamp 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | ------- Summary: start ------- 04:12:54 INFO - PROCESS | 12411 | Number of tests: 14 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:3.81 (3.4%) stddev-sans-first:4.04 04:12:54 INFO - PROCESS | 12411 | Values: 110.0 112.0 107.0 111.0 112.0 112.0 100.0 112.0 111.0 112.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:158.50 stddev:22.47 (14.2%) stddev-sans-first:23.64 04:12:54 INFO - PROCESS | 12411 | Values: 160.0 132.0 154.0 179.0 129.0 157.0 162.0 128.0 190.0 126.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:0.88 (0.5%) stddev-sans-first:0.83 04:12:54 INFO - PROCESS | 12411 | Values: 162.0 164.0 162.0 162.0 163.0 164.0 163.0 164.0 164.0 163.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#3] audio-fft Cycles:10 Average:90.80 Median:76.00 stddev:19.98 (26.3%) stddev-sans-first:20.13 04:12:54 INFO - PROCESS | 12411 | Values: 73.0 77.0 113.0 111.0 76.0 76.0 76.0 126.0 102.0 78.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:92.50 stddev:29.76 (32.2%) stddev-sans-first:30.85 04:12:54 INFO - PROCESS | 12411 | Values: 93.0 91.0 155.0 93.0 93.0 93.0 152.0 92.0 92.0 155.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 04:12:54 INFO - PROCESS | 12411 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 119.0 117.0 116.0 117.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:12:54 INFO - PROCESS | 12411 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 147.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:12:54 INFO - PROCESS | 12411 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.00 stddev:5.10 (9.1%) stddev-sans-first:5.39 04:12:54 INFO - PROCESS | 12411 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 56.0 72.0 56.0 55.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:12:54 INFO - PROCESS | 12411 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.50 stddev:4.55 (5.9%) stddev-sans-first:4.82 04:12:54 INFO - PROCESS | 12411 | Values: 78.0 76.0 74.0 76.0 75.0 77.0 88.0 76.0 78.0 85.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:127.00 stddev:14.38 (11.3%) stddev-sans-first:15.20 04:12:54 INFO - PROCESS | 12411 | Values: 127.0 134.0 126.0 122.0 121.0 124.0 120.0 133.0 169.0 127.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.50 stddev:5.66 (3.4%) stddev-sans-first:2.45 04:12:54 INFO - PROCESS | 12411 | Values: 180.0 165.0 162.0 160.0 161.0 163.0 166.0 167.0 163.0 166.0 04:12:54 INFO - PROCESS | 12411 | 04:12:54 INFO - PROCESS | 12411 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 04:12:54 INFO - PROCESS | 12411 | Values: 68.0 69.0 69.0 67.0 67.0 67.0 68.0 67.0 68.0 67.0 04:12:54 INFO - PROCESS | 12411 | -------- Summary: end -------- 04:12:54 INFO - PROCESS | 12411 | 04:12:55 INFO - TEST-INFO | 12411: exit 0 04:12:55 INFO - TEST-OK | kraken | took 61282ms 04:12:55 INFO - SUITE-END | took 1172s 04:12:55 INFO - Completed test suite (00:19:33) 04:12:55 INFO - javascript benchmark 04:12:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.6189226346705, 3114.6573876873526, 3154.7160755532, 3156.542301366302, 3183.395154920566, 5304.761285742141, 5307.1243244864645, 5379.623426360156, 5392.352917649882, 5395.352557693072, 5344.22508736233, 5362.490563396481, 5416.1063424535005, 5477.287952566161, 5490.094134467808, 4775.856724298276, 4822.638302127328, 4902.803887844482, 4905.190643543811, 4946.629002824785, 4839.7338146401935, 4872.6101911847145, 4907.631927605426, 4908.8281910133155, 4925.113479573675, 4784.90430191396, 4798.304245884345, 4798.448178459487, 4839.612830973531, 4874.610031197496, 4831.879203019917, 4837.395325584302, 4839.540243676845, 4840.733759643218, 4881.389826271716, 4753.9762301188275, 4796.952030479721, 4824.927626085611, 4850.6362022848425, 4877.0, 5226.242194881759, 5312.495312945264, 5321.627486075976, 5350.839474815762, 5352.304200453955, 5624.803131890405, 5630.971845140789, 5634.154876768476, 5638.154276858463, 5643.463870932255, 5654.971725141348, 5687.658740475585, 5689.118186681071, 5689.687067211302, 5692.8861422771315, 5355.946440535584, 5358.973205133989, 5375.032494151052, 5380.704061276629, 5405.972970135203, 5736.541076713853, 5742.885142297131, 5743.167240750068, 5753.367129615823, 5783.595148339576, 5483.0, 5541.473560011793, 5549.72251387429, 5578.0, 5641.605087643826, 5546.7781288748, 5547.528460080938, 5548.91676624851, 5552.52803511706, 5587.497125258747, 5522.420145884705, 5523.917141242885, 5523.944760552343, 5526.198701188305, 5534.363548191929, 5457.945420545823, 5595.7481913313995, 5609.1305847593685, 5650.886982260414, 5730.77076916927, 4329.220740266782, 4333.891652708708, 4338.783060846945, 4339.218940590724, 4373.278409062469, 3868.2843673920415, 3873.770231672458, 3881.6700580450415, 3888.9805550972064, 3911.647951684362, 5377.7311134443125, 5386.649867758583, 5448.727563621803, 5462.890742185134, 5470.0, 5743.310802703619, 5746.798862039808, 5759.568032397503, 5767.711614419262, 5768.596198266081, 5412.621116521885, 5437.374701909252, 5439.184122381675, 5449.754761035763, 5451.236826844245, 4677.672562920631, 4691.577758001797, 4748.572628463386, 4764.356811830358, 4787.42550893895, 5920.0, 5952.642841429528, 5953.642781433128, 5957.582969192115, 5960.135780311917, 5672.886542269049, 5729.1119876419225, 5746.683932383759, 5746.913796292975, 5751.712414379348, 5958.0, 6013.759449621966, 6014.729337179925, 6045.395460454095, 6058.4244496772735, 5592.133219351007, 5600.187972743848, 5602.691851948182, 5606.411326810626, 5608.0, 5620.213170156263, 5644.435556444323, 5667.659940403589, 5673.574481913955, 5678.829635110953, 5553.0, 5564.248826408545, 5566.860828479321, 5570.359408668055, 5612.0, 5494.670319780826, 5511.311086114236, 5533.6956467393065, 5542.445755424586, 5543.279373681396, 5382.03123437785, 5419.187121931742, 5423.159410291411, 5475.780968761205, 5526.22632831412, 5547.389787123494, 5556.055470570093, 5556.416576259596, 5559.249501317432, 5600.747966341443, 5456.154296084113, 5457.481539253765, 5461.0, 5464.3442786865835, 5466.34403871538], "value": 5241.396431726309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.4706337827645, 638.894582393905, 644.1400730025416, 647.7344288841574, 662.036736548322, 30417.0, 36617.63382366175, 37433.06417339564, 37450.0, 37530.249395012084, 42515.57484425155, 43361.0, 43418.0, 43511.129777404436, 43649.78175109128, 7841.215878412142, 8783.78040548985, 8965.417247878899, 8979.551022448852, 9911.851322230172, 10227.744306392362, 10464.372137671764, 10502.842457363146, 10514.053735163834, 10516.053555180033, 10457.424841633707, 10533.578656853717, 10543.420111893844, 10543.894561054407, 10550.314229575053, 8027.438079334478, 10280.640177593748, 10436.165106791439, 10659.84010239847, 10668.306560073648, 10146.188304935587, 10286.588536458532, 10290.691279261635, 10315.1747860171, 10339.896601033968, 38939.41590876139, 39125.41311880324, 39512.0, 39547.40678889819, 39550.406743898864, 3303.8182899940493, 3849.903752406184, 3928.64642182205, 3968.940465893014, 4301.913961720779, 31291.687083129105, 31344.529832052536, 31662.208444789063, 31735.0, 32143.678563214304, 4224.78876056196, 4290.14197160566, 4353.5428779977965, 4396.538363471821, 4431.423914891076, 292390.0, 292422.0, 292942.0, 293741.0, 294568.0, 55125.0, 55201.72399137979, 55340.72329638326, 55811.72094139503, 55886.16170757442, 59163.0, 59226.0, 59415.0, 59428.70285648544, 59443.40556594379, 15453.072815631098, 15740.527784166494, 15894.60263493422, 15897.443589474313, 15964.201789910458, 12604.369781510888, 12717.109802313935, 12746.745065098647, 12753.171043882117, 12767.297798620979, 16059.43791967299, 16096.11471369086, 16254.431094911857, 16320.265588048565, 16524.586885327964, 5467.398586155519, 6278.623282603058, 6576.80269591913, 6629.767958121539, 6665.733370665216, 1102.862142232221, 1122.865256169265, 1129.4691494997337, 1138.6697857621364, 1140.3386036099043, 29708.55437168444, 29760.92291850963, 29942.0, 30229.244268893453, 30604.98928452468, 1116.8659760828752, 1134.1493879590307, 1150.4132892225025, 1153.700037990112, 1163.7672465506932, 16871.240794164292, 17169.31322747101, 17185.0, 17238.0, 17316.63970925934, 385752.0, 390305.0, 391900.0, 392992.0, 399122.0, 55237.72381138149, 56203.156952645746, 56287.99999999918, 56414.71792641011, 56417.717911411004, 1282.5446966327006, 1390.860913908601, 1399.846016938136, 1404.1855723680242, 1509.584864162364, 25581.0, 26624.33439163959, 27241.45517089687, 27653.723462765116, 27670.0, 43660.78169609132, 44864.77567612141, 45028.0, 45283.54716452925, 45489.09021819479, 265105.0, 267274.0, 267554.0, 267557.0, 267895.0, 35348.0, 39856.20287594174, 41359.793201033805, 41390.1721965553, 41608.0, 42314.57685423106, 44308.556914431734, 44653.330200046374, 45301.773491132335, 45572.54427455683, 38016.239675206896, 38322.42516362313, 38648.80675596604, 38767.6123238764, 39125.80437097796, 38221.42667859929, 39109.0, 39523.80238098791, 39532.40701389539, 39603.0, 39586.40620390639, 39653.206935860544, 39976.8001160004, 40424.0, 40437.79781101076, 32679.22226610765, 34061.82969085139, 34951.650483495854, 35286.47070293896, 35310.646893530735, 27050.0, 27131.72868271292, 27264.454710905273, 27456.176314710592, 27577.310567235978], "value": 19501.74888654635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.20882772660593, 382.5466821816148, 393.89955561331857, 399.7441637352095, 406.21194881929074, 14725.631859203526, 16307.266173022213, 17683.29266829327, 20015.799842001594, 20016.799832001674, 14911.77632335513, 17259.654806903887, 17827.853602631458, 18069.90965045173, 18367.448976530693, 5416.891662166754, 5674.546036317085, 5713.6000479966415, 5737.627054241482, 5749.65502069875, 4041.636252737253, 5556.86107847303, 5614.045612245928, 5618.325800903876, 5859.414058594128, 6134.478569321613, 6174.722137503823, 6176.660283684396, 6182.659953702567, 6186.072089186613, 5980.983232850404, 6155.630662160284, 6191.0, 6240.219972503437, 6254.0, 5406.864828379283, 5438.320209973754, 5439.0209762242785, 5472.20653005312, 5473.616846820724, 21119.260825871173, 21606.351809445743, 22434.87825608713, 22435.102595896144, 22649.320520384415, 2325.0118699552622, 2348.518553696488, 2412.2763171048614, 2469.493753780471, 2544.2875994721508, 13927.442902283896, 14150.716985660229, 14380.64048398788, 14473.276336183255, 14611.050281731654, 1875.6717574424558, 1921.5580416504283, 1921.769387673474, 1943.5918457124021, 1959.3240332085409, 75727.0, 76253.61873190654, 76586.6170669143, 76679.0, 78642.21357786407, 9459.38513996588, 9619.230461563058, 9736.853947190797, 9867.717196764375, 10273.989691081606, 13002.219866807833, 13079.607611771662, 13083.08418410721, 13103.344832758514, 13108.80336794949, 6904.896426553606, 6923.6192009439965, 7258.782236532912, 7313.268673132644, 7924.0, 7799.298063174341, 7813.726519571787, 7829.45193836426, 7937.801554961056, 7945.48354356965, 6135.5398345124295, 6234.314225435199, 6254.186955695731, 6262.12330273762, 6302.180716506825, 1694.517062637167, 1720.0711615727616, 1739.3303578122513, 1749.4314347837003, 1772.485979066082, 454.46146316614255, 462.9031777409122, 463.74494028284306, 475.46747642639775, 1029.7271223125877, 10684.94657526723, 11182.21724479295, 11186.496607652674, 11247.381394023243, 11261.32432054063, 473.74654559811023, 473.8673171511982, 477.05066916835943, 479.08494774979624, 482.2645465664889, 5154.819581314711, 6083.11794789753, 6191.226096737908, 6269.8746025079245, 6284.717187726564, 456763.0, 461585.0, 482676.0, 483635.0, 487457.0, 90434.0, 93986.0, 94802.525987371, 95770.0, 96985.0, 445.2475316714677, 468.981240750373, 472.38825720691784, 472.8486884197093, 475.2324995132836, 10297.588096476056, 10828.079613232963, 10980.450977451255, 11030.227884048361, 11069.335839849635, 32540.83729581337, 33914.66085339115, 34640.82679586586, 35194.82402587971, 35465.822670887515, 41346.79326603348, 42750.78624606857, 48899.75550122369, 50188.498115019844, 57911.420885792286, 7089.397401220954, 7437.851242975218, 8402.663893444194, 8502.659893604186, 8689.695860644848, 12490.562830300896, 13442.596722098353, 13591.388387522784, 13768.173909565458, 13844.723105538034, 11735.354555499189, 12085.939570302093, 12103.455344509694, 12260.754784904073, 12520.248785072925, 11575.073994080622, 11631.360275184608, 11641.359725214856, 11777.646670599896, 11880.643580692593, 12222.816657749963, 12241.387930603612, 12399.690007749878, 12406.503739850305, 12425.62723118308, 8008.279254866857, 8592.871106933277, 8675.34934879874, 8735.912640873765, 8758.0, 11708.47311870985, 12037.337946413032, 12234.143609947574, 12263.325517096646, 12429.44067516982], "value": 8234.533788975228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.5761356365954, 1477.99261003695, 1509.9547013589593, 1646.4648989078546, 1784.8309357370917, 7329.706811727531, 8089.352851771859, 8239.87640185397, 8265.752027439186, 8301.91698083019, 8023.157568455301, 8141.43009989301, 8147.0, 8152.877706834387, 8160.428769986089, 2039.9184032638677, 2108.114591871418, 2111.050027487629, 2297.5404919016223, 2313.6760853480528, 2303.0442366418, 2373.738888722239, 2375.536770329778, 2376.7147942246957, 2380.9642855357097, 2229.6989906362596, 2237.65316375962, 2238.630625946717, 2249.1003598560624, 2280.304507125326, 2036.1549956767924, 2106.410205142547, 2274.454131008554, 2283.6460348645905, 2287.839851210416, 2030.7867673894177, 2237.2393386248755, 2330.1378489958656, 2332.755060718634, 2334.2997100869843, 8015.4389192756535, 8042.356611471068, 8071.394645401619, 8073.515589064675, 8084.231997960184, 4921.8523444296725, 5038.445770965191, 5052.57053150479, 5058.064258112224, 5072.72100034498, 3309.321589074234, 3329.400707872582, 3366.5791776027995, 3387.068556147079, 3440.0367896988632, 1139.0147522393154, 1152.8270759386075, 1157.0, 1186.5075993462704, 1216.6289281769057, 11421.714457138554, 11438.0, 11446.542138314457, 11453.828192577119, 11456.739758626545, 4279.679024073207, 4498.032922921522, 4518.0, 4666.066786642685, 4674.719516829001, 9664.130228279488, 9668.613255469843, 9673.12941835224, 9680.709578712649, 9692.369995950241, 5075.0, 5102.0, 5118.206677964921, 5127.410347809975, 5134.101532231844, 4314.7626880521875, 4672.299155126758, 4715.717056976592, 4750.976245118753, 4836.903261934812, 3753.474513568103, 3801.4867992820614, 3838.7696738195796, 3847.249786291646, 3931.5085614298214, 1215.6474622359594, 1275.5790589105573, 1282.7178020835402, 1291.5673249461347, 1307.2156705976338, 869.8390797702318, 883.1124719656704, 883.9160279773412, 897.3583887520455, 910.2672348759312, 5670.092785154356, 5736.942630573641, 5744.511716504144, 5790.913136302959, 5892.558058145656, 941.3316545252948, 944.4663764972769, 948.6821914658528, 957.6217394129419, 1013.1692012549786, 4027.375756757707, 4078.5105787305715, 4084.7549147051272, 4093.1404405074672, 4095.201435720006, 10134.391936483835, 10439.843402348972, 10496.0, 10515.526801293807, 10516.263861529773, 10183.643572474928, 10276.332038417479, 10304.278700490893, 10348.016938390841, 10357.4303413313, 7243.601601911945, 7848.843023139505, 7936.4047696423, 7974.5215287082965, 7980.3615710743, 5666.433356664301, 5735.913961290667, 5737.713114344183, 5757.424257574209, 5857.8535536610225, 9187.0, 9280.72157835266, 9405.20055795265, 9421.152096311365, 9422.95288523553, 9426.340156189, 9503.66737164196, 9514.85727714071, 9614.0, 9641.084097010773, 6733.326667333227, 6840.863182736218, 6938.5143039986715, 6940.375366216863, 7140.85718285621, 7969.3226075784205, 8225.095239523767, 8234.547099909563, 8250.339972802281, 8278.130796266305, 7356.595387253752, 7399.926000739923, 7565.243475652391, 7569.1673915870315, 7591.658375373011, 7304.671289792079, 7337.339639432476, 7362.006129172493, 7395.8151046224275, 7443.292887175709, 6850.177978642595, 6857.55425897315, 6907.34380233877, 6916.170059592881, 6921.169459664671, 5089.745512724423, 5171.379434467888, 5181.093308670892, 5330.387005494418, 5363.624546281723, 5025.673331233458, 5033.672811267256, 5062.898742025212, 5075.568576671024, 5123.436421993503], "value": 4473.736820676046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.32954176956264, 310.93004074083336, 311.53425628685113, 316.3720015768699, 319.19085119222774, 5612.298462692163, 5664.546836253095, 5747.36200182948, 5748.885022299557, 5763.1355296705415, 5322.281491998579, 5460.150593831349, 5669.015844454439, 5699.31870098321, 5701.2018317435595, 4291.35629655551, 4317.503487098977, 4341.110072435144, 4342.934855977162, 4347.760873151976, 4275.722078064931, 4328.2209202343565, 4340.631046361047, 4342.891427714317, 4351.369051487548, 4117.982188727517, 4186.141840922619, 4305.67707421943, 4307.763073030982, 4327.242732521812, 4294.763787991659, 4299.161663475624, 4303.763293018883, 4317.935230971538, 4318.524962254165, 3773.2830762155377, 3780.6030366811638, 3792.6207379262128, 3796.468494410785, 3797.829097690583, 5195.116830138885, 5419.83740487786, 5425.562226010111, 5426.0, 5474.09677403228, 4945.975270123662, 4953.4303555091265, 4955.141821816818, 4972.577330926875, 4984.077945580043, 5877.882442351129, 5885.499197704601, 5891.351951285355, 5903.911441328383, 5915.970420147872, 3855.094052897595, 4041.191761647682, 4041.8787436376956, 4052.250333688277, 4077.143799802045, 6134.78528251509, 6198.4731297839735, 6220.129181914535, 6227.734002208502, 6252.3122456529745, 4088.7342322748927, 4111.362738775495, 4114.403411505315, 4123.773192474443, 4146.295129827937, 4122.175564887035, 4190.5180904195795, 4191.098913733562, 4198.118395136994, 4210.578942105765, 4884.975575122173, 4901.730404827768, 4909.091818013608, 4909.533594308535, 4912.926306105412, 5971.4327138921735, 5975.551833612496, 5977.22296101504, 5988.371221021817, 6009.0, 1376.8141300924447, 1403.7506619109001, 1409.5489443378021, 1465.8167729033871, 1472.8158980127484, 938.6573900526396, 939.6100618243353, 957.2772556719632, 962.956666949989, 968.1770495079127, 5709.486146246858, 5720.48515633595, 5736.856578585569, 5753.51095156908, 5761.337446193657, 6098.0, 6109.5112391008615, 6110.297315808739, 6112.663803490851, 6122.8876037766895, 5612.35457922336, 5728.598998070179, 5751.597388182787, 5839.620424672383, 5884.264466941632, 3299.1752061984503, 3299.2411745298236, 3310.503424486298, 3311.503274508843, 3329.5338652588657, 6168.444839964424, 6433.356664333623, 6434.967825160844, 6442.420182183626, 6447.742090316428, 6336.809895703136, 6346.841328966812, 6356.77751278703, 6361.872762544724, 6380.033284522719, 6400.551961362753, 6444.742210311535, 6462.0, 6467.579607325509, 6467.838304042342, 5936.436038576328, 6261.092141639528, 6267.2165979252595, 6295.150154729236, 6308.243010838545, 6077.270727512727, 6161.784337548164, 6171.228596425447, 6199.535034872493, 6217.253929528486, 6240.344763799736, 6304.0, 6359.523035772429, 6428.742850285937, 6434.453071488976, 4134.1524987376915, 4137.15188386374, 4143.1713657269265, 4159.313713237403, 4169.8957526062095, 5919.0, 6250.812475625738, 6267.373262673696, 6268.247810262797, 6290.0879372491645, 5904.439078287556, 6054.212952316171, 6071.574989750852, 6089.482393996383, 6090.0, 6017.428344307284, 6027.3726093955265, 6028.87942241144, 6032.698365081641, 6060.333363330118, 5766.654000759968, 5913.142594323885, 5923.881522369442, 5931.614445061057, 5959.4934430573885, 5966.850828729316, 6027.939720602913, 6047.425494578008, 6062.272527296753, 6069.969650151721, 5745.741441635053, 5921.3782552831335, 5934.525237980864, 5944.6433214005565, 5945.791897283747], "value": 4485.594412559829, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.4544705088808, 814.1532805881882, 830.9833803323932, 846.957652117394, 852.936029797765, 14424.062435941656, 14598.270086495686, 14604.123752574853, 14626.0, 14688.192149431778, 13092.869071309284, 13268.0, 13283.667908302274, 13284.667883302922, 13310.866891331083, 662.5262937000056, 677.566357531178, 678.0304165043985, 678.9321067893196, 777.1800750208528, 791.1534657916033, 792.2988155482411, 794.0788685125256, 798.8881556582054, 801.1867954026668, 840.4327079221532, 843.2579330189425, 843.8987321521427, 845.5856630251163, 846.1834329871673, 708.0794966543473, 842.8019415437428, 842.9789255268606, 843.7257891185359, 844.1558441558442, 600.26467577218, 611.1810174366326, 613.745295702283, 614.1340709599443, 614.1586027142798, 14176.787348189786, 14261.073030253001, 14267.500637477742, 14274.3576539056, 14292.499762508261, 13742.93128534361, 14121.293935303296, 14139.858601413956, 14221.715565688628, 14297.356618952172, 11595.652130436101, 11604.883951160466, 11605.245659032136, 11628.302301861831, 11715.472803723853, 3783.1109689223013, 3839.0978120141745, 3844.596317386662, 3887.1253967857288, 3891.6692081173132, 49746.0, 54673.0, 56013.71993140008, 56427.71786141043, 56583.151252731244, 10125.64560240388, 10162.4918754062, 10173.237007224488, 10312.484375781181, 10363.481825908675, 18487.075646217636, 18921.432357029313, 18962.0, 18970.0, 19086.618267634847, 8441.802872709262, 8504.53225072627, 8535.0, 8747.562621868881, 8854.734357969272, 4929.580985616263, 4941.72820494869, 4945.703257804544, 4974.477679843637, 5052.469490703424, 3373.4433818420175, 3487.3199726053685, 3489.5986961499752, 3492.441209406483, 3493.039414161126, 654.2704884054245, 662.5792621685168, 664.0305154474424, 678.1523096129838, 681.0397339751026, 623.6912728199479, 624.865653884408, 722.4762047515509, 734.229059487536, 738.7931379213828, 8639.78400539979, 8787.604557794915, 9020.8646870297, 9524.761880952892, 9576.186024188022, 722.6459035072777, 727.0257854474924, 737.9262073792578, 746.6042997211377, 776.1850057439666, 4156.480439945007, 4185.455890734185, 4250.617444430016, 4292.5492823253735, 4406.361077643724, 57573.56066098297, 59620.0, 59820.401795982354, 60013.39986600165, 60561.0, 51640.19259325905, 51910.22134667983, 52612.47387526152, 52641.7367913158, 53278.99999999922, 47702.5229747705, 48209.276860847116, 49024.264636030486, 49210.50789492059, 49925.25112123321, 8199.79500512468, 8223.794405139919, 8332.791680207802, 8366.748997530083, 8408.0, 28450.85774571114, 30105.69894301029, 31732.365352692355, 32497.675023249463, 33075.50386744153, 40819.0, 41434.0, 41821.37267940922, 42295.0, 43210.0, 12217.389130543259, 12347.75304493923, 12376.62870113898, 12449.439775209956, 12489.93755031219, 13525.2561109136, 13612.795808062689, 13655.317234138054, 14080.647983800487, 14111.576652700436, 11115.944420277847, 13076.215427074407, 13324.200547967153, 13591.592252232449, 13591.86408135906, 12580.937095314464, 12958.935205324291, 13080.345982700637, 13159.342032898125, 13625.931870340584, 12307.261564305812, 12353.691157721129, 12495.062870284946, 12733.55432559856, 13565.728685426038, 10333.0, 10412.583496660049, 10832.67501974942, 11207.943960280472, 11240.156988225752, 10903.34579925207, 11149.940755628202, 11376.203665743318, 11573.537058517903, 11645.359505226956], "value": 6688.793580079121, "unit": "score"}], "name": "dromaeo_css", "value": 6953.016945415012, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 107.0, 111.0, 112.0, 112.0, 100.0, 112.0, 111.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 154.0, 179.0, 129.0, 157.0, 162.0, 128.0, 190.0, 126.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 163.0, 164.0, 163.0, 164.0, 164.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 113.0, 111.0, 76.0, 76.0, 76.0, 126.0, 102.0, 78.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 155.0, 93.0, 93.0, 93.0, 152.0, 92.0, 92.0, 155.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 119.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 72.0, 56.0, 55.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 74.0, 76.0, 75.0, 77.0, 88.0, 76.0, 78.0, 85.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 126.0, 122.0, 121.0, 124.0, 120.0, 133.0, 169.0, 127.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 165.0, 162.0, 160.0, 161.0, 163.0, 166.0, 167.0, 163.0, 166.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1543.7, "alertThreshold": 2.0}]} 04:12:56 INFO - Return code: 0 04:12:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:12:56 ERROR - # TBPL SUCCESS # 04:12:56 INFO - Running post-action listener: _resource_record_post_action 04:12:56 INFO - Running post-run listener: _resource_record_post_run 04:12:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535937024; Read time: 12; Write time: 497580 04:12:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244224000; Read time: 0; Write time: 294848 04:12:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291713024; Read time: 12; Write time: 202732 04:12:57 INFO - Running post-run listener: _upload_blobber_files 04:12:57 INFO - Blob upload gear active. 04:12:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:57 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 04:12:57 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:12:57 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:12:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:58 INFO - (blobuploader) - INFO - Done attempting. 04:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:12:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:59 INFO - (blobuploader) - INFO - Done attempting. 04:12:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:59 INFO - Return code: 0 04:12:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5805aa2ca1852ff725e5e3270ecaa17c6b3d52a8c42c969ec2ac48d91aa3b95d48e244f8c532865c75462ed3df5d80e3c0860a7be9d5906111436dc17dcf098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/edcbf4f4e9505a1261724ffec7e2d3fe6bf942104ffe4ad8f6268a23e4500299f41d1c8789427c9b288f25eb20777194e60a4de742e390ed19549cf874280c3a"} 04:12:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:59 INFO - Contents: 04:12:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5805aa2ca1852ff725e5e3270ecaa17c6b3d52a8c42c969ec2ac48d91aa3b95d48e244f8c532865c75462ed3df5d80e3c0860a7be9d5906111436dc17dcf098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/edcbf4f4e9505a1261724ffec7e2d3fe6bf942104ffe4ad8f6268a23e4500299f41d1c8789427c9b288f25eb20777194e60a4de742e390ed19549cf874280c3a"} 04:12:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:59 INFO - Copying logs to upload dir... 04:12:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.183253 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-15 04:12:59.309512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 04:12:59.312997) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605 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-Inbound/sha512/f5805aa2ca1852ff725e5e3270ecaa17c6b3d52a8c42c969ec2ac48d91aa3b95d48e244f8c532865c75462ed3df5d80e3c0860a7be9d5906111436dc17dcf098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/edcbf4f4e9505a1261724ffec7e2d3fe6bf942104ffe4ad8f6268a23e4500299f41d1c8789427c9b288f25eb20777194e60a4de742e390ed19549cf874280c3a"} build_url:https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/e-dxueeTSTaCmxxGGQkDlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5805aa2ca1852ff725e5e3270ecaa17c6b3d52a8c42c969ec2ac48d91aa3b95d48e244f8c532865c75462ed3df5d80e3c0860a7be9d5906111436dc17dcf098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/edcbf4f4e9505a1261724ffec7e2d3fe6bf942104ffe4ad8f6268a23e4500299f41d1c8789427c9b288f25eb20777194e60a4de742e390ed19549cf874280c3a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 04:12:59.340435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:12:59.341118) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460716730.522546-163560605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:12:59.426585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 04:12:59.427315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 04:12:59.427742) ========= ========= Total master_lag: 0.18 =========