builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1461161593.32 results: success (0) buildid: 20160420043041 builduid: 7a58e70991484b2897f278ab3d2ef28f revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.321446) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.321940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.322279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.344037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.344367) ========= 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=7de08804244eb36560b44971000001c3-1461161361.40097-1503712564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 07:13:13-- 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% 224M=0s 2016-04-20 07:13:13 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143140 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.503144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.503460) ========= 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=7de08804244eb36560b44971000001c3-1461161361.40097-1503712564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018565 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:13.579155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 07:13:13.579524) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f05a1242fb29023bd7ebc492897ed3d6907733c7 --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 f05a1242fb29023bd7ebc492897ed3d6907733c7 --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=7de08804244eb36560b44971000001c3-1461161361.40097-1503712564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 07:13:13,865 truncating revision to first 12 chars 2016-04-20 07:13:13,865 Setting DEBUG logging. 2016-04-20 07:13:13,865 attempt 1/10 2016-04-20 07:13:13,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f05a1242fb29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 07:13:15,132 unpacking tar archive at: mozilla-central-f05a1242fb29/testing/mozharness/ program finished with exit code 0 elapsedTime=1.608075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 07:13:15.203947) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:15.204361) ========= script_repo_revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:15.204880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:15.205256) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 07:13:15.226679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-20 07:13:15.227019) ========= /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=7de08804244eb36560b44971000001c3-1461161361.40097-1503712564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:13:15 INFO - MultiFileLogger online at 20160420 07:13:15 in /builds/slave/test 07:13:15 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 07:13:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:15 INFO - {'append_to_log': False, 07:13:15 INFO - 'base_work_dir': '/builds/slave/test', 07:13:15 INFO - 'blob_upload_branch': 'Firefox', 07:13:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:15 INFO - 'branch': 'Firefox', 07:13:15 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:15 INFO - 'config_files': ('talos/linux_config.py',), 07:13:15 INFO - 'default_actions': ('clobber', 07:13:15 INFO - 'read-buildbot-config', 07:13:15 INFO - 'download-and-extract', 07:13:15 INFO - 'populate-webroot', 07:13:15 INFO - 'create-virtualenv', 07:13:15 INFO - 'install', 07:13:15 INFO - 'run-tests'), 07:13:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:15 INFO - 'download_minidump_stackwalk': True, 07:13:15 INFO - 'download_symbols': 'ondemand', 07:13:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:15 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:15 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:15 INFO - 'installer_path': 'installer.exe', 07:13:15 INFO - 'log_level': 'info', 07:13:15 INFO - 'log_name': 'talos', 07:13:15 INFO - 'log_to_console': True, 07:13:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:13:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:13:15 INFO - 'opt_config_files': (), 07:13:15 INFO - 'pip_index': False, 07:13:15 INFO - 'sps_profile': False, 07:13:15 INFO - 'sps_profile_interval': 0, 07:13:15 INFO - 'suite': 'dromaeojs-e10s', 07:13:15 INFO - 'system_bits': '32', 07:13:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:15 INFO - 'title': 'talos-linux64-ix-003', 07:13:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:15 INFO - 'use_talos_json': True, 07:13:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:15 INFO - 'work_dir': 'build'} 07:13:15 INFO - ##### 07:13:15 INFO - ##### Running clobber step. 07:13:15 INFO - ##### 07:13:15 INFO - Running pre-action listener: _resource_record_pre_action 07:13:15 INFO - Running main action method: clobber 07:13:15 INFO - rmtree: /builds/slave/test/build 07:13:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:16 INFO - Running post-action listener: _resource_record_post_action 07:13:16 INFO - ##### 07:13:16 INFO - ##### Running read-buildbot-config step. 07:13:16 INFO - ##### 07:13:16 INFO - Running pre-action listener: _resource_record_pre_action 07:13:16 INFO - Running main action method: read_buildbot_config 07:13:16 INFO - Using buildbot properties: 07:13:16 INFO - { 07:13:16 INFO - "project": "", 07:13:16 INFO - "product": "firefox", 07:13:16 INFO - "script_repo_revision": "production", 07:13:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:13:16 INFO - "repository": "", 07:13:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:13:16 INFO - "buildid": "20160420043041", 07:13:16 INFO - "pgo_build": "True", 07:13:16 INFO - "basedir": "/builds/slave/test", 07:13:16 INFO - "buildnumber": 707, 07:13:16 INFO - "slavename": "talos-linux64-ix-003", 07:13:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:13:16 INFO - "platform": "ubuntu64_hw", 07:13:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:13:16 INFO - "branch": "mozilla-central", 07:13:16 INFO - "repo_path": "mozilla-central", 07:13:16 INFO - "revision": "f05a1242fb29023bd7ebc492897ed3d6907733c7", 07:13:16 INFO - "stage_platform": "linux64-pgo", 07:13:16 INFO - "builduid": "7a58e70991484b2897f278ab3d2ef28f", 07:13:16 INFO - "slavebuilddir": "test" 07:13:16 INFO - } 07:13:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:13:16 INFO - Running post-action listener: _resource_record_post_action 07:13:16 INFO - ##### 07:13:16 INFO - ##### Running download-and-extract step. 07:13:16 INFO - ##### 07:13:16 INFO - Running pre-action listener: _resource_record_pre_action 07:13:16 INFO - Running main action method: download_and_extract 07:13:16 INFO - mkdir: /builds/slave/test/build/tests 07:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:16 INFO - https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:30 INFO - Downloaded 1361 bytes. 07:13:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:13:30 INFO - Using the following test package requirements: 07:13:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:13:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:13:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:13:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'jsshell-linux-x86_64.zip'], 07:13:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:13:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:13:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:13:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:13:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:13:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:13:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:30 INFO - https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:13:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:13:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:13:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:40 INFO - Downloaded 23839133 bytes. 07:13: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'] 07:13: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 07:13:41 INFO - Return code: 0 07:13: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 07:13: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')]} 07:13:41 INFO - https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:43 INFO - Downloaded 23839133 bytes. 07:13:43 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'] 07:13:43 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 07:13:44 INFO - Return code: 0 07:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:44 INFO - https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:45 INFO - Downloaded 10845952 bytes. 07:13:45 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'] 07:13:45 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 07:13:46 INFO - Return code: 0 07:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:46 INFO - https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDMCPj5_QuuBdDZtj6pheA/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 07:13:47 INFO - Downloaded 58298884 bytes. 07:13:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:13:47 INFO - mkdir: /builds/slave/test/properties 07:13:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:47 INFO - Contents: 07:13:47 INFO - build_url:https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:13:48 INFO - Running post-action listener: _resource_record_post_action 07:13:48 INFO - Running post-action listener: set_extra_try_arguments 07:13:48 INFO - ##### 07:13:48 INFO - ##### Running populate-webroot step. 07:13:48 INFO - ##### 07:13:48 INFO - Running pre-action listener: _resource_record_pre_action 07:13:48 INFO - Running main action method: populate_webroot 07:13:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:13:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:13:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:13:48 INFO - '--tppagecycles', 07:13:48 INFO - '7'], 07:13:48 INFO - 'tests': ['tsvgm']}}, 07:13:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:13:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:13:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:13:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:13:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['damp', 'tps']}, 07:13:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'tests': ['damp', 'tps']}, 07:13:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['dromaeo_dom']}, 07:13:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['a11yr', 07:13:48 INFO - 'ts_paint', 07:13:48 INFO - 'tpaint', 07:13:48 INFO - 'sessionrestore', 07:13:48 INFO - 'sessionrestore_no_auto_restore', 07:13:48 INFO - 'tabpaint']}, 07:13:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:13:48 INFO - 'ts_paint', 07:13:48 INFO - 'tpaint', 07:13:48 INFO - 'sessionrestore', 07:13:48 INFO - 'sessionrestore_no_auto_restore', 07:13:48 INFO - 'tabpaint']}, 07:13:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:13:48 INFO - 'ts_paint', 07:13:48 INFO - 'tpaint', 07:13:48 INFO - 'sessionrestore', 07:13:48 INFO - 'sessionrestore_no_auto_restore', 07:13:48 INFO - 'tabpaint']}, 07:13:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:13:48 INFO - 'ts_paint', 07:13:48 INFO - 'tpaint', 07:13:48 INFO - 'sessionrestore', 07:13:48 INFO - 'sessionrestore_no_auto_restore', 07:13:48 INFO - 'tabpaint']}, 07:13:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['a11yr', 07:13:48 INFO - 'ts_paint', 07:13:48 INFO - 'tpaint', 07:13:48 INFO - 'sessionrestore', 07:13:48 INFO - 'sessionrestore_no_auto_restore', 07:13:48 INFO - 'tabpaint']}, 07:13:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['a11yr', 07:13:48 INFO - 'ts_paint', 07:13:48 INFO - 'tpaint', 07:13:48 INFO - 'sessionrestore', 07:13:48 INFO - 'sessionrestore_no_auto_restore', 07:13:48 INFO - 'tabpaint']}, 07:13:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['tsvgx', 07:13:48 INFO - 'tsvgr_opacity', 07:13:48 INFO - 'tart', 07:13:48 INFO - 'tscrollx', 07:13:48 INFO - 'cart']}, 07:13:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:13:48 INFO - 'tsvgr_opacity', 07:13:48 INFO - 'tart', 07:13:48 INFO - 'tscrollx', 07:13:48 INFO - 'cart']}, 07:13:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'talos_options': ['--disable-e10s'], 07:13:48 INFO - 'tests': ['tp5o']}, 07:13:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'tests': ['tp5o']}, 07:13:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'talos_options': ['--disable-e10s', 07:13:48 INFO - '--xperf_path', 07:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:48 INFO - 'tests': ['tp5n']}, 07:13:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:48 INFO - 'talos_options': ['--xperf_path', 07:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:48 INFO - 'tests': ['tp5n']}}, 07:13:48 INFO - 'talos.zip': {'path': '', 07:13:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:13:48 INFO - Running post-action listener: _resource_record_post_action 07:13:48 INFO - ##### 07:13:48 INFO - ##### Running create-virtualenv step. 07:13:48 INFO - ##### 07:13:48 INFO - Running pre-action listener: _resource_record_pre_action 07:13:48 INFO - Running main action method: create_virtualenv 07:13:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:48 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 07:13:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:13:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:48 INFO - Using real prefix '/usr' 07:13:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:51 INFO - Installing pip.................done. 07:13:51 INFO - Return code: 0 07:13:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:51 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:13:51 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 07:13:51 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 07:13:51 INFO - Using env: {'DISPLAY': ':0', 07:13:51 INFO - 'HOME': '/home/cltbld', 07:13:51 INFO - 'LANG': 'en_US.UTF-8', 07:13:51 INFO - 'LANGUAGE': 'en_US:en', 07:13:51 INFO - 'LOGNAME': 'cltbld', 07:13:51 INFO - 'MAIL': '/var/mail/cltbld', 07:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:51 INFO - 'MOZ_NO_REMOTE': '1', 07:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:51 INFO - 'NO_EM_RESTART': '1', 07:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:51 INFO - 'PWD': '/builds/slave/test', 07:13:51 INFO - 'SHELL': '/bin/bash', 07:13:51 INFO - 'SHLVL': '1', 07:13:51 INFO - 'TERM': 'linux', 07:13:51 INFO - 'TMOUT': '86400', 07:13:51 INFO - 'USER': 'cltbld', 07:13:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:51 INFO - '_': '/tools/buildbot/bin/python'} 07:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:51 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 07:13:51 INFO - Cleaning up... 07:13:51 INFO - Return code: 0 07:13:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:51 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:13:51 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 07:13:51 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 07:13:51 INFO - Using env: {'DISPLAY': ':0', 07:13:51 INFO - 'HOME': '/home/cltbld', 07:13:51 INFO - 'LANG': 'en_US.UTF-8', 07:13:51 INFO - 'LANGUAGE': 'en_US:en', 07:13:51 INFO - 'LOGNAME': 'cltbld', 07:13:51 INFO - 'MAIL': '/var/mail/cltbld', 07:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:51 INFO - 'MOZ_NO_REMOTE': '1', 07:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:51 INFO - 'NO_EM_RESTART': '1', 07:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:51 INFO - 'PWD': '/builds/slave/test', 07:13:51 INFO - 'SHELL': '/bin/bash', 07:13:51 INFO - 'SHLVL': '1', 07:13:51 INFO - 'TERM': 'linux', 07:13:51 INFO - 'TMOUT': '86400', 07:13:51 INFO - 'USER': 'cltbld', 07:13:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:51 INFO - '_': '/tools/buildbot/bin/python'} 07:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:51 INFO - Downloading/unpacking psutil>=0.7.1 07:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:53 INFO - Installing collected packages: psutil 07:13:53 INFO - Running setup.py install for psutil 07:13:53 INFO - building 'psutil._psutil_linux' extension 07:13:53 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 07:13:53 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 07:13:53 INFO - building 'psutil._psutil_posix' extension 07:13:53 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 07:13:53 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 07:13:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:54 INFO - Successfully installed psutil 07:13:54 INFO - Cleaning up... 07:13:54 INFO - Return code: 0 07:13:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:54 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:13:54 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 07:13:54 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 07:13:54 INFO - Using env: {'DISPLAY': ':0', 07:13:54 INFO - 'HOME': '/home/cltbld', 07:13:54 INFO - 'LANG': 'en_US.UTF-8', 07:13:54 INFO - 'LANGUAGE': 'en_US:en', 07:13:54 INFO - 'LOGNAME': 'cltbld', 07:13:54 INFO - 'MAIL': '/var/mail/cltbld', 07:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:54 INFO - 'MOZ_NO_REMOTE': '1', 07:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:54 INFO - 'NO_EM_RESTART': '1', 07:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:54 INFO - 'PWD': '/builds/slave/test', 07:13:54 INFO - 'SHELL': '/bin/bash', 07:13:54 INFO - 'SHLVL': '1', 07:13:54 INFO - 'TERM': 'linux', 07:13:54 INFO - 'TMOUT': '86400', 07:13:54 INFO - 'USER': 'cltbld', 07:13:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:54 INFO - '_': '/tools/buildbot/bin/python'} 07:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:13:54 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 07:13:54 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 07:13:54 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 07:13:54 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 07:13:54 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 07:13:54 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 07:13:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:13:56 INFO - Installing collected packages: mozsystemmonitor 07:13:56 INFO - Running setup.py install for mozsystemmonitor 07:13:56 INFO - Successfully installed mozsystemmonitor 07:13:56 INFO - Cleaning up... 07:13:56 INFO - Return code: 0 07:13:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:13:56 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')]} 07:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:56 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')]} 07:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:56 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:13:56 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 07:13:56 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 07:13:56 INFO - Using env: {'DISPLAY': ':0', 07:13:56 INFO - 'HOME': '/home/cltbld', 07:13:56 INFO - 'LANG': 'en_US.UTF-8', 07:13:56 INFO - 'LANGUAGE': 'en_US:en', 07:13:56 INFO - 'LOGNAME': 'cltbld', 07:13:56 INFO - 'MAIL': '/var/mail/cltbld', 07:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:56 INFO - 'MOZ_NO_REMOTE': '1', 07:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:56 INFO - 'NO_EM_RESTART': '1', 07:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:56 INFO - 'PWD': '/builds/slave/test', 07:13:56 INFO - 'SHELL': '/bin/bash', 07:13:56 INFO - 'SHLVL': '1', 07:13:56 INFO - 'TERM': 'linux', 07:13:56 INFO - 'TMOUT': '86400', 07:13:56 INFO - 'USER': 'cltbld', 07:13:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:56 INFO - '_': '/tools/buildbot/bin/python'} 07:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:58 INFO - Downloading blobuploader-1.2.4.tar.gz 07:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:13:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:13:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 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 07:13:59 INFO - Downloading docopt-0.6.1.tar.gz 07:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:13:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:13:59 INFO - Running setup.py install for blobuploader 07:13:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:13:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:13:59 INFO - Running setup.py install for requests 07:13:59 INFO - Running setup.py install for docopt 07:13:59 INFO - Successfully installed blobuploader requests docopt 07:13:59 INFO - Cleaning up... 07:13:59 INFO - Return code: 0 07:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:59 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:13:59 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 07:13:59 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 07:13:59 INFO - Using env: {'DISPLAY': ':0', 07:13:59 INFO - 'HOME': '/home/cltbld', 07:13:59 INFO - 'LANG': 'en_US.UTF-8', 07:13:59 INFO - 'LANGUAGE': 'en_US:en', 07:13:59 INFO - 'LOGNAME': 'cltbld', 07:13:59 INFO - 'MAIL': '/var/mail/cltbld', 07:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:59 INFO - 'MOZ_NO_REMOTE': '1', 07:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:59 INFO - 'NO_EM_RESTART': '1', 07:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:59 INFO - 'PWD': '/builds/slave/test', 07:13:59 INFO - 'SHELL': '/bin/bash', 07:13:59 INFO - 'SHLVL': '1', 07:13:59 INFO - 'TERM': 'linux', 07:13:59 INFO - 'TMOUT': '86400', 07:13:59 INFO - 'USER': 'cltbld', 07:13:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:59 INFO - '_': '/tools/buildbot/bin/python'} 07:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:00 INFO - Running setup.py (path:/tmp/pip-9dvOoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:00 INFO - Running setup.py (path:/tmp/pip-9HAJI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:00 INFO - Running setup.py (path:/tmp/pip-blgCNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:00 INFO - Running setup.py (path:/tmp/pip-fQOKll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:00 INFO - Running setup.py (path:/tmp/pip-Ydu8Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:00 INFO - Running setup.py (path:/tmp/pip-vZCTIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:00 INFO - Running setup.py (path:/tmp/pip-ciMLmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:00 INFO - Running setup.py (path:/tmp/pip-4rSNGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:00 INFO - Running setup.py (path:/tmp/pip-OImdDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:00 INFO - Running setup.py (path:/tmp/pip-s9oxJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:00 INFO - Running setup.py (path:/tmp/pip-Ve1ttI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:00 INFO - Running setup.py (path:/tmp/pip-kbUhTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:00 INFO - Running setup.py (path:/tmp/pip-SYETUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:01 INFO - Running setup.py (path:/tmp/pip-4ZwKso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:01 INFO - Running setup.py (path:/tmp/pip-yCZo27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:01 INFO - Running setup.py (path:/tmp/pip-tkj5Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:01 INFO - Running setup.py (path:/tmp/pip-_URm1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:01 INFO - Running setup.py install for manifestparser 07:14:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:01 INFO - Running setup.py install for mozcrash 07:14:01 INFO - Running setup.py install for mozdebug 07:14:01 INFO - Running setup.py install for mozdevice 07:14:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:01 INFO - Running setup.py install for mozfile 07:14:01 INFO - Running setup.py install for mozhttpd 07:14:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:01 INFO - Running setup.py install for mozinfo 07:14:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:01 INFO - Running setup.py install for mozInstall 07:14:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Running setup.py install for mozleak 07:14:02 INFO - Running setup.py install for mozlog 07:14:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Running setup.py install for moznetwork 07:14:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Running setup.py install for mozprocess 07:14:02 INFO - Running setup.py install for mozprofile 07:14:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Running setup.py install for mozrunner 07:14:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:02 INFO - Running setup.py install for mozscreenshot 07:14:02 INFO - Running setup.py install for moztest 07:14:02 INFO - Running setup.py install for mozversion 07:14:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:03 INFO - Cleaning up... 07:14:03 INFO - Return code: 0 07:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:03 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:14:03 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 07:14:03 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 07:14:03 INFO - Using env: {'DISPLAY': ':0', 07:14:03 INFO - 'HOME': '/home/cltbld', 07:14:03 INFO - 'LANG': 'en_US.UTF-8', 07:14:03 INFO - 'LANGUAGE': 'en_US:en', 07:14:03 INFO - 'LOGNAME': 'cltbld', 07:14:03 INFO - 'MAIL': '/var/mail/cltbld', 07:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:03 INFO - 'MOZ_NO_REMOTE': '1', 07:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:03 INFO - 'NO_EM_RESTART': '1', 07:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:03 INFO - 'PWD': '/builds/slave/test', 07:14:03 INFO - 'SHELL': '/bin/bash', 07:14:03 INFO - 'SHLVL': '1', 07:14:03 INFO - 'TERM': 'linux', 07:14:03 INFO - 'TMOUT': '86400', 07:14:03 INFO - 'USER': 'cltbld', 07:14:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:03 INFO - '_': '/tools/buildbot/bin/python'} 07:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:03 INFO - Running setup.py (path:/tmp/pip-e5xBbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:03 INFO - Running setup.py (path:/tmp/pip-w_nadw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:03 INFO - Running setup.py (path:/tmp/pip-aQi4M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:03 INFO - Running setup.py (path:/tmp/pip-jQmIXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:03 INFO - Running setup.py (path:/tmp/pip-lctu34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:03 INFO - Running setup.py (path:/tmp/pip-TVQMfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:03 INFO - Running setup.py (path:/tmp/pip-LMZmK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:03 INFO - Running setup.py (path:/tmp/pip-m3ETK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:03 INFO - Running setup.py (path:/tmp/pip-hH34GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:03 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)) 07:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:03 INFO - Running setup.py (path:/tmp/pip-eVexJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:04 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)) 07:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:04 INFO - Running setup.py (path:/tmp/pip-Q9UHjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:04 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)) 07:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:04 INFO - Running setup.py (path:/tmp/pip-GLeVbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:04 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)) 07:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:04 INFO - Running setup.py (path:/tmp/pip-zUrKQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:04 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)) 07:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:04 INFO - Running setup.py (path:/tmp/pip-uFHRYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:04 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)) 07:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:04 INFO - Running setup.py (path:/tmp/pip-B94BNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:04 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)) 07:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:04 INFO - Running setup.py (path:/tmp/pip-IqJpQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:04 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)) 07:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:04 INFO - Running setup.py (path:/tmp/pip-JbZJup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:04 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)) 07:14:04 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)) 07:14:04 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)) 07:14:04 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)) 07:14:04 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)) 07:14:04 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)) 07:14:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:06 INFO - Downloading blessings-1.6.tar.gz 07:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:06 INFO - Installing collected packages: blessings 07:14:06 INFO - Running setup.py install for blessings 07:14:06 INFO - Successfully installed blessings 07:14:06 INFO - Cleaning up... 07:14:06 INFO - Return code: 0 07:14:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:06 INFO - Reading from file tmpfile_stdout 07:14:06 INFO - Current package versions: 07:14:06 INFO - argparse == 1.2.1 07:14:06 INFO - blessings == 1.6 07:14:06 INFO - blobuploader == 1.2.4 07:14:06 INFO - docopt == 0.6.1 07:14:06 INFO - manifestparser == 1.1 07:14:06 INFO - mozInstall == 1.12 07:14:06 INFO - mozcrash == 0.17 07:14:06 INFO - mozdebug == 0.1 07:14:06 INFO - mozdevice == 0.48 07:14:06 INFO - mozfile == 1.2 07:14:06 INFO - mozhttpd == 0.7 07:14:06 INFO - mozinfo == 0.9 07:14:06 INFO - mozleak == 0.1 07:14:06 INFO - mozlog == 3.1 07:14:06 INFO - moznetwork == 0.27 07:14:06 INFO - mozprocess == 0.22 07:14:06 INFO - mozprofile == 0.28 07:14:06 INFO - mozrunner == 6.11 07:14:06 INFO - mozscreenshot == 0.1 07:14:06 INFO - mozsystemmonitor == 0.0 07:14:06 INFO - moztest == 0.7 07:14:06 INFO - mozversion == 1.4 07:14:06 INFO - psutil == 3.1.1 07:14:06 INFO - requests == 1.2.3 07:14:06 INFO - wsgiref == 0.1.2 07:14:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:06 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:14:06 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 07:14:06 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 07:14:06 INFO - Using env: {'DISPLAY': ':0', 07:14:06 INFO - 'HOME': '/home/cltbld', 07:14:06 INFO - 'LANG': 'en_US.UTF-8', 07:14:06 INFO - 'LANGUAGE': 'en_US:en', 07:14:06 INFO - 'LOGNAME': 'cltbld', 07:14:06 INFO - 'MAIL': '/var/mail/cltbld', 07:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:06 INFO - 'MOZ_NO_REMOTE': '1', 07:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:06 INFO - 'NO_EM_RESTART': '1', 07:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:06 INFO - 'PWD': '/builds/slave/test', 07:14:06 INFO - 'SHELL': '/bin/bash', 07:14:06 INFO - 'SHLVL': '1', 07:14:06 INFO - 'TERM': 'linux', 07:14:06 INFO - 'TMOUT': '86400', 07:14:06 INFO - 'USER': 'cltbld', 07:14:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:06 INFO - '_': '/tools/buildbot/bin/python'} 07:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 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)) 07:14:07 INFO - Cleaning up... 07:14:07 INFO - Return code: 0 07:14:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14:07 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')]} 07:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:07 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')]} 07:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:07 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 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:14:07 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 07:14:07 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 07:14:07 INFO - Using env: {'DISPLAY': ':0', 07:14:07 INFO - 'HOME': '/home/cltbld', 07:14:07 INFO - 'LANG': 'en_US.UTF-8', 07:14:07 INFO - 'LANGUAGE': 'en_US:en', 07:14:07 INFO - 'LOGNAME': 'cltbld', 07:14:07 INFO - 'MAIL': '/var/mail/cltbld', 07:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:07 INFO - 'MOZ_NO_REMOTE': '1', 07:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:07 INFO - 'NO_EM_RESTART': '1', 07:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:07 INFO - 'PWD': '/builds/slave/test', 07:14:07 INFO - 'SHELL': '/bin/bash', 07:14:07 INFO - 'SHLVL': '1', 07:14:07 INFO - 'TERM': 'linux', 07:14:07 INFO - 'TMOUT': '86400', 07:14:07 INFO - 'USER': 'cltbld', 07:14:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:07 INFO - '_': '/tools/buildbot/bin/python'} 07:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:07 INFO - Downloading/unpacking jsonschema 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:09 INFO - Downloading/unpacking functools32 (from jsonschema) 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:09 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:09 INFO - warning: no files found matching '*.txt' 07:14:09 INFO - no previously-included directories found matching 'build' 07:14:09 INFO - no previously-included directories found matching 'dist' 07:14:09 INFO - no previously-included directories found matching '.git*' 07:14:09 INFO - Installing collected packages: jsonschema, functools32 07:14:09 INFO - Running setup.py install for functools32 07:14:09 INFO - warning: no files found matching '*.txt' 07:14:09 INFO - no previously-included directories found matching 'build' 07:14:09 INFO - no previously-included directories found matching 'dist' 07:14:09 INFO - no previously-included directories found matching '.git*' 07:14:09 INFO - Successfully installed jsonschema functools32 07:14:09 INFO - Cleaning up... 07:14:09 INFO - Return code: 0 07:14:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e08db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, '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': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', '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 07:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:14:09 INFO - Using env: {'DISPLAY': ':0', 07:14:09 INFO - 'HOME': '/home/cltbld', 07:14:09 INFO - 'LANG': 'en_US.UTF-8', 07:14:09 INFO - 'LANGUAGE': 'en_US:en', 07:14:09 INFO - 'LOGNAME': 'cltbld', 07:14:09 INFO - 'MAIL': '/var/mail/cltbld', 07:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:09 INFO - 'MOZ_NO_REMOTE': '1', 07:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:09 INFO - 'NO_EM_RESTART': '1', 07:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:09 INFO - 'PWD': '/builds/slave/test', 07:14:09 INFO - 'SHELL': '/bin/bash', 07:14:09 INFO - 'SHLVL': '1', 07:14:09 INFO - 'TERM': 'linux', 07:14:09 INFO - 'TMOUT': '86400', 07:14:09 INFO - 'USER': 'cltbld', 07:14:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:09 INFO - '_': '/tools/buildbot/bin/python'} 07:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:09 INFO - Downloading/unpacking flake8 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:14:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:14:11 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 07:14:11 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 07:14:11 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 07:14:11 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 07:14:11 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 07:14:11 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 07:14:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:14:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:14:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:12 INFO - no previously-included directories found matching 'docs/_build' 07:14:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:14:12 INFO - Running setup.py install for pep8 07:14:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:12 INFO - no previously-included directories found matching 'docs/_build' 07:14:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:14:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:14:12 INFO - Cleaning up... 07:14:12 INFO - Return code: 0 07:14:12 INFO - Running post-action listener: _resource_record_post_action 07:14:12 INFO - Running post-action listener: _start_resource_monitoring 07:14:12 INFO - Starting resource monitoring. 07:14:12 INFO - ##### 07:14:12 INFO - ##### Running install step. 07:14:12 INFO - ##### 07:14:12 INFO - Running pre-action listener: _resource_record_pre_action 07:14:12 INFO - Running main action method: install 07:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:13 INFO - Reading from file tmpfile_stdout 07:14:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:13 INFO - Reading from file tmpfile_stdout 07:14:13 INFO - Output received: 07:14:13 INFO - Usage: mozinstall [options] installer 07:14:13 INFO - Options: 07:14:13 INFO - -h, --help show this help message and exit 07:14:13 INFO - -d DEST, --destination=DEST 07:14:13 INFO - Directory to install application into. [default: 07:14:13 INFO - "/builds/slave/test"] 07:14:13 INFO - --app=APP Application being installed. [default: firefox] 07:14:13 INFO - mkdir: /builds/slave/test/build/application 07:14:13 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'] 07:14:13 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 07:14:29 INFO - Reading from file tmpfile_stdout 07:14:29 INFO - Output received: 07:14:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:14:29 INFO - Running post-action listener: _resource_record_post_action 07:14:29 INFO - ##### 07:14:29 INFO - ##### Running run-tests step. 07:14:29 INFO - ##### 07:14:29 INFO - Running pre-action listener: _resource_record_pre_action 07:14:29 INFO - Running main action method: run_tests 07:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:29 INFO - Python 2.7.3 07:14:29 INFO - Return code: 0 07:14:29 INFO - grabbing minidump binary from tooltool 07:14:29 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')]} 07:14:29 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 0x2371410>, '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 0x2372310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23727a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:29 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 07:14:29 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 07:14:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:29 INFO - Return code: 0 07:14:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:14:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:14:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:14:30 INFO - Return code: 0 07:14:30 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/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 07:14:30 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/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 07:14:30 INFO - Using env: {'DISPLAY': ':0', 07:14:30 INFO - 'HOME': '/home/cltbld', 07:14:30 INFO - 'LANG': 'en_US.UTF-8', 07:14:30 INFO - 'LANGUAGE': 'en_US:en', 07:14:30 INFO - 'LOGNAME': 'cltbld', 07:14:30 INFO - 'MAIL': '/var/mail/cltbld', 07:14:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:30 INFO - 'MOZ_NO_REMOTE': '1', 07:14:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:30 INFO - 'NO_EM_RESTART': '1', 07:14:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:30 INFO - 'PWD': '/builds/slave/test', 07:14:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:30 INFO - 'SHELL': '/bin/bash', 07:14:30 INFO - 'SHLVL': '1', 07:14:30 INFO - 'TERM': 'linux', 07:14:30 INFO - 'TMOUT': '86400', 07:14:30 INFO - 'USER': 'cltbld', 07:14:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461161361.40097-1503712564', 07:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:30 INFO - '_': '/tools/buildbot/bin/python'} 07:14:30 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/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 07:14:30 INFO - mozversion application_buildid: 20160420043041 07:14:30 INFO - mozversion application_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 07:14:30 INFO - mozversion application_display_name: Nightly 07:14:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:30 INFO - mozversion application_name: Firefox 07:14:30 INFO - mozversion application_remotingname: firefox 07:14:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:14:30 INFO - mozversion application_vendor: Mozilla 07:14:30 INFO - mozversion application_version: 48.0a1 07:14:30 INFO - mozversion platform_buildid: 20160420043041 07:14:30 INFO - mozversion platform_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 07:14:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:14:30 INFO - mozversion platform_version: 48.0a1 07:14:30 INFO - using testdate: 1461161670 07:14:30 INFO - actual date: 1461161670 07:14:30 INFO - starting webserver on 'localhost:59651' 07:14:30 INFO - SUITE-START | Running 2 tests 07:14:30 INFO - TEST-START | dromaeo_css 07:14:30 INFO - operating with platform_type : linux_ 07:14:30 INFO - Initialising browser for dromaeo_css test... 07:14:30 INFO - TEST-INFO | started process 18528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGrK7F1/profile http://localhost:59651/getInfo.html) 07:14:34 INFO - PROCESS | 18528 | 07:14:34 INFO - PROCESS | 18528 | (process:18596): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:14:35 INFO - PROCESS | 18528 | __metrics Screen width/height:1600/1200 07:14:35 INFO - PROCESS | 18528 | colorDepth:24 07:14:35 INFO - PROCESS | 18528 | Browser inner width/height: 1024/697 07:14:35 INFO - PROCESS | 18528 | __metrics 07:14:36 ERROR - PROCESS | 18528 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:14:37 INFO - TEST-INFO | 18528: exit 0 07:14:37 INFO - Browser initialized. 07:14:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:14:37 INFO - TEST-INFO | started process 18647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGrK7F1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:38 INFO - PROCESS | 18647 | 07:14:38 INFO - PROCESS | 18647 | (process:18710): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:14:48 INFO - PROCESS | 18647 | RSS: Main: 163368960 07:14:48 INFO - PROCESS | 18647 | 07:15:38 INFO - PROCESS | 18647 | 1461161738520 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] 07:17:45 INFO - PROCESS | 18647 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59651/tests/dromaeo/cssquery-ext.html) 07:17:46 INFO - PROCESS | 18647 | RSS: Main: 168431616 07:17:46 INFO - PROCESS | 18647 | 07:20:48 INFO - PROCESS | 18647 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-ext.html (next: http://localhost:59651/tests/dromaeo/cssquery-jquery.html) 07:20:49 INFO - PROCESS | 18647 | RSS: Main: 168132608 07:20:49 INFO - PROCESS | 18647 | 07:23:51 INFO - PROCESS | 18647 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59651/tests/dromaeo/cssquery-mootools.html) 07:23:51 INFO - PROCESS | 18647 | RSS: Main: 166522880 07:23:51 INFO - PROCESS | 18647 | 07:26:53 INFO - PROCESS | 18647 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59651/tests/dromaeo/cssquery-prototype.html) 07:26:54 INFO - PROCESS | 18647 | RSS: Main: 164110336 07:26:54 INFO - PROCESS | 18647 | 07:29:56 INFO - PROCESS | 18647 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59651/tests/dromaeo/cssquery-yui.html) 07:29:56 INFO - PROCESS | 18647 | RSS: Main: 165470208 07:29:56 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-yui.html (next: http://localhost:59651/tests/dromaeo/cssquery-dojo.html) 07:32:59 INFO - PROCESS | 18647 | RSS: Main: 167436288 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | __start_tp_report 07:32:59 INFO - PROCESS | 18647 | _x_x_mozilla_page_load 07:32:59 INFO - PROCESS | 18647 | _x_x_mozilla_page_load_details 07:32:59 INFO - PROCESS | 18647 | |i|pagename|runs| 07:32:59 INFO - PROCESS | 18647 | |0;dojo.html;3081.6764239754825;3124.781265311428;3172.333809899921;3195.82422966737;3222.097812612469;5379.246905433242;5382.354117505895;5399.406065332815;5421.783128674858;5467.343918729758;5273.156294992802;5367.087595108831;5384.811531596395;5431.131019036955;5481.068218402881;4766.61867050636;4789.760511974405;4849.51504849514;4855.684380515255;4901.779419926094;4757.9056816932125;4995.625328100389;5000.274960130779;5009.4239162496415;5016.046951079302;4814.181589129839;4898.191798353268;4903.117438861003;4916.926246106311;4920.409550853885;4805.20714082176;4834.2990266411525;4844.612431005511;4849.175640141185;4890.706557606555;4823.9035219295765;4825.252085926687;4834.3473631059705;4839.05638400512;4851.078295123915;5128.974355128238;5233.790648374061;5243.292155558989;5300.92048619271;5302.708351040691;5714.79998200061;5745.2818397700285;5761.53907687384;5783.681897495636;5800.419958004208;5643.858903527444;5830.679312637803;5840.211571437844;5842.766289348421;5843.18195452637;5397.595180361449;5431.728413579305;5456.154296084113;5461.644993075437;5494.890102197974;5831.79588714393;5849.9177652134495;5870;5898.439648233497;5907.497862681635;5536.944630553723;5619.213310136584;5663.801766938137;5664.065429204217;5673.347565030074;5791.797287094932;5805.419458054161;5812.070068789058;5815.331236907725;5860;5574.1917421973585;5696.259486266842;5756.539476841843;5764.07774756037;5774;5682.6306290091015;5695.1741997410145;5698.544116470755;5721.971390143022;5748.109043098327;4312.417823593837;4366.301391777364;4368.388425620416;4374.103308821684;4404.471463424409;3801.8099095045136;3888.6889048876587;3893.201893611803;3942.8225729842225;3954.723169378116;5512;5517.586181036358;5522.337319521683;5540.168974653753;5562.276904002454;5769.653820770767;5775.104858746901;5813.982553053199;5827.271591051119;5827.650340979555;5355.839324820262;5428.864278393072;5445.401005889349;5521.696306703089;5542.501174894279;4956.851294461172;4963.851084467472;4966.553010229097;4968.503149685075;4982.10322142018;5899.439553242435;5926.8814623707285;5933.110033494924;5938.673372964442;5971.402859713994;5642.6614403135945;5751.511121554715;5751.712414379264;5802.5357971361345;5827.446392592697;5968.4926781224085;5969.104634304889;5969.194158788681;5973.850653733692;5982.371850955761;5637.464440878274;5688.11834165705;5689.800856969986;5706.572007099401;5717.828465146053;5678.602497825113;5799.420057994167;5828.6502809831545;5848.181254624271;5889.705514724333;5660.320761508646;5690.800821971211;5707.258056452634;5708.543316534584;5714.485696287354;5484.753186106555;5688.715564221689;5688.971555142198;5693.857653558694;5702.315722113373;5431.918521222264;5505.284313039279;5515.09001014828;5563.721813909207;5614.382417934105;5588.189712491585;5655.547556195576;5663.603547751618;5694.857628559319;5729.68486733217;5361.812336568201;5546.694931778629;5552.944470555242;5576.693281869536;5577.191307260344 07:32:59 INFO - PROCESS | 18647 | |1;ext.html;609.4332270987979;650.1840190560847;655.9540832141752;663.2571519897714;666.6799936030708;37497.62502374979;38375.23249535008;38429.61570384295;38531.422028669556;38565.22869542608;40496.59503404965;41277.380839287434;41327.38008929861;41373.99999999993;41412;8433.367497437686;8743.12568743127;8795.78010549735;8800.42797218182;8829.381943263974;8625.611847466847;8663.826723465527;8751.168638979287;8752.69365572205;8758.693445729401;8982.820343593125;8983.14660107292;9025.684101056464;9027.368084234105;9076.183143517115;8915.42049766763;8952.925648922139;8974.955125224398;8983.775405614846;8991.28069754418;8781.121887811169;8890;8896.19934205918;8900.37697361185;8912.153345432174;40361.78914632566;40627.7968610158;40644;40934.38598421026;40950.1809963802;3363.394588973984;3384.729221662261;3393.2704468539137;3575.570931488212;3657.871974480907;28489.85755071232;28579.857100714362;28761;30219.546706799414;31648.841755791305;4251.383549385353;4339.218940590724;4366.912661746779;4388.078503514266;4401.987542865127;269978;271109;271529;271958.999999998;272298;35860.10349741225;51129.74435127801;51260.487395126314;51777;51934.480655192965;34781.47827782585;34995.12512187165;35074.64925350714;35127.4730879037;35197.120071997895;12736.108472407028;12737.93631031839;12843.743125137631;12847.421866015864;12880.420381082873;10854.891451085388;10883.292585981886;10912.072473839813;10924.2899211551;10932.56269749201;8432.620532076071;8455.154484551496;8554.914450855536;8597.742067737978;8621.534339162357;3242.400155971153;3260.4783234682336;3270.2151483643756;3281.6062072551445;3327.800331980089;1043.6712435582767;1076.6500887211687;1112.0825319111766;1162.9649611845464;1202.1825158891863;31557.36885262328;31987;32075.839620802213;32542.186445339055;32853.67146328554;1155.058627218814;1161.9709507262216;1203.085654902263;1204.7048473124141;1213.7269114449177;16853.915730421268;16965.15174241283;16966.830331696772;17153.056581888115;17308;433956;445089;445993;446242;447537;55451;56349;56590;56627;56873;1349.5411560069426;1354.8170996915487;1361.0676686469799;1363.9999999999802;1386.81278027467;30379.544306835858;30762.53856192114;30960.53559196659;31068.22329441782;31272.530912035883;51301;51744;52013.479865202375;52105.47894521006;52123.47876521186;413361;414999;415776;417751;418897;26210.60684089702;26945.73054269432;28836.855815720788;29190.56214156747;29276.853615731787;40437.79781101194;40631;40846.38730418987;41207.79396103;41375.7931210342;39874.2025159501;40740.388894167205;41093.79453102715;41240.38139427851;41714.79142604268;39995.60004400035;40605.59394406018;40635;41050.38424423696;41710.165796683286;36603.633963660024;41612.16775664409;41641.37537936873;41961;42669.14661706811;31402.842985784926;33969.32061358709;34133.82933085319;34592.13519661928;34608;27267.86366068157;27541.586876196474;27713;27804;27834.103225548843 07:32:59 INFO - PROCESS | 18647 | |2;jquery.html;399.504614278295;400.52337718115456;404.94735684361035;407.22830236701435;408.5138684964892;13477.797833032513;15291.92354038231;17872.30213129752;18509.81490185096;18630.90684546577;16360.509184724477;16699.332026718916;16945.576360590992;16961.66076678466;17013;5156.303898973638;5335.093034184179;5386.111291636876;5850.6782126983;5884.735186916599;5630.887382252373;5812.360640329561;5819.7963071292515;5821.53427725781;5867.11993201019;5673.447168520345;5712.0860662293835;5723.627964182336;5732.2548068751;5748.683822389788;5670.716464176775;5768.42315768424;5777.855553611152;5808.82573522795;5812.0119579671555;4995.375578052744;5162.22566615007;5175.275461435402;5180.222966555047;5184.507471790174;12218.816717749241;12920.741585168338;13479.326033698277;13592.93203533976;13619.727605447935;2313.41008042948;2344.2146880794953;2489.6390023446497;2651.68179818423;2886.826790392583;8757.430767000189;9427.717168484956;9460.148586627236;9555.761105972337;9568.138867501888;1838.6598479281377;1855.7494738210303;1869.4952362862086;1870.3453791173117;1931.169597073258;67927.66036169836;79867.6006619969;81579;81791;82767;10753.623623173151;10952.890471095347;11065.114790816715;11070.335779853234;11086.334819910831;15572.844271557366;15590.220488975507;15667;15829.841701582836;15864.968777029457;7094.858102837914;7576.3181313682035;7765.53406795594;7990.480618759762;8026.357891368676;6678.3989440950545;6761.729530818712;6762.932370676231;6933.895991560131;7007.719691212396;4624.44506659203;4687.484376718558;4708.764561771898;4745.406824146981;4774.737389443544;1755.7454169145403;1926.3546711851407;1977.4957385866799;2008.7388639476774;2012.1448384436555;925.486355072941;964.0889359555154;1001.1840350114634;1037.4812593703148;1091.1543553745753;17749.201285942163;18700.81299186991;19359;19463.80536194648;19587.118579663664;976.1653786012998;995.2684776689127;1000.5897581991348;1038.2991480750463;1076.3057827701089;10755.83866242007;10817.945910270399;10908.072813810757;10920.399378034284;10958.671239862817;477648;488597;492536;495184.86113541626;497021;88286.55856720675;88913;89400.5529972346;89557.55221223983;90094.54952725195;1027.8509616105623;1040.573364920379;1093.1801149138146;1105.364415461097;1108.9722756931142;16743.74884376711;16998;17102.14489275556;17185.742213866553;17393.478195654152;27184;28009.719902801527;34735.13162170966;35532.64467355293;37781.2443751118;50942.74528627333;54042.459575403744;54284.45715542794;54448.45551544434;54787.72606136944;8282.296004839656;8317.875231871405;8462.323014158976;8466.830663386821;8502.022267439324;11701.239419437708;13372.197668139943;13448.1258718183;13573.660658483617;13661.726765464833;11257.662270131908;11563.248388854698;11568.884311157117;11584.073274138218;12317.260964342167;11578.652640420802;11742.530298788295;11804.3507607079;11881.5841445549;11920.880791192323;11899.881001189877;11951.282923024646;12017.759644807229;12263.202891812003;12331.876681233072;8089.029316481824;8102.392320575863;8117.715879944174;8178.323443693909;8269.875951860606;8212.712555060543;11475.426228688366;11930.284182949052;11974.161808673658;12021.158518903592 07:32:59 INFO - PROCESS | 18647 | |3;mootools.html;1251.3242848861614;1345.858684838092;1376.0711519724184;1729.71459709148;1734.2802736864203;7168.498205125643;7902.644381002854;8033.91966080339;8122.796930076751;8131.634076466558;8052.63763130659;8092.554909479976;8132.26809587137;8136.186381361861;8144.06343270524;2233.363491404954;2257.413072601119;2273.2839155665997;2274.7725227477285;2280.486890449652;2240.003198576634;2248.763879792623;2257.762934891837;2258.096761295487;2264.3433404312727;2253.2226381898217;2263.3066650685714;2271.0802125139344;2289.622212334971;2292.255017119443;2207;2207.0178770447155;2214.30249471416;2215.324326080545;2222.677711731806;2197.450637340665;2199.9340019799433;2205.9669104963436;2220.2340192633515;2222.744384395799;8454.112318206562;8507.659693612248;8570.957145214297;8576.485410875368;8579.356548258844;4764.166270902579;4888.242322439992;4931.309616653672;4937.654364194508;4943;3222.887198948049;3286.8520916558814;3326.700596946262;3353.7820041697455;3360.2103505676146;1136.1649187846926;1152.4007516091585;1156.19066653343;1163.8021536338842;1175.7942360087036;11809.350485723282;11843.526258949632;11861.229020113666;11863.288202707865;11867.169298149132;4343.4353534041;4410.4927933287445;4522.321651752263;4541.795619197078;4557.407537020166;9994.650187243411;10018.448985305879;10022;10033.046860548237;10042;5146.228065790161;5147.897042059138;5147.948520514747;5173.81891633791;5181.481851814789;4085.8569950051606;4709.62323014158;4737.052589482118;4754.7147171169845;4754.833580824655;3956.4658771066115;3974.5627980922077;3997.300472417315;4039.9596004040172;4080.8775736727944;1286.6783304173957;1320.630223537411;1324.8741369569875;1341.9329033548283;1346.4681450827065;961.6586111930164;965.6571916969515;970.2286682087757;985.556499575194;1001.4041645221082;5749.88500229993;5874.265716785402;5926.140709597084;5934.584579079509;5985.431384018511;394.05820089984957;407.4011203530805;409.9118689481716;416.1282113971225;419.0863916661707;4071.694622903294;4088.3254263046265;4095.9590404096175;4097.385392191195;4102.343625020042;10284.434356110485;10467.685969420929;10484;10619.36283822973;10646.414447205323;10504;10534.683959481228;10550.525226364833;10552.050315471492;10572.41851698164;7784.065912090586;7834.608269586384;7856.332211762065;7869.960650196713;7896.723614673574;5823.272090988627;5873.9412605873395;5932.080527518242;6014.879702405839;6038.396160384103;9492.477913714813;9557.474338911426;9655.324127311022;9952.402855828674;9966;9560.56977436031;9740.951295243478;9810.215182785503;9825.115739583473;9932.652357167464;6876.793696189123;7442.255774422514;7578.54528728256;7810.921890781019;8082.555459449787;8195.754127376189;8205.507669539847;8255.752327430188;8291.95854020726;8301.58492075406;7347.485676002629;7504;7610.429217808576;7620.352270056886;7719.3052625264;7328.743493977899;7383.852322953403;7410.5183163094225;7464.290892365217;7478.401727861649;6602.10871532337;6763.425108865801;6768.357006084414;6777.491688123509;6802.829929251809;5168.664036837594;5241.266222728745;5279.709615971158;5351.625386222927;5354.54486368663;5315.681059136464;5323;5345.572354211576;5375.220593014069;5448.482394172547 07:32:59 INFO - PROCESS | 18647 | |4;prototype.html;317.18958062151194;319.7394123789112;320.9695078967498;325.7442907317756;330.6775893503834;6032.366601506839;6087.817365479037;6116;6135.785247516338;6144.385561443864;5989.251343582052;6021.608595441293;6028.75884964602;6033.818985430433;6046.727897244624;4300.505441874186;4313.547077556843;4399.538048504909;4512.729236245819;4527.7400271804245;4486.214912390335;4510.097980403916;4528.117017181651;4531.524189960056;4534.1385136824065;4439.955600444003;4487.1025794841;4487.551244875503;4493.662975276851;4498.730076195422;4386.837488065665;4509.413776209089;4516.638668906479;4521.050579378301;4533.795979180944;3975.46944426395;3987;3993.1813978134705;3996.320625493673;4005.1989602079702;5718.71406429681;5743.712814359265;5750.137479378127;5757.704516483757;5764.452377024176;5134.101532231844;5271.973640131813;5273.129933560957;5288.312519372495;5291.4708529147165;6243.282022567372;6245.314514758652;6286.14558705183;6288.685565721696;6293.199526210838;4259.76571288579;4403.6256918162;4407.955920440787;4411.360352748866;4414.227510185705;6534.183227096613;6552.7378904843745;6552.967235163841;6555.93444065558;6571.967140164268;4485.708428952108;4486.285797092777;4488.865334039984;4489.618382437529;4535.3694856982875;4411.713238639542;4559.430071241095;4560.612347950461;4571.839985600488;4583.770811459413;5208.479152084761;5213.713245771443;5230.097296000756;5232;5244.108501554745;6344.460720838781;6357.841053973595;6357.982722764335;6362.9045564316575;6363.872722545523;1563.725563665609;1566.929488173035;1573.9527814165594;1595.7526583379595;1598.472504073653;970.7233438470003;1044.4882007816116;1050.669039252633;1071.9464026798628;1073.9140868730483;5980.700964951822;6080.969595151996;6087.756489740361;6091.878162436815;6108.205933228652;6447.613143211329;6467.547271690936;6515.837104072436;6522.836929076716;6525.543211975211;5951.226340575698;6081.239845019372;6084.209052823193;6084.726187321581;6097.878042439126;3446.3968805458944;3476.11359103427;3476.704480119168;3497.761432683085;3501.1072176595317;6438.420542151229;6610.206775187008;6654.86690266192;6676.53264271506;6732.3267673232285;6559.311272316433;6574.80275591733;6580.473562115019;6612.471002319803;6667.266600673922;6531.8693626127215;6632.535722499379;6653.600783952978;6688.632125233062;6694.899576506356;6458.38645328693;6470.805875823733;6471.838204044749;6487.513436492188;6492.156019717407;6276.6547839869245;6297.244330680348;6405.903911441239;6410.4294447860575;6429.7106630200815;6660.068580111713;6673.866522669617;6680.699368528525;6694.933050669431;6704.83237919056;4483.461984561874;4490.214212512862;4501.707389019703;4504.864854054384;4521.118381915495;6269.404406581368;6493.480521558169;6513.446357059703;6514.54398192141;6525;6252.374762523711;6298.338674439118;6304.406488301624;6307.621542707452;6318.210223722035;6108.389161083856;6270.655113968775;6295.874082518416;6313.337099604659;6452.161219041494;6108.5723999319625;6295.559310848196;6297.307296197323;6311.715972781144;6316.684165791784;6473.287938326686;6486.967565162144;6492.772752953624;6505.8698826024165;6530;6114.510839132769;6260;6308.369163083655;6336;6346.270178929482 07:32:59 INFO - PROCESS | 18647 | |5;yui.html;698.5983059740648;723.9565626062437;779.0962483519119;816.8733846253829;820;12807.871921280785;13165.934170329147;13202.735945281089;13401;13417.396217170226;13057.151285166457;13122.147060441064;13173.670658233548;13210.40553175107;13238.139520931158;651.2543138106877;767.0450289389689;795.2683531151355;795.4193438789687;795.757294025322;786.2412771675332;786.6460092958163;788.8343447875953;791.3550456378033;793.3851265269434;824.6948629007276;830.161536847782;831.2186544648042;835.1982097186708;836.2640876029086;818.3207937411934;819.0989911097804;824.406427372291;824.9628766705513;826.0871736730946;596.0344242327413;601.5338112962489;602.0788194063047;604.5979423683245;606.6511755740466;13485.797713034215;13543.119697219749;13554.322283885866;13564.253966031863;13579.796303055462;13374.598762037154;13414.46342146313;13451;13632.795508067387;13658;11084;11153.498092585773;11248.15638827083;11430.771384572345;11430.828537571942;3856.3058649443087;3877.0888841122314;3889.1638297765835;3897.1815918657117;3914.9804250978846;54675.72662136704;55489.44510554883;55922.44077559213;56104.15843762347;56439.71780141114;10817.783644327226;10841.13270938323;10863.239573229956;10895.583574135311;10906.672799816019;19336;19548.02259887;19581.706274405897;19687.901560492104;19708.901455492916;8123;8291.461055031403;8294.58527073656;8315.376346774015;8404.243618074403;4749.501302363271;4821.662483626113;4930.9013819723405;5055.797768089235;5057.393112826411;3050.9847450762604;3146.0719087869134;3147.5750773645723;3147.716705496516;3157.3369592385397;587.5563949218313;594.5481434110108;595.6426144313377;600.2886579403333;609.6981993912952;678.4470656415006;700.7932659865352;701.235653138082;706.2795948132875;715.5170260074428;9150.450972941644;9520.761980950532;9558.474283914451;9568.282378821477;9729.318947673595;690.81348036031;694.4028135803205;698.6052880122714;705.989410158848;716.4375964867554;4443.755593442327;4493.5281795411665;4573.565511276423;4629.282461218517;4750.501197374295;54199.45800542023;55915.72042139763;56353.7182314094;56415.43584564102;57071.14393284104;48118.5188148121;48631.75684121627;48793.756031219615;49455.75272123616;50161.74919125454;48384;49478.257826132634;49740.502594974314;50349.244761328606;50895.23657145072;9265.44407335562;9449.811003780023;9562.091601297865;9653.276004299565;9744.415335079917;33440.665593344725;34118.14704632305;35025.64974350224;35602.8219858899;36619.63380366162;49001.5099848997;49774.50225497843;49781.253281200086;50752;51043.48956510536;12844.935775321064;13091.410886509939;13128.277944713132;13484.865151348753;13516.729665406834;13093.934530327288;13181.670458238621;13187.67030824237;13840.930795346361;14091.154530728189;12890.935545322214;12894.41975111141;12939.094263401472;13058.934705326412;13071.673208169492;12526.311052892179;12606.55877044299;12680.619581412573;12721.491140354652;12768.6807829805;12911.935440322739;13115.409806558537;13149.934250328688;13164.012699047418;13375;10715.785684286426;10762.340804126634;11098;11149.219554631423;11176.105911526896;10849.620263290746;11080.168987325822;11085.445727713743;11170.49732762044;11192 07:32:59 INFO - PROCESS | 18647 | __end_tp_report 07:32:59 INFO - PROCESS | 18647 | __start_cc_report 07:32:59 INFO - PROCESS | 18647 | _x_x_mozilla_cycle_collect,340 07:32:59 INFO - PROCESS | 18647 | __end_cc_report 07:32:59 INFO - PROCESS | 18647 | __startTimestamp1461162779523__endTimestamp 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | ------- Summary: start ------- 07:32:59 INFO - PROCESS | 18647 | Number of tests: 6 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | [#0] dojo.html Cycles:165 Average:5350.08 Median:5562.28 stddev:613.26 (11.0%) stddev-sans-first:588.75 07:32:59 INFO - PROCESS | 18647 | Values: 3081.7 3124.8 3172.3 3195.8 3222.1 5379.2 5382.4 5399.4 5421.8 5467.3 5273.2 5367.1 5384.8 5431.1 5481.1 4766.6 4789.8 4849.5 4855.7 4901.8 4757.9 4995.6 5000.3 5009.4 5016.0 4814.2 4898.2 4903.1 4916.9 4920.4 4805.2 4834.3 4844.6 4849.2 4890.7 4823.9 4825.3 4834.3 4839.1 4851.1 5129.0 5233.8 5243.3 5300.9 5302.7 5714.8 5745.3 5761.5 5783.7 5800.4 5643.9 5830.7 5840.2 5842.8 5843.2 5397.6 5431.7 5456.2 5461.6 5494.9 5831.8 5849.9 5870.0 5898.4 5907.5 5536.9 5619.2 5663.8 5664.1 5673.3 5791.8 5805.4 5812.1 5815.3 5860.0 5574.2 5696.3 5756.5 5764.1 5774.0 5682.6 5695.2 5698.5 5722.0 5748.1 4312.4 4366.3 4368.4 4374.1 4404.5 3801.8 3888.7 3893.2 3942.8 3954.7 5512.0 5517.6 5522.3 5540.2 5562.3 5769.7 5775.1 5814.0 5827.3 5827.7 5355.8 5428.9 5445.4 5521.7 5542.5 4956.9 4963.9 4966.6 4968.5 4982.1 5899.4 5926.9 5933.1 5938.7 5971.4 5642.7 5751.5 5751.7 5802.5 5827.4 5968.5 5969.1 5969.2 5973.9 5982.4 5637.5 5688.1 5689.8 5706.6 5717.8 5678.6 5799.4 5828.7 5848.2 5889.7 5660.3 5690.8 5707.3 5708.5 5714.5 5484.8 5688.7 5689.0 5693.9 5702.3 5431.9 5505.3 5515.1 5563.7 5614.4 5588.2 5655.5 5663.6 5694.9 5729.7 5361.8 5546.7 5552.9 5576.7 5577.2 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | [#1] ext.html Cycles:180 Average:52715.21 Median:40467.20 stddev:101851.13 (251.7%) stddev-sans-first:102061.71 07:32:59 INFO - PROCESS | 18647 | Values: 609.4 650.2 656.0 663.3 666.7 37497.6 38375.2 38429.6 38531.4 38565.2 40496.6 41277.4 41327.4 41374.0 41412.0 8433.4 8743.1 8795.8 8800.4 8829.4 8625.6 8663.8 8751.2 8752.7 8758.7 8982.8 8983.1 9025.7 9027.4 9076.2 8915.4 8952.9 8975.0 8983.8 8991.3 8781.1 8890.0 8896.2 8900.4 8912.2 40361.8 40627.8 40644.0 40934.4 40950.2 3363.4 3384.7 3393.3 3575.6 3657.9 28489.9 28579.9 28761.0 30219.5 31648.8 4251.4 4339.2 4366.9 4388.1 4402.0 269978.0 271109.0 271529.0 271959.0 272298.0 35860.1 51129.7 51260.5 51777.0 51934.5 34781.5 34995.1 35074.6 35127.5 35197.1 12736.1 12737.9 12843.7 12847.4 12880.4 10854.9 10883.3 10912.1 10924.3 10932.6 8432.6 8455.2 8554.9 8597.7 8621.5 3242.4 3260.5 3270.2 3281.6 3327.8 1043.7 1076.7 1112.1 1163.0 1202.2 31557.4 31987.0 32075.8 32542.2 32853.7 1155.1 1162.0 1203.1 1204.7 1213.7 16853.9 16965.2 16966.8 17153.1 17308.0 433956.0 445089.0 445993.0 446242.0 447537.0 55451.0 56349.0 56590.0 56627.0 56873.0 1349.5 1354.8 1361.1 1364.0 1386.8 30379.5 30762.5 30960.5 31068.2 31272.5 51301.0 51744.0 52013.5 52105.5 52123.5 413361.0 414999.0 415776.0 417751.0 418897.0 26210.6 26945.7 28836.9 29190.6 29276.9 40437.8 40631.0 40846.4 41207.8 41375.8 39874.2 40740.4 41093.8 41240.4 41714.8 39995.6 40605.6 40635.0 41050.4 41710.2 36603.6 41612.2 41641.4 41961.0 42669.1 31402.8 33969.3 34133.8 34592.1 34608.0 27267.9 27541.6 27713.0 27804.0 27834.1 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | [#2] jquery.html Cycles:180 Average:27990.48 Median:15448.27 stddev:80749.83 (522.7%) stddev-sans-first:80949.77 07:32:59 INFO - PROCESS | 18647 | Values: 399.5 400.5 404.9 407.2 408.5 13477.8 15291.9 17872.3 18509.8 18630.9 16360.5 16699.3 16945.6 16961.7 17013.0 5156.3 5335.1 5386.1 5850.7 5884.7 5630.9 5812.4 5819.8 5821.5 5867.1 5673.4 5712.1 5723.6 5732.3 5748.7 5670.7 5768.4 5777.9 5808.8 5812.0 4995.4 5162.2 5175.3 5180.2 5184.5 12218.8 12920.7 13479.3 13592.9 13619.7 2313.4 2344.2 2489.6 2651.7 2886.8 8757.4 9427.7 9460.1 9555.8 9568.1 1838.7 1855.7 1869.5 1870.3 1931.2 67927.7 79867.6 81579.0 81791.0 82767.0 10753.6 10952.9 11065.1 11070.3 11086.3 15572.8 15590.2 15667.0 15829.8 15865.0 7094.9 7576.3 7765.5 7990.5 8026.4 6678.4 6761.7 6762.9 6933.9 7007.7 4624.4 4687.5 4708.8 4745.4 4774.7 1755.7 1926.4 1977.5 2008.7 2012.1 925.5 964.1 1001.2 1037.5 1091.2 17749.2 18700.8 19359.0 19463.8 19587.1 976.2 995.3 1000.6 1038.3 1076.3 10755.8 10817.9 10908.1 10920.4 10958.7 477648.0 488597.0 492536.0 495184.9 497021.0 88286.6 88913.0 89400.6 89557.6 90094.5 1027.9 1040.6 1093.2 1105.4 1109.0 16743.7 16998.0 17102.1 17185.7 17393.5 27184.0 28009.7 34735.1 35532.6 37781.2 50942.7 54042.5 54284.5 54448.5 54787.7 8282.3 8317.9 8462.3 8466.8 8502.0 11701.2 13372.2 13448.1 13573.7 13661.7 11257.7 11563.2 11568.9 11584.1 12317.3 11578.7 11742.5 11804.4 11881.6 11920.9 11899.9 11951.3 12017.8 12263.2 12331.9 8089.0 8102.4 8117.7 8178.3 8269.9 8212.7 11475.4 11930.3 11974.2 12021.2 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | [#3] mootools.html Cycles:180 Average:5608.16 Median:4826.20 stddev:3168.62 (65.7%) stddev-sans-first:3160.59 07:32:59 INFO - PROCESS | 18647 | Values: 1251.3 1345.9 1376.1 1729.7 1734.3 7168.5 7902.6 8033.9 8122.8 8131.6 8052.6 8092.6 8132.3 8136.2 8144.1 2233.4 2257.4 2273.3 2274.8 2280.5 2240.0 2248.8 2257.8 2258.1 2264.3 2253.2 2263.3 2271.1 2289.6 2292.3 2207.0 2207.0 2214.3 2215.3 2222.7 2197.5 2199.9 2206.0 2220.2 2222.7 8454.1 8507.7 8571.0 8576.5 8579.4 4764.2 4888.2 4931.3 4937.7 4943.0 3222.9 3286.9 3326.7 3353.8 3360.2 1136.2 1152.4 1156.2 1163.8 1175.8 11809.4 11843.5 11861.2 11863.3 11867.2 4343.4 4410.5 4522.3 4541.8 4557.4 9994.7 10018.4 10022.0 10033.0 10042.0 5146.2 5147.9 5147.9 5173.8 5181.5 4085.9 4709.6 4737.1 4754.7 4754.8 3956.5 3974.6 3997.3 4040.0 4080.9 1286.7 1320.6 1324.9 1341.9 1346.5 961.7 965.7 970.2 985.6 1001.4 5749.9 5874.3 5926.1 5934.6 5985.4 394.1 407.4 409.9 416.1 419.1 4071.7 4088.3 4096.0 4097.4 4102.3 10284.4 10467.7 10484.0 10619.4 10646.4 10504.0 10534.7 10550.5 10552.1 10572.4 7784.1 7834.6 7856.3 7870.0 7896.7 5823.3 5873.9 5932.1 6014.9 6038.4 9492.5 9557.5 9655.3 9952.4 9966.0 9560.6 9741.0 9810.2 9825.1 9932.7 6876.8 7442.3 7578.5 7810.9 8082.6 8195.8 8205.5 8255.8 8292.0 8301.6 7347.5 7504.0 7610.4 7620.4 7719.3 7328.7 7383.9 7410.5 7464.3 7478.4 6602.1 6763.4 6768.4 6777.5 6802.8 5168.7 5241.3 5279.7 5351.6 5354.5 5315.7 5323.0 5345.6 5375.2 5448.5 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | [#4] prototype.html Cycles:180 Average:5273.96 Median:6086.24 stddev:1595.86 (26.2%) stddev-sans-first:1556.37 07:32:59 INFO - PROCESS | 18647 | Values: 317.2 319.7 321.0 325.7 330.7 6032.4 6087.8 6116.0 6135.8 6144.4 5989.3 6021.6 6028.8 6033.8 6046.7 4300.5 4313.5 4399.5 4512.7 4527.7 4486.2 4510.1 4528.1 4531.5 4534.1 4440.0 4487.1 4487.6 4493.7 4498.7 4386.8 4509.4 4516.6 4521.1 4533.8 3975.5 3987.0 3993.2 3996.3 4005.2 5718.7 5743.7 5750.1 5757.7 5764.5 5134.1 5272.0 5273.1 5288.3 5291.5 6243.3 6245.3 6286.1 6288.7 6293.2 4259.8 4403.6 4408.0 4411.4 4414.2 6534.2 6552.7 6553.0 6555.9 6572.0 4485.7 4486.3 4488.9 4489.6 4535.4 4411.7 4559.4 4560.6 4571.8 4583.8 5208.5 5213.7 5230.1 5232.0 5244.1 6344.5 6357.8 6358.0 6362.9 6363.9 1563.7 1566.9 1574.0 1595.8 1598.5 970.7 1044.5 1050.7 1071.9 1073.9 5980.7 6081.0 6087.8 6091.9 6108.2 6447.6 6467.5 6515.8 6522.8 6525.5 5951.2 6081.2 6084.2 6084.7 6097.9 3446.4 3476.1 3476.7 3497.8 3501.1 6438.4 6610.2 6654.9 6676.5 6732.3 6559.3 6574.8 6580.5 6612.5 6667.3 6531.9 6632.5 6653.6 6688.6 6694.9 6458.4 6470.8 6471.8 6487.5 6492.2 6276.7 6297.2 6405.9 6410.4 6429.7 6660.1 6673.9 6680.7 6694.9 6704.8 4483.5 4490.2 4501.7 4504.9 4521.1 6269.4 6493.5 6513.4 6514.5 6525.0 6252.4 6298.3 6304.4 6307.6 6318.2 6108.4 6270.7 6295.9 6313.3 6452.2 6108.6 6295.6 6297.3 6311.7 6316.7 6473.3 6487.0 6492.8 6505.9 6530.0 6114.5 6260.0 6308.4 6336.0 6346.3 07:32:59 INFO - PROCESS | 18647 | 07:32:59 INFO - PROCESS | 18647 | [#5] yui.html Cycles:180 Average:14683.60 Median:26434.51 stddev:16596.60 (62.8%) stddev-sans-first:16609.93 07:32:59 INFO - PROCESS | 18647 | Values: 698.6 724.0 779.1 816.9 820.0 12807.9 13165.9 13202.7 13401.0 13417.4 13057.2 13122.1 13173.7 13210.4 13238.1 651.3 767.0 795.3 795.4 795.8 786.2 786.6 788.8 791.4 793.4 824.7 830.2 831.2 835.2 836.3 818.3 819.1 824.4 825.0 826.1 596.0 601.5 602.1 604.6 606.7 13485.8 13543.1 13554.3 13564.3 13579.8 13374.6 13414.5 13451.0 13632.8 13658.0 11084.0 11153.5 11248.2 11430.8 11430.8 3856.3 3877.1 3889.2 3897.2 3915.0 54675.7 55489.4 55922.4 56104.2 56439.7 10817.8 10841.1 10863.2 10895.6 10906.7 19336.0 19548.0 19581.7 19687.9 19708.9 8123.0 8291.5 8294.6 8315.4 8404.2 4749.5 4821.7 4930.9 5055.8 5057.4 3051.0 3146.1 3147.6 3147.7 3157.3 587.6 594.5 595.6 600.3 609.7 678.4 700.8 701.2 706.3 715.5 9150.5 9520.8 9558.5 9568.3 9729.3 690.8 694.4 698.6 706.0 716.4 4443.8 4493.5 4573.6 4629.3 4750.5 54199.5 55915.7 56353.7 56415.4 57071.1 48118.5 48631.8 48793.8 49455.8 50161.7 48384.0 49478.3 49740.5 50349.2 50895.2 9265.4 9449.8 9562.1 9653.3 9744.4 33440.7 34118.1 35025.6 35602.8 36619.6 49001.5 49774.5 49781.3 50752.0 51043.5 12844.9 13091.4 13128.3 13484.9 13516.7 13093.9 13181.7 13187.7 13840.9 14091.2 12890.9 12894.4 12939.1 13058.9 13071.7 12526.3 12606.6 12680.6 12721.5 12768.7 12911.9 13115.4 13149.9 13164.0 13375.0 10715.8 10762.3 11098.0 11149.2 11176.1 10849.6 11080.2 11085.4 11170.5 11192.0 07:32:59 INFO - PROCESS | 18647 | -------- Summary: end -------- 07:32:59 INFO - PROCESS | 18647 | 07:33:00 INFO - TEST-INFO | 18647: exit 0 07:33:00 INFO - TEST-OK | dromaeo_css | took 1109181ms 07:33:00 INFO - TEST-START | kraken 07:33:00 INFO - operating with platform_type : linux_ 07:33:00 INFO - Initialising browser for kraken test... 07:33:00 INFO - TEST-INFO | started process 18886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5S9yJn/profile http://localhost:59651/getInfo.html) 07:33:03 INFO - PROCESS | 18886 | 07:33:03 INFO - PROCESS | 18886 | (process:18953): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:33:04 INFO - PROCESS | 18886 | __metrics Screen width/height:1600/1200 07:33:04 INFO - PROCESS | 18886 | colorDepth:24 07:33:04 INFO - PROCESS | 18886 | Browser inner width/height: 1024/697 07:33:04 INFO - PROCESS | 18886 | __metrics 07:33:05 ERROR - PROCESS | 18886 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:33:06 INFO - TEST-INFO | 18886: exit 0 07:33:06 INFO - Browser initialized. 07:33:06 INFO - Running cycle 1/1 for kraken test... 07:33:06 INFO - TEST-INFO | started process 19004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5S9yJn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:07 INFO - PROCESS | 19004 | 07:33:07 INFO - PROCESS | 19004 | (process:19067): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:33:17 INFO - PROCESS | 19004 | RSS: Main: 163729408 07:33:17 INFO - PROCESS | 19004 | 07:33:20 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-beat-detection) 07:33:21 INFO - PROCESS | 19004 | RSS: Main: 168341504 07:33:21 INFO - PROCESS | 19004 | 07:33:24 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-dft) 07:33:24 INFO - PROCESS | 19004 | RSS: Main: 171966464 07:33:24 INFO - PROCESS | 19004 | 07:33:27 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-fft) 07:33:28 INFO - PROCESS | 19004 | RSS: Main: 163467264 07:33:28 INFO - PROCESS | 19004 | 07:33:30 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-oscillator) 07:33:30 INFO - PROCESS | 19004 | RSS: Main: 163512320 07:33:30 INFO - PROCESS | 19004 | 07:33:33 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:33 INFO - PROCESS | 19004 | RSS: Main: 163790848 07:33:33 INFO - PROCESS | 19004 | 07:33:36 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59651/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:37 INFO - PROCESS | 19004 | RSS: Main: 164048896 07:33:37 INFO - PROCESS | 19004 | 07:33:40 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59651/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:41 INFO - PROCESS | 19004 | RSS: Main: 163692544 07:33:41 INFO - PROCESS | 19004 | 07:33:44 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59651/tests/kraken/driver.html?testName=json-parse-financial) 07:33:44 INFO - PROCESS | 19004 | RSS: Main: 164126720 07:33:44 INFO - PROCESS | 19004 | 07:33:46 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:47 INFO - PROCESS | 19004 | RSS: Main: 164409344 07:33:47 INFO - PROCESS | 19004 | 07:33:48 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:49 INFO - PROCESS | 19004 | RSS: Main: 164429824 07:33:49 INFO - PROCESS | 19004 | 07:33:51 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:52 INFO - PROCESS | 19004 | RSS: Main: 164544512 07:33:52 INFO - PROCESS | 19004 | 07:33:54 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:55 INFO - PROCESS | 19004 | RSS: Main: 165326848 07:33:55 INFO - PROCESS | 19004 | 07:33:58 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:58 INFO - PROCESS | 19004 | RSS: Main: 165572608 07:33:58 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59651/tests/kraken/driver.html?testName=ai-astar) 07:34:00 INFO - PROCESS | 19004 | RSS: Main: 166686720 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | __start_tp_report 07:34:00 INFO - PROCESS | 19004 | _x_x_mozilla_page_load 07:34:00 INFO - PROCESS | 19004 | _x_x_mozilla_page_load_details 07:34:00 INFO - PROCESS | 19004 | |i|pagename|runs| 07:34:00 INFO - PROCESS | 19004 | |0;ai-astar;112;106;111;111;113;123;110;112;110;111 07:34:00 INFO - PROCESS | 19004 | |1;audio-beat-detection;160;130;156;184;128;151;158;133;187;136 07:34:00 INFO - PROCESS | 19004 | |2;audio-dft;162;162;163;163;162;165;171;166;167;163 07:34:00 INFO - PROCESS | 19004 | |3;audio-fft;77;73;74;161;76;77;78;76;98;75 07:34:00 INFO - PROCESS | 19004 | |4;audio-oscillator;94;93;156;93;92;92;146;92;92;146 07:34:00 INFO - PROCESS | 19004 | |5;imaging-gaussian-blur;117;118;118;120;117;117;117;117;117;117 07:34:00 INFO - PROCESS | 19004 | |6;imaging-darkroom;146;146;146;146;146;147;147;147;147;147 07:34:00 INFO - PROCESS | 19004 | |7;imaging-desaturate;95;96;95;95;95;95;96;95;95;95 07:34:00 INFO - PROCESS | 19004 | |8;json-parse-financial;56;60;56;56;57;63;57;75;56;58 07:34:00 INFO - PROCESS | 19004 | |9;json-stringify-tinderbox;60;61;61;61;60;62;61;66;61;61 07:34:00 INFO - PROCESS | 19004 | |10;stanford-crypto-aes;77;76;77;77;79;78;80;78;78;80 07:34:00 INFO - PROCESS | 19004 | |11;stanford-crypto-ccm;126;126;123;125;124;125;134;128;155;128 07:34:00 INFO - PROCESS | 19004 | |12;stanford-crypto-pbkdf2;167;173;175;169;168;173;163;177;167;165 07:34:00 INFO - PROCESS | 19004 | |13;stanford-crypto-sha256-iterative;68;69;69;67;69;70;72;67;69;70 07:34:00 INFO - PROCESS | 19004 | __end_tp_report 07:34:00 INFO - PROCESS | 19004 | __start_cc_report 07:34:00 INFO - PROCESS | 19004 | _x_x_mozilla_cycle_collect,801 07:34:00 INFO - PROCESS | 19004 | __end_cc_report 07:34:00 INFO - PROCESS | 19004 | __startTimestamp1461162840697__endTimestamp 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | ------- Summary: start ------- 07:34:00 INFO - PROCESS | 19004 | Number of tests: 14 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.33 (3.9%) stddev-sans-first:4.59 07:34:00 INFO - PROCESS | 19004 | Values: 112.0 106.0 111.0 111.0 113.0 123.0 110.0 112.0 110.0 111.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:157.00 stddev:21.19 (13.5%) stddev-sans-first:22.29 07:34:00 INFO - PROCESS | 19004 | Values: 160.0 130.0 156.0 184.0 128.0 151.0 158.0 133.0 187.0 136.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.91 (1.8%) stddev-sans-first:2.96 07:34:00 INFO - PROCESS | 19004 | Values: 162.0 162.0 163.0 163.0 162.0 165.0 171.0 166.0 167.0 163.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#3] audio-fft Cycles:10 Average:86.50 Median:76.50 stddev:27.13 (35.5%) stddev-sans-first:28.56 07:34:00 INFO - PROCESS | 19004 | Values: 77.0 73.0 74.0 161.0 76.0 77.0 78.0 76.0 98.0 75.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:27.56 (30.0%) stddev-sans-first:28.65 07:34:00 INFO - PROCESS | 19004 | Values: 94.0 93.0 156.0 93.0 92.0 92.0 146.0 92.0 92.0 146.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 07:34:00 INFO - PROCESS | 19004 | Values: 117.0 118.0 118.0 120.0 117.0 117.0 117.0 117.0 117.0 117.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:34:00 INFO - PROCESS | 19004 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:34:00 INFO - PROCESS | 19004 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:57.50 stddev:5.93 (10.3%) stddev-sans-first:6.16 07:34:00 INFO - PROCESS | 19004 | Values: 56.0 60.0 56.0 56.0 57.0 63.0 57.0 75.0 56.0 58.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.71 (2.8%) stddev-sans-first:1.74 07:34:00 INFO - PROCESS | 19004 | Values: 60.0 61.0 61.0 61.0 60.0 62.0 61.0 66.0 61.0 61.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:1.33 (1.7%) stddev-sans-first:1.36 07:34:00 INFO - PROCESS | 19004 | Values: 77.0 76.0 77.0 77.0 79.0 78.0 80.0 78.0 78.0 80.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:127.00 stddev:9.50 (7.5%) stddev-sans-first:10.00 07:34:00 INFO - PROCESS | 19004 | Values: 126.0 126.0 123.0 125.0 124.0 125.0 134.0 128.0 155.0 128.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:171.00 stddev:4.57 (2.7%) stddev-sans-first:4.74 07:34:00 INFO - PROCESS | 19004 | Values: 167.0 173.0 175.0 169.0 168.0 173.0 163.0 177.0 167.0 165.0 07:34:00 INFO - PROCESS | 19004 | 07:34:00 INFO - PROCESS | 19004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.54 07:34:00 INFO - PROCESS | 19004 | Values: 68.0 69.0 69.0 67.0 69.0 70.0 72.0 67.0 69.0 70.0 07:34:00 INFO - PROCESS | 19004 | -------- Summary: end -------- 07:34:00 INFO - PROCESS | 19004 | 07:34:01 INFO - TEST-INFO | 19004: exit 0 07:34:01 INFO - TEST-OK | kraken | took 61521ms 07:34:01 INFO - SUITE-END | took 1170s 07:34:01 INFO - Completed test suite (00:19:30) 07:34:01 INFO - javascript benchmark 07:34:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.6764239754825, 3124.781265311428, 3172.333809899921, 3195.82422966737, 3222.097812612469, 5379.246905433242, 5382.354117505895, 5399.406065332815, 5421.783128674858, 5467.343918729758, 5273.156294992802, 5367.087595108831, 5384.811531596395, 5431.131019036955, 5481.068218402881, 4766.61867050636, 4789.760511974405, 4849.51504849514, 4855.684380515255, 4901.779419926094, 4757.9056816932125, 4995.625328100389, 5000.274960130779, 5009.4239162496415, 5016.046951079302, 4814.181589129839, 4898.191798353268, 4903.117438861003, 4916.926246106311, 4920.409550853885, 4805.20714082176, 4834.2990266411525, 4844.612431005511, 4849.175640141185, 4890.706557606555, 4823.9035219295765, 4825.252085926687, 4834.3473631059705, 4839.05638400512, 4851.078295123915, 5128.974355128238, 5233.790648374061, 5243.292155558989, 5300.92048619271, 5302.708351040691, 5714.79998200061, 5745.2818397700285, 5761.53907687384, 5783.681897495636, 5800.419958004208, 5643.858903527444, 5830.679312637803, 5840.211571437844, 5842.766289348421, 5843.18195452637, 5397.595180361449, 5431.728413579305, 5456.154296084113, 5461.644993075437, 5494.890102197974, 5831.79588714393, 5849.9177652134495, 5870.0, 5898.439648233497, 5907.497862681635, 5536.944630553723, 5619.213310136584, 5663.801766938137, 5664.065429204217, 5673.347565030074, 5791.797287094932, 5805.419458054161, 5812.070068789058, 5815.331236907725, 5860.0, 5574.1917421973585, 5696.259486266842, 5756.539476841843, 5764.07774756037, 5774.0, 5682.6306290091015, 5695.1741997410145, 5698.544116470755, 5721.971390143022, 5748.109043098327, 4312.417823593837, 4366.301391777364, 4368.388425620416, 4374.103308821684, 4404.471463424409, 3801.8099095045136, 3888.6889048876587, 3893.201893611803, 3942.8225729842225, 3954.723169378116, 5512.0, 5517.586181036358, 5522.337319521683, 5540.168974653753, 5562.276904002454, 5769.653820770767, 5775.104858746901, 5813.982553053199, 5827.271591051119, 5827.650340979555, 5355.839324820262, 5428.864278393072, 5445.401005889349, 5521.696306703089, 5542.501174894279, 4956.851294461172, 4963.851084467472, 4966.553010229097, 4968.503149685075, 4982.10322142018, 5899.439553242435, 5926.8814623707285, 5933.110033494924, 5938.673372964442, 5971.402859713994, 5642.6614403135945, 5751.511121554715, 5751.712414379264, 5802.5357971361345, 5827.446392592697, 5968.4926781224085, 5969.104634304889, 5969.194158788681, 5973.850653733692, 5982.371850955761, 5637.464440878274, 5688.11834165705, 5689.800856969986, 5706.572007099401, 5717.828465146053, 5678.602497825113, 5799.420057994167, 5828.6502809831545, 5848.181254624271, 5889.705514724333, 5660.320761508646, 5690.800821971211, 5707.258056452634, 5708.543316534584, 5714.485696287354, 5484.753186106555, 5688.715564221689, 5688.971555142198, 5693.857653558694, 5702.315722113373, 5431.918521222264, 5505.284313039279, 5515.09001014828, 5563.721813909207, 5614.382417934105, 5588.189712491585, 5655.547556195576, 5663.603547751618, 5694.857628559319, 5729.68486733217, 5361.812336568201, 5546.694931778629, 5552.944470555242, 5576.693281869536, 5577.191307260344], "value": 5308.602157222209, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.4332270987979, 650.1840190560847, 655.9540832141752, 663.2571519897714, 666.6799936030708, 37497.62502374979, 38375.23249535008, 38429.61570384295, 38531.422028669556, 38565.22869542608, 40496.59503404965, 41277.380839287434, 41327.38008929861, 41373.99999999993, 41412.0, 8433.367497437686, 8743.12568743127, 8795.78010549735, 8800.42797218182, 8829.381943263974, 8625.611847466847, 8663.826723465527, 8751.168638979287, 8752.69365572205, 8758.693445729401, 8982.820343593125, 8983.14660107292, 9025.684101056464, 9027.368084234105, 9076.183143517115, 8915.42049766763, 8952.925648922139, 8974.955125224398, 8983.775405614846, 8991.28069754418, 8781.121887811169, 8890.0, 8896.19934205918, 8900.37697361185, 8912.153345432174, 40361.78914632566, 40627.7968610158, 40644.0, 40934.38598421026, 40950.1809963802, 3363.394588973984, 3384.729221662261, 3393.2704468539137, 3575.570931488212, 3657.871974480907, 28489.85755071232, 28579.857100714362, 28761.0, 30219.546706799414, 31648.841755791305, 4251.383549385353, 4339.218940590724, 4366.912661746779, 4388.078503514266, 4401.987542865127, 269978.0, 271109.0, 271529.0, 271958.999999998, 272298.0, 35860.10349741225, 51129.74435127801, 51260.487395126314, 51777.0, 51934.480655192965, 34781.47827782585, 34995.12512187165, 35074.64925350714, 35127.4730879037, 35197.120071997895, 12736.108472407028, 12737.93631031839, 12843.743125137631, 12847.421866015864, 12880.420381082873, 10854.891451085388, 10883.292585981886, 10912.072473839813, 10924.2899211551, 10932.56269749201, 8432.620532076071, 8455.154484551496, 8554.914450855536, 8597.742067737978, 8621.534339162357, 3242.400155971153, 3260.4783234682336, 3270.2151483643756, 3281.6062072551445, 3327.800331980089, 1043.6712435582767, 1076.6500887211687, 1112.0825319111766, 1162.9649611845464, 1202.1825158891863, 31557.36885262328, 31987.0, 32075.839620802213, 32542.186445339055, 32853.67146328554, 1155.058627218814, 1161.9709507262216, 1203.085654902263, 1204.7048473124141, 1213.7269114449177, 16853.915730421268, 16965.15174241283, 16966.830331696772, 17153.056581888115, 17308.0, 433956.0, 445089.0, 445993.0, 446242.0, 447537.0, 55451.0, 56349.0, 56590.0, 56627.0, 56873.0, 1349.5411560069426, 1354.8170996915487, 1361.0676686469799, 1363.9999999999802, 1386.81278027467, 30379.544306835858, 30762.53856192114, 30960.53559196659, 31068.22329441782, 31272.530912035883, 51301.0, 51744.0, 52013.479865202375, 52105.47894521006, 52123.47876521186, 413361.0, 414999.0, 415776.0, 417751.0, 418897.0, 26210.60684089702, 26945.73054269432, 28836.855815720788, 29190.56214156747, 29276.853615731787, 40437.79781101194, 40631.0, 40846.38730418987, 41207.79396103, 41375.7931210342, 39874.2025159501, 40740.388894167205, 41093.79453102715, 41240.38139427851, 41714.79142604268, 39995.60004400035, 40605.59394406018, 40635.0, 41050.38424423696, 41710.165796683286, 36603.633963660024, 41612.16775664409, 41641.37537936873, 41961.0, 42669.14661706811, 31402.842985784926, 33969.32061358709, 34133.82933085319, 34592.13519661928, 34608.0, 27267.86366068157, 27541.586876196474, 27713.0, 27804.0, 27834.103225548843], "value": 18181.107529216275, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.504614278295, 400.52337718115456, 404.94735684361035, 407.22830236701435, 408.5138684964892, 13477.797833032513, 15291.92354038231, 17872.30213129752, 18509.81490185096, 18630.90684546577, 16360.509184724477, 16699.332026718916, 16945.576360590992, 16961.66076678466, 17013.0, 5156.303898973638, 5335.093034184179, 5386.111291636876, 5850.6782126983, 5884.735186916599, 5630.887382252373, 5812.360640329561, 5819.7963071292515, 5821.53427725781, 5867.11993201019, 5673.447168520345, 5712.0860662293835, 5723.627964182336, 5732.2548068751, 5748.683822389788, 5670.716464176775, 5768.42315768424, 5777.855553611152, 5808.82573522795, 5812.0119579671555, 4995.375578052744, 5162.22566615007, 5175.275461435402, 5180.222966555047, 5184.507471790174, 12218.816717749241, 12920.741585168338, 13479.326033698277, 13592.93203533976, 13619.727605447935, 2313.41008042948, 2344.2146880794953, 2489.6390023446497, 2651.68179818423, 2886.826790392583, 8757.430767000189, 9427.717168484956, 9460.148586627236, 9555.761105972337, 9568.138867501888, 1838.6598479281377, 1855.7494738210303, 1869.4952362862086, 1870.3453791173117, 1931.169597073258, 67927.66036169836, 79867.6006619969, 81579.0, 81791.0, 82767.0, 10753.623623173151, 10952.890471095347, 11065.114790816715, 11070.335779853234, 11086.334819910831, 15572.844271557366, 15590.220488975507, 15667.0, 15829.841701582836, 15864.968777029457, 7094.858102837914, 7576.3181313682035, 7765.53406795594, 7990.480618759762, 8026.357891368676, 6678.3989440950545, 6761.729530818712, 6762.932370676231, 6933.895991560131, 7007.719691212396, 4624.44506659203, 4687.484376718558, 4708.764561771898, 4745.406824146981, 4774.737389443544, 1755.7454169145403, 1926.3546711851407, 1977.4957385866799, 2008.7388639476774, 2012.1448384436555, 925.486355072941, 964.0889359555154, 1001.1840350114634, 1037.4812593703148, 1091.1543553745753, 17749.201285942163, 18700.81299186991, 19359.0, 19463.80536194648, 19587.118579663664, 976.1653786012998, 995.2684776689127, 1000.5897581991348, 1038.2991480750463, 1076.3057827701089, 10755.83866242007, 10817.945910270399, 10908.072813810757, 10920.399378034284, 10958.671239862817, 477648.0, 488597.0, 492536.0, 495184.86113541626, 497021.0, 88286.55856720675, 88913.0, 89400.5529972346, 89557.55221223983, 90094.54952725195, 1027.8509616105623, 1040.573364920379, 1093.1801149138146, 1105.364415461097, 1108.9722756931142, 16743.74884376711, 16998.0, 17102.14489275556, 17185.742213866553, 17393.478195654152, 27184.0, 28009.719902801527, 34735.13162170966, 35532.64467355293, 37781.2443751118, 50942.74528627333, 54042.459575403744, 54284.45715542794, 54448.45551544434, 54787.72606136944, 8282.296004839656, 8317.875231871405, 8462.323014158976, 8466.830663386821, 8502.022267439324, 11701.239419437708, 13372.197668139943, 13448.1258718183, 13573.660658483617, 13661.726765464833, 11257.662270131908, 11563.248388854698, 11568.884311157117, 11584.073274138218, 12317.260964342167, 11578.652640420802, 11742.530298788295, 11804.3507607079, 11881.5841445549, 11920.880791192323, 11899.881001189877, 11951.282923024646, 12017.759644807229, 12263.202891812003, 12331.876681233072, 8089.029316481824, 8102.392320575863, 8117.715879944174, 8178.323443693909, 8269.875951860606, 8212.712555060543, 11475.426228688366, 11930.284182949052, 11974.161808673658, 12021.158518903592], "value": 8837.088329167711, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.3242848861614, 1345.858684838092, 1376.0711519724184, 1729.71459709148, 1734.2802736864203, 7168.498205125643, 7902.644381002854, 8033.91966080339, 8122.796930076751, 8131.634076466558, 8052.63763130659, 8092.554909479976, 8132.26809587137, 8136.186381361861, 8144.06343270524, 2233.363491404954, 2257.413072601119, 2273.2839155665997, 2274.7725227477285, 2280.486890449652, 2240.003198576634, 2248.763879792623, 2257.762934891837, 2258.096761295487, 2264.3433404312727, 2253.2226381898217, 2263.3066650685714, 2271.0802125139344, 2289.622212334971, 2292.255017119443, 2207.0, 2207.0178770447155, 2214.30249471416, 2215.324326080545, 2222.677711731806, 2197.450637340665, 2199.9340019799433, 2205.9669104963436, 2220.2340192633515, 2222.744384395799, 8454.112318206562, 8507.659693612248, 8570.957145214297, 8576.485410875368, 8579.356548258844, 4764.166270902579, 4888.242322439992, 4931.309616653672, 4937.654364194508, 4943.0, 3222.887198948049, 3286.8520916558814, 3326.700596946262, 3353.7820041697455, 3360.2103505676146, 1136.1649187846926, 1152.4007516091585, 1156.19066653343, 1163.8021536338842, 1175.7942360087036, 11809.350485723282, 11843.526258949632, 11861.229020113666, 11863.288202707865, 11867.169298149132, 4343.4353534041, 4410.4927933287445, 4522.321651752263, 4541.795619197078, 4557.407537020166, 9994.650187243411, 10018.448985305879, 10022.0, 10033.046860548237, 10042.0, 5146.228065790161, 5147.897042059138, 5147.948520514747, 5173.81891633791, 5181.481851814789, 4085.8569950051606, 4709.62323014158, 4737.052589482118, 4754.7147171169845, 4754.833580824655, 3956.4658771066115, 3974.5627980922077, 3997.300472417315, 4039.9596004040172, 4080.8775736727944, 1286.6783304173957, 1320.630223537411, 1324.8741369569875, 1341.9329033548283, 1346.4681450827065, 961.6586111930164, 965.6571916969515, 970.2286682087757, 985.556499575194, 1001.4041645221082, 5749.88500229993, 5874.265716785402, 5926.140709597084, 5934.584579079509, 5985.431384018511, 394.05820089984957, 407.4011203530805, 409.9118689481716, 416.1282113971225, 419.0863916661707, 4071.694622903294, 4088.3254263046265, 4095.9590404096175, 4097.385392191195, 4102.343625020042, 10284.434356110485, 10467.685969420929, 10484.0, 10619.36283822973, 10646.414447205323, 10504.0, 10534.683959481228, 10550.525226364833, 10552.050315471492, 10572.41851698164, 7784.065912090586, 7834.608269586384, 7856.332211762065, 7869.960650196713, 7896.723614673574, 5823.272090988627, 5873.9412605873395, 5932.080527518242, 6014.879702405839, 6038.396160384103, 9492.477913714813, 9557.474338911426, 9655.324127311022, 9952.402855828674, 9966.0, 9560.56977436031, 9740.951295243478, 9810.215182785503, 9825.115739583473, 9932.652357167464, 6876.793696189123, 7442.255774422514, 7578.54528728256, 7810.921890781019, 8082.555459449787, 8195.754127376189, 8205.507669539847, 8255.752327430188, 8291.95854020726, 8301.58492075406, 7347.485676002629, 7504.0, 7610.429217808576, 7620.352270056886, 7719.3052625264, 7328.743493977899, 7383.852322953403, 7410.5183163094225, 7464.290892365217, 7478.401727861649, 6602.10871532337, 6763.425108865801, 6768.357006084414, 6777.491688123509, 6802.829929251809, 5168.664036837594, 5241.266222728745, 5279.709615971158, 5351.625386222927, 5354.54486368663, 5315.681059136464, 5323.0, 5345.572354211576, 5375.220593014069, 5448.482394172547], "value": 4427.734891728642, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.18958062151194, 319.7394123789112, 320.9695078967498, 325.7442907317756, 330.6775893503834, 6032.366601506839, 6087.817365479037, 6116.0, 6135.785247516338, 6144.385561443864, 5989.251343582052, 6021.608595441293, 6028.75884964602, 6033.818985430433, 6046.727897244624, 4300.505441874186, 4313.547077556843, 4399.538048504909, 4512.729236245819, 4527.7400271804245, 4486.214912390335, 4510.097980403916, 4528.117017181651, 4531.524189960056, 4534.1385136824065, 4439.955600444003, 4487.1025794841, 4487.551244875503, 4493.662975276851, 4498.730076195422, 4386.837488065665, 4509.413776209089, 4516.638668906479, 4521.050579378301, 4533.795979180944, 3975.46944426395, 3987.0, 3993.1813978134705, 3996.320625493673, 4005.1989602079702, 5718.71406429681, 5743.712814359265, 5750.137479378127, 5757.704516483757, 5764.452377024176, 5134.101532231844, 5271.973640131813, 5273.129933560957, 5288.312519372495, 5291.4708529147165, 6243.282022567372, 6245.314514758652, 6286.14558705183, 6288.685565721696, 6293.199526210838, 4259.76571288579, 4403.6256918162, 4407.955920440787, 4411.360352748866, 4414.227510185705, 6534.183227096613, 6552.7378904843745, 6552.967235163841, 6555.93444065558, 6571.967140164268, 4485.708428952108, 4486.285797092777, 4488.865334039984, 4489.618382437529, 4535.3694856982875, 4411.713238639542, 4559.430071241095, 4560.612347950461, 4571.839985600488, 4583.770811459413, 5208.479152084761, 5213.713245771443, 5230.097296000756, 5232.0, 5244.108501554745, 6344.460720838781, 6357.841053973595, 6357.982722764335, 6362.9045564316575, 6363.872722545523, 1563.725563665609, 1566.929488173035, 1573.9527814165594, 1595.7526583379595, 1598.472504073653, 970.7233438470003, 1044.4882007816116, 1050.669039252633, 1071.9464026798628, 1073.9140868730483, 5980.700964951822, 6080.969595151996, 6087.756489740361, 6091.878162436815, 6108.205933228652, 6447.613143211329, 6467.547271690936, 6515.837104072436, 6522.836929076716, 6525.543211975211, 5951.226340575698, 6081.239845019372, 6084.209052823193, 6084.726187321581, 6097.878042439126, 3446.3968805458944, 3476.11359103427, 3476.704480119168, 3497.761432683085, 3501.1072176595317, 6438.420542151229, 6610.206775187008, 6654.86690266192, 6676.53264271506, 6732.3267673232285, 6559.311272316433, 6574.80275591733, 6580.473562115019, 6612.471002319803, 6667.266600673922, 6531.8693626127215, 6632.535722499379, 6653.600783952978, 6688.632125233062, 6694.899576506356, 6458.38645328693, 6470.805875823733, 6471.838204044749, 6487.513436492188, 6492.156019717407, 6276.6547839869245, 6297.244330680348, 6405.903911441239, 6410.4294447860575, 6429.7106630200815, 6660.068580111713, 6673.866522669617, 6680.699368528525, 6694.933050669431, 6704.83237919056, 4483.461984561874, 4490.214212512862, 4501.707389019703, 4504.864854054384, 4521.118381915495, 6269.404406581368, 6493.480521558169, 6513.446357059703, 6514.54398192141, 6525.0, 6252.374762523711, 6298.338674439118, 6304.406488301624, 6307.621542707452, 6318.210223722035, 6108.389161083856, 6270.655113968775, 6295.874082518416, 6313.337099604659, 6452.161219041494, 6108.5723999319625, 6295.559310848196, 6297.307296197323, 6311.715972781144, 6316.684165791784, 6473.287938326686, 6486.967565162144, 6492.772752953624, 6505.8698826024165, 6530.0, 6114.510839132769, 6260.0, 6308.369163083655, 6336.0, 6346.270178929482], "value": 4747.947938882012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.5983059740648, 723.9565626062437, 779.0962483519119, 816.8733846253829, 820.0, 12807.871921280785, 13165.934170329147, 13202.735945281089, 13401.0, 13417.396217170226, 13057.151285166457, 13122.147060441064, 13173.670658233548, 13210.40553175107, 13238.139520931158, 651.2543138106877, 767.0450289389689, 795.2683531151355, 795.4193438789687, 795.757294025322, 786.2412771675332, 786.6460092958163, 788.8343447875953, 791.3550456378033, 793.3851265269434, 824.6948629007276, 830.161536847782, 831.2186544648042, 835.1982097186708, 836.2640876029086, 818.3207937411934, 819.0989911097804, 824.406427372291, 824.9628766705513, 826.0871736730946, 596.0344242327413, 601.5338112962489, 602.0788194063047, 604.5979423683245, 606.6511755740466, 13485.797713034215, 13543.119697219749, 13554.322283885866, 13564.253966031863, 13579.796303055462, 13374.598762037154, 13414.46342146313, 13451.0, 13632.795508067387, 13658.0, 11084.0, 11153.498092585773, 11248.15638827083, 11430.771384572345, 11430.828537571942, 3856.3058649443087, 3877.0888841122314, 3889.1638297765835, 3897.1815918657117, 3914.9804250978846, 54675.72662136704, 55489.44510554883, 55922.44077559213, 56104.15843762347, 56439.71780141114, 10817.783644327226, 10841.13270938323, 10863.239573229956, 10895.583574135311, 10906.672799816019, 19336.0, 19548.02259887, 19581.706274405897, 19687.901560492104, 19708.901455492916, 8123.0, 8291.461055031403, 8294.58527073656, 8315.376346774015, 8404.243618074403, 4749.501302363271, 4821.662483626113, 4930.9013819723405, 5055.797768089235, 5057.393112826411, 3050.9847450762604, 3146.0719087869134, 3147.5750773645723, 3147.716705496516, 3157.3369592385397, 587.5563949218313, 594.5481434110108, 595.6426144313377, 600.2886579403333, 609.6981993912952, 678.4470656415006, 700.7932659865352, 701.235653138082, 706.2795948132875, 715.5170260074428, 9150.450972941644, 9520.761980950532, 9558.474283914451, 9568.282378821477, 9729.318947673595, 690.81348036031, 694.4028135803205, 698.6052880122714, 705.989410158848, 716.4375964867554, 4443.755593442327, 4493.5281795411665, 4573.565511276423, 4629.282461218517, 4750.501197374295, 54199.45800542023, 55915.72042139763, 56353.7182314094, 56415.43584564102, 57071.14393284104, 48118.5188148121, 48631.75684121627, 48793.756031219615, 49455.75272123616, 50161.74919125454, 48384.0, 49478.257826132634, 49740.502594974314, 50349.244761328606, 50895.23657145072, 9265.44407335562, 9449.811003780023, 9562.091601297865, 9653.276004299565, 9744.415335079917, 33440.665593344725, 34118.14704632305, 35025.64974350224, 35602.8219858899, 36619.63380366162, 49001.5099848997, 49774.50225497843, 49781.253281200086, 50752.0, 51043.48956510536, 12844.935775321064, 13091.410886509939, 13128.277944713132, 13484.865151348753, 13516.729665406834, 13093.934530327288, 13181.670458238621, 13187.67030824237, 13840.930795346361, 14091.154530728189, 12890.935545322214, 12894.41975111141, 12939.094263401472, 13058.934705326412, 13071.673208169492, 12526.311052892179, 12606.55877044299, 12680.619581412573, 12721.491140354652, 12768.6807829805, 12911.935440322739, 13115.409806558537, 13149.934250328688, 13164.012699047418, 13375.0, 10715.785684286426, 10762.340804126634, 11098.0, 11149.219554631423, 11176.105911526896, 10849.620263290746, 11080.168987325822, 11085.445727713743, 11170.49732762044, 11192.0], "value": 6700.710703674126, "unit": "score"}], "name": "dromaeo_css", "value": 7024.67223323714, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 111.0, 113.0, 123.0, 110.0, 112.0, 110.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 156.0, 184.0, 128.0, 151.0, 158.0, 133.0, 187.0, 136.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 165.0, 171.0, 166.0, 167.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 74.0, 161.0, 76.0, 77.0, 78.0, 76.0, 98.0, 75.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 156.0, 93.0, 92.0, 92.0, 146.0, 92.0, 92.0, 146.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 120.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 56.0, 56.0, 57.0, 63.0, 57.0, 75.0, 56.0, 58.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 66.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 77.0, 79.0, 78.0, 80.0, 78.0, 78.0, 80.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 123.0, 125.0, 124.0, 125.0, 134.0, 128.0, 155.0, 128.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 175.0, 169.0, 168.0, 173.0, 163.0, 177.0, 167.0, 165.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 67.0, 69.0, 70.0, 72.0, 67.0, 69.0, 70.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1550.8000000000004, "alertThreshold": 2.0}]} 07:34:01 INFO - Return code: 0 07:34:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:34:01 ERROR - # TBPL SUCCESS # 07:34:01 INFO - Running post-action listener: _resource_record_post_action 07:34:01 INFO - Running post-run listener: _resource_record_post_run 07:34:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536006656; Read time: 20; Write time: 418928 07:34:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 220344320; Read time: 0; Write time: 216580 07:34:03 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291495936; Read time: 20; Write time: 196472 07:34:03 INFO - Running post-run listener: _upload_blobber_files 07:34:03 INFO - Blob upload gear active. 07:34:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:34:03 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'] 07:34:03 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 07:34:03 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:34:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:04 INFO - (blobuploader) - INFO - Done attempting. 07:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:34:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:05 INFO - (blobuploader) - INFO - Done attempting. 07:34:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:05 INFO - Return code: 0 07:34:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0352e49a428248eaa4737dedda9dd72e0d6861567de6d25b0ce0b29cb5b63b9a2b446966777d059cc52f1b96005e47bc2554b157b8aa3529371fe9b3b0f14f3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a794ec2e3917b01c3ad47756cb3f909aa465d3e3b58b4b48ad4a414c67c8f79874e227f5d9ef9bf0c5a1bee119433fb5e2dc46be333c432fd19607ab863aed22"} 07:34:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:05 INFO - Contents: 07:34:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0352e49a428248eaa4737dedda9dd72e0d6861567de6d25b0ce0b29cb5b63b9a2b446966777d059cc52f1b96005e47bc2554b157b8aa3529371fe9b3b0f14f3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a794ec2e3917b01c3ad47756cb3f909aa465d3e3b58b4b48ad4a414c67c8f79874e227f5d9ef9bf0c5a1bee119433fb5e2dc46be333c432fd19607ab863aed22"} 07:34:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:05 INFO - Copying logs to upload dir... 07:34:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.629432 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-20 07:34:04.875348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 07:34:04.878430) ========= 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=7de08804244eb36560b44971000001c3-1461161361.40097-1503712564 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/0352e49a428248eaa4737dedda9dd72e0d6861567de6d25b0ce0b29cb5b63b9a2b446966777d059cc52f1b96005e47bc2554b157b8aa3529371fe9b3b0f14f3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a794ec2e3917b01c3ad47756cb3f909aa465d3e3b58b4b48ad4a414c67c8f79874e227f5d9ef9bf0c5a1bee119433fb5e2dc46be333c432fd19607ab863aed22"} build_url:https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/MDMCPj5_QuuBdDZtj6pheA/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/0352e49a428248eaa4737dedda9dd72e0d6861567de6d25b0ce0b29cb5b63b9a2b446966777d059cc52f1b96005e47bc2554b157b8aa3529371fe9b3b0f14f3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a794ec2e3917b01c3ad47756cb3f909aa465d3e3b58b4b48ad4a414c67c8f79874e227f5d9ef9bf0c5a1bee119433fb5e2dc46be333c432fd19607ab863aed22"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 07:34:04.903222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:34:04.903556) ========= 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=7de08804244eb36560b44971000001c3-1461161361.40097-1503712564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:34:04.988981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 07:34:04.989309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 07:34:04.989599) ========= ========= Total master_lag: 0.20 =========