builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1461339131.29 results: success (0) buildid: 20160422065716 builduid: b45713089684492fa0483343b4eeab0c revision: fc15477ce628599519cb0055f52cc195d640dc94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.289554) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.290088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.290366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.307875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.308201) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 08:32:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.9M=0s 2016-04-22 08:32:11 (24.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.441028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.441392) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015006 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.493054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:11.493656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc15477ce628599519cb0055f52cc195d640dc94 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fc15477ce628599519cb0055f52cc195d640dc94 --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=7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 08:32:11,988 truncating revision to first 12 chars 2016-04-22 08:32:11,989 Setting DEBUG logging. 2016-04-22 08:32:11,989 attempt 1/10 2016-04-22 08:32:11,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc15477ce628?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 08:32:12,639 unpacking tar archive at: mozilla-central-fc15477ce628/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:12.428788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:12.432165) ========= script_repo_revision: fc15477ce628599519cb0055f52cc195d640dc94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:12.432556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:12.432842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:32:12.443542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-22 08:32:12.443833) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:13 INFO - MultiFileLogger online at 20160422 08:32:13 in /builds/slave/test 08:32:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:32:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:13 INFO - {'append_to_log': False, 08:32:13 INFO - 'base_work_dir': '/builds/slave/test', 08:32:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:32:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:13 INFO - 'branch': 'Firefox-Non-PGO', 08:32:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:13 INFO - 'config_files': ('talos/linux_config.py',), 08:32:13 INFO - 'default_actions': ('clobber', 08:32:13 INFO - 'read-buildbot-config', 08:32:13 INFO - 'download-and-extract', 08:32:13 INFO - 'populate-webroot', 08:32:13 INFO - 'create-virtualenv', 08:32:13 INFO - 'install', 08:32:13 INFO - 'run-tests'), 08:32:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:13 INFO - 'download_minidump_stackwalk': True, 08:32:13 INFO - 'download_symbols': 'ondemand', 08:32:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:13 INFO - 'installer_path': 'installer.exe', 08:32:13 INFO - 'log_level': 'info', 08:32:13 INFO - 'log_name': 'talos', 08:32:13 INFO - 'log_to_console': True, 08:32:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:13 INFO - 'opt_config_files': (), 08:32:13 INFO - 'pip_index': False, 08:32:13 INFO - 'sps_profile': False, 08:32:13 INFO - 'sps_profile_interval': 0, 08:32:13 INFO - 'suite': 'dromaeojs', 08:32:13 INFO - 'system_bits': '32', 08:32:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:13 INFO - 'title': 'talos-linux64-ix-005', 08:32:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:13 INFO - 'use_talos_json': True, 08:32:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:13 INFO - 'work_dir': 'build'} 08:32:13 INFO - ##### 08:32:13 INFO - ##### Running clobber step. 08:32:13 INFO - ##### 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: clobber 08:32:13 INFO - rmtree: /builds/slave/test/build 08:32:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:13 INFO - Running post-action listener: _resource_record_post_action 08:32:13 INFO - ##### 08:32:13 INFO - ##### Running read-buildbot-config step. 08:32:13 INFO - ##### 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: read_buildbot_config 08:32:13 INFO - Using buildbot properties: 08:32:13 INFO - { 08:32:13 INFO - "project": "", 08:32:13 INFO - "product": "firefox", 08:32:13 INFO - "script_repo_revision": "production", 08:32:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:32:13 INFO - "repository": "", 08:32:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:32:13 INFO - "buildid": "20160422065716", 08:32:13 INFO - "pgo_build": "False", 08:32:13 INFO - "basedir": "/builds/slave/test", 08:32:13 INFO - "buildnumber": 482, 08:32:13 INFO - "slavename": "talos-linux64-ix-005", 08:32:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:32:13 INFO - "platform": "ubuntu64_hw", 08:32:13 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:32:13 INFO - "branch": "mozilla-central", 08:32:13 INFO - "repo_path": "mozilla-central", 08:32:13 INFO - "revision": "fc15477ce628599519cb0055f52cc195d640dc94", 08:32:13 INFO - "stage_platform": "linux64", 08:32:13 INFO - "builduid": "b45713089684492fa0483343b4eeab0c", 08:32:13 INFO - "slavebuilddir": "test" 08:32:13 INFO - } 08:32:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:32:13 INFO - Running post-action listener: _resource_record_post_action 08:32:13 INFO - ##### 08:32:13 INFO - ##### Running download-and-extract step. 08:32:13 INFO - ##### 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: download_and_extract 08:32:13 INFO - mkdir: /builds/slave/test/build/tests 08:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:13 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:14 INFO - Downloaded 1361 bytes. 08:32:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:32:14 INFO - Using the following test package requirements: 08:32:14 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:32:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:32:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'jsshell-linux-x86_64.zip'], 08:32:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:32:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:32:14 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:32:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:32:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:32:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:32:14 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')]} 08:32:14 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:15 INFO - Downloaded 22285370 bytes. 08:32:15 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'] 08:32:15 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 08:32:16 INFO - Return code: 0 08:32:16 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 08:32:16 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')]} 08:32:16 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:17 INFO - Downloaded 22285370 bytes. 08:32:17 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'] 08:32:17 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 08:32:18 INFO - Return code: 0 08:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:18 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:32:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:19 INFO - Downloaded 10840145 bytes. 08:32:19 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'] 08:32:19 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 08:32:20 INFO - Return code: 0 08:32:20 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')]} 08:32:20 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:32:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:32:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:32:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/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 08:32:21 INFO - Downloaded 54660662 bytes. 08:32:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:32:21 INFO - mkdir: /builds/slave/test/properties 08:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:21 INFO - Contents: 08:32:21 INFO - build_url:https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:32:22 INFO - Running post-action listener: _resource_record_post_action 08:32:22 INFO - Running post-action listener: set_extra_try_arguments 08:32:22 INFO - ##### 08:32:22 INFO - ##### Running populate-webroot step. 08:32:22 INFO - ##### 08:32:22 INFO - Running pre-action listener: _resource_record_pre_action 08:32:22 INFO - Running main action method: populate_webroot 08:32:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:22 INFO - '--tppagecycles', 08:32:22 INFO - '7'], 08:32:22 INFO - 'tests': ['tsvgm']}}, 08:32:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['damp', 'tps']}, 08:32:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'tests': ['damp', 'tps']}, 08:32:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['dromaeo_dom']}, 08:32:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['a11yr', 08:32:22 INFO - 'ts_paint', 08:32:22 INFO - 'tpaint', 08:32:22 INFO - 'sessionrestore', 08:32:22 INFO - 'sessionrestore_no_auto_restore', 08:32:22 INFO - 'tabpaint']}, 08:32:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:22 INFO - 'ts_paint', 08:32:22 INFO - 'tpaint', 08:32:22 INFO - 'sessionrestore', 08:32:22 INFO - 'sessionrestore_no_auto_restore', 08:32:22 INFO - 'tabpaint']}, 08:32:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:22 INFO - 'ts_paint', 08:32:22 INFO - 'tpaint', 08:32:22 INFO - 'sessionrestore', 08:32:22 INFO - 'sessionrestore_no_auto_restore', 08:32:22 INFO - 'tabpaint']}, 08:32:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:22 INFO - 'ts_paint', 08:32:22 INFO - 'tpaint', 08:32:22 INFO - 'sessionrestore', 08:32:22 INFO - 'sessionrestore_no_auto_restore', 08:32:22 INFO - 'tabpaint']}, 08:32:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['a11yr', 08:32:22 INFO - 'ts_paint', 08:32:22 INFO - 'tpaint', 08:32:22 INFO - 'sessionrestore', 08:32:22 INFO - 'sessionrestore_no_auto_restore', 08:32:22 INFO - 'tabpaint']}, 08:32:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['a11yr', 08:32:22 INFO - 'ts_paint', 08:32:22 INFO - 'tpaint', 08:32:22 INFO - 'sessionrestore', 08:32:22 INFO - 'sessionrestore_no_auto_restore', 08:32:22 INFO - 'tabpaint']}, 08:32:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['tsvgx', 08:32:22 INFO - 'tsvgr_opacity', 08:32:22 INFO - 'tart', 08:32:22 INFO - 'tscrollx', 08:32:22 INFO - 'cart']}, 08:32:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:22 INFO - 'tsvgr_opacity', 08:32:22 INFO - 'tart', 08:32:22 INFO - 'tscrollx', 08:32:22 INFO - 'cart']}, 08:32:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'talos_options': ['--disable-e10s'], 08:32:22 INFO - 'tests': ['tp5o']}, 08:32:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'tests': ['tp5o']}, 08:32:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'talos_options': ['--disable-e10s', 08:32:22 INFO - '--xperf_path', 08:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:22 INFO - 'tests': ['tp5n']}, 08:32:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:22 INFO - 'talos_options': ['--xperf_path', 08:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:22 INFO - 'tests': ['tp5n']}}, 08:32:22 INFO - 'talos.zip': {'path': '', 08:32:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:22 INFO - Running post-action listener: _resource_record_post_action 08:32:22 INFO - ##### 08:32:22 INFO - ##### Running create-virtualenv step. 08:32:22 INFO - ##### 08:32:22 INFO - Running pre-action listener: _resource_record_pre_action 08:32:22 INFO - Running main action method: create_virtualenv 08:32:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:22 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 08:32:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:22 INFO - Using real prefix '/usr' 08:32:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:25 INFO - Installing pip.................done. 08:32:25 INFO - Return code: 0 08:32:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:32:25 INFO - Using env: {'DISPLAY': ':0', 08:32:25 INFO - 'HOME': '/home/cltbld', 08:32:25 INFO - 'LANG': 'en_US.UTF-8', 08:32:25 INFO - 'LANGUAGE': 'en_US:en', 08:32:25 INFO - 'LOGNAME': 'cltbld', 08:32:25 INFO - 'MAIL': '/var/mail/cltbld', 08:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:25 INFO - 'MOZ_NO_REMOTE': '1', 08:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:25 INFO - 'NO_EM_RESTART': '1', 08:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:25 INFO - 'PWD': '/builds/slave/test', 08:32:25 INFO - 'SHELL': '/bin/bash', 08:32:25 INFO - 'SHLVL': '1', 08:32:25 INFO - 'TERM': 'linux', 08:32:25 INFO - 'TMOUT': '86400', 08:32:25 INFO - 'USER': 'cltbld', 08:32:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:25 INFO - '_': '/tools/buildbot/bin/python'} 08:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:25 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 08:32:25 INFO - Cleaning up... 08:32:25 INFO - Return code: 0 08:32:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:32:25 INFO - Using env: {'DISPLAY': ':0', 08:32:25 INFO - 'HOME': '/home/cltbld', 08:32:25 INFO - 'LANG': 'en_US.UTF-8', 08:32:25 INFO - 'LANGUAGE': 'en_US:en', 08:32:25 INFO - 'LOGNAME': 'cltbld', 08:32:25 INFO - 'MAIL': '/var/mail/cltbld', 08:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:25 INFO - 'MOZ_NO_REMOTE': '1', 08:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:25 INFO - 'NO_EM_RESTART': '1', 08:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:25 INFO - 'PWD': '/builds/slave/test', 08:32:25 INFO - 'SHELL': '/bin/bash', 08:32:25 INFO - 'SHLVL': '1', 08:32:25 INFO - 'TERM': 'linux', 08:32:25 INFO - 'TMOUT': '86400', 08:32:25 INFO - 'USER': 'cltbld', 08:32:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:25 INFO - '_': '/tools/buildbot/bin/python'} 08:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:25 INFO - Downloading/unpacking psutil>=0.7.1 08:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:27 INFO - Installing collected packages: psutil 08:32:27 INFO - Running setup.py install for psutil 08:32:27 INFO - building 'psutil._psutil_linux' extension 08:32:27 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 08:32:27 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 08:32:27 INFO - building 'psutil._psutil_posix' extension 08:32:27 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 08:32:28 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 08:32:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:28 INFO - Successfully installed psutil 08:32:28 INFO - Cleaning up... 08:32:28 INFO - Return code: 0 08:32:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:32:28 INFO - Using env: {'DISPLAY': ':0', 08:32:28 INFO - 'HOME': '/home/cltbld', 08:32:28 INFO - 'LANG': 'en_US.UTF-8', 08:32:28 INFO - 'LANGUAGE': 'en_US:en', 08:32:28 INFO - 'LOGNAME': 'cltbld', 08:32:28 INFO - 'MAIL': '/var/mail/cltbld', 08:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:28 INFO - 'MOZ_NO_REMOTE': '1', 08:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:28 INFO - 'NO_EM_RESTART': '1', 08:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:28 INFO - 'PWD': '/builds/slave/test', 08:32:28 INFO - 'SHELL': '/bin/bash', 08:32:28 INFO - 'SHLVL': '1', 08:32:28 INFO - 'TERM': 'linux', 08:32:28 INFO - 'TMOUT': '86400', 08:32:28 INFO - 'USER': 'cltbld', 08:32:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:28 INFO - '_': '/tools/buildbot/bin/python'} 08:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:32:30 INFO - Installing collected packages: mozsystemmonitor 08:32:30 INFO - Running setup.py install for mozsystemmonitor 08:32:30 INFO - Successfully installed mozsystemmonitor 08:32:30 INFO - Cleaning up... 08:32:30 INFO - Return code: 0 08:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:30 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 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:30 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 08:32:30 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 08:32:30 INFO - Using env: {'DISPLAY': ':0', 08:32:30 INFO - 'HOME': '/home/cltbld', 08:32:30 INFO - 'LANG': 'en_US.UTF-8', 08:32:30 INFO - 'LANGUAGE': 'en_US:en', 08:32:30 INFO - 'LOGNAME': 'cltbld', 08:32:30 INFO - 'MAIL': '/var/mail/cltbld', 08:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:30 INFO - 'MOZ_NO_REMOTE': '1', 08:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:30 INFO - 'NO_EM_RESTART': '1', 08:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:30 INFO - 'PWD': '/builds/slave/test', 08:32:30 INFO - 'SHELL': '/bin/bash', 08:32:30 INFO - 'SHLVL': '1', 08:32:30 INFO - 'TERM': 'linux', 08:32:30 INFO - 'TMOUT': '86400', 08:32:30 INFO - 'USER': 'cltbld', 08:32:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:30 INFO - '_': '/tools/buildbot/bin/python'} 08:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:32 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 08:32:32 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 08:32:32 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 08:32:32 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 08:32:32 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 08:32:32 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 08:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:33 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 08:32:33 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 08:32:33 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 08:32:33 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 08:32:33 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 08:32:33 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 08:32:33 INFO - Downloading docopt-0.6.1.tar.gz 08:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:33 INFO - Running setup.py install for blobuploader 08:32:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:33 INFO - Running setup.py install for requests 08:32:33 INFO - Running setup.py install for docopt 08:32:33 INFO - Successfully installed blobuploader requests docopt 08:32:33 INFO - Cleaning up... 08:32:33 INFO - Return code: 0 08:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:33 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 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:33 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 08:32:33 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 08:32:33 INFO - Using env: {'DISPLAY': ':0', 08:32:33 INFO - 'HOME': '/home/cltbld', 08:32:33 INFO - 'LANG': 'en_US.UTF-8', 08:32:33 INFO - 'LANGUAGE': 'en_US:en', 08:32:33 INFO - 'LOGNAME': 'cltbld', 08:32:33 INFO - 'MAIL': '/var/mail/cltbld', 08:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:33 INFO - 'MOZ_NO_REMOTE': '1', 08:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:33 INFO - 'NO_EM_RESTART': '1', 08:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:33 INFO - 'PWD': '/builds/slave/test', 08:32:33 INFO - 'SHELL': '/bin/bash', 08:32:33 INFO - 'SHLVL': '1', 08:32:33 INFO - 'TERM': 'linux', 08:32:34 INFO - 'TMOUT': '86400', 08:32:34 INFO - 'USER': 'cltbld', 08:32:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:34 INFO - '_': '/tools/buildbot/bin/python'} 08:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:34 INFO - Running setup.py (path:/tmp/pip-XaQPKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:34 INFO - Running setup.py (path:/tmp/pip-dfXqy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:34 INFO - Running setup.py (path:/tmp/pip-tt3g2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:34 INFO - Running setup.py (path:/tmp/pip-_Xcinv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:34 INFO - Running setup.py (path:/tmp/pip-cALP5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:34 INFO - Running setup.py (path:/tmp/pip-ElXfON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:34 INFO - Running setup.py (path:/tmp/pip-H2Vose-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:34 INFO - Running setup.py (path:/tmp/pip-NRfLvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:34 INFO - Running setup.py (path:/tmp/pip-VtZm2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:34 INFO - Running setup.py (path:/tmp/pip-9gWGQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:34 INFO - Running setup.py (path:/tmp/pip-msl2xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:35 INFO - Running setup.py (path:/tmp/pip-bPHH2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:35 INFO - Running setup.py (path:/tmp/pip-EPVQ2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:35 INFO - Running setup.py (path:/tmp/pip-_HKlIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:35 INFO - Running setup.py (path:/tmp/pip-eWeT4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:35 INFO - Running setup.py (path:/tmp/pip-jFrgKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:35 INFO - Running setup.py (path:/tmp/pip-bTBPwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:35 INFO - Running setup.py install for manifestparser 08:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Running setup.py install for mozcrash 08:32:35 INFO - Running setup.py install for mozdebug 08:32:35 INFO - Running setup.py install for mozdevice 08:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Running setup.py install for mozfile 08:32:35 INFO - Running setup.py install for mozhttpd 08:32:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozinfo 08:32:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozInstall 08:32:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozleak 08:32:36 INFO - Running setup.py install for mozlog 08:32:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for moznetwork 08:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozprocess 08:32:36 INFO - Running setup.py install for mozprofile 08:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozrunner 08:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozscreenshot 08:32:37 INFO - Running setup.py install for moztest 08:32:37 INFO - Running setup.py install for mozversion 08:32:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:37 INFO - Cleaning up... 08:32:37 INFO - Return code: 0 08:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:37 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 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:37 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 08:32:37 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 08:32:37 INFO - Using env: {'DISPLAY': ':0', 08:32:37 INFO - 'HOME': '/home/cltbld', 08:32:37 INFO - 'LANG': 'en_US.UTF-8', 08:32:37 INFO - 'LANGUAGE': 'en_US:en', 08:32:37 INFO - 'LOGNAME': 'cltbld', 08:32:37 INFO - 'MAIL': '/var/mail/cltbld', 08:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:37 INFO - 'MOZ_NO_REMOTE': '1', 08:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:37 INFO - 'NO_EM_RESTART': '1', 08:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:37 INFO - 'PWD': '/builds/slave/test', 08:32:37 INFO - 'SHELL': '/bin/bash', 08:32:37 INFO - 'SHLVL': '1', 08:32:37 INFO - 'TERM': 'linux', 08:32:37 INFO - 'TMOUT': '86400', 08:32:37 INFO - 'USER': 'cltbld', 08:32:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:37 INFO - '_': '/tools/buildbot/bin/python'} 08:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:37 INFO - Running setup.py (path:/tmp/pip-VfILiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:37 INFO - Running setup.py (path:/tmp/pip-TuheET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:37 INFO - Running setup.py (path:/tmp/pip-Jik1Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:37 INFO - Running setup.py (path:/tmp/pip-iDeNpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:37 INFO - Running setup.py (path:/tmp/pip-6cx8zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:37 INFO - Running setup.py (path:/tmp/pip-_r5h2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:37 INFO - Running setup.py (path:/tmp/pip-X6PwzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:37 INFO - Running setup.py (path:/tmp/pip-P0fzoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:38 INFO - Running setup.py (path:/tmp/pip-IbUsxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:38 INFO - Running setup.py (path:/tmp/pip-rBIqCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:38 INFO - Running setup.py (path:/tmp/pip-oSHOGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:38 INFO - Running setup.py (path:/tmp/pip-BBPki1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:38 INFO - Running setup.py (path:/tmp/pip-jvLYVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:38 INFO - Running setup.py (path:/tmp/pip-9Q0hJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:38 INFO - Running setup.py (path:/tmp/pip-SgnSdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:38 INFO - Running setup.py (path:/tmp/pip-7j4Hwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:38 INFO - Running setup.py (path:/tmp/pip-juRaHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:38 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)) 08:32:38 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)) 08:32:38 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)) 08:32:38 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)) 08:32:38 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)) 08:32:38 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)) 08:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:38 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 08:32:38 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 08:32:38 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 08:32:38 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 08:32:38 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 08:32:38 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 08:32:40 INFO - Downloading blessings-1.6.tar.gz 08:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:40 INFO - Installing collected packages: blessings 08:32:40 INFO - Running setup.py install for blessings 08:32:40 INFO - Successfully installed blessings 08:32:40 INFO - Cleaning up... 08:32:40 INFO - Return code: 0 08:32:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:41 INFO - Reading from file tmpfile_stdout 08:32:41 INFO - Current package versions: 08:32:41 INFO - argparse == 1.2.1 08:32:41 INFO - blessings == 1.6 08:32:41 INFO - blobuploader == 1.2.4 08:32:41 INFO - docopt == 0.6.1 08:32:41 INFO - manifestparser == 1.1 08:32:41 INFO - mozInstall == 1.12 08:32:41 INFO - mozcrash == 0.17 08:32:41 INFO - mozdebug == 0.1 08:32:41 INFO - mozdevice == 0.48 08:32:41 INFO - mozfile == 1.2 08:32:41 INFO - mozhttpd == 0.7 08:32:41 INFO - mozinfo == 0.9 08:32:41 INFO - mozleak == 0.1 08:32:41 INFO - mozlog == 3.1 08:32:41 INFO - moznetwork == 0.27 08:32:41 INFO - mozprocess == 0.22 08:32:41 INFO - mozprofile == 0.28 08:32:41 INFO - mozrunner == 6.11 08:32:41 INFO - mozscreenshot == 0.1 08:32:41 INFO - mozsystemmonitor == 0.0 08:32:41 INFO - moztest == 0.7 08:32:41 INFO - mozversion == 1.4 08:32:41 INFO - psutil == 3.1.1 08:32:41 INFO - requests == 1.2.3 08:32:41 INFO - wsgiref == 0.1.2 08:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:41 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')]} 08:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 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')]} 08:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 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 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:41 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 08:32:41 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 08:32:41 INFO - Using env: {'DISPLAY': ':0', 08:32:41 INFO - 'HOME': '/home/cltbld', 08:32:41 INFO - 'LANG': 'en_US.UTF-8', 08:32:41 INFO - 'LANGUAGE': 'en_US:en', 08:32:41 INFO - 'LOGNAME': 'cltbld', 08:32:41 INFO - 'MAIL': '/var/mail/cltbld', 08:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:41 INFO - 'MOZ_NO_REMOTE': '1', 08:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:41 INFO - 'NO_EM_RESTART': '1', 08:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:41 INFO - 'PWD': '/builds/slave/test', 08:32:41 INFO - 'SHELL': '/bin/bash', 08:32:41 INFO - 'SHLVL': '1', 08:32:41 INFO - 'TERM': 'linux', 08:32:41 INFO - 'TMOUT': '86400', 08:32:41 INFO - 'USER': 'cltbld', 08:32:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:41 INFO - '_': '/tools/buildbot/bin/python'} 08:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 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)) 08:32:41 INFO - Cleaning up... 08:32:41 INFO - Return code: 0 08:32:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:32:41 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')]} 08:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 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')]} 08:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 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 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32:41 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 08:32:41 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 08:32:41 INFO - Using env: {'DISPLAY': ':0', 08:32:41 INFO - 'HOME': '/home/cltbld', 08:32:41 INFO - 'LANG': 'en_US.UTF-8', 08:32:41 INFO - 'LANGUAGE': 'en_US:en', 08:32:41 INFO - 'LOGNAME': 'cltbld', 08:32:41 INFO - 'MAIL': '/var/mail/cltbld', 08:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:41 INFO - 'MOZ_NO_REMOTE': '1', 08:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:41 INFO - 'NO_EM_RESTART': '1', 08:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:41 INFO - 'PWD': '/builds/slave/test', 08:32:41 INFO - 'SHELL': '/bin/bash', 08:32:41 INFO - 'SHLVL': '1', 08:32:41 INFO - 'TERM': 'linux', 08:32:41 INFO - 'TMOUT': '86400', 08:32:41 INFO - 'USER': 'cltbld', 08:32:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:41 INFO - '_': '/tools/buildbot/bin/python'} 08:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:41 INFO - Downloading/unpacking jsonschema 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:43 INFO - Downloading/unpacking functools32 (from jsonschema) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:43 INFO - warning: no files found matching '*.txt' 08:32:43 INFO - no previously-included directories found matching 'build' 08:32:43 INFO - no previously-included directories found matching 'dist' 08:32:43 INFO - no previously-included directories found matching '.git*' 08:32:43 INFO - Installing collected packages: jsonschema, functools32 08:32:43 INFO - Running setup.py install for functools32 08:32:43 INFO - warning: no files found matching '*.txt' 08:32:43 INFO - no previously-included directories found matching 'build' 08:32:43 INFO - no previously-included directories found matching 'dist' 08:32:43 INFO - no previously-included directories found matching '.git*' 08:32:43 INFO - Successfully installed jsonschema functools32 08:32:43 INFO - Cleaning up... 08:32:43 INFO - Return code: 0 08:32:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf6aabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', '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 08:32: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', 'flake8'] in /builds/slave/test/build 08:32: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 flake8 08:32:43 INFO - Using env: {'DISPLAY': ':0', 08:32:43 INFO - 'HOME': '/home/cltbld', 08:32:43 INFO - 'LANG': 'en_US.UTF-8', 08:32:43 INFO - 'LANGUAGE': 'en_US:en', 08:32:43 INFO - 'LOGNAME': 'cltbld', 08:32:43 INFO - 'MAIL': '/var/mail/cltbld', 08:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:43 INFO - 'MOZ_NO_REMOTE': '1', 08:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:43 INFO - 'NO_EM_RESTART': '1', 08:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:43 INFO - 'PWD': '/builds/slave/test', 08:32:43 INFO - 'SHELL': '/bin/bash', 08:32:43 INFO - 'SHLVL': '1', 08:32:43 INFO - 'TERM': 'linux', 08:32:43 INFO - 'TMOUT': '86400', 08:32:43 INFO - 'USER': 'cltbld', 08:32:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:43 INFO - '_': '/tools/buildbot/bin/python'} 08:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:44 INFO - Downloading/unpacking flake8 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:32:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:32:45 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 08:32:45 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 08:32:45 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 08:32:45 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 08:32:45 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 08:32:45 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 08:32:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:32:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:32:46 INFO - no previously-included directories found matching 'docs/_build' 08:32:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:32:46 INFO - Running setup.py install for pep8 08:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:32:46 INFO - no previously-included directories found matching 'docs/_build' 08:32:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:32:46 INFO - Cleaning up... 08:32:46 INFO - Return code: 0 08:32:46 INFO - Running post-action listener: _resource_record_post_action 08:32:46 INFO - Running post-action listener: _start_resource_monitoring 08:32:46 INFO - Starting resource monitoring. 08:32:46 INFO - ##### 08:32:46 INFO - ##### Running install step. 08:32:46 INFO - ##### 08:32:46 INFO - Running pre-action listener: _resource_record_pre_action 08:32:46 INFO - Running main action method: install 08:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:47 INFO - Reading from file tmpfile_stdout 08:32:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:47 INFO - Reading from file tmpfile_stdout 08:32:47 INFO - Output received: 08:32:47 INFO - Usage: mozinstall [options] installer 08:32:47 INFO - Options: 08:32:47 INFO - -h, --help show this help message and exit 08:32:47 INFO - -d DEST, --destination=DEST 08:32:47 INFO - Directory to install application into. [default: 08:32:47 INFO - "/builds/slave/test"] 08:32:47 INFO - --app=APP Application being installed. [default: firefox] 08:32:47 INFO - mkdir: /builds/slave/test/build/application 08:32:47 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'] 08:32:47 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 08:33:02 INFO - Reading from file tmpfile_stdout 08:33:02 INFO - Output received: 08:33:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:02 INFO - Running post-action listener: _resource_record_post_action 08:33:02 INFO - ##### 08:33:02 INFO - ##### Running run-tests step. 08:33:02 INFO - ##### 08:33:02 INFO - Running pre-action listener: _resource_record_pre_action 08:33:02 INFO - Running main action method: run_tests 08:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:02 INFO - Python 2.7.3 08:33:02 INFO - Return code: 0 08:33:02 INFO - grabbing minidump binary from tooltool 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:02 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 0x287b410>, '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 0x287c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:02 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 08:33:02 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 08:33:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:03 INFO - Return code: 0 08:33:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:33:03 INFO - Return code: 0 08:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 08:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 08:33:03 INFO - Using env: {'DISPLAY': ':0', 08:33:03 INFO - 'HOME': '/home/cltbld', 08:33:03 INFO - 'LANG': 'en_US.UTF-8', 08:33:03 INFO - 'LANGUAGE': 'en_US:en', 08:33:03 INFO - 'LOGNAME': 'cltbld', 08:33:03 INFO - 'MAIL': '/var/mail/cltbld', 08:33:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:03 INFO - 'MOZ_NO_REMOTE': '1', 08:33:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:03 INFO - 'NO_EM_RESTART': '1', 08:33:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:03 INFO - 'PWD': '/builds/slave/test', 08:33:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:03 INFO - 'SHELL': '/bin/bash', 08:33:03 INFO - 'SHLVL': '1', 08:33:03 INFO - 'TERM': 'linux', 08:33:03 INFO - 'TMOUT': '86400', 08:33:03 INFO - 'USER': 'cltbld', 08:33:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475', 08:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:03 INFO - '_': '/tools/buildbot/bin/python'} 08:33:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 08:33:04 INFO - mozversion application_buildid: 20160422065716 08:33:04 INFO - mozversion application_changeset: fc15477ce628599519cb0055f52cc195d640dc94 08:33:04 INFO - mozversion application_display_name: Nightly 08:33:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:04 INFO - mozversion application_name: Firefox 08:33:04 INFO - mozversion application_remotingname: firefox 08:33:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:33:04 INFO - mozversion application_vendor: Mozilla 08:33:04 INFO - mozversion application_version: 48.0a1 08:33:04 INFO - mozversion platform_buildid: 20160422065716 08:33:04 INFO - mozversion platform_changeset: fc15477ce628599519cb0055f52cc195d640dc94 08:33:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:33:04 INFO - mozversion platform_version: 48.0a1 08:33:04 INFO - using testdate: 1461339184 08:33:04 INFO - actual date: 1461339184 08:33:04 INFO - starting webserver on 'localhost:34030' 08:33:04 INFO - SUITE-START | Running 2 tests 08:33:04 INFO - TEST-START | dromaeo_css 08:33:04 INFO - operating with platform_type : linux_ 08:33:04 INFO - Initialising browser for dromaeo_css test... 08:33:04 INFO - TEST-INFO | started process 2186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZmnuUu/profile http://localhost:34030/getInfo.html) 08:33:08 INFO - PROCESS | 2186 | __metrics Screen width/height:1600/1200 08:33:08 INFO - PROCESS | 2186 | colorDepth:24 08:33:08 INFO - PROCESS | 2186 | Browser inner width/height: 1024/697 08:33:08 INFO - PROCESS | 2186 | __metrics 08:33:09 ERROR - PROCESS | 2186 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:33:10 INFO - TEST-INFO | 2186: exit 0 08:33:10 INFO - Browser initialized. 08:33:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:10 INFO - TEST-INFO | started process 2269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZmnuUu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:22 INFO - PROCESS | 2269 | RSS: Main: 155500544 08:33:22 INFO - PROCESS | 2269 | 08:34:13 INFO - PROCESS | 2269 | 1461339253570 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] 08:36:24 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34030/tests/dromaeo/cssquery-ext.html) 08:36:26 INFO - PROCESS | 2269 | RSS: Main: 231317504 08:36:26 INFO - PROCESS | 2269 | 08:39:28 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-ext.html (next: http://localhost:34030/tests/dromaeo/cssquery-jquery.html) 08:39:29 INFO - PROCESS | 2269 | RSS: Main: 240062464 08:39:29 INFO - PROCESS | 2269 | 08:42:31 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34030/tests/dromaeo/cssquery-mootools.html) 08:42:31 INFO - PROCESS | 2269 | RSS: Main: 240717824 08:42:31 INFO - PROCESS | 2269 | 08:45:34 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34030/tests/dromaeo/cssquery-prototype.html) 08:45:34 INFO - PROCESS | 2269 | RSS: Main: 236457984 08:45:34 INFO - PROCESS | 2269 | 08:48:37 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34030/tests/dromaeo/cssquery-yui.html) 08:48:38 INFO - PROCESS | 2269 | RSS: Main: 219992064 08:48:38 INFO - PROCESS | 2269 | 08:51:40 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-yui.html (next: http://localhost:34030/tests/dromaeo/cssquery-dojo.html) 08:51:41 INFO - PROCESS | 2269 | RSS: Main: 267354112 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | __start_tp_report 08:51:41 INFO - PROCESS | 2269 | _x_x_mozilla_page_load 08:51:41 INFO - PROCESS | 2269 | _x_x_mozilla_page_load_details 08:51:41 INFO - PROCESS | 2269 | |i|pagename|runs| 08:51:41 INFO - PROCESS | 2269 | |0;dojo.html;2608.0480624572033;2641.9207423777293;2652.1645681610303;2661.4677064587086;2681.5709486482165;4577.267637178053;4585.105904348649;4586.8394606188795;4617.2150734375155;4708.43498780146;4666.393368862043;4717.599004084648;4730.645201609876;4748.3827102476625;4776.880577985544;4225.598568136023;4278.614924656773;4283;4307.913841723163;4448.844290449835;4356.586124318184;4380.780960951955;4404.163208990298;4412.624926881203;4450.844220452284;4245.363195520681;4287.292596721569;4324.935125973113;4335.674824388184;4404.559544045602;4248.787560621957;4272.359146128075;4273.551277115889;4275.080857615628;4310.892227694333;4259.041715613993;4266.765327906964;4273.145370925796;4298.935515967263;4329.675274354405;4469.039156581318;4539.251023581105;4598.218302888484;4693.507181745902;4697.483276839579;5034.546890779848;5057.443681195065;5059.06407314648;5072.213806859942;5098.235264710286;5054.69671819692;5099.566536844335;5101.744912754348;5106.9489305106845;5117.257997590365;4612.515685852971;4723.480417154145;4765.976170119127;4812.278158276286;4819.060283244734;5111.233315002705;5122.948770512322;5137.8715532112;5143.639945203875;5198.610104242197;4863.756812159378;4916.139675556763;4929.7781599828095;4934.1611925972675;4975.875603109951;4952.777125029383;4972.627052971042;4997.550220480174;5038.974805126024;5039.370078740158;4983.302337672729;4983.950160498421;4998.050370429607;4998.650094493423;5042.823501177441;4867.732274724854;4987.301777751118;4991.101601711654;5035.471275516092;5037.269595908573;4283.464566929134;4292.077203401222;4306.720063195945;4329.1341731653165;4330.935035974463;3702.796346200931;3703.277860817169;3710.350688629479;3747.700183985329;3762.3227818992846;4242.257604919127;4267.658587313008;4279.058607106432;4309.59058889405;4323.135372925428;4932.8520144395725;4945.480724523945;4946.208606622923;4974.0797952378925;4999.900002000012;4246.4691913510815;4252.468441444819;4257.481986426272;4277.465316835395;4291.785410729513;4474.753888536096;4499.4150760400935;4514.932276015862;4562.703424277412;4579.473360563577;4762.452317983476;4782.545658162469;4785.59322457588;4788.497207793132;4836.613070954386;5019.372578427697;5033.018561380496;5037.093323201859;5038.319826823478;5070.518300761421;4640.791164397543;4717.78769955346;4747.83382581608;4793.592544633606;4821.445533763662;4809.78355973975;4841.95158048415;4842.782074806712;4883.145449546244;4899.632527560376;4896.36347274852;4924;4926.704397736147;4950.2079667253065;4983.975080124576;4803.519648035308;4819.783109760139;4944.53026962438;5038.420581633012;5042.09242336383;4911.8280860169725;4912.38595175603;4927.1377508935075;4928.359313289393;4977.452480227244;4832.057748739103;4855.077535268288;4856.1987272099705;4857.562819346276;4901.240307752304;4731.219348807546;4917.065757506062;4953.678010929278;4980.078685443204;4994.275830004702;4826.758662066953;4860.73265970375;4867.294242334912;4871.975640121776;4922.310876477368 08:51:41 INFO - PROCESS | 2269 | |1;ext.html;572.8739677270999;600.6036016229289;607.0651197156379;608.3490664988459;630.8359826445125;34107;35044;35067.473987890204;35149.824250878744;35191.712538684966;36923.63076369235;37627.811860940725;37635.81182094086;37759.81120094402;37868;7601.201873803254;7796.649150788228;7805.102413222467;7806.453548251625;7810.140884502728;7595.126560445537;7718;7730.806729831743;7734.806629834271;7736.226377362247;7827.882581761278;7945.642446089911;7964;7967.123616402191;7968.362530997535;7868.213178682115;7915.564643944581;7919.168487308865;7929.326007289387;7931.246531579491;7847.450678452511;7923.445358824884;7934.801629959239;7945.245201705829;7946;39030;39373.40939885904;39520.60479395198;39543.40684889729;39641.40537891934;3268.2646404559023;3420.96579034209;3487.808170550619;3601.711863050976;3801.5628202756484;25895.35261618456;25979.480410391687;26284.342891427677;26884.73115268842;27231.319217019536;3468.5664291963503;3478.4260597001467;3513.5608048993877;3517.472379143149;3537.7523573349877;218127;220118.89940550356;220320;220356;220510;51348.48651513437;51704.74147629313;51785.48214517882;51868.481315186364;51870.22194667008;55620.721896390256;56911.430885690614;59292.40707592955;61054.69472652608;61187.69406152941;14362.85637143636;14573.635659108395;14620;14624;14630.487932922297;11138.387388693538;11251.549938002552;11263.267887587444;11276.436178191057;11276.492557834918;18033;18102.366417175337;18152.727709084375;18171.454856354332;18179.272829086953;6795.510287675258;7163.606001669854;7166.283371662897;7196.280371962866;7236.240194779578;840.7057529864621;893.4728510179026;909.7179874239007;937.1471960515897;974.5760594141572;27394;27748.583771243448;27982.095934618206;28434.431311373657;28465.430691386056;969.9888040107463;986.5560497775886;990.9950450247846;994.3685759542742;1122.5341483284346;14590.978631495693;14971.775423368657;15156.469523566622;15406.138756814707;15444.613884652974;361415;365351;369676;370144;370864;49110;50005.49994500008;50020;50065.24902126471;50074.99999999927;1117.1118960426481;1138.2885696439726;1267.9936600317124;1268.6447794617523;1290.0711487729009;24901.50196996086;25683.229503114937;25881.870590646926;25989.090381836544;28236.43527129487;42226.577734222265;43011.3548296782;43404.565954340054;43424;43440.34839477347;249244;254250;254969;255130;255435;32808.50787238146;37381.25237495289;38355.808220958716;39304;39331.410028850165;39498;40764;40936.59063409328;41493.585064148974;41862.79068604759;33995.66004339925;34300.91291783652;34593.48109778405;35061.649383505835;35517.46723799093;34245.315093697485;34441;34732.65267347294;34798.30403391969;35285.823570881985;34761.82619086889;35007.299854003286;35167.47248791321;35275;37141;26076;26434.603480948186;28729.42541149207;28985.275368115967;29433.264168395104;22403.887980559994;22468;22599.661005084607;22623.886880565493;22652.320430387113 08:51:41 INFO - PROCESS | 2269 | |2;jquery.html;384.1184481614694;388.41931312687535;393.53810432695144;393.6752179451952;398.4939127308318;12684.556040538582;12988.220706757602;15655.21723913804;16462.341506339748;16493.092879891603;10693.465326733653;15999.280032398541;16273.593160171002;16289.185540722976;16306.673866522662;4608.562186592277;4793.640476964224;4806.83176088837;4815.614750819944;4818.397700287464;3520.260745243502;4735.73953432561;4780.856574302777;4782.139214941327;6581.7696380626685;6911.654417279141;6955.130608673916;6961.825954351131;6961.895571566431;6967.721291148348;6740.629265390402;6809.829754256159;6847.1783385994;6873.312668733137;6890.965545172267;6478.319776423455;6539.705713242915;6734.124563806723;6736.2590115087305;6817.659117044128;23354.76645233543;23359.76640233593;23829.663847061252;23957.40106497334;23996.760032399627;2038.6840039793856;2087.0608226298073;2209.834262430324;2252.4706693926914;2740.3560163361594;13522.864771352259;14463.566093017227;14483.565493035227;14651.487197948127;15281.61795955099;1900.249401486419;1927.951801204967;2011.4870707969374;2080.167932826866;2230.7657695941853;79677;82998.58500707518;85537.57231213867;86109;86504.13495865087;16613.584660383345;16752.162391880356;16869.493915182564;17018.744718829228;17048.914755426144;31057.844710776753;31183.84408077945;31359.21601959969;31400.37199256048;31448.37103257922;8177.304929081095;8595.914040859636;8658.610362533702;8759.34304927133;8880;7062.611556364449;7089.699553871033;7190.7483238086415;7202.20775714671;7214.71141154348;8346.415750897379;8564.229219370287;8573.871391929126;8660.956695216484;8666.393352465268;3242.789218700777;3406.6933975942284;3480.564929383827;3489.2149266415363;3538.168530395355;896.1979028769215;897.7037577599376;952.3857112162616;999.93000489965;1017.4759998600726;16446.34214631425;16890.493285201464;16915.407960721317;17049.659006819795;17230.396936107176;881.3786280672239;888.320434867327;931.9906800931903;940.238406890421;946.2146418472789;9253.72238832836;9473.857892131624;9708;9729.70810875675;9755.219582433388;377082;378577;394338;406418;410216;78423.60788196023;81229;81377.59311203405;81427;83985;917.1653795046476;931.5295775633398;932.8973812880713;939.3189937295406;950.8763860698065;14939.477118300807;15123.31945062497;15212.619684507534;15242.695146096794;15431.459898903484;33706.325873482885;34070.65929340675;36309;36409;36591.08522286964;48075;48234.758826205645;48236.27645585249;49094;49552.256716148564;7794.883076753967;7918.168592297726;7960.124386317385;8133.2680058794995;8228.177182281963;11388;11860.94069529647;11924.76150477003;12184.086193535697;12189.51241950312;10072.496375181065;10238.12975897057;10505.579776809147;10607.045365917105;10640.52117654692;10028;10293.53679084428;10337.896621033693;10371.533281002223;10636.734081648021;8539.018012928593;10021.549030293509;10550.736231594272;10846.18653600999;10948.233623646269;7981.122076571689;8019.518828870287;8049.436539442183;8073.717419890276;8259.83480330402;8201.056878459054;9744.658936937172;10681.89318106809;10708.411037393018;10764.08505277029 08:51:41 INFO - PROCESS | 2269 | |3;mootools.html;1240.6030070377483;1315.2700251360493;1350.3450826349222;1490.8732757715593;1785.4911350265186;6521.250056243527;7590.1650818409935;7742.187070357616;7747.573883436416;7762.3402010829;7501.549907005584;7624.351930085935;7643.770686879402;7646.044244469442;7648.923510764891;1829.4694538583794;2097.769245383007;2151.709519214902;2226.1651880544796;2257.1874125314876;2255.751867294596;2272.6136556785304;2279.794818466338;2286.131270117353;2288.4622113803243;2129.595376878396;2139.7539282982502;2154.827613790893;2163.718716566852;2165.296278709418;1884.2274667386375;2110.482931681732;2150.612889679857;2170.7178066851366;2174.510735084609;2205.856619319739;2224.165937773335;2227.3429338345063;2227.6769868368997;2232.2745107839855;7499.925000750031;7541.170471248159;7549.169591344948;7553.093628764584;7554.735584254579;4297.119090586422;4410.294352903552;4416.646668266531;4417.624501917341;4430.224710675619;2745.68424631166;2789.316617428743;2896.5075937090746;2909.5344744840936;2916.9270768230754;928.2295694573488;928.4104593583056;936.8782058332373;956.0582825916466;978.5694294510392;9694.466804325759;9754.414735115915;9769.90230097697;9787.46168960714;9793.510324483746;4058.553559108496;4119.752814831119;4269.893252668646;4294.677899157513;4311.051568654953;8452.74641760748;8464.280536154496;8488.448250863674;8497.830043399097;8501.022382425976;4497.2129877271345;4509.098180363941;4516.81932722694;4524.298733696282;4548.749818759934;3763.284975854579;4191.580841915784;4257.63810076147;4304.569543045671;4304.612584867315;3552.325058238978;3615.060084378081;3666.1934374438115;3697.9815100924325;3739.9813000934823;1217.3122185965078;1241.0878004666563;1245.9127861049822;1253.5549879792725;1258.087886282456;737.5943231222806;783.2950344689825;836.610975896199;839.4879123734516;845.6110189312861;5223.190405487156;5354.892902142014;5424.267723857229;5589.105743081169;5669.43305669438;915.8946721127155;923.3444254579324;926.5922993882805;948.3882895532342;953.142172045151;3555.182308069107;3718.9070273242846;3726.6459686329754;3744.1575645479547;3786.3373909565717;9349;9667.854982175273;9696.854547181798;9716.708498745049;9759.170470510086;9648.276379271583;9670.468124253233;9685.079917407835;9698.127168554864;9701.369410988264;7014.123234595676;7418.146913104954;7442.18136005039;7461.253874612604;7461.888071678821;5087.160618498055;5215.5827533797965;5316.468353164652;5353.4646535346155;5489.505944465017;8810.074942130985;8845.69040083594;8881.200691937756;8988.640454381752;9009.189172974202;8279.751607451786;8698.956505217433;8701.303895688203;8709.695160669346;8986.236169925629;5871.794487192928;6504.38208370204;6585.835354115994;6660.600363978177;6844.2129155147795;7359.558426494427;7387.482876198615;7426.331630153312;7446.590437525988;7449.813754656177;6386.680665966776;6653.234877989094;6673.733050677918;6778.389944904982;6832.487563432663;6646.966765166143;6713.462922966249;6729.52893297484;6737.090492783412;6848.760293389708;6394.136791533269;6428.4214420702365;6477.805665830033;6483.578567393104;6484.578502397329;4572.45130584332;4593.28804035375;4623.144718227139;4661.114388266218;4758.095961767253;4446.488653804854;4450.443694538183;4598.218302888584;4605;4694.953050469451 08:51:41 INFO - PROCESS | 2269 | |4;prototype.html;313.40609544912377;326.33427807273165;328.59254524389763;330.80978437398494;333.6863348452453;4997.701057513544;5027.170516864722;5039.4204666463365;5054.974725126373;5069.594432445405;4698.177818881699;4889.731064791435;4894;4910.288008238803;5003.974980125095;3845.0198147953824;3875.786831724261;3885.30064588374;3976.761394316336;3987.3620220764683;3962.960370396288;3974.0462289050565;3981.581933896928;3988.3419235826054;3990.421388898608;3851.114243723945;3930.8231129599094;3949.1904159647347;3950.8419663213435;3974.9801250993705;3923.391874259494;3960.1881614269005;3964.108075682977;3975.085730282037;3977.303971804937;3535.1869070114017;3541.29174165168;3543.6102028776813;3546.6453354664586;3551.5738111426535;4830.5652491275605;4844;4853.466118726938;4864.246041863516;4873.439554451248;4412.602865742098;4565.132624801277;4578.78662154526;4578.931316030262;4593.990935936967;5250.868728281824;5252.264682944353;5293.073712100367;5301.973490132525;5317.255584218213;3891.6692081173132;3900.5124359455067;3902.941455878164;3916.020994751312;3920.353141731611;5358.383785864637;5521.116621340566;5529.861753456195;5538.6399884007415;5543.334799824007;3978.741381810173;3985.8405663773124;4002.999250187453;4005.178938317638;4006.6794656427414;4053.8175782089875;4060.939085913714;4065.4714887064492;4066.1461093170765;4088.2028004539425;4225.894352641209;4504.256797628354;4544.341070544752;4581.358609794632;4581.381513495702;5270.631055826132;5280.260763493114;5289.153735402318;5300.522952934254;5301.787928482895;1287.1955028107434;1354.0927578522414;1373.505538006317;1374.780035194384;1380.9792853107213;901.7655409593552;934.8457504511815;936.3024546712743;943.0710749911332;943.2171297822928;4605.6776025678555;4612.169809434334;4620.399348084795;4641.930371044437;4656.371389862393;5381.596380271495;5382.03123437785;5385.515303622693;5393.191021346829;5402.432744561843;4489.753063581535;4633.328167415706;4682.204025315705;4696.295555666609;4702.36518070063;2873.8994135205166;2899.3476467794576;2910.2287893708185;2918.6351706036744;2919.620449341572;5127.392791553007;5184.403793563789;5195.6622819516615;5218.765155568009;5233.345831771028;5464.644798088191;5612.971935140298;5664.348599911063;5674.177244299636;5675.404082571353;5204;5208.817691380784;5212.322398088224;5213.40045894727;5231.424543300234;5233.084210263265;5447.809326673548;5451.863703407446;5454.481824226692;5474.945250547444;5342.412334643263;5367.812126575551;5374.516293533445;5385.3268341457315;5396.865078373072;5168.664036837594;5179.792808287777;5184.403793563789;5192.766325515437;5194.142966410651;3669.5779985302033;3861.4400911868183;3888.747231429948;3898.142408670088;3902.551206611276;5473.945260547503;5491.862703432446;5495.6153069286365;5497.422770609189;5501.422350653123;5337.386200586982;5340.9465905342;5355.758990845344;5361.061814182581;5364.275822763877;4998.700077995332;5258.132408152765;5295.443978382368;5331.253624492651;5343.3587969443915;4960.553550180501;5032.924506132485;5196.350456192976;5217.478252174904;5234.97382513085;5327.786888524571;5338.318429694634;5351.464853514617;5356.7589458473685;5365.9463405367005;5231.163013917755;5235.921461178009;5246.422893481637;5248.947510524846;5249.895002100013 08:51:41 INFO - PROCESS | 2269 | |5;yui.html;698.1447726534996;733.5928559649395;744.6993611891327;745.6458182363378;755.8450517643884;11154.330740155596;13885.514007009744;14008.509702160427;14223.715525689493;14226.075305105162;14149.221792801392;14172.078814877026;14226.573202803933;14244.14535127893;14250.928745356285;648.3030741952397;811.2860682599334;812.2608426332039;814.1654803826067;814.9185081491847;656.2551504042898;659.6240143118424;660.4617236951893;792.3265224559136;823.3742355809568;858.7037472072157;861.530465896085;862.3187681731424;862.482510493705;863.0592654007131;859.1022381611232;859.7721603775004;859.8710193470936;860.0109873645326;860.371928492198;495.3065708008817;607.9726412311456;628.707650942314;630.6468377708497;634.3846468925135;12669.303188324639;12800.295983720891;12817.03872209588;12828.422720977578;12850.421731022127;11833.290002599872;12064.155509114365;12182.939085304517;12312.384380781015;12562.246265224025;8655.413996858573;8765.430247033986;8860.778480537974;8939.865902011476;9055.818883622356;3273.836308184605;3277.8197199154038;3327.38443387974;3329.6836800503916;3394.932101357959;41933.999999999694;42337.364939525934;42674;42828.143437131395;42936.57063429357;9801.656942006995;9834.430480749992;9861.457619830835;10024.147947424404;10032.899671003343;16970.490885273462;16995.235214415134;17001.659966800595;17002.23489942931;17029.318827247018;6655.101561289261;6662.267150613428;6763.628000459924;6936.375726184668;6997.685104170325;3868.497095377583;4019.618136277049;4027.7986100694848;4059.6143366380147;4067.633912947849;2772.8336299822076;2831.9858400707863;2835.8014938954075;2840.304125489227;2843.402885394049;528.6273177409917;534.5349545895097;541.5775694957939;541.8103663717667;543.2828666160709;529.7430746088221;561.7163332517134;583.6643929740417;588.7703795519665;625.0218408191166;7785.086628120974;7943.960280198562;8025.03699556057;8051.59742012897;8251.669933202726;574.1875246526118;586.2291087220292;606.1507936507936;615.8398816307792;624.5784095735361;3689.4834723138783;3703.388940824788;3761.435784632327;3829.3298672732717;3843;41954.790226049285;44839.77580112144;45654.77172614182;45807.77096114498;46925.5307446928;40044;40206;40632;41264.58735412668;42067;37642.16546435307;37710;38141.427878581846;38223.61776382256;38437.423438648446;8014.479058861155;8029.4379393441895;8160.102388737353;8360.45657032291;8484.575771211292;25023.624645630694;25376.74623253744;25515.10697125592;26439.471210575295;28092;34004.82997584996;34140;34462;34836.129096772784;35073;10665.733356666145;10804.891951080388;10813.56745730162;10818.837717434402;10900.727481813017;11981.940090299493;12038.277703337828;12043.518259269531;12083.275003499819;12684.302363370103;11075.889241107487;11156.665300041012;11365.602203922823;11605.419729013684;11649.068074554185;11438;11452.713682158013;11659.53361865516;11697.005754510961;12165.452554634885;10411.84382234252;10761.04114691494;10849.511771970123;10928.781424371628;11031.338119712844;9791.657291994747;9815.116639502194;9818.214542836698;9843.60625574969;9907.405555666683;9315.284636471304;9320.72037838866;9510.667126650535;9596.136347728738;9669.564869580745 08:51:41 INFO - PROCESS | 2269 | __end_tp_report 08:51:41 INFO - PROCESS | 2269 | __start_cc_report 08:51:41 INFO - PROCESS | 2269 | _x_x_mozilla_cycle_collect,1075 08:51:41 INFO - PROCESS | 2269 | __end_cc_report 08:51:41 INFO - PROCESS | 2269 | __startTimestamp1461340301085__endTimestamp 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | ------- Summary: start ------- 08:51:41 INFO - PROCESS | 2269 | Number of tests: 6 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | [#0] dojo.html Cycles:165 Average:4638.92 Median:4803.52 stddev:484.04 (10.1%) stddev-sans-first:458.56 08:51:41 INFO - PROCESS | 2269 | Values: 2608.0 2641.9 2652.2 2661.5 2681.6 4577.3 4585.1 4586.8 4617.2 4708.4 4666.4 4717.6 4730.6 4748.4 4776.9 4225.6 4278.6 4283.0 4307.9 4448.8 4356.6 4380.8 4404.2 4412.6 4450.8 4245.4 4287.3 4324.9 4335.7 4404.6 4248.8 4272.4 4273.6 4275.1 4310.9 4259.0 4266.8 4273.1 4298.9 4329.7 4469.0 4539.3 4598.2 4693.5 4697.5 5034.5 5057.4 5059.1 5072.2 5098.2 5054.7 5099.6 5101.7 5106.9 5117.3 4612.5 4723.5 4766.0 4812.3 4819.1 5111.2 5122.9 5137.9 5143.6 5198.6 4863.8 4916.1 4929.8 4934.2 4975.9 4952.8 4972.6 4997.6 5039.0 5039.4 4983.3 4984.0 4998.1 4998.7 5042.8 4867.7 4987.3 4991.1 5035.5 5037.3 4283.5 4292.1 4306.7 4329.1 4330.9 3702.8 3703.3 3710.4 3747.7 3762.3 4242.3 4267.7 4279.1 4309.6 4323.1 4932.9 4945.5 4946.2 4974.1 4999.9 4246.5 4252.5 4257.5 4277.5 4291.8 4474.8 4499.4 4514.9 4562.7 4579.5 4762.5 4782.5 4785.6 4788.5 4836.6 5019.4 5033.0 5037.1 5038.3 5070.5 4640.8 4717.8 4747.8 4793.6 4821.4 4809.8 4842.0 4842.8 4883.1 4899.6 4896.4 4924.0 4926.7 4950.2 4984.0 4803.5 4819.8 4944.5 5038.4 5042.1 4911.8 4912.4 4927.1 4928.4 4977.5 4832.1 4855.1 4856.2 4857.6 4901.2 4731.2 4917.1 4953.7 4980.1 4994.3 4826.8 4860.7 4867.3 4872.0 4922.3 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | [#1] ext.html Cycles:180 Average:44083.61 Median:363383.00 stddev:75493.06 (20.8%) stddev-sans-first:75634.15 08:51:41 INFO - PROCESS | 2269 | Values: 572.9 600.6 607.1 608.3 630.8 34107.0 35044.0 35067.5 35149.8 35191.7 36923.6 37627.8 37635.8 37759.8 37868.0 7601.2 7796.6 7805.1 7806.5 7810.1 7595.1 7718.0 7730.8 7734.8 7736.2 7827.9 7945.6 7964.0 7967.1 7968.4 7868.2 7915.6 7919.2 7929.3 7931.2 7847.5 7923.4 7934.8 7945.2 7946.0 39030.0 39373.4 39520.6 39543.4 39641.4 3268.3 3421.0 3487.8 3601.7 3801.6 25895.4 25979.5 26284.3 26884.7 27231.3 3468.6 3478.4 3513.6 3517.5 3537.8 218127.0 220118.9 220320.0 220356.0 220510.0 51348.5 51704.7 51785.5 51868.5 51870.2 55620.7 56911.4 59292.4 61054.7 61187.7 14362.9 14573.6 14620.0 14624.0 14630.5 11138.4 11251.5 11263.3 11276.4 11276.5 18033.0 18102.4 18152.7 18171.5 18179.3 6795.5 7163.6 7166.3 7196.3 7236.2 840.7 893.5 909.7 937.1 974.6 27394.0 27748.6 27982.1 28434.4 28465.4 970.0 986.6 991.0 994.4 1122.5 14591.0 14971.8 15156.5 15406.1 15444.6 361415.0 365351.0 369676.0 370144.0 370864.0 49110.0 50005.5 50020.0 50065.2 50075.0 1117.1 1138.3 1268.0 1268.6 1290.1 24901.5 25683.2 25881.9 25989.1 28236.4 42226.6 43011.4 43404.6 43424.0 43440.3 249244.0 254250.0 254969.0 255130.0 255435.0 32808.5 37381.3 38355.8 39304.0 39331.4 39498.0 40764.0 40936.6 41493.6 41862.8 33995.7 34300.9 34593.5 35061.6 35517.5 34245.3 34441.0 34732.7 34798.3 35285.8 34761.8 35007.3 35167.5 35275.0 37141.0 26076.0 26434.6 28729.4 28985.3 29433.3 22403.9 22468.0 22599.7 22623.9 22652.3 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | [#2] jquery.html Cycles:180 Average:25975.08 Median:197368.25 stddev:65187.66 (33.0%) stddev-sans-first:65342.21 08:51:41 INFO - PROCESS | 2269 | Values: 384.1 388.4 393.5 393.7 398.5 12684.6 12988.2 15655.2 16462.3 16493.1 10693.5 15999.3 16273.6 16289.2 16306.7 4608.6 4793.6 4806.8 4815.6 4818.4 3520.3 4735.7 4780.9 4782.1 6581.8 6911.7 6955.1 6961.8 6961.9 6967.7 6740.6 6809.8 6847.2 6873.3 6891.0 6478.3 6539.7 6734.1 6736.3 6817.7 23354.8 23359.8 23829.7 23957.4 23996.8 2038.7 2087.1 2209.8 2252.5 2740.4 13522.9 14463.6 14483.6 14651.5 15281.6 1900.2 1928.0 2011.5 2080.2 2230.8 79677.0 82998.6 85537.6 86109.0 86504.1 16613.6 16752.2 16869.5 17018.7 17048.9 31057.8 31183.8 31359.2 31400.4 31448.4 8177.3 8595.9 8658.6 8759.3 8880.0 7062.6 7089.7 7190.7 7202.2 7214.7 8346.4 8564.2 8573.9 8661.0 8666.4 3242.8 3406.7 3480.6 3489.2 3538.2 896.2 897.7 952.4 999.9 1017.5 16446.3 16890.5 16915.4 17049.7 17230.4 881.4 888.3 932.0 940.2 946.2 9253.7 9473.9 9708.0 9729.7 9755.2 377082.0 378577.0 394338.0 406418.0 410216.0 78423.6 81229.0 81377.6 81427.0 83985.0 917.2 931.5 932.9 939.3 950.9 14939.5 15123.3 15212.6 15242.7 15431.5 33706.3 34070.7 36309.0 36409.0 36591.1 48075.0 48234.8 48236.3 49094.0 49552.3 7794.9 7918.2 7960.1 8133.3 8228.2 11388.0 11860.9 11924.8 12184.1 12189.5 10072.5 10238.1 10505.6 10607.0 10640.5 10028.0 10293.5 10337.9 10371.5 10636.7 8539.0 10021.5 10550.7 10846.2 10948.2 7981.1 8019.5 8049.4 8073.7 8259.8 8201.1 9744.7 10681.9 10708.4 10764.1 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | [#3] mootools.html Cycles:180 Average:5071.17 Median:6129.24 stddev:2778.47 (45.3%) stddev-sans-first:2771.35 08:51:41 INFO - PROCESS | 2269 | Values: 1240.6 1315.3 1350.3 1490.9 1785.5 6521.3 7590.2 7742.2 7747.6 7762.3 7501.5 7624.4 7643.8 7646.0 7648.9 1829.5 2097.8 2151.7 2226.2 2257.2 2255.8 2272.6 2279.8 2286.1 2288.5 2129.6 2139.8 2154.8 2163.7 2165.3 1884.2 2110.5 2150.6 2170.7 2174.5 2205.9 2224.2 2227.3 2227.7 2232.3 7499.9 7541.2 7549.2 7553.1 7554.7 4297.1 4410.3 4416.6 4417.6 4430.2 2745.7 2789.3 2896.5 2909.5 2916.9 928.2 928.4 936.9 956.1 978.6 9694.5 9754.4 9769.9 9787.5 9793.5 4058.6 4119.8 4269.9 4294.7 4311.1 8452.7 8464.3 8488.4 8497.8 8501.0 4497.2 4509.1 4516.8 4524.3 4548.7 3763.3 4191.6 4257.6 4304.6 4304.6 3552.3 3615.1 3666.2 3698.0 3740.0 1217.3 1241.1 1245.9 1253.6 1258.1 737.6 783.3 836.6 839.5 845.6 5223.2 5354.9 5424.3 5589.1 5669.4 915.9 923.3 926.6 948.4 953.1 3555.2 3718.9 3726.6 3744.2 3786.3 9349.0 9667.9 9696.9 9716.7 9759.2 9648.3 9670.5 9685.1 9698.1 9701.4 7014.1 7418.1 7442.2 7461.3 7461.9 5087.2 5215.6 5316.5 5353.5 5489.5 8810.1 8845.7 8881.2 8988.6 9009.2 8279.8 8699.0 8701.3 8709.7 8986.2 5871.8 6504.4 6585.8 6660.6 6844.2 7359.6 7387.5 7426.3 7446.6 7449.8 6386.7 6653.2 6673.7 6778.4 6832.5 6647.0 6713.5 6729.5 6737.1 6848.8 6394.1 6428.4 6477.8 6483.6 6484.6 4572.5 4593.3 4623.1 4661.1 4758.1 4446.5 4450.4 4598.2 4605.0 4695.0 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | [#4] prototype.html Cycles:180 Average:4416.42 Median:4998.20 stddev:1269.17 (25.4%) stddev-sans-first:1234.80 08:51:41 INFO - PROCESS | 2269 | Values: 313.4 326.3 328.6 330.8 333.7 4997.7 5027.2 5039.4 5055.0 5069.6 4698.2 4889.7 4894.0 4910.3 5004.0 3845.0 3875.8 3885.3 3976.8 3987.4 3963.0 3974.0 3981.6 3988.3 3990.4 3851.1 3930.8 3949.2 3950.8 3975.0 3923.4 3960.2 3964.1 3975.1 3977.3 3535.2 3541.3 3543.6 3546.6 3551.6 4830.6 4844.0 4853.5 4864.2 4873.4 4412.6 4565.1 4578.8 4578.9 4594.0 5250.9 5252.3 5293.1 5302.0 5317.3 3891.7 3900.5 3902.9 3916.0 3920.4 5358.4 5521.1 5529.9 5538.6 5543.3 3978.7 3985.8 4003.0 4005.2 4006.7 4053.8 4060.9 4065.5 4066.1 4088.2 4225.9 4504.3 4544.3 4581.4 4581.4 5270.6 5280.3 5289.2 5300.5 5301.8 1287.2 1354.1 1373.5 1374.8 1381.0 901.8 934.8 936.3 943.1 943.2 4605.7 4612.2 4620.4 4641.9 4656.4 5381.6 5382.0 5385.5 5393.2 5402.4 4489.8 4633.3 4682.2 4696.3 4702.4 2873.9 2899.3 2910.2 2918.6 2919.6 5127.4 5184.4 5195.7 5218.8 5233.3 5464.6 5613.0 5664.3 5674.2 5675.4 5204.0 5208.8 5212.3 5213.4 5231.4 5233.1 5447.8 5451.9 5454.5 5474.9 5342.4 5367.8 5374.5 5385.3 5396.9 5168.7 5179.8 5184.4 5192.8 5194.1 3669.6 3861.4 3888.7 3898.1 3902.6 5473.9 5491.9 5495.6 5497.4 5501.4 5337.4 5340.9 5355.8 5361.1 5364.3 4998.7 5258.1 5295.4 5331.3 5343.4 4960.6 5032.9 5196.4 5217.5 5235.0 5327.8 5338.3 5351.5 5356.8 5365.9 5231.2 5235.9 5246.4 5248.9 5249.9 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - PROCESS | 2269 | [#5] yui.html Cycles:180 Average:12079.27 Median:41599.29 stddev:12734.02 (30.6%) stddev-sans-first:12741.05 08:51:41 INFO - PROCESS | 2269 | Values: 698.1 733.6 744.7 745.6 755.8 11154.3 13885.5 14008.5 14223.7 14226.1 14149.2 14172.1 14226.6 14244.1 14250.9 648.3 811.3 812.3 814.2 814.9 656.3 659.6 660.5 792.3 823.4 858.7 861.5 862.3 862.5 863.1 859.1 859.8 859.9 860.0 860.4 495.3 608.0 628.7 630.6 634.4 12669.3 12800.3 12817.0 12828.4 12850.4 11833.3 12064.2 12182.9 12312.4 12562.2 8655.4 8765.4 8860.8 8939.9 9055.8 3273.8 3277.8 3327.4 3329.7 3394.9 41934.0 42337.4 42674.0 42828.1 42936.6 9801.7 9834.4 9861.5 10024.1 10032.9 16970.5 16995.2 17001.7 17002.2 17029.3 6655.1 6662.3 6763.6 6936.4 6997.7 3868.5 4019.6 4027.8 4059.6 4067.6 2772.8 2832.0 2835.8 2840.3 2843.4 528.6 534.5 541.6 541.8 543.3 529.7 561.7 583.7 588.8 625.0 7785.1 7944.0 8025.0 8051.6 8251.7 574.2 586.2 606.2 615.8 624.6 3689.5 3703.4 3761.4 3829.3 3843.0 41954.8 44839.8 45654.8 45807.8 46925.5 40044.0 40206.0 40632.0 41264.6 42067.0 37642.2 37710.0 38141.4 38223.6 38437.4 8014.5 8029.4 8160.1 8360.5 8484.6 25023.6 25376.7 25515.1 26439.5 28092.0 34004.8 34140.0 34462.0 34836.1 35073.0 10665.7 10804.9 10813.6 10818.8 10900.7 11981.9 12038.3 12043.5 12083.3 12684.3 11075.9 11156.7 11365.6 11605.4 11649.1 11438.0 11452.7 11659.5 11697.0 12165.5 10411.8 10761.0 10849.5 10928.8 11031.3 9791.7 9815.1 9818.2 9843.6 9907.4 9315.3 9320.7 9510.7 9596.1 9669.6 08:51:41 INFO - PROCESS | 2269 | -------- Summary: end -------- 08:51:41 INFO - PROCESS | 2269 | 08:51:41 INFO - TEST-INFO | 2269: exit 0 08:51:41 INFO - TEST-OK | dromaeo_css | took 1117703ms 08:51:41 INFO - TEST-START | kraken 08:51:41 INFO - operating with platform_type : linux_ 08:51:41 INFO - Initialising browser for kraken test... 08:51:41 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTFEVk/profile http://localhost:34030/getInfo.html) 08:51:45 INFO - PROCESS | 2538 | __metrics Screen width/height:1600/1200 08:51:45 INFO - PROCESS | 2538 | colorDepth:24 08:51:45 INFO - PROCESS | 2538 | Browser inner width/height: 1024/697 08:51:45 INFO - PROCESS | 2538 | __metrics 08:51:46 ERROR - PROCESS | 2538 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:51:47 INFO - TEST-INFO | 2538: exit 0 08:51:47 INFO - Browser initialized. 08:51:47 INFO - Running cycle 1/1 for kraken test... 08:51:47 INFO - TEST-INFO | started process 2619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTFEVk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:59 INFO - PROCESS | 2619 | RSS: Main: 155672576 08:51:59 INFO - PROCESS | 2619 | 08:52:02 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:03 INFO - PROCESS | 2619 | RSS: Main: 210460672 08:52:03 INFO - PROCESS | 2619 | 08:52:06 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-dft) 08:52:06 INFO - PROCESS | 2619 | RSS: Main: 196059136 08:52:06 INFO - PROCESS | 2619 | 08:52:09 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-fft) 08:52:10 INFO - PROCESS | 2619 | RSS: Main: 265961472 08:52:10 INFO - PROCESS | 2619 | 08:52:12 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-oscillator) 08:52:13 INFO - PROCESS | 2619 | RSS: Main: 174333952 08:52:13 INFO - PROCESS | 2619 | 08:52:15 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34030/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:16 INFO - PROCESS | 2619 | RSS: Main: 179191808 08:52:16 INFO - PROCESS | 2619 | 08:52:19 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34030/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:19 INFO - PROCESS | 2619 | RSS: Main: 215191552 08:52:19 INFO - PROCESS | 2619 | 08:52:23 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34030/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:23 INFO - PROCESS | 2619 | RSS: Main: 215826432 08:52:23 INFO - PROCESS | 2619 | 08:52:26 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34030/tests/kraken/driver.html?testName=json-parse-financial) 08:52:27 INFO - PROCESS | 2619 | RSS: Main: 215805952 08:52:27 INFO - PROCESS | 2619 | 08:52:29 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34030/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:29 INFO - PROCESS | 2619 | RSS: Main: 201646080 08:52:29 INFO - PROCESS | 2619 | 08:52:31 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:32 INFO - PROCESS | 2619 | RSS: Main: 206508032 08:52:32 INFO - PROCESS | 2619 | 08:52:34 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:35 INFO - PROCESS | 2619 | RSS: Main: 216600576 08:52:35 INFO - PROCESS | 2619 | 08:52:37 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:38 INFO - PROCESS | 2619 | RSS: Main: 224587776 08:52:38 INFO - PROCESS | 2619 | 08:52:41 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:41 INFO - PROCESS | 2619 | RSS: Main: 220323840 08:52:41 INFO - PROCESS | 2619 | 08:52:43 INFO - PROCESS | 2619 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34030/tests/kraken/driver.html?testName=ai-astar) 08:52:44 INFO - PROCESS | 2619 | RSS: Main: 283213824 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | __start_tp_report 08:52:44 INFO - PROCESS | 2619 | _x_x_mozilla_page_load 08:52:44 INFO - PROCESS | 2619 | _x_x_mozilla_page_load_details 08:52:44 INFO - PROCESS | 2619 | |i|pagename|runs| 08:52:44 INFO - PROCESS | 2619 | |0;ai-astar;112;115;108;112;114;114;104;112;113;113 08:52:44 INFO - PROCESS | 2619 | |1;audio-beat-detection;165;143;155;202;133;153;158;141;183;133 08:52:44 INFO - PROCESS | 2619 | |2;audio-dft;161;160;160;161;162;164;172;162;159;160 08:52:44 INFO - PROCESS | 2619 | |3;audio-fft;73;77;100;117;75;77;77;124;101;75 08:52:44 INFO - PROCESS | 2619 | |4;audio-oscillator;96;96;142;93;95;93;148;94;94;144 08:52:44 INFO - PROCESS | 2619 | |5;imaging-gaussian-blur;118;116;116;116;117;116;117;117;117;116 08:52:44 INFO - PROCESS | 2619 | |6;imaging-darkroom;146;146;146;147;145;146;145;146;146;145 08:52:44 INFO - PROCESS | 2619 | |7;imaging-desaturate;96;95;95;95;95;96;95;94;95;95 08:52:44 INFO - PROCESS | 2619 | |8;json-parse-financial;65;69;66;65;66;67;68;85;64;63 08:52:44 INFO - PROCESS | 2619 | |9;json-stringify-tinderbox;66;66;65;64;65;64;64;65;65;65 08:52:44 INFO - PROCESS | 2619 | |10;stanford-crypto-aes;77;79;78;78;79;82;80;79;79;80 08:52:44 INFO - PROCESS | 2619 | |11;stanford-crypto-ccm;141;139;144;131;132;131;133;137;172;131 08:52:44 INFO - PROCESS | 2619 | |12;stanford-crypto-pbkdf2;177;172;178;172;175;177;180;177;174;174 08:52:44 INFO - PROCESS | 2619 | |13;stanford-crypto-sha256-iterative;73;72;72;74;72;72;71;73;73;70 08:52:44 INFO - PROCESS | 2619 | __end_tp_report 08:52:44 INFO - PROCESS | 2619 | __start_cc_report 08:52:44 INFO - PROCESS | 2619 | _x_x_mozilla_cycle_collect,1939 08:52:44 INFO - PROCESS | 2619 | __end_cc_report 08:52:44 INFO - PROCESS | 2619 | __startTimestamp1461340364063__endTimestamp 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | ------- Summary: start ------- 08:52:44 INFO - PROCESS | 2619 | Number of tests: 14 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.30 (2.9%) stddev-sans-first:3.50 08:52:44 INFO - PROCESS | 2619 | Values: 112.0 115.0 108.0 112.0 114.0 114.0 104.0 112.0 113.0 113.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:156.50 stddev:22.08 (14.1%) stddev-sans-first:23.21 08:52:44 INFO - PROCESS | 2619 | Values: 165.0 143.0 155.0 202.0 133.0 153.0 158.0 141.0 183.0 133.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#2] audio-dft Cycles:10 Average:162.10 Median:161.50 stddev:3.75 (2.3%) stddev-sans-first:3.96 08:52:44 INFO - PROCESS | 2619 | Values: 161.0 160.0 160.0 161.0 162.0 164.0 172.0 162.0 159.0 160.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#3] audio-fft Cycles:10 Average:89.60 Median:75.00 stddev:19.29 (25.7%) stddev-sans-first:19.51 08:52:44 INFO - PROCESS | 2619 | Values: 73.0 77.0 100.0 117.0 75.0 77.0 77.0 124.0 101.0 75.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:94.00 stddev:24.33 (25.9%) stddev-sans-first:25.31 08:52:44 INFO - PROCESS | 2619 | Values: 96.0 96.0 142.0 93.0 95.0 93.0 148.0 94.0 94.0 144.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 08:52:44 INFO - PROCESS | 2619 | Values: 118.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:52:44 INFO - PROCESS | 2619 | Values: 146.0 146.0 146.0 147.0 145.0 146.0 145.0 146.0 146.0 145.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:52:44 INFO - PROCESS | 2619 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:66.50 stddev:6.30 (9.5%) stddev-sans-first:6.60 08:52:44 INFO - PROCESS | 2619 | Values: 65.0 69.0 66.0 65.0 66.0 67.0 68.0 85.0 64.0 63.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 08:52:44 INFO - PROCESS | 2619 | Values: 66.0 66.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.37 (1.7%) stddev-sans-first:1.22 08:52:44 INFO - PROCESS | 2619 | Values: 77.0 79.0 78.0 78.0 79.0 82.0 80.0 79.0 79.0 80.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:138.00 stddev:12.47 (9.0%) stddev-sans-first:13.20 08:52:44 INFO - PROCESS | 2619 | Values: 141.0 139.0 144.0 131.0 132.0 131.0 133.0 137.0 172.0 131.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:177.00 stddev:2.63 (1.5%) stddev-sans-first:2.74 08:52:44 INFO - PROCESS | 2619 | Values: 177.0 172.0 178.0 172.0 175.0 177.0 180.0 177.0 174.0 174.0 08:52:44 INFO - PROCESS | 2619 | 08:52:44 INFO - PROCESS | 2619 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.50 stddev:1.14 (1.6%) stddev-sans-first:1.17 08:52:44 INFO - PROCESS | 2619 | Values: 73.0 72.0 72.0 74.0 72.0 72.0 71.0 73.0 73.0 70.0 08:52:44 INFO - PROCESS | 2619 | -------- Summary: end -------- 08:52:44 INFO - PROCESS | 2619 | 08:52:45 INFO - TEST-INFO | 2619: exit 0 08:52:45 INFO - TEST-OK | kraken | took 63273ms 08:52:45 INFO - SUITE-END | took 1180s 08:52:45 INFO - Completed test suite (00:19:41) 08:52:45 INFO - javascript benchmark 08:52:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.0480624572033, 2641.9207423777293, 2652.1645681610303, 2661.4677064587086, 2681.5709486482165, 4577.267637178053, 4585.105904348649, 4586.8394606188795, 4617.2150734375155, 4708.43498780146, 4666.393368862043, 4717.599004084648, 4730.645201609876, 4748.3827102476625, 4776.880577985544, 4225.598568136023, 4278.614924656773, 4283.0, 4307.913841723163, 4448.844290449835, 4356.586124318184, 4380.780960951955, 4404.163208990298, 4412.624926881203, 4450.844220452284, 4245.363195520681, 4287.292596721569, 4324.935125973113, 4335.674824388184, 4404.559544045602, 4248.787560621957, 4272.359146128075, 4273.551277115889, 4275.080857615628, 4310.892227694333, 4259.041715613993, 4266.765327906964, 4273.145370925796, 4298.935515967263, 4329.675274354405, 4469.039156581318, 4539.251023581105, 4598.218302888484, 4693.507181745902, 4697.483276839579, 5034.546890779848, 5057.443681195065, 5059.06407314648, 5072.213806859942, 5098.235264710286, 5054.69671819692, 5099.566536844335, 5101.744912754348, 5106.9489305106845, 5117.257997590365, 4612.515685852971, 4723.480417154145, 4765.976170119127, 4812.278158276286, 4819.060283244734, 5111.233315002705, 5122.948770512322, 5137.8715532112, 5143.639945203875, 5198.610104242197, 4863.756812159378, 4916.139675556763, 4929.7781599828095, 4934.1611925972675, 4975.875603109951, 4952.777125029383, 4972.627052971042, 4997.550220480174, 5038.974805126024, 5039.370078740158, 4983.302337672729, 4983.950160498421, 4998.050370429607, 4998.650094493423, 5042.823501177441, 4867.732274724854, 4987.301777751118, 4991.101601711654, 5035.471275516092, 5037.269595908573, 4283.464566929134, 4292.077203401222, 4306.720063195945, 4329.1341731653165, 4330.935035974463, 3702.796346200931, 3703.277860817169, 3710.350688629479, 3747.700183985329, 3762.3227818992846, 4242.257604919127, 4267.658587313008, 4279.058607106432, 4309.59058889405, 4323.135372925428, 4932.8520144395725, 4945.480724523945, 4946.208606622923, 4974.0797952378925, 4999.900002000012, 4246.4691913510815, 4252.468441444819, 4257.481986426272, 4277.465316835395, 4291.785410729513, 4474.753888536096, 4499.4150760400935, 4514.932276015862, 4562.703424277412, 4579.473360563577, 4762.452317983476, 4782.545658162469, 4785.59322457588, 4788.497207793132, 4836.613070954386, 5019.372578427697, 5033.018561380496, 5037.093323201859, 5038.319826823478, 5070.518300761421, 4640.791164397543, 4717.78769955346, 4747.83382581608, 4793.592544633606, 4821.445533763662, 4809.78355973975, 4841.95158048415, 4842.782074806712, 4883.145449546244, 4899.632527560376, 4896.36347274852, 4924.0, 4926.704397736147, 4950.2079667253065, 4983.975080124576, 4803.519648035308, 4819.783109760139, 4944.53026962438, 5038.420581633012, 5042.09242336383, 4911.8280860169725, 4912.38595175603, 4927.1377508935075, 4928.359313289393, 4977.452480227244, 4832.057748739103, 4855.077535268288, 4856.1987272099705, 4857.562819346276, 4901.240307752304, 4731.219348807546, 4917.065757506062, 4953.678010929278, 4980.078685443204, 4994.275830004702, 4826.758662066953, 4860.73265970375, 4867.294242334912, 4871.975640121776, 4922.310876477368], "value": 4608.358263664927, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8739677270999, 600.6036016229289, 607.0651197156379, 608.3490664988459, 630.8359826445125, 34107.0, 35044.0, 35067.473987890204, 35149.824250878744, 35191.712538684966, 36923.63076369235, 37627.811860940725, 37635.81182094086, 37759.81120094402, 37868.0, 7601.201873803254, 7796.649150788228, 7805.102413222467, 7806.453548251625, 7810.140884502728, 7595.126560445537, 7718.0, 7730.806729831743, 7734.806629834271, 7736.226377362247, 7827.882581761278, 7945.642446089911, 7964.0, 7967.123616402191, 7968.362530997535, 7868.213178682115, 7915.564643944581, 7919.168487308865, 7929.326007289387, 7931.246531579491, 7847.450678452511, 7923.445358824884, 7934.801629959239, 7945.245201705829, 7946.0, 39030.0, 39373.40939885904, 39520.60479395198, 39543.40684889729, 39641.40537891934, 3268.2646404559023, 3420.96579034209, 3487.808170550619, 3601.711863050976, 3801.5628202756484, 25895.35261618456, 25979.480410391687, 26284.342891427677, 26884.73115268842, 27231.319217019536, 3468.5664291963503, 3478.4260597001467, 3513.5608048993877, 3517.472379143149, 3537.7523573349877, 218127.0, 220118.89940550356, 220320.0, 220356.0, 220510.0, 51348.48651513437, 51704.74147629313, 51785.48214517882, 51868.481315186364, 51870.22194667008, 55620.721896390256, 56911.430885690614, 59292.40707592955, 61054.69472652608, 61187.69406152941, 14362.85637143636, 14573.635659108395, 14620.0, 14624.0, 14630.487932922297, 11138.387388693538, 11251.549938002552, 11263.267887587444, 11276.436178191057, 11276.492557834918, 18033.0, 18102.366417175337, 18152.727709084375, 18171.454856354332, 18179.272829086953, 6795.510287675258, 7163.606001669854, 7166.283371662897, 7196.280371962866, 7236.240194779578, 840.7057529864621, 893.4728510179026, 909.7179874239007, 937.1471960515897, 974.5760594141572, 27394.0, 27748.583771243448, 27982.095934618206, 28434.431311373657, 28465.430691386056, 969.9888040107463, 986.5560497775886, 990.9950450247846, 994.3685759542742, 1122.5341483284346, 14590.978631495693, 14971.775423368657, 15156.469523566622, 15406.138756814707, 15444.613884652974, 361415.0, 365351.0, 369676.0, 370144.0, 370864.0, 49110.0, 50005.49994500008, 50020.0, 50065.24902126471, 50074.99999999927, 1117.1118960426481, 1138.2885696439726, 1267.9936600317124, 1268.6447794617523, 1290.0711487729009, 24901.50196996086, 25683.229503114937, 25881.870590646926, 25989.090381836544, 28236.43527129487, 42226.577734222265, 43011.3548296782, 43404.565954340054, 43424.0, 43440.34839477347, 249244.0, 254250.0, 254969.0, 255130.0, 255435.0, 32808.50787238146, 37381.25237495289, 38355.808220958716, 39304.0, 39331.410028850165, 39498.0, 40764.0, 40936.59063409328, 41493.585064148974, 41862.79068604759, 33995.66004339925, 34300.91291783652, 34593.48109778405, 35061.649383505835, 35517.46723799093, 34245.315093697485, 34441.0, 34732.65267347294, 34798.30403391969, 35285.823570881985, 34761.82619086889, 35007.299854003286, 35167.47248791321, 35275.0, 37141.0, 26076.0, 26434.603480948186, 28729.42541149207, 28985.275368115967, 29433.264168395104, 22403.887980559994, 22468.0, 22599.661005084607, 22623.886880565493, 22652.320430387113], "value": 17381.692810724246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1184481614694, 388.41931312687535, 393.53810432695144, 393.6752179451952, 398.4939127308318, 12684.556040538582, 12988.220706757602, 15655.21723913804, 16462.341506339748, 16493.092879891603, 10693.465326733653, 15999.280032398541, 16273.593160171002, 16289.185540722976, 16306.673866522662, 4608.562186592277, 4793.640476964224, 4806.83176088837, 4815.614750819944, 4818.397700287464, 3520.260745243502, 4735.73953432561, 4780.856574302777, 4782.139214941327, 6581.7696380626685, 6911.654417279141, 6955.130608673916, 6961.825954351131, 6961.895571566431, 6967.721291148348, 6740.629265390402, 6809.829754256159, 6847.1783385994, 6873.312668733137, 6890.965545172267, 6478.319776423455, 6539.705713242915, 6734.124563806723, 6736.2590115087305, 6817.659117044128, 23354.76645233543, 23359.76640233593, 23829.663847061252, 23957.40106497334, 23996.760032399627, 2038.6840039793856, 2087.0608226298073, 2209.834262430324, 2252.4706693926914, 2740.3560163361594, 13522.864771352259, 14463.566093017227, 14483.565493035227, 14651.487197948127, 15281.61795955099, 1900.249401486419, 1927.951801204967, 2011.4870707969374, 2080.167932826866, 2230.7657695941853, 79677.0, 82998.58500707518, 85537.57231213867, 86109.0, 86504.13495865087, 16613.584660383345, 16752.162391880356, 16869.493915182564, 17018.744718829228, 17048.914755426144, 31057.844710776753, 31183.84408077945, 31359.21601959969, 31400.37199256048, 31448.37103257922, 8177.304929081095, 8595.914040859636, 8658.610362533702, 8759.34304927133, 8880.0, 7062.611556364449, 7089.699553871033, 7190.7483238086415, 7202.20775714671, 7214.71141154348, 8346.415750897379, 8564.229219370287, 8573.871391929126, 8660.956695216484, 8666.393352465268, 3242.789218700777, 3406.6933975942284, 3480.564929383827, 3489.2149266415363, 3538.168530395355, 896.1979028769215, 897.7037577599376, 952.3857112162616, 999.93000489965, 1017.4759998600726, 16446.34214631425, 16890.493285201464, 16915.407960721317, 17049.659006819795, 17230.396936107176, 881.3786280672239, 888.320434867327, 931.9906800931903, 940.238406890421, 946.2146418472789, 9253.72238832836, 9473.857892131624, 9708.0, 9729.70810875675, 9755.219582433388, 377082.0, 378577.0, 394338.0, 406418.0, 410216.0, 78423.60788196023, 81229.0, 81377.59311203405, 81427.0, 83985.0, 917.1653795046476, 931.5295775633398, 932.8973812880713, 939.3189937295406, 950.8763860698065, 14939.477118300807, 15123.31945062497, 15212.619684507534, 15242.695146096794, 15431.459898903484, 33706.325873482885, 34070.65929340675, 36309.0, 36409.0, 36591.08522286964, 48075.0, 48234.758826205645, 48236.27645585249, 49094.0, 49552.256716148564, 7794.883076753967, 7918.168592297726, 7960.124386317385, 8133.2680058794995, 8228.177182281963, 11388.0, 11860.94069529647, 11924.76150477003, 12184.086193535697, 12189.51241950312, 10072.496375181065, 10238.12975897057, 10505.579776809147, 10607.045365917105, 10640.52117654692, 10028.0, 10293.53679084428, 10337.896621033693, 10371.533281002223, 10636.734081648021, 8539.018012928593, 10021.549030293509, 10550.736231594272, 10846.18653600999, 10948.233623646269, 7981.122076571689, 8019.518828870287, 8049.436539442183, 8073.717419890276, 8259.83480330402, 8201.056878459054, 9744.658936937172, 10681.89318106809, 10708.411037393018, 10764.08505277029], "value": 9313.708541264758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.6030070377483, 1315.2700251360493, 1350.3450826349222, 1490.8732757715593, 1785.4911350265186, 6521.250056243527, 7590.1650818409935, 7742.187070357616, 7747.573883436416, 7762.3402010829, 7501.549907005584, 7624.351930085935, 7643.770686879402, 7646.044244469442, 7648.923510764891, 1829.4694538583794, 2097.769245383007, 2151.709519214902, 2226.1651880544796, 2257.1874125314876, 2255.751867294596, 2272.6136556785304, 2279.794818466338, 2286.131270117353, 2288.4622113803243, 2129.595376878396, 2139.7539282982502, 2154.827613790893, 2163.718716566852, 2165.296278709418, 1884.2274667386375, 2110.482931681732, 2150.612889679857, 2170.7178066851366, 2174.510735084609, 2205.856619319739, 2224.165937773335, 2227.3429338345063, 2227.6769868368997, 2232.2745107839855, 7499.925000750031, 7541.170471248159, 7549.169591344948, 7553.093628764584, 7554.735584254579, 4297.119090586422, 4410.294352903552, 4416.646668266531, 4417.624501917341, 4430.224710675619, 2745.68424631166, 2789.316617428743, 2896.5075937090746, 2909.5344744840936, 2916.9270768230754, 928.2295694573488, 928.4104593583056, 936.8782058332373, 956.0582825916466, 978.5694294510392, 9694.466804325759, 9754.414735115915, 9769.90230097697, 9787.46168960714, 9793.510324483746, 4058.553559108496, 4119.752814831119, 4269.893252668646, 4294.677899157513, 4311.051568654953, 8452.74641760748, 8464.280536154496, 8488.448250863674, 8497.830043399097, 8501.022382425976, 4497.2129877271345, 4509.098180363941, 4516.81932722694, 4524.298733696282, 4548.749818759934, 3763.284975854579, 4191.580841915784, 4257.63810076147, 4304.569543045671, 4304.612584867315, 3552.325058238978, 3615.060084378081, 3666.1934374438115, 3697.9815100924325, 3739.9813000934823, 1217.3122185965078, 1241.0878004666563, 1245.9127861049822, 1253.5549879792725, 1258.087886282456, 737.5943231222806, 783.2950344689825, 836.610975896199, 839.4879123734516, 845.6110189312861, 5223.190405487156, 5354.892902142014, 5424.267723857229, 5589.105743081169, 5669.43305669438, 915.8946721127155, 923.3444254579324, 926.5922993882805, 948.3882895532342, 953.142172045151, 3555.182308069107, 3718.9070273242846, 3726.6459686329754, 3744.1575645479547, 3786.3373909565717, 9349.0, 9667.854982175273, 9696.854547181798, 9716.708498745049, 9759.170470510086, 9648.276379271583, 9670.468124253233, 9685.079917407835, 9698.127168554864, 9701.369410988264, 7014.123234595676, 7418.146913104954, 7442.18136005039, 7461.253874612604, 7461.888071678821, 5087.160618498055, 5215.5827533797965, 5316.468353164652, 5353.4646535346155, 5489.505944465017, 8810.074942130985, 8845.69040083594, 8881.200691937756, 8988.640454381752, 9009.189172974202, 8279.751607451786, 8698.956505217433, 8701.303895688203, 8709.695160669346, 8986.236169925629, 5871.794487192928, 6504.38208370204, 6585.835354115994, 6660.600363978177, 6844.2129155147795, 7359.558426494427, 7387.482876198615, 7426.331630153312, 7446.590437525988, 7449.813754656177, 6386.680665966776, 6653.234877989094, 6673.733050677918, 6778.389944904982, 6832.487563432663, 6646.966765166143, 6713.462922966249, 6729.52893297484, 6737.090492783412, 6848.760293389708, 6394.136791533269, 6428.4214420702365, 6477.805665830033, 6483.578567393104, 6484.578502397329, 4572.45130584332, 4593.28804035375, 4623.144718227139, 4661.114388266218, 4758.095961767253, 4446.488653804854, 4450.443694538183, 4598.218302888584, 4605.0, 4694.953050469451], "value": 4116.78573051959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.40609544912377, 326.33427807273165, 328.59254524389763, 330.80978437398494, 333.6863348452453, 4997.701057513544, 5027.170516864722, 5039.4204666463365, 5054.974725126373, 5069.594432445405, 4698.177818881699, 4889.731064791435, 4894.0, 4910.288008238803, 5003.974980125095, 3845.0198147953824, 3875.786831724261, 3885.30064588374, 3976.761394316336, 3987.3620220764683, 3962.960370396288, 3974.0462289050565, 3981.581933896928, 3988.3419235826054, 3990.421388898608, 3851.114243723945, 3930.8231129599094, 3949.1904159647347, 3950.8419663213435, 3974.9801250993705, 3923.391874259494, 3960.1881614269005, 3964.108075682977, 3975.085730282037, 3977.303971804937, 3535.1869070114017, 3541.29174165168, 3543.6102028776813, 3546.6453354664586, 3551.5738111426535, 4830.5652491275605, 4844.0, 4853.466118726938, 4864.246041863516, 4873.439554451248, 4412.602865742098, 4565.132624801277, 4578.78662154526, 4578.931316030262, 4593.990935936967, 5250.868728281824, 5252.264682944353, 5293.073712100367, 5301.973490132525, 5317.255584218213, 3891.6692081173132, 3900.5124359455067, 3902.941455878164, 3916.020994751312, 3920.353141731611, 5358.383785864637, 5521.116621340566, 5529.861753456195, 5538.6399884007415, 5543.334799824007, 3978.741381810173, 3985.8405663773124, 4002.999250187453, 4005.178938317638, 4006.6794656427414, 4053.8175782089875, 4060.939085913714, 4065.4714887064492, 4066.1461093170765, 4088.2028004539425, 4225.894352641209, 4504.256797628354, 4544.341070544752, 4581.358609794632, 4581.381513495702, 5270.631055826132, 5280.260763493114, 5289.153735402318, 5300.522952934254, 5301.787928482895, 1287.1955028107434, 1354.0927578522414, 1373.505538006317, 1374.780035194384, 1380.9792853107213, 901.7655409593552, 934.8457504511815, 936.3024546712743, 943.0710749911332, 943.2171297822928, 4605.6776025678555, 4612.169809434334, 4620.399348084795, 4641.930371044437, 4656.371389862393, 5381.596380271495, 5382.03123437785, 5385.515303622693, 5393.191021346829, 5402.432744561843, 4489.753063581535, 4633.328167415706, 4682.204025315705, 4696.295555666609, 4702.36518070063, 2873.8994135205166, 2899.3476467794576, 2910.2287893708185, 2918.6351706036744, 2919.620449341572, 5127.392791553007, 5184.403793563789, 5195.6622819516615, 5218.765155568009, 5233.345831771028, 5464.644798088191, 5612.971935140298, 5664.348599911063, 5674.177244299636, 5675.404082571353, 5204.0, 5208.817691380784, 5212.322398088224, 5213.40045894727, 5231.424543300234, 5233.084210263265, 5447.809326673548, 5451.863703407446, 5454.481824226692, 5474.945250547444, 5342.412334643263, 5367.812126575551, 5374.516293533445, 5385.3268341457315, 5396.865078373072, 5168.664036837594, 5179.792808287777, 5184.403793563789, 5192.766325515437, 5194.142966410651, 3669.5779985302033, 3861.4400911868183, 3888.747231429948, 3898.142408670088, 3902.551206611276, 5473.945260547503, 5491.862703432446, 5495.6153069286365, 5497.422770609189, 5501.422350653123, 5337.386200586982, 5340.9465905342, 5355.758990845344, 5361.061814182581, 5364.275822763877, 4998.700077995332, 5258.132408152765, 5295.443978382368, 5331.253624492651, 5343.3587969443915, 4960.553550180501, 5032.924506132485, 5196.350456192976, 5217.478252174904, 5234.97382513085, 5327.786888524571, 5338.318429694634, 5351.464853514617, 5356.7589458473685, 5365.9463405367005, 5231.163013917755, 5235.921461178009, 5246.422893481637, 5248.947510524846, 5249.895002100013], "value": 4017.6936933665397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.1447726534996, 733.5928559649395, 744.6993611891327, 745.6458182363378, 755.8450517643884, 11154.330740155596, 13885.514007009744, 14008.509702160427, 14223.715525689493, 14226.075305105162, 14149.221792801392, 14172.078814877026, 14226.573202803933, 14244.14535127893, 14250.928745356285, 648.3030741952397, 811.2860682599334, 812.2608426332039, 814.1654803826067, 814.9185081491847, 656.2551504042898, 659.6240143118424, 660.4617236951893, 792.3265224559136, 823.3742355809568, 858.7037472072157, 861.530465896085, 862.3187681731424, 862.482510493705, 863.0592654007131, 859.1022381611232, 859.7721603775004, 859.8710193470936, 860.0109873645326, 860.371928492198, 495.3065708008817, 607.9726412311456, 628.707650942314, 630.6468377708497, 634.3846468925135, 12669.303188324639, 12800.295983720891, 12817.03872209588, 12828.422720977578, 12850.421731022127, 11833.290002599872, 12064.155509114365, 12182.939085304517, 12312.384380781015, 12562.246265224025, 8655.413996858573, 8765.430247033986, 8860.778480537974, 8939.865902011476, 9055.818883622356, 3273.836308184605, 3277.8197199154038, 3327.38443387974, 3329.6836800503916, 3394.932101357959, 41933.999999999694, 42337.364939525934, 42674.0, 42828.143437131395, 42936.57063429357, 9801.656942006995, 9834.430480749992, 9861.457619830835, 10024.147947424404, 10032.899671003343, 16970.490885273462, 16995.235214415134, 17001.659966800595, 17002.23489942931, 17029.318827247018, 6655.101561289261, 6662.267150613428, 6763.628000459924, 6936.375726184668, 6997.685104170325, 3868.497095377583, 4019.618136277049, 4027.7986100694848, 4059.6143366380147, 4067.633912947849, 2772.8336299822076, 2831.9858400707863, 2835.8014938954075, 2840.304125489227, 2843.402885394049, 528.6273177409917, 534.5349545895097, 541.5775694957939, 541.8103663717667, 543.2828666160709, 529.7430746088221, 561.7163332517134, 583.6643929740417, 588.7703795519665, 625.0218408191166, 7785.086628120974, 7943.960280198562, 8025.03699556057, 8051.59742012897, 8251.669933202726, 574.1875246526118, 586.2291087220292, 606.1507936507936, 615.8398816307792, 624.5784095735361, 3689.4834723138783, 3703.388940824788, 3761.435784632327, 3829.3298672732717, 3843.0, 41954.790226049285, 44839.77580112144, 45654.77172614182, 45807.77096114498, 46925.5307446928, 40044.0, 40206.0, 40632.0, 41264.58735412668, 42067.0, 37642.16546435307, 37710.0, 38141.427878581846, 38223.61776382256, 38437.423438648446, 8014.479058861155, 8029.4379393441895, 8160.102388737353, 8360.45657032291, 8484.575771211292, 25023.624645630694, 25376.74623253744, 25515.10697125592, 26439.471210575295, 28092.0, 34004.82997584996, 34140.0, 34462.0, 34836.129096772784, 35073.0, 10665.733356666145, 10804.891951080388, 10813.56745730162, 10818.837717434402, 10900.727481813017, 11981.940090299493, 12038.277703337828, 12043.518259269531, 12083.275003499819, 12684.302363370103, 11075.889241107487, 11156.665300041012, 11365.602203922823, 11605.419729013684, 11649.068074554185, 11438.0, 11452.713682158013, 11659.53361865516, 11697.005754510961, 12165.452554634885, 10411.84382234252, 10761.04114691494, 10849.511771970123, 10928.781424371628, 11031.338119712844, 9791.657291994747, 9815.116639502194, 9818.214542836698, 9843.60625574969, 9907.405555666683, 9315.284636471304, 9320.72037838866, 9510.667126650535, 9596.136347728738, 9669.564869580745], "value": 5867.014572187851, "unit": "score"}], "name": "dromaeo_css", "value": 6455.955162841967, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 108.0, 112.0, 114.0, 114.0, 104.0, 112.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 143.0, 155.0, 202.0, 133.0, 153.0, 158.0, 141.0, 183.0, 133.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 164.0, 172.0, 162.0, 159.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 100.0, 117.0, 75.0, 77.0, 77.0, 124.0, 101.0, 75.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 142.0, 93.0, 95.0, 93.0, 148.0, 94.0, 94.0, 144.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 65.0, 66.0, 67.0, 68.0, 85.0, 64.0, 63.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 78.0, 78.0, 79.0, 82.0, 80.0, 79.0, 79.0, 80.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 144.0, 131.0, 132.0, 131.0, 133.0, 137.0, 172.0, 131.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 178.0, 172.0, 175.0, 177.0, 180.0, 177.0, 174.0, 174.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 74.0, 72.0, 72.0, 71.0, 73.0, 73.0, 70.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1585.7, "alertThreshold": 2.0}]} 08:52:45 INFO - Return code: 0 08:52:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:52:45 ERROR - # TBPL SUCCESS # 08:52:45 INFO - Running post-action listener: _resource_record_post_action 08:52:45 INFO - Running post-run listener: _resource_record_post_run 08:52:46 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518348800; Read time: 8; Write time: 393940 08:52:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234647552; Read time: 0; Write time: 198204 08:52:46 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283701248; Read time: 8; Write time: 195736 08:52:46 INFO - Running post-run listener: _upload_blobber_files 08:52:46 INFO - Blob upload gear active. 08:52:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:52:46 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 08:52:46 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:52:46 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:52:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:47 INFO - (blobuploader) - INFO - Done attempting. 08:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:48 INFO - (blobuploader) - INFO - Done attempting. 08:52:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:52:48 INFO - Return code: 0 08:52:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:52:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:52:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19547f7ecf3da69debebf77ffef2d03afb24d69b5d27703b4acce4d2fa33355a94c480e7e3d75994719a7df88a0063c5adf8da0a74563abe5e091d296119b611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19b0e466a1c4fe463522174a594df1a651bd2893fd604c250b64b79c05925495c6d01caca24cb2c6f7f41bc235ea069415f5ea3212dc0f1e542bf51f78c6a5a6"} 08:52:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:52:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:52:48 INFO - Contents: 08:52:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19547f7ecf3da69debebf77ffef2d03afb24d69b5d27703b4acce4d2fa33355a94c480e7e3d75994719a7df88a0063c5adf8da0a74563abe5e091d296119b611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19b0e466a1c4fe463522174a594df1a651bd2893fd604c250b64b79c05925495c6d01caca24cb2c6f7f41bc235ea069415f5ea3212dc0f1e542bf51f78c6a5a6"} 08:52:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:52:48 INFO - Copying logs to upload dir... 08:52:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:52:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.824200 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-22 08:52:48.332920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:52:48.336395) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19547f7ecf3da69debebf77ffef2d03afb24d69b5d27703b4acce4d2fa33355a94c480e7e3d75994719a7df88a0063c5adf8da0a74563abe5e091d296119b611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19b0e466a1c4fe463522174a594df1a651bd2893fd604c250b64b79c05925495c6d01caca24cb2c6f7f41bc235ea069415f5ea3212dc0f1e542bf51f78c6a5a6"} build_url:https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/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/Firefox-Non-PGO/sha512/19547f7ecf3da69debebf77ffef2d03afb24d69b5d27703b4acce4d2fa33355a94c480e7e3d75994719a7df88a0063c5adf8da0a74563abe5e091d296119b611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19b0e466a1c4fe463522174a594df1a651bd2893fd604c250b64b79c05925495c6d01caca24cb2c6f7f41bc235ea069415f5ea3212dc0f1e542bf51f78c6a5a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:52:48.360618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:52:48.360928) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461339124.598239-703115475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:52:48.443071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:52:48.443472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:52:48.443855) ========= ========= Total master_lag: 0.22 =========