builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1461754740.51 results: success (0) buildid: 20160425042155 builduid: 3cafbae6ee4445cbb07d61c2d398d690 revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.507124) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.507556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.507842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.524444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.524805) ========= 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=aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 03:59:00-- 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% 112M=0s 2016-04-27 03:59:00 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.673689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.674010) ========= 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=aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014597 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.723588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:00.723953) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f328ac32af6a3d0ce1593c41fd18edf7216a1652 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f328ac32af6a3d0ce1593c41fd18edf7216a1652 --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=aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 03:59:00,888 truncating revision to first 12 chars 2016-04-27 03:59:00,888 Setting DEBUG logging. 2016-04-27 03:59:00,888 attempt 1/10 2016-04-27 03:59:00,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f328ac32af6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:59:01,240 unpacking tar archive at: mozilla-aurora-f328ac32af6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:01.396741) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:01.397083) ========= script_repo_revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:01.397469) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:01.397746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:01.406131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-27 03:59:01.406469) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:01 INFO - MultiFileLogger online at 20160427 03:59:01 in /builds/slave/test 03:59:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:59:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:01 INFO - {'append_to_log': False, 03:59:01 INFO - 'base_work_dir': '/builds/slave/test', 03:59:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:59:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:01 INFO - 'branch': 'Mozilla-Aurora', 03:59:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:01 INFO - 'config_files': ('talos/linux_config.py',), 03:59:01 INFO - 'default_actions': ('clobber', 03:59:01 INFO - 'read-buildbot-config', 03:59:01 INFO - 'download-and-extract', 03:59:01 INFO - 'populate-webroot', 03:59:01 INFO - 'create-virtualenv', 03:59:01 INFO - 'install', 03:59:01 INFO - 'run-tests'), 03:59:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:01 INFO - 'download_minidump_stackwalk': True, 03:59:01 INFO - 'download_symbols': 'ondemand', 03:59:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:01 INFO - 'installer_path': 'installer.exe', 03:59:01 INFO - 'log_level': 'info', 03:59:01 INFO - 'log_name': 'talos', 03:59:01 INFO - 'log_to_console': True, 03:59:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:01 INFO - 'opt_config_files': (), 03:59:01 INFO - 'pip_index': False, 03:59:01 INFO - 'sps_profile': False, 03:59:01 INFO - 'sps_profile_interval': 0, 03:59:01 INFO - 'suite': 'dromaeojs-e10s', 03:59:01 INFO - 'system_bits': '32', 03:59:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:01 INFO - 'title': 'talos-linux64-ix-009', 03:59:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:01 INFO - 'use_talos_json': True, 03:59:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:01 INFO - 'work_dir': 'build'} 03:59:01 INFO - ##### 03:59:01 INFO - ##### Running clobber step. 03:59:01 INFO - ##### 03:59:01 INFO - Running pre-action listener: _resource_record_pre_action 03:59:01 INFO - Running main action method: clobber 03:59:01 INFO - rmtree: /builds/slave/test/build 03:59:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:02 INFO - Running post-action listener: _resource_record_post_action 03:59:02 INFO - ##### 03:59:02 INFO - ##### Running read-buildbot-config step. 03:59:02 INFO - ##### 03:59:02 INFO - Running pre-action listener: _resource_record_pre_action 03:59:02 INFO - Running main action method: read_buildbot_config 03:59:02 INFO - Using buildbot properties: 03:59:02 INFO - { 03:59:02 INFO - "project": "", 03:59:02 INFO - "product": "firefox", 03:59:02 INFO - "script_repo_revision": "production", 03:59:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:59:02 INFO - "repository": "", 03:59:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:59:02 INFO - "buildid": "20160425042155", 03:59:02 INFO - "pgo_build": "True", 03:59:02 INFO - "basedir": "/builds/slave/test", 03:59:02 INFO - "buildnumber": 330, 03:59:02 INFO - "slavename": "talos-linux64-ix-009", 03:59:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:02 INFO - "platform": "ubuntu64_hw", 03:59:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:59:02 INFO - "branch": "mozilla-aurora", 03:59:02 INFO - "repo_path": "releases/mozilla-aurora", 03:59:02 INFO - "revision": "f328ac32af6a3d0ce1593c41fd18edf7216a1652", 03:59:02 INFO - "stage_platform": "linux64-pgo", 03:59:02 INFO - "builduid": "3cafbae6ee4445cbb07d61c2d398d690", 03:59:02 INFO - "slavebuilddir": "test" 03:59:02 INFO - } 03:59:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:59:02 INFO - Running post-action listener: _resource_record_post_action 03:59:02 INFO - ##### 03:59:02 INFO - ##### Running download-and-extract step. 03:59:02 INFO - ##### 03:59:02 INFO - Running pre-action listener: _resource_record_pre_action 03:59:02 INFO - Running main action method: download_and_extract 03:59:02 INFO - mkdir: /builds/slave/test/build/tests 03:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:02 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:59:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:59:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:59:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:59:03 INFO - Downloaded 1448 bytes. 03:59:03 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:59:03 INFO - Using the following test package requirements: 03:59:03 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:03 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:03 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:59:03 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'jsshell-linux-x86_64.zip'], 03:59:03 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:03 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:03 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:59:03 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:59:03 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:03 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:03 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:03 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:03 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59: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')]} 03:59:03 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:04 INFO - Downloaded 23359883 bytes. 03:59:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:06 INFO - Return code: 0 03:59:06 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:59: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')]} 03:59:06 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:07 INFO - Downloaded 23359883 bytes. 03:59:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:08 INFO - Return code: 0 03:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:08 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:59:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:59:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:59:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:59:09 INFO - Downloaded 10845194 bytes. 03:59:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:59:10 INFO - Return code: 0 03:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:10 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:59:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:59:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:59:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:59:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:59:11 INFO - Downloaded 60838843 bytes. 03:59:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:59:11 INFO - mkdir: /builds/slave/test/properties 03:59:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:11 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:11 INFO - Contents: 03:59:11 INFO - build_url:https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:59:12 INFO - Running post-action listener: _resource_record_post_action 03:59:12 INFO - Running post-action listener: set_extra_try_arguments 03:59:12 INFO - ##### 03:59:12 INFO - ##### Running populate-webroot step. 03:59:12 INFO - ##### 03:59:12 INFO - Running pre-action listener: _resource_record_pre_action 03:59:12 INFO - Running main action method: populate_webroot 03:59:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:12 INFO - '--tppagecycles', 03:59:12 INFO - '7'], 03:59:12 INFO - 'tests': ['tsvgm']}}, 03:59:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:59:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:59:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:59:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'tests': ['damp', 'tps']}, 03:59:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['damp', 'tps']}, 03:59:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:59:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:12 INFO - 'other': {'tests': ['a11yr', 03:59:12 INFO - 'ts_paint', 03:59:12 INFO - 'tpaint', 03:59:12 INFO - 'sessionrestore', 03:59:12 INFO - 'sessionrestore_no_auto_restore', 03:59:12 INFO - 'tabpaint']}, 03:59:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['a11yr', 03:59:12 INFO - 'ts_paint', 03:59:12 INFO - 'tpaint', 03:59:12 INFO - 'sessionrestore', 03:59:12 INFO - 'sessionrestore_no_auto_restore', 03:59:12 INFO - 'tabpaint']}, 03:59:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['a11yr', 03:59:12 INFO - 'ts_paint', 03:59:12 INFO - 'tpaint', 03:59:12 INFO - 'sessionrestore', 03:59:12 INFO - 'sessionrestore_no_auto_restore', 03:59:12 INFO - 'tabpaint']}, 03:59:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['a11yr', 03:59:12 INFO - 'ts_paint', 03:59:12 INFO - 'tpaint', 03:59:12 INFO - 'sessionrestore', 03:59:12 INFO - 'sessionrestore_no_auto_restore', 03:59:12 INFO - 'tabpaint']}, 03:59:12 INFO - 'other_l64': {'tests': ['a11yr', 03:59:12 INFO - 'ts_paint', 03:59:12 INFO - 'tpaint', 03:59:12 INFO - 'sessionrestore', 03:59:12 INFO - 'sessionrestore_no_auto_restore', 03:59:12 INFO - 'tabpaint']}, 03:59:12 INFO - 'other_nol64': {'tests': ['a11yr', 03:59:12 INFO - 'ts_paint', 03:59:12 INFO - 'tpaint', 03:59:12 INFO - 'sessionrestore', 03:59:12 INFO - 'sessionrestore_no_auto_restore', 03:59:12 INFO - 'tabpaint']}, 03:59:12 INFO - 'svgr': {'tests': ['tsvgx', 03:59:12 INFO - 'tsvgr_opacity', 03:59:12 INFO - 'tart', 03:59:12 INFO - 'tscrollx', 03:59:12 INFO - 'cart']}, 03:59:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['tsvgx', 03:59:12 INFO - 'tsvgr_opacity', 03:59:12 INFO - 'tart', 03:59:12 INFO - 'tscrollx', 03:59:12 INFO - 'cart']}, 03:59:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'tests': ['tp5o']}, 03:59:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'talos_options': ['--e10s'], 03:59:12 INFO - 'tests': ['tp5o']}, 03:59:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'talos_options': ['--xperf_path', 03:59:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:12 INFO - 'tests': ['tp5n']}, 03:59:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:12 INFO - 'talos_options': ['--e10s', 03:59:12 INFO - '--xperf_path', 03:59:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:12 INFO - 'tests': ['tp5n']}}, 03:59:12 INFO - 'talos.zip': {'path': '', 03:59:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:12 INFO - Running post-action listener: _resource_record_post_action 03:59:12 INFO - ##### 03:59:12 INFO - ##### Running create-virtualenv step. 03:59:12 INFO - ##### 03:59:12 INFO - Running pre-action listener: _resource_record_pre_action 03:59:12 INFO - Running main action method: create_virtualenv 03:59:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:59:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:12 INFO - Using real prefix '/usr' 03:59:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:14 INFO - Installing pip.................done. 03:59:14 INFO - Return code: 0 03:59:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:14 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:59:14 INFO - Using env: {'DISPLAY': ':0', 03:59:14 INFO - 'HOME': '/home/cltbld', 03:59:14 INFO - 'LANG': 'en_US.UTF-8', 03:59:14 INFO - 'LANGUAGE': 'en_US:en', 03:59:14 INFO - 'LOGNAME': 'cltbld', 03:59:14 INFO - 'MAIL': '/var/mail/cltbld', 03:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:14 INFO - 'MOZ_NO_REMOTE': '1', 03:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:14 INFO - 'NO_EM_RESTART': '1', 03:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:14 INFO - 'PWD': '/builds/slave/test', 03:59:14 INFO - 'SHELL': '/bin/bash', 03:59:14 INFO - 'SHLVL': '1', 03:59:14 INFO - 'TERM': 'linux', 03:59:14 INFO - 'TMOUT': '86400', 03:59:14 INFO - 'USER': 'cltbld', 03:59:14 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:14 INFO - '_': '/tools/buildbot/bin/python'} 03:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:59:15 INFO - Cleaning up... 03:59:15 INFO - Return code: 0 03:59:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:15 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:59:15 INFO - Using env: {'DISPLAY': ':0', 03:59:15 INFO - 'HOME': '/home/cltbld', 03:59:15 INFO - 'LANG': 'en_US.UTF-8', 03:59:15 INFO - 'LANGUAGE': 'en_US:en', 03:59:15 INFO - 'LOGNAME': 'cltbld', 03:59:15 INFO - 'MAIL': '/var/mail/cltbld', 03:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:15 INFO - 'MOZ_NO_REMOTE': '1', 03:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:15 INFO - 'NO_EM_RESTART': '1', 03:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:15 INFO - 'PWD': '/builds/slave/test', 03:59:15 INFO - 'SHELL': '/bin/bash', 03:59:15 INFO - 'SHLVL': '1', 03:59:15 INFO - 'TERM': 'linux', 03:59:15 INFO - 'TMOUT': '86400', 03:59:15 INFO - 'USER': 'cltbld', 03:59:15 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:15 INFO - '_': '/tools/buildbot/bin/python'} 03:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:15 INFO - Downloading/unpacking psutil>=0.7.1 03:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:17 INFO - Installing collected packages: psutil 03:59:17 INFO - Running setup.py install for psutil 03:59:17 INFO - building 'psutil._psutil_linux' extension 03:59:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:59:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:59:17 INFO - building 'psutil._psutil_posix' extension 03:59:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:59:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:59:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:17 INFO - Successfully installed psutil 03:59:17 INFO - Cleaning up... 03:59:17 INFO - Return code: 0 03:59:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:17 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:59:17 INFO - Using env: {'DISPLAY': ':0', 03:59:17 INFO - 'HOME': '/home/cltbld', 03:59:17 INFO - 'LANG': 'en_US.UTF-8', 03:59:17 INFO - 'LANGUAGE': 'en_US:en', 03:59:17 INFO - 'LOGNAME': 'cltbld', 03:59:17 INFO - 'MAIL': '/var/mail/cltbld', 03:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:17 INFO - 'MOZ_NO_REMOTE': '1', 03:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:17 INFO - 'NO_EM_RESTART': '1', 03:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:17 INFO - 'PWD': '/builds/slave/test', 03:59:17 INFO - 'SHELL': '/bin/bash', 03:59:17 INFO - 'SHLVL': '1', 03:59:17 INFO - 'TERM': 'linux', 03:59:17 INFO - 'TMOUT': '86400', 03:59:17 INFO - 'USER': 'cltbld', 03:59:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:17 INFO - '_': '/tools/buildbot/bin/python'} 03:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:59:20 INFO - Installing collected packages: mozsystemmonitor 03:59:20 INFO - Running setup.py install for mozsystemmonitor 03:59:20 INFO - Successfully installed mozsystemmonitor 03:59:20 INFO - Cleaning up... 03:59:20 INFO - Return code: 0 03:59:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:20 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:59:20 INFO - Using env: {'DISPLAY': ':0', 03:59:20 INFO - 'HOME': '/home/cltbld', 03:59:20 INFO - 'LANG': 'en_US.UTF-8', 03:59:20 INFO - 'LANGUAGE': 'en_US:en', 03:59:20 INFO - 'LOGNAME': 'cltbld', 03:59:20 INFO - 'MAIL': '/var/mail/cltbld', 03:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:20 INFO - 'MOZ_NO_REMOTE': '1', 03:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:20 INFO - 'NO_EM_RESTART': '1', 03:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:20 INFO - 'PWD': '/builds/slave/test', 03:59:20 INFO - 'SHELL': '/bin/bash', 03:59:20 INFO - 'SHLVL': '1', 03:59:20 INFO - 'TERM': 'linux', 03:59:20 INFO - 'TMOUT': '86400', 03:59:20 INFO - 'USER': 'cltbld', 03:59:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:20 INFO - '_': '/tools/buildbot/bin/python'} 03:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:20 INFO - Downloading/unpacking blobuploader==1.2.4 03:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:22 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:22 INFO - Downloading docopt-0.6.1.tar.gz 03:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:22 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:22 INFO - Running setup.py install for blobuploader 03:59:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:23 INFO - Running setup.py install for requests 03:59:23 INFO - Running setup.py install for docopt 03:59:23 INFO - Successfully installed blobuploader requests docopt 03:59:23 INFO - Cleaning up... 03:59:23 INFO - Return code: 0 03:59:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:23 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:23 INFO - Using env: {'DISPLAY': ':0', 03:59:23 INFO - 'HOME': '/home/cltbld', 03:59:23 INFO - 'LANG': 'en_US.UTF-8', 03:59:23 INFO - 'LANGUAGE': 'en_US:en', 03:59:23 INFO - 'LOGNAME': 'cltbld', 03:59:23 INFO - 'MAIL': '/var/mail/cltbld', 03:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:23 INFO - 'MOZ_NO_REMOTE': '1', 03:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:23 INFO - 'NO_EM_RESTART': '1', 03:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:23 INFO - 'PWD': '/builds/slave/test', 03:59:23 INFO - 'SHELL': '/bin/bash', 03:59:23 INFO - 'SHLVL': '1', 03:59:23 INFO - 'TERM': 'linux', 03:59:23 INFO - 'TMOUT': '86400', 03:59:23 INFO - 'USER': 'cltbld', 03:59:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:23 INFO - '_': '/tools/buildbot/bin/python'} 03:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:23 INFO - Running setup.py (path:/tmp/pip-AufpdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:23 INFO - Running setup.py (path:/tmp/pip-OYDwd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:23 INFO - Running setup.py (path:/tmp/pip-k7OW6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:24 INFO - Running setup.py (path:/tmp/pip-ONDdrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:24 INFO - Running setup.py (path:/tmp/pip-0mV3Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:24 INFO - Running setup.py (path:/tmp/pip-xo0Q4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:24 INFO - Running setup.py (path:/tmp/pip-jjMiK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:24 INFO - Running setup.py (path:/tmp/pip-X9s2Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:24 INFO - Running setup.py (path:/tmp/pip-p3hRsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:24 INFO - Running setup.py (path:/tmp/pip-e2uZ_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:24 INFO - Running setup.py (path:/tmp/pip-Piqwho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:24 INFO - Running setup.py (path:/tmp/pip-ZhAOSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:24 INFO - Running setup.py (path:/tmp/pip-rduYfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:24 INFO - Running setup.py (path:/tmp/pip-OCVstj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:24 INFO - Running setup.py (path:/tmp/pip-kWP8sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:24 INFO - Running setup.py (path:/tmp/pip-nbrIpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:24 INFO - Running setup.py (path:/tmp/pip-4q9Zpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:25 INFO - Running setup.py install for manifestparser 03:59:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Running setup.py install for mozcrash 03:59:25 INFO - Running setup.py install for mozdebug 03:59:25 INFO - Running setup.py install for mozdevice 03:59:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Running setup.py install for mozfile 03:59:25 INFO - Running setup.py install for mozhttpd 03:59:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Running setup.py install for mozinfo 03:59:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Running setup.py install for mozInstall 03:59:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:25 INFO - Running setup.py install for mozleak 03:59:25 INFO - Running setup.py install for mozlog 03:59:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:26 INFO - Running setup.py install for moznetwork 03:59:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:26 INFO - Running setup.py install for mozprocess 03:59:26 INFO - Running setup.py install for mozprofile 03:59:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:26 INFO - Running setup.py install for mozrunner 03:59:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:26 INFO - Running setup.py install for mozscreenshot 03:59:26 INFO - Running setup.py install for moztest 03:59:26 INFO - Running setup.py install for mozversion 03:59:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:26 INFO - Cleaning up... 03:59:26 INFO - Return code: 0 03:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:26 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:26 INFO - Using env: {'DISPLAY': ':0', 03:59:26 INFO - 'HOME': '/home/cltbld', 03:59:26 INFO - 'LANG': 'en_US.UTF-8', 03:59:26 INFO - 'LANGUAGE': 'en_US:en', 03:59:26 INFO - 'LOGNAME': 'cltbld', 03:59:26 INFO - 'MAIL': '/var/mail/cltbld', 03:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:26 INFO - 'MOZ_NO_REMOTE': '1', 03:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:26 INFO - 'NO_EM_RESTART': '1', 03:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:26 INFO - 'PWD': '/builds/slave/test', 03:59:26 INFO - 'SHELL': '/bin/bash', 03:59:26 INFO - 'SHLVL': '1', 03:59:26 INFO - 'TERM': 'linux', 03:59:26 INFO - 'TMOUT': '86400', 03:59:26 INFO - 'USER': 'cltbld', 03:59:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:26 INFO - '_': '/tools/buildbot/bin/python'} 03:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:27 INFO - Running setup.py (path:/tmp/pip-OdF57O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:27 INFO - Running setup.py (path:/tmp/pip-m2VJfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:27 INFO - Running setup.py (path:/tmp/pip-1DIV_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:27 INFO - Running setup.py (path:/tmp/pip-Fz_Aak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:27 INFO - Running setup.py (path:/tmp/pip-lpF6jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:27 INFO - Running setup.py (path:/tmp/pip-VJybik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:27 INFO - Running setup.py (path:/tmp/pip-Al_NAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:27 INFO - Running setup.py (path:/tmp/pip-f2dOT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:27 INFO - Running setup.py (path:/tmp/pip-7UZqN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:27 INFO - Running setup.py (path:/tmp/pip-Ww4kL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:27 INFO - Running setup.py (path:/tmp/pip-obl5Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:27 INFO - Running setup.py (path:/tmp/pip-2sYQdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:27 INFO - Running setup.py (path:/tmp/pip-irOYh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:27 INFO - Running setup.py (path:/tmp/pip-7P9jtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:28 INFO - Running setup.py (path:/tmp/pip-lGBIlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:28 INFO - Running setup.py (path:/tmp/pip-U5kkiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:28 INFO - Running setup.py (path:/tmp/pip-1n1U7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:30 INFO - Downloading blessings-1.6.tar.gz 03:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:30 INFO - Installing collected packages: blessings 03:59:30 INFO - Running setup.py install for blessings 03:59:30 INFO - Successfully installed blessings 03:59:30 INFO - Cleaning up... 03:59:30 INFO - Return code: 0 03:59:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:30 INFO - Reading from file tmpfile_stdout 03:59:30 INFO - Current package versions: 03:59:30 INFO - argparse == 1.2.1 03:59:30 INFO - blessings == 1.6 03:59:30 INFO - blobuploader == 1.2.4 03:59:30 INFO - docopt == 0.6.1 03:59:30 INFO - manifestparser == 1.1 03:59:30 INFO - mozInstall == 1.12 03:59:30 INFO - mozcrash == 0.17 03:59:30 INFO - mozdebug == 0.1 03:59:30 INFO - mozdevice == 0.48 03:59:30 INFO - mozfile == 1.2 03:59:30 INFO - mozhttpd == 0.7 03:59:30 INFO - mozinfo == 0.9 03:59:30 INFO - mozleak == 0.1 03:59:30 INFO - mozlog == 3.1 03:59:30 INFO - moznetwork == 0.27 03:59:30 INFO - mozprocess == 0.22 03:59:30 INFO - mozprofile == 0.28 03:59:30 INFO - mozrunner == 6.11 03:59:30 INFO - mozscreenshot == 0.1 03:59:30 INFO - mozsystemmonitor == 0.0 03:59:30 INFO - moztest == 0.7 03:59:30 INFO - mozversion == 1.4 03:59:30 INFO - psutil == 3.1.1 03:59:30 INFO - requests == 1.2.3 03:59:30 INFO - wsgiref == 0.1.2 03:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:30 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:30 INFO - Using env: {'DISPLAY': ':0', 03:59:30 INFO - 'HOME': '/home/cltbld', 03:59:30 INFO - 'LANG': 'en_US.UTF-8', 03:59:30 INFO - 'LANGUAGE': 'en_US:en', 03:59:30 INFO - 'LOGNAME': 'cltbld', 03:59:30 INFO - 'MAIL': '/var/mail/cltbld', 03:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:30 INFO - 'MOZ_NO_REMOTE': '1', 03:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:30 INFO - 'NO_EM_RESTART': '1', 03:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:30 INFO - 'PWD': '/builds/slave/test', 03:59:30 INFO - 'SHELL': '/bin/bash', 03:59:30 INFO - 'SHLVL': '1', 03:59:30 INFO - 'TERM': 'linux', 03:59:30 INFO - 'TMOUT': '86400', 03:59:30 INFO - 'USER': 'cltbld', 03:59:30 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:30 INFO - '_': '/tools/buildbot/bin/python'} 03:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:59:30 INFO - Cleaning up... 03:59:30 INFO - Return code: 0 03:59:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:59:30 INFO - Using env: {'DISPLAY': ':0', 03:59:30 INFO - 'HOME': '/home/cltbld', 03:59:30 INFO - 'LANG': 'en_US.UTF-8', 03:59:30 INFO - 'LANGUAGE': 'en_US:en', 03:59:30 INFO - 'LOGNAME': 'cltbld', 03:59:30 INFO - 'MAIL': '/var/mail/cltbld', 03:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:30 INFO - 'MOZ_NO_REMOTE': '1', 03:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:30 INFO - 'NO_EM_RESTART': '1', 03:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:30 INFO - 'PWD': '/builds/slave/test', 03:59:30 INFO - 'SHELL': '/bin/bash', 03:59:30 INFO - 'SHLVL': '1', 03:59:30 INFO - 'TERM': 'linux', 03:59:30 INFO - 'TMOUT': '86400', 03:59:30 INFO - 'USER': 'cltbld', 03:59:30 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:30 INFO - '_': '/tools/buildbot/bin/python'} 03:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:31 INFO - Downloading/unpacking jsonschema 03:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:32 INFO - Downloading/unpacking functools32 (from jsonschema) 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:33 INFO - warning: no files found matching '*.txt' 03:59:33 INFO - no previously-included directories found matching 'build' 03:59:33 INFO - no previously-included directories found matching 'dist' 03:59:33 INFO - no previously-included directories found matching '.git*' 03:59:33 INFO - Installing collected packages: jsonschema, functools32 03:59:33 INFO - Running setup.py install for functools32 03:59:33 INFO - warning: no files found matching '*.txt' 03:59:33 INFO - no previously-included directories found matching 'build' 03:59:33 INFO - no previously-included directories found matching 'dist' 03:59:33 INFO - no previously-included directories found matching '.git*' 03:59:33 INFO - Successfully installed jsonschema functools32 03:59:33 INFO - Cleaning up... 03:59:33 INFO - Return code: 0 03:59:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:33 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 0x7f04f3d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:59:33 INFO - Using env: {'DISPLAY': ':0', 03:59:33 INFO - 'HOME': '/home/cltbld', 03:59:33 INFO - 'LANG': 'en_US.UTF-8', 03:59:33 INFO - 'LANGUAGE': 'en_US:en', 03:59:33 INFO - 'LOGNAME': 'cltbld', 03:59:33 INFO - 'MAIL': '/var/mail/cltbld', 03:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:33 INFO - 'MOZ_NO_REMOTE': '1', 03:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:33 INFO - 'NO_EM_RESTART': '1', 03:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:33 INFO - 'PWD': '/builds/slave/test', 03:59:33 INFO - 'SHELL': '/bin/bash', 03:59:33 INFO - 'SHLVL': '1', 03:59:33 INFO - 'TERM': 'linux', 03:59:33 INFO - 'TMOUT': '86400', 03:59:33 INFO - 'USER': 'cltbld', 03:59:33 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:33 INFO - '_': '/tools/buildbot/bin/python'} 03:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:33 INFO - Downloading/unpacking flake8 03:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:59:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:59:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:59:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:59:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:59:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:59:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:59:36 INFO - no previously-included directories found matching 'docs/_build' 03:59:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:59:36 INFO - Running setup.py install for pep8 03:59:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:59:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:59:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:59:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:59:36 INFO - no previously-included directories found matching 'docs/_build' 03:59:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:59:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:59:36 INFO - Cleaning up... 03:59:36 INFO - Return code: 0 03:59:36 INFO - Running post-action listener: _resource_record_post_action 03:59:36 INFO - Running post-action listener: _start_resource_monitoring 03:59:36 INFO - Starting resource monitoring. 03:59:36 INFO - ##### 03:59:36 INFO - ##### Running install step. 03:59:36 INFO - ##### 03:59:36 INFO - Running pre-action listener: _resource_record_pre_action 03:59:36 INFO - Running main action method: install 03:59:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:36 INFO - Reading from file tmpfile_stdout 03:59:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:59:36 INFO - Reading from file tmpfile_stdout 03:59:36 INFO - Output received: 03:59:36 INFO - Usage: mozinstall [options] installer 03:59:36 INFO - Options: 03:59:36 INFO - -h, --help show this help message and exit 03:59:36 INFO - -d DEST, --destination=DEST 03:59:36 INFO - Directory to install application into. [default: 03:59:36 INFO - "/builds/slave/test"] 03:59:36 INFO - --app=APP Application being installed. [default: firefox] 03:59:36 INFO - mkdir: /builds/slave/test/build/application 03:59:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:59:51 INFO - Reading from file tmpfile_stdout 03:59:51 INFO - Output received: 03:59:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:59:51 INFO - Running post-action listener: _resource_record_post_action 03:59:51 INFO - ##### 03:59:51 INFO - ##### Running run-tests step. 03:59:51 INFO - ##### 03:59:51 INFO - Running pre-action listener: _resource_record_pre_action 03:59:51 INFO - Running main action method: run_tests 03:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:51 INFO - Python 2.7.3 03:59:51 INFO - Return code: 0 03:59:51 INFO - grabbing minidump binary from tooltool 03:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:51 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 0x20b2160>, '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 0x20b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b34f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:59:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:59:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:52 INFO - Return code: 0 03:59:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:59:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:59:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:59:53 INFO - Return code: 0 03:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 03:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 03:59:53 INFO - Using env: {'DISPLAY': ':0', 03:59:53 INFO - 'HOME': '/home/cltbld', 03:59:53 INFO - 'LANG': 'en_US.UTF-8', 03:59:53 INFO - 'LANGUAGE': 'en_US:en', 03:59:53 INFO - 'LOGNAME': 'cltbld', 03:59:53 INFO - 'MAIL': '/var/mail/cltbld', 03:59:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:53 INFO - 'MOZ_NO_REMOTE': '1', 03:59:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:53 INFO - 'NO_EM_RESTART': '1', 03:59:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:53 INFO - 'PWD': '/builds/slave/test', 03:59:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:53 INFO - 'SHELL': '/bin/bash', 03:59:53 INFO - 'SHLVL': '1', 03:59:53 INFO - 'TERM': 'linux', 03:59:53 INFO - 'TMOUT': '86400', 03:59:53 INFO - 'USER': 'cltbld', 03:59:53 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986', 03:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:53 INFO - '_': '/tools/buildbot/bin/python'} 03:59:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 03:59:53 INFO - mozversion application_buildid: 20160425042155 03:59:53 INFO - mozversion application_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 03:59:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:59:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:53 INFO - mozversion application_name: Firefox 03:59:53 INFO - mozversion application_remotingname: firefox-dev 03:59:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:59:53 INFO - mozversion application_vendor: Mozilla 03:59:53 INFO - mozversion application_version: 47.0a2 03:59:53 INFO - mozversion platform_buildid: 20160425042155 03:59:53 INFO - mozversion platform_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 03:59:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:59:53 INFO - mozversion platform_version: 47.0a2 03:59:53 INFO - using testdate: 1461754793 03:59:53 INFO - actual date: 1461754793 03:59:53 INFO - starting webserver on 'localhost:48466' 03:59:53 INFO - SUITE-START | Running 2 tests 03:59:53 INFO - TEST-START | dromaeo_css 03:59:53 INFO - operating with platform_type : linux_ 03:59:53 INFO - Initialising browser for dromaeo_css test... 03:59:53 INFO - TEST-INFO | started process 12853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxRXWOp/profile http://localhost:48466/getInfo.html) 03:59:57 INFO - PROCESS | 12853 | 03:59:57 INFO - PROCESS | 12853 | (process:12927): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:59:58 INFO - PROCESS | 12853 | __metrics Screen width/height:1600/1200 03:59:58 INFO - PROCESS | 12853 | colorDepth:24 03:59:58 INFO - PROCESS | 12853 | Browser inner width/height: 1024/697 03:59:58 INFO - PROCESS | 12853 | __metrics 03:59:58 ERROR - PROCESS | 12853 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:00:00 INFO - TEST-INFO | 12853: exit 0 04:00:00 INFO - Browser initialized. 04:00:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:00 INFO - TEST-INFO | started process 12978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxRXWOp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:01 INFO - PROCESS | 12978 | 04:00:01 INFO - PROCESS | 12978 | (process:13045): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:11 INFO - PROCESS | 12978 | RSS: Main: 151494656 04:00:11 INFO - PROCESS | 12978 | 04:01:01 INFO - PROCESS | 12978 | 1461754861430 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] 04:03:09 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48466/tests/dromaeo/cssquery-ext.html) 04:03:10 INFO - PROCESS | 12978 | RSS: Main: 155045888 04:03:10 INFO - PROCESS | 12978 | 04:06:12 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-ext.html (next: http://localhost:48466/tests/dromaeo/cssquery-jquery.html) 04:06:12 INFO - PROCESS | 12978 | RSS: Main: 153780224 04:06:12 INFO - PROCESS | 12978 | 04:09:14 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48466/tests/dromaeo/cssquery-mootools.html) 04:09:15 INFO - PROCESS | 12978 | RSS: Main: 153530368 04:09:15 INFO - PROCESS | 12978 | 04:12:16 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48466/tests/dromaeo/cssquery-prototype.html) 04:12:17 INFO - PROCESS | 12978 | RSS: Main: 153284608 04:12:17 INFO - PROCESS | 12978 | 04:15:19 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48466/tests/dromaeo/cssquery-yui.html) 04:15:20 INFO - PROCESS | 12978 | RSS: Main: 154234880 04:15:20 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-yui.html (next: http://localhost:48466/tests/dromaeo/cssquery-dojo.html) 04:18:22 INFO - PROCESS | 12978 | RSS: Main: 156078080 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | __start_tp_report 04:18:22 INFO - PROCESS | 12978 | _x_x_mozilla_page_load 04:18:22 INFO - PROCESS | 12978 | _x_x_mozilla_page_load_details 04:18:22 INFO - PROCESS | 12978 | |i|pagename|runs| 04:18:22 INFO - PROCESS | 12978 | |0;dojo.html;3323.9002829915103;3401.20071783131;3416.8291585420725;3458.56767904012;3463.411220092584;5535.474129957658;5546.889062218764;5578.3584887737925;5590.944090559094;5593.916091258629;5548.056830338842;5552.805651802188;5557.360903496099;5557.3886872444;5582.162675598663;5064.290999260106;5103.209002604603;5164.45773193813;5165.896682066356;5184;4958.305837182797;5035.798568057273;5251.501107394792;5262.236975638531;5310.761015754281;5033.11920413928;5056.949430505685;5076.340075790142;5146.356705411824;5187.714675692835;5052.292679024939;5091.363579552574;5092;5099;5100.795968161269;5001.649884508086;5115.155999260118;5132.820351287687;5141.717205553693;5150.793968241266;5246.737663116829;5325.999999999961;5342.706151161685;5355.839324820262;5381.461853814626;5887.499562537189;5941.524678025748;5988.071848863433;5995.940040599582;6009.459148676597;5853.50245229156;6010.549208809313;6020.066889632114;6021.90967135489;6022.156898034279;5599.916001259943;5615.9157612635845;5617.4382561743905;5624.072028115315;5650.208970744099;6062.090686397076;6103;6106.72519736613;6110.511159107261;6122;5788.855278618068;5850.795222167204;5872.882542349129;5892.322382925932;5929.407059294036;6017;6031.457168854824;6032.487238584682;6032.969835150796;6034.24571928509;5965.13505541694;5968.403159683997;5977.3126090500145;5977.641341519523;5987;5717.599768016282;5956.076808094752;5980.85047873798;6023.849403764941;6050.304215015241;4551.544845515488;4565;4575.862724118282;4578.130155270488;4590;4112.465379500705;4123.97938010308;4137.9861933825805;4143.02638879863;4172.102997855475;5568.972155139199;5635.746391412396;5712.6001179917;5790.160426738099;5837.591368604157;5954.07711804671;6006.189164462829;6008.969955150196;6011.038233882645;6036.788712395045;5498.367687715884;5685.943140568624;5700.771969121189;5719.399463056402;5745.913811292834;5042.117629414838;5057.848264552069;5138.897222055538;5176.06830770465;5191.8182863599595;6141.539384546088;6168.537359698041;6178.505719542516;6205.844853878689;6209.472194863397;5978.97010514962;5996.790112346047;5997.310309314485;6031.728572214349;6034.668093254913;6009.87980240384;6115.514161902999;6164.938350616616;6214.9067763984485;6222.968885155546;5940.079287710412;5942.61373010753;5948.405159484017;5951.315598706031;5964.075568286922;5883.882322353615;5958.851028724316;6012.8797424052145;6021.939780602138;6029.728662210299;5840.2115714378015;5914.733836977261;5924.851878703067;5932.703364831655;5966.254218222723;5793.797217097382;5803;5806.767729290781;5846.181534585076;5868;5631.099024156116;5740.483356497935;5742.540596752333;5765.8558536036935;5787.623804452697;5843.590948633725;5867.9413205869105;5887.558433117448;5891.410858914246;5901.557383196192;5760.596758226884;5761.481466667852;5767.394423585631;5777.2200752897825;5780.450857168562 04:18:22 INFO - PROCESS | 12978 | |1;ext.html;551.9044696277886;580.011081106713;584.013003639293;588.5350573047293;603.3966033966034;39828.601713982855;40427;40525.986850328794;40605.39091913624;40615.79692101539;43600.3459948101;43847;44266.33600495987;44392.778036109776;44501.332480012825;8867.911320886806;8992.415492992966;9010.774730631721;9080.228180604623;9101.772455688595;8837.160469755396;8952.776180595472;9005.819883602357;9190.21883139934;9274;9180.908190918106;9226.907730922672;9227.861582076273;9258.953705231464;9275.118863707938;9185.95407022964;9251.259899208047;9262.397944133678;9266.953665231698;9289.907100929006;9103.135202155785;9238.03000684925;9254.953725231398;9256;9291.070892910722;42343.153136937086;42815.78592107019;42902.14195716068;43033.56966430327;43123.78438107821;3776.150366167618;3821.6942644588644;3852.8266228019806;3867.6325749054076;3914.9608503914883;31030.22424439407;31100.688993110005;31141.532877006863;31257.68742312593;32274.515882261785;4208.494980602347;4228.281192197333;4240.639545638624;4292.29177185764;4317.460317460317;294417;300401;301286;301831;303297;48314;49302;72042;73657;74067.62966185242;49138;49219;49261;49493.752531237114;49505.25742113871;16113.838861611468;16117.194140292939;16127.274272657758;16146.273417696231;16181.757273640906;12771.552995645108;12898;12922.095453318365;12932.482700692055;12968.80546791799;16072;16108.436204732778;16142.75785863213;16870.325186992628;16964.830351696324;6172.444479996821;6189.907151392733;6340.270868850049;6394.26465956421;6403.615783053032;1000.1898462245605;1107.617871834216;1109.755853712182;1145.1525870855507;1159.8144296912453;27284.727152728217;27302.31744206371;27421.725782742316;27650.308742281202;29051.56422653662;1165.3998190931677;1201.0571701214506;1239.2378687107544;1240.7828629989715;1268.1820225954207;15267.160356014445;15489.30298136564;15523.611909702122;15871.841281587267;15914.124723140338;420690;500978;507066;507170;769422;57709.422905771244;57806.421935780105;58067.70966145142;58183.12725309124;58207.41792582105;1509.5094094419358;1516.3252352702941;1528.1976962094989;1535.247728612994;1552.0765144738862;29242;30196.849015754782;30259;30596.08211753651;30712.078637640905;51887.2216916739;51928.48071519387;52498.21252681137;52685.20972185497;52786.472135278156;329002;330199;331045;332135;333056;35562.64437355697;35638;36055.27889442249;36276.27447451089;36444.63555364519;47325.71650849625;47446.28830567475;47653;47951;48538.5146148534;39832.60167398289;40419.1916161681;41017.79491102525;41133.58866411298;41307;39156.80421597874;39633;40610.121054972886;40784.79607601943;40993.1801363977;38785.6121438782;39145;39230.41154382744;39667.404988925766;39721.40417893792;34837;35368.646313536534;35732;35843.64156358507;36388.27223455569;27468.45063098687;27660;27767;27773;27882.860585697752 04:18:22 INFO - PROCESS | 12978 | |2;jquery.html;384.2507111133291;386.9980650096749;392.630926928687;393.40595700492247;394.46746891696216;17130.229139688712;18166.4550063498;18625.06874656267;18705.4388368349;18748.062596870135;18504.167312470938;18719.719204211946;18763.437096887083;18873.33943311981;18892.81107188928;5671.092625179972;5909.586328956974;5921.378255283198;5939.109133629969;5947.434993675594;5288.127458969285;5504.91742623861;5521.558275337983;5526.557875369961;5528.115501519757;5340.225667278242;5463.7814487420455;5495.340559132909;5685.715714214293;5708.315002199742;5706.971465142668;5733.741981610817;5744.454276843735;5748.97125514374;5754.625949313302;5394.244805727201;5513.558915286768;5523.7238138093335;5593.74828132735;5649.661020338752;13539.796903046463;13623.114497557726;13632.250226237553;13633.318334083257;18472.630547388977;2324.931649005168;2354.587947109266;2389.9163529276393;2438.9512209755885;2612.203278000209;9964.80070398588;10142.645007424704;10333.896661033368;10586.364818110938;12828.294443805587;1949.7952714964865;1991.790861959488;1994.2820584589535;2008.56815784607;2019.1418647075081;67127.32872671308;67326.66336668334;68209.31790682129;68876;69969;9694.709158725249;9866.062724041205;9908.20734341251;9914.909359970541;10010.949945250373;13338.466461341437;13538.729225415633;13541.39063742134;13570.796438053438;13651.180929144084;7806.68773249075;7876.251756083163;7880.251376119374;7916.247956444128;7932.365410767125;7857.1749966253865;7889.566073865878;7960.562169080757;7972.720954766672;8003.919960800317;3852.653261206449;3987.641112299849;4098.344264917599;4117.094239267356;4212.651951375592;1757.3761314733342;1789.0518025446534;1821.3534195360721;1869.1775618727715;1879.6992481202942;990.6730778842965;1054.6414219165367;1074.9623763168252;1077.8706555213269;1099.7360633447915;16465.094419807025;16518.339266429208;16606.418775342805;17146.914265428593;17198.31206751741;984.0061537846683;997.4563862694848;1035.2080658296409;1091.6943255888364;1091.9344839309667;9545.61817527305;10169.898301016896;10172.745681358025;10255.641052563124;10306.433146176882;431673;431888;436196;440243;441671;72721.27278727251;73966;76250.61874690701;76348;79636;1044.12815299226;1051.3376572759266;1070.6841481762742;1078.735709751116;1081.8269076947652;15614.177989435932;15643.843561564694;15839.208039598205;15959.840401595835;15969.8403015973;33833.15417114592;34081.31837363289;34473.827630861684;34497;34590.65409345975;45365.54634453613;47275.52724472711;47446.05107897892;47490;48039.039219216116;8050.033995920527;8567.528785916835;8584.699535516227;8682.044975052613;8785.51679657625;7259.818504537428;10083.344582602107;11843.822342665038;13377.732445351234;13549.59351219465;5552.944470555242;5963.970180149072;10652.254342196282;11487.483063262007;11723.882761172279;11744.647660570197;11966.760664786829;11967.012980541784;11974.401279936143;12256.754864902474;5854.795082172274;8519.8722019171;9895.406275623485;11537.48081336325;11752.823707644222;8741.169588889044;8769.38614296993;8858.689945851864;8907.153820387053;8918.24194943437;11641.76716465649;11788;11837.348945808064;11858.822117668069;11893.345865977455 04:18:22 INFO - PROCESS | 12978 | |3;mootools.html;1531.7855500229966;1539.276540026188;1751.9474415767531;1898.2596787252983;1923.9422817315476;7278.526895751786;8101.3518918486525;8266.38002149839;8421.3683973702;8434.789130271747;8261.380396470258;8464.492130472176;8480.66077356905;8499.447535910176;8542.95728521358;2411.156095366621;2432.6107822748363;2447.339218411028;2452.0559584559983;2452.0682140786475;2414.9758502415016;2432.489177272766;2471.616899380599;2476.578981573137;2484.1926373928545;2381.559411508868;2405.651180578815;2417.3110663460916;2420.5037967216767;2447.877606119696;2336.5210131922913;2342.6720259163644;2351.670766092748;2393.3418309964727;2449.914253001154;2389.749076346993;2394.437307232799;2403.675503806981;2406.1337918349554;2409.590369637166;8472.661093556251;8490.66037358505;8530.914690853137;8531;8559.82880342396;5191.584673226171;5286.02208591408;5336.359636843565;5345.037893179227;5346.652467589594;3146.3235404387938;3179.5071763876635;3192.8084314940947;3230.4508233600345;3241.4813629819114;1025.52825700178;1030.9484525773682;1045.7019749371468;1052.1214785653988;1087.983680244797;11784.58753943608;11795;11840.171188016842;11879.94060029703;11900.226485278428;4595.1039547287955;4638.79125439356;4667.9766601166775;4692.95307046932;4698.835540756126;10187.949060254652;10225.744356391;10235;10235.48822558884;10253.179745620333;5297.576193904479;5322.574194064466;5325.068113080196;5327.7336133193185;5341.732913354317;4098.631123198927;4532.5694059064335;4546.636269098464;4585.977070114628;4809.831655892097;3939.0546268895832;3962.465067215889;3986.940195897064;3991.600839915985;4041.6160464755803;1257.0823298991788;1262.0976002158318;1267.512007876974;1268.7272236469203;1278.9104762666525;1419.5599364197133;1434.0391937401967;1450.804141440892;1494.5366936249798;1498.0562245785304;7983;7986.640601172961;7997.400194985399;8017.919820801834;8024.759257222176;522.4018498818831;528.1549520766742;532.9899839803551;540.0009981534209;540.0818608365794;5948.643081415043;5992.8801423972145;6000.909986350208;6011.428914253226;6069.2716873975405;9930.900690993141;10023.14803241718;10122.645707400206;10136.949315253523;10194.694159175237;10065.446400448045;10151.847722284172;10243.180545556486;10255.128314093387;10317.329373590692;7943.563104029218;8055.395845311508;8078.636461359253;8127.959360203161;8137.715179968791;7722.073351197892;7744.341730952932;7763.417743669361;7774.067111946602;7860.764177074697;8939.955300223457;9096.454212747256;9160.267178625827;9249.30630202724;9300.767480813034;9226.677066302647;9250.583723732314;9313.580888859882;9381.530923453936;9637.18083962871;6350.142730731477;6746.5277430581355;6931.09895713554;7205.891911621435;7279.526830755984;7674.155842857393;7677.9232207677205;7731.806704832199;7756.379489640703;7801.765947021599;6787.830304242236;6803.591784492946;6860.656967151523;6948.826279343057;7007.544509606859;6988.231294557493;7027.543209691354;7090;7144.785656430316;7155.427565794828;7495.325420712162;7532.811679708051;7597.544147351176;7636.08366995964;7672.156062832973;6994.160700715743;6997.195322537973;7009.649517524002;7032.859342813217;7063.470239732143;6833.829154270984;6837.453003759588;6891.000804883364;7061.929380706332;7065.929340706527 04:18:22 INFO - PROCESS | 12978 | |4;prototype.html;358.38715795988855;358.8474898168278;363.73992595294357;366.28939856678045;367.280130943351;6388.520860935431;6400.327965563619;6415.582987105847;6429.228492580891;6449.355064493554;6294.716737746801;6298.779542716006;6310.24277086749;6322.557420980534;6334.714937827797;4688.578027977482;4762.071396077767;4835.443923948756;4847.612191024709;4904.239842824359;4808.447028591704;4815.566599006089;4819.1325561398935;4836.443808961962;4838.951610483885;4726.26742854858;4743.976280118612;4744.6204303655795;4775.4985726498735;4783.043391321749;4802.159622066142;4806.212396809842;4812.133815913135;4812.951870481303;4823.155947709172;4114.177164567069;4180.28935081037;4205.453291072172;4208.621224089816;4212.85255016073;5937.584369094165;6009.609375390585;6063.727132279058;6083.787067452662;6096.359882212392;5535.6955367454775;5606.187102870102;5609.635373700697;5618.943810561924;5624.3813180550105;6661.833454163636;6747.460203183734;6773.762918297885;6779.932200677979;6781.152355955505;4586.7477288749105;4610.101030299093;4613.884652883671;4614.30785382192;4624.28323609841;6831;6881.793546193622;6946.826329341757;6951.16586009682;6957.860842783167;4674.275487299474;4738.857834264978;4741.099191153669;4745.549172828576;4750.8337208197545;4770.76146192689;4810.13417584838;4812.975935120302;4813.229883218668;4832.106060378841;5539.7784088636;5541.168824676331;5547.306586676666;5564.081926482166;5615.775368985276;6582.572132811448;6677.933220667828;6799.456043516507;6808.9659551701925;6811.046453496514;1703.9744403833952;1724.1637805664243;1724.7240441529295;1728.4296182259825;1730.7403889416437;1114.5597488991802;1116.6426743442182;1129.745807193375;1129.9039581635652;1142.160512023662;6526.118973938553;6544.54188206821;6577.901331480031;6582.111414959015;6583.440407565315;6950.965245173843;6965.059716938148;6978.651067446607;6995.8600827983155;7032.718691252395;6533.477321814244;6567.277599464055;6582.506312026617;6584.341565843377;6588.703508342136;3639.235760490327;3715.5169827922196;3753.868614598476;3797.050737315671;3802.980985095057;7117.430605551647;7140.107486564179;7277.636118194069;7291.197968223491;7337.779866604011;7188.4968052235845;7192.208857025723;7196.46026548011;7219.494635375473;7234.240404757425;7342.596157211405;7350.889736653954;7351.117865856131;7352.448566357544;7360.227176146427;6871.656417179221;6997.4052205561065;7004.124484439445;7056.823579410556;7071.540349877241;6930.48021398387;6938.479614029069;6950.409215216763;6951.235364110045;6963.816151254197;7257.637118144177;7282.089738782653;7291.05216321896;7307.707691692272;7314.378277846443;4867.80528778859;4869.780859861244;4872.439669437918;4884.413870335582;4894.92657610129;6820.317968203339;7067.540609860343;7082.433405327459;7082.4688148390105;7098.503104782616;6781.89827152603;6837.692303846239;6842.486813489108;6853.348931851466;6866.073080134118;6792.796216113525;6823.112995310578;6825.078614386995;6844.486663500357;6846.041554182518;6651.7006734698025;6694.698738556874;6701.1623547056615;6702.463802895854;6725.663716814238;6677.565958212701;6883.3116688330765;6884.552504087218;6904.689288982108;6933.064036355027;6695.196576410667;6714.899276510954;6739.5619284746335;6745.12313399255;6746.392824645805 04:18:22 INFO - PROCESS | 12978 | |5;yui.html;821.7863355527562;904.2720609909021;908.6547112097397;909.4179724976017;909.4997751236821;14983;15128.697426051473;15177.317020734066;15224.543263702079;15226.771598426005;14165.504207352744;14207.573772786807;14242.643933901658;14255.3585088671;14261.714765704706;759.350755104386;912.4570880326195;924.6070420071476;928.8606708993638;931.6273490603762;932.9860052099224;935.050923312838;936.5972631768337;939.173527295982;946.2146418472652;985.6747273399797;989.7525618595351;994.1599348550463;1000.2448151645498;1004.3923426327076;989.0060489208299;991.9603215871357;992.1517102877044;994.8358520844052;996.7059717383316;732.421387104187;734.4234775701102;734.7061175529831;737.1522748838825;737.200137850433;14640.121592704365;14713.043652162574;14730.18983955882;14745.336459859333;14820;14059.578212653636;14100.224487653175;14142.292885355691;14217.644558886008;14257;12006.279623222634;12063.758724825455;12172.208806427554;12202.267863928193;12290.385480725929;3949.526056873165;3976.483057202574;3982.601739825994;4008.4388185654034;4048.4534587830562;53451.46548534504;53640;53678.46321536813;54027.72986135083;54252;11316.207865449504;11523.366214858095;11548.133889958119;11669.299842009506;11693.239939403911;21188.89405552993;21333.35999920005;21353.25263615766;21361.35915922525;21396.679049814265;8241.546714930737;8369.121242269595;8454.704085356983;8488;8568.52873091986;4672.275797251432;4689.062187562433;4722.315264286728;4736.076465089274;4819.036192761461;3451.7066049386085;3507.5264839246884;3509.964900350964;3510.210202704422;3511.3855075361707;610.3194937644583;612.1980205930246;612.2469362683835;614.846288427893;615.2463232540102;718.2279050021143;723.5976557827961;738.6159197217524;758.7647829172975;777.3004296133412;9299;9484.099010593982;9516.333856630108;9700.854487182698;9797.80404391908;588.7880363069291;646.4182235987555;683.9637948508014;710.7618947652594;744.3747252308087;4367.606915377632;4426.667999900021;4485.147821913826;4489.595936365743;4567.3377360282575;66445.6677716618;67358.97923062315;67359;67498.32501675018;67646.32353676499;55216.44783552113;56050;57258.427415726146;58024;59295.11057334144;48435;49208.753956229986;49680;49761.50238497568;52231.21653175129;8806.427582207136;9043.366964312436;9893.554790034323;9909.752256193364;10182.745431364276;33205;33533.664663353054;35030.824845875606;35034.82482587571;35385.29229415449;49184.26223606577;49725.75137124291;50189;50609.24086138784;50885.491145088075;12525.56160534377;12742.808857867325;12776.680582985127;12791;12868.163569367962;13709.451621935012;14191.503297384543;14370.49703260381;14430.927845360706;14920;13131.146475479063;13290.800637990631;13291.268980206181;13323.333833308103;13418.597442076752;13314.33428328599;13362.398692059076;13391.464341426234;13394.93302533481;13564.38960246811;12737.363131843185;12840.422181002064;12954.222746635232;12986.090973631755;13346.532871349456;10014.849777253492;10098.54556544972;10287.53706083213;10299.227557933034;10474.07666026578;10855;11180.776384472103;11274.830877536679;11292.096632269562;11376.829347559627 04:18:22 INFO - PROCESS | 12978 | __end_tp_report 04:18:22 INFO - PROCESS | 12978 | __start_cc_report 04:18:22 INFO - PROCESS | 12978 | _x_x_mozilla_cycle_collect,332 04:18:22 INFO - PROCESS | 12978 | __end_cc_report 04:18:22 INFO - PROCESS | 12978 | __startTimestamp1461755902490__endTimestamp 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | ------- Summary: start ------- 04:18:22 INFO - PROCESS | 12978 | Number of tests: 6 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | [#0] dojo.html Cycles:165 Average:5562.34 Median:5780.45 stddev:606.43 (10.5%) stddev-sans-first:582.31 04:18:22 INFO - PROCESS | 12978 | Values: 3323.9 3401.2 3416.8 3458.6 3463.4 5535.5 5546.9 5578.4 5590.9 5593.9 5548.1 5552.8 5557.4 5557.4 5582.2 5064.3 5103.2 5164.5 5165.9 5184.0 4958.3 5035.8 5251.5 5262.2 5310.8 5033.1 5056.9 5076.3 5146.4 5187.7 5052.3 5091.4 5092.0 5099.0 5100.8 5001.6 5115.2 5132.8 5141.7 5150.8 5246.7 5326.0 5342.7 5355.8 5381.5 5887.5 5941.5 5988.1 5995.9 6009.5 5853.5 6010.5 6020.1 6021.9 6022.2 5599.9 5615.9 5617.4 5624.1 5650.2 6062.1 6103.0 6106.7 6110.5 6122.0 5788.9 5850.8 5872.9 5892.3 5929.4 6017.0 6031.5 6032.5 6033.0 6034.2 5965.1 5968.4 5977.3 5977.6 5987.0 5717.6 5956.1 5980.9 6023.8 6050.3 4551.5 4565.0 4575.9 4578.1 4590.0 4112.5 4124.0 4138.0 4143.0 4172.1 5569.0 5635.7 5712.6 5790.2 5837.6 5954.1 6006.2 6009.0 6011.0 6036.8 5498.4 5685.9 5700.8 5719.4 5745.9 5042.1 5057.8 5138.9 5176.1 5191.8 6141.5 6168.5 6178.5 6205.8 6209.5 5979.0 5996.8 5997.3 6031.7 6034.7 6009.9 6115.5 6164.9 6214.9 6223.0 5940.1 5942.6 5948.4 5951.3 5964.1 5883.9 5958.9 6012.9 6021.9 6029.7 5840.2 5914.7 5924.9 5932.7 5966.3 5793.8 5803.0 5806.8 5846.2 5868.0 5631.1 5740.5 5742.5 5765.9 5787.6 5843.6 5867.9 5887.6 5891.4 5901.6 5760.6 5761.5 5767.4 5777.2 5780.5 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | [#1] ext.html Cycles:180 Average:55703.60 Median:40476.49 stddev:109290.17 (270.0%) stddev-sans-first:109518.31 04:18:22 INFO - PROCESS | 12978 | Values: 551.9 580.0 584.0 588.5 603.4 39828.6 40427.0 40526.0 40605.4 40615.8 43600.3 43847.0 44266.3 44392.8 44501.3 8867.9 8992.4 9010.8 9080.2 9101.8 8837.2 8952.8 9005.8 9190.2 9274.0 9180.9 9226.9 9227.9 9259.0 9275.1 9186.0 9251.3 9262.4 9267.0 9289.9 9103.1 9238.0 9255.0 9256.0 9291.1 42343.2 42815.8 42902.1 43033.6 43123.8 3776.2 3821.7 3852.8 3867.6 3915.0 31030.2 31100.7 31141.5 31257.7 32274.5 4208.5 4228.3 4240.6 4292.3 4317.5 294417.0 300401.0 301286.0 301831.0 303297.0 48314.0 49302.0 72042.0 73657.0 74067.6 49138.0 49219.0 49261.0 49493.8 49505.3 16113.8 16117.2 16127.3 16146.3 16181.8 12771.6 12898.0 12922.1 12932.5 12968.8 16072.0 16108.4 16142.8 16870.3 16964.8 6172.4 6189.9 6340.3 6394.3 6403.6 1000.2 1107.6 1109.8 1145.2 1159.8 27284.7 27302.3 27421.7 27650.3 29051.6 1165.4 1201.1 1239.2 1240.8 1268.2 15267.2 15489.3 15523.6 15871.8 15914.1 420690.0 500978.0 507066.0 507170.0 769422.0 57709.4 57806.4 58067.7 58183.1 58207.4 1509.5 1516.3 1528.2 1535.2 1552.1 29242.0 30196.8 30259.0 30596.1 30712.1 51887.2 51928.5 52498.2 52685.2 52786.5 329002.0 330199.0 331045.0 332135.0 333056.0 35562.6 35638.0 36055.3 36276.3 36444.6 47325.7 47446.3 47653.0 47951.0 48538.5 39832.6 40419.2 41017.8 41133.6 41307.0 39156.8 39633.0 40610.1 40784.8 40993.2 38785.6 39145.0 39230.4 39667.4 39721.4 34837.0 35368.6 35732.0 35843.6 36388.3 27468.5 27660.0 27767.0 27773.0 27882.9 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | [#2] jquery.html Cycles:180 Average:25530.73 Median:2118.45 stddev:71643.34 (3381.9%) stddev-sans-first:71819.44 04:18:22 INFO - PROCESS | 12978 | Values: 384.3 387.0 392.6 393.4 394.5 17130.2 18166.5 18625.1 18705.4 18748.1 18504.2 18719.7 18763.4 18873.3 18892.8 5671.1 5909.6 5921.4 5939.1 5947.4 5288.1 5504.9 5521.6 5526.6 5528.1 5340.2 5463.8 5495.3 5685.7 5708.3 5707.0 5733.7 5744.5 5749.0 5754.6 5394.2 5513.6 5523.7 5593.7 5649.7 13539.8 13623.1 13632.3 13633.3 18472.6 2324.9 2354.6 2389.9 2439.0 2612.2 9964.8 10142.6 10333.9 10586.4 12828.3 1949.8 1991.8 1994.3 2008.6 2019.1 67127.3 67326.7 68209.3 68876.0 69969.0 9694.7 9866.1 9908.2 9914.9 10010.9 13338.5 13538.7 13541.4 13570.8 13651.2 7806.7 7876.3 7880.3 7916.2 7932.4 7857.2 7889.6 7960.6 7972.7 8003.9 3852.7 3987.6 4098.3 4117.1 4212.7 1757.4 1789.1 1821.4 1869.2 1879.7 990.7 1054.6 1075.0 1077.9 1099.7 16465.1 16518.3 16606.4 17146.9 17198.3 984.0 997.5 1035.2 1091.7 1091.9 9545.6 10169.9 10172.7 10255.6 10306.4 431673.0 431888.0 436196.0 440243.0 441671.0 72721.3 73966.0 76250.6 76348.0 79636.0 1044.1 1051.3 1070.7 1078.7 1081.8 15614.2 15643.8 15839.2 15959.8 15969.8 33833.2 34081.3 34473.8 34497.0 34590.7 45365.5 47275.5 47446.1 47490.0 48039.0 8050.0 8567.5 8584.7 8682.0 8785.5 7259.8 10083.3 11843.8 13377.7 13549.6 5552.9 5964.0 10652.3 11487.5 11723.9 11744.6 11966.8 11967.0 11974.4 12256.8 5854.8 8519.9 9895.4 11537.5 11752.8 8741.2 8769.4 8858.7 8907.2 8918.2 11641.8 11788.0 11837.3 11858.8 11893.3 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | [#3] mootools.html Cycles:180 Average:5861.73 Median:5323.82 stddev:3092.85 (58.1%) stddev-sans-first:3084.41 04:18:22 INFO - PROCESS | 12978 | Values: 1531.8 1539.3 1751.9 1898.3 1923.9 7278.5 8101.4 8266.4 8421.4 8434.8 8261.4 8464.5 8480.7 8499.4 8543.0 2411.2 2432.6 2447.3 2452.1 2452.1 2415.0 2432.5 2471.6 2476.6 2484.2 2381.6 2405.7 2417.3 2420.5 2447.9 2336.5 2342.7 2351.7 2393.3 2449.9 2389.7 2394.4 2403.7 2406.1 2409.6 8472.7 8490.7 8530.9 8531.0 8559.8 5191.6 5286.0 5336.4 5345.0 5346.7 3146.3 3179.5 3192.8 3230.5 3241.5 1025.5 1030.9 1045.7 1052.1 1088.0 11784.6 11795.0 11840.2 11879.9 11900.2 4595.1 4638.8 4668.0 4693.0 4698.8 10187.9 10225.7 10235.0 10235.5 10253.2 5297.6 5322.6 5325.1 5327.7 5341.7 4098.6 4532.6 4546.6 4586.0 4809.8 3939.1 3962.5 3986.9 3991.6 4041.6 1257.1 1262.1 1267.5 1268.7 1278.9 1419.6 1434.0 1450.8 1494.5 1498.1 7983.0 7986.6 7997.4 8017.9 8024.8 522.4 528.2 533.0 540.0 540.1 5948.6 5992.9 6000.9 6011.4 6069.3 9930.9 10023.1 10122.6 10136.9 10194.7 10065.4 10151.8 10243.2 10255.1 10317.3 7943.6 8055.4 8078.6 8128.0 8137.7 7722.1 7744.3 7763.4 7774.1 7860.8 8940.0 9096.5 9160.3 9249.3 9300.8 9226.7 9250.6 9313.6 9381.5 9637.2 6350.1 6746.5 6931.1 7205.9 7279.5 7674.2 7677.9 7731.8 7756.4 7801.8 6787.8 6803.6 6860.7 6948.8 7007.5 6988.2 7027.5 7090.0 7144.8 7155.4 7495.3 7532.8 7597.5 7636.1 7672.2 6994.2 6997.2 7009.6 7032.9 7063.5 6833.8 6837.5 6891.0 7061.9 7065.9 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | [#4] prototype.html Cycles:180 Average:5661.30 Median:6529.80 stddev:1727.90 (26.5%) stddev-sans-first:1686.28 04:18:22 INFO - PROCESS | 12978 | Values: 358.4 358.8 363.7 366.3 367.3 6388.5 6400.3 6415.6 6429.2 6449.4 6294.7 6298.8 6310.2 6322.6 6334.7 4688.6 4762.1 4835.4 4847.6 4904.2 4808.4 4815.6 4819.1 4836.4 4839.0 4726.3 4744.0 4744.6 4775.5 4783.0 4802.2 4806.2 4812.1 4813.0 4823.2 4114.2 4180.3 4205.5 4208.6 4212.9 5937.6 6009.6 6063.7 6083.8 6096.4 5535.7 5606.2 5609.6 5618.9 5624.4 6661.8 6747.5 6773.8 6779.9 6781.2 4586.7 4610.1 4613.9 4614.3 4624.3 6831.0 6881.8 6946.8 6951.2 6957.9 4674.3 4738.9 4741.1 4745.5 4750.8 4770.8 4810.1 4813.0 4813.2 4832.1 5539.8 5541.2 5547.3 5564.1 5615.8 6582.6 6677.9 6799.5 6809.0 6811.0 1704.0 1724.2 1724.7 1728.4 1730.7 1114.6 1116.6 1129.7 1129.9 1142.2 6526.1 6544.5 6577.9 6582.1 6583.4 6951.0 6965.1 6978.7 6995.9 7032.7 6533.5 6567.3 6582.5 6584.3 6588.7 3639.2 3715.5 3753.9 3797.1 3803.0 7117.4 7140.1 7277.6 7291.2 7337.8 7188.5 7192.2 7196.5 7219.5 7234.2 7342.6 7350.9 7351.1 7352.4 7360.2 6871.7 6997.4 7004.1 7056.8 7071.5 6930.5 6938.5 6950.4 6951.2 6963.8 7257.6 7282.1 7291.1 7307.7 7314.4 4867.8 4869.8 4872.4 4884.4 4894.9 6820.3 7067.5 7082.4 7082.5 7098.5 6781.9 6837.7 6842.5 6853.3 6866.1 6792.8 6823.1 6825.1 6844.5 6846.0 6651.7 6694.7 6701.2 6702.5 6725.7 6677.6 6883.3 6884.6 6904.7 6933.1 6695.2 6714.9 6739.6 6745.1 6746.4 04:18:22 INFO - PROCESS | 12978 | 04:18:22 INFO - PROCESS | 12978 | [#5] yui.html Cycles:180 Average:15439.47 Median:4487.37 stddev:17793.30 (396.5%) stddev-sans-first:17809.35 04:18:22 INFO - PROCESS | 12978 | Values: 821.8 904.3 908.7 909.4 909.5 14983.0 15128.7 15177.3 15224.5 15226.8 14165.5 14207.6 14242.6 14255.4 14261.7 759.4 912.5 924.6 928.9 931.6 933.0 935.1 936.6 939.2 946.2 985.7 989.8 994.2 1000.2 1004.4 989.0 992.0 992.2 994.8 996.7 732.4 734.4 734.7 737.2 737.2 14640.1 14713.0 14730.2 14745.3 14820.0 14059.6 14100.2 14142.3 14217.6 14257.0 12006.3 12063.8 12172.2 12202.3 12290.4 3949.5 3976.5 3982.6 4008.4 4048.5 53451.5 53640.0 53678.5 54027.7 54252.0 11316.2 11523.4 11548.1 11669.3 11693.2 21188.9 21333.4 21353.3 21361.4 21396.7 8241.5 8369.1 8454.7 8488.0 8568.5 4672.3 4689.1 4722.3 4736.1 4819.0 3451.7 3507.5 3510.0 3510.2 3511.4 610.3 612.2 612.2 614.8 615.2 718.2 723.6 738.6 758.8 777.3 9299.0 9484.1 9516.3 9700.9 9797.8 588.8 646.4 684.0 710.8 744.4 4367.6 4426.7 4485.1 4489.6 4567.3 66445.7 67359.0 67359.0 67498.3 67646.3 55216.4 56050.0 57258.4 58024.0 59295.1 48435.0 49208.8 49680.0 49761.5 52231.2 8806.4 9043.4 9893.6 9909.8 10182.7 33205.0 33533.7 35030.8 35034.8 35385.3 49184.3 49725.8 50189.0 50609.2 50885.5 12525.6 12742.8 12776.7 12791.0 12868.2 13709.5 14191.5 14370.5 14430.9 14920.0 13131.1 13290.8 13291.3 13323.3 13418.6 13314.3 13362.4 13391.5 13394.9 13564.4 12737.4 12840.4 12954.2 12986.1 13346.5 10014.8 10098.5 10287.5 10299.2 10474.1 10855.0 11180.8 11274.8 11292.1 11376.8 04:18:22 INFO - PROCESS | 12978 | -------- Summary: end -------- 04:18:22 INFO - PROCESS | 12978 | 04:18:23 INFO - TEST-INFO | 12978: exit 0 04:18:23 INFO - TEST-OK | dromaeo_css | took 1110018ms 04:18:23 INFO - TEST-START | kraken 04:18:23 INFO - operating with platform_type : linux_ 04:18:23 INFO - Initialising browser for kraken test... 04:18:23 INFO - TEST-INFO | started process 13225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Qbv13/profile http://localhost:48466/getInfo.html) 04:18:26 INFO - PROCESS | 13225 | 04:18:26 INFO - PROCESS | 13225 | (process:13299): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:18:27 INFO - PROCESS | 13225 | __metrics Screen width/height:1600/1200 04:18:27 INFO - PROCESS | 13225 | colorDepth:24 04:18:27 INFO - PROCESS | 13225 | Browser inner width/height: 1024/697 04:18:27 INFO - PROCESS | 13225 | __metrics 04:18:28 ERROR - PROCESS | 13225 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:18:29 INFO - TEST-INFO | 13225: exit 0 04:18:29 INFO - Browser initialized. 04:18:29 INFO - Running cycle 1/1 for kraken test... 04:18:29 INFO - TEST-INFO | started process 13350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Qbv13/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:31 INFO - PROCESS | 13350 | 04:18:31 INFO - PROCESS | 13350 | (process:13417): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:18:41 INFO - PROCESS | 13350 | RSS: Main: 151855104 04:18:41 INFO - PROCESS | 13350 | 04:18:43 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:44 INFO - PROCESS | 13350 | RSS: Main: 155688960 04:18:44 INFO - PROCESS | 13350 | 04:18:46 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-dft) 04:18:47 INFO - PROCESS | 13350 | RSS: Main: 156147712 04:18:47 INFO - PROCESS | 13350 | 04:18:50 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-fft) 04:18:50 INFO - PROCESS | 13350 | RSS: Main: 156426240 04:18:50 INFO - PROCESS | 13350 | 04:18:52 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-oscillator) 04:18:53 INFO - PROCESS | 13350 | RSS: Main: 156430336 04:18:53 INFO - PROCESS | 13350 | 04:18:55 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:56 INFO - PROCESS | 13350 | RSS: Main: 156418048 04:18:56 INFO - PROCESS | 13350 | 04:18:59 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48466/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:00 INFO - PROCESS | 13350 | RSS: Main: 156348416 04:19:00 INFO - PROCESS | 13350 | 04:19:03 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48466/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:04 INFO - PROCESS | 13350 | RSS: Main: 156553216 04:19:04 INFO - PROCESS | 13350 | 04:19:06 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48466/tests/kraken/driver.html?testName=json-parse-financial) 04:19:07 INFO - PROCESS | 13350 | RSS: Main: 156667904 04:19:07 INFO - PROCESS | 13350 | 04:19:08 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:09 INFO - PROCESS | 13350 | RSS: Main: 156954624 04:19:09 INFO - PROCESS | 13350 | 04:19:11 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:11 INFO - PROCESS | 13350 | RSS: Main: 156508160 04:19:11 INFO - PROCESS | 13350 | 04:19:13 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:14 INFO - PROCESS | 13350 | RSS: Main: 156979200 04:19:14 INFO - PROCESS | 13350 | 04:19:16 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:17 INFO - PROCESS | 13350 | RSS: Main: 157442048 04:19:17 INFO - PROCESS | 13350 | 04:19:20 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:20 INFO - PROCESS | 13350 | RSS: Main: 157442048 04:19:20 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48466/tests/kraken/driver.html?testName=ai-astar) 04:19:22 INFO - PROCESS | 13350 | RSS: Main: 158887936 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | __start_tp_report 04:19:22 INFO - PROCESS | 13350 | _x_x_mozilla_page_load 04:19:22 INFO - PROCESS | 13350 | _x_x_mozilla_page_load_details 04:19:22 INFO - PROCESS | 13350 | |i|pagename|runs| 04:19:22 INFO - PROCESS | 13350 | |0;ai-astar;112;102;109;109;111;120;110;109;111;109 04:19:22 INFO - PROCESS | 13350 | |1;audio-beat-detection;153;127;159;160;135;158;159;130;176;129 04:19:22 INFO - PROCESS | 13350 | |2;audio-dft;162;163;164;162;163;165;162;163;167;165 04:19:22 INFO - PROCESS | 13350 | |3;audio-fft;76;77;76;164;82;76;77;79;182;76 04:19:22 INFO - PROCESS | 13350 | |4;audio-oscillator;92;92;138;93;94;93;147;94;94;143 04:19:22 INFO - PROCESS | 13350 | |5;imaging-gaussian-blur;118;117;117;118;118;117;119;117;117;120 04:19:22 INFO - PROCESS | 13350 | |6;imaging-darkroom;147;148;148;146;147;148;147;147;148;147 04:19:22 INFO - PROCESS | 13350 | |7;imaging-desaturate;96;96;96;96;98;97;97;96;96;95 04:19:22 INFO - PROCESS | 13350 | |8;json-parse-financial;54;57;56;54;60;55;60;61;53;58 04:19:22 INFO - PROCESS | 13350 | |9;json-stringify-tinderbox;65;66;66;66;66;67;67;66;66;66 04:19:22 INFO - PROCESS | 13350 | |10;stanford-crypto-aes;77;78;80;78;78;79;79;78;78;80 04:19:22 INFO - PROCESS | 13350 | |11;stanford-crypto-ccm;112;111;112;121;119;127;113;118;112;114 04:19:22 INFO - PROCESS | 13350 | |12;stanford-crypto-pbkdf2;135;153;144;141;142;145;144;144;141;143 04:19:22 INFO - PROCESS | 13350 | |13;stanford-crypto-sha256-iterative;69;66;65;66;70;67;66;65;65;64 04:19:22 INFO - PROCESS | 13350 | __end_tp_report 04:19:22 INFO - PROCESS | 13350 | __start_cc_report 04:19:22 INFO - PROCESS | 13350 | _x_x_mozilla_cycle_collect,841 04:19:22 INFO - PROCESS | 13350 | __end_cc_report 04:19:22 INFO - PROCESS | 13350 | __startTimestamp1461755962587__endTimestamp 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | ------- Summary: start ------- 04:19:22 INFO - PROCESS | 13350 | Number of tests: 14 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:4.39 (4.0%) stddev-sans-first:4.61 04:19:22 INFO - PROCESS | 13350 | Values: 112.0 102.0 109.0 109.0 111.0 120.0 110.0 109.0 111.0 109.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:158.50 stddev:16.95 (10.7%) stddev-sans-first:17.91 04:19:22 INFO - PROCESS | 13350 | Values: 153.0 127.0 159.0 160.0 135.0 158.0 159.0 130.0 176.0 129.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:1.65 (1.0%) stddev-sans-first:1.64 04:19:22 INFO - PROCESS | 13350 | Values: 162.0 163.0 164.0 162.0 163.0 165.0 162.0 163.0 167.0 165.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.50 stddev:40.59 (53.1%) stddev-sans-first:42.36 04:19:22 INFO - PROCESS | 13350 | Values: 76.0 77.0 76.0 164.0 82.0 76.0 77.0 79.0 182.0 76.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:24.03 (25.8%) stddev-sans-first:24.78 04:19:22 INFO - PROCESS | 13350 | Values: 92.0 92.0 138.0 93.0 94.0 93.0 147.0 94.0 94.0 143.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 04:19:22 INFO - PROCESS | 13350 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 119.0 117.0 117.0 120.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:19:22 INFO - PROCESS | 13350 | Values: 147.0 148.0 148.0 146.0 147.0 148.0 147.0 147.0 148.0 147.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 04:19:22 INFO - PROCESS | 13350 | Values: 96.0 96.0 96.0 96.0 98.0 97.0 97.0 96.0 96.0 95.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.50 stddev:2.86 (5.0%) stddev-sans-first:2.85 04:19:22 INFO - PROCESS | 13350 | Values: 54.0 57.0 56.0 54.0 60.0 55.0 60.0 61.0 53.0 58.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 04:19:22 INFO - PROCESS | 13350 | Values: 65.0 66.0 66.0 66.0 66.0 67.0 67.0 66.0 66.0 66.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:0.97 (1.2%) stddev-sans-first:0.87 04:19:22 INFO - PROCESS | 13350 | Values: 77.0 78.0 80.0 78.0 78.0 79.0 79.0 78.0 78.0 80.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#11] stanford-crypto-ccm Cycles:10 Average:115.90 Median:116.00 stddev:5.22 (4.5%) stddev-sans-first:5.34 04:19:22 INFO - PROCESS | 13350 | Values: 112.0 111.0 112.0 121.0 119.0 127.0 113.0 118.0 112.0 114.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.00 stddev:4.47 (3.1%) stddev-sans-first:3.62 04:19:22 INFO - PROCESS | 13350 | Values: 135.0 153.0 144.0 141.0 142.0 145.0 144.0 144.0 141.0 143.0 04:19:22 INFO - PROCESS | 13350 | 04:19:22 INFO - PROCESS | 13350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.89 (2.9%) stddev-sans-first:1.73 04:19:22 INFO - PROCESS | 13350 | Values: 69.0 66.0 65.0 66.0 70.0 67.0 66.0 65.0 65.0 64.0 04:19:22 INFO - PROCESS | 13350 | -------- Summary: end -------- 04:19:22 INFO - PROCESS | 13350 | 04:19:23 INFO - TEST-INFO | 13350: exit 0 04:19:23 INFO - TEST-OK | kraken | took 60273ms 04:19:23 INFO - SUITE-END | took 1170s 04:19:23 INFO - Completed test suite (00:19:30) 04:19:23 INFO - javascript benchmark 04:19:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3323.9002829915103, 3401.20071783131, 3416.8291585420725, 3458.56767904012, 3463.411220092584, 5535.474129957658, 5546.889062218764, 5578.3584887737925, 5590.944090559094, 5593.916091258629, 5548.056830338842, 5552.805651802188, 5557.360903496099, 5557.3886872444, 5582.162675598663, 5064.290999260106, 5103.209002604603, 5164.45773193813, 5165.896682066356, 5184.0, 4958.305837182797, 5035.798568057273, 5251.501107394792, 5262.236975638531, 5310.761015754281, 5033.11920413928, 5056.949430505685, 5076.340075790142, 5146.356705411824, 5187.714675692835, 5052.292679024939, 5091.363579552574, 5092.0, 5099.0, 5100.795968161269, 5001.649884508086, 5115.155999260118, 5132.820351287687, 5141.717205553693, 5150.793968241266, 5246.737663116829, 5325.999999999961, 5342.706151161685, 5355.839324820262, 5381.461853814626, 5887.499562537189, 5941.524678025748, 5988.071848863433, 5995.940040599582, 6009.459148676597, 5853.50245229156, 6010.549208809313, 6020.066889632114, 6021.90967135489, 6022.156898034279, 5599.916001259943, 5615.9157612635845, 5617.4382561743905, 5624.072028115315, 5650.208970744099, 6062.090686397076, 6103.0, 6106.72519736613, 6110.511159107261, 6122.0, 5788.855278618068, 5850.795222167204, 5872.882542349129, 5892.322382925932, 5929.407059294036, 6017.0, 6031.457168854824, 6032.487238584682, 6032.969835150796, 6034.24571928509, 5965.13505541694, 5968.403159683997, 5977.3126090500145, 5977.641341519523, 5987.0, 5717.599768016282, 5956.076808094752, 5980.85047873798, 6023.849403764941, 6050.304215015241, 4551.544845515488, 4565.0, 4575.862724118282, 4578.130155270488, 4590.0, 4112.465379500705, 4123.97938010308, 4137.9861933825805, 4143.02638879863, 4172.102997855475, 5568.972155139199, 5635.746391412396, 5712.6001179917, 5790.160426738099, 5837.591368604157, 5954.07711804671, 6006.189164462829, 6008.969955150196, 6011.038233882645, 6036.788712395045, 5498.367687715884, 5685.943140568624, 5700.771969121189, 5719.399463056402, 5745.913811292834, 5042.117629414838, 5057.848264552069, 5138.897222055538, 5176.06830770465, 5191.8182863599595, 6141.539384546088, 6168.537359698041, 6178.505719542516, 6205.844853878689, 6209.472194863397, 5978.97010514962, 5996.790112346047, 5997.310309314485, 6031.728572214349, 6034.668093254913, 6009.87980240384, 6115.514161902999, 6164.938350616616, 6214.9067763984485, 6222.968885155546, 5940.079287710412, 5942.61373010753, 5948.405159484017, 5951.315598706031, 5964.075568286922, 5883.882322353615, 5958.851028724316, 6012.8797424052145, 6021.939780602138, 6029.728662210299, 5840.2115714378015, 5914.733836977261, 5924.851878703067, 5932.703364831655, 5966.254218222723, 5793.797217097382, 5803.0, 5806.767729290781, 5846.181534585076, 5868.0, 5631.099024156116, 5740.483356497935, 5742.540596752333, 5765.8558536036935, 5787.623804452697, 5843.590948633725, 5867.9413205869105, 5887.558433117448, 5891.410858914246, 5901.557383196192, 5760.596758226884, 5761.481466667852, 5767.394423585631, 5777.2200752897825, 5780.450857168562], "unit": "score", "name": "dojo.html", "value": 5523.974837504086}, {"lowerIsBetter": false, "replicates": [551.9044696277886, 580.011081106713, 584.013003639293, 588.5350573047293, 603.3966033966034, 39828.601713982855, 40427.0, 40525.986850328794, 40605.39091913624, 40615.79692101539, 43600.3459948101, 43847.0, 44266.33600495987, 44392.778036109776, 44501.332480012825, 8867.911320886806, 8992.415492992966, 9010.774730631721, 9080.228180604623, 9101.772455688595, 8837.160469755396, 8952.776180595472, 9005.819883602357, 9190.21883139934, 9274.0, 9180.908190918106, 9226.907730922672, 9227.861582076273, 9258.953705231464, 9275.118863707938, 9185.95407022964, 9251.259899208047, 9262.397944133678, 9266.953665231698, 9289.907100929006, 9103.135202155785, 9238.03000684925, 9254.953725231398, 9256.0, 9291.070892910722, 42343.153136937086, 42815.78592107019, 42902.14195716068, 43033.56966430327, 43123.78438107821, 3776.150366167618, 3821.6942644588644, 3852.8266228019806, 3867.6325749054076, 3914.9608503914883, 31030.22424439407, 31100.688993110005, 31141.532877006863, 31257.68742312593, 32274.515882261785, 4208.494980602347, 4228.281192197333, 4240.639545638624, 4292.29177185764, 4317.460317460317, 294417.0, 300401.0, 301286.0, 301831.0, 303297.0, 48314.0, 49302.0, 72042.0, 73657.0, 74067.62966185242, 49138.0, 49219.0, 49261.0, 49493.752531237114, 49505.25742113871, 16113.838861611468, 16117.194140292939, 16127.274272657758, 16146.273417696231, 16181.757273640906, 12771.552995645108, 12898.0, 12922.095453318365, 12932.482700692055, 12968.80546791799, 16072.0, 16108.436204732778, 16142.75785863213, 16870.325186992628, 16964.830351696324, 6172.444479996821, 6189.907151392733, 6340.270868850049, 6394.26465956421, 6403.615783053032, 1000.1898462245605, 1107.617871834216, 1109.755853712182, 1145.1525870855507, 1159.8144296912453, 27284.727152728217, 27302.31744206371, 27421.725782742316, 27650.308742281202, 29051.56422653662, 1165.3998190931677, 1201.0571701214506, 1239.2378687107544, 1240.7828629989715, 1268.1820225954207, 15267.160356014445, 15489.30298136564, 15523.611909702122, 15871.841281587267, 15914.124723140338, 420690.0, 500978.0, 507066.0, 507170.0, 769422.0, 57709.422905771244, 57806.421935780105, 58067.70966145142, 58183.12725309124, 58207.41792582105, 1509.5094094419358, 1516.3252352702941, 1528.1976962094989, 1535.247728612994, 1552.0765144738862, 29242.0, 30196.849015754782, 30259.0, 30596.08211753651, 30712.078637640905, 51887.2216916739, 51928.48071519387, 52498.21252681137, 52685.20972185497, 52786.472135278156, 329002.0, 330199.0, 331045.0, 332135.0, 333056.0, 35562.64437355697, 35638.0, 36055.27889442249, 36276.27447451089, 36444.63555364519, 47325.71650849625, 47446.28830567475, 47653.0, 47951.0, 48538.5146148534, 39832.60167398289, 40419.1916161681, 41017.79491102525, 41133.58866411298, 41307.0, 39156.80421597874, 39633.0, 40610.121054972886, 40784.79607601943, 40993.1801363977, 38785.6121438782, 39145.0, 39230.41154382744, 39667.404988925766, 39721.40417893792, 34837.0, 35368.646313536534, 35732.0, 35843.64156358507, 36388.27223455569, 27468.45063098687, 27660.0, 27767.0, 27773.0, 27882.860585697752], "unit": "score", "name": "ext.html", "value": 19801.20598767598}, {"lowerIsBetter": false, "replicates": [384.2507111133291, 386.9980650096749, 392.630926928687, 393.40595700492247, 394.46746891696216, 17130.229139688712, 18166.4550063498, 18625.06874656267, 18705.4388368349, 18748.062596870135, 18504.167312470938, 18719.719204211946, 18763.437096887083, 18873.33943311981, 18892.81107188928, 5671.092625179972, 5909.586328956974, 5921.378255283198, 5939.109133629969, 5947.434993675594, 5288.127458969285, 5504.91742623861, 5521.558275337983, 5526.557875369961, 5528.115501519757, 5340.225667278242, 5463.7814487420455, 5495.340559132909, 5685.715714214293, 5708.315002199742, 5706.971465142668, 5733.741981610817, 5744.454276843735, 5748.97125514374, 5754.625949313302, 5394.244805727201, 5513.558915286768, 5523.7238138093335, 5593.74828132735, 5649.661020338752, 13539.796903046463, 13623.114497557726, 13632.250226237553, 13633.318334083257, 18472.630547388977, 2324.931649005168, 2354.587947109266, 2389.9163529276393, 2438.9512209755885, 2612.203278000209, 9964.80070398588, 10142.645007424704, 10333.896661033368, 10586.364818110938, 12828.294443805587, 1949.7952714964865, 1991.790861959488, 1994.2820584589535, 2008.56815784607, 2019.1418647075081, 67127.32872671308, 67326.66336668334, 68209.31790682129, 68876.0, 69969.0, 9694.709158725249, 9866.062724041205, 9908.20734341251, 9914.909359970541, 10010.949945250373, 13338.466461341437, 13538.729225415633, 13541.39063742134, 13570.796438053438, 13651.180929144084, 7806.68773249075, 7876.251756083163, 7880.251376119374, 7916.247956444128, 7932.365410767125, 7857.1749966253865, 7889.566073865878, 7960.562169080757, 7972.720954766672, 8003.919960800317, 3852.653261206449, 3987.641112299849, 4098.344264917599, 4117.094239267356, 4212.651951375592, 1757.3761314733342, 1789.0518025446534, 1821.3534195360721, 1869.1775618727715, 1879.6992481202942, 990.6730778842965, 1054.6414219165367, 1074.9623763168252, 1077.8706555213269, 1099.7360633447915, 16465.094419807025, 16518.339266429208, 16606.418775342805, 17146.914265428593, 17198.31206751741, 984.0061537846683, 997.4563862694848, 1035.2080658296409, 1091.6943255888364, 1091.9344839309667, 9545.61817527305, 10169.898301016896, 10172.745681358025, 10255.641052563124, 10306.433146176882, 431673.0, 431888.0, 436196.0, 440243.0, 441671.0, 72721.27278727251, 73966.0, 76250.61874690701, 76348.0, 79636.0, 1044.12815299226, 1051.3376572759266, 1070.6841481762742, 1078.735709751116, 1081.8269076947652, 15614.177989435932, 15643.843561564694, 15839.208039598205, 15959.840401595835, 15969.8403015973, 33833.15417114592, 34081.31837363289, 34473.827630861684, 34497.0, 34590.65409345975, 45365.54634453613, 47275.52724472711, 47446.05107897892, 47490.0, 48039.039219216116, 8050.033995920527, 8567.528785916835, 8584.699535516227, 8682.044975052613, 8785.51679657625, 7259.818504537428, 10083.344582602107, 11843.822342665038, 13377.732445351234, 13549.59351219465, 5552.944470555242, 5963.970180149072, 10652.254342196282, 11487.483063262007, 11723.882761172279, 11744.647660570197, 11966.760664786829, 11967.012980541784, 11974.401279936143, 12256.754864902474, 5854.795082172274, 8519.8722019171, 9895.406275623485, 11537.48081336325, 11752.823707644222, 8741.169588889044, 8769.38614296993, 8858.689945851864, 8907.153820387053, 8918.24194943437, 11641.76716465649, 11788.0, 11837.348945808064, 11858.822117668069, 11893.345865977455], "unit": "score", "name": "jquery.html", "value": 8591.516225403942}, {"lowerIsBetter": false, "replicates": [1531.7855500229966, 1539.276540026188, 1751.9474415767531, 1898.2596787252983, 1923.9422817315476, 7278.526895751786, 8101.3518918486525, 8266.38002149839, 8421.3683973702, 8434.789130271747, 8261.380396470258, 8464.492130472176, 8480.66077356905, 8499.447535910176, 8542.95728521358, 2411.156095366621, 2432.6107822748363, 2447.339218411028, 2452.0559584559983, 2452.0682140786475, 2414.9758502415016, 2432.489177272766, 2471.616899380599, 2476.578981573137, 2484.1926373928545, 2381.559411508868, 2405.651180578815, 2417.3110663460916, 2420.5037967216767, 2447.877606119696, 2336.5210131922913, 2342.6720259163644, 2351.670766092748, 2393.3418309964727, 2449.914253001154, 2389.749076346993, 2394.437307232799, 2403.675503806981, 2406.1337918349554, 2409.590369637166, 8472.661093556251, 8490.66037358505, 8530.914690853137, 8531.0, 8559.82880342396, 5191.584673226171, 5286.02208591408, 5336.359636843565, 5345.037893179227, 5346.652467589594, 3146.3235404387938, 3179.5071763876635, 3192.8084314940947, 3230.4508233600345, 3241.4813629819114, 1025.52825700178, 1030.9484525773682, 1045.7019749371468, 1052.1214785653988, 1087.983680244797, 11784.58753943608, 11795.0, 11840.171188016842, 11879.94060029703, 11900.226485278428, 4595.1039547287955, 4638.79125439356, 4667.9766601166775, 4692.95307046932, 4698.835540756126, 10187.949060254652, 10225.744356391, 10235.0, 10235.48822558884, 10253.179745620333, 5297.576193904479, 5322.574194064466, 5325.068113080196, 5327.7336133193185, 5341.732913354317, 4098.631123198927, 4532.5694059064335, 4546.636269098464, 4585.977070114628, 4809.831655892097, 3939.0546268895832, 3962.465067215889, 3986.940195897064, 3991.600839915985, 4041.6160464755803, 1257.0823298991788, 1262.0976002158318, 1267.512007876974, 1268.7272236469203, 1278.9104762666525, 1419.5599364197133, 1434.0391937401967, 1450.804141440892, 1494.5366936249798, 1498.0562245785304, 7983.0, 7986.640601172961, 7997.400194985399, 8017.919820801834, 8024.759257222176, 522.4018498818831, 528.1549520766742, 532.9899839803551, 540.0009981534209, 540.0818608365794, 5948.643081415043, 5992.8801423972145, 6000.909986350208, 6011.428914253226, 6069.2716873975405, 9930.900690993141, 10023.14803241718, 10122.645707400206, 10136.949315253523, 10194.694159175237, 10065.446400448045, 10151.847722284172, 10243.180545556486, 10255.128314093387, 10317.329373590692, 7943.563104029218, 8055.395845311508, 8078.636461359253, 8127.959360203161, 8137.715179968791, 7722.073351197892, 7744.341730952932, 7763.417743669361, 7774.067111946602, 7860.764177074697, 8939.955300223457, 9096.454212747256, 9160.267178625827, 9249.30630202724, 9300.767480813034, 9226.677066302647, 9250.583723732314, 9313.580888859882, 9381.530923453936, 9637.18083962871, 6350.142730731477, 6746.5277430581355, 6931.09895713554, 7205.891911621435, 7279.526830755984, 7674.155842857393, 7677.9232207677205, 7731.806704832199, 7756.379489640703, 7801.765947021599, 6787.830304242236, 6803.591784492946, 6860.656967151523, 6948.826279343057, 7007.544509606859, 6988.231294557493, 7027.543209691354, 7090.0, 7144.785656430316, 7155.427565794828, 7495.325420712162, 7532.811679708051, 7597.544147351176, 7636.08366995964, 7672.156062832973, 6994.160700715743, 6997.195322537973, 7009.649517524002, 7032.859342813217, 7063.470239732143, 6833.829154270984, 6837.453003759588, 6891.000804883364, 7061.929380706332, 7065.929340706527], "unit": "score", "name": "mootools.html", "value": 4732.597137910898}, {"lowerIsBetter": false, "replicates": [358.38715795988855, 358.8474898168278, 363.73992595294357, 366.28939856678045, 367.280130943351, 6388.520860935431, 6400.327965563619, 6415.582987105847, 6429.228492580891, 6449.355064493554, 6294.716737746801, 6298.779542716006, 6310.24277086749, 6322.557420980534, 6334.714937827797, 4688.578027977482, 4762.071396077767, 4835.443923948756, 4847.612191024709, 4904.239842824359, 4808.447028591704, 4815.566599006089, 4819.1325561398935, 4836.443808961962, 4838.951610483885, 4726.26742854858, 4743.976280118612, 4744.6204303655795, 4775.4985726498735, 4783.043391321749, 4802.159622066142, 4806.212396809842, 4812.133815913135, 4812.951870481303, 4823.155947709172, 4114.177164567069, 4180.28935081037, 4205.453291072172, 4208.621224089816, 4212.85255016073, 5937.584369094165, 6009.609375390585, 6063.727132279058, 6083.787067452662, 6096.359882212392, 5535.6955367454775, 5606.187102870102, 5609.635373700697, 5618.943810561924, 5624.3813180550105, 6661.833454163636, 6747.460203183734, 6773.762918297885, 6779.932200677979, 6781.152355955505, 4586.7477288749105, 4610.101030299093, 4613.884652883671, 4614.30785382192, 4624.28323609841, 6831.0, 6881.793546193622, 6946.826329341757, 6951.16586009682, 6957.860842783167, 4674.275487299474, 4738.857834264978, 4741.099191153669, 4745.549172828576, 4750.8337208197545, 4770.76146192689, 4810.13417584838, 4812.975935120302, 4813.229883218668, 4832.106060378841, 5539.7784088636, 5541.168824676331, 5547.306586676666, 5564.081926482166, 5615.775368985276, 6582.572132811448, 6677.933220667828, 6799.456043516507, 6808.9659551701925, 6811.046453496514, 1703.9744403833952, 1724.1637805664243, 1724.7240441529295, 1728.4296182259825, 1730.7403889416437, 1114.5597488991802, 1116.6426743442182, 1129.745807193375, 1129.9039581635652, 1142.160512023662, 6526.118973938553, 6544.54188206821, 6577.901331480031, 6582.111414959015, 6583.440407565315, 6950.965245173843, 6965.059716938148, 6978.651067446607, 6995.8600827983155, 7032.718691252395, 6533.477321814244, 6567.277599464055, 6582.506312026617, 6584.341565843377, 6588.703508342136, 3639.235760490327, 3715.5169827922196, 3753.868614598476, 3797.050737315671, 3802.980985095057, 7117.430605551647, 7140.107486564179, 7277.636118194069, 7291.197968223491, 7337.779866604011, 7188.4968052235845, 7192.208857025723, 7196.46026548011, 7219.494635375473, 7234.240404757425, 7342.596157211405, 7350.889736653954, 7351.117865856131, 7352.448566357544, 7360.227176146427, 6871.656417179221, 6997.4052205561065, 7004.124484439445, 7056.823579410556, 7071.540349877241, 6930.48021398387, 6938.479614029069, 6950.409215216763, 6951.235364110045, 6963.816151254197, 7257.637118144177, 7282.089738782653, 7291.05216321896, 7307.707691692272, 7314.378277846443, 4867.80528778859, 4869.780859861244, 4872.439669437918, 4884.413870335582, 4894.92657610129, 6820.317968203339, 7067.540609860343, 7082.433405327459, 7082.4688148390105, 7098.503104782616, 6781.89827152603, 6837.692303846239, 6842.486813489108, 6853.348931851466, 6866.073080134118, 6792.796216113525, 6823.112995310578, 6825.078614386995, 6844.486663500357, 6846.041554182518, 6651.7006734698025, 6694.698738556874, 6701.1623547056615, 6702.463802895854, 6725.663716814238, 6677.565958212701, 6883.3116688330765, 6884.552504087218, 6904.689288982108, 6933.064036355027, 6695.196576410667, 6714.899276510954, 6739.5619284746335, 6745.12313399255, 6746.392824645805], "unit": "score", "name": "prototype.html", "value": 5100.408359574742}, {"lowerIsBetter": false, "replicates": [821.7863355527562, 904.2720609909021, 908.6547112097397, 909.4179724976017, 909.4997751236821, 14983.0, 15128.697426051473, 15177.317020734066, 15224.543263702079, 15226.771598426005, 14165.504207352744, 14207.573772786807, 14242.643933901658, 14255.3585088671, 14261.714765704706, 759.350755104386, 912.4570880326195, 924.6070420071476, 928.8606708993638, 931.6273490603762, 932.9860052099224, 935.050923312838, 936.5972631768337, 939.173527295982, 946.2146418472652, 985.6747273399797, 989.7525618595351, 994.1599348550463, 1000.2448151645498, 1004.3923426327076, 989.0060489208299, 991.9603215871357, 992.1517102877044, 994.8358520844052, 996.7059717383316, 732.421387104187, 734.4234775701102, 734.7061175529831, 737.1522748838825, 737.200137850433, 14640.121592704365, 14713.043652162574, 14730.18983955882, 14745.336459859333, 14820.0, 14059.578212653636, 14100.224487653175, 14142.292885355691, 14217.644558886008, 14257.0, 12006.279623222634, 12063.758724825455, 12172.208806427554, 12202.267863928193, 12290.385480725929, 3949.526056873165, 3976.483057202574, 3982.601739825994, 4008.4388185654034, 4048.4534587830562, 53451.46548534504, 53640.0, 53678.46321536813, 54027.72986135083, 54252.0, 11316.207865449504, 11523.366214858095, 11548.133889958119, 11669.299842009506, 11693.239939403911, 21188.89405552993, 21333.35999920005, 21353.25263615766, 21361.35915922525, 21396.679049814265, 8241.546714930737, 8369.121242269595, 8454.704085356983, 8488.0, 8568.52873091986, 4672.275797251432, 4689.062187562433, 4722.315264286728, 4736.076465089274, 4819.036192761461, 3451.7066049386085, 3507.5264839246884, 3509.964900350964, 3510.210202704422, 3511.3855075361707, 610.3194937644583, 612.1980205930246, 612.2469362683835, 614.846288427893, 615.2463232540102, 718.2279050021143, 723.5976557827961, 738.6159197217524, 758.7647829172975, 777.3004296133412, 9299.0, 9484.099010593982, 9516.333856630108, 9700.854487182698, 9797.80404391908, 588.7880363069291, 646.4182235987555, 683.9637948508014, 710.7618947652594, 744.3747252308087, 4367.606915377632, 4426.667999900021, 4485.147821913826, 4489.595936365743, 4567.3377360282575, 66445.6677716618, 67358.97923062315, 67359.0, 67498.32501675018, 67646.32353676499, 55216.44783552113, 56050.0, 57258.427415726146, 58024.0, 59295.11057334144, 48435.0, 49208.753956229986, 49680.0, 49761.50238497568, 52231.21653175129, 8806.427582207136, 9043.366964312436, 9893.554790034323, 9909.752256193364, 10182.745431364276, 33205.0, 33533.664663353054, 35030.824845875606, 35034.82482587571, 35385.29229415449, 49184.26223606577, 49725.75137124291, 50189.0, 50609.24086138784, 50885.491145088075, 12525.56160534377, 12742.808857867325, 12776.680582985127, 12791.0, 12868.163569367962, 13709.451621935012, 14191.503297384543, 14370.49703260381, 14430.927845360706, 14920.0, 13131.146475479063, 13290.800637990631, 13291.268980206181, 13323.333833308103, 13418.597442076752, 13314.33428328599, 13362.398692059076, 13391.464341426234, 13394.93302533481, 13564.38960246811, 12737.363131843185, 12840.422181002064, 12954.222746635232, 12986.090973631755, 13346.532871349456, 10014.849777253492, 10098.54556544972, 10287.53706083213, 10299.227557933034, 10474.07666026578, 10855.0, 11180.776384472103, 11274.830877536679, 11292.096632269562, 11376.829347559627], "unit": "score", "name": "yui.html", "value": 7099.713767135908}], "name": "dromaeo_css", "value": 7376.195139755318}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 102.0, 109.0, 109.0, 111.0, 120.0, 110.0, 109.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 159.0, 160.0, 135.0, 158.0, 159.0, 130.0, 176.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 162.0, 163.0, 165.0, 162.0, 163.0, 167.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 76.0, 164.0, 82.0, 76.0, 77.0, 79.0, 182.0, 76.0], "unit": "score", "name": "audio-fft", "value": 96.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 138.0, 93.0, 94.0, 93.0, 147.0, 94.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0, 117.0, 120.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.8}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 146.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 98.0, 97.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 56.0, 54.0, 60.0, 55.0, 60.0, 61.0, 53.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 80.0, 78.0, 78.0, 79.0, 79.0, 78.0, 78.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.5}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 112.0, 121.0, 119.0, 127.0, 113.0, 118.0, 112.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.9}, {"lowerIsBetter": true, "replicates": [135.0, 153.0, 144.0, 141.0, 142.0, 145.0, 144.0, 144.0, 141.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 65.0, 66.0, 70.0, 67.0, 66.0, 65.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1515.1}]} 04:19:23 INFO - Return code: 0 04:19:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:19:23 ERROR - # TBPL SUCCESS # 04:19:23 INFO - Running post-action listener: _resource_record_post_action 04:19:23 INFO - Running post-run listener: _resource_record_post_run 04:19:24 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 500637696; Read time: 0; Write time: 650140 04:19:24 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 245465088; Read time: 0; Write time: 475932 04:19:25 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 255172608; Read time: 0; Write time: 174208 04:19:25 INFO - Running post-run listener: _upload_blobber_files 04:19:25 INFO - Blob upload gear active. 04:19:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:19:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:26 INFO - (blobuploader) - INFO - Done attempting. 04:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:26 INFO - (blobuploader) - INFO - Done attempting. 04:19:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:26 INFO - Return code: 0 04:19:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32a3a70d7a4bd146dd4618acb95f08a41665f411dd29f6ea983491d0d98efea34d6e4472ae2c53f226ff45e72c6822f09468409c61c6915f2a2c52f02cda4ccb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8904e53621da95a318b2fad21290db852cf95570b64c18103b6588e6ee7c217f144988eb890cf0d572e1a4c527be654af192754218bd420ed36ccfc06f779fe9"} 04:19:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:26 INFO - Contents: 04:19:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32a3a70d7a4bd146dd4618acb95f08a41665f411dd29f6ea983491d0d98efea34d6e4472ae2c53f226ff45e72c6822f09468409c61c6915f2a2c52f02cda4ccb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8904e53621da95a318b2fad21290db852cf95570b64c18103b6588e6ee7c217f144988eb890cf0d572e1a4c527be654af192754218bd420ed36ccfc06f779fe9"} 04:19:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:26 INFO - Copying logs to upload dir... 04:19:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.498597 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-27 04:19:26.926498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:26.930272) ========= 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=aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986 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/Mozilla-Aurora/sha512/32a3a70d7a4bd146dd4618acb95f08a41665f411dd29f6ea983491d0d98efea34d6e4472ae2c53f226ff45e72c6822f09468409c61c6915f2a2c52f02cda4ccb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8904e53621da95a318b2fad21290db852cf95570b64c18103b6588e6ee7c217f144988eb890cf0d572e1a4c527be654af192754218bd420ed36ccfc06f779fe9"} build_url:https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32a3a70d7a4bd146dd4618acb95f08a41665f411dd29f6ea983491d0d98efea34d6e4472ae2c53f226ff45e72c6822f09468409c61c6915f2a2c52f02cda4ccb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8904e53621da95a318b2fad21290db852cf95570b64c18103b6588e6ee7c217f144988eb890cf0d572e1a4c527be654af192754218bd420ed36ccfc06f779fe9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:26.955753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:26.956156) ========= 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=aa52b8aba932b19cc50b5275000001de-1461754740.36177-430990986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:27.038035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:19:27.038380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:19:27.038759) ========= ========= Total master_lag: 0.17 =========