builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1461010476.78 results: success (0) buildid: 20160418103109 builduid: 2b1cbf67d9434f07bab7c00b959e2f9b revision: d53b301a14e1dfa05324072a7159796a4f5e24c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.776732) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.777247) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.777566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.794511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.795203) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 13:14:36-- 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% 29.7M=0s 2016-04-18 13:14:36 (29.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.906359) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.907067) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016066 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.960866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:36.961692) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d53b301a14e1dfa05324072a7159796a4f5e24c7 --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 d53b301a14e1dfa05324072a7159796a4f5e24c7 --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=7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 13:14:37,129 truncating revision to first 12 chars 2016-04-18 13:14:37,129 Setting DEBUG logging. 2016-04-18 13:14:37,129 attempt 1/10 2016-04-18 13:14:37,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d53b301a14e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 13:14:37,417 unpacking tar archive at: mozilla-central-d53b301a14e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:37.533390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:37.534196) ========= script_repo_revision: d53b301a14e1dfa05324072a7159796a4f5e24c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:37.535177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:37.535859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 13:14:37.547441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-18 13:14:37.547748) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:14:37 INFO - MultiFileLogger online at 20160418 13:14:37 in /builds/slave/test 13:14:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:14:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:14:37 INFO - {'append_to_log': False, 13:14:37 INFO - 'base_work_dir': '/builds/slave/test', 13:14:37 INFO - 'blob_upload_branch': 'Firefox', 13:14:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:14:37 INFO - 'branch': 'Firefox', 13:14:37 INFO - 'buildbot_json_path': 'buildprops.json', 13:14:37 INFO - 'config_files': ('talos/linux_config.py',), 13:14:37 INFO - 'default_actions': ('clobber', 13:14:37 INFO - 'read-buildbot-config', 13:14:37 INFO - 'download-and-extract', 13:14:37 INFO - 'populate-webroot', 13:14:37 INFO - 'create-virtualenv', 13:14:37 INFO - 'install', 13:14:37 INFO - 'run-tests'), 13:14:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:14:37 INFO - 'download_minidump_stackwalk': True, 13:14:37 INFO - 'download_symbols': 'ondemand', 13:14:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:14:37 INFO - 'tooltool.py': '/tools/tooltool.py', 13:14:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:14:37 INFO - '/tools/misc-python/virtualenv.py')}, 13:14:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:14:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:14:37 INFO - 'installer_path': 'installer.exe', 13:14:37 INFO - 'log_level': 'info', 13:14:37 INFO - 'log_name': 'talos', 13:14:37 INFO - 'log_to_console': True, 13:14:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:14:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:14:37 INFO - 'opt_config_files': (), 13:14:37 INFO - 'pip_index': False, 13:14:37 INFO - 'sps_profile': False, 13:14:37 INFO - 'sps_profile_interval': 0, 13:14:37 INFO - 'suite': 'dromaeojs-e10s', 13:14:37 INFO - 'system_bits': '32', 13:14:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:14:37 INFO - 'title': 'talos-linux64-ix-024', 13:14:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:14:37 INFO - 'use_talos_json': True, 13:14:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:14:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:14:37 INFO - 'work_dir': 'build'} 13:14:37 INFO - ##### 13:14:37 INFO - ##### Running clobber step. 13:14:37 INFO - ##### 13:14:37 INFO - Running pre-action listener: _resource_record_pre_action 13:14:37 INFO - Running main action method: clobber 13:14:37 INFO - rmtree: /builds/slave/test/build 13:14:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:38 INFO - Running post-action listener: _resource_record_post_action 13:14:38 INFO - ##### 13:14:38 INFO - ##### Running read-buildbot-config step. 13:14:38 INFO - ##### 13:14:38 INFO - Running pre-action listener: _resource_record_pre_action 13:14:38 INFO - Running main action method: read_buildbot_config 13:14:38 INFO - Using buildbot properties: 13:14:38 INFO - { 13:14:38 INFO - "project": "", 13:14:38 INFO - "product": "firefox", 13:14:38 INFO - "script_repo_revision": "production", 13:14:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:14:38 INFO - "repository": "", 13:14:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 13:14:38 INFO - "buildid": "20160418103109", 13:14:38 INFO - "pgo_build": "True", 13:14:38 INFO - "basedir": "/builds/slave/test", 13:14:38 INFO - "buildnumber": 184, 13:14:38 INFO - "slavename": "talos-linux64-ix-024", 13:14:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:14:38 INFO - "platform": "ubuntu64_hw", 13:14:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:14:38 INFO - "branch": "mozilla-central", 13:14:38 INFO - "repo_path": "mozilla-central", 13:14:38 INFO - "revision": "d53b301a14e1dfa05324072a7159796a4f5e24c7", 13:14:38 INFO - "stage_platform": "linux64-pgo", 13:14:38 INFO - "builduid": "2b1cbf67d9434f07bab7c00b959e2f9b", 13:14:38 INFO - "slavebuilddir": "test" 13:14:38 INFO - } 13:14:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:14:38 INFO - Running post-action listener: _resource_record_post_action 13:14:38 INFO - ##### 13:14:38 INFO - ##### Running download-and-extract step. 13:14:38 INFO - ##### 13:14:38 INFO - Running pre-action listener: _resource_record_pre_action 13:14:38 INFO - Running main action method: download_and_extract 13:14:38 INFO - mkdir: /builds/slave/test/build/tests 13:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:38 INFO - https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:38 INFO - Downloaded 1361 bytes. 13:14:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:14:38 INFO - Using the following test package requirements: 13:14:38 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:14:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:14:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:39 INFO - u'jsshell-linux-x86_64.zip'], 13:14:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:14:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:14:39 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:14:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:14:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:14:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:14:39 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')]} 13:14:39 INFO - https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:40 INFO - Downloaded 23775021 bytes. 13:14:40 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'] 13:14:40 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 13:14:41 INFO - Return code: 0 13:14:41 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 13:14: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')]} 13:14:41 INFO - https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:42 INFO - Downloaded 23775021 bytes. 13:14:42 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'] 13:14:42 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 13:14:43 INFO - Return code: 0 13:14: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')]} 13:14:43 INFO - https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:44 INFO - Downloaded 10845952 bytes. 13:14:44 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'] 13:14:44 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 13:14:45 INFO - Return code: 0 13:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:45 INFO - https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/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 13:14:46 INFO - Downloaded 58231682 bytes. 13:14:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:14:46 INFO - mkdir: /builds/slave/test/properties 13:14:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:14:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:14:46 INFO - Contents: 13:14:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:14:47 INFO - Running post-action listener: _resource_record_post_action 13:14:47 INFO - Running post-action listener: set_extra_try_arguments 13:14:47 INFO - ##### 13:14:47 INFO - ##### Running populate-webroot step. 13:14:47 INFO - ##### 13:14:47 INFO - Running pre-action listener: _resource_record_pre_action 13:14:47 INFO - Running main action method: populate_webroot 13:14:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:14:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:14:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:14:47 INFO - '--tppagecycles', 13:14:47 INFO - '7'], 13:14:47 INFO - 'tests': ['tsvgm']}}, 13:14:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:14:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:14:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:14:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:14:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['damp', 'tps']}, 13:14:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'tests': ['damp', 'tps']}, 13:14:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['dromaeo_dom']}, 13:14:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:14:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['a11yr', 13:14:47 INFO - 'ts_paint', 13:14:47 INFO - 'tpaint', 13:14:47 INFO - 'sessionrestore', 13:14:47 INFO - 'sessionrestore_no_auto_restore', 13:14:47 INFO - 'tabpaint']}, 13:14:47 INFO - 'other-e10s': {'tests': ['a11yr', 13:14:47 INFO - 'ts_paint', 13:14:47 INFO - 'tpaint', 13:14:47 INFO - 'sessionrestore', 13:14:47 INFO - 'sessionrestore_no_auto_restore', 13:14:47 INFO - 'tabpaint']}, 13:14:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:14:47 INFO - 'ts_paint', 13:14:47 INFO - 'tpaint', 13:14:47 INFO - 'sessionrestore', 13:14:47 INFO - 'sessionrestore_no_auto_restore', 13:14:47 INFO - 'tabpaint']}, 13:14:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:14:47 INFO - 'ts_paint', 13:14:47 INFO - 'tpaint', 13:14:47 INFO - 'sessionrestore', 13:14:47 INFO - 'sessionrestore_no_auto_restore', 13:14:47 INFO - 'tabpaint']}, 13:14:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['a11yr', 13:14:47 INFO - 'ts_paint', 13:14:47 INFO - 'tpaint', 13:14:47 INFO - 'sessionrestore', 13:14:47 INFO - 'sessionrestore_no_auto_restore', 13:14:47 INFO - 'tabpaint']}, 13:14:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['a11yr', 13:14:47 INFO - 'ts_paint', 13:14:47 INFO - 'tpaint', 13:14:47 INFO - 'sessionrestore', 13:14:47 INFO - 'sessionrestore_no_auto_restore', 13:14:47 INFO - 'tabpaint']}, 13:14:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['tsvgx', 13:14:47 INFO - 'tsvgr_opacity', 13:14:47 INFO - 'tart', 13:14:47 INFO - 'tscrollx', 13:14:47 INFO - 'cart']}, 13:14:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:14:47 INFO - 'tsvgr_opacity', 13:14:47 INFO - 'tart', 13:14:47 INFO - 'tscrollx', 13:14:47 INFO - 'cart']}, 13:14:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'talos_options': ['--disable-e10s'], 13:14:47 INFO - 'tests': ['tp5o']}, 13:14:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'tests': ['tp5o']}, 13:14:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'talos_options': ['--disable-e10s', 13:14:47 INFO - '--xperf_path', 13:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:47 INFO - 'tests': ['tp5n']}, 13:14:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:47 INFO - 'talos_options': ['--xperf_path', 13:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:47 INFO - 'tests': ['tp5n']}}, 13:14:47 INFO - 'talos.zip': {'path': '', 13:14:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:14:47 INFO - Running post-action listener: _resource_record_post_action 13:14:47 INFO - ##### 13:14:47 INFO - ##### Running create-virtualenv step. 13:14:47 INFO - ##### 13:14:47 INFO - Running pre-action listener: _resource_record_pre_action 13:14:47 INFO - Running main action method: create_virtualenv 13:14:47 INFO - Creating virtualenv /builds/slave/test/build/venv 13:14:47 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 13:14:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:14:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:14:47 INFO - Using real prefix '/usr' 13:14:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:14:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:14:49 INFO - Installing pip.................done. 13:14:49 INFO - Return code: 0 13:14:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:49 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:14:49 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 13:14:49 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 13:14:49 INFO - Using env: {'DISPLAY': ':0', 13:14:49 INFO - 'HOME': '/home/cltbld', 13:14:49 INFO - 'LANG': 'en_US.UTF-8', 13:14:49 INFO - 'LANGUAGE': 'en_US:en', 13:14:49 INFO - 'LOGNAME': 'cltbld', 13:14:49 INFO - 'MAIL': '/var/mail/cltbld', 13:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:49 INFO - 'MOZ_NO_REMOTE': '1', 13:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:49 INFO - 'NO_EM_RESTART': '1', 13:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:49 INFO - 'PWD': '/builds/slave/test', 13:14:49 INFO - 'SHELL': '/bin/bash', 13:14:49 INFO - 'SHLVL': '1', 13:14:49 INFO - 'TERM': 'linux', 13:14:49 INFO - 'TMOUT': '86400', 13:14:49 INFO - 'USER': 'cltbld', 13:14:49 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:49 INFO - '_': '/tools/buildbot/bin/python'} 13:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:50 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 13:14:50 INFO - Cleaning up... 13:14:50 INFO - Return code: 0 13:14:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:14:50 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')]} 13:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:50 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')]} 13:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:50 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:14:50 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 13:14:50 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 13:14:50 INFO - Using env: {'DISPLAY': ':0', 13:14:50 INFO - 'HOME': '/home/cltbld', 13:14:50 INFO - 'LANG': 'en_US.UTF-8', 13:14:50 INFO - 'LANGUAGE': 'en_US:en', 13:14:50 INFO - 'LOGNAME': 'cltbld', 13:14:50 INFO - 'MAIL': '/var/mail/cltbld', 13:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:50 INFO - 'MOZ_NO_REMOTE': '1', 13:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:50 INFO - 'NO_EM_RESTART': '1', 13:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:50 INFO - 'PWD': '/builds/slave/test', 13:14:50 INFO - 'SHELL': '/bin/bash', 13:14:50 INFO - 'SHLVL': '1', 13:14:50 INFO - 'TERM': 'linux', 13:14:50 INFO - 'TMOUT': '86400', 13:14:50 INFO - 'USER': 'cltbld', 13:14:50 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:50 INFO - '_': '/tools/buildbot/bin/python'} 13:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:50 INFO - Downloading/unpacking psutil>=0.7.1 13:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:52 INFO - Installing collected packages: psutil 13:14:52 INFO - Running setup.py install for psutil 13:14:52 INFO - building 'psutil._psutil_linux' extension 13:14:52 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 13:14:52 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 13:14:52 INFO - building 'psutil._psutil_posix' extension 13:14:52 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 13:14:52 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 13:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:52 INFO - Successfully installed psutil 13:14:52 INFO - Cleaning up... 13:14:52 INFO - Return code: 0 13:14:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:52 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:14:52 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 13:14:52 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 13:14:52 INFO - Using env: {'DISPLAY': ':0', 13:14:52 INFO - 'HOME': '/home/cltbld', 13:14:52 INFO - 'LANG': 'en_US.UTF-8', 13:14:52 INFO - 'LANGUAGE': 'en_US:en', 13:14:52 INFO - 'LOGNAME': 'cltbld', 13:14:52 INFO - 'MAIL': '/var/mail/cltbld', 13:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:52 INFO - 'MOZ_NO_REMOTE': '1', 13:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:52 INFO - 'NO_EM_RESTART': '1', 13:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:52 INFO - 'PWD': '/builds/slave/test', 13:14:52 INFO - 'SHELL': '/bin/bash', 13:14:52 INFO - 'SHLVL': '1', 13:14:52 INFO - 'TERM': 'linux', 13:14:52 INFO - 'TMOUT': '86400', 13:14:52 INFO - 'USER': 'cltbld', 13:14:52 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:52 INFO - '_': '/tools/buildbot/bin/python'} 13:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:14:53 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 13:14:53 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 13:14:53 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 13:14:53 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 13:14:53 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 13:14:53 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 13:14:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:14:55 INFO - Installing collected packages: mozsystemmonitor 13:14:55 INFO - Running setup.py install for mozsystemmonitor 13:14:55 INFO - Successfully installed mozsystemmonitor 13:14:55 INFO - Cleaning up... 13:14:55 INFO - Return code: 0 13:14:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:55 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:14:55 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 13:14:55 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 13:14:55 INFO - Using env: {'DISPLAY': ':0', 13:14:55 INFO - 'HOME': '/home/cltbld', 13:14:55 INFO - 'LANG': 'en_US.UTF-8', 13:14:55 INFO - 'LANGUAGE': 'en_US:en', 13:14:55 INFO - 'LOGNAME': 'cltbld', 13:14:55 INFO - 'MAIL': '/var/mail/cltbld', 13:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:55 INFO - 'MOZ_NO_REMOTE': '1', 13:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:55 INFO - 'NO_EM_RESTART': '1', 13:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:55 INFO - 'PWD': '/builds/slave/test', 13:14:55 INFO - 'SHELL': '/bin/bash', 13:14:55 INFO - 'SHLVL': '1', 13:14:55 INFO - 'TERM': 'linux', 13:14:55 INFO - 'TMOUT': '86400', 13:14:55 INFO - 'USER': 'cltbld', 13:14:55 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:55 INFO - '_': '/tools/buildbot/bin/python'} 13:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:14:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - Downloading docopt-0.6.1.tar.gz 13:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:14:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:14:58 INFO - Running setup.py install for blobuploader 13:14:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:14:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:14:58 INFO - Running setup.py install for requests 13:14:58 INFO - Running setup.py install for docopt 13:14:58 INFO - Successfully installed blobuploader requests docopt 13:14:58 INFO - Cleaning up... 13:14:58 INFO - Return code: 0 13:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:58 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:14:58 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 13:14:58 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 13:14:58 INFO - Using env: {'DISPLAY': ':0', 13:14:58 INFO - 'HOME': '/home/cltbld', 13:14:58 INFO - 'LANG': 'en_US.UTF-8', 13:14:58 INFO - 'LANGUAGE': 'en_US:en', 13:14:58 INFO - 'LOGNAME': 'cltbld', 13:14:58 INFO - 'MAIL': '/var/mail/cltbld', 13:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:58 INFO - 'MOZ_NO_REMOTE': '1', 13:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:58 INFO - 'NO_EM_RESTART': '1', 13:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:58 INFO - 'PWD': '/builds/slave/test', 13:14:58 INFO - 'SHELL': '/bin/bash', 13:14:58 INFO - 'SHLVL': '1', 13:14:58 INFO - 'TERM': 'linux', 13:14:58 INFO - 'TMOUT': '86400', 13:14:58 INFO - 'USER': 'cltbld', 13:14:58 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:58 INFO - '_': '/tools/buildbot/bin/python'} 13:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:14:58 INFO - Running setup.py (path:/tmp/pip-AvwVoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:14:58 INFO - Running setup.py (path:/tmp/pip-nucI5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:14:58 INFO - Running setup.py (path:/tmp/pip-nwaTvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:14:59 INFO - Running setup.py (path:/tmp/pip-UNi9PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:14:59 INFO - Running setup.py (path:/tmp/pip-KaMh4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:14:59 INFO - Running setup.py (path:/tmp/pip-tXsP3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:14:59 INFO - Running setup.py (path:/tmp/pip-NAlght-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:14:59 INFO - Running setup.py (path:/tmp/pip-Bg2u5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:14:59 INFO - Running setup.py (path:/tmp/pip-hwQzsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:14:59 INFO - Running setup.py (path:/tmp/pip-JJgqB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:14:59 INFO - Running setup.py (path:/tmp/pip-3BuuRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:14:59 INFO - Running setup.py (path:/tmp/pip-Xzz0y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:14:59 INFO - Running setup.py (path:/tmp/pip-5NEVs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:14:59 INFO - Running setup.py (path:/tmp/pip-11hmH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:59 INFO - Running setup.py (path:/tmp/pip-zJc5jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:14:59 INFO - Running setup.py (path:/tmp/pip-QlgmLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:00 INFO - Running setup.py (path:/tmp/pip-nqn6Qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:15:00 INFO - Running setup.py install for manifestparser 13:15:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozcrash 13:15:00 INFO - Running setup.py install for mozdebug 13:15:00 INFO - Running setup.py install for mozdevice 13:15:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozfile 13:15:00 INFO - Running setup.py install for mozhttpd 13:15:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozinfo 13:15:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozInstall 13:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozleak 13:15:00 INFO - Running setup.py install for mozlog 13:15:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Running setup.py install for moznetwork 13:15:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Running setup.py install for mozprocess 13:15:01 INFO - Running setup.py install for mozprofile 13:15:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Running setup.py install for mozrunner 13:15:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Running setup.py install for mozscreenshot 13:15:01 INFO - Running setup.py install for moztest 13:15:01 INFO - Running setup.py install for mozversion 13:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:01 INFO - Cleaning up... 13:15:01 INFO - Return code: 0 13:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:01 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:15:01 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 13:15:01 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 13:15:01 INFO - Using env: {'DISPLAY': ':0', 13:15:01 INFO - 'HOME': '/home/cltbld', 13:15:01 INFO - 'LANG': 'en_US.UTF-8', 13:15:01 INFO - 'LANGUAGE': 'en_US:en', 13:15:01 INFO - 'LOGNAME': 'cltbld', 13:15:01 INFO - 'MAIL': '/var/mail/cltbld', 13:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:01 INFO - 'MOZ_NO_REMOTE': '1', 13:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:01 INFO - 'NO_EM_RESTART': '1', 13:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:01 INFO - 'PWD': '/builds/slave/test', 13:15:01 INFO - 'SHELL': '/bin/bash', 13:15:01 INFO - 'SHLVL': '1', 13:15:01 INFO - 'TERM': 'linux', 13:15:01 INFO - 'TMOUT': '86400', 13:15:01 INFO - 'USER': 'cltbld', 13:15:01 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:01 INFO - '_': '/tools/buildbot/bin/python'} 13:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:02 INFO - Running setup.py (path:/tmp/pip-2aizgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:02 INFO - Running setup.py (path:/tmp/pip-tIB8PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:02 INFO - Running setup.py (path:/tmp/pip-MRBhh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:02 INFO - Running setup.py (path:/tmp/pip-ZMAObA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:02 INFO - Running setup.py (path:/tmp/pip-5Sd4lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:02 INFO - Running setup.py (path:/tmp/pip-wjWWzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:02 INFO - Running setup.py (path:/tmp/pip-Vh3eoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:02 INFO - Running setup.py (path:/tmp/pip-p1rdGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:02 INFO - Running setup.py (path:/tmp/pip-VQhNZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:02 INFO - Running setup.py (path:/tmp/pip-PMXjvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:02 INFO - Running setup.py (path:/tmp/pip-Ubhz4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:02 INFO - Running setup.py (path:/tmp/pip-uh5p5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:02 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)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:02 INFO - Running setup.py (path:/tmp/pip-FgIBpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:03 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)) 13:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:03 INFO - Running setup.py (path:/tmp/pip-ZHA7pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:03 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)) 13:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:03 INFO - Running setup.py (path:/tmp/pip-iq5I_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:03 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)) 13:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:03 INFO - Running setup.py (path:/tmp/pip-TAKwCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:03 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)) 13:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:03 INFO - Running setup.py (path:/tmp/pip-bg4JUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:03 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)) 13:15:03 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)) 13:15:03 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)) 13:15:03 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)) 13:15:03 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)) 13:15:03 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)) 13:15:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:05 INFO - Downloading blessings-1.6.tar.gz 13:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:05 INFO - Installing collected packages: blessings 13:15:05 INFO - Running setup.py install for blessings 13:15:05 INFO - Successfully installed blessings 13:15:05 INFO - Cleaning up... 13:15:05 INFO - Return code: 0 13:15:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:05 INFO - Reading from file tmpfile_stdout 13:15:05 INFO - Current package versions: 13:15:05 INFO - argparse == 1.2.1 13:15:05 INFO - blessings == 1.6 13:15:05 INFO - blobuploader == 1.2.4 13:15:05 INFO - docopt == 0.6.1 13:15:05 INFO - manifestparser == 1.1 13:15:05 INFO - mozInstall == 1.12 13:15:05 INFO - mozcrash == 0.17 13:15:05 INFO - mozdebug == 0.1 13:15:05 INFO - mozdevice == 0.48 13:15:05 INFO - mozfile == 1.2 13:15:05 INFO - mozhttpd == 0.7 13:15:05 INFO - mozinfo == 0.9 13:15:05 INFO - mozleak == 0.1 13:15:05 INFO - mozlog == 3.1 13:15:05 INFO - moznetwork == 0.27 13:15:05 INFO - mozprocess == 0.22 13:15:05 INFO - mozprofile == 0.28 13:15:05 INFO - mozrunner == 6.11 13:15:05 INFO - mozscreenshot == 0.1 13:15:05 INFO - mozsystemmonitor == 0.0 13:15:05 INFO - moztest == 0.7 13:15:05 INFO - mozversion == 1.4 13:15:05 INFO - psutil == 3.1.1 13:15:05 INFO - requests == 1.2.3 13:15:05 INFO - wsgiref == 0.1.2 13:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:05 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:15:05 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 13:15:05 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 13:15:05 INFO - Using env: {'DISPLAY': ':0', 13:15:05 INFO - 'HOME': '/home/cltbld', 13:15:05 INFO - 'LANG': 'en_US.UTF-8', 13:15:05 INFO - 'LANGUAGE': 'en_US:en', 13:15:05 INFO - 'LOGNAME': 'cltbld', 13:15:05 INFO - 'MAIL': '/var/mail/cltbld', 13:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:05 INFO - 'MOZ_NO_REMOTE': '1', 13:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:05 INFO - 'NO_EM_RESTART': '1', 13:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:05 INFO - 'PWD': '/builds/slave/test', 13:15:05 INFO - 'SHELL': '/bin/bash', 13:15:05 INFO - 'SHLVL': '1', 13:15:05 INFO - 'TERM': 'linux', 13:15:05 INFO - 'TMOUT': '86400', 13:15:05 INFO - 'USER': 'cltbld', 13:15:05 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:05 INFO - '_': '/tools/buildbot/bin/python'} 13:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 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)) 13:15:05 INFO - Cleaning up... 13:15:05 INFO - Return code: 0 13:15:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:05 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:15:05 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 13:15:05 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 13:15:05 INFO - Using env: {'DISPLAY': ':0', 13:15:05 INFO - 'HOME': '/home/cltbld', 13:15:05 INFO - 'LANG': 'en_US.UTF-8', 13:15:05 INFO - 'LANGUAGE': 'en_US:en', 13:15:05 INFO - 'LOGNAME': 'cltbld', 13:15:05 INFO - 'MAIL': '/var/mail/cltbld', 13:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:05 INFO - 'MOZ_NO_REMOTE': '1', 13:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:05 INFO - 'NO_EM_RESTART': '1', 13:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:05 INFO - 'PWD': '/builds/slave/test', 13:15:05 INFO - 'SHELL': '/bin/bash', 13:15:05 INFO - 'SHLVL': '1', 13:15:05 INFO - 'TERM': 'linux', 13:15:05 INFO - 'TMOUT': '86400', 13:15:05 INFO - 'USER': 'cltbld', 13:15:05 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:05 INFO - '_': '/tools/buildbot/bin/python'} 13:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:06 INFO - Downloading/unpacking jsonschema 13:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:15:07 INFO - Downloading/unpacking functools32 (from jsonschema) 13:15:07 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 13:15:07 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 13:15:07 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 13:15:07 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 13:15:07 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 13:15:07 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 13:15:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:15:08 INFO - warning: no files found matching '*.txt' 13:15:08 INFO - no previously-included directories found matching 'build' 13:15:08 INFO - no previously-included directories found matching 'dist' 13:15:08 INFO - no previously-included directories found matching '.git*' 13:15:08 INFO - Installing collected packages: jsonschema, functools32 13:15:08 INFO - Running setup.py install for functools32 13:15:08 INFO - warning: no files found matching '*.txt' 13:15:08 INFO - no previously-included directories found matching 'build' 13:15:08 INFO - no previously-included directories found matching 'dist' 13:15:08 INFO - no previously-included directories found matching '.git*' 13:15:08 INFO - Successfully installed jsonschema functools32 13:15:08 INFO - Cleaning up... 13:15:08 INFO - Return code: 0 13:15:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:15:08 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')]} 13:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:08 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')]} 13:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:08 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 0x7f92054c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', '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 13:15:08 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 13:15:08 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 13:15:08 INFO - Using env: {'DISPLAY': ':0', 13:15:08 INFO - 'HOME': '/home/cltbld', 13:15:08 INFO - 'LANG': 'en_US.UTF-8', 13:15:08 INFO - 'LANGUAGE': 'en_US:en', 13:15:08 INFO - 'LOGNAME': 'cltbld', 13:15:08 INFO - 'MAIL': '/var/mail/cltbld', 13:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:08 INFO - 'MOZ_NO_REMOTE': '1', 13:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:08 INFO - 'NO_EM_RESTART': '1', 13:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:08 INFO - 'PWD': '/builds/slave/test', 13:15:08 INFO - 'SHELL': '/bin/bash', 13:15:08 INFO - 'SHLVL': '1', 13:15:08 INFO - 'TERM': 'linux', 13:15:08 INFO - 'TMOUT': '86400', 13:15:08 INFO - 'USER': 'cltbld', 13:15:08 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:08 INFO - '_': '/tools/buildbot/bin/python'} 13:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:08 INFO - Downloading/unpacking flake8 13:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:15:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:15:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:11 INFO - no previously-included directories found matching 'docs/_build' 13:15:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:15:11 INFO - Running setup.py install for pep8 13:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:11 INFO - no previously-included directories found matching 'docs/_build' 13:15:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:15:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:15:11 INFO - Cleaning up... 13:15:11 INFO - Return code: 0 13:15:11 INFO - Running post-action listener: _resource_record_post_action 13:15:11 INFO - Running post-action listener: _start_resource_monitoring 13:15:11 INFO - Starting resource monitoring. 13:15:11 INFO - ##### 13:15:11 INFO - ##### Running install step. 13:15:11 INFO - ##### 13:15:11 INFO - Running pre-action listener: _resource_record_pre_action 13:15:11 INFO - Running main action method: install 13:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:11 INFO - Reading from file tmpfile_stdout 13:15:11 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:11 INFO - Reading from file tmpfile_stdout 13:15:11 INFO - Output received: 13:15:11 INFO - Usage: mozinstall [options] installer 13:15:11 INFO - Options: 13:15:11 INFO - -h, --help show this help message and exit 13:15:11 INFO - -d DEST, --destination=DEST 13:15:11 INFO - Directory to install application into. [default: 13:15:11 INFO - "/builds/slave/test"] 13:15:11 INFO - --app=APP Application being installed. [default: firefox] 13:15:11 INFO - mkdir: /builds/slave/test/build/application 13:15:11 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'] 13:15:11 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 13:15:28 INFO - Reading from file tmpfile_stdout 13:15:28 INFO - Output received: 13:15:28 INFO - /builds/slave/test/build/application/firefox/firefox 13:15:28 INFO - Running post-action listener: _resource_record_post_action 13:15:28 INFO - ##### 13:15:28 INFO - ##### Running run-tests step. 13:15:28 INFO - ##### 13:15:28 INFO - Running pre-action listener: _resource_record_pre_action 13:15:28 INFO - Running main action method: run_tests 13:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:15:28 INFO - Python 2.7.3 13:15:28 INFO - Return code: 0 13:15:28 INFO - grabbing minidump binary from tooltool 13:15: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')]} 13:15:28 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 0x2942410>, '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 0x2943310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29437a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:15:28 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 13:15:28 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 13:15:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:15:28 INFO - Return code: 0 13:15:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:15:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:15:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:15:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:15:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:15:29 INFO - Return code: 0 13:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:15:29 INFO - Using env: {'DISPLAY': ':0', 13:15:29 INFO - 'HOME': '/home/cltbld', 13:15:29 INFO - 'LANG': 'en_US.UTF-8', 13:15:29 INFO - 'LANGUAGE': 'en_US:en', 13:15:29 INFO - 'LOGNAME': 'cltbld', 13:15:29 INFO - 'MAIL': '/var/mail/cltbld', 13:15:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:15:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:29 INFO - 'MOZ_NO_REMOTE': '1', 13:15:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:29 INFO - 'NO_EM_RESTART': '1', 13:15:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:29 INFO - 'PWD': '/builds/slave/test', 13:15:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:15:29 INFO - 'SHELL': '/bin/bash', 13:15:29 INFO - 'SHLVL': '1', 13:15:29 INFO - 'TERM': 'linux', 13:15:29 INFO - 'TMOUT': '86400', 13:15:29 INFO - 'USER': 'cltbld', 13:15:29 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683', 13:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:29 INFO - '_': '/tools/buildbot/bin/python'} 13:15:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:15:29 INFO - mozversion application_buildid: 20160418103109 13:15:29 INFO - mozversion application_changeset: d53b301a14e1dfa05324072a7159796a4f5e24c7 13:15:29 INFO - mozversion application_display_name: Nightly 13:15:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:15:29 INFO - mozversion application_name: Firefox 13:15:29 INFO - mozversion application_remotingname: firefox 13:15:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:15:29 INFO - mozversion application_vendor: Mozilla 13:15:29 INFO - mozversion application_version: 48.0a1 13:15:29 INFO - mozversion platform_buildid: 20160418103109 13:15:29 INFO - mozversion platform_changeset: d53b301a14e1dfa05324072a7159796a4f5e24c7 13:15:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:15:29 INFO - mozversion platform_version: 48.0a1 13:15:29 INFO - using testdate: 1461010529 13:15:29 INFO - actual date: 1461010529 13:15:29 INFO - starting webserver on 'localhost:48833' 13:15:29 INFO - SUITE-START | Running 2 tests 13:15:29 INFO - TEST-START | dromaeo_css 13:15:29 INFO - operating with platform_type : linux_ 13:15:29 INFO - Initialising browser for dromaeo_css test... 13:15:29 INFO - TEST-INFO | started process 7740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp98Rhox/profile http://localhost:48833/getInfo.html) 13:15:33 INFO - PROCESS | 7740 | 13:15:33 INFO - PROCESS | 7740 | (process:7813): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:15:33 INFO - PROCESS | 7740 | __metrics Screen width/height:1600/1200 13:15:33 INFO - PROCESS | 7740 | colorDepth:24 13:15:33 INFO - PROCESS | 7740 | Browser inner width/height: 1024/697 13:15:33 INFO - PROCESS | 7740 | __metrics 13:15:34 ERROR - PROCESS | 7740 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:15:35 INFO - TEST-INFO | 7740: exit 0 13:15:35 INFO - Browser initialized. 13:15:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:15:35 INFO - TEST-INFO | started process 7864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp98Rhox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:36 INFO - PROCESS | 7864 | 13:15:36 INFO - PROCESS | 7864 | (process:7923): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:15:46 INFO - PROCESS | 7864 | RSS: Main: 163459072 13:15:46 INFO - PROCESS | 7864 | 13:16:36 INFO - PROCESS | 7864 | 1461010596473 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] 13:18:44 INFO - PROCESS | 7864 | Cycle 1(1): loaded http://localhost:48833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48833/tests/dromaeo/cssquery-ext.html) 13:18:45 INFO - PROCESS | 7864 | RSS: Main: 168726528 13:18:45 INFO - PROCESS | 7864 | 13:21:47 INFO - PROCESS | 7864 | Cycle 1(1): loaded http://localhost:48833/tests/dromaeo/cssquery-ext.html (next: http://localhost:48833/tests/dromaeo/cssquery-jquery.html) 13:21:48 INFO - PROCESS | 7864 | RSS: Main: 165629952 13:21:48 INFO - PROCESS | 7864 | 13:24:49 INFO - PROCESS | 7864 | Cycle 1(1): loaded http://localhost:48833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48833/tests/dromaeo/cssquery-mootools.html) 13:24:50 INFO - PROCESS | 7864 | RSS: Main: 166289408 13:24:50 INFO - PROCESS | 7864 | 13:27:52 INFO - PROCESS | 7864 | Cycle 1(1): loaded http://localhost:48833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48833/tests/dromaeo/cssquery-prototype.html) 13:27:52 INFO - PROCESS | 7864 | RSS: Main: 164315136 13:27:52 INFO - PROCESS | 7864 | 13:30:55 INFO - PROCESS | 7864 | Cycle 1(1): loaded http://localhost:48833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48833/tests/dromaeo/cssquery-yui.html) 13:30:55 INFO - PROCESS | 7864 | RSS: Main: 164970496 13:30:55 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | Cycle 1(1): loaded http://localhost:48833/tests/dromaeo/cssquery-yui.html (next: http://localhost:48833/tests/dromaeo/cssquery-dojo.html) 13:33:58 INFO - PROCESS | 7864 | RSS: Main: 167104512 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | __start_tp_report 13:33:58 INFO - PROCESS | 7864 | _x_x_mozilla_page_load 13:33:58 INFO - PROCESS | 7864 | _x_x_mozilla_page_load_details 13:33:58 INFO - PROCESS | 7864 | |i|pagename|runs| 13:33:58 INFO - PROCESS | 7864 | |0;dojo.html;3080.522519009553;3121.001279590532;3128.5463607776865;3163.4938409854426;3164.88922887699;5471.343438787346;5473.972630136844;5477.986572484083;5504.422035686255;5543.41794111618;5367.06076436624;5467.644603100795;5528.640638358514;5552.278203833496;5600.4959553640165;4957.355543779304;4982.701037937717;4999.925001124968;5030.496950304959;5066.088104141253;4931.679440836334;5104.234364845266;5138.895137545427;5139.280500729901;5140.845774626749;4929.383827021605;5006.69959802413;5020.548150666421;5024.723640199788;5062.164742817431;5008.24876268559;5026.195808670632;5028.522290382444;5038.899222015576;5102.387713474407;4986.351774269358;4987.351644286256;4994.950050499485;5006.324146240284;5034;5236.9738151309;5436.782528698847;5480.232767412565;5504.697241651707;5531.25328080708;5764.481196692318;5779.971100144472;5787.33445653751;5789.942100578983;5802.245708057925;5827.038538641119;5836.88326233473;5839.970800146015;5847.736851841677;5871.383504731984;5498.5876059295315;5573.721313934287;5581.302337207849;5598.24423702799;5623.044082505984;6020.638761674313;6041.788537401258;6053.818385448443;6063.818085457443;6081.422264884829;5657.660540367591;5783.334916484658;5810;5839.708014599253;5843.18195452637;5844.59087863854;5846;5864.882702346014;5882.23530940975;5929.080992446177;5757.596968212269;5794.159846822187;5815.447532484407;5839.766409343663;5844.327902291206;5750.539956803445;5860.677662728591;5938.910916336258;5939.910901336483;5944.346121926585;4431.379606855043;4494.07871386365;4496.280595104833;4523.5250298718165;4524.9547504524535;3919.862804801818;3922.5685174630767;3936.4488971544006;3947.973526883031;3985;5418.214358917935;5540.584456165723;5558.305211848519;5559.972200138974;5563.944360556424;5962.07587823888;5963.105534169822;5991.670458124845;5995.130706047686;5998.640081595031;5472.315960504937;5517.779288828482;5518.641288316327;5521.4478552144465;5524.364698059694;4989.226669866177;4995.25071239317;5015.498450154955;5036;5057.797688092509;6104.0347610180015;6112.449879510866;6184.072389141665;6190.938090619126;6196.349383314777;5988.682489852225;5994.10088486713;5997.370276121119;6003.099535069775;6007.549433792483;5952.851178720393;5997.460228579449;6095.939040609537;6135.754569817157;6157.291911430064;5770.682612456355;5781.075027995501;5782.653040817564;5784.8553786154;5798.739056742373;5814.418558144152;5879.265091863517;5884.411558844081;5885.764569417175;5895.351511333835;5609.663420194802;5680.971595141998;5714.742836572281;5728.656280623176;5735.168400581809;5635.915461268002;5645.209670646031;5699.971500142473;5736.512396446349;5749.885002300014;5644.520215781705;5647.802326918538;5661.57538184646;5713.257276554022;5722.113072473773;5684.232628595087;5775.075987842093;5794.18881356602;5816.098504731774;5855.560832937632;5621.5221706155435;5649.971750141387;5652.830415087554;5663.688497132697;5700.116481945305 13:33:58 INFO - PROCESS | 7864 | |1;ext.html;590.681032242589;649.1755470552396;655.4068567946008;659.8944168932971;682.8736683713516;35386.292274154504;36687;36872.81563592182;36873.44689829651;36970.26059478809;36500.817495912546;36733.26533469336;37106.257874842486;37328.999999999935;37408.625913740856;8260.876086858701;8396.160383961616;8424.157584241588;8436.915630843705;8451;8378.539180345078;8615.353848461391;8615.95692021539;8637.52493612851;8641.438306510088;8601.096884827097;8614.396992210548;8666.739997800045;8675.305975521975;8696.956515217415;8609;8622.310215182802;8677.522736249504;8678.045415004344;8685.131486851327;8553.615087321086;8610.225079742791;8625.56872156396;8629.30965522763;8685.652573897036;31978.360432791214;38218.61781382179;38651.42022869631;38655;38745.41881871746;3328.8242085494912;3411.9829400852836;3505.333986542574;3548.520949671787;3652.013956231829;27316.45367092667;27627.86186069057;27636;27791.30521736973;28512.857435712896;3866.516685414323;3890.2997460457104;3934.881953541398;3964.385520244338;4028.8187031583648;190157;190220;191312;191634;239585;34373;34417.13957151041;34439.48340774891;35893;36981.44527832085;34865.47701784475;34955;35011.824940875646;35055.123621909144;35093;14244.85755142456;14449.927750361181;14480.782788258184;14520.273986300643;14532.854671453362;12735.808962865565;12804.551840685532;12853.93573032129;12862.807057894139;12881;8575.485470871768;8601;8623;8632.654693812303;8657.610407531676;3289.7697161198485;3321.5515905352468;3330.7834990725523;3332.900012999614;3414.2317978455144;1055.5988724284723;1064.41989115932;1098.74728812372;1146.4267866066966;1168.5617893290016;31863.88476403361;32572.837135814643;32918.835405822814;32988.3402331952;33187.50218746721;1132.1226049811462;1159.9362035087981;1199.2324912056117;1233.0443905972943;1237.3132911234352;16678.916605416896;17112.65774684524;17225.7416138758;17251.82748172502;17516.38692645751;196373;521856;530921;533961;540297;55627.44372556303;56535.71732141313;56871;56877.71561142168;56924.71537642368;1475.0043720488627;1477.6896851661272;1481.7990995527584;1502.9398824047134;1505.8870584706192;29722.40555188841;32415.379231038827;32624;32759;33006;51256.74371628118;52362.21456678229;52438.756124387255;52542;52683.47316526786;416885;418143;424325;424550;424837;44001.57991310381;44545.55454445544;44548.32242614479;46387.304190436495;48511.51488485211;49220.507794923025;49312.26031609457;49417;50499.74750126226;50535;39519;39906.80046599748;41118.79440602778;41184.58815411808;42337.78831105825;36617;37544.249115018094;37572.62427375691;37657;37689.62310376861;37246.44130338101;37291.81354093212;38103.42844857274;38146.237075257784;38634;32900.50649240311;33398.833005834815;33414.832925836185;35601.46597800983;35856.28287434289;27369.86315068412;27790.305242369104;27871.770258379685;27977.720222798325;28056.859715702107 13:33:58 INFO - PROCESS | 7864 | |2;jquery.html;394.3965732429383;403.243917654398;403.6730248498716;405.45061441746435;416.3712793681542;13792.448302067905;18526;18581.163847626856;19368.99999999998;19371.41885743428;16529.91735041326;18089.366872159477;18639.627207455844;18667.533311667215;18830.905845470752;5491.093969495038;5536.114221724525;5588.497035266825;5667.121596152603;5714.71426428679;5209.088409528336;5529.944700552983;5546.362168350651;5546.86132846678;5585.609007369486;5496.697681627509;5502.477264659871;5508.9724551377185;5517.310336207974;5532.225488431623;5418.810341638044;5792.507636850873;5836.299644042742;5839.153322768175;5844.298684157907;5421.430749771296;5539.584531160179;5574.080276754331;5609.130584759328;5614;13699.178049317074;13803.792943105862;13941.930290348484;14029.158250505003;16604.83395166045;2303.1478353009325;2373.086361750721;2382.2972223194024;2492.6011838105815;2774.7918906082123;10290.639827606074;10348.58605655773;10438.63464778729;10586.735331616694;10667.466626668636;1906.8569857260622;1924.6439408709434;1924.6631839428044;1965.7346258255095;2000.98999505003;65776;74606;80406.59796701037;83630;86458;10394.532246048946;10659.84010239847;10722.303050301705;10940.726481838017;10970;15292.694146117015;15322.923385383001;15362.462313818962;15402.22988850553;15446.613834654;8036.638351274207;8256.8348633027;8295.04606970206;8356.582170891432;8432.831343373098;7991.640376183086;8072;8138.715144969898;8160.224778646019;8269.379796515286;4521.909561808811;4611.5619016193405;4662.976685116552;4726.26742854858;4735;1943.6987266973642;1961.568454939911;1978.7449645333345;2033.7356143701224;2054.9381421681587;982.7297493189287;1010.6664800615779;1081.4031429209863;1095.3646884806951;1112.2770199370475;17843.553911152067;17868.481179099923;18279.817201827813;18612.720809187875;18635.81364186368;1017.7404761785697;1032.396048311746;1052.936823790575;1060.4326685223368;1068.4924660786219;9977.351472154432;10263.076323130954;10275.588976441008;10286.588536458608;10303.072723454925;450370;455930;464724;472981;475279;76773.61613191899;92399;95683.52158239164;96625.51687241519;96778;1029.341221618165;1046.9057784799252;1052.0741747262514;1053.0101704397841;1054.6361505280665;16134;16386.83613163853;16510.66978660396;16679.16604169811;16855.66288674195;37413;39062;39215.60784392119;39248.60751392449;39494.40758388684;54086.459135409714;55267.17099243595;55866;56076;56092.71953640206;7971.880421793794;8369.790755231168;8430.747077587683;8593.785155371166;8672.609732561923;9506.47714375716;11938.403079845799;13013.151166427419;13045.478180872658;13054.15148015376;11889.643310700692;11899.167058305835;11950.880491194977;12017.579384721494;12153.453094610586;11564.710882228012;11691.123165762772;11870.169088163746;11928;12086.879131208927;11873.881261187278;12122.27266364021;12408.62774116778;12520;12588.559400420942;8600.78498037554;8643.17889800468;8822.823543528964;8899.866502002345;8927.910720892707;8732.25775809038;10668.466576671291;11186.832197517206;11196.104311654884;11488.425578720864 13:33:58 INFO - PROCESS | 7864 | |3;mootools.html;1531.448678475749;1551.3174203350525;1728.3345911823944;1789.7673302470678;1818.0273553648808;7674.46278760487;8030.638621262043;8109.797255068619;8361.080281169074;8389.370797190213;7768.262015108569;7785.0657921049415;7818.296353328199;7839.882401763978;7888.881666775003;2319.8144148468123;2346.765323467657;2348.9060437582475;2351.130081869702;2368.265837590344;2276.8975396107217;2281.7147856517936;2348.823838212132;2350.670906073151;2357.316378250305;2341.285907798121;2347.730011048726;2366.92899213023;2370.9170179043736;2384.141708984773;2279.1453205048106;2282.9657555136687;2295.931122066341;2300;2345.026813872241;2308.4575124845646;2309.030207312916;2309.4919117794057;2314.745378008418;2315.8378913476063;8189.71336003243;8237.423380363376;8290.792730181733;8336.166383361677;8353;5086.77109530072;5272.789088436458;5281.287026251445;5313.654612450178;5330.360356757175;3222.983885080583;3225.6935591118804;3243.2378391078314;3311.1391038329966;3373.122988023107;1140.737630345017;1173.9413029348584;1180.6930198148457;1197.2696655040418;1207.704112492445;11045.613403530919;11155.442227888572;11157.051650609708;11193.49629266685;11237.3257604544;4342.891427714269;4625.722456652612;4628.166929952641;4631.282151266491;4641.767911604406;9090.090990900857;9154.084591540926;9205.907940920504;9218.262538996863;9221.17009469151;5188.610854185951;5198.7140707260705;5202.713850738246;5210.635255532076;5236.136037553761;4273.18809426208;4836.443808961944;4842.903141937141;4847.297141914402;4885.877853053702;3679.0986208379118;3707.2214834884976;3769.453429252743;3810.7523011004196;3824.0631045394057;1137.175547727907;1149.8102813035755;1154.3362566524281;1154.572808061023;1173.8004539228352;839.2195258409738;857.3826844671827;889.2441424788877;926.4348747264163;1011.9342242754198;5775.942240577624;5832.62087964281;5962.522998160137;5996.910046349309;6112.388761123852;451.5439406199762;457.3277282394941;461.6560662306603;461.7760386212684;468.0241696063677;4077.662153668126;4099.2416402964955;4129.628333450004;4138.710290279711;4166.187593419315;9612.75968100803;10112.544935477921;10181.287309888237;10253.692389228336;10291.279610427198;9992.700218993441;10070.295079344522;10082.193424526167;10151.847722284172;10184.134348580306;7772.183920688246;7774.1837107104075;7814.179511151361;7814.921850781533;7875.488093273919;5559.972200138974;5633.436656334334;5679.517241034393;5764.538836892954;5811.128330750252;9348.672796452092;9371;9409.952950235478;9457.527123643928;9509;9262;9285.907140928504;9566.234701223746;9568.904310956801;9656.275779316438;6473.287938326875;6683.4319082876555;6815.42068924147;6831;7007.859842803014;7779.533228006338;7834.6866125354345;7905.841883162419;7945.761627151194;8002.279794818494;7131;7306.232845551353;7312.96343518279;7373.078365204349;7404.592747398945;7158.319959604038;7205.459590530626;7218.566885986857;7315.231900650568;7381.188069312264;6407.551471397144;6412.903806443001;6434.195725534309;6481.092647029325;6482.060101285381;5082.263071854486;5088.618353623419;5097.08252514551;5210.869728256824;5234.895302093861;5076.390833100052;5178.119719647744;5245.711485868162;5252.527272545489;5289.523942845162 13:33:58 INFO - PROCESS | 7864 | |4;prototype.html;320.54395337542496;335.1654380592326;337.6319811405569;344.06586118687767;348.3607580090534;6006.729697163627;6038.698065096744;6066.787662431816;6110.114033465151;6146.938530614692;6108.511319094473;6117.235345581802;6120;6133.754649814014;6134.478569321613;4660.673752837302;4662.067586482709;4672.084445377396;4676.900928281851;4700.811967521295;4365.4106695596165;4542.523035081318;4576.336431217472;4608.124456353299;4672.275797251415;4547.63618910488;4556.111558246143;4567.497575266718;4580.702254353473;4582.77086145693;4571.291449825282;4572.15415148197;4578.908421831561;4586.65600079992;4601.953980460219;3898.493195884517;3902.1415288636454;3929.25344184604;3932.8033598320258;3998.7200895937294;5742.196092547005;5764.250647415851;5792.189093526909;5805.158252053428;5827.446392592697;5179.637425380225;5219.11275083233;5247.6385626468245;5258.50044245796;5271.446498117681;6163.938360616381;6201.596896201732;6274.623522588659;6303.8739225215695;6344.238691357021;4397.340398940152;4414.933775993362;4415.536368681274;4423.491298500681;4437.600615944581;6258.311585725612;6486.124373209604;6611.570247933869;6656.101426307435;6673.6663166841945;4385.3641222022625;4437.245668236407;4441.200583894865;4469.5306992765945;4481.977590112028;4560.475545312265;4571.9085618287445;4577;4584.174848527297;4600.102979918951;4882.902341953141;5303.374829459365;5305.124654431976;5306.230596563554;5311.840644780663;6163.476104531165;6269.373062693694;6356.809295721136;6375.298717141203;6383.616982981036;1550.1629120275152;1581.7469204927156;1584.4533635895598;1586.309955169505;1589.0703938196054;992.4045572656348;1006.642641862143;1025.9692209233735;1055.4406164732704;1055.8257887448638;6209.5032397408095;6212.254529456403;6224.595401298901;6224.688765561704;6234.096056071844;6427.646479443582;6558.475321974231;6592.76925307612;6599.307072757291;6637.767678131242;5950.67271300074;6141;6192.287886893065;6195.535334849904;6199.659018754011;3500.1074725944723;3506.544149260631;3543.3799085159994;3545.858165673396;3560.1633616100194;6622.437092847065;6824.931750682529;6837.025893736141;6853.554518956252;6883.793486195422;6685.799426017227;6699.263081061079;6702.128723265944;6715;6748.696308666122;6600.339966003361;6782.016607591871;6838.316168383221;6848.14398200225;6848.9726541019245;6558.04908288286;6576.342365763386;6597.373249541286;6612.636305003271;6622.801315960529;6279.434850863444;6454.643585335693;6474.741010359533;6483.740650373932;6528.510361722985;6762.526623136333;6843.794686159423;6856.348646878539;6863.897041544281;6881.174259088942;4466.106778644349;4486.439195100613;4512.548745125461;4525;4528.796204170886;6327.462165715966;6445.614192948538;6594.802155935329;6630.811832095494;6702.056403642889;6383.904241436289;6385.233771947396;6426.361277874113;6436.806895793134;6441.098246245436;6231.158793562811;6427.292997770148;6430.614163150226;6431.389018043278;6440;6228.5951413158;6304.65324407162;6306.337834527492;6306.842328941813;6324.557280990471;6441.967790161019;6452.128962590178;6455.580387274812;6456.063870738811;6459.773907913201;6160.395045029443;6252.468540174136;6288.182536270256;6303.590266632654;6313.96843015782 13:33:58 INFO - PROCESS | 7864 | |5;yui.html;846.3736834742291;859.5745106172445;867.1025488619276;869.890142739705;871.1767379826063;14177.078489898162;14730.852691473083;14954.775678364833;14992.775108373356;15019.92490037551;13796.517121900735;13857.4457021719;13860.237686927216;13867.098638588484;13933.44266229352;812.5449748141045;819.2217393476192;828.8715249136394;848.3806821020659;852.7058164933119;822.6997146041712;835.3108685334593;835.6156168162622;837.1210229259284;837.9706710265142;877.903430622631;881.0968757024037;885.8538341173698;886.366248132585;889.7864512517014;864.3603733237422;871.5859966515886;873.7466134820926;883.2624758326805;884.2528063786091;636.6116668832055;637.2416823979496;641.7304732012566;644.0596728775993;645.8901986662279;13990.16059036461;14007.509737159253;14055.156690598495;14064.859351406458;14067.2966351682;13775.448982040707;13941.721165576733;13941.930290348584;13955.302234888215;13957.232352220624;10788.298760580616;10923.289986150954;10938.671839844817;10993.560257589686;11091.168162387854;3681.4845921571;3707.8516859325596;3765.190484045916;3803.82882770276;3862.0344913771555;48126.759366203296;52611.47388526104;54366.99999999961;54402.455975440134;56357.43642563563;11260.549578016951;11307.886921130683;11571.594994175164;11627.360495172847;11746.823797643043;21174.364769056952;21231.78768212329;21379.968902954195;21442.249521266993;21460.463488412603;8193.959030204811;8211.671533138728;8242.835143297221;8337.458065225863;8566;4283.250431174532;4361.781910904442;4378.78106094694;4380.496242932039;4390.385346051556;3201.8399080045906;3287.375398674244;3291.341731653679;3295.423300922377;3338.1821453743987;630.8233694565529;641.9518536109717;646.2309851276965;652.6019128331714;653.8347058239848;688.3288793426369;712.7576623947882;732.8900664900201;749.6851322444586;776.4836383804819;8778.648854045767;8781.604827782765;8847.823043539092;8872.822543549093;8988.191062804379;597.8475488750341;627.7834147219202;726.7456390263471;739.5230076600562;747.5477336211623;4109.856155034559;4246.214450326699;4309.59058889405;4338.761368124783;4359.978200108979;59778.40221597815;62400;62561.374386256466;62668;62769.37230627727;51307.23039154416;52137.47862521402;54408.45591544113;54524.45475545273;55636.443635563934;42612;43778.7811060949;43905.24379024867;44217.33673994893;49971.500284996684;8580.356473264404;8675.436096653697;8702.260307873901;8716.564171791259;8837.91162088371;30782.076537703906;30994;31413.371732565676;31471;32841.17897052593;40887;44960;45064.774676126406;45346.31980520361;45668.54331456643;11299.943500282774;11301.830472542753;11557.479913404086;11759.76480470403;11938.880611193777;13257.469701211843;13264.933675331562;13290.534831280858;13318.400671969592;13442.865571344553;12448.439820207932;12717.872821271669;12801.29592872401;12805.231686098863;13547.796783048065;12075.094367922617;12361.443735032126;12660.936695316464;12702.745945081231;12893.161944473579;12041.759164816829;12535.561255356384;12571.87428125707;12602.810957835824;12627.747445050863;10583.5237414315;10631.149508039493;10755.569777208824;10797.676069717922;10885.891141088488;10411.687649370531;10785.946070269598;10809.837852432378;10831.404272764757;10867.836982445428 13:33:58 INFO - PROCESS | 7864 | __end_tp_report 13:33:58 INFO - PROCESS | 7864 | __start_cc_report 13:33:58 INFO - PROCESS | 7864 | _x_x_mozilla_cycle_collect,347 13:33:58 INFO - PROCESS | 7864 | __end_cc_report 13:33:58 INFO - PROCESS | 7864 | __startTimestamp1461011638285__endTimestamp 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | ------- Summary: start ------- 13:33:58 INFO - PROCESS | 7864 | Number of tests: 6 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | [#0] dojo.html Cycles:165 Average:5460.42 Median:5652.83 stddev:630.93 (11.2%) stddev-sans-first:604.61 13:33:58 INFO - PROCESS | 7864 | Values: 3080.5 3121.0 3128.5 3163.5 3164.9 5471.3 5474.0 5478.0 5504.4 5543.4 5367.1 5467.6 5528.6 5552.3 5600.5 4957.4 4982.7 4999.9 5030.5 5066.1 4931.7 5104.2 5138.9 5139.3 5140.8 4929.4 5006.7 5020.5 5024.7 5062.2 5008.2 5026.2 5028.5 5038.9 5102.4 4986.4 4987.4 4995.0 5006.3 5034.0 5237.0 5436.8 5480.2 5504.7 5531.3 5764.5 5780.0 5787.3 5789.9 5802.2 5827.0 5836.9 5840.0 5847.7 5871.4 5498.6 5573.7 5581.3 5598.2 5623.0 6020.6 6041.8 6053.8 6063.8 6081.4 5657.7 5783.3 5810.0 5839.7 5843.2 5844.6 5846.0 5864.9 5882.2 5929.1 5757.6 5794.2 5815.4 5839.8 5844.3 5750.5 5860.7 5938.9 5939.9 5944.3 4431.4 4494.1 4496.3 4523.5 4525.0 3919.9 3922.6 3936.4 3948.0 3985.0 5418.2 5540.6 5558.3 5560.0 5563.9 5962.1 5963.1 5991.7 5995.1 5998.6 5472.3 5517.8 5518.6 5521.4 5524.4 4989.2 4995.3 5015.5 5036.0 5057.8 6104.0 6112.4 6184.1 6190.9 6196.3 5988.7 5994.1 5997.4 6003.1 6007.5 5952.9 5997.5 6095.9 6135.8 6157.3 5770.7 5781.1 5782.7 5784.9 5798.7 5814.4 5879.3 5884.4 5885.8 5895.4 5609.7 5681.0 5714.7 5728.7 5735.2 5635.9 5645.2 5700.0 5736.5 5749.9 5644.5 5647.8 5661.6 5713.3 5722.1 5684.2 5775.1 5794.2 5816.1 5855.6 5621.5 5650.0 5652.8 5663.7 5700.1 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | [#1] ext.html Cycles:180 Average:51504.64 Median:37176.35 stddev:103634.97 (278.8%) stddev-sans-first:103855.19 13:33:58 INFO - PROCESS | 7864 | Values: 590.7 649.2 655.4 659.9 682.9 35386.3 36687.0 36872.8 36873.4 36970.3 36500.8 36733.3 37106.3 37329.0 37408.6 8260.9 8396.2 8424.2 8436.9 8451.0 8378.5 8615.4 8616.0 8637.5 8641.4 8601.1 8614.4 8666.7 8675.3 8697.0 8609.0 8622.3 8677.5 8678.0 8685.1 8553.6 8610.2 8625.6 8629.3 8685.7 31978.4 38218.6 38651.4 38655.0 38745.4 3328.8 3412.0 3505.3 3548.5 3652.0 27316.5 27627.9 27636.0 27791.3 28512.9 3866.5 3890.3 3934.9 3964.4 4028.8 190157.0 190220.0 191312.0 191634.0 239585.0 34373.0 34417.1 34439.5 35893.0 36981.4 34865.5 34955.0 35011.8 35055.1 35093.0 14244.9 14449.9 14480.8 14520.3 14532.9 12735.8 12804.6 12853.9 12862.8 12881.0 8575.5 8601.0 8623.0 8632.7 8657.6 3289.8 3321.6 3330.8 3332.9 3414.2 1055.6 1064.4 1098.7 1146.4 1168.6 31863.9 32572.8 32918.8 32988.3 33187.5 1132.1 1159.9 1199.2 1233.0 1237.3 16678.9 17112.7 17225.7 17251.8 17516.4 196373.0 521856.0 530921.0 533961.0 540297.0 55627.4 56535.7 56871.0 56877.7 56924.7 1475.0 1477.7 1481.8 1502.9 1505.9 29722.4 32415.4 32624.0 32759.0 33006.0 51256.7 52362.2 52438.8 52542.0 52683.5 416885.0 418143.0 424325.0 424550.0 424837.0 44001.6 44545.6 44548.3 46387.3 48511.5 49220.5 49312.3 49417.0 50499.7 50535.0 39519.0 39906.8 41118.8 41184.6 42337.8 36617.0 37544.2 37572.6 37657.0 37689.6 37246.4 37291.8 38103.4 38146.2 38634.0 32900.5 33398.8 33414.8 35601.5 35856.3 27369.9 27790.3 27871.8 27977.7 28056.9 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | [#2] jquery.html Cycles:180 Average:27640.72 Median:2179.04 stddev:76621.48 (3516.3%) stddev-sans-first:76809.11 13:33:58 INFO - PROCESS | 7864 | Values: 394.4 403.2 403.7 405.5 416.4 13792.4 18526.0 18581.2 19369.0 19371.4 16529.9 18089.4 18639.6 18667.5 18830.9 5491.1 5536.1 5588.5 5667.1 5714.7 5209.1 5529.9 5546.4 5546.9 5585.6 5496.7 5502.5 5509.0 5517.3 5532.2 5418.8 5792.5 5836.3 5839.2 5844.3 5421.4 5539.6 5574.1 5609.1 5614.0 13699.2 13803.8 13941.9 14029.2 16604.8 2303.1 2373.1 2382.3 2492.6 2774.8 10290.6 10348.6 10438.6 10586.7 10667.5 1906.9 1924.6 1924.7 1965.7 2001.0 65776.0 74606.0 80406.6 83630.0 86458.0 10394.5 10659.8 10722.3 10940.7 10970.0 15292.7 15322.9 15362.5 15402.2 15446.6 8036.6 8256.8 8295.0 8356.6 8432.8 7991.6 8072.0 8138.7 8160.2 8269.4 4521.9 4611.6 4663.0 4726.3 4735.0 1943.7 1961.6 1978.7 2033.7 2054.9 982.7 1010.7 1081.4 1095.4 1112.3 17843.6 17868.5 18279.8 18612.7 18635.8 1017.7 1032.4 1052.9 1060.4 1068.5 9977.4 10263.1 10275.6 10286.6 10303.1 450370.0 455930.0 464724.0 472981.0 475279.0 76773.6 92399.0 95683.5 96625.5 96778.0 1029.3 1046.9 1052.1 1053.0 1054.6 16134.0 16386.8 16510.7 16679.2 16855.7 37413.0 39062.0 39215.6 39248.6 39494.4 54086.5 55267.2 55866.0 56076.0 56092.7 7971.9 8369.8 8430.7 8593.8 8672.6 9506.5 11938.4 13013.2 13045.5 13054.2 11889.6 11899.2 11950.9 12017.6 12153.5 11564.7 11691.1 11870.2 11928.0 12086.9 11873.9 12122.3 12408.6 12520.0 12588.6 8600.8 8643.2 8822.8 8899.9 8927.9 8732.3 10668.5 11186.8 11196.1 11488.4 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | [#3] mootools.html Cycles:180 Average:5473.05 Median:5193.66 stddev:2988.97 (57.6%) stddev-sans-first:2982.68 13:33:58 INFO - PROCESS | 7864 | Values: 1531.4 1551.3 1728.3 1789.8 1818.0 7674.5 8030.6 8109.8 8361.1 8389.4 7768.3 7785.1 7818.3 7839.9 7888.9 2319.8 2346.8 2348.9 2351.1 2368.3 2276.9 2281.7 2348.8 2350.7 2357.3 2341.3 2347.7 2366.9 2370.9 2384.1 2279.1 2283.0 2295.9 2300.0 2345.0 2308.5 2309.0 2309.5 2314.7 2315.8 8189.7 8237.4 8290.8 8336.2 8353.0 5086.8 5272.8 5281.3 5313.7 5330.4 3223.0 3225.7 3243.2 3311.1 3373.1 1140.7 1173.9 1180.7 1197.3 1207.7 11045.6 11155.4 11157.1 11193.5 11237.3 4342.9 4625.7 4628.2 4631.3 4641.8 9090.1 9154.1 9205.9 9218.3 9221.2 5188.6 5198.7 5202.7 5210.6 5236.1 4273.2 4836.4 4842.9 4847.3 4885.9 3679.1 3707.2 3769.5 3810.8 3824.1 1137.2 1149.8 1154.3 1154.6 1173.8 839.2 857.4 889.2 926.4 1011.9 5775.9 5832.6 5962.5 5996.9 6112.4 451.5 457.3 461.7 461.8 468.0 4077.7 4099.2 4129.6 4138.7 4166.2 9612.8 10112.5 10181.3 10253.7 10291.3 9992.7 10070.3 10082.2 10151.8 10184.1 7772.2 7774.2 7814.2 7814.9 7875.5 5560.0 5633.4 5679.5 5764.5 5811.1 9348.7 9371.0 9410.0 9457.5 9509.0 9262.0 9285.9 9566.2 9568.9 9656.3 6473.3 6683.4 6815.4 6831.0 7007.9 7779.5 7834.7 7905.8 7945.8 8002.3 7131.0 7306.2 7313.0 7373.1 7404.6 7158.3 7205.5 7218.6 7315.2 7381.2 6407.6 6412.9 6434.2 6481.1 6482.1 5082.3 5088.6 5097.1 5210.9 5234.9 5076.4 5178.1 5245.7 5252.5 5289.5 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | [#4] prototype.html Cycles:180 Average:5325.72 Median:6153.67 stddev:1617.82 (26.3%) stddev-sans-first:1578.14 13:33:58 INFO - PROCESS | 7864 | Values: 320.5 335.2 337.6 344.1 348.4 6006.7 6038.7 6066.8 6110.1 6146.9 6108.5 6117.2 6120.0 6133.8 6134.5 4660.7 4662.1 4672.1 4676.9 4700.8 4365.4 4542.5 4576.3 4608.1 4672.3 4547.6 4556.1 4567.5 4580.7 4582.8 4571.3 4572.2 4578.9 4586.7 4602.0 3898.5 3902.1 3929.3 3932.8 3998.7 5742.2 5764.3 5792.2 5805.2 5827.4 5179.6 5219.1 5247.6 5258.5 5271.4 6163.9 6201.6 6274.6 6303.9 6344.2 4397.3 4414.9 4415.5 4423.5 4437.6 6258.3 6486.1 6611.6 6656.1 6673.7 4385.4 4437.2 4441.2 4469.5 4482.0 4560.5 4571.9 4577.0 4584.2 4600.1 4882.9 5303.4 5305.1 5306.2 5311.8 6163.5 6269.4 6356.8 6375.3 6383.6 1550.2 1581.7 1584.5 1586.3 1589.1 992.4 1006.6 1026.0 1055.4 1055.8 6209.5 6212.3 6224.6 6224.7 6234.1 6427.6 6558.5 6592.8 6599.3 6637.8 5950.7 6141.0 6192.3 6195.5 6199.7 3500.1 3506.5 3543.4 3545.9 3560.2 6622.4 6824.9 6837.0 6853.6 6883.8 6685.8 6699.3 6702.1 6715.0 6748.7 6600.3 6782.0 6838.3 6848.1 6849.0 6558.0 6576.3 6597.4 6612.6 6622.8 6279.4 6454.6 6474.7 6483.7 6528.5 6762.5 6843.8 6856.3 6863.9 6881.2 4466.1 4486.4 4512.5 4525.0 4528.8 6327.5 6445.6 6594.8 6630.8 6702.1 6383.9 6385.2 6426.4 6436.8 6441.1 6231.2 6427.3 6430.6 6431.4 6440.0 6228.6 6304.7 6306.3 6306.8 6324.6 6442.0 6452.1 6455.6 6456.1 6459.8 6160.4 6252.5 6288.2 6303.6 6314.0 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - PROCESS | 7864 | [#5] yui.html Cycles:180 Average:14520.78 Median:4324.18 stddev:16527.08 (382.2%) stddev-sans-first:16541.53 13:33:58 INFO - PROCESS | 7864 | Values: 846.4 859.6 867.1 869.9 871.2 14177.1 14730.9 14954.8 14992.8 15019.9 13796.5 13857.4 13860.2 13867.1 13933.4 812.5 819.2 828.9 848.4 852.7 822.7 835.3 835.6 837.1 838.0 877.9 881.1 885.9 886.4 889.8 864.4 871.6 873.7 883.3 884.3 636.6 637.2 641.7 644.1 645.9 13990.2 14007.5 14055.2 14064.9 14067.3 13775.4 13941.7 13941.9 13955.3 13957.2 10788.3 10923.3 10938.7 10993.6 11091.2 3681.5 3707.9 3765.2 3803.8 3862.0 48126.8 52611.5 54367.0 54402.5 56357.4 11260.5 11307.9 11571.6 11627.4 11746.8 21174.4 21231.8 21380.0 21442.2 21460.5 8194.0 8211.7 8242.8 8337.5 8566.0 4283.3 4361.8 4378.8 4380.5 4390.4 3201.8 3287.4 3291.3 3295.4 3338.2 630.8 642.0 646.2 652.6 653.8 688.3 712.8 732.9 749.7 776.5 8778.6 8781.6 8847.8 8872.8 8988.2 597.8 627.8 726.7 739.5 747.5 4109.9 4246.2 4309.6 4338.8 4360.0 59778.4 62400.0 62561.4 62668.0 62769.4 51307.2 52137.5 54408.5 54524.5 55636.4 42612.0 43778.8 43905.2 44217.3 49971.5 8580.4 8675.4 8702.3 8716.6 8837.9 30782.1 30994.0 31413.4 31471.0 32841.2 40887.0 44960.0 45064.8 45346.3 45668.5 11299.9 11301.8 11557.5 11759.8 11938.9 13257.5 13264.9 13290.5 13318.4 13442.9 12448.4 12717.9 12801.3 12805.2 13547.8 12075.1 12361.4 12660.9 12702.7 12893.2 12041.8 12535.6 12571.9 12602.8 12627.7 10583.5 10631.1 10755.6 10797.7 10885.9 10411.7 10785.9 10809.8 10831.4 10867.8 13:33:58 INFO - PROCESS | 7864 | -------- Summary: end -------- 13:33:58 INFO - PROCESS | 7864 | 13:33:58 INFO - TEST-INFO | 7864: exit 0 13:33:58 INFO - TEST-OK | dromaeo_css | took 1109394ms 13:33:58 INFO - TEST-START | kraken 13:33:58 INFO - operating with platform_type : linux_ 13:33:58 INFO - Initialising browser for kraken test... 13:33:58 INFO - TEST-INFO | started process 8103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeOoFbA/profile http://localhost:48833/getInfo.html) 13:34:02 INFO - PROCESS | 8103 | 13:34:02 INFO - PROCESS | 8103 | (process:8173): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:34:03 INFO - PROCESS | 8103 | __metrics Screen width/height:1600/1200 13:34:03 INFO - PROCESS | 8103 | colorDepth:24 13:34:03 INFO - PROCESS | 8103 | Browser inner width/height: 1024/697 13:34:03 INFO - PROCESS | 8103 | __metrics 13:34:03 ERROR - PROCESS | 8103 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:34:04 INFO - TEST-INFO | 8103: exit 0 13:34:04 INFO - Browser initialized. 13:34:04 INFO - Running cycle 1/1 for kraken test... 13:34:04 INFO - TEST-INFO | started process 8224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeOoFbA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:06 INFO - PROCESS | 8224 | 13:34:06 INFO - PROCESS | 8224 | (process:8284): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:34:16 INFO - PROCESS | 8224 | RSS: Main: 164028416 13:34:16 INFO - PROCESS | 8224 | 13:34:18 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48833/tests/kraken/driver.html?testName=audio-beat-detection) 13:34:19 INFO - PROCESS | 8224 | RSS: Main: 168275968 13:34:19 INFO - PROCESS | 8224 | 13:34:22 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48833/tests/kraken/driver.html?testName=audio-dft) 13:34:22 INFO - PROCESS | 8224 | RSS: Main: 172142592 13:34:22 INFO - PROCESS | 8224 | 13:34:25 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48833/tests/kraken/driver.html?testName=audio-fft) 13:34:26 INFO - PROCESS | 8224 | RSS: Main: 162004992 13:34:26 INFO - PROCESS | 8224 | 13:34:28 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48833/tests/kraken/driver.html?testName=audio-oscillator) 13:34:29 INFO - PROCESS | 8224 | RSS: Main: 162639872 13:34:29 INFO - PROCESS | 8224 | 13:34:31 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:34:32 INFO - PROCESS | 8224 | RSS: Main: 163868672 13:34:32 INFO - PROCESS | 8224 | 13:34:35 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48833/tests/kraken/driver.html?testName=imaging-darkroom) 13:34:35 INFO - PROCESS | 8224 | RSS: Main: 164175872 13:34:35 INFO - PROCESS | 8224 | 13:34:39 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48833/tests/kraken/driver.html?testName=imaging-desaturate) 13:34:40 INFO - PROCESS | 8224 | RSS: Main: 166383616 13:34:40 INFO - PROCESS | 8224 | 13:34:42 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48833/tests/kraken/driver.html?testName=json-parse-financial) 13:34:43 INFO - PROCESS | 8224 | RSS: Main: 166731776 13:34:43 INFO - PROCESS | 8224 | 13:34:45 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:34:45 INFO - PROCESS | 8224 | RSS: Main: 166772736 13:34:45 INFO - PROCESS | 8224 | 13:34:47 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:34:48 INFO - PROCESS | 8224 | RSS: Main: 166055936 13:34:48 INFO - PROCESS | 8224 | 13:34:50 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:34:50 INFO - PROCESS | 8224 | RSS: Main: 166490112 13:34:50 INFO - PROCESS | 8224 | 13:34:53 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:34:54 INFO - PROCESS | 8224 | RSS: Main: 166686720 13:34:54 INFO - PROCESS | 8224 | 13:34:57 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:34:57 INFO - PROCESS | 8224 | RSS: Main: 166588416 13:34:57 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | Cycle 1(1): loaded http://localhost:48833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48833/tests/kraken/driver.html?testName=ai-astar) 13:34:59 INFO - PROCESS | 8224 | RSS: Main: 168804352 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | __start_tp_report 13:34:59 INFO - PROCESS | 8224 | _x_x_mozilla_page_load 13:34:59 INFO - PROCESS | 8224 | _x_x_mozilla_page_load_details 13:34:59 INFO - PROCESS | 8224 | |i|pagename|runs| 13:34:59 INFO - PROCESS | 8224 | |0;ai-astar;112;107;112;111;112;123;113;111;112;119 13:34:59 INFO - PROCESS | 8224 | |1;audio-beat-detection;154;127;154;188;133;152;160;128;189;137 13:34:59 INFO - PROCESS | 8224 | |2;audio-dft;166;163;163;163;162;164;168;162;165;161 13:34:59 INFO - PROCESS | 8224 | |3;audio-fft;72;73;76;167;76;76;73;76;180;77 13:34:59 INFO - PROCESS | 8224 | |4;audio-oscillator;93;93;152;92;92;93;144;93;92;155 13:34:59 INFO - PROCESS | 8224 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;118 13:34:59 INFO - PROCESS | 8224 | |6;imaging-darkroom;147;147;147;147;146;171;147;147;146;147 13:34:59 INFO - PROCESS | 8224 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;95;95 13:34:59 INFO - PROCESS | 8224 | |8;json-parse-financial;59;59;58;57;63;67;57;78;55;57 13:34:59 INFO - PROCESS | 8224 | |9;json-stringify-tinderbox;62;62;62;62;62;62;61;61;62;62 13:34:59 INFO - PROCESS | 8224 | |10;stanford-crypto-aes;76;76;78;77;78;85;78;79;79;77 13:34:59 INFO - PROCESS | 8224 | |11;stanford-crypto-ccm;139;132;130;134;133;130;127;139;162;137 13:34:59 INFO - PROCESS | 8224 | |12;stanford-crypto-pbkdf2;173;172;186;176;168;167;169;172;171;171 13:34:59 INFO - PROCESS | 8224 | |13;stanford-crypto-sha256-iterative;70;68;71;72;68;68;68;69;68;69 13:34:59 INFO - PROCESS | 8224 | __end_tp_report 13:34:59 INFO - PROCESS | 8224 | __start_cc_report 13:34:59 INFO - PROCESS | 8224 | _x_x_mozilla_cycle_collect,879 13:34:59 INFO - PROCESS | 8224 | __end_cc_report 13:34:59 INFO - PROCESS | 8224 | __startTimestamp1461011699570__endTimestamp 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | ------- Summary: start ------- 13:34:59 INFO - PROCESS | 8224 | Number of tests: 14 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#0] ai-astar Cycles:10 Average:113.20 Median:112.00 stddev:4.52 (4.0%) stddev-sans-first:4.77 13:34:59 INFO - PROCESS | 8224 | Values: 112.0 107.0 112.0 111.0 112.0 123.0 113.0 111.0 112.0 119.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:154.00 stddev:22.42 (14.6%) stddev-sans-first:23.77 13:34:59 INFO - PROCESS | 8224 | Values: 154.0 127.0 154.0 188.0 133.0 152.0 160.0 128.0 189.0 137.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.11 (1.3%) stddev-sans-first:2.07 13:34:59 INFO - PROCESS | 8224 | Values: 166.0 163.0 163.0 163.0 162.0 164.0 168.0 162.0 165.0 161.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:41.73 (54.9%) stddev-sans-first:43.45 13:34:59 INFO - PROCESS | 8224 | Values: 72.0 73.0 76.0 167.0 76.0 76.0 73.0 76.0 180.0 77.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.50 stddev:28.03 (30.3%) stddev-sans-first:29.06 13:34:59 INFO - PROCESS | 8224 | Values: 93.0 93.0 152.0 92.0 92.0 93.0 144.0 93.0 92.0 155.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:34:59 INFO - PROCESS | 8224 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:147.00 stddev:7.67 (5.2%) stddev-sans-first:8.09 13:34:59 INFO - PROCESS | 8224 | Values: 147.0 147.0 147.0 147.0 146.0 171.0 147.0 147.0 146.0 147.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:34:59 INFO - PROCESS | 8224 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:59.00 stddev:6.91 (11.7%) stddev-sans-first:7.29 13:34:59 INFO - PROCESS | 8224 | Values: 59.0 59.0 58.0 57.0 63.0 67.0 57.0 78.0 55.0 57.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 13:34:59 INFO - PROCESS | 8224 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 61.0 61.0 62.0 62.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:2.58 (3.3%) stddev-sans-first:2.60 13:34:59 INFO - PROCESS | 8224 | Values: 76.0 76.0 78.0 77.0 78.0 85.0 78.0 79.0 79.0 77.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:135.50 stddev:9.87 (7.3%) stddev-sans-first:10.42 13:34:59 INFO - PROCESS | 8224 | Values: 139.0 132.0 130.0 134.0 133.0 130.0 127.0 139.0 162.0 137.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.00 stddev:5.40 (3.1%) stddev-sans-first:5.73 13:34:59 INFO - PROCESS | 8224 | Values: 173.0 172.0 186.0 176.0 168.0 167.0 169.0 172.0 171.0 171.0 13:34:59 INFO - PROCESS | 8224 | 13:34:59 INFO - PROCESS | 8224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.50 13:34:59 INFO - PROCESS | 8224 | Values: 70.0 68.0 71.0 72.0 68.0 68.0 68.0 69.0 68.0 69.0 13:34:59 INFO - PROCESS | 8224 | -------- Summary: end -------- 13:34:59 INFO - PROCESS | 8224 | 13:35:00 INFO - TEST-INFO | 8224: exit 0 13:35:00 INFO - TEST-OK | kraken | took 61533ms 13:35:00 INFO - SUITE-END | took 1170s 13:35:00 INFO - Completed test suite (00:19:31) 13:35:00 INFO - javascript benchmark 13:35:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.522519009553, 3121.001279590532, 3128.5463607776865, 3163.4938409854426, 3164.88922887699, 5471.343438787346, 5473.972630136844, 5477.986572484083, 5504.422035686255, 5543.41794111618, 5367.06076436624, 5467.644603100795, 5528.640638358514, 5552.278203833496, 5600.4959553640165, 4957.355543779304, 4982.701037937717, 4999.925001124968, 5030.496950304959, 5066.088104141253, 4931.679440836334, 5104.234364845266, 5138.895137545427, 5139.280500729901, 5140.845774626749, 4929.383827021605, 5006.69959802413, 5020.548150666421, 5024.723640199788, 5062.164742817431, 5008.24876268559, 5026.195808670632, 5028.522290382444, 5038.899222015576, 5102.387713474407, 4986.351774269358, 4987.351644286256, 4994.950050499485, 5006.324146240284, 5034.0, 5236.9738151309, 5436.782528698847, 5480.232767412565, 5504.697241651707, 5531.25328080708, 5764.481196692318, 5779.971100144472, 5787.33445653751, 5789.942100578983, 5802.245708057925, 5827.038538641119, 5836.88326233473, 5839.970800146015, 5847.736851841677, 5871.383504731984, 5498.5876059295315, 5573.721313934287, 5581.302337207849, 5598.24423702799, 5623.044082505984, 6020.638761674313, 6041.788537401258, 6053.818385448443, 6063.818085457443, 6081.422264884829, 5657.660540367591, 5783.334916484658, 5810.0, 5839.708014599253, 5843.18195452637, 5844.59087863854, 5846.0, 5864.882702346014, 5882.23530940975, 5929.080992446177, 5757.596968212269, 5794.159846822187, 5815.447532484407, 5839.766409343663, 5844.327902291206, 5750.539956803445, 5860.677662728591, 5938.910916336258, 5939.910901336483, 5944.346121926585, 4431.379606855043, 4494.07871386365, 4496.280595104833, 4523.5250298718165, 4524.9547504524535, 3919.862804801818, 3922.5685174630767, 3936.4488971544006, 3947.973526883031, 3985.0, 5418.214358917935, 5540.584456165723, 5558.305211848519, 5559.972200138974, 5563.944360556424, 5962.07587823888, 5963.105534169822, 5991.670458124845, 5995.130706047686, 5998.640081595031, 5472.315960504937, 5517.779288828482, 5518.641288316327, 5521.4478552144465, 5524.364698059694, 4989.226669866177, 4995.25071239317, 5015.498450154955, 5036.0, 5057.797688092509, 6104.0347610180015, 6112.449879510866, 6184.072389141665, 6190.938090619126, 6196.349383314777, 5988.682489852225, 5994.10088486713, 5997.370276121119, 6003.099535069775, 6007.549433792483, 5952.851178720393, 5997.460228579449, 6095.939040609537, 6135.754569817157, 6157.291911430064, 5770.682612456355, 5781.075027995501, 5782.653040817564, 5784.8553786154, 5798.739056742373, 5814.418558144152, 5879.265091863517, 5884.411558844081, 5885.764569417175, 5895.351511333835, 5609.663420194802, 5680.971595141998, 5714.742836572281, 5728.656280623176, 5735.168400581809, 5635.915461268002, 5645.209670646031, 5699.971500142473, 5736.512396446349, 5749.885002300014, 5644.520215781705, 5647.802326918538, 5661.57538184646, 5713.257276554022, 5722.113072473773, 5684.232628595087, 5775.075987842093, 5794.18881356602, 5816.098504731774, 5855.560832937632, 5621.5221706155435, 5649.971750141387, 5652.830415087554, 5663.688497132697, 5700.116481945305], "value": 5416.6583329788755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.681032242589, 649.1755470552396, 655.4068567946008, 659.8944168932971, 682.8736683713516, 35386.292274154504, 36687.0, 36872.81563592182, 36873.44689829651, 36970.26059478809, 36500.817495912546, 36733.26533469336, 37106.257874842486, 37328.999999999935, 37408.625913740856, 8260.876086858701, 8396.160383961616, 8424.157584241588, 8436.915630843705, 8451.0, 8378.539180345078, 8615.353848461391, 8615.95692021539, 8637.52493612851, 8641.438306510088, 8601.096884827097, 8614.396992210548, 8666.739997800045, 8675.305975521975, 8696.956515217415, 8609.0, 8622.310215182802, 8677.522736249504, 8678.045415004344, 8685.131486851327, 8553.615087321086, 8610.225079742791, 8625.56872156396, 8629.30965522763, 8685.652573897036, 31978.360432791214, 38218.61781382179, 38651.42022869631, 38655.0, 38745.41881871746, 3328.8242085494912, 3411.9829400852836, 3505.333986542574, 3548.520949671787, 3652.013956231829, 27316.45367092667, 27627.86186069057, 27636.0, 27791.30521736973, 28512.857435712896, 3866.516685414323, 3890.2997460457104, 3934.881953541398, 3964.385520244338, 4028.8187031583648, 190157.0, 190220.0, 191312.0, 191634.0, 239585.0, 34373.0, 34417.13957151041, 34439.48340774891, 35893.0, 36981.44527832085, 34865.47701784475, 34955.0, 35011.824940875646, 35055.123621909144, 35093.0, 14244.85755142456, 14449.927750361181, 14480.782788258184, 14520.273986300643, 14532.854671453362, 12735.808962865565, 12804.551840685532, 12853.93573032129, 12862.807057894139, 12881.0, 8575.485470871768, 8601.0, 8623.0, 8632.654693812303, 8657.610407531676, 3289.7697161198485, 3321.5515905352468, 3330.7834990725523, 3332.900012999614, 3414.2317978455144, 1055.5988724284723, 1064.41989115932, 1098.74728812372, 1146.4267866066966, 1168.5617893290016, 31863.88476403361, 32572.837135814643, 32918.835405822814, 32988.3402331952, 33187.50218746721, 1132.1226049811462, 1159.9362035087981, 1199.2324912056117, 1233.0443905972943, 1237.3132911234352, 16678.916605416896, 17112.65774684524, 17225.7416138758, 17251.82748172502, 17516.38692645751, 196373.0, 521856.0, 530921.0, 533961.0, 540297.0, 55627.44372556303, 56535.71732141313, 56871.0, 56877.71561142168, 56924.71537642368, 1475.0043720488627, 1477.6896851661272, 1481.7990995527584, 1502.9398824047134, 1505.8870584706192, 29722.40555188841, 32415.379231038827, 32624.0, 32759.0, 33006.0, 51256.74371628118, 52362.21456678229, 52438.756124387255, 52542.0, 52683.47316526786, 416885.0, 418143.0, 424325.0, 424550.0, 424837.0, 44001.57991310381, 44545.55454445544, 44548.32242614479, 46387.304190436495, 48511.51488485211, 49220.507794923025, 49312.26031609457, 49417.0, 50499.74750126226, 50535.0, 39519.0, 39906.80046599748, 41118.79440602778, 41184.58815411808, 42337.78831105825, 36617.0, 37544.249115018094, 37572.62427375691, 37657.0, 37689.62310376861, 37246.44130338101, 37291.81354093212, 38103.42844857274, 38146.237075257784, 38634.0, 32900.50649240311, 33398.833005834815, 33414.832925836185, 35601.46597800983, 35856.28287434289, 27369.86315068412, 27790.305242369104, 27871.770258379685, 27977.720222798325, 28056.859715702107], "value": 18119.496251911765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.3965732429383, 403.243917654398, 403.6730248498716, 405.45061441746435, 416.3712793681542, 13792.448302067905, 18526.0, 18581.163847626856, 19368.99999999998, 19371.41885743428, 16529.91735041326, 18089.366872159477, 18639.627207455844, 18667.533311667215, 18830.905845470752, 5491.093969495038, 5536.114221724525, 5588.497035266825, 5667.121596152603, 5714.71426428679, 5209.088409528336, 5529.944700552983, 5546.362168350651, 5546.86132846678, 5585.609007369486, 5496.697681627509, 5502.477264659871, 5508.9724551377185, 5517.310336207974, 5532.225488431623, 5418.810341638044, 5792.507636850873, 5836.299644042742, 5839.153322768175, 5844.298684157907, 5421.430749771296, 5539.584531160179, 5574.080276754331, 5609.130584759328, 5614.0, 13699.178049317074, 13803.792943105862, 13941.930290348484, 14029.158250505003, 16604.83395166045, 2303.1478353009325, 2373.086361750721, 2382.2972223194024, 2492.6011838105815, 2774.7918906082123, 10290.639827606074, 10348.58605655773, 10438.63464778729, 10586.735331616694, 10667.466626668636, 1906.8569857260622, 1924.6439408709434, 1924.6631839428044, 1965.7346258255095, 2000.98999505003, 65776.0, 74606.0, 80406.59796701037, 83630.0, 86458.0, 10394.532246048946, 10659.84010239847, 10722.303050301705, 10940.726481838017, 10970.0, 15292.694146117015, 15322.923385383001, 15362.462313818962, 15402.22988850553, 15446.613834654, 8036.638351274207, 8256.8348633027, 8295.04606970206, 8356.582170891432, 8432.831343373098, 7991.640376183086, 8072.0, 8138.715144969898, 8160.224778646019, 8269.379796515286, 4521.909561808811, 4611.5619016193405, 4662.976685116552, 4726.26742854858, 4735.0, 1943.6987266973642, 1961.568454939911, 1978.7449645333345, 2033.7356143701224, 2054.9381421681587, 982.7297493189287, 1010.6664800615779, 1081.4031429209863, 1095.3646884806951, 1112.2770199370475, 17843.553911152067, 17868.481179099923, 18279.817201827813, 18612.720809187875, 18635.81364186368, 1017.7404761785697, 1032.396048311746, 1052.936823790575, 1060.4326685223368, 1068.4924660786219, 9977.351472154432, 10263.076323130954, 10275.588976441008, 10286.588536458608, 10303.072723454925, 450370.0, 455930.0, 464724.0, 472981.0, 475279.0, 76773.61613191899, 92399.0, 95683.52158239164, 96625.51687241519, 96778.0, 1029.341221618165, 1046.9057784799252, 1052.0741747262514, 1053.0101704397841, 1054.6361505280665, 16134.0, 16386.83613163853, 16510.66978660396, 16679.16604169811, 16855.66288674195, 37413.0, 39062.0, 39215.60784392119, 39248.60751392449, 39494.40758388684, 54086.459135409714, 55267.17099243595, 55866.0, 56076.0, 56092.71953640206, 7971.880421793794, 8369.790755231168, 8430.747077587683, 8593.785155371166, 8672.609732561923, 9506.47714375716, 11938.403079845799, 13013.151166427419, 13045.478180872658, 13054.15148015376, 11889.643310700692, 11899.167058305835, 11950.880491194977, 12017.579384721494, 12153.453094610586, 11564.710882228012, 11691.123165762772, 11870.169088163746, 11928.0, 12086.879131208927, 11873.881261187278, 12122.27266364021, 12408.62774116778, 12520.0, 12588.559400420942, 8600.78498037554, 8643.17889800468, 8822.823543528964, 8899.866502002345, 8927.910720892707, 8732.25775809038, 10668.466576671291, 11186.832197517206, 11196.104311654884, 11488.425578720864], "value": 9000.738945598478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.448678475749, 1551.3174203350525, 1728.3345911823944, 1789.7673302470678, 1818.0273553648808, 7674.46278760487, 8030.638621262043, 8109.797255068619, 8361.080281169074, 8389.370797190213, 7768.262015108569, 7785.0657921049415, 7818.296353328199, 7839.882401763978, 7888.881666775003, 2319.8144148468123, 2346.765323467657, 2348.9060437582475, 2351.130081869702, 2368.265837590344, 2276.8975396107217, 2281.7147856517936, 2348.823838212132, 2350.670906073151, 2357.316378250305, 2341.285907798121, 2347.730011048726, 2366.92899213023, 2370.9170179043736, 2384.141708984773, 2279.1453205048106, 2282.9657555136687, 2295.931122066341, 2300.0, 2345.026813872241, 2308.4575124845646, 2309.030207312916, 2309.4919117794057, 2314.745378008418, 2315.8378913476063, 8189.71336003243, 8237.423380363376, 8290.792730181733, 8336.166383361677, 8353.0, 5086.77109530072, 5272.789088436458, 5281.287026251445, 5313.654612450178, 5330.360356757175, 3222.983885080583, 3225.6935591118804, 3243.2378391078314, 3311.1391038329966, 3373.122988023107, 1140.737630345017, 1173.9413029348584, 1180.6930198148457, 1197.2696655040418, 1207.704112492445, 11045.613403530919, 11155.442227888572, 11157.051650609708, 11193.49629266685, 11237.3257604544, 4342.891427714269, 4625.722456652612, 4628.166929952641, 4631.282151266491, 4641.767911604406, 9090.090990900857, 9154.084591540926, 9205.907940920504, 9218.262538996863, 9221.17009469151, 5188.610854185951, 5198.7140707260705, 5202.713850738246, 5210.635255532076, 5236.136037553761, 4273.18809426208, 4836.443808961944, 4842.903141937141, 4847.297141914402, 4885.877853053702, 3679.0986208379118, 3707.2214834884976, 3769.453429252743, 3810.7523011004196, 3824.0631045394057, 1137.175547727907, 1149.8102813035755, 1154.3362566524281, 1154.572808061023, 1173.8004539228352, 839.2195258409738, 857.3826844671827, 889.2441424788877, 926.4348747264163, 1011.9342242754198, 5775.942240577624, 5832.62087964281, 5962.522998160137, 5996.910046349309, 6112.388761123852, 451.5439406199762, 457.3277282394941, 461.6560662306603, 461.7760386212684, 468.0241696063677, 4077.662153668126, 4099.2416402964955, 4129.628333450004, 4138.710290279711, 4166.187593419315, 9612.75968100803, 10112.544935477921, 10181.287309888237, 10253.692389228336, 10291.279610427198, 9992.700218993441, 10070.295079344522, 10082.193424526167, 10151.847722284172, 10184.134348580306, 7772.183920688246, 7774.1837107104075, 7814.179511151361, 7814.921850781533, 7875.488093273919, 5559.972200138974, 5633.436656334334, 5679.517241034393, 5764.538836892954, 5811.128330750252, 9348.672796452092, 9371.0, 9409.952950235478, 9457.527123643928, 9509.0, 9262.0, 9285.907140928504, 9566.234701223746, 9568.904310956801, 9656.275779316438, 6473.287938326875, 6683.4319082876555, 6815.42068924147, 6831.0, 7007.859842803014, 7779.533228006338, 7834.6866125354345, 7905.841883162419, 7945.761627151194, 8002.279794818494, 7131.0, 7306.232845551353, 7312.96343518279, 7373.078365204349, 7404.592747398945, 7158.319959604038, 7205.459590530626, 7218.566885986857, 7315.231900650568, 7381.188069312264, 6407.551471397144, 6412.903806443001, 6434.195725534309, 6481.092647029325, 6482.060101285381, 5082.263071854486, 5088.618353623419, 5097.08252514551, 5210.869728256824, 5234.895302093861, 5076.390833100052, 5178.119719647744, 5245.711485868162, 5252.527272545489, 5289.523942845162], "value": 4380.44283470375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.54395337542496, 335.1654380592326, 337.6319811405569, 344.06586118687767, 348.3607580090534, 6006.729697163627, 6038.698065096744, 6066.787662431816, 6110.114033465151, 6146.938530614692, 6108.511319094473, 6117.235345581802, 6120.0, 6133.754649814014, 6134.478569321613, 4660.673752837302, 4662.067586482709, 4672.084445377396, 4676.900928281851, 4700.811967521295, 4365.4106695596165, 4542.523035081318, 4576.336431217472, 4608.124456353299, 4672.275797251415, 4547.63618910488, 4556.111558246143, 4567.497575266718, 4580.702254353473, 4582.77086145693, 4571.291449825282, 4572.15415148197, 4578.908421831561, 4586.65600079992, 4601.953980460219, 3898.493195884517, 3902.1415288636454, 3929.25344184604, 3932.8033598320258, 3998.7200895937294, 5742.196092547005, 5764.250647415851, 5792.189093526909, 5805.158252053428, 5827.446392592697, 5179.637425380225, 5219.11275083233, 5247.6385626468245, 5258.50044245796, 5271.446498117681, 6163.938360616381, 6201.596896201732, 6274.623522588659, 6303.8739225215695, 6344.238691357021, 4397.340398940152, 4414.933775993362, 4415.536368681274, 4423.491298500681, 4437.600615944581, 6258.311585725612, 6486.124373209604, 6611.570247933869, 6656.101426307435, 6673.6663166841945, 4385.3641222022625, 4437.245668236407, 4441.200583894865, 4469.5306992765945, 4481.977590112028, 4560.475545312265, 4571.9085618287445, 4577.0, 4584.174848527297, 4600.102979918951, 4882.902341953141, 5303.374829459365, 5305.124654431976, 5306.230596563554, 5311.840644780663, 6163.476104531165, 6269.373062693694, 6356.809295721136, 6375.298717141203, 6383.616982981036, 1550.1629120275152, 1581.7469204927156, 1584.4533635895598, 1586.309955169505, 1589.0703938196054, 992.4045572656348, 1006.642641862143, 1025.9692209233735, 1055.4406164732704, 1055.8257887448638, 6209.5032397408095, 6212.254529456403, 6224.595401298901, 6224.688765561704, 6234.096056071844, 6427.646479443582, 6558.475321974231, 6592.76925307612, 6599.307072757291, 6637.767678131242, 5950.67271300074, 6141.0, 6192.287886893065, 6195.535334849904, 6199.659018754011, 3500.1074725944723, 3506.544149260631, 3543.3799085159994, 3545.858165673396, 3560.1633616100194, 6622.437092847065, 6824.931750682529, 6837.025893736141, 6853.554518956252, 6883.793486195422, 6685.799426017227, 6699.263081061079, 6702.128723265944, 6715.0, 6748.696308666122, 6600.339966003361, 6782.016607591871, 6838.316168383221, 6848.14398200225, 6848.9726541019245, 6558.04908288286, 6576.342365763386, 6597.373249541286, 6612.636305003271, 6622.801315960529, 6279.434850863444, 6454.643585335693, 6474.741010359533, 6483.740650373932, 6528.510361722985, 6762.526623136333, 6843.794686159423, 6856.348646878539, 6863.897041544281, 6881.174259088942, 4466.106778644349, 4486.439195100613, 4512.548745125461, 4525.0, 4528.796204170886, 6327.462165715966, 6445.614192948538, 6594.802155935329, 6630.811832095494, 6702.056403642889, 6383.904241436289, 6385.233771947396, 6426.361277874113, 6436.806895793134, 6441.098246245436, 6231.158793562811, 6427.292997770148, 6430.614163150226, 6431.389018043278, 6440.0, 6228.5951413158, 6304.65324407162, 6306.337834527492, 6306.842328941813, 6324.557280990471, 6441.967790161019, 6452.128962590178, 6455.580387274812, 6456.063870738811, 6459.773907913201, 6160.395045029443, 6252.468540174136, 6288.182536270256, 6303.590266632654, 6313.96843015782], "value": 4794.306141131178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.3736834742291, 859.5745106172445, 867.1025488619276, 869.890142739705, 871.1767379826063, 14177.078489898162, 14730.852691473083, 14954.775678364833, 14992.775108373356, 15019.92490037551, 13796.517121900735, 13857.4457021719, 13860.237686927216, 13867.098638588484, 13933.44266229352, 812.5449748141045, 819.2217393476192, 828.8715249136394, 848.3806821020659, 852.7058164933119, 822.6997146041712, 835.3108685334593, 835.6156168162622, 837.1210229259284, 837.9706710265142, 877.903430622631, 881.0968757024037, 885.8538341173698, 886.366248132585, 889.7864512517014, 864.3603733237422, 871.5859966515886, 873.7466134820926, 883.2624758326805, 884.2528063786091, 636.6116668832055, 637.2416823979496, 641.7304732012566, 644.0596728775993, 645.8901986662279, 13990.16059036461, 14007.509737159253, 14055.156690598495, 14064.859351406458, 14067.2966351682, 13775.448982040707, 13941.721165576733, 13941.930290348584, 13955.302234888215, 13957.232352220624, 10788.298760580616, 10923.289986150954, 10938.671839844817, 10993.560257589686, 11091.168162387854, 3681.4845921571, 3707.8516859325596, 3765.190484045916, 3803.82882770276, 3862.0344913771555, 48126.759366203296, 52611.47388526104, 54366.99999999961, 54402.455975440134, 56357.43642563563, 11260.549578016951, 11307.886921130683, 11571.594994175164, 11627.360495172847, 11746.823797643043, 21174.364769056952, 21231.78768212329, 21379.968902954195, 21442.249521266993, 21460.463488412603, 8193.959030204811, 8211.671533138728, 8242.835143297221, 8337.458065225863, 8566.0, 4283.250431174532, 4361.781910904442, 4378.78106094694, 4380.496242932039, 4390.385346051556, 3201.8399080045906, 3287.375398674244, 3291.341731653679, 3295.423300922377, 3338.1821453743987, 630.8233694565529, 641.9518536109717, 646.2309851276965, 652.6019128331714, 653.8347058239848, 688.3288793426369, 712.7576623947882, 732.8900664900201, 749.6851322444586, 776.4836383804819, 8778.648854045767, 8781.604827782765, 8847.823043539092, 8872.822543549093, 8988.191062804379, 597.8475488750341, 627.7834147219202, 726.7456390263471, 739.5230076600562, 747.5477336211623, 4109.856155034559, 4246.214450326699, 4309.59058889405, 4338.761368124783, 4359.978200108979, 59778.40221597815, 62400.0, 62561.374386256466, 62668.0, 62769.37230627727, 51307.23039154416, 52137.47862521402, 54408.45591544113, 54524.45475545273, 55636.443635563934, 42612.0, 43778.7811060949, 43905.24379024867, 44217.33673994893, 49971.500284996684, 8580.356473264404, 8675.436096653697, 8702.260307873901, 8716.564171791259, 8837.91162088371, 30782.076537703906, 30994.0, 31413.371732565676, 31471.0, 32841.17897052593, 40887.0, 44960.0, 45064.774676126406, 45346.31980520361, 45668.54331456643, 11299.943500282774, 11301.830472542753, 11557.479913404086, 11759.76480470403, 11938.880611193777, 13257.469701211843, 13264.933675331562, 13290.534831280858, 13318.400671969592, 13442.865571344553, 12448.439820207932, 12717.872821271669, 12801.29592872401, 12805.231686098863, 13547.796783048065, 12075.094367922617, 12361.443735032126, 12660.936695316464, 12702.745945081231, 12893.161944473579, 12041.759164816829, 12535.561255356384, 12571.87428125707, 12602.810957835824, 12627.747445050863, 10583.5237414315, 10631.149508039493, 10755.569777208824, 10797.676069717922, 10885.891141088488, 10411.687649370531, 10785.946070269598, 10809.837852432378, 10831.404272764757, 10867.836982445428], "value": 6720.618620643868, "unit": "score"}], "name": "dromaeo_css", "value": 7068.183333947297, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 112.0, 111.0, 112.0, 123.0, 113.0, 111.0, 112.0, 119.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 154.0, 188.0, 133.0, 152.0, 160.0, 128.0, 189.0, 137.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 163.0, 162.0, 164.0, 168.0, 162.0, 165.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 76.0, 167.0, 76.0, 76.0, 73.0, 76.0, 180.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 152.0, 92.0, 92.0, 93.0, 144.0, 93.0, 92.0, 155.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 171.0, 147.0, 147.0, 146.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 57.0, 63.0, 67.0, 57.0, 78.0, 55.0, 57.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 77.0, 78.0, 85.0, 78.0, 79.0, 79.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 130.0, 134.0, 133.0, 130.0, 127.0, 139.0, 162.0, 137.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 186.0, 176.0, 168.0, 167.0, 169.0, 172.0, 171.0, 171.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 71.0, 72.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1574.1999999999998, "alertThreshold": 2.0}]} 13:35:00 INFO - Return code: 0 13:35:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:35:00 ERROR - # TBPL SUCCESS # 13:35:00 INFO - Running post-action listener: _resource_record_post_action 13:35:00 INFO - Running post-run listener: _resource_record_post_run 13:35:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536973312; Read time: 12; Write time: 436688 13:35:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250871808; Read time: 0; Write time: 230448 13:35:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286101504; Read time: 12; Write time: 206240 13:35:01 INFO - Running post-run listener: _upload_blobber_files 13:35:01 INFO - Blob upload gear active. 13:35:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:35:01 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 13:35:01 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:35:01 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:35:02 INFO - (blobuploader) - INFO - Open directory for files ... 13:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:03 INFO - (blobuploader) - INFO - Done attempting. 13:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:04 INFO - (blobuploader) - INFO - Done attempting. 13:35:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:35:04 INFO - Return code: 0 13:35:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:35:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:35:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa44063714e10a4acefeea016d24da03d8831b2adf4a415e54532c5afd02250a27991af6b8d2c29a52b088052b11b30310dfd7ac1e0b4d3c78d41c9d7c3485a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75033cc1b30cafe224b5c6c1be712b8267d3b48ba35ccc8ae07158d159bc1cd6cab5c32fb1d8053261a4acc16cc001ec03a778d030c0b6c5f7c9c7722f436983"} 13:35:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:35:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:35:04 INFO - Contents: 13:35:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa44063714e10a4acefeea016d24da03d8831b2adf4a415e54532c5afd02250a27991af6b8d2c29a52b088052b11b30310dfd7ac1e0b4d3c78d41c9d7c3485a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75033cc1b30cafe224b5c6c1be712b8267d3b48ba35ccc8ae07158d159bc1cd6cab5c32fb1d8053261a4acc16cc001ec03a778d030c0b6c5f7c9c7722f436983"} 13:35:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:35:04 INFO - Copying logs to upload dir... 13:35:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:35:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.648737 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-18 13:35:04.218825) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 13:35:04.222493) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa44063714e10a4acefeea016d24da03d8831b2adf4a415e54532c5afd02250a27991af6b8d2c29a52b088052b11b30310dfd7ac1e0b4d3c78d41c9d7c3485a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75033cc1b30cafe224b5c6c1be712b8267d3b48ba35ccc8ae07158d159bc1cd6cab5c32fb1d8053261a4acc16cc001ec03a778d030c0b6c5f7c9c7722f436983"} build_url:https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/Pc1qn_bCTeWzXaqcnsQwzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa44063714e10a4acefeea016d24da03d8831b2adf4a415e54532c5afd02250a27991af6b8d2c29a52b088052b11b30310dfd7ac1e0b4d3c78d41c9d7c3485a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75033cc1b30cafe224b5c6c1be712b8267d3b48ba35ccc8ae07158d159bc1cd6cab5c32fb1d8053261a4acc16cc001ec03a778d030c0b6c5f7c9c7722f436983"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 13:35:04.251181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:35:04.251908) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461010476.209647-571375683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 13:35:04.336649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 13:35:04.337286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 13:35:04.337905) ========= ========= Total master_lag: 0.19 =========