builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1461754767.04 results: success (0) buildid: 20160425042155 builduid: 3cafbae6ee4445cbb07d61c2d398d690 revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.039583) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.040395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.040794) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.058272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.058674) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 03:59:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.5M=0s 2016-04-27 03:59:27 (95.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.206763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.281942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.282376) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013832 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.334601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:27.335110) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 03:59:27,841 truncating revision to first 12 chars 2016-04-27 03:59:27,841 Setting DEBUG logging. 2016-04-27 03:59:27,841 attempt 1/10 2016-04-27 03:59:27,841 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:28,186 unpacking tar archive at: mozilla-aurora-f328ac32af6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:28.011003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:28.011486) ========= script_repo_revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:28.011943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:28.012272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:59:28.023981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-04-27 03:59:28.024691) ========= /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=5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:28 INFO - MultiFileLogger online at 20160427 03:59:28 in /builds/slave/test 03:59:28 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:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:28 INFO - {'append_to_log': False, 03:59:28 INFO - 'base_work_dir': '/builds/slave/test', 03:59:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:59:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:28 INFO - 'branch': 'Mozilla-Aurora', 03:59:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:28 INFO - 'config_files': ('talos/linux_config.py',), 03:59:28 INFO - 'default_actions': ('clobber', 03:59:28 INFO - 'read-buildbot-config', 03:59:28 INFO - 'download-and-extract', 03:59:28 INFO - 'populate-webroot', 03:59:28 INFO - 'create-virtualenv', 03:59:28 INFO - 'install', 03:59:28 INFO - 'run-tests'), 03:59:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:28 INFO - 'download_minidump_stackwalk': True, 03:59:28 INFO - 'download_symbols': 'ondemand', 03:59:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:28 INFO - 'installer_path': 'installer.exe', 03:59:28 INFO - 'log_level': 'info', 03:59:28 INFO - 'log_name': 'talos', 03:59:28 INFO - 'log_to_console': True, 03:59:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:28 INFO - 'opt_config_files': (), 03:59:28 INFO - 'pip_index': False, 03:59:28 INFO - 'sps_profile': False, 03:59:28 INFO - 'sps_profile_interval': 0, 03:59:28 INFO - 'suite': 'dromaeojs-e10s', 03:59:28 INFO - 'system_bits': '32', 03:59:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:28 INFO - 'title': 'talos-linux64-ix-039', 03:59:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:28 INFO - 'use_talos_json': True, 03:59:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:28 INFO - 'work_dir': 'build'} 03:59:28 INFO - ##### 03:59:28 INFO - ##### Running clobber step. 03:59:28 INFO - ##### 03:59:28 INFO - Running pre-action listener: _resource_record_pre_action 03:59:28 INFO - Running main action method: clobber 03:59:28 INFO - rmtree: /builds/slave/test/build 03:59:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:29 INFO - Running post-action listener: _resource_record_post_action 03:59:29 INFO - ##### 03:59:29 INFO - ##### Running read-buildbot-config step. 03:59:29 INFO - ##### 03:59:29 INFO - Running pre-action listener: _resource_record_pre_action 03:59:29 INFO - Running main action method: read_buildbot_config 03:59:29 INFO - Using buildbot properties: 03:59:29 INFO - { 03:59:29 INFO - "project": "", 03:59:29 INFO - "product": "firefox", 03:59:29 INFO - "script_repo_revision": "production", 03:59:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:59:29 INFO - "repository": "", 03:59:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:59:29 INFO - "buildid": "20160425042155", 03:59:29 INFO - "pgo_build": "True", 03:59:29 INFO - "basedir": "/builds/slave/test", 03:59:29 INFO - "buildnumber": 267, 03:59:29 INFO - "slavename": "talos-linux64-ix-039", 03:59:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:59:29 INFO - "platform": "ubuntu64_hw", 03:59:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:59:29 INFO - "branch": "mozilla-aurora", 03:59:29 INFO - "repo_path": "releases/mozilla-aurora", 03:59:29 INFO - "revision": "f328ac32af6a3d0ce1593c41fd18edf7216a1652", 03:59:29 INFO - "stage_platform": "linux64-pgo", 03:59:29 INFO - "builduid": "3cafbae6ee4445cbb07d61c2d398d690", 03:59:29 INFO - "slavebuilddir": "test" 03:59:29 INFO - } 03:59:29 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:29 INFO - Running post-action listener: _resource_record_post_action 03:59:29 INFO - ##### 03:59:29 INFO - ##### Running download-and-extract step. 03:59:29 INFO - ##### 03:59:29 INFO - Running pre-action listener: _resource_record_pre_action 03:59:29 INFO - Running main action method: download_and_extract 03:59:29 INFO - mkdir: /builds/slave/test/build/tests 03:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:29 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:29 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:29 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:29 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:29 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:29 INFO - Downloaded 1448 bytes. 03:59:29 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:59:29 INFO - Using the following test package requirements: 03:59:29 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:29 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:29 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:59:29 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'jsshell-linux-x86_64.zip'], 03:59:29 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:29 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:29 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:59:29 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:59:29 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:29 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:29 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:29 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:29 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:29 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:29 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:29 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:29 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:30 INFO - Downloaded 23359883 bytes. 03:59:30 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:30 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:32 INFO - Return code: 0 03:59:32 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:32 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:32 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:32 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:32 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:32 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:32 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:33 INFO - Downloaded 23359883 bytes. 03:59:33 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:33 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:34 INFO - Return code: 0 03:59:34 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:34 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:34 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:34 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:34 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:34 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:35 INFO - Downloaded 10845194 bytes. 03:59:35 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:35 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:35 INFO - Return code: 0 03:59:35 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:35 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:35 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:35 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:35 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:35 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:37 INFO - Downloaded 60838843 bytes. 03:59:37 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:37 INFO - mkdir: /builds/slave/test/properties 03:59:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:37 INFO - Contents: 03:59:37 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:38 INFO - Running post-action listener: _resource_record_post_action 03:59:38 INFO - Running post-action listener: set_extra_try_arguments 03:59:38 INFO - ##### 03:59:38 INFO - ##### Running populate-webroot step. 03:59:38 INFO - ##### 03:59:38 INFO - Running pre-action listener: _resource_record_pre_action 03:59:38 INFO - Running main action method: populate_webroot 03:59:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:38 INFO - '--tppagecycles', 03:59:38 INFO - '7'], 03:59:38 INFO - 'tests': ['tsvgm']}}, 03:59:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:59:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:59:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:59:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'tests': ['damp', 'tps']}, 03:59:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['damp', 'tps']}, 03:59:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:38 INFO - 'other': {'tests': ['a11yr', 03:59:38 INFO - 'ts_paint', 03:59:38 INFO - 'tpaint', 03:59:38 INFO - 'sessionrestore', 03:59:38 INFO - 'sessionrestore_no_auto_restore', 03:59:38 INFO - 'tabpaint']}, 03:59:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['a11yr', 03:59:38 INFO - 'ts_paint', 03:59:38 INFO - 'tpaint', 03:59:38 INFO - 'sessionrestore', 03:59:38 INFO - 'sessionrestore_no_auto_restore', 03:59:38 INFO - 'tabpaint']}, 03:59:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['a11yr', 03:59:38 INFO - 'ts_paint', 03:59:38 INFO - 'tpaint', 03:59:38 INFO - 'sessionrestore', 03:59:38 INFO - 'sessionrestore_no_auto_restore', 03:59:38 INFO - 'tabpaint']}, 03:59:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['a11yr', 03:59:38 INFO - 'ts_paint', 03:59:38 INFO - 'tpaint', 03:59:38 INFO - 'sessionrestore', 03:59:38 INFO - 'sessionrestore_no_auto_restore', 03:59:38 INFO - 'tabpaint']}, 03:59:38 INFO - 'other_l64': {'tests': ['a11yr', 03:59:38 INFO - 'ts_paint', 03:59:38 INFO - 'tpaint', 03:59:38 INFO - 'sessionrestore', 03:59:38 INFO - 'sessionrestore_no_auto_restore', 03:59:38 INFO - 'tabpaint']}, 03:59:38 INFO - 'other_nol64': {'tests': ['a11yr', 03:59:38 INFO - 'ts_paint', 03:59:38 INFO - 'tpaint', 03:59:38 INFO - 'sessionrestore', 03:59:38 INFO - 'sessionrestore_no_auto_restore', 03:59:38 INFO - 'tabpaint']}, 03:59:38 INFO - 'svgr': {'tests': ['tsvgx', 03:59:38 INFO - 'tsvgr_opacity', 03:59:38 INFO - 'tart', 03:59:38 INFO - 'tscrollx', 03:59:38 INFO - 'cart']}, 03:59:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['tsvgx', 03:59:38 INFO - 'tsvgr_opacity', 03:59:38 INFO - 'tart', 03:59:38 INFO - 'tscrollx', 03:59:38 INFO - 'cart']}, 03:59:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'tests': ['tp5o']}, 03:59:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'talos_options': ['--e10s'], 03:59:38 INFO - 'tests': ['tp5o']}, 03:59:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'talos_options': ['--xperf_path', 03:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:38 INFO - 'tests': ['tp5n']}, 03:59:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:38 INFO - 'talos_options': ['--e10s', 03:59:38 INFO - '--xperf_path', 03:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:38 INFO - 'tests': ['tp5n']}}, 03:59:38 INFO - 'talos.zip': {'path': '', 03:59:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:38 INFO - Running post-action listener: _resource_record_post_action 03:59:38 INFO - ##### 03:59:38 INFO - ##### Running create-virtualenv step. 03:59:38 INFO - ##### 03:59:38 INFO - Running pre-action listener: _resource_record_pre_action 03:59:38 INFO - Running main action method: create_virtualenv 03:59:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:38 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:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:38 INFO - Using real prefix '/usr' 03:59:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:40 INFO - Installing pip.................done. 03:59:40 INFO - Return code: 0 03:59:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:40 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 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 03:59:40 INFO - 'HOME': '/home/cltbld', 03:59:40 INFO - 'LANG': 'en_US.UTF-8', 03:59:40 INFO - 'LANGUAGE': 'en_US:en', 03:59:40 INFO - 'LOGNAME': 'cltbld', 03:59:40 INFO - 'MAIL': '/var/mail/cltbld', 03:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:40 INFO - 'MOZ_NO_REMOTE': '1', 03:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:40 INFO - 'NO_EM_RESTART': '1', 03:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:40 INFO - 'PWD': '/builds/slave/test', 03:59:40 INFO - 'SHELL': '/bin/bash', 03:59:40 INFO - 'SHLVL': '1', 03:59:40 INFO - 'TERM': 'linux', 03:59:40 INFO - 'TMOUT': '86400', 03:59:40 INFO - 'USER': 'cltbld', 03:59:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:40 INFO - '_': '/tools/buildbot/bin/python'} 03:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:40 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:40 INFO - Cleaning up... 03:59:40 INFO - Return code: 0 03:59:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:59:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:40 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 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 03:59:40 INFO - 'HOME': '/home/cltbld', 03:59:40 INFO - 'LANG': 'en_US.UTF-8', 03:59:40 INFO - 'LANGUAGE': 'en_US:en', 03:59:40 INFO - 'LOGNAME': 'cltbld', 03:59:40 INFO - 'MAIL': '/var/mail/cltbld', 03:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:40 INFO - 'MOZ_NO_REMOTE': '1', 03:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:40 INFO - 'NO_EM_RESTART': '1', 03:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:40 INFO - 'PWD': '/builds/slave/test', 03:59:40 INFO - 'SHELL': '/bin/bash', 03:59:40 INFO - 'SHLVL': '1', 03:59:40 INFO - 'TERM': 'linux', 03:59:40 INFO - 'TMOUT': '86400', 03:59:40 INFO - 'USER': 'cltbld', 03:59:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:40 INFO - '_': '/tools/buildbot/bin/python'} 03:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:41 INFO - Downloading/unpacking psutil>=0.7.1 03:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:43 INFO - Installing collected packages: psutil 03:59:43 INFO - Running setup.py install for psutil 03:59:43 INFO - building 'psutil._psutil_linux' extension 03:59:43 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:43 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:43 INFO - building 'psutil._psutil_posix' extension 03:59:43 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:43 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:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:43 INFO - Successfully installed psutil 03:59:43 INFO - Cleaning up... 03:59:43 INFO - Return code: 0 03:59:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:59:43 INFO - Using env: {'DISPLAY': ':0', 03:59:43 INFO - 'HOME': '/home/cltbld', 03:59:43 INFO - 'LANG': 'en_US.UTF-8', 03:59:43 INFO - 'LANGUAGE': 'en_US:en', 03:59:43 INFO - 'LOGNAME': 'cltbld', 03:59:43 INFO - 'MAIL': '/var/mail/cltbld', 03:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:43 INFO - 'MOZ_NO_REMOTE': '1', 03:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:43 INFO - 'NO_EM_RESTART': '1', 03:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:43 INFO - 'PWD': '/builds/slave/test', 03:59:43 INFO - 'SHELL': '/bin/bash', 03:59:43 INFO - 'SHLVL': '1', 03:59:43 INFO - 'TERM': 'linux', 03:59:43 INFO - 'TMOUT': '86400', 03:59:43 INFO - 'USER': 'cltbld', 03:59:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:43 INFO - '_': '/tools/buildbot/bin/python'} 03:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:45 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:45 INFO - Installing collected packages: mozsystemmonitor 03:59:45 INFO - Running setup.py install for mozsystemmonitor 03:59:45 INFO - Successfully installed mozsystemmonitor 03:59:45 INFO - Cleaning up... 03:59:45 INFO - Return code: 0 03:59:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 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 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 03:59:45 INFO - 'HOME': '/home/cltbld', 03:59:45 INFO - 'LANG': 'en_US.UTF-8', 03:59:45 INFO - 'LANGUAGE': 'en_US:en', 03:59:45 INFO - 'LOGNAME': 'cltbld', 03:59:45 INFO - 'MAIL': '/var/mail/cltbld', 03:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:45 INFO - 'MOZ_NO_REMOTE': '1', 03:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:45 INFO - 'NO_EM_RESTART': '1', 03:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:45 INFO - 'PWD': '/builds/slave/test', 03:59:45 INFO - 'SHELL': '/bin/bash', 03:59:45 INFO - 'SHLVL': '1', 03:59:45 INFO - 'TERM': 'linux', 03:59:45 INFO - 'TMOUT': '86400', 03:59:45 INFO - 'USER': 'cltbld', 03:59:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:45 INFO - '_': '/tools/buildbot/bin/python'} 03:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - Downloading docopt-0.6.1.tar.gz 03:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:48 INFO - Running setup.py install for blobuploader 03:59:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:48 INFO - Running setup.py install for requests 03:59:49 INFO - Running setup.py install for docopt 03:59:49 INFO - Successfully installed blobuploader requests docopt 03:59:49 INFO - Cleaning up... 03:59:49 INFO - Return code: 0 03:59:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:49 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 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 03:59:49 INFO - 'HOME': '/home/cltbld', 03:59:49 INFO - 'LANG': 'en_US.UTF-8', 03:59:49 INFO - 'LANGUAGE': 'en_US:en', 03:59:49 INFO - 'LOGNAME': 'cltbld', 03:59:49 INFO - 'MAIL': '/var/mail/cltbld', 03:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:49 INFO - 'MOZ_NO_REMOTE': '1', 03:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:49 INFO - 'NO_EM_RESTART': '1', 03:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:49 INFO - 'PWD': '/builds/slave/test', 03:59:49 INFO - 'SHELL': '/bin/bash', 03:59:49 INFO - 'SHLVL': '1', 03:59:49 INFO - 'TERM': 'linux', 03:59:49 INFO - 'TMOUT': '86400', 03:59:49 INFO - 'USER': 'cltbld', 03:59:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:49 INFO - '_': '/tools/buildbot/bin/python'} 03:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:49 INFO - Running setup.py (path:/tmp/pip-dW_leo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:49 INFO - Running setup.py (path:/tmp/pip-4gjU1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:49 INFO - Running setup.py (path:/tmp/pip-2kYkJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:49 INFO - Running setup.py (path:/tmp/pip-JoN5hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:49 INFO - Running setup.py (path:/tmp/pip-trlW86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:49 INFO - Running setup.py (path:/tmp/pip-kVBpas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:50 INFO - Running setup.py (path:/tmp/pip-VHTYgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:50 INFO - Running setup.py (path:/tmp/pip-4cuHkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:50 INFO - Running setup.py (path:/tmp/pip-YasKHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:50 INFO - Running setup.py (path:/tmp/pip-9pBpfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:50 INFO - Running setup.py (path:/tmp/pip-YyXRKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:50 INFO - Running setup.py (path:/tmp/pip-iesGMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:50 INFO - Running setup.py (path:/tmp/pip-PRi8l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:50 INFO - Running setup.py (path:/tmp/pip-hW0ap8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:50 INFO - Running setup.py (path:/tmp/pip-RfUGB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:50 INFO - Running setup.py (path:/tmp/pip-oI6vFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:50 INFO - Running setup.py (path:/tmp/pip-TLlT32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:50 INFO - Running setup.py install for manifestparser 03:59:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozcrash 03:59:50 INFO - Running setup.py install for mozdebug 03:59:51 INFO - Running setup.py install for mozdevice 03:59:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozfile 03:59:51 INFO - Running setup.py install for mozhttpd 03:59:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozinfo 03:59:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozInstall 03:59:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozleak 03:59:51 INFO - Running setup.py install for mozlog 03:59:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for moznetwork 03:59:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozprocess 03:59:52 INFO - Running setup.py install for mozprofile 03:59:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Running setup.py install for mozrunner 03:59:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Running setup.py install for mozscreenshot 03:59:52 INFO - Running setup.py install for moztest 03:59:52 INFO - Running setup.py install for mozversion 03:59:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:52 INFO - Cleaning up... 03:59:52 INFO - Return code: 0 03:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:52 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 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 03:59:52 INFO - 'HOME': '/home/cltbld', 03:59:52 INFO - 'LANG': 'en_US.UTF-8', 03:59:52 INFO - 'LANGUAGE': 'en_US:en', 03:59:52 INFO - 'LOGNAME': 'cltbld', 03:59:52 INFO - 'MAIL': '/var/mail/cltbld', 03:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:52 INFO - 'MOZ_NO_REMOTE': '1', 03:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:52 INFO - 'NO_EM_RESTART': '1', 03:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:52 INFO - 'PWD': '/builds/slave/test', 03:59:52 INFO - 'SHELL': '/bin/bash', 03:59:52 INFO - 'SHLVL': '1', 03:59:52 INFO - 'TERM': 'linux', 03:59:52 INFO - 'TMOUT': '86400', 03:59:52 INFO - 'USER': 'cltbld', 03:59:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:52 INFO - '_': '/tools/buildbot/bin/python'} 03:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:52 INFO - Running setup.py (path:/tmp/pip-jde5KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:52 INFO - Running setup.py (path:/tmp/pip-O4zG5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:52 INFO - Running setup.py (path:/tmp/pip-OYVdX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:53 INFO - Running setup.py (path:/tmp/pip-XRXoto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:53 INFO - Running setup.py (path:/tmp/pip-UZRWoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:53 INFO - Running setup.py (path:/tmp/pip-GGdzPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:53 INFO - Running setup.py (path:/tmp/pip-Gbn9vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:53 INFO - Running setup.py (path:/tmp/pip-Na0WqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:53 INFO - Running setup.py (path:/tmp/pip-zP2s5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:53 INFO - Running setup.py (path:/tmp/pip-Jmwyv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:53 INFO - Running setup.py (path:/tmp/pip-sU0dZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:53 INFO - Running setup.py (path:/tmp/pip-ACk0s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:53 INFO - Running setup.py (path:/tmp/pip-J5velv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:53 INFO - Running setup.py (path:/tmp/pip-EXxlmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:53 INFO - Running setup.py (path:/tmp/pip-SC1RQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:53 INFO - Running setup.py (path:/tmp/pip-olWHHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:53 INFO - Running setup.py (path:/tmp/pip-T2zU82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:54 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:54 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:54 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:54 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:54 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:54 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:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:55 INFO - Downloading blessings-1.6.tar.gz 03:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:55 INFO - Installing collected packages: blessings 03:59:55 INFO - Running setup.py install for blessings 03:59:56 INFO - Successfully installed blessings 03:59:56 INFO - Cleaning up... 03:59:56 INFO - Return code: 0 03:59:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:56 INFO - Reading from file tmpfile_stdout 03:59:56 INFO - Current package versions: 03:59:56 INFO - argparse == 1.2.1 03:59:56 INFO - blessings == 1.6 03:59:56 INFO - blobuploader == 1.2.4 03:59:56 INFO - docopt == 0.6.1 03:59:56 INFO - manifestparser == 1.1 03:59:56 INFO - mozInstall == 1.12 03:59:56 INFO - mozcrash == 0.17 03:59:56 INFO - mozdebug == 0.1 03:59:56 INFO - mozdevice == 0.48 03:59:56 INFO - mozfile == 1.2 03:59:56 INFO - mozhttpd == 0.7 03:59:56 INFO - mozinfo == 0.9 03:59:56 INFO - mozleak == 0.1 03:59:56 INFO - mozlog == 3.1 03:59:56 INFO - moznetwork == 0.27 03:59:56 INFO - mozprocess == 0.22 03:59:56 INFO - mozprofile == 0.28 03:59:56 INFO - mozrunner == 6.11 03:59:56 INFO - mozscreenshot == 0.1 03:59:56 INFO - mozsystemmonitor == 0.0 03:59:56 INFO - moztest == 0.7 03:59:56 INFO - mozversion == 1.4 03:59:56 INFO - psutil == 3.1.1 03:59:56 INFO - requests == 1.2.3 03:59:56 INFO - wsgiref == 0.1.2 03:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 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 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 03:59:56 INFO - 'HOME': '/home/cltbld', 03:59:56 INFO - 'LANG': 'en_US.UTF-8', 03:59:56 INFO - 'LANGUAGE': 'en_US:en', 03:59:56 INFO - 'LOGNAME': 'cltbld', 03:59:56 INFO - 'MAIL': '/var/mail/cltbld', 03:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:56 INFO - 'MOZ_NO_REMOTE': '1', 03:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:56 INFO - 'NO_EM_RESTART': '1', 03:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:56 INFO - 'PWD': '/builds/slave/test', 03:59:56 INFO - 'SHELL': '/bin/bash', 03:59:56 INFO - 'SHLVL': '1', 03:59:56 INFO - 'TERM': 'linux', 03:59:56 INFO - 'TMOUT': '86400', 03:59:56 INFO - 'USER': 'cltbld', 03:59:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:56 INFO - '_': '/tools/buildbot/bin/python'} 03:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Cleaning up... 03:59:56 INFO - Return code: 0 03:59:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:59:56 INFO - Using env: {'DISPLAY': ':0', 03:59:56 INFO - 'HOME': '/home/cltbld', 03:59:56 INFO - 'LANG': 'en_US.UTF-8', 03:59:56 INFO - 'LANGUAGE': 'en_US:en', 03:59:56 INFO - 'LOGNAME': 'cltbld', 03:59:56 INFO - 'MAIL': '/var/mail/cltbld', 03:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:56 INFO - 'MOZ_NO_REMOTE': '1', 03:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:56 INFO - 'NO_EM_RESTART': '1', 03:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:56 INFO - 'PWD': '/builds/slave/test', 03:59:56 INFO - 'SHELL': '/bin/bash', 03:59:56 INFO - 'SHLVL': '1', 03:59:56 INFO - 'TERM': 'linux', 03:59:56 INFO - 'TMOUT': '86400', 03:59:56 INFO - 'USER': 'cltbld', 03:59:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:56 INFO - '_': '/tools/buildbot/bin/python'} 03:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:56 INFO - Downloading/unpacking jsonschema 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:58 INFO - Downloading/unpacking functools32 (from jsonschema) 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:58 INFO - warning: no files found matching '*.txt' 03:59:58 INFO - no previously-included directories found matching 'build' 03:59:58 INFO - no previously-included directories found matching 'dist' 03:59:58 INFO - no previously-included directories found matching '.git*' 03:59:58 INFO - Installing collected packages: jsonschema, functools32 03:59:58 INFO - Running setup.py install for functools32 03:59:59 INFO - warning: no files found matching '*.txt' 03:59:59 INFO - no previously-included directories found matching 'build' 03:59:59 INFO - no previously-included directories found matching 'dist' 03:59:59 INFO - no previously-included directories found matching '.git*' 03:59:59 INFO - Successfully installed jsonschema functools32 03:59:59 INFO - Cleaning up... 03:59:59 INFO - Return code: 0 03:59:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed92546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', '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:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:59:59 INFO - Using env: {'DISPLAY': ':0', 03:59:59 INFO - 'HOME': '/home/cltbld', 03:59:59 INFO - 'LANG': 'en_US.UTF-8', 03:59:59 INFO - 'LANGUAGE': 'en_US:en', 03:59:59 INFO - 'LOGNAME': 'cltbld', 03:59:59 INFO - 'MAIL': '/var/mail/cltbld', 03:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:59 INFO - 'MOZ_NO_REMOTE': '1', 03:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:59 INFO - 'NO_EM_RESTART': '1', 03:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:59 INFO - 'PWD': '/builds/slave/test', 03:59:59 INFO - 'SHELL': '/bin/bash', 03:59:59 INFO - 'SHLVL': '1', 03:59:59 INFO - 'TERM': 'linux', 03:59:59 INFO - 'TMOUT': '86400', 03:59:59 INFO - 'USER': 'cltbld', 03:59:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 03:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:59 INFO - '_': '/tools/buildbot/bin/python'} 03:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:59 INFO - Downloading/unpacking flake8 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:00:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:00:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:01 INFO - no previously-included directories found matching 'docs/_build' 04:00:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:00:02 INFO - Running setup.py install for pep8 04:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:02 INFO - no previously-included directories found matching 'docs/_build' 04:00:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:00:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:00:02 INFO - Cleaning up... 04:00:02 INFO - Return code: 0 04:00:02 INFO - Running post-action listener: _resource_record_post_action 04:00:02 INFO - Running post-action listener: _start_resource_monitoring 04:00:02 INFO - Starting resource monitoring. 04:00:02 INFO - ##### 04:00:02 INFO - ##### Running install step. 04:00:02 INFO - ##### 04:00:02 INFO - Running pre-action listener: _resource_record_pre_action 04:00:02 INFO - Running main action method: install 04:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:02 INFO - Reading from file tmpfile_stdout 04:00:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:02 INFO - Reading from file tmpfile_stdout 04:00:02 INFO - Output received: 04:00:02 INFO - Usage: mozinstall [options] installer 04:00:02 INFO - Options: 04:00:02 INFO - -h, --help show this help message and exit 04:00:02 INFO - -d DEST, --destination=DEST 04:00:02 INFO - Directory to install application into. [default: 04:00:02 INFO - "/builds/slave/test"] 04:00:02 INFO - --app=APP Application being installed. [default: firefox] 04:00:02 INFO - mkdir: /builds/slave/test/build/application 04:00:02 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'] 04:00:02 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 04:00:17 INFO - Reading from file tmpfile_stdout 04:00:17 INFO - Output received: 04:00:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:17 INFO - Running post-action listener: _resource_record_post_action 04:00:17 INFO - ##### 04:00:17 INFO - ##### Running run-tests step. 04:00:17 INFO - ##### 04:00:17 INFO - Running pre-action listener: _resource_record_pre_action 04:00:17 INFO - Running main action method: run_tests 04:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:17 INFO - Python 2.7.3 04:00:17 INFO - Return code: 0 04:00:17 INFO - grabbing minidump binary from tooltool 04:00: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')]} 04:00:17 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 0x148c160>, '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 0x148d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148d4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:17 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 04:00:17 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 04:00:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:17 INFO - Return code: 0 04:00:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:00:18 INFO - Return code: 0 04:00:18 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-039', '--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 04:00:18 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-039 --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 04:00:18 INFO - Using env: {'DISPLAY': ':0', 04:00:18 INFO - 'HOME': '/home/cltbld', 04:00:18 INFO - 'LANG': 'en_US.UTF-8', 04:00:18 INFO - 'LANGUAGE': 'en_US:en', 04:00:18 INFO - 'LOGNAME': 'cltbld', 04:00:18 INFO - 'MAIL': '/var/mail/cltbld', 04:00:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:18 INFO - 'MOZ_NO_REMOTE': '1', 04:00:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:18 INFO - 'NO_EM_RESTART': '1', 04:00:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:18 INFO - 'PWD': '/builds/slave/test', 04:00:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:18 INFO - 'SHELL': '/bin/bash', 04:00:18 INFO - 'SHLVL': '1', 04:00:18 INFO - 'TERM': 'linux', 04:00:18 INFO - 'TMOUT': '86400', 04:00:18 INFO - 'USER': 'cltbld', 04:00:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283', 04:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:18 INFO - '_': '/tools/buildbot/bin/python'} 04:00:18 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-039', '--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 04:00:19 INFO - mozversion application_buildid: 20160425042155 04:00:19 INFO - mozversion application_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 04:00:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:00:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:19 INFO - mozversion application_name: Firefox 04:00:19 INFO - mozversion application_remotingname: firefox-dev 04:00:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:00:19 INFO - mozversion application_vendor: Mozilla 04:00:19 INFO - mozversion application_version: 47.0a2 04:00:19 INFO - mozversion platform_buildid: 20160425042155 04:00:19 INFO - mozversion platform_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 04:00:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:00:19 INFO - mozversion platform_version: 47.0a2 04:00:19 INFO - using testdate: 1461754819 04:00:19 INFO - actual date: 1461754819 04:00:19 INFO - starting webserver on 'localhost:47115' 04:00:19 INFO - SUITE-START | Running 2 tests 04:00:19 INFO - TEST-START | dromaeo_css 04:00:19 INFO - operating with platform_type : linux_ 04:00:19 INFO - Initialising browser for dromaeo_css test... 04:00:19 INFO - TEST-INFO | started process 11336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX5FjC0/profile http://localhost:47115/getInfo.html) 04:00:22 INFO - PROCESS | 11336 | 04:00:22 INFO - PROCESS | 11336 | (process:11414): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:23 INFO - PROCESS | 11336 | __metrics Screen width/height:1600/1200 04:00:23 INFO - PROCESS | 11336 | colorDepth:24 04:00:23 INFO - PROCESS | 11336 | Browser inner width/height: 1024/697 04:00:23 INFO - PROCESS | 11336 | __metrics 04:00:24 ERROR - PROCESS | 11336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:00:25 INFO - TEST-INFO | 11336: exit 0 04:00:25 INFO - Browser initialized. 04:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:25 INFO - TEST-INFO | started process 11465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX5FjC0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:27 INFO - PROCESS | 11465 | 04:00:27 INFO - PROCESS | 11465 | (process:11533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:37 INFO - PROCESS | 11465 | RSS: Main: 151576576 04:00:37 INFO - PROCESS | 11465 | 04:01:26 INFO - PROCESS | 11465 | 1461754886824 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:35 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:47115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47115/tests/dromaeo/cssquery-ext.html) 04:03:36 INFO - PROCESS | 11465 | RSS: Main: 154312704 04:03:36 INFO - PROCESS | 11465 | 04:06:37 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:47115/tests/dromaeo/cssquery-ext.html (next: http://localhost:47115/tests/dromaeo/cssquery-jquery.html) 04:06:38 INFO - PROCESS | 11465 | RSS: Main: 153477120 04:06:38 INFO - PROCESS | 11465 | 04:09:40 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:47115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47115/tests/dromaeo/cssquery-mootools.html) 04:09:40 INFO - PROCESS | 11465 | RSS: Main: 153247744 04:09:40 INFO - PROCESS | 11465 | 04:12:42 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:47115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47115/tests/dromaeo/cssquery-prototype.html) 04:12:42 INFO - PROCESS | 11465 | RSS: Main: 152879104 04:12:42 INFO - PROCESS | 11465 | 04:15:45 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:47115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47115/tests/dromaeo/cssquery-yui.html) 04:15:45 INFO - PROCESS | 11465 | RSS: Main: 154423296 04:15:45 INFO - PROCESS | 11465 | 04:18:47 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:47115/tests/dromaeo/cssquery-yui.html (next: http://localhost:47115/tests/dromaeo/cssquery-dojo.html) 04:18:48 INFO - PROCESS | 11465 | RSS: Main: 155729920 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | __start_tp_report 04:18:48 INFO - PROCESS | 11465 | _x_x_mozilla_page_load 04:18:48 INFO - PROCESS | 11465 | _x_x_mozilla_page_load_details 04:18:48 INFO - PROCESS | 11465 | |i|pagename|runs| 04:18:48 INFO - PROCESS | 11465 | |0;dojo.html;3319.037479131052;3427.468742344937;3432.9485057724123;3473.739469539785;3474.496198051281;5575.358833734122;5577.135543990683;5602.411746766582;5602.831915042545;5629.127485239789;5614.410486898878;5635.830925072254;5641.464060914206;5645.689487078209;5663.830085097454;5121.462246464114;5175.482451754813;5182.948170518284;5207.6354655174155;5235.319408476893;5020.723860187688;5141.562967147797;5241.030409374278;5249.1338929076655;5250.133727934886;5127.717975511346;5171.689698618095;5178.974105129469;5262.8684282892855;5282.286891269668;5258.500442457979;5275.0768615492325;5282.3925248596515;5282.841514754564;5313.1764576490705;4941.579965702919;5013.774380152902;5103.362079740033;5142.537171654531;5226.3989641191365;5386.380566234894;5416.864578385572;5424.620276580641;5439.238506609078;5444.074507333763;5923.674197919113;5979.730912108966;5998.4601385875485;6010.098485227207;6029.547783916224;6037.54718396122;6073.180120683695;6113;6124.816255512342;6127.142200091991;5646.548276137899;5664.980303545361;5667.404922483162;5672;5679.460451257165;5939.732712027969;6205.565610407228;6212.720427580679;6215.285242197115;6233.407826256498;5971.790987315423;5984.401559844068;5988.610740301953;5990.520758339322;6019.247594050744;6073.39266073398;6076.149339092531;6079.452849243501;6080.635161890301;6092.268927728701;5920.023196172583;6002.219711437485;6037.969810151009;6038.30559485656;6080.179175811298;6042.12389203563;6077.1491991121275;6099.878002439927;6109.938900611026;6115.694215289218;4575.656825738083;4585.931211031837;4623.722576645345;4626.167289887852;4638.350630911675;4023.5372932112596;4110.157417729359;4142;4149.688773342012;4192.937105943413;5660.716964151776;5752.424757524214;5759.136129580513;5765.365809760923;5824.388439213906;6086.786962456293;6099.390060993954;6099.9085013724825;6111.816645500642;6111.816645500642;5574.275344205308;5757.107648314518;5765.221695071195;5787.942120578825;5826.475617194473;5192.636515443958;5204.0372531081875;5207.479252074762;5207.947920520822;5218.973905130526;6216.316205217422;6219.098230756515;6219.844503887349;6222.968885155636;6224.06639004153;5853.882922341444;6038.788642397495;6094.786682466092;6123.785667501795;6128.662923539248;6194.34959329282;6231.345708700521;6237.126802247598;6239.594426362272;6241.407066328691;5908.793192238423;5976.103584462366;5977.163197152315;5985.281766188085;6007.8197654070445;5963.0459126539545;6088;6091.177691011657;6146;6157.6613286269685;5960.046392577166;5996.400359963969;6008.339082700987;6009.789657361971;6030.849228769316;5795.391483894299;5957.553183511341;5967.731452084753;5992.490638295793;5993.490553303018;5805.332386775575;5847.94152058491;5849.94150058511;5863.149843272787;5907.645541267538;5841.474267315962;5950.583459157818;5952.464278214981;5965.105234214902;5966.463018328372;5666.206731057573;5840.591158618856;5854.092615644582;5864.560157988082;5867.061270196748 04:18:48 INFO - PROCESS | 11465 | |1;ext.html;514.3955851874044;564.2889958652098;578.0923949399444;605.2313561776541;615.3292910727306;30686.84656576717;37498.62501374986;37562.81218593903;37730.056748581264;38333.80833095834;41830;42071.579284207146;42423.787881060554;42503.78748106255;42509.7874510627;8795;8986.281097512216;8999.145081217306;8999.550022498881;9016.954915225415;8851.60167792451;8975.865362019542;8979.595918183664;9011.143941325596;9018.368714189977;8944.239739622108;8959.328050396214;8996.235319997808;9008.504532250723;9036.548172591343;8886.688965886195;8994.910050899472;9005.639774409015;9176.587053582605;9235.861462078074;9003.684871029547;9155.542222888895;9156.771080722969;9186.908130918739;9193.770155746093;41918;42347;42422.57577424217;42474.78762606198;42593.57406425927;3515.3320869035056;3541.628129046439;3684.9815750921075;3737.3085979093953;3884.3784994401044;31764.682353176635;32249.83875080633;32559.83720081408;33188.3362332752;33371.33257334864;4052.250333688248;4148.460700108997;4200.978995105035;4240.575942405735;4261.062566235423;281761;283355;284141;284693.5765321181;285318;45586.54413455889;59978.70010650006;61092;61098.69450652718;61257.38742612517;44314.113717725464;44914.77542612266;45083.77458112688;45137.54862451399;45315.09369812586;15894.364225431085;15987.840121598867;16120.355185792672;16161.191940402932;16224.945378550356;12900.612981610566;12932.41804118817;12971.286579238233;12996.610101696964;13072.411741471657;15526.068435893656;15544.145072021147;15562.533124006299;15659.530214093367;15739.213039347987;5957.314908785458;6034.818955431344;6052.213212282463;6100.176476175749;6177.505799536027;1069.2301542889263;1069.588208539718;1094.2395035450445;1136.6760473265244;1195.838561794164;32996.67003329936;34487.310253794785;34725.47911781325;35069.47395789065;35341;1138.5844166879194;1157.8321143434323;1157.8842115788523;1220.1215125109907;1244.6079484962208;15516;15551.455699050479;15624.92187539055;15902.125383104041;16025.67948641044;408359;492520;494533;516549;516828;55606;56620;56658;56739;56741.71629141828;1434.583970648521;1452.0996981871308;1452.6513636727109;1459.4818839312104;1491.164947629331;29384.26539336534;30744.538831917092;30893.69106308998;31330.843345783127;31798.841005794824;48185;48755.26867096926;48957.2656410147;49218.26172607342;49348.2597761041;316163;324557;326179;327296;327752;34040.31919361649;34214.315713685086;34424.31151377009;34510.30979380449;34645.13387165341;44843.77578112089;45491.31763023491;45664.771676141405;45975.54024459713;46114.769426152656;36866;38082.61917380901;38427.42358864675;38973.220535589695;39136.412953806284;37062;38880.416793748685;39079.804600976815;39782;39850;38216.61783382131;38689.6131038686;38928.41607375835;39190.608093918694;39304.41043384409;33585.034925457956;34047;34204.31591368109;34409.483857742656;34635.4804677925;26387;26434;26449;26700.465990679688;26727.331816704736 04:18:48 INFO - PROCESS | 11465 | |2;jquery.html;374.18054460731;389.4469852809012;395.30229145558116;395.5806844744571;403.1976367029612;16800.579985500353;18865.62268754624;18909.810901890978;19084.618307633857;19243.711344329848;17386.3914762983;17478.3008679653;17668.469945901612;17748.733768993476;17810.376636817713;5117.181250999841;5184.403793563751;5228.320318358627;5357.785688572472;5382.461753824606;5209.1404918188455;5259.474052594748;5269.262303277545;5269.394019687727;5290.074237008527;5140.228965655144;5246.921296180561;5278.102722537178;5280.366356037281;5301.8939621207555;5568.387477377485;5630.859228519279;5640.802571909984;5668.319801623811;5683.914741278884;5033.974830125862;5053.140966035783;5056.924146137811;5059.16523773577;5083.923741143886;13860.861391386057;18916.243350265973;21540.461488462755;22239.888800556055;22415.887920560293;2311.4914718761847;2747.955776804801;3005.3989202159655;3031.5149576067724;3032.150997720642;10275.743106422324;11065.889341106566;11537.307761534335;12707.745845083138;14113.87089032875;1817.3639226270832;1911.7036859286832;1928.4503916383762;1956.4424139120283;1962.0876292523901;64392.35607643911;68177.65911170462;69475;71953.6402317985;73694.63152684203;9501.287403444769;9657.275704322205;9661.565229564687;9797.853032204523;9911.10800028001;13107.803382949263;13533;13552.186868787905;13717.108387954751;14466.927665361605;7626.580538070349;7694.538327700356;7738;7745.10931242903;7895.328897043701;7684.884726729104;7719.498232614862;7725.5364678119495;7790.415718821111;7818.14000459949;4220.303649897794;4304.225239456865;4306.332518459643;4309.892252693708;4313.0726893718;1797.5056859363779;1798.5773343264323;1825.799162092169;1848.7966323704381;1920.4718702356683;951.8429459139164;963.9518024098767;1019.6635110413694;1049.3284298049255;1075.1828610256105;16647.250873710713;17189.57026074358;17396.913015435093;17667.29330826778;17713.557161070818;975.1467465967279;1008.6167256442504;1042.551702767802;1052.9105026072716;1061.1192710050639;6308.243010838729;6670.399664030164;6674.399304062657;9309.674161404453;9410.529473526296;257826;366907;490170;491256;495909;82140;82673;85816;86795;87450.56274718713;499.6202885806813;519.2833889232835;519.8258583374536;521.817363922624;522.1827839431354;9480.336376453582;10156.644517441853;10594.4702764863;10777.838332424863;11093.833592496281;35527.64472355243;36432.27135457329;36584.634153658124;36756.632433675324;37421.43867842039;47219;51026;52272.47727522676;52514.212286816495;52781.7360913193;8641.351898607756;8647.14225285546;8711.520866352412;8727.345449091217;8804.515751633722;9865.06281903218;13026.869731302566;13171.47314107425;13229.206247625174;13463.528776492776;11142.498587563417;11175.161862860155;11356.375399353115;11615.477303521193;11710.238834475731;11280.492377842853;11376.829347559627;11615.593454229062;11654.941725291319;11921.940390297994;11052.834207487054;11367.829482557934;11787.174897757075;11919.284842909454;12045.698857528632;8310.252077313071;8397.538135402612;8738.475691458278;8782.253508451598;8814.603342849716;10957.287776294515;11047.834282485608;11270.774584508099;11303.039241664223;11439.714007149554 04:18:48 INFO - PROCESS | 11465 | |3;mootools.html;1564.0693787196617;1570.8115026196858;1756.2272600055974;1868.6169335286268;1896.6680830854605;7309.159446663635;8007.759767206979;8101.270885620293;8258.050324212718;8338.749837504876;7966.5618390988475;8061.516309021463;8180.181981801832;8201.220884016024;8207.097219305871;2389.044382247102;2407.843490173142;2419.6249581314923;2421.673074134987;2424.2848359733835;2412.7345991940874;2422.2975337152207;2453.7791598756107;2460.803135749136;2465.4329504214043;2368.798652114572;2371.3952941999764;2381.7499162587937;2401.7117945846435;2404.603240465321;2390.9760902390926;2419.7701218384314;2419.830611857171;2423.9636405453934;2424.660547523348;2424.248482970285;2431.647411125377;2441.4506735984437;2448.6939132608422;2452.301094188148;8229.753107406728;8296.170382961716;8296.336293096538;8307.750767476924;8354.624041918129;5176.249443830661;5210.062188806013;5249.973750131263;5274.815381461669;5285.4450282720145;3037.681043490446;3078.6459557150993;3105.627324721048;3121.890733824328;3157.068664743906;962.43216502264;971.9757006074834;975.8874882633803;1013.3413281367096;1020.0258752890971;11418.143639227092;11425.200235983484;11478.655640330804;11533.826992595117;11538.365389903553;4319.6976211665515;4388.232059389594;4439.578240067189;4461.5092339842595;4478.865634030984;9090.727278181665;9122.81754364909;9145.725628231165;9154.31342649304;9166.450012999241;5131.384233891957;5147.0735267651435;5158.303629010111;5158.948410515847;5164.612654050961;4166.0834616384345;4652.767361631905;4703.318018887242;4729;4742.312364707098;3614.584322802859;3643.0710168906758;3648.835802388899;3699.7595156314756;3710.5547334320054;1080.556971641639;1091.6343025086526;1094.3816743539874;1106.286445242814;1106.5020740666732;1431.334429490292;1438.1155589312707;1450.782382642612;1451.6298343922444;1469.8677119059337;7657.57883316423;7684.039495063117;7700.653470593837;7704.036995375578;7726.922730772732;524.1011664994553;525.4167873660234;528.8228443471403;531.1342511705894;542.6174546944395;5940.227770389822;5975.25309336333;5982.880342393128;5995.790147344822;6049.667268300285;9349.626014959325;9489.572969216402;9537.046295370546;9618.278629102706;9618.326717129734;9236.937752158454;9387.202087822476;9427.57575909072;9438.292128090283;9473;7795.610219489003;7834.764957051298;7851.371890248766;7888.723894663659;7895.052593688794;7617.581033043014;7631.69473221065;7679.769606911802;7734.071911370672;8000.51996880189;8851.734447966572;8962.73111806647;9085.727428177166;9119.635214591342;9207.355485115977;8942.50816205115;9108.499032553273;9186.816263674822;9313.953430232805;9388.342816003087;6372.617642941438;6790.354916282945;6927.445804335742;6937.7571784987285;7078.115235595551;7807.024121984752;7833;7845.960770196112;7862.921370786219;7869.724559640614;7123.145222573325;7177.461690373348;7269.41844652416;7314.561126332437;7359.337659610661;7146.9285307146265;7168.17565979919;7199.71201151948;7235.782926512213;7269.491135620456;7343.4492413068165;7551.697932082875;7554.131274903457;7572.734954276574;7599.810004749926;6883.242843287134;6899;6946.235914049349;6954.617496037767;6966.1988871280455;6929.272426395156;7057.188423331382;7065.717371305091;7087.893681594677;7100.609466479394 04:18:48 INFO - PROCESS | 11465 | |4;prototype.html;363.5982239625214;363.8399104394068;367.35162438296413;371.0871256708497;375.2869547859069;6389.361063893608;6413.8717225655455;6460.935390646092;6477.352264773526;6484.319146489622;6348.6825658717;6349.8412539686415;6350.364963503659;6370.458511026557;6378.330275321094;4677.36855524505;4746.76266186691;4858.587020103296;4861.513848615145;4875.804967801284;4820.39745031871;4859.805607775685;4865.343178670887;4867.634927380443;4879.048585525824;4793.7363445010515;4814.398200224972;4820.855374338758;4825.131476334259;4826.5414785595485;4818.566329030386;4828.758562071883;4833.854984350475;4839;4839.661223714342;4328.696991210617;4332.9566704332865;4333.43665323506;4337.850469625551;4340.565943405666;5889.1460738193155;6066.48434883031;6103.786367477162;6120.663363515005;6124.601900876429;5660.037793575102;5685.090385538294;5686.2039314496005;5695.658260504341;5705.515031222351;6729.596224226562;6747.5276730628875;6766.661666916634;6791.524593278473;6813.148356455443;4684.36761037259;4699.647526435531;4702.764861756933;4704.529547045302;4717.292406139107;7076.469264805109;7126.857462850714;7134.2509036551455;7147.74982875602;7163.570185788869;4702.9764851176205;4740.762961851894;4785;4785.808567657325;4788.880277993008;4844.660873738875;4857.295692124693;4863.440704319049;4917.582005529499;4923.384576927884;5666.631668941588;5673.971630141823;5686.9715651421475;5687.914681279784;5689.487946084872;6818.624975626289;6821.113255276782;6836.965815170992;6840.042394064835;6846.349596788297;1696.584336837458;1734.0289437914807;1735.8803571696185;1736.140610397861;1737.4353335166122;1092.5029111754134;1125.9605913792977;1133.0595605647293;1134.325076579434;1153.6308381318065;6537.378948999933;6608.570442921195;6615.37153970372;6617.8014659560295;6627.768028118992;7041.260667629927;7042.119735033121;7044.189918159374;7098.858022839618;7100.325469080429;6609.306022867626;6619.669016549154;6627.403533681895;6662.7334906604165;6685.39831415175;3779.9244015120094;3813.866514671973;3822.0444888777806;3827.2536855312946;3846.0961674006585;7102.538335008208;7276.1622967042895;7286.599237042014;7341.192468828424;7344.081989751281;7164.713411463483;7185.101862267216;7189.676464559107;7208.56748595086;7223.855522889513;7248.963755181296;7271.236520165412;7274.127104747464;7286.162091359562;7292.562446253241;6878.793636190922;7044.330788575077;7047.647617619201;7059.5058345915295;7065.6820443081215;6839;6854.862902742017;6889.724411023503;6901.275366086488;6916.100906882073;7209.387202087882;7222.0611320528;7256.7097316106765;7272.563646181246;7280.672369743268;4816.397950256218;4824.95175048245;4835.782389792538;4849.733264670477;4854.077725232195;6779.8983015253825;6958.686859091455;6994.860102798018;7015.789526314014;7154.713811447484;6892.207396149507;6902.378785909293;6913.204981426999;6917.100776898971;6918.411934985583;6865.862682746218;6899.793006209822;6901.689423976033;6905.240423553305;6922.342377474132;6700.932990670226;6741.02255173007;6748.898766518408;6750.426213771884;6791.558548694319;6808.62552559614;6849.616245602918;6962.721491140298;6962.756303529352;6966.1988871280455;6743.1908171019795;6747.224069232101;6764.289749576224;6782.287859774653;6797.694103765243 04:18:48 INFO - PROCESS | 11465 | |5;yui.html;790.6481615681021;802.9156938521455;869.7825543614097;871.0940621753376;881.88094607228;14825.110493370405;15004.624884377896;15065.472708455207;15087;15132.848671513282;12612.747745045117;13944.372503237353;14018.509352172676;14020.22888741119;14028.78956815646;922.9769255768592;944.7496413450407;944.9291303152256;951.2580187453763;951.9333646644737;939.539625583466;946.0350442548631;947.3557980573207;947.4173383369247;947.8815148106487;985.9063388978036;988.2884323287258;990.6483198464549;996.2030375699447;998.4907697074508;972.7762614598646;977.941323520591;978.2467500024941;984.758734110144;989.3519744567284;723.2911746488418;736.4145504324075;736.4292673178276;737.1890919988024;740.4446665001249;13807.102538334975;13823.654408639764;13860.861391386057;13890.791638125436;13940.86059139416;14319.928400358036;14638.853611463855;14642.780358294634;14668;14853;11722.531098756039;11726.648200553997;11760.529578816837;11793.528258869635;11839.28964262147;3942.1524372259814;3955.960440395617;3974.602539746031;4009.0779120802085;4012.1775036117524;56047.43952560463;56235.71882140604;56256.718716406154;56617.71691141518;56714.71642641802;10555.366677999345;10789.62236321725;10864.293820901616;10870.130389568816;10888.455577221108;18890.62218755617;18937.242510299435;18971;19110.90444547796;19166.80833191678;7663.080430348283;7777.72777952769;7918.960405197937;8013.038435387674;8049.839003219903;4454.4654641442585;4568.840090596879;4599.05719327537;4613.677042606985;4759.643026773006;3324.900252992414;3325.4061831771255;3348.7823291485975;3354.8825791097192;3358.026172410023;573.1202604002918;584.5294537897033;589.7847285740673;593.3354642800092;593.403629352498;716.5270921191989;762.7521055656933;768.0667988394127;788.9368850491946;790.3795520516367;9598.184154346958;9607.711768646952;9702.951485242529;9861.506924653739;9971;606.3693758491208;626.8687903919949;642.7172044300493;677.7187467201155;756.3193126186476;4069.206504731608;4179.310413781692;4215.662746980234;4328.177646247203;4403.8018289176425;58172;59204.70397647984;61405.38594613997;62115.37884621186;62141.06788398178;51793.7410312946;52101;53485;54101;54384.728076359366;45849.54150458453;47396.05207895823;49922.50077499251;50322.74838625784;51109.744451277504;9116.954415227881;9134.725958221265;9153.814255809424;9307.813843723223;9380.437173769596;35801.1049723759;36049.81975090108;37192.256154877294;37205.44191837179;37284.25431491301;43880.78059609809;46016.76991615154;47197.29204061873;47329.76335118302;48096.03807923892;12249.448774804978;12701.682457938625;12717.364131793189;12720.236785792882;12937.094403391673;13669.521566745116;13851.16892986424;13958.371873265525;14151.080179788692;14331.211783352015;12754.936225318814;13006.609801705965;13035.283059431822;13206.80189797173;13267.270300133585;12906.483740650268;13008;13009.544665936646;13282.269475178959;13410.597682069554;12813.615591532269;12916.806247906477;13274;13417.262050587311;13635.454581816617;10947.56209751601;11240;11271.323720576791;11384.14618903569;11546.76906461883;10079.748006299902;10153.796924061626;10399.740006499595;10870.61952831647;11392.316461012366 04:18:48 INFO - PROCESS | 11465 | __end_tp_report 04:18:48 INFO - PROCESS | 11465 | __start_cc_report 04:18:48 INFO - PROCESS | 11465 | _x_x_mozilla_cycle_collect,335 04:18:48 INFO - PROCESS | 11465 | __end_cc_report 04:18:48 INFO - PROCESS | 11465 | __startTimestamp1461755928170__endTimestamp 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | ------- Summary: start ------- 04:18:48 INFO - PROCESS | 11465 | Number of tests: 6 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | [#0] dojo.html Cycles:165 Average:5628.93 Median:5853.88 stddev:621.72 (10.6%) stddev-sans-first:596.63 04:18:48 INFO - PROCESS | 11465 | Values: 3319.0 3427.5 3432.9 3473.7 3474.5 5575.4 5577.1 5602.4 5602.8 5629.1 5614.4 5635.8 5641.5 5645.7 5663.8 5121.5 5175.5 5182.9 5207.6 5235.3 5020.7 5141.6 5241.0 5249.1 5250.1 5127.7 5171.7 5179.0 5262.9 5282.3 5258.5 5275.1 5282.4 5282.8 5313.2 4941.6 5013.8 5103.4 5142.5 5226.4 5386.4 5416.9 5424.6 5439.2 5444.1 5923.7 5979.7 5998.5 6010.1 6029.5 6037.5 6073.2 6113.0 6124.8 6127.1 5646.5 5665.0 5667.4 5672.0 5679.5 5939.7 6205.6 6212.7 6215.3 6233.4 5971.8 5984.4 5988.6 5990.5 6019.2 6073.4 6076.1 6079.5 6080.6 6092.3 5920.0 6002.2 6038.0 6038.3 6080.2 6042.1 6077.1 6099.9 6109.9 6115.7 4575.7 4585.9 4623.7 4626.2 4638.4 4023.5 4110.2 4142.0 4149.7 4192.9 5660.7 5752.4 5759.1 5765.4 5824.4 6086.8 6099.4 6099.9 6111.8 6111.8 5574.3 5757.1 5765.2 5787.9 5826.5 5192.6 5204.0 5207.5 5207.9 5219.0 6216.3 6219.1 6219.8 6223.0 6224.1 5853.9 6038.8 6094.8 6123.8 6128.7 6194.3 6231.3 6237.1 6239.6 6241.4 5908.8 5976.1 5977.2 5985.3 6007.8 5963.0 6088.0 6091.2 6146.0 6157.7 5960.0 5996.4 6008.3 6009.8 6030.8 5795.4 5957.6 5967.7 5992.5 5993.5 5805.3 5847.9 5849.9 5863.1 5907.6 5841.5 5950.6 5952.5 5965.1 5966.5 5666.2 5840.6 5854.1 5864.6 5867.1 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | [#1] ext.html Cycles:180 Average:52822.93 Median:21382.40 stddev:99308.19 (464.4%) stddev-sans-first:99509.11 04:18:48 INFO - PROCESS | 11465 | Values: 514.4 564.3 578.1 605.2 615.3 30686.8 37498.6 37562.8 37730.1 38333.8 41830.0 42071.6 42423.8 42503.8 42509.8 8795.0 8986.3 8999.1 8999.6 9017.0 8851.6 8975.9 8979.6 9011.1 9018.4 8944.2 8959.3 8996.2 9008.5 9036.5 8886.7 8994.9 9005.6 9176.6 9235.9 9003.7 9155.5 9156.8 9186.9 9193.8 41918.0 42347.0 42422.6 42474.8 42593.6 3515.3 3541.6 3685.0 3737.3 3884.4 31764.7 32249.8 32559.8 33188.3 33371.3 4052.3 4148.5 4201.0 4240.6 4261.1 281761.0 283355.0 284141.0 284693.6 285318.0 45586.5 59978.7 61092.0 61098.7 61257.4 44314.1 44914.8 45083.8 45137.5 45315.1 15894.4 15987.8 16120.4 16161.2 16224.9 12900.6 12932.4 12971.3 12996.6 13072.4 15526.1 15544.1 15562.5 15659.5 15739.2 5957.3 6034.8 6052.2 6100.2 6177.5 1069.2 1069.6 1094.2 1136.7 1195.8 32996.7 34487.3 34725.5 35069.5 35341.0 1138.6 1157.8 1157.9 1220.1 1244.6 15516.0 15551.5 15624.9 15902.1 16025.7 408359.0 492520.0 494533.0 516549.0 516828.0 55606.0 56620.0 56658.0 56739.0 56741.7 1434.6 1452.1 1452.7 1459.5 1491.2 29384.3 30744.5 30893.7 31330.8 31798.8 48185.0 48755.3 48957.3 49218.3 49348.3 316163.0 324557.0 326179.0 327296.0 327752.0 34040.3 34214.3 34424.3 34510.3 34645.1 44843.8 45491.3 45664.8 45975.5 46114.8 36866.0 38082.6 38427.4 38973.2 39136.4 37062.0 38880.4 39079.8 39782.0 39850.0 38216.6 38689.6 38928.4 39190.6 39304.4 33585.0 34047.0 34204.3 34409.5 34635.5 26387.0 26434.0 26449.0 26700.5 26727.3 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | [#2] jquery.html Cycles:180 Average:25577.97 Median:399.39 stddev:71160.69 (17817.4%) stddev-sans-first:71335.15 04:18:48 INFO - PROCESS | 11465 | Values: 374.2 389.4 395.3 395.6 403.2 16800.6 18865.6 18909.8 19084.6 19243.7 17386.4 17478.3 17668.5 17748.7 17810.4 5117.2 5184.4 5228.3 5357.8 5382.5 5209.1 5259.5 5269.3 5269.4 5290.1 5140.2 5246.9 5278.1 5280.4 5301.9 5568.4 5630.9 5640.8 5668.3 5683.9 5034.0 5053.1 5056.9 5059.2 5083.9 13860.9 18916.2 21540.5 22239.9 22415.9 2311.5 2748.0 3005.4 3031.5 3032.2 10275.7 11065.9 11537.3 12707.7 14113.9 1817.4 1911.7 1928.5 1956.4 1962.1 64392.4 68177.7 69475.0 71953.6 73694.6 9501.3 9657.3 9661.6 9797.9 9911.1 13107.8 13533.0 13552.2 13717.1 14466.9 7626.6 7694.5 7738.0 7745.1 7895.3 7684.9 7719.5 7725.5 7790.4 7818.1 4220.3 4304.2 4306.3 4309.9 4313.1 1797.5 1798.6 1825.8 1848.8 1920.5 951.8 964.0 1019.7 1049.3 1075.2 16647.3 17189.6 17396.9 17667.3 17713.6 975.1 1008.6 1042.6 1052.9 1061.1 6308.2 6670.4 6674.4 9309.7 9410.5 257826.0 366907.0 490170.0 491256.0 495909.0 82140.0 82673.0 85816.0 86795.0 87450.6 499.6 519.3 519.8 521.8 522.2 9480.3 10156.6 10594.5 10777.8 11093.8 35527.6 36432.3 36584.6 36756.6 37421.4 47219.0 51026.0 52272.5 52514.2 52781.7 8641.4 8647.1 8711.5 8727.3 8804.5 9865.1 13026.9 13171.5 13229.2 13463.5 11142.5 11175.2 11356.4 11615.5 11710.2 11280.5 11376.8 11615.6 11654.9 11921.9 11052.8 11367.8 11787.2 11919.3 12045.7 8310.3 8397.5 8738.5 8782.3 8814.6 10957.3 11047.8 11270.8 11303.0 11439.7 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | [#3] mootools.html Cycles:180 Average:5726.07 Median:6913.22 stddev:2976.30 (43.1%) stddev-sans-first:2968.21 04:18:48 INFO - PROCESS | 11465 | Values: 1564.1 1570.8 1756.2 1868.6 1896.7 7309.2 8007.8 8101.3 8258.1 8338.7 7966.6 8061.5 8180.2 8201.2 8207.1 2389.0 2407.8 2419.6 2421.7 2424.3 2412.7 2422.3 2453.8 2460.8 2465.4 2368.8 2371.4 2381.7 2401.7 2404.6 2391.0 2419.8 2419.8 2424.0 2424.7 2424.2 2431.6 2441.5 2448.7 2452.3 8229.8 8296.2 8296.3 8307.8 8354.6 5176.2 5210.1 5250.0 5274.8 5285.4 3037.7 3078.6 3105.6 3121.9 3157.1 962.4 972.0 975.9 1013.3 1020.0 11418.1 11425.2 11478.7 11533.8 11538.4 4319.7 4388.2 4439.6 4461.5 4478.9 9090.7 9122.8 9145.7 9154.3 9166.5 5131.4 5147.1 5158.3 5158.9 5164.6 4166.1 4652.8 4703.3 4729.0 4742.3 3614.6 3643.1 3648.8 3699.8 3710.6 1080.6 1091.6 1094.4 1106.3 1106.5 1431.3 1438.1 1450.8 1451.6 1469.9 7657.6 7684.0 7700.7 7704.0 7726.9 524.1 525.4 528.8 531.1 542.6 5940.2 5975.3 5982.9 5995.8 6049.7 9349.6 9489.6 9537.0 9618.3 9618.3 9236.9 9387.2 9427.6 9438.3 9473.0 7795.6 7834.8 7851.4 7888.7 7895.1 7617.6 7631.7 7679.8 7734.1 8000.5 8851.7 8962.7 9085.7 9119.6 9207.4 8942.5 9108.5 9186.8 9314.0 9388.3 6372.6 6790.4 6927.4 6937.8 7078.1 7807.0 7833.0 7846.0 7862.9 7869.7 7123.1 7177.5 7269.4 7314.6 7359.3 7146.9 7168.2 7199.7 7235.8 7269.5 7343.4 7551.7 7554.1 7572.7 7599.8 6883.2 6899.0 6946.2 6954.6 6966.2 6929.3 7057.2 7065.7 7087.9 7100.6 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | [#4] prototype.html Cycles:180 Average:5701.07 Median:6572.97 stddev:1728.95 (26.3%) stddev-sans-first:1686.75 04:18:48 INFO - PROCESS | 11465 | Values: 363.6 363.8 367.4 371.1 375.3 6389.4 6413.9 6460.9 6477.4 6484.3 6348.7 6349.8 6350.4 6370.5 6378.3 4677.4 4746.8 4858.6 4861.5 4875.8 4820.4 4859.8 4865.3 4867.6 4879.0 4793.7 4814.4 4820.9 4825.1 4826.5 4818.6 4828.8 4833.9 4839.0 4839.7 4328.7 4333.0 4333.4 4337.9 4340.6 5889.1 6066.5 6103.8 6120.7 6124.6 5660.0 5685.1 5686.2 5695.7 5705.5 6729.6 6747.5 6766.7 6791.5 6813.1 4684.4 4699.6 4702.8 4704.5 4717.3 7076.5 7126.9 7134.3 7147.7 7163.6 4703.0 4740.8 4785.0 4785.8 4788.9 4844.7 4857.3 4863.4 4917.6 4923.4 5666.6 5674.0 5687.0 5687.9 5689.5 6818.6 6821.1 6837.0 6840.0 6846.3 1696.6 1734.0 1735.9 1736.1 1737.4 1092.5 1126.0 1133.1 1134.3 1153.6 6537.4 6608.6 6615.4 6617.8 6627.8 7041.3 7042.1 7044.2 7098.9 7100.3 6609.3 6619.7 6627.4 6662.7 6685.4 3779.9 3813.9 3822.0 3827.3 3846.1 7102.5 7276.2 7286.6 7341.2 7344.1 7164.7 7185.1 7189.7 7208.6 7223.9 7249.0 7271.2 7274.1 7286.2 7292.6 6878.8 7044.3 7047.6 7059.5 7065.7 6839.0 6854.9 6889.7 6901.3 6916.1 7209.4 7222.1 7256.7 7272.6 7280.7 4816.4 4825.0 4835.8 4849.7 4854.1 6779.9 6958.7 6994.9 7015.8 7154.7 6892.2 6902.4 6913.2 6917.1 6918.4 6865.9 6899.8 6901.7 6905.2 6922.3 6700.9 6741.0 6748.9 6750.4 6791.6 6808.6 6849.6 6962.7 6962.8 6966.2 6743.2 6747.2 6764.3 6782.3 6797.7 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - PROCESS | 11465 | [#5] yui.html Cycles:180 Average:14985.25 Median:4429.13 stddev:17022.03 (384.3%) stddev-sans-first:17036.40 04:18:48 INFO - PROCESS | 11465 | Values: 790.6 802.9 869.8 871.1 881.9 14825.1 15004.6 15065.5 15087.0 15132.8 12612.7 13944.4 14018.5 14020.2 14028.8 923.0 944.7 944.9 951.3 951.9 939.5 946.0 947.4 947.4 947.9 985.9 988.3 990.6 996.2 998.5 972.8 977.9 978.2 984.8 989.4 723.3 736.4 736.4 737.2 740.4 13807.1 13823.7 13860.9 13890.8 13940.9 14319.9 14638.9 14642.8 14668.0 14853.0 11722.5 11726.6 11760.5 11793.5 11839.3 3942.2 3956.0 3974.6 4009.1 4012.2 56047.4 56235.7 56256.7 56617.7 56714.7 10555.4 10789.6 10864.3 10870.1 10888.5 18890.6 18937.2 18971.0 19110.9 19166.8 7663.1 7777.7 7919.0 8013.0 8049.8 4454.5 4568.8 4599.1 4613.7 4759.6 3324.9 3325.4 3348.8 3354.9 3358.0 573.1 584.5 589.8 593.3 593.4 716.5 762.8 768.1 788.9 790.4 9598.2 9607.7 9703.0 9861.5 9971.0 606.4 626.9 642.7 677.7 756.3 4069.2 4179.3 4215.7 4328.2 4403.8 58172.0 59204.7 61405.4 62115.4 62141.1 51793.7 52101.0 53485.0 54101.0 54384.7 45849.5 47396.1 49922.5 50322.7 51109.7 9117.0 9134.7 9153.8 9307.8 9380.4 35801.1 36049.8 37192.3 37205.4 37284.3 43880.8 46016.8 47197.3 47329.8 48096.0 12249.4 12701.7 12717.4 12720.2 12937.1 13669.5 13851.2 13958.4 14151.1 14331.2 12754.9 13006.6 13035.3 13206.8 13267.3 12906.5 13008.0 13009.5 13282.3 13410.6 12813.6 12916.8 13274.0 13417.3 13635.5 10947.6 11240.0 11271.3 11384.1 11546.8 10079.7 10153.8 10399.7 10870.6 11392.3 04:18:48 INFO - PROCESS | 11465 | -------- Summary: end -------- 04:18:48 INFO - PROCESS | 11465 | 04:18:48 INFO - TEST-INFO | 11465: exit 0 04:18:48 INFO - TEST-OK | dromaeo_css | took 1109750ms 04:18:48 INFO - TEST-START | kraken 04:18:48 INFO - operating with platform_type : linux_ 04:18:48 INFO - Initialising browser for kraken test... 04:18:48 INFO - TEST-INFO | started process 11709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCLR36/profile http://localhost:47115/getInfo.html) 04:18:52 INFO - PROCESS | 11709 | 04:18:52 INFO - PROCESS | 11709 | (process:11782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:18:53 INFO - PROCESS | 11709 | __metrics Screen width/height:1600/1200 04:18:53 INFO - PROCESS | 11709 | colorDepth:24 04:18:53 INFO - PROCESS | 11709 | Browser inner width/height: 1024/697 04:18:53 INFO - PROCESS | 11709 | __metrics 04:18:53 ERROR - PROCESS | 11709 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:18:54 INFO - TEST-INFO | 11709: exit 0 04:18:54 INFO - Browser initialized. 04:18:54 INFO - Running cycle 1/1 for kraken test... 04:18:54 INFO - TEST-INFO | started process 11833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCLR36/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:56 INFO - PROCESS | 11833 | 04:18:56 INFO - PROCESS | 11833 | (process:11904): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:06 INFO - PROCESS | 11833 | RSS: Main: 151384064 04:19:06 INFO - PROCESS | 11833 | 04:19:09 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47115/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:09 INFO - PROCESS | 11833 | RSS: Main: 155394048 04:19:09 INFO - PROCESS | 11833 | 04:19:12 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47115/tests/kraken/driver.html?testName=audio-dft) 04:19:13 INFO - PROCESS | 11833 | RSS: Main: 155418624 04:19:13 INFO - PROCESS | 11833 | 04:19:15 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47115/tests/kraken/driver.html?testName=audio-fft) 04:19:16 INFO - PROCESS | 11833 | RSS: Main: 155947008 04:19:16 INFO - PROCESS | 11833 | 04:19:18 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47115/tests/kraken/driver.html?testName=audio-oscillator) 04:19:19 INFO - PROCESS | 11833 | RSS: Main: 155762688 04:19:19 INFO - PROCESS | 11833 | 04:19:21 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:21 INFO - PROCESS | 11833 | RSS: Main: 155754496 04:19:21 INFO - PROCESS | 11833 | 04:19:24 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47115/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:25 INFO - PROCESS | 11833 | RSS: Main: 156397568 04:19:25 INFO - PROCESS | 11833 | 04:19:28 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47115/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:29 INFO - PROCESS | 11833 | RSS: Main: 156594176 04:19:29 INFO - PROCESS | 11833 | 04:19:32 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47115/tests/kraken/driver.html?testName=json-parse-financial) 04:19:32 INFO - PROCESS | 11833 | RSS: Main: 156831744 04:19:32 INFO - PROCESS | 11833 | 04:19:34 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:35 INFO - PROCESS | 11833 | RSS: Main: 157437952 04:19:35 INFO - PROCESS | 11833 | 04:19:36 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:37 INFO - PROCESS | 11833 | RSS: Main: 156700672 04:19:37 INFO - PROCESS | 11833 | 04:19:39 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:40 INFO - PROCESS | 11833 | RSS: Main: 156475392 04:19:40 INFO - PROCESS | 11833 | 04:19:42 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:43 INFO - PROCESS | 11833 | RSS: Main: 156921856 04:19:43 INFO - PROCESS | 11833 | 04:19:45 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:46 INFO - PROCESS | 11833 | RSS: Main: 158121984 04:19:46 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:47115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47115/tests/kraken/driver.html?testName=ai-astar) 04:19:48 INFO - PROCESS | 11833 | RSS: Main: 159412224 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | __start_tp_report 04:19:48 INFO - PROCESS | 11833 | _x_x_mozilla_page_load 04:19:48 INFO - PROCESS | 11833 | _x_x_mozilla_page_load_details 04:19:48 INFO - PROCESS | 11833 | |i|pagename|runs| 04:19:48 INFO - PROCESS | 11833 | |0;ai-astar;112;104;110;110;110;120;109;110;109;110 04:19:48 INFO - PROCESS | 11833 | |1;audio-beat-detection;154;127;151;162;129;157;155;129;168;127 04:19:48 INFO - PROCESS | 11833 | |2;audio-dft;163;163;163;162;164;163;164;165;166;162 04:19:48 INFO - PROCESS | 11833 | |3;audio-fft;76;76;75;163;76;76;77;73;166;77 04:19:48 INFO - PROCESS | 11833 | |4;audio-oscillator;92;97;146;92;92;94;139;92;93;139 04:19:48 INFO - PROCESS | 11833 | |5;imaging-gaussian-blur;117;118;121;118;117;116;117;117;117;117 04:19:48 INFO - PROCESS | 11833 | |6;imaging-darkroom;147;147;147;147;148;146;147;147;147;147 04:19:48 INFO - PROCESS | 11833 | |7;imaging-desaturate;96;97;97;96;96;98;96;98;96;97 04:19:48 INFO - PROCESS | 11833 | |8;json-parse-financial;56;63;55;56;56;56;58;63;55;54 04:19:48 INFO - PROCESS | 11833 | |9;json-stringify-tinderbox;65;66;65;70;67;68;65;65;65;65 04:19:48 INFO - PROCESS | 11833 | |10;stanford-crypto-aes;86;78;81;81;87;81;87;80;85;80 04:19:48 INFO - PROCESS | 11833 | |11;stanford-crypto-ccm;113;114;112;115;112;117;122;112;115;118 04:19:48 INFO - PROCESS | 11833 | |12;stanford-crypto-pbkdf2;132;144;145;142;144;154;155;141;145;133 04:19:48 INFO - PROCESS | 11833 | |13;stanford-crypto-sha256-iterative;76;68;72;67;68;66;68;65;71;65 04:19:48 INFO - PROCESS | 11833 | __end_tp_report 04:19:48 INFO - PROCESS | 11833 | __start_cc_report 04:19:48 INFO - PROCESS | 11833 | _x_x_mozilla_cycle_collect,857 04:19:48 INFO - PROCESS | 11833 | __end_cc_report 04:19:48 INFO - PROCESS | 11833 | __startTimestamp1461755988273__endTimestamp 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | ------- Summary: start ------- 04:19:48 INFO - PROCESS | 11833 | Number of tests: 14 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:3.95 (3.6%) stddev-sans-first:4.15 04:19:48 INFO - PROCESS | 11833 | Values: 112.0 104.0 110.0 110.0 110.0 120.0 109.0 110.0 109.0 110.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.50 stddev:16.09 (10.4%) stddev-sans-first:16.80 04:19:48 INFO - PROCESS | 11833 | Values: 154.0 127.0 151.0 162.0 129.0 157.0 155.0 129.0 168.0 127.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 04:19:48 INFO - PROCESS | 11833 | Values: 163.0 163.0 163.0 162.0 164.0 163.0 164.0 165.0 166.0 162.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:37.44 (49.3%) stddev-sans-first:39.18 04:19:48 INFO - PROCESS | 11833 | Values: 76.0 76.0 75.0 163.0 76.0 76.0 77.0 73.0 166.0 77.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:92.00 stddev:23.41 (25.4%) stddev-sans-first:24.14 04:19:48 INFO - PROCESS | 11833 | Values: 92.0 97.0 146.0 92.0 92.0 94.0 139.0 92.0 93.0 139.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 04:19:48 INFO - PROCESS | 11833 | Values: 117.0 118.0 121.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 04:19:48 INFO - PROCESS | 11833 | Values: 147.0 147.0 147.0 147.0 148.0 146.0 147.0 147.0 147.0 147.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 04:19:48 INFO - PROCESS | 11833 | Values: 96.0 97.0 97.0 96.0 96.0 98.0 96.0 98.0 96.0 97.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.00 stddev:3.22 (5.8%) stddev-sans-first:3.39 04:19:48 INFO - PROCESS | 11833 | Values: 56.0 63.0 55.0 56.0 56.0 56.0 58.0 63.0 55.0 54.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.50 stddev:1.73 (2.6%) stddev-sans-first:1.79 04:19:48 INFO - PROCESS | 11833 | Values: 65.0 66.0 65.0 70.0 67.0 68.0 65.0 65.0 65.0 65.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:3.31 (4.0%) stddev-sans-first:3.27 04:19:48 INFO - PROCESS | 11833 | Values: 86.0 78.0 81.0 81.0 87.0 81.0 87.0 80.0 85.0 80.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.00 stddev:3.23 (2.8%) stddev-sans-first:3.35 04:19:48 INFO - PROCESS | 11833 | Values: 113.0 114.0 112.0 115.0 112.0 117.0 122.0 112.0 115.0 118.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:144.50 stddev:7.44 (5.2%) stddev-sans-first:6.63 04:19:48 INFO - PROCESS | 11833 | Values: 132.0 144.0 145.0 142.0 144.0 154.0 155.0 141.0 145.0 133.0 04:19:48 INFO - PROCESS | 11833 | 04:19:48 INFO - PROCESS | 11833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:3.47 (5.1%) stddev-sans-first:2.44 04:19:48 INFO - PROCESS | 11833 | Values: 76.0 68.0 72.0 67.0 68.0 66.0 68.0 65.0 71.0 65.0 04:19:48 INFO - PROCESS | 11833 | -------- Summary: end -------- 04:19:48 INFO - PROCESS | 11833 | 04:19:49 INFO - TEST-INFO | 11833: exit 0 04:19:49 INFO - TEST-OK | kraken | took 60335ms 04:19:49 INFO - SUITE-END | took 1170s 04:19:49 INFO - Completed test suite (00:19:30) 04:19:49 INFO - javascript benchmark 04:19:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.037479131052, 3427.468742344937, 3432.9485057724123, 3473.739469539785, 3474.496198051281, 5575.358833734122, 5577.135543990683, 5602.411746766582, 5602.831915042545, 5629.127485239789, 5614.410486898878, 5635.830925072254, 5641.464060914206, 5645.689487078209, 5663.830085097454, 5121.462246464114, 5175.482451754813, 5182.948170518284, 5207.6354655174155, 5235.319408476893, 5020.723860187688, 5141.562967147797, 5241.030409374278, 5249.1338929076655, 5250.133727934886, 5127.717975511346, 5171.689698618095, 5178.974105129469, 5262.8684282892855, 5282.286891269668, 5258.500442457979, 5275.0768615492325, 5282.3925248596515, 5282.841514754564, 5313.1764576490705, 4941.579965702919, 5013.774380152902, 5103.362079740033, 5142.537171654531, 5226.3989641191365, 5386.380566234894, 5416.864578385572, 5424.620276580641, 5439.238506609078, 5444.074507333763, 5923.674197919113, 5979.730912108966, 5998.4601385875485, 6010.098485227207, 6029.547783916224, 6037.54718396122, 6073.180120683695, 6113.0, 6124.816255512342, 6127.142200091991, 5646.548276137899, 5664.980303545361, 5667.404922483162, 5672.0, 5679.460451257165, 5939.732712027969, 6205.565610407228, 6212.720427580679, 6215.285242197115, 6233.407826256498, 5971.790987315423, 5984.401559844068, 5988.610740301953, 5990.520758339322, 6019.247594050744, 6073.39266073398, 6076.149339092531, 6079.452849243501, 6080.635161890301, 6092.268927728701, 5920.023196172583, 6002.219711437485, 6037.969810151009, 6038.30559485656, 6080.179175811298, 6042.12389203563, 6077.1491991121275, 6099.878002439927, 6109.938900611026, 6115.694215289218, 4575.656825738083, 4585.931211031837, 4623.722576645345, 4626.167289887852, 4638.350630911675, 4023.5372932112596, 4110.157417729359, 4142.0, 4149.688773342012, 4192.937105943413, 5660.716964151776, 5752.424757524214, 5759.136129580513, 5765.365809760923, 5824.388439213906, 6086.786962456293, 6099.390060993954, 6099.9085013724825, 6111.816645500642, 6111.816645500642, 5574.275344205308, 5757.107648314518, 5765.221695071195, 5787.942120578825, 5826.475617194473, 5192.636515443958, 5204.0372531081875, 5207.479252074762, 5207.947920520822, 5218.973905130526, 6216.316205217422, 6219.098230756515, 6219.844503887349, 6222.968885155636, 6224.06639004153, 5853.882922341444, 6038.788642397495, 6094.786682466092, 6123.785667501795, 6128.662923539248, 6194.34959329282, 6231.345708700521, 6237.126802247598, 6239.594426362272, 6241.407066328691, 5908.793192238423, 5976.103584462366, 5977.163197152315, 5985.281766188085, 6007.8197654070445, 5963.0459126539545, 6088.0, 6091.177691011657, 6146.0, 6157.6613286269685, 5960.046392577166, 5996.400359963969, 6008.339082700987, 6009.789657361971, 6030.849228769316, 5795.391483894299, 5957.553183511341, 5967.731452084753, 5992.490638295793, 5993.490553303018, 5805.332386775575, 5847.94152058491, 5849.94150058511, 5863.149843272787, 5907.645541267538, 5841.474267315962, 5950.583459157818, 5952.464278214981, 5965.105234214902, 5966.463018328372, 5666.206731057573, 5840.591158618856, 5854.092615644582, 5864.560157988082, 5867.061270196748], "unit": "score", "name": "dojo.html", "value": 5588.825430839459}, {"lowerIsBetter": false, "replicates": [514.3955851874044, 564.2889958652098, 578.0923949399444, 605.2313561776541, 615.3292910727306, 30686.84656576717, 37498.62501374986, 37562.81218593903, 37730.056748581264, 38333.80833095834, 41830.0, 42071.579284207146, 42423.787881060554, 42503.78748106255, 42509.7874510627, 8795.0, 8986.281097512216, 8999.145081217306, 8999.550022498881, 9016.954915225415, 8851.60167792451, 8975.865362019542, 8979.595918183664, 9011.143941325596, 9018.368714189977, 8944.239739622108, 8959.328050396214, 8996.235319997808, 9008.504532250723, 9036.548172591343, 8886.688965886195, 8994.910050899472, 9005.639774409015, 9176.587053582605, 9235.861462078074, 9003.684871029547, 9155.542222888895, 9156.771080722969, 9186.908130918739, 9193.770155746093, 41918.0, 42347.0, 42422.57577424217, 42474.78762606198, 42593.57406425927, 3515.3320869035056, 3541.628129046439, 3684.9815750921075, 3737.3085979093953, 3884.3784994401044, 31764.682353176635, 32249.83875080633, 32559.83720081408, 33188.3362332752, 33371.33257334864, 4052.250333688248, 4148.460700108997, 4200.978995105035, 4240.575942405735, 4261.062566235423, 281761.0, 283355.0, 284141.0, 284693.5765321181, 285318.0, 45586.54413455889, 59978.70010650006, 61092.0, 61098.69450652718, 61257.38742612517, 44314.113717725464, 44914.77542612266, 45083.77458112688, 45137.54862451399, 45315.09369812586, 15894.364225431085, 15987.840121598867, 16120.355185792672, 16161.191940402932, 16224.945378550356, 12900.612981610566, 12932.41804118817, 12971.286579238233, 12996.610101696964, 13072.411741471657, 15526.068435893656, 15544.145072021147, 15562.533124006299, 15659.530214093367, 15739.213039347987, 5957.314908785458, 6034.818955431344, 6052.213212282463, 6100.176476175749, 6177.505799536027, 1069.2301542889263, 1069.588208539718, 1094.2395035450445, 1136.6760473265244, 1195.838561794164, 32996.67003329936, 34487.310253794785, 34725.47911781325, 35069.47395789065, 35341.0, 1138.5844166879194, 1157.8321143434323, 1157.8842115788523, 1220.1215125109907, 1244.6079484962208, 15516.0, 15551.455699050479, 15624.92187539055, 15902.125383104041, 16025.67948641044, 408359.0, 492520.0, 494533.0, 516549.0, 516828.0, 55606.0, 56620.0, 56658.0, 56739.0, 56741.71629141828, 1434.583970648521, 1452.0996981871308, 1452.6513636727109, 1459.4818839312104, 1491.164947629331, 29384.26539336534, 30744.538831917092, 30893.69106308998, 31330.843345783127, 31798.841005794824, 48185.0, 48755.26867096926, 48957.2656410147, 49218.26172607342, 49348.2597761041, 316163.0, 324557.0, 326179.0, 327296.0, 327752.0, 34040.31919361649, 34214.315713685086, 34424.31151377009, 34510.30979380449, 34645.13387165341, 44843.77578112089, 45491.31763023491, 45664.771676141405, 45975.54024459713, 46114.769426152656, 36866.0, 38082.61917380901, 38427.42358864675, 38973.220535589695, 39136.412953806284, 37062.0, 38880.416793748685, 39079.804600976815, 39782.0, 39850.0, 38216.61783382131, 38689.6131038686, 38928.41607375835, 39190.608093918694, 39304.41043384409, 33585.034925457956, 34047.0, 34204.31591368109, 34409.483857742656, 34635.4804677925, 26387.0, 26434.0, 26449.0, 26700.465990679688, 26727.331816704736], "unit": "score", "name": "ext.html", "value": 19296.021455366623}, {"lowerIsBetter": false, "replicates": [374.18054460731, 389.4469852809012, 395.30229145558116, 395.5806844744571, 403.1976367029612, 16800.579985500353, 18865.62268754624, 18909.810901890978, 19084.618307633857, 19243.711344329848, 17386.3914762983, 17478.3008679653, 17668.469945901612, 17748.733768993476, 17810.376636817713, 5117.181250999841, 5184.403793563751, 5228.320318358627, 5357.785688572472, 5382.461753824606, 5209.1404918188455, 5259.474052594748, 5269.262303277545, 5269.394019687727, 5290.074237008527, 5140.228965655144, 5246.921296180561, 5278.102722537178, 5280.366356037281, 5301.8939621207555, 5568.387477377485, 5630.859228519279, 5640.802571909984, 5668.319801623811, 5683.914741278884, 5033.974830125862, 5053.140966035783, 5056.924146137811, 5059.16523773577, 5083.923741143886, 13860.861391386057, 18916.243350265973, 21540.461488462755, 22239.888800556055, 22415.887920560293, 2311.4914718761847, 2747.955776804801, 3005.3989202159655, 3031.5149576067724, 3032.150997720642, 10275.743106422324, 11065.889341106566, 11537.307761534335, 12707.745845083138, 14113.87089032875, 1817.3639226270832, 1911.7036859286832, 1928.4503916383762, 1956.4424139120283, 1962.0876292523901, 64392.35607643911, 68177.65911170462, 69475.0, 71953.6402317985, 73694.63152684203, 9501.287403444769, 9657.275704322205, 9661.565229564687, 9797.853032204523, 9911.10800028001, 13107.803382949263, 13533.0, 13552.186868787905, 13717.108387954751, 14466.927665361605, 7626.580538070349, 7694.538327700356, 7738.0, 7745.10931242903, 7895.328897043701, 7684.884726729104, 7719.498232614862, 7725.5364678119495, 7790.415718821111, 7818.14000459949, 4220.303649897794, 4304.225239456865, 4306.332518459643, 4309.892252693708, 4313.0726893718, 1797.5056859363779, 1798.5773343264323, 1825.799162092169, 1848.7966323704381, 1920.4718702356683, 951.8429459139164, 963.9518024098767, 1019.6635110413694, 1049.3284298049255, 1075.1828610256105, 16647.250873710713, 17189.57026074358, 17396.913015435093, 17667.29330826778, 17713.557161070818, 975.1467465967279, 1008.6167256442504, 1042.551702767802, 1052.9105026072716, 1061.1192710050639, 6308.243010838729, 6670.399664030164, 6674.399304062657, 9309.674161404453, 9410.529473526296, 257826.0, 366907.0, 490170.0, 491256.0, 495909.0, 82140.0, 82673.0, 85816.0, 86795.0, 87450.56274718713, 499.6202885806813, 519.2833889232835, 519.8258583374536, 521.817363922624, 522.1827839431354, 9480.336376453582, 10156.644517441853, 10594.4702764863, 10777.838332424863, 11093.833592496281, 35527.64472355243, 36432.27135457329, 36584.634153658124, 36756.632433675324, 37421.43867842039, 47219.0, 51026.0, 52272.47727522676, 52514.212286816495, 52781.7360913193, 8641.351898607756, 8647.14225285546, 8711.520866352412, 8727.345449091217, 8804.515751633722, 9865.06281903218, 13026.869731302566, 13171.47314107425, 13229.206247625174, 13463.528776492776, 11142.498587563417, 11175.161862860155, 11356.375399353115, 11615.477303521193, 11710.238834475731, 11280.492377842853, 11376.829347559627, 11615.593454229062, 11654.941725291319, 11921.940390297994, 11052.834207487054, 11367.829482557934, 11787.174897757075, 11919.284842909454, 12045.698857528632, 8310.252077313071, 8397.538135402612, 8738.475691458278, 8782.253508451598, 8814.603342849716, 10957.287776294515, 11047.834282485608, 11270.774584508099, 11303.039241664223, 11439.714007149554], "unit": "score", "name": "jquery.html", "value": 8456.921290695016}, {"lowerIsBetter": false, "replicates": [1564.0693787196617, 1570.8115026196858, 1756.2272600055974, 1868.6169335286268, 1896.6680830854605, 7309.159446663635, 8007.759767206979, 8101.270885620293, 8258.050324212718, 8338.749837504876, 7966.5618390988475, 8061.516309021463, 8180.181981801832, 8201.220884016024, 8207.097219305871, 2389.044382247102, 2407.843490173142, 2419.6249581314923, 2421.673074134987, 2424.2848359733835, 2412.7345991940874, 2422.2975337152207, 2453.7791598756107, 2460.803135749136, 2465.4329504214043, 2368.798652114572, 2371.3952941999764, 2381.7499162587937, 2401.7117945846435, 2404.603240465321, 2390.9760902390926, 2419.7701218384314, 2419.830611857171, 2423.9636405453934, 2424.660547523348, 2424.248482970285, 2431.647411125377, 2441.4506735984437, 2448.6939132608422, 2452.301094188148, 8229.753107406728, 8296.170382961716, 8296.336293096538, 8307.750767476924, 8354.624041918129, 5176.249443830661, 5210.062188806013, 5249.973750131263, 5274.815381461669, 5285.4450282720145, 3037.681043490446, 3078.6459557150993, 3105.627324721048, 3121.890733824328, 3157.068664743906, 962.43216502264, 971.9757006074834, 975.8874882633803, 1013.3413281367096, 1020.0258752890971, 11418.143639227092, 11425.200235983484, 11478.655640330804, 11533.826992595117, 11538.365389903553, 4319.6976211665515, 4388.232059389594, 4439.578240067189, 4461.5092339842595, 4478.865634030984, 9090.727278181665, 9122.81754364909, 9145.725628231165, 9154.31342649304, 9166.450012999241, 5131.384233891957, 5147.0735267651435, 5158.303629010111, 5158.948410515847, 5164.612654050961, 4166.0834616384345, 4652.767361631905, 4703.318018887242, 4729.0, 4742.312364707098, 3614.584322802859, 3643.0710168906758, 3648.835802388899, 3699.7595156314756, 3710.5547334320054, 1080.556971641639, 1091.6343025086526, 1094.3816743539874, 1106.286445242814, 1106.5020740666732, 1431.334429490292, 1438.1155589312707, 1450.782382642612, 1451.6298343922444, 1469.8677119059337, 7657.57883316423, 7684.039495063117, 7700.653470593837, 7704.036995375578, 7726.922730772732, 524.1011664994553, 525.4167873660234, 528.8228443471403, 531.1342511705894, 542.6174546944395, 5940.227770389822, 5975.25309336333, 5982.880342393128, 5995.790147344822, 6049.667268300285, 9349.626014959325, 9489.572969216402, 9537.046295370546, 9618.278629102706, 9618.326717129734, 9236.937752158454, 9387.202087822476, 9427.57575909072, 9438.292128090283, 9473.0, 7795.610219489003, 7834.764957051298, 7851.371890248766, 7888.723894663659, 7895.052593688794, 7617.581033043014, 7631.69473221065, 7679.769606911802, 7734.071911370672, 8000.51996880189, 8851.734447966572, 8962.73111806647, 9085.727428177166, 9119.635214591342, 9207.355485115977, 8942.50816205115, 9108.499032553273, 9186.816263674822, 9313.953430232805, 9388.342816003087, 6372.617642941438, 6790.354916282945, 6927.445804335742, 6937.7571784987285, 7078.115235595551, 7807.024121984752, 7833.0, 7845.960770196112, 7862.921370786219, 7869.724559640614, 7123.145222573325, 7177.461690373348, 7269.41844652416, 7314.561126332437, 7359.337659610661, 7146.9285307146265, 7168.17565979919, 7199.71201151948, 7235.782926512213, 7269.491135620456, 7343.4492413068165, 7551.697932082875, 7554.131274903457, 7572.734954276574, 7599.810004749926, 6883.242843287134, 6899.0, 6946.235914049349, 6954.617496037767, 6966.1988871280455, 6929.272426395156, 7057.188423331382, 7065.717371305091, 7087.893681594677, 7100.609466479394], "unit": "score", "name": "mootools.html", "value": 4628.253255059578}, {"lowerIsBetter": false, "replicates": [363.5982239625214, 363.8399104394068, 367.35162438296413, 371.0871256708497, 375.2869547859069, 6389.361063893608, 6413.8717225655455, 6460.935390646092, 6477.352264773526, 6484.319146489622, 6348.6825658717, 6349.8412539686415, 6350.364963503659, 6370.458511026557, 6378.330275321094, 4677.36855524505, 4746.76266186691, 4858.587020103296, 4861.513848615145, 4875.804967801284, 4820.39745031871, 4859.805607775685, 4865.343178670887, 4867.634927380443, 4879.048585525824, 4793.7363445010515, 4814.398200224972, 4820.855374338758, 4825.131476334259, 4826.5414785595485, 4818.566329030386, 4828.758562071883, 4833.854984350475, 4839.0, 4839.661223714342, 4328.696991210617, 4332.9566704332865, 4333.43665323506, 4337.850469625551, 4340.565943405666, 5889.1460738193155, 6066.48434883031, 6103.786367477162, 6120.663363515005, 6124.601900876429, 5660.037793575102, 5685.090385538294, 5686.2039314496005, 5695.658260504341, 5705.515031222351, 6729.596224226562, 6747.5276730628875, 6766.661666916634, 6791.524593278473, 6813.148356455443, 4684.36761037259, 4699.647526435531, 4702.764861756933, 4704.529547045302, 4717.292406139107, 7076.469264805109, 7126.857462850714, 7134.2509036551455, 7147.74982875602, 7163.570185788869, 4702.9764851176205, 4740.762961851894, 4785.0, 4785.808567657325, 4788.880277993008, 4844.660873738875, 4857.295692124693, 4863.440704319049, 4917.582005529499, 4923.384576927884, 5666.631668941588, 5673.971630141823, 5686.9715651421475, 5687.914681279784, 5689.487946084872, 6818.624975626289, 6821.113255276782, 6836.965815170992, 6840.042394064835, 6846.349596788297, 1696.584336837458, 1734.0289437914807, 1735.8803571696185, 1736.140610397861, 1737.4353335166122, 1092.5029111754134, 1125.9605913792977, 1133.0595605647293, 1134.325076579434, 1153.6308381318065, 6537.378948999933, 6608.570442921195, 6615.37153970372, 6617.8014659560295, 6627.768028118992, 7041.260667629927, 7042.119735033121, 7044.189918159374, 7098.858022839618, 7100.325469080429, 6609.306022867626, 6619.669016549154, 6627.403533681895, 6662.7334906604165, 6685.39831415175, 3779.9244015120094, 3813.866514671973, 3822.0444888777806, 3827.2536855312946, 3846.0961674006585, 7102.538335008208, 7276.1622967042895, 7286.599237042014, 7341.192468828424, 7344.081989751281, 7164.713411463483, 7185.101862267216, 7189.676464559107, 7208.56748595086, 7223.855522889513, 7248.963755181296, 7271.236520165412, 7274.127104747464, 7286.162091359562, 7292.562446253241, 6878.793636190922, 7044.330788575077, 7047.647617619201, 7059.5058345915295, 7065.6820443081215, 6839.0, 6854.862902742017, 6889.724411023503, 6901.275366086488, 6916.100906882073, 7209.387202087882, 7222.0611320528, 7256.7097316106765, 7272.563646181246, 7280.672369743268, 4816.397950256218, 4824.95175048245, 4835.782389792538, 4849.733264670477, 4854.077725232195, 6779.8983015253825, 6958.686859091455, 6994.860102798018, 7015.789526314014, 7154.713811447484, 6892.207396149507, 6902.378785909293, 6913.204981426999, 6917.100776898971, 6918.411934985583, 6865.862682746218, 6899.793006209822, 6901.689423976033, 6905.240423553305, 6922.342377474132, 6700.932990670226, 6741.02255173007, 6748.898766518408, 6750.426213771884, 6791.558548694319, 6808.62552559614, 6849.616245602918, 6962.721491140298, 6962.756303529352, 6966.1988871280455, 6743.1908171019795, 6747.224069232101, 6764.289749576224, 6782.287859774653, 6797.694103765243], "unit": "score", "name": "prototype.html", "value": 5139.448444863946}, {"lowerIsBetter": false, "replicates": [790.6481615681021, 802.9156938521455, 869.7825543614097, 871.0940621753376, 881.88094607228, 14825.110493370405, 15004.624884377896, 15065.472708455207, 15087.0, 15132.848671513282, 12612.747745045117, 13944.372503237353, 14018.509352172676, 14020.22888741119, 14028.78956815646, 922.9769255768592, 944.7496413450407, 944.9291303152256, 951.2580187453763, 951.9333646644737, 939.539625583466, 946.0350442548631, 947.3557980573207, 947.4173383369247, 947.8815148106487, 985.9063388978036, 988.2884323287258, 990.6483198464549, 996.2030375699447, 998.4907697074508, 972.7762614598646, 977.941323520591, 978.2467500024941, 984.758734110144, 989.3519744567284, 723.2911746488418, 736.4145504324075, 736.4292673178276, 737.1890919988024, 740.4446665001249, 13807.102538334975, 13823.654408639764, 13860.861391386057, 13890.791638125436, 13940.86059139416, 14319.928400358036, 14638.853611463855, 14642.780358294634, 14668.0, 14853.0, 11722.531098756039, 11726.648200553997, 11760.529578816837, 11793.528258869635, 11839.28964262147, 3942.1524372259814, 3955.960440395617, 3974.602539746031, 4009.0779120802085, 4012.1775036117524, 56047.43952560463, 56235.71882140604, 56256.718716406154, 56617.71691141518, 56714.71642641802, 10555.366677999345, 10789.62236321725, 10864.293820901616, 10870.130389568816, 10888.455577221108, 18890.62218755617, 18937.242510299435, 18971.0, 19110.90444547796, 19166.80833191678, 7663.080430348283, 7777.72777952769, 7918.960405197937, 8013.038435387674, 8049.839003219903, 4454.4654641442585, 4568.840090596879, 4599.05719327537, 4613.677042606985, 4759.643026773006, 3324.900252992414, 3325.4061831771255, 3348.7823291485975, 3354.8825791097192, 3358.026172410023, 573.1202604002918, 584.5294537897033, 589.7847285740673, 593.3354642800092, 593.403629352498, 716.5270921191989, 762.7521055656933, 768.0667988394127, 788.9368850491946, 790.3795520516367, 9598.184154346958, 9607.711768646952, 9702.951485242529, 9861.506924653739, 9971.0, 606.3693758491208, 626.8687903919949, 642.7172044300493, 677.7187467201155, 756.3193126186476, 4069.206504731608, 4179.310413781692, 4215.662746980234, 4328.177646247203, 4403.8018289176425, 58172.0, 59204.70397647984, 61405.38594613997, 62115.37884621186, 62141.06788398178, 51793.7410312946, 52101.0, 53485.0, 54101.0, 54384.728076359366, 45849.54150458453, 47396.05207895823, 49922.50077499251, 50322.74838625784, 51109.744451277504, 9116.954415227881, 9134.725958221265, 9153.814255809424, 9307.813843723223, 9380.437173769596, 35801.1049723759, 36049.81975090108, 37192.256154877294, 37205.44191837179, 37284.25431491301, 43880.78059609809, 46016.76991615154, 47197.29204061873, 47329.76335118302, 48096.03807923892, 12249.448774804978, 12701.682457938625, 12717.364131793189, 12720.236785792882, 12937.094403391673, 13669.521566745116, 13851.16892986424, 13958.371873265525, 14151.080179788692, 14331.211783352015, 12754.936225318814, 13006.609801705965, 13035.283059431822, 13206.80189797173, 13267.270300133585, 12906.483740650268, 13008.0, 13009.544665936646, 13282.269475178959, 13410.597682069554, 12813.615591532269, 12916.806247906477, 13274.0, 13417.262050587311, 13635.454581816617, 10947.56209751601, 11240.0, 11271.323720576791, 11384.14618903569, 11546.76906461883, 10079.748006299902, 10153.796924061626, 10399.740006499595, 10870.61952831647, 11392.316461012366], "unit": "score", "name": "yui.html", "value": 6961.2274677824125}], "name": "dromaeo_css", "value": 7297.529820683005}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 110.0, 110.0, 110.0, 120.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 151.0, 162.0, 129.0, 157.0, 155.0, 129.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 164.0, 163.0, 164.0, 165.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 163.0, 76.0, 76.0, 77.0, 73.0, 166.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 146.0, 92.0, 92.0, 94.0, 139.0, 92.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 121.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 98.0, 96.0, 98.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [56.0, 63.0, 55.0, 56.0, 56.0, 56.0, 58.0, 63.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 70.0, 67.0, 68.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [86.0, 78.0, 81.0, 81.0, 87.0, 81.0, 87.0, 80.0, 85.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [113.0, 114.0, 112.0, 115.0, 112.0, 117.0, 122.0, 112.0, 115.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [132.0, 144.0, 145.0, 142.0, 144.0, 154.0, 155.0, 141.0, 145.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [76.0, 68.0, 72.0, 67.0, 68.0, 66.0, 68.0, 65.0, 71.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1515.0999999999997}]} 04:19:49 INFO - Return code: 0 04:19:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:19:49 ERROR - # TBPL SUCCESS # 04:19:49 INFO - Running post-action listener: _resource_record_post_action 04:19:49 INFO - Running post-run listener: _resource_record_post_run 04:19:50 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499195904; Read time: 12; Write time: 659620 04:19:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244916224; Read time: 0; Write time: 427668 04:19:50 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253681664; Read time: 12; Write time: 231952 04:19:50 INFO - Running post-run listener: _upload_blobber_files 04:19:50 INFO - Blob upload gear active. 04:19:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:50 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:50 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:50 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:51 INFO - (blobuploader) - INFO - Done attempting. 04:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:52 INFO - (blobuploader) - INFO - Done attempting. 04:19:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:52 INFO - Return code: 0 04:19:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d9b7b294ee3b95c35cfd724a0bb26098746728026db6affe21d4d47815b6ae8b558885a1480bf62f59853d1e064e52610b0e552b3e2e653e1c28ff266a1b702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58cf7e9e50e11b26d11373c9fe8d4c9a0b2c4c5577d94d2041e4cbadda9312e8365025dfd038e9770383beb63e31e44082e9460da242d46c8542f4fec2bb3a52"} 04:19:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:52 INFO - Contents: 04:19:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d9b7b294ee3b95c35cfd724a0bb26098746728026db6affe21d4d47815b6ae8b558885a1480bf62f59853d1e064e52610b0e552b3e2e653e1c28ff266a1b702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58cf7e9e50e11b26d11373c9fe8d4c9a0b2c4c5577d94d2041e4cbadda9312e8365025dfd038e9770383beb63e31e44082e9460da242d46c8542f4fec2bb3a52"} 04:19:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:52 INFO - Copying logs to upload dir... 04:19:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.204070 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-04-27 04:19:52.243427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:52.247503) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283 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/8d9b7b294ee3b95c35cfd724a0bb26098746728026db6affe21d4d47815b6ae8b558885a1480bf62f59853d1e064e52610b0e552b3e2e653e1c28ff266a1b702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58cf7e9e50e11b26d11373c9fe8d4c9a0b2c4c5577d94d2041e4cbadda9312e8365025dfd038e9770383beb63e31e44082e9460da242d46c8542f4fec2bb3a52"} 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.011174 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/8d9b7b294ee3b95c35cfd724a0bb26098746728026db6affe21d4d47815b6ae8b558885a1480bf62f59853d1e064e52610b0e552b3e2e653e1c28ff266a1b702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58cf7e9e50e11b26d11373c9fe8d4c9a0b2c4c5577d94d2041e4cbadda9312e8365025dfd038e9770383beb63e31e44082e9460da242d46c8542f4fec2bb3a52"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:52.272107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:52.272418) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461754766.873244-1468943283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:19:52.355059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:19:52.355399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:19:52.355725) ========= ========= Total master_lag: 0.18 =========