builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1462554392.91 results: success (0) buildid: 20160506073123 builduid: 0d73d835f3aa40f6a190e118b5f6a08a revision: 19a1743ceb2e035e571012e88d25275ce627b925 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:32.913243) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:32.913752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:32.914049) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:33.399588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:33.399881) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 10:06:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.4M=0s 2016-05-06 10:06:33 (36.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144347 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:33.588205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:33.588559) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.055024 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:33.655369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:33.655888) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19a1743ceb2e035e571012e88d25275ce627b925 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 19a1743ceb2e035e571012e88d25275ce627b925 --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=82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 10:06:33,751 truncating revision to first 12 chars 2016-05-06 10:06:33,751 Setting DEBUG logging. 2016-05-06 10:06:33,751 attempt 1/10 2016-05-06 10:06:33,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19a1743ceb2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 10:06:34,021 unpacking tar archive at: mozilla-central-19a1743ceb2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:34.260417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:34.260852) ========= script_repo_revision: 19a1743ceb2e035e571012e88d25275ce627b925 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:34.261324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:34.261640) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 10:06:34.270351) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-06 10:06:34.270667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:06:34 INFO - MultiFileLogger online at 20160506 10:06:34 in /builds/slave/test 10:06:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:06:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:06:34 INFO - {'append_to_log': False, 10:06:34 INFO - 'base_work_dir': '/builds/slave/test', 10:06:34 INFO - 'blob_upload_branch': 'Firefox', 10:06:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:06:34 INFO - 'branch': 'Firefox', 10:06:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:06:34 INFO - 'config_files': ('talos/linux_config.py',), 10:06:34 INFO - 'default_actions': ('clobber', 10:06:34 INFO - 'read-buildbot-config', 10:06:34 INFO - 'download-and-extract', 10:06:34 INFO - 'populate-webroot', 10:06:34 INFO - 'create-virtualenv', 10:06:34 INFO - 'install', 10:06:34 INFO - 'run-tests'), 10:06:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:06:34 INFO - 'download_minidump_stackwalk': True, 10:06:34 INFO - 'download_symbols': 'ondemand', 10:06:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:06:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:06:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:06:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:06:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:06:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:06:34 INFO - 'installer_path': 'installer.exe', 10:06:34 INFO - 'log_level': 'info', 10:06:34 INFO - 'log_name': 'talos', 10:06:34 INFO - 'log_to_console': True, 10:06:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:06:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:06:34 INFO - 'opt_config_files': (), 10:06:34 INFO - 'pip_index': False, 10:06:34 INFO - 'sps_profile': False, 10:06:34 INFO - 'sps_profile_interval': 0, 10:06:34 INFO - 'suite': 'dromaeojs-e10s', 10:06:34 INFO - 'system_bits': '32', 10:06:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:06:34 INFO - 'title': 'talos-linux64-ix-066', 10:06:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:06:34 INFO - 'use_talos_json': True, 10:06:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:06:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:06:34 INFO - 'work_dir': 'build'} 10:06:34 INFO - ##### 10:06:34 INFO - ##### Running clobber step. 10:06:34 INFO - ##### 10:06:34 INFO - Running pre-action listener: _resource_record_pre_action 10:06:34 INFO - Running main action method: clobber 10:06:34 INFO - rmtree: /builds/slave/test/build 10:06:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:06:39 INFO - Running post-action listener: _resource_record_post_action 10:06:39 INFO - ##### 10:06:39 INFO - ##### Finished clobber step (success) 10:06:39 INFO - ##### 10:06:39 INFO - ##### 10:06:39 INFO - ##### Running read-buildbot-config step. 10:06:39 INFO - ##### 10:06:39 INFO - Running pre-action listener: _resource_record_pre_action 10:06:39 INFO - Running main action method: read_buildbot_config 10:06:39 INFO - Using buildbot properties: 10:06:39 INFO - { 10:06:39 INFO - "project": "", 10:06:39 INFO - "product": "firefox", 10:06:39 INFO - "script_repo_revision": "production", 10:06:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:06:39 INFO - "repository": "", 10:06:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:06:39 INFO - "buildid": "20160506073123", 10:06:39 INFO - "pgo_build": "True", 10:06:39 INFO - "basedir": "/builds/slave/test", 10:06:39 INFO - "buildnumber": 194, 10:06:39 INFO - "slavename": "talos-linux64-ix-066", 10:06:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:06:39 INFO - "platform": "ubuntu64_hw", 10:06:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:06:39 INFO - "branch": "mozilla-central", 10:06:39 INFO - "repo_path": "mozilla-central", 10:06:39 INFO - "revision": "19a1743ceb2e035e571012e88d25275ce627b925", 10:06:39 INFO - "stage_platform": "linux64-pgo", 10:06:39 INFO - "builduid": "0d73d835f3aa40f6a190e118b5f6a08a", 10:06:39 INFO - "slavebuilddir": "test" 10:06:39 INFO - } 10:06:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:06:39 INFO - Running post-action listener: _resource_record_post_action 10:06:39 INFO - ##### 10:06:39 INFO - ##### Finished read-buildbot-config step (success) 10:06:39 INFO - ##### 10:06:39 INFO - ##### 10:06:39 INFO - ##### Running download-and-extract step. 10:06:39 INFO - ##### 10:06:39 INFO - Running pre-action listener: _resource_record_pre_action 10:06:39 INFO - Running main action method: download_and_extract 10:06:39 INFO - mkdir: /builds/slave/test/build/tests 10:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:39 INFO - https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:06:43 INFO - Downloaded 1361 bytes. 10:06:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:43 INFO - Using the following test package requirements: 10:06:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:06:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:06:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'jsshell-linux-x86_64.zip'], 10:06:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:06:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:06:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:06:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:06:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:06:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:06: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')]} 10:06:43 INFO - https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:44 INFO - Downloaded 23894242 bytes. 10:06:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:46 INFO - Return code: 0 10:06:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:46 INFO - https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:47 INFO - Downloaded 23894242 bytes. 10:06:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:49 INFO - Return code: 0 10:06: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')]} 10:06:49 INFO - https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:06:51 INFO - Downloaded 10840152 bytes. 10:06:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:06:51 INFO - Return code: 0 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:51 INFO - https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:06:52 INFO - Downloaded 58424821 bytes. 10:06:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:52 INFO - mkdir: /builds/slave/test/properties 10:06:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:52 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:52 INFO - Contents: 10:06:52 INFO - build_url:https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:53 INFO - Running post-action listener: _resource_record_post_action 10:06:53 INFO - Running post-action listener: set_extra_try_arguments 10:06:53 INFO - ##### 10:06:53 INFO - ##### Finished download-and-extract step (success) 10:06:53 INFO - ##### 10:06:53 INFO - ##### 10:06:53 INFO - ##### Running populate-webroot step. 10:06:53 INFO - ##### 10:06:53 INFO - Running pre-action listener: _resource_record_pre_action 10:06:53 INFO - Running main action method: populate_webroot 10:06:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:53 INFO - '--tppagecycles', 10:06:53 INFO - '7'], 10:06:53 INFO - 'tests': ['tsvgm']}}, 10:06:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['damp', 'tps']}, 10:06:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'tests': ['damp', 'tps']}, 10:06:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['dromaeo_dom']}, 10:06:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['a11yr', 10:06:53 INFO - 'ts_paint', 10:06:53 INFO - 'tpaint', 10:06:53 INFO - 'sessionrestore', 10:06:53 INFO - 'sessionrestore_no_auto_restore', 10:06:53 INFO - 'tabpaint']}, 10:06:53 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:53 INFO - 'ts_paint', 10:06:53 INFO - 'tpaint', 10:06:53 INFO - 'sessionrestore', 10:06:53 INFO - 'sessionrestore_no_auto_restore', 10:06:53 INFO - 'tabpaint']}, 10:06:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:53 INFO - 'ts_paint', 10:06:53 INFO - 'tpaint', 10:06:53 INFO - 'sessionrestore', 10:06:53 INFO - 'sessionrestore_no_auto_restore', 10:06:53 INFO - 'tabpaint']}, 10:06:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:53 INFO - 'ts_paint', 10:06:53 INFO - 'tpaint', 10:06:53 INFO - 'sessionrestore', 10:06:53 INFO - 'sessionrestore_no_auto_restore', 10:06:53 INFO - 'tabpaint']}, 10:06:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['a11yr', 10:06:53 INFO - 'ts_paint', 10:06:53 INFO - 'tpaint', 10:06:53 INFO - 'sessionrestore', 10:06:53 INFO - 'sessionrestore_no_auto_restore', 10:06:53 INFO - 'tabpaint']}, 10:06:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['a11yr', 10:06:53 INFO - 'ts_paint', 10:06:53 INFO - 'tpaint', 10:06:53 INFO - 'sessionrestore', 10:06:53 INFO - 'sessionrestore_no_auto_restore', 10:06:53 INFO - 'tabpaint']}, 10:06:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['tsvgx', 10:06:53 INFO - 'tsvgr_opacity', 10:06:53 INFO - 'tart', 10:06:53 INFO - 'tscrollx', 10:06:53 INFO - 'cart']}, 10:06:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:53 INFO - 'tsvgr_opacity', 10:06:53 INFO - 'tart', 10:06:53 INFO - 'tscrollx', 10:06:53 INFO - 'cart']}, 10:06:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'talos_options': ['--disable-e10s'], 10:06:53 INFO - 'tests': ['tp5o']}, 10:06:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'tests': ['tp5o']}, 10:06:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'talos_options': ['--disable-e10s', 10:06:53 INFO - '--xperf_path', 10:06:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:53 INFO - 'tests': ['tp5n']}, 10:06:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:53 INFO - 'talos_options': ['--xperf_path', 10:06:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:53 INFO - 'tests': ['tp5n']}}, 10:06:53 INFO - 'talos.zip': {'path': '', 10:06:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:53 INFO - Running post-action listener: _resource_record_post_action 10:06:53 INFO - ##### 10:06:53 INFO - ##### Finished populate-webroot step (success) 10:06:53 INFO - ##### 10:06:53 INFO - ##### 10:06:53 INFO - ##### Running create-virtualenv step. 10:06:53 INFO - ##### 10:06:53 INFO - Running pre-action listener: _resource_record_pre_action 10:06:53 INFO - Running main action method: create_virtualenv 10:06:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:53 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 10:06:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:53 INFO - Using real prefix '/usr' 10:06:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:56 INFO - Installing pip.................done. 10:06:56 INFO - Return code: 0 10:06:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:06: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', 'pip>=1.5'] in /builds/slave/test/build 10:06: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 pip>=1.5 10:06:56 INFO - Using env: {'DISPLAY': ':0', 10:06:56 INFO - 'HOME': '/home/cltbld', 10:06:56 INFO - 'LANG': 'en_US.UTF-8', 10:06:56 INFO - 'LANGUAGE': 'en_US:en', 10:06:56 INFO - 'LOGNAME': 'cltbld', 10:06:56 INFO - 'MAIL': '/var/mail/cltbld', 10:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:56 INFO - 'MOZ_NO_REMOTE': '1', 10:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:56 INFO - 'NO_EM_RESTART': '1', 10:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:56 INFO - 'PWD': '/builds/slave/test', 10:06:56 INFO - 'SHELL': '/bin/bash', 10:06:56 INFO - 'SHLVL': '1', 10:06:56 INFO - 'TERM': 'linux', 10:06:56 INFO - 'TMOUT': '86400', 10:06:56 INFO - 'USER': 'cltbld', 10:06:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:56 INFO - '_': '/tools/buildbot/bin/python'} 10:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:56 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 10:06:56 INFO - Cleaning up... 10:06:56 INFO - Return code: 0 10:06:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', '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 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:06: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:06: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 psutil>=0.7.1 10:06:56 INFO - Using env: {'DISPLAY': ':0', 10:06:56 INFO - 'HOME': '/home/cltbld', 10:06:56 INFO - 'LANG': 'en_US.UTF-8', 10:06:56 INFO - 'LANGUAGE': 'en_US:en', 10:06:56 INFO - 'LOGNAME': 'cltbld', 10:06:56 INFO - 'MAIL': '/var/mail/cltbld', 10:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:56 INFO - 'MOZ_NO_REMOTE': '1', 10:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:56 INFO - 'NO_EM_RESTART': '1', 10:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:56 INFO - 'PWD': '/builds/slave/test', 10:06:56 INFO - 'SHELL': '/bin/bash', 10:06:56 INFO - 'SHLVL': '1', 10:06:56 INFO - 'TERM': 'linux', 10:06:56 INFO - 'TMOUT': '86400', 10:06:56 INFO - 'USER': 'cltbld', 10:06:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:56 INFO - '_': '/tools/buildbot/bin/python'} 10:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:56 INFO - Downloading/unpacking psutil>=0.7.1 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:59 INFO - Installing collected packages: psutil 10:06:59 INFO - Running setup.py install for psutil 10:06:59 INFO - building 'psutil._psutil_linux' extension 10:06:59 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 10:07:00 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 10:07:00 INFO - building 'psutil._psutil_posix' extension 10:07:00 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 10:07:00 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 10:07:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:00 INFO - Successfully installed psutil 10:07:00 INFO - Cleaning up... 10:07:01 INFO - Return code: 0 10:07:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 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 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:07:01 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 10:07:01 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 10:07:01 INFO - Using env: {'DISPLAY': ':0', 10:07:01 INFO - 'HOME': '/home/cltbld', 10:07:01 INFO - 'LANG': 'en_US.UTF-8', 10:07:01 INFO - 'LANGUAGE': 'en_US:en', 10:07:01 INFO - 'LOGNAME': 'cltbld', 10:07:01 INFO - 'MAIL': '/var/mail/cltbld', 10:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:01 INFO - 'MOZ_NO_REMOTE': '1', 10:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:01 INFO - 'NO_EM_RESTART': '1', 10:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:01 INFO - 'PWD': '/builds/slave/test', 10:07:01 INFO - 'SHELL': '/bin/bash', 10:07:01 INFO - 'SHLVL': '1', 10:07:01 INFO - 'TERM': 'linux', 10:07:01 INFO - 'TMOUT': '86400', 10:07:01 INFO - 'USER': 'cltbld', 10:07:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:01 INFO - '_': '/tools/buildbot/bin/python'} 10:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:07:03 INFO - Installing collected packages: mozsystemmonitor 10:07:03 INFO - Running setup.py install for mozsystemmonitor 10:07:03 INFO - Successfully installed mozsystemmonitor 10:07:03 INFO - Cleaning up... 10:07:03 INFO - Return code: 0 10:07:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:03 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 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:07:03 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 10:07:03 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 10:07:03 INFO - Using env: {'DISPLAY': ':0', 10:07:03 INFO - 'HOME': '/home/cltbld', 10:07:03 INFO - 'LANG': 'en_US.UTF-8', 10:07:03 INFO - 'LANGUAGE': 'en_US:en', 10:07:03 INFO - 'LOGNAME': 'cltbld', 10:07:03 INFO - 'MAIL': '/var/mail/cltbld', 10:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:03 INFO - 'MOZ_NO_REMOTE': '1', 10:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:03 INFO - 'NO_EM_RESTART': '1', 10:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:03 INFO - 'PWD': '/builds/slave/test', 10:07:03 INFO - 'SHELL': '/bin/bash', 10:07:03 INFO - 'SHLVL': '1', 10:07:03 INFO - 'TERM': 'linux', 10:07:03 INFO - 'TMOUT': '86400', 10:07:03 INFO - 'USER': 'cltbld', 10:07:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:03 INFO - '_': '/tools/buildbot/bin/python'} 10:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:05 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 10:07:05 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 10:07:05 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 10:07:05 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 10:07:05 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 10:07:05 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 10:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:06 INFO - Downloading docopt-0.6.1.tar.gz 10:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:06 INFO - Running setup.py install for blobuploader 10:07:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:06 INFO - Running setup.py install for requests 10:07:06 INFO - Running setup.py install for docopt 10:07:07 INFO - Successfully installed blobuploader requests docopt 10:07:07 INFO - Cleaning up... 10:07:07 INFO - Return code: 0 10:07:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:07 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 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:07:07 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 10:07:07 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 10:07:07 INFO - Using env: {'DISPLAY': ':0', 10:07:07 INFO - 'HOME': '/home/cltbld', 10:07:07 INFO - 'LANG': 'en_US.UTF-8', 10:07:07 INFO - 'LANGUAGE': 'en_US:en', 10:07:07 INFO - 'LOGNAME': 'cltbld', 10:07:07 INFO - 'MAIL': '/var/mail/cltbld', 10:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:07 INFO - 'MOZ_NO_REMOTE': '1', 10:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:07 INFO - 'NO_EM_RESTART': '1', 10:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:07 INFO - 'PWD': '/builds/slave/test', 10:07:07 INFO - 'SHELL': '/bin/bash', 10:07:07 INFO - 'SHLVL': '1', 10:07:07 INFO - 'TERM': 'linux', 10:07:07 INFO - 'TMOUT': '86400', 10:07:07 INFO - 'USER': 'cltbld', 10:07:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:07 INFO - '_': '/tools/buildbot/bin/python'} 10:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:07 INFO - Running setup.py (path:/tmp/pip-rWEVXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:07 INFO - Running setup.py (path:/tmp/pip-6bIsZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:07 INFO - Running setup.py (path:/tmp/pip-zVKta5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:07 INFO - Running setup.py (path:/tmp/pip-4VjLpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:07 INFO - Running setup.py (path:/tmp/pip-sf5ud5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:07 INFO - Running setup.py (path:/tmp/pip-aP3rl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:07 INFO - Running setup.py (path:/tmp/pip-jI9KNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:07 INFO - Running setup.py (path:/tmp/pip-wLesqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:07 INFO - Running setup.py (path:/tmp/pip-MSQJv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:07 INFO - Running setup.py (path:/tmp/pip-DPpXDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:08 INFO - Running setup.py (path:/tmp/pip-FIwZrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:08 INFO - Running setup.py (path:/tmp/pip-0q6c8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:08 INFO - Running setup.py (path:/tmp/pip-b4_MwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:08 INFO - Running setup.py (path:/tmp/pip-HNJwgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:08 INFO - Running setup.py (path:/tmp/pip-1dUgtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:08 INFO - Running setup.py (path:/tmp/pip-xqTZsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:08 INFO - Running setup.py (path:/tmp/pip-ydZhLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:08 INFO - Running setup.py install for manifestparser 10:07:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:08 INFO - Running setup.py install for mozcrash 10:07:08 INFO - Running setup.py install for mozdebug 10:07:08 INFO - Running setup.py install for mozdevice 10:07:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:07:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:08 INFO - Running setup.py install for mozfile 10:07:09 INFO - Running setup.py install for mozhttpd 10:07:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Running setup.py install for mozinfo 10:07:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Running setup.py install for mozInstall 10:07:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Running setup.py install for mozleak 10:07:09 INFO - Running setup.py install for mozlog 10:07:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Running setup.py install for moznetwork 10:07:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Running setup.py install for mozprocess 10:07:09 INFO - Running setup.py install for mozprofile 10:07:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:09 INFO - Running setup.py install for mozrunner 10:07:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:10 INFO - Running setup.py install for mozscreenshot 10:07:10 INFO - Running setup.py install for moztest 10:07:10 INFO - Running setup.py install for mozversion 10:07:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:10 INFO - Cleaning up... 10:07:10 INFO - Return code: 0 10:07:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:10 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 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:07:10 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 10:07:10 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 10:07:10 INFO - Using env: {'DISPLAY': ':0', 10:07:10 INFO - 'HOME': '/home/cltbld', 10:07:10 INFO - 'LANG': 'en_US.UTF-8', 10:07:10 INFO - 'LANGUAGE': 'en_US:en', 10:07:10 INFO - 'LOGNAME': 'cltbld', 10:07:10 INFO - 'MAIL': '/var/mail/cltbld', 10:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:10 INFO - 'MOZ_NO_REMOTE': '1', 10:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:10 INFO - 'NO_EM_RESTART': '1', 10:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:10 INFO - 'PWD': '/builds/slave/test', 10:07:10 INFO - 'SHELL': '/bin/bash', 10:07:10 INFO - 'SHLVL': '1', 10:07:10 INFO - 'TERM': 'linux', 10:07:10 INFO - 'TMOUT': '86400', 10:07:10 INFO - 'USER': 'cltbld', 10:07:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:10 INFO - '_': '/tools/buildbot/bin/python'} 10:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:10 INFO - Running setup.py (path:/tmp/pip-gNerxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:10 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)) 10:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:10 INFO - Running setup.py (path:/tmp/pip-tbt3Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:10 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)) 10:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:10 INFO - Running setup.py (path:/tmp/pip-xT5ale-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:10 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)) 10:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:10 INFO - Running setup.py (path:/tmp/pip-IcUJpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:10 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)) 10:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:10 INFO - Running setup.py (path:/tmp/pip-ICld9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:10 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)) 10:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:10 INFO - Running setup.py (path:/tmp/pip-YoaVZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:10 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)) 10:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:10 INFO - Running setup.py (path:/tmp/pip-oSiKuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:11 INFO - Running setup.py (path:/tmp/pip-ZgeSrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:11 INFO - Running setup.py (path:/tmp/pip-cWo0UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:11 INFO - Running setup.py (path:/tmp/pip-d4S9fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:11 INFO - Running setup.py (path:/tmp/pip-VrumV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:11 INFO - Running setup.py (path:/tmp/pip-GtHVto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:11 INFO - Running setup.py (path:/tmp/pip-nZx63t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:11 INFO - Running setup.py (path:/tmp/pip-Y0pW5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:11 INFO - Running setup.py (path:/tmp/pip-njQTGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:11 INFO - Running setup.py (path:/tmp/pip-ziCE_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:11 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)) 10:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:11 INFO - Running setup.py (path:/tmp/pip-HeDnCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:11 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)) 10:07:11 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)) 10:07:11 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)) 10:07:11 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)) 10:07:11 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)) 10:07:11 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)) 10:07:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:13 INFO - Downloading blessings-1.6.tar.gz 10:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:13 INFO - Installing collected packages: blessings 10:07:13 INFO - Running setup.py install for blessings 10:07:13 INFO - Successfully installed blessings 10:07:13 INFO - Cleaning up... 10:07:13 INFO - Return code: 0 10:07:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:14 INFO - Reading from file tmpfile_stdout 10:07:14 INFO - Current package versions: 10:07:14 INFO - argparse == 1.2.1 10:07:14 INFO - blessings == 1.6 10:07:14 INFO - blobuploader == 1.2.4 10:07:14 INFO - docopt == 0.6.1 10:07:14 INFO - manifestparser == 1.1 10:07:14 INFO - mozInstall == 1.12 10:07:14 INFO - mozcrash == 0.17 10:07:14 INFO - mozdebug == 0.1 10:07:14 INFO - mozdevice == 0.48 10:07:14 INFO - mozfile == 1.2 10:07:14 INFO - mozhttpd == 0.7 10:07:14 INFO - mozinfo == 0.9 10:07:14 INFO - mozleak == 0.1 10:07:14 INFO - mozlog == 3.1 10:07:14 INFO - moznetwork == 0.27 10:07:14 INFO - mozprocess == 0.22 10:07:14 INFO - mozprofile == 0.28 10:07:14 INFO - mozrunner == 6.11 10:07:14 INFO - mozscreenshot == 0.1 10:07:14 INFO - mozsystemmonitor == 0.0 10:07:14 INFO - moztest == 0.7 10:07:14 INFO - mozversion == 1.4 10:07:14 INFO - psutil == 3.1.1 10:07:14 INFO - requests == 1.2.3 10:07:14 INFO - wsgiref == 0.1.2 10:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:14 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 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:07:14 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 10:07:14 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 10:07:14 INFO - Using env: {'DISPLAY': ':0', 10:07:14 INFO - 'HOME': '/home/cltbld', 10:07:14 INFO - 'LANG': 'en_US.UTF-8', 10:07:14 INFO - 'LANGUAGE': 'en_US:en', 10:07:14 INFO - 'LOGNAME': 'cltbld', 10:07:14 INFO - 'MAIL': '/var/mail/cltbld', 10:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:14 INFO - 'MOZ_NO_REMOTE': '1', 10:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:14 INFO - 'NO_EM_RESTART': '1', 10:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:14 INFO - 'PWD': '/builds/slave/test', 10:07:14 INFO - 'SHELL': '/bin/bash', 10:07:14 INFO - 'SHLVL': '1', 10:07:14 INFO - 'TERM': 'linux', 10:07:14 INFO - 'TMOUT': '86400', 10:07:14 INFO - 'USER': 'cltbld', 10:07:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:14 INFO - '_': '/tools/buildbot/bin/python'} 10:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 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)) 10:07:14 INFO - Cleaning up... 10:07:14 INFO - Return code: 0 10:07:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:07:14 INFO - Using env: {'DISPLAY': ':0', 10:07:14 INFO - 'HOME': '/home/cltbld', 10:07:14 INFO - 'LANG': 'en_US.UTF-8', 10:07:14 INFO - 'LANGUAGE': 'en_US:en', 10:07:14 INFO - 'LOGNAME': 'cltbld', 10:07:14 INFO - 'MAIL': '/var/mail/cltbld', 10:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:14 INFO - 'MOZ_NO_REMOTE': '1', 10:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:14 INFO - 'NO_EM_RESTART': '1', 10:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:14 INFO - 'PWD': '/builds/slave/test', 10:07:14 INFO - 'SHELL': '/bin/bash', 10:07:14 INFO - 'SHLVL': '1', 10:07:14 INFO - 'TERM': 'linux', 10:07:14 INFO - 'TMOUT': '86400', 10:07:14 INFO - 'USER': 'cltbld', 10:07:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:14 INFO - '_': '/tools/buildbot/bin/python'} 10:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:14 INFO - Downloading/unpacking jsonschema 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:16 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:16 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 10:07:16 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 10:07:16 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 10:07:16 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 10:07:16 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 10:07:16 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 10:07:16 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:16 INFO - warning: no files found matching '*.txt' 10:07:16 INFO - no previously-included directories found matching 'build' 10:07:16 INFO - no previously-included directories found matching 'dist' 10:07:16 INFO - no previously-included directories found matching '.git*' 10:07:16 INFO - Installing collected packages: jsonschema, functools32 10:07:16 INFO - Running setup.py install for functools32 10:07:16 INFO - warning: no files found matching '*.txt' 10:07:16 INFO - no previously-included directories found matching 'build' 10:07:16 INFO - no previously-included directories found matching 'dist' 10:07:16 INFO - no previously-included directories found matching '.git*' 10:07:16 INFO - Successfully installed jsonschema functools32 10:07:16 INFO - Cleaning up... 10:07:16 INFO - Return code: 0 10:07:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:16 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 0x7f7b1a62bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', '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 10:07:16 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 10:07:16 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 10:07:16 INFO - Using env: {'DISPLAY': ':0', 10:07:16 INFO - 'HOME': '/home/cltbld', 10:07:16 INFO - 'LANG': 'en_US.UTF-8', 10:07:16 INFO - 'LANGUAGE': 'en_US:en', 10:07:16 INFO - 'LOGNAME': 'cltbld', 10:07:16 INFO - 'MAIL': '/var/mail/cltbld', 10:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:16 INFO - 'MOZ_NO_REMOTE': '1', 10:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:16 INFO - 'NO_EM_RESTART': '1', 10:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:16 INFO - 'PWD': '/builds/slave/test', 10:07:16 INFO - 'SHELL': '/bin/bash', 10:07:16 INFO - 'SHLVL': '1', 10:07:16 INFO - 'TERM': 'linux', 10:07:16 INFO - 'TMOUT': '86400', 10:07:16 INFO - 'USER': 'cltbld', 10:07:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:16 INFO - '_': '/tools/buildbot/bin/python'} 10:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:17 INFO - Downloading/unpacking flake8 10:07:17 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 10:07:17 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 10:07:17 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 10:07:17 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 10:07:17 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 10:07:17 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 10:07:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:07:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:07:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:19 INFO - no previously-included directories found matching 'docs/_build' 10:07:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:07:19 INFO - Running setup.py install for pep8 10:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:19 INFO - no previously-included directories found matching 'docs/_build' 10:07:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:07:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:07:19 INFO - Cleaning up... 10:07:19 INFO - Return code: 0 10:07:19 INFO - Running post-action listener: _resource_record_post_action 10:07:19 INFO - Running post-action listener: _start_resource_monitoring 10:07:20 INFO - Starting resource monitoring. 10:07:20 INFO - ##### 10:07:20 INFO - ##### Finished create-virtualenv step (success) 10:07:20 INFO - ##### 10:07:20 INFO - ##### 10:07:20 INFO - ##### Running install step. 10:07:20 INFO - ##### 10:07:20 INFO - Running pre-action listener: _resource_record_pre_action 10:07:20 INFO - Running main action method: install 10:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:20 INFO - Reading from file tmpfile_stdout 10:07:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:20 INFO - Reading from file tmpfile_stdout 10:07:20 INFO - Output received: 10:07:20 INFO - Usage: mozinstall [options] installer 10:07:20 INFO - Options: 10:07:20 INFO - -h, --help show this help message and exit 10:07:20 INFO - -d DEST, --destination=DEST 10:07:20 INFO - Directory to install application into. [default: 10:07:20 INFO - "/builds/slave/test"] 10:07:20 INFO - --app=APP Application being installed. [default: firefox] 10:07:20 INFO - mkdir: /builds/slave/test/build/application 10:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:07:36 INFO - Reading from file tmpfile_stdout 10:07:36 INFO - Output received: 10:07:36 INFO - /builds/slave/test/build/application/firefox/firefox 10:07:36 INFO - Running post-action listener: _resource_record_post_action 10:07:36 INFO - ##### 10:07:36 INFO - ##### Finished install step (success) 10:07:36 INFO - ##### 10:07:36 INFO - ##### 10:07:36 INFO - ##### Running run-tests step. 10:07:36 INFO - ##### 10:07:36 INFO - Running pre-action listener: _resource_record_pre_action 10:07:36 INFO - Running main action method: run_tests 10:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:36 INFO - Python 2.7.3 10:07:36 INFO - Return code: 0 10:07:36 INFO - grabbing minidump binary from tooltool 10:07:36 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')]} 10:07:36 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 0x26c8410>, '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 0x26c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:36 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 10:07:36 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 10:07:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:36 INFO - Return code: 0 10:07:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:07:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:07:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:07:37 INFO - Return code: 0 10:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 10:07:37 INFO - Using env: {'DISPLAY': ':0', 10:07:37 INFO - 'HOME': '/home/cltbld', 10:07:37 INFO - 'LANG': 'en_US.UTF-8', 10:07:37 INFO - 'LANGUAGE': 'en_US:en', 10:07:37 INFO - 'LOGNAME': 'cltbld', 10:07:37 INFO - 'MAIL': '/var/mail/cltbld', 10:07:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:37 INFO - 'MOZ_NO_REMOTE': '1', 10:07:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:37 INFO - 'NO_EM_RESTART': '1', 10:07:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:37 INFO - 'PWD': '/builds/slave/test', 10:07:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:37 INFO - 'SHELL': '/bin/bash', 10:07:37 INFO - 'SHLVL': '1', 10:07:37 INFO - 'TERM': 'linux', 10:07:37 INFO - 'TMOUT': '86400', 10:07:37 INFO - 'USER': 'cltbld', 10:07:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055', 10:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:37 INFO - '_': '/tools/buildbot/bin/python'} 10:07:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:07:38 INFO - mozversion application_buildid: 20160506073123 10:07:38 INFO - mozversion application_changeset: 19a1743ceb2e035e571012e88d25275ce627b925 10:07:38 INFO - mozversion application_display_name: Nightly 10:07:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:38 INFO - mozversion application_name: Firefox 10:07:38 INFO - mozversion application_remotingname: firefox 10:07:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:07:38 INFO - mozversion application_vendor: Mozilla 10:07:38 INFO - mozversion application_version: 49.0a1 10:07:38 INFO - mozversion platform_buildid: 20160506073123 10:07:38 INFO - mozversion platform_changeset: 19a1743ceb2e035e571012e88d25275ce627b925 10:07:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:07:38 INFO - mozversion platform_version: 49.0a1 10:07:38 INFO - using testdate: 1462554458 10:07:38 INFO - actual date: 1462554458 10:07:38 INFO - starting webserver on 'localhost:33233' 10:07:38 INFO - SUITE-START | Running 2 tests 10:07:38 INFO - TEST-START | dromaeo_css 10:07:38 INFO - operating with platform_type : linux_ 10:07:38 INFO - Initialising browser for dromaeo_css test... 10:07:38 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmGkz2/profile http://localhost:33233/getInfo.html) 10:07:43 INFO - PROCESS | 3313 | 10:07:43 INFO - PROCESS | 3313 | (process:3376): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:44 INFO - PROCESS | 3313 | __metrics Screen width/height:1600/1200 10:07:44 INFO - PROCESS | 3313 | colorDepth:24 10:07:44 INFO - PROCESS | 3313 | Browser inner width/height: 1024/697 10:07:44 INFO - PROCESS | 3313 | __metrics 10:07:45 ERROR - PROCESS | 3313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:07:45 INFO - TEST-INFO | 3313: exit 0 10:07:45 INFO - Browser initialized. 10:07:45 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:45 INFO - TEST-INFO | started process 3431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmGkz2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:47 INFO - PROCESS | 3431 | 10:07:47 INFO - PROCESS | 3431 | (process:3491): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:57 INFO - PROCESS | 3431 | RSS: Main: 163504128 10:07:57 INFO - PROCESS | 3431 | 10:08:47 INFO - PROCESS | 3431 | 1462554527390 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] 10:10:55 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:33233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33233/tests/dromaeo/cssquery-ext.html) 10:10:56 INFO - PROCESS | 3431 | RSS: Main: 166178816 10:10:56 INFO - PROCESS | 3431 | 10:13:58 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:33233/tests/dromaeo/cssquery-ext.html (next: http://localhost:33233/tests/dromaeo/cssquery-jquery.html) 10:13:58 INFO - PROCESS | 3431 | RSS: Main: 167428096 10:13:58 INFO - PROCESS | 3431 | 10:17:00 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:33233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33233/tests/dromaeo/cssquery-mootools.html) 10:17:01 INFO - PROCESS | 3431 | RSS: Main: 168062976 10:17:01 INFO - PROCESS | 3431 | 10:20:02 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:33233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33233/tests/dromaeo/cssquery-prototype.html) 10:20:03 INFO - PROCESS | 3431 | RSS: Main: 165322752 10:20:03 INFO - PROCESS | 3431 | 10:23:05 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:33233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33233/tests/dromaeo/cssquery-yui.html) 10:23:06 INFO - PROCESS | 3431 | RSS: Main: 166600704 10:23:06 INFO - PROCESS | 3431 | 10:26:08 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:33233/tests/dromaeo/cssquery-yui.html (next: http://localhost:33233/tests/dromaeo/cssquery-dojo.html) 10:26:09 INFO - PROCESS | 3431 | RSS: Main: 168742912 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | __start_tp_report 10:26:09 INFO - PROCESS | 3431 | _x_x_mozilla_page_load 10:26:09 INFO - PROCESS | 3431 | _x_x_mozilla_page_load_details 10:26:09 INFO - PROCESS | 3431 | |i|pagename|runs| 10:26:09 INFO - PROCESS | 3431 | |0;dojo.html;3142.497200447928;3165.0663054398938;3199.4400979828524;3200.231944333359;3237.3687131009447;5222;5262.57899368051;5278.076336641092;5390.380106287768;5456.9181462278;5293.655912365693;5336.893262134765;5400.78396864126;5402.594805389592;5482.342118945722;4814.9037019259595;4872.853814385574;4961.479044700309;4983.302337672729;5041.344625198737;654.8937756597018;4822.614190864722;4823.89050518381;4926.2364333528185;4942.233953737176;4905.460399356068;4919.803207871681;4938.185199442088;4940.925886111711;4952.479989601094;4953.2074868020945;4964.553190212898;4974.980129073531;4977.576905962997;4989.775460104304;4799.13615549201;4852.56326930578;4854.732989685566;4873.342098816685;4888.73111978841;5232.215167724834;5245.213218017289;5245.527902488756;5253.55344795689;5255.237990491358;5570.582206334541;5667.319921609434;5688.232088668018;5695.829125126253;5697.7464957709235;5766.567507436959;5885.146653735227;5896.469317761422;5901.498372638331;5946.345901950782;5405.972970135124;5431.2396264522995;5433.728313584305;5433.8369848904595;5456.699881506515;5719.628224165416;5740.368559458456;5762.250907382014;5961.135635332853;5983.581149319506;5604.215409842625;5615.2700148981185;5624.831255062355;5626.634268772516;5664.660120392789;5699.088145896637;5701.116326969326;5704.34400043992;5713.942860571424;5715.142728590745;5566.053770858964;5661.547076233891;5686.232358631614;5737.340205876294;5748.741306641211;5785.652860828363;5789.363170051291;5792.218050563204;5792.4497172768515;5809.564282678816;4368.563143685606;4370.694051416434;4407.162639098561;4410.6030457259;4431.578999994996;3809.0858194033785;3863.34323165057;3865.34289170836;3892.0853599404118;3923.156521347924;5382.1119515280325;5392.757325920343;5401.6218864679095;5452.427495112956;5467.343918729778;5712.857178570486;5758.395368486333;5761;5763.711814409263;5764.394738552475;5319.308489896289;5399.514043736082;5414.756335964891;5418.241446197536;5450.1007333789485;4932.975335123373;4935.531124543163;4949.752512374367;4986;4992.425871024879;5869.383714709979;5883.146943693226;5913.497352725067;5915.319738230159;5926.2295901532525;5725.6850873202375;5777.91333129995;5807.128930660435;5810.331811841608;5853.970730146322;6027.939720602913;6067.817965461043;6068.696565171812;6080;6117.724702388492;5738.368779434342;5744.3681195067675;5792.826215213382;5795.072788353843;5800.9419905800405;5663.235463212578;5699.7435115419075;5748.051571490657;5793.768249269982;5912.970435147797;5649.802256920988;5664.660120392789;5673;5682.772689092555;5683.147527870852;5607.41122182165;5659.320881494247;5661.952538780339;5682.232898558807;5682.687452190169;5428.891422171613;5565.1374037024325;5580.1629755537;5631.408702086386;5678.0915053591225;5716.199732037601;5761.164631128379;5782.710864456676;5792.942070579409;5795.449432303924;5424.728763561885;5643.689597072201;5647.971760141173;5668.319801623831;5681.715914204356 10:26:09 INFO - PROCESS | 3431 | |1;ext.html;584.2521572387343;628.8396458902985;634.9015902535107;649.2663290481755;652.8726898254843;42958.57041429585;44457;44701.776491117496;44825.551744482545;47426.28860567094;44011.3398299025;44543.554564454345;44720.552794472045;44850;44887;8662.30701543875;8823.117688231157;8857.114288571123;8894.599743011548;8905;8659.393842431;8722.040575536686;8764.430312029697;8787;8834.558272086402;8776.07851175627;8797.912020879774;8837.823243535126;8841.823163536725;8846.911530884705;8767.167119123706;8845.911540884574;8853.867191992125;8857.734267971971;8880.200781929658;8806.987196472424;8815.691450799191;8865.556722163867;8883.333749968713;8930.553472326423;41232.79383603093;41427;41814;41922.37116443256;41966;3444.121748954001;3498.912527186815;3531.4702794581017;3803.7717736935874;4167.249895018896;31800;32209.355812883845;32287.838560807282;32388.514172287436;34062.829685851415;4268.59448352406;4288.635465985395;4295.570442955711;4370.628496577795;4549.47681016684;233281;322442;322735;322769;325054.3747281272;34978;35834.104147396;36123.63876361255;37586.43620345697;57182.428175718545;36309;36386.8180659095;36527.26945461129;36705.63294367075;36771.81614091966;14093.577192684235;14213.076150050214;14243.928780356031;14259.429622815178;14282.714345713235;11835.11236657254;11883.287002779862;11942.223755455867;11988.88011119895;11994.940025299818;8518.318534517224;8530.616122274512;8545.572721363907;8598.785030374165;8611.354148438892;3305.173706573357;3371.3425881953276;3377.834647046765;3378.054144839449;3451.033710561047;986.1962500562018;1051.3481641382239;1092.229977865603;1193.3198077096145;1254.5107408110844;31387;32002;32069;32817;32825.50761738576;1096.8957948994832;1138.0610995928391;1158.5365853658436;1181.7518321152481;1236.8082947143207;16842.494725158263;16886.57783555421;17035.91482042582;17072.02806961582;17255.56861078483;483106;486101;488183;488273;490496;57695.42304576984;58573.70713146407;58626;58649;58663.413365865796;1291.3414158778903;1371.7119404924879;1411.1039489923767;1412.894032947533;1422.5803388000566;30178.69821301759;30722.231944201572;31055.68944310528;31105.222369440944;31408.842955785076;51354.48645513497;51660.22509662283;51717.48282517127;51794.22308665298;51939;389878;390071;390133;390424;390795;28230;28952.855235723688;28957.85521072381;29071;29072.56391154092;48188.5181148198;48376;48800;48996.5100348992;49077;40017.1996560073;40683.1863362737;41256.79371603243;41484.37773433341;41818.58181418147;39090.218195636495;40515.79742101271;41380.1723965525;41894;42242;41028.384574232005;41625.37561936513;42423.787881060394;42664;45434;35532;36605.594021046745;36855.81572092122;37507.24985500329;37508.81245593754;28095.859520702266;28469;28474;28518.714812851606;28852.567211492264 10:26:09 INFO - PROCESS | 3431 | |2;jquery.html;394.74933417280016;396.2965735818921;401.9075612609099;406.4127335999482;416.35049323056035;13752.312384380766;17438.73841892371;18710.81289187111;18896.527586810338;18981.145848436838;18288.908555457238;18603.627927441445;18643.720344194848;18827.341043063494;19032.2387104516;5456;5564.8052318168975;5736.770529178828;5774.018416869142;5786.392428794979;5762.481376676098;5764.452377024197;5780.161876527901;5795.15970184323;5821.301443826746;5764.62128475552;5777.566682498829;5799.9130013049835;5804.606894345347;5824.796132135376;5685.971570142144;5762.30852297727;5765.106408506667;5787.074068149076;5805.825825225229;5394;5598.300212473441;5617.269754931874;5628.915566266509;5648.85877853057;13243.668908277274;13430.395632196574;13445.32773361328;13670.93164534171;13700.52048178319;2365.988170059156;2492.8628925409093;2574;2836.4327134572964;3031.272494601302;10029.147522460527;10138.341007834468;10348.58605655773;10360.79278414435;10424.530896109618;1970.7733610634816;2032.2582257476063;2059.3718915730697;2071.337172104927;2107.1782005018053;63146.368536314505;79515;80698;82693;86537.13462865354;8993.955030224806;9564.713058608253;9607.615695372107;9834.508274586386;9999.650012249682;13191.736165276641;13248.668783280495;13250.867491325156;13295.468181272641;13309;7636.541807491457;7788.961055194688;7848.7645370638975;7902.288794008567;7916;7609.619519024027;7759.7672069838;7883.448158628956;7889.566073865993;7970.202979701983;3982.123932734794;4142.668586513072;4143.129942712004;4196.454460920122;4202.957970420257;1957.2366776956999;2006.829419499359;2045.6317862784842;2056.7223424837753;2091.7699053104147;988.2439933450916;1002.9589784787921;1055.498638146874;1138.1293310617218;1153.423288355822;17792.91103544474;18174.18216180275;18220.36228731988;18275.177617007266;18504;994.537540043883;1016.9644062457778;1035.358077991635;1044.4151275285865;1112.8330750387345;9949.816493146465;10237.283390162765;10244.64143754965;10273.9486302568;10317.74205644865;492820;505549;506910;510223;527333;56211.43788562062;73210.63394682993;93033;93124.53437732904;93167.5341623301;1088.1892989722708;1104.5305745058158;1109.4064675398783;1131.0668698323916;1131.6605018494583;15829.841701582836;15989.280482378554;16134.112623805804;16149.838501615304;16285;37808.62191378051;38313.233735325695;38836.6116338833;39312.803435982634;39318.83746393976;50903;52740.736296318275;58998.705006474695;59662;59788;7615.65729542183;8013.479123857164;8260.545669987969;9007.459552426875;9036.774080648036;13181.275029873448;13584;13629;13642;13681.452741890611;11593.942030289794;11812.881871181178;11817.113716471471;11836.934675879213;11839.644810655695;11624.186306958432;11802.763944720886;11874.287542747463;11929.422319693036;12063.517459301529;11916.344601047025;11940.820887686517;12149.574764883188;12197.634070977885;12204.084693647834;7490.662920168715;7887.171846955987;8068.636911338886;8098.83802323962;8238.423310368216;8913.331500137387;10423.895761042293;10941.781164376827;10944.179186560881;11437.485313160762 10:26:09 INFO - PROCESS | 3431 | |3;mootools.html;1513.6518600721834;1522.7106849698557;1692.737625668021;1797.3799039331427;1807.4758320087176;7520.6991720331125;7974.2823145916855;8350.95824520878;8507.829843403128;8586;8401.159884011597;8625.309975201984;8737.038925718165;8743.387962842604;8746.169113934182;2272.8977196026176;2306.9192578259763;2307.5961706701346;2312.4450131968374;2312.5143719818857;2250.414892128042;2260.175036111824;2312.8843557822124;2321.93034208974;2324.8023917966993;2244.607193741097;2258.1306197114145;2264.841461097724;2317.79139877411;2322.6412548659055;2230.152542034033;2239.876806775627;2265.1166045242367;2267.8639281643154;2277.87471689057;2232.0848452134546;2267.455810605459;2271.205078222609;2272.1138755885218;2275.7382900966436;8606.397552171351;8636.39545231834;8662.653493860238;8665.263452606472;8681.479111253282;4998.375203099613;5118.053160165344;5142.922856157161;5156.994386094713;5183.896322073538;3239.1092449576317;3286.2277364819247;3426.468897320919;3441.208522039945;3490.581130264359;1050.9369437833677;1070.1599244592958;1075.8063548561256;1089.624079692505;1103.5530610102921;11809.586664466788;11815;11838.230515016496;11914.642560723192;11930.642080737505;4443.800028998703;4450.931776373647;4506.121306345297;4530.524294949048;4710.835120770825;10035.899641003496;10041.246906482043;10046.19630429564;10049.346792458467;10065;5169.689818610896;5191.480851914778;5202.4277329493725;5216.63483556155;5261.447548007481;4198.1393814268;4729.07782982322;4753.857384278477;4831.396075490564;4874.147024270738;3798.9430158547643;3871.7483363581277;3942.3889297158985;3970.9801450993136;4100.466939297872;1195.6293548999663;1198.7662405830954;1205.1563905266173;1206.8250103734908;1212.4968138222716;875.9605817738217;979.588572799426;1041.4063983529315;1067.4769363012067;1070.930389524694;6198.907016394758;6236.75052997875;6274.968625156845;6319.526035547352;6353.745850166034;464.5192226046026;464.9628029757611;466.7689493700572;467.3503829676752;468.6859803931306;4345.087531618396;4416.6025057744955;4423.778811059434;4437.711548749321;4443.2224360736745;10247.180225582084;10659.84010239847;10685.519151638195;10689;10699;10048.447335396624;10450.529726162342;10522.736931576772;10620.256582039183;10645.148388128931;7878.330341920886;8080.474769139987;8159.143289954588;8176.877346839802;8182.386321025947;5903.734331954986;6110.450059494667;6132.59119371846;6149.631022138686;6153.907691384543;9302.581383837609;9352.485613291334;9382.95308523453;9434.575444104894;9573.569189386355;9390.24878009744;9420.152186303265;9496.14534691881;9582.808343833223;9687.079727425884;7663.731769388268;7707.383409327353;7747.418943579141;7786.143524212445;7817.6872925084635;8074.475159114639;8146.511209327459;8170.836583268182;8190.303824175012;8231.34149268069;6922.273161317989;7138.893293166356;7336.669849856663;7398.482106252511;7440.962795185989;7227.421806255382;7243.818904527429;7257.092863392076;7257.854842903218;7289.271072892669;6981.441484681111;6982.371586557234;6988.301169882971;6997.335253150943;7043.049188359506;5220.347456567929;5285.63000589955;5448.673079615236;5482.890342193214;5533.446655334435;5332.200169974535;5413.350397952271;5440.455954404528;5626.774929002794;5633.126865335879 10:26:09 INFO - PROCESS | 3431 | |4;prototype.html;335.21524347212414;337.4314280437463;341.3820984018926;342.28804087497997;345.0511094490152;5438.945610543893;5532.197831314457;5560.777568897244;5693.686847223401;5694.515966142878;5557.138358649847;5572.4706152915505;5575.330960284761;5577.21918931349;5586.458161536501;4313;4325.502567204764;4337.652987760972;4382.211201983634;4393.450818647669;4086.1010577672864;4311.353297005443;4312.361302704968;4351.412559304501;4364.061726728753;4217.430646862665;4238.766867822269;4255.616924499534;4273.29490634045;4284.243460181327;4286.271333873249;4287.892802679927;4290.034742182999;4295.763732994684;4296.720713153635;3655.976326628548;3780.546334439857;3783.3190025795348;3784.924301513954;3795.203007368456;5370.382406023279;5370.462953704638;5379.193121031837;5382.892342153135;5403.621746477748;4953.529414705597;4961.3798275215595;4978.178600530908;4978.975105124451;4987.426445958725;5479.369872464677;5786.710664466802;5807.970960145214;5842.2405087338375;5865.120231965197;4194.622483976456;4226.1336426032585;4228.344606585984;4231.032569855032;4238.533761286256;6013.218281623361;6014.338422773491;6025.789097381615;6049.546284028672;6057.575969682124;4197.853075142355;4274.380214868826;4285.657147428198;4293.475816085307;4327.545607711208;4317.395564620955;4353.673474489426;4357.8451710296795;4376.993291542963;4382.627476664456;4957.7769000395065;4975.676581022222;5018.322526458955;5019.598432125421;5057.393112826484;5765.942340576625;5865.149553314745;5865.20819689345;5882.382349853289;5887.057271100526;1470.948271985514;1480.2376775960388;1486.680363721805;1487.137460273039;1504.0223854494448;1007.2093406675724;1032.5611615063567;1036.2176556699644;1050.2963014780116;1051.7633532455136;5531.612787104945;5539.723013849291;5548.77804887808;5550.612346913272;5562.833115006556;5776.913346299809;5807.448292412214;5861.413858614104;5913.201717768132;5939.673317967467;5197.818076367309;5496.076373269324;5496.862578435571;5548.750306236229;5589.217509548666;3142.4972004479173;3170.8097514149226;3174.8888788892277;3177.936441271208;3179.666135055832;5513.434887868194;5822.650640961471;5949.6430214187285;6114.633122012693;6115.082737589397;5813.854653633693;5882.55880808941;5905.675187864623;5918.869207085446;5961.225040744675;5880.852978675482;5900.43945825146;5941.792037278675;5969.31352894414;5977.790777322686;5662.57530685192;5811.680357580204;6059.303180134341;6116.235470566179;6203.720832562455;6050.761218349239;6073.180120683651;6132.693365331805;6134.693265336626;6137.7851775187655;5992.850178745566;6044.969775151272;6211.65835879031;6218.31598524171;6286.402791734778;4209.116085622054;4238;4242.809073591634;4249.171411574837;4251.277282861859;5998.620317327127;6076.848078798065;6100.511959043355;6118.969405152946;6122.2959359674205;5704.515116215168;5872.618279811799;5874.765009399747;5944.197533332945;5967.731452084753;5883.705814709162;5900.498457630978;5918.970405147947;5924.733386997682;5946.494547963299;5738.741756620879;5762.683052432157;5777.16231146473;5814.331351894586;5829.795957141479;5524.640898341595;5803.47768700819;5835.533157347317;5860;5870.765169393177;5667.761234312506;5795.652260864362;5811.796587119599;5832.825015249549;5845.824625261249 10:26:09 INFO - PROCESS | 3431 | |5;yui.html;754.2005474197351;817.1624085312556;845.8392905347984;847.2036285891262;866.6490071521036;14052.086614370059;14090.436382544685;14123.152610843357;14135.151890886542;14393.568192954215;14240.501582444616;14243.78634320486;14244.643883902907;14249.287535623229;14305;662.2979641579917;797.8204903896635;826.6817275348974;826.9586520673943;831.1522247307743;823.8681810910256;826.3389288569151;828.9626966786509;829.4732844643664;829.7054545636303;861.7371701631;862.3187681731456;863.4603372891943;864.2912811494577;870.8345414371249;848.9151084891492;853.9530325832077;854.1842540373927;854.5513605357144;862.482510493705;629.5058379172374;630.1933525087849;630.6783540394385;631.6399652198248;632.4687262699355;12597.307148106851;12615.747685046339;12616.116871818977;12654.683632909158;12676.556320528738;14276.286185690778;14283.35724892372;14332;14457.132572045712;14491.42034318626;11610.535578576846;11745.765084698343;11776.175667703264;11844.466998985066;12051;3774.830132644038;3882.864099756495;3886;3941.7043721720984;3999.42008408782;54661.72669136629;54804.451955480734;55171;55223.17165242484;55882.720586396805;10845.295055821347;10935.179861510418;11069;11092.944535277433;11187.832182517106;18434.90782546079;18850.15174317159;18924.43226703201;19601.80398196028;19648.803511964696;8836;8915.643374265086;8977.23693486061;9039.728808135766;9044.909550904407;4809.302651115569;4842.007388485352;4928.334674818925;4993.350864387607;5040.31955685985;3271.378438096754;3348.2299071213756;3348.8325583720716;3352.9329413411597;3356.429407000816;617.6695467924638;621.3941407128104;621.4996927473337;627.8399008252866;639.216959224955;738.4683028219673;757.7499425189674;767.5087943716027;779;790.6916302641974;9336.813263734823;9755.512224388753;9799.11807937289;9823.214142868554;10220;788.0700773087812;797.2943944609062;798.1659166171365;803.9718609848627;815.5106935838568;4621.2837010263465;4622.19111655459;4757.048590281957;4787.0904528139545;4794.113089078532;63450.36549634537;63494.36505634977;64657.35342646608;65472.34527654663;65515.67242163759;57262;58413.70793146007;58592.12111818326;59364.70317648384;59365;50830.49169508258;53445.7327713359;53672.46327536675;53750.7312463443;54194.7290263554;9203.447793132433;9267.87457205569;9408.388454750419;9434.811303774024;9482.099200575934;33123.33753324968;33562.664373355954;33899.15252118717;34334;34822.651773482954;37950.810245949695;38691.80654096712;45721;46127.07745845131;46961.76519117383;12277.815832762337;12392.704664451445;12439.813402798783;12578.55975040869;12829.166104203197;12741.362931853186;13067.869321306665;13132.934335328644;13534.390952406968;14018.719625607635;12811.231326120462;12844.486220551073;12994.675133121747;13330.200187988752;13845.446182152602;12221;12421.068419868727;12832.743345133233;12885.613431597067;12890.806637900252;10836.620718274822;11080.335179889233;12418.130730848754;12562.937185314015;12924.935375323063;10426.843597346198;10467.895321046692;10679;10952.390446190318;11007.174461915549;9884.703458896245;9965;10086.747831304276;10613.893861061291;10674.839877402 10:26:09 INFO - PROCESS | 3431 | __end_tp_report 10:26:09 INFO - PROCESS | 3431 | __start_cc_report 10:26:09 INFO - PROCESS | 3431 | _x_x_mozilla_cycle_collect,330 10:26:09 INFO - PROCESS | 3431 | __end_cc_report 10:26:09 INFO - PROCESS | 3431 | __startTimestamp1462555569073__endTimestamp 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | ------- Summary: start ------- 10:26:09 INFO - PROCESS | 3431 | Number of tests: 6 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | [#0] dojo.html Cycles:165 Average:5329.64 Median:5615.27 stddev:709.08 (12.6%) stddev-sans-first:690.18 10:26:09 INFO - PROCESS | 3431 | Values: 3142.5 3165.1 3199.4 3200.2 3237.4 5222.0 5262.6 5278.1 5390.4 5456.9 5293.7 5336.9 5400.8 5402.6 5482.3 4814.9 4872.9 4961.5 4983.3 5041.3 654.9 4822.6 4823.9 4926.2 4942.2 4905.5 4919.8 4938.2 4940.9 4952.5 4953.2 4964.6 4975.0 4977.6 4989.8 4799.1 4852.6 4854.7 4873.3 4888.7 5232.2 5245.2 5245.5 5253.6 5255.2 5570.6 5667.3 5688.2 5695.8 5697.7 5766.6 5885.1 5896.5 5901.5 5946.3 5406.0 5431.2 5433.7 5433.8 5456.7 5719.6 5740.4 5762.3 5961.1 5983.6 5604.2 5615.3 5624.8 5626.6 5664.7 5699.1 5701.1 5704.3 5713.9 5715.1 5566.1 5661.5 5686.2 5737.3 5748.7 5785.7 5789.4 5792.2 5792.4 5809.6 4368.6 4370.7 4407.2 4410.6 4431.6 3809.1 3863.3 3865.3 3892.1 3923.2 5382.1 5392.8 5401.6 5452.4 5467.3 5712.9 5758.4 5761.0 5763.7 5764.4 5319.3 5399.5 5414.8 5418.2 5450.1 4933.0 4935.5 4949.8 4986.0 4992.4 5869.4 5883.1 5913.5 5915.3 5926.2 5725.7 5777.9 5807.1 5810.3 5854.0 6027.9 6067.8 6068.7 6080.0 6117.7 5738.4 5744.4 5792.8 5795.1 5800.9 5663.2 5699.7 5748.1 5793.8 5913.0 5649.8 5664.7 5673.0 5682.8 5683.1 5607.4 5659.3 5662.0 5682.2 5682.7 5428.9 5565.1 5580.2 5631.4 5678.1 5716.2 5761.2 5782.7 5792.9 5795.4 5424.7 5643.7 5648.0 5668.3 5681.7 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | [#1] ext.html Cycles:180 Average:54879.36 Median:40855.79 stddev:106411.87 (260.5%) stddev-sans-first:106632.30 10:26:09 INFO - PROCESS | 3431 | Values: 584.3 628.8 634.9 649.3 652.9 42958.6 44457.0 44701.8 44825.6 47426.3 44011.3 44543.6 44720.6 44850.0 44887.0 8662.3 8823.1 8857.1 8894.6 8905.0 8659.4 8722.0 8764.4 8787.0 8834.6 8776.1 8797.9 8837.8 8841.8 8846.9 8767.2 8845.9 8853.9 8857.7 8880.2 8807.0 8815.7 8865.6 8883.3 8930.6 41232.8 41427.0 41814.0 41922.4 41966.0 3444.1 3498.9 3531.5 3803.8 4167.2 31800.0 32209.4 32287.8 32388.5 34062.8 4268.6 4288.6 4295.6 4370.6 4549.5 233281.0 322442.0 322735.0 322769.0 325054.4 34978.0 35834.1 36123.6 37586.4 57182.4 36309.0 36386.8 36527.3 36705.6 36771.8 14093.6 14213.1 14243.9 14259.4 14282.7 11835.1 11883.3 11942.2 11988.9 11994.9 8518.3 8530.6 8545.6 8598.8 8611.4 3305.2 3371.3 3377.8 3378.1 3451.0 986.2 1051.3 1092.2 1193.3 1254.5 31387.0 32002.0 32069.0 32817.0 32825.5 1096.9 1138.1 1158.5 1181.8 1236.8 16842.5 16886.6 17035.9 17072.0 17255.6 483106.0 486101.0 488183.0 488273.0 490496.0 57695.4 58573.7 58626.0 58649.0 58663.4 1291.3 1371.7 1411.1 1412.9 1422.6 30178.7 30722.2 31055.7 31105.2 31408.8 51354.5 51660.2 51717.5 51794.2 51939.0 389878.0 390071.0 390133.0 390424.0 390795.0 28230.0 28952.9 28957.9 29071.0 29072.6 48188.5 48376.0 48800.0 48996.5 49077.0 40017.2 40683.2 41256.8 41484.4 41818.6 39090.2 40515.8 41380.2 41894.0 42242.0 41028.4 41625.4 42423.8 42664.0 45434.0 35532.0 36605.6 36855.8 37507.2 37508.8 28095.9 28469.0 28474.0 28518.7 28852.6 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | [#2] jquery.html Cycles:180 Average:28504.43 Median:20419.95 stddev:83638.03 (409.6%) stddev-sans-first:83846.02 10:26:09 INFO - PROCESS | 3431 | Values: 394.7 396.3 401.9 406.4 416.4 13752.3 17438.7 18710.8 18896.5 18981.1 18288.9 18603.6 18643.7 18827.3 19032.2 5456.0 5564.8 5736.8 5774.0 5786.4 5762.5 5764.5 5780.2 5795.2 5821.3 5764.6 5777.6 5799.9 5804.6 5824.8 5686.0 5762.3 5765.1 5787.1 5805.8 5394.0 5598.3 5617.3 5628.9 5648.9 13243.7 13430.4 13445.3 13670.9 13700.5 2366.0 2492.9 2574.0 2836.4 3031.3 10029.1 10138.3 10348.6 10360.8 10424.5 1970.8 2032.3 2059.4 2071.3 2107.2 63146.4 79515.0 80698.0 82693.0 86537.1 8994.0 9564.7 9607.6 9834.5 9999.7 13191.7 13248.7 13250.9 13295.5 13309.0 7636.5 7789.0 7848.8 7902.3 7916.0 7609.6 7759.8 7883.4 7889.6 7970.2 3982.1 4142.7 4143.1 4196.5 4203.0 1957.2 2006.8 2045.6 2056.7 2091.8 988.2 1003.0 1055.5 1138.1 1153.4 17792.9 18174.2 18220.4 18275.2 18504.0 994.5 1017.0 1035.4 1044.4 1112.8 9949.8 10237.3 10244.6 10273.9 10317.7 492820.0 505549.0 506910.0 510223.0 527333.0 56211.4 73210.6 93033.0 93124.5 93167.5 1088.2 1104.5 1109.4 1131.1 1131.7 15829.8 15989.3 16134.1 16149.8 16285.0 37808.6 38313.2 38836.6 39312.8 39318.8 50903.0 52740.7 58998.7 59662.0 59788.0 7615.7 8013.5 8260.5 9007.5 9036.8 13181.3 13584.0 13629.0 13642.0 13681.5 11593.9 11812.9 11817.1 11836.9 11839.6 11624.2 11802.8 11874.3 11929.4 12063.5 11916.3 11940.8 12149.6 12197.6 12204.1 7490.7 7887.2 8068.6 8098.8 8238.4 8913.3 10423.9 10941.8 10944.2 11437.5 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | [#3] mootools.html Cycles:180 Average:5672.54 Median:4792.63 stddev:3161.71 (66.0%) stddev-sans-first:3155.13 10:26:09 INFO - PROCESS | 3431 | Values: 1513.7 1522.7 1692.7 1797.4 1807.5 7520.7 7974.3 8351.0 8507.8 8586.0 8401.2 8625.3 8737.0 8743.4 8746.2 2272.9 2306.9 2307.6 2312.4 2312.5 2250.4 2260.2 2312.9 2321.9 2324.8 2244.6 2258.1 2264.8 2317.8 2322.6 2230.2 2239.9 2265.1 2267.9 2277.9 2232.1 2267.5 2271.2 2272.1 2275.7 8606.4 8636.4 8662.7 8665.3 8681.5 4998.4 5118.1 5142.9 5157.0 5183.9 3239.1 3286.2 3426.5 3441.2 3490.6 1050.9 1070.2 1075.8 1089.6 1103.6 11809.6 11815.0 11838.2 11914.6 11930.6 4443.8 4450.9 4506.1 4530.5 4710.8 10035.9 10041.2 10046.2 10049.3 10065.0 5169.7 5191.5 5202.4 5216.6 5261.4 4198.1 4729.1 4753.9 4831.4 4874.1 3798.9 3871.7 3942.4 3971.0 4100.5 1195.6 1198.8 1205.2 1206.8 1212.5 876.0 979.6 1041.4 1067.5 1070.9 6198.9 6236.8 6275.0 6319.5 6353.7 464.5 465.0 466.8 467.4 468.7 4345.1 4416.6 4423.8 4437.7 4443.2 10247.2 10659.8 10685.5 10689.0 10699.0 10048.4 10450.5 10522.7 10620.3 10645.1 7878.3 8080.5 8159.1 8176.9 8182.4 5903.7 6110.5 6132.6 6149.6 6153.9 9302.6 9352.5 9383.0 9434.6 9573.6 9390.2 9420.2 9496.1 9582.8 9687.1 7663.7 7707.4 7747.4 7786.1 7817.7 8074.5 8146.5 8170.8 8190.3 8231.3 6922.3 7138.9 7336.7 7398.5 7441.0 7227.4 7243.8 7257.1 7257.9 7289.3 6981.4 6982.4 6988.3 6997.3 7043.0 5220.3 5285.6 5448.7 5482.9 5533.4 5332.2 5413.4 5440.5 5626.8 5633.1 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | [#4] prototype.html Cycles:180 Average:4896.76 Median:5548.76 stddev:1434.32 (25.8%) stddev-sans-first:1396.89 10:26:09 INFO - PROCESS | 3431 | Values: 335.2 337.4 341.4 342.3 345.1 5438.9 5532.2 5560.8 5693.7 5694.5 5557.1 5572.5 5575.3 5577.2 5586.5 4313.0 4325.5 4337.7 4382.2 4393.5 4086.1 4311.4 4312.4 4351.4 4364.1 4217.4 4238.8 4255.6 4273.3 4284.2 4286.3 4287.9 4290.0 4295.8 4296.7 3656.0 3780.5 3783.3 3784.9 3795.2 5370.4 5370.5 5379.2 5382.9 5403.6 4953.5 4961.4 4978.2 4979.0 4987.4 5479.4 5786.7 5808.0 5842.2 5865.1 4194.6 4226.1 4228.3 4231.0 4238.5 6013.2 6014.3 6025.8 6049.5 6057.6 4197.9 4274.4 4285.7 4293.5 4327.5 4317.4 4353.7 4357.8 4377.0 4382.6 4957.8 4975.7 5018.3 5019.6 5057.4 5765.9 5865.1 5865.2 5882.4 5887.1 1470.9 1480.2 1486.7 1487.1 1504.0 1007.2 1032.6 1036.2 1050.3 1051.8 5531.6 5539.7 5548.8 5550.6 5562.8 5776.9 5807.4 5861.4 5913.2 5939.7 5197.8 5496.1 5496.9 5548.8 5589.2 3142.5 3170.8 3174.9 3177.9 3179.7 5513.4 5822.7 5949.6 6114.6 6115.1 5813.9 5882.6 5905.7 5918.9 5961.2 5880.9 5900.4 5941.8 5969.3 5977.8 5662.6 5811.7 6059.3 6116.2 6203.7 6050.8 6073.2 6132.7 6134.7 6137.8 5992.9 6045.0 6211.7 6218.3 6286.4 4209.1 4238.0 4242.8 4249.2 4251.3 5998.6 6076.8 6100.5 6119.0 6122.3 5704.5 5872.6 5874.8 5944.2 5967.7 5883.7 5900.5 5919.0 5924.7 5946.5 5738.7 5762.7 5777.2 5814.3 5829.8 5524.6 5803.5 5835.5 5860.0 5870.8 5667.8 5795.7 5811.8 5832.8 5845.8 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - PROCESS | 3431 | [#5] yui.html Cycles:180 Average:15064.55 Median:25859.41 stddev:17602.23 (68.1%) stddev-sans-first:17618.81 10:26:09 INFO - PROCESS | 3431 | Values: 754.2 817.2 845.8 847.2 866.6 14052.1 14090.4 14123.2 14135.2 14393.6 14240.5 14243.8 14244.6 14249.3 14305.0 662.3 797.8 826.7 827.0 831.2 823.9 826.3 829.0 829.5 829.7 861.7 862.3 863.5 864.3 870.8 848.9 854.0 854.2 854.6 862.5 629.5 630.2 630.7 631.6 632.5 12597.3 12615.7 12616.1 12654.7 12676.6 14276.3 14283.4 14332.0 14457.1 14491.4 11610.5 11745.8 11776.2 11844.5 12051.0 3774.8 3882.9 3886.0 3941.7 3999.4 54661.7 54804.5 55171.0 55223.2 55882.7 10845.3 10935.2 11069.0 11092.9 11187.8 18434.9 18850.2 18924.4 19601.8 19648.8 8836.0 8915.6 8977.2 9039.7 9044.9 4809.3 4842.0 4928.3 4993.4 5040.3 3271.4 3348.2 3348.8 3352.9 3356.4 617.7 621.4 621.5 627.8 639.2 738.5 757.7 767.5 779.0 790.7 9336.8 9755.5 9799.1 9823.2 10220.0 788.1 797.3 798.2 804.0 815.5 4621.3 4622.2 4757.0 4787.1 4794.1 63450.4 63494.4 64657.4 65472.3 65515.7 57262.0 58413.7 58592.1 59364.7 59365.0 50830.5 53445.7 53672.5 53750.7 54194.7 9203.4 9267.9 9408.4 9434.8 9482.1 33123.3 33562.7 33899.2 34334.0 34822.7 37950.8 38691.8 45721.0 46127.1 46961.8 12277.8 12392.7 12439.8 12578.6 12829.2 12741.4 13067.9 13132.9 13534.4 14018.7 12811.2 12844.5 12994.7 13330.2 13845.4 12221.0 12421.1 12832.7 12885.6 12890.8 10836.6 11080.3 12418.1 12562.9 12924.9 10426.8 10467.9 10679.0 10952.4 11007.2 9884.7 9965.0 10086.7 10613.9 10674.8 10:26:09 INFO - PROCESS | 3431 | -------- Summary: end -------- 10:26:09 INFO - PROCESS | 3431 | 10:26:09 INFO - TEST-INFO | 3431: exit 0 10:26:09 INFO - TEST-OK | dromaeo_css | took 1111632ms 10:26:09 INFO - TEST-START | kraken 10:26:09 INFO - operating with platform_type : linux_ 10:26:09 INFO - Initialising browser for kraken test... 10:26:09 INFO - TEST-INFO | started process 3664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAcTOSL/profile http://localhost:33233/getInfo.html) 10:26:13 INFO - PROCESS | 3664 | 10:26:13 INFO - PROCESS | 3664 | (process:3732): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:26:14 INFO - PROCESS | 3664 | __metrics Screen width/height:1600/1200 10:26:14 INFO - PROCESS | 3664 | colorDepth:24 10:26:14 INFO - PROCESS | 3664 | Browser inner width/height: 1024/697 10:26:14 INFO - PROCESS | 3664 | __metrics 10:26:15 ERROR - PROCESS | 3664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:26:16 INFO - TEST-INFO | 3664: exit 0 10:26:16 INFO - Browser initialized. 10:26:16 INFO - Running cycle 1/1 for kraken test... 10:26:16 INFO - TEST-INFO | started process 3783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAcTOSL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:18 INFO - PROCESS | 3783 | 10:26:18 INFO - PROCESS | 3783 | (process:3843): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:26:28 INFO - PROCESS | 3783 | RSS: Main: 163598336 10:26:28 INFO - PROCESS | 3783 | 10:26:30 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33233/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:31 INFO - PROCESS | 3783 | RSS: Main: 167997440 10:26:31 INFO - PROCESS | 3783 | 10:26:34 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33233/tests/kraken/driver.html?testName=audio-dft) 10:26:34 INFO - PROCESS | 3783 | RSS: Main: 168095744 10:26:34 INFO - PROCESS | 3783 | 10:26:37 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33233/tests/kraken/driver.html?testName=audio-fft) 10:26:38 INFO - PROCESS | 3783 | RSS: Main: 162779136 10:26:38 INFO - PROCESS | 3783 | 10:26:40 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33233/tests/kraken/driver.html?testName=audio-oscillator) 10:26:40 INFO - PROCESS | 3783 | RSS: Main: 163291136 10:26:40 INFO - PROCESS | 3783 | 10:26:43 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:43 INFO - PROCESS | 3783 | RSS: Main: 163651584 10:26:43 INFO - PROCESS | 3783 | 10:26:46 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33233/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:47 INFO - PROCESS | 3783 | RSS: Main: 164126720 10:26:47 INFO - PROCESS | 3783 | 10:26:50 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33233/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:51 INFO - PROCESS | 3783 | RSS: Main: 163942400 10:26:51 INFO - PROCESS | 3783 | 10:26:54 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33233/tests/kraken/driver.html?testName=json-parse-financial) 10:26:54 INFO - PROCESS | 3783 | RSS: Main: 163377152 10:26:54 INFO - PROCESS | 3783 | 10:26:56 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:57 INFO - PROCESS | 3783 | RSS: Main: 163774464 10:26:57 INFO - PROCESS | 3783 | 10:26:59 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:59 INFO - PROCESS | 3783 | RSS: Main: 163225600 10:26:59 INFO - PROCESS | 3783 | 10:27:01 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:02 INFO - PROCESS | 3783 | RSS: Main: 164425728 10:27:02 INFO - PROCESS | 3783 | 10:27:04 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:05 INFO - PROCESS | 3783 | RSS: Main: 164069376 10:27:05 INFO - PROCESS | 3783 | 10:27:08 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:09 INFO - PROCESS | 3783 | RSS: Main: 164327424 10:27:09 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:33233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33233/tests/kraken/driver.html?testName=ai-astar) 10:27:10 INFO - PROCESS | 3783 | RSS: Main: 166080512 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | __start_tp_report 10:27:10 INFO - PROCESS | 3783 | _x_x_mozilla_page_load 10:27:10 INFO - PROCESS | 3783 | _x_x_mozilla_page_load_details 10:27:10 INFO - PROCESS | 3783 | |i|pagename|runs| 10:27:10 INFO - PROCESS | 3783 | |0;ai-astar;111;112;105;114;112;112;111;113;112;111 10:27:10 INFO - PROCESS | 3783 | |1;audio-beat-detection;158;127;151;172;126;155;159;128;178;127 10:27:10 INFO - PROCESS | 3783 | |2;audio-dft;161;162;162;159;162;166;177;162;161;163 10:27:10 INFO - PROCESS | 3783 | |3;audio-fft;75;76;77;163;76;75;75;77;162;76 10:27:10 INFO - PROCESS | 3783 | |4;audio-oscillator;92;92;153;92;93;92;155;92;93;164 10:27:10 INFO - PROCESS | 3783 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;117;116 10:27:10 INFO - PROCESS | 3783 | |6;imaging-darkroom;146;146;147;147;147;147;147;145;148;147 10:27:10 INFO - PROCESS | 3783 | |7;imaging-desaturate;96;95;96;95;96;95;95;95;96;95 10:27:10 INFO - PROCESS | 3783 | |8;json-parse-financial;61;58;61;58;60;58;59;71;65;60 10:27:10 INFO - PROCESS | 3783 | |9;json-stringify-tinderbox;60;60;61;59;60;60;60;60;65;59 10:27:10 INFO - PROCESS | 3783 | |10;stanford-crypto-aes;84;82;80;78;83;80;80;84;81;81 10:27:10 INFO - PROCESS | 3783 | |11;stanford-crypto-ccm;124;141;125;124;137;136;123;129;157;127 10:27:10 INFO - PROCESS | 3783 | |12;stanford-crypto-pbkdf2;166;169;170;171;171;169;172;168;172;169 10:27:10 INFO - PROCESS | 3783 | |13;stanford-crypto-sha256-iterative;65;64;64;64;68;66;65;63;68;67 10:27:10 INFO - PROCESS | 3783 | __end_tp_report 10:27:10 INFO - PROCESS | 3783 | __start_cc_report 10:27:10 INFO - PROCESS | 3783 | _x_x_mozilla_cycle_collect,851 10:27:10 INFO - PROCESS | 3783 | __end_cc_report 10:27:10 INFO - PROCESS | 3783 | __startTimestamp1462555630976__endTimestamp 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | ------- Summary: start ------- 10:27:10 INFO - PROCESS | 3783 | Number of tests: 14 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.41 (2.1%) stddev-sans-first:2.55 10:27:10 INFO - PROCESS | 3783 | Values: 111.0 112.0 105.0 114.0 112.0 112.0 111.0 113.0 112.0 111.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:156.50 stddev:19.78 (12.6%) stddev-sans-first:20.65 10:27:10 INFO - PROCESS | 3783 | Values: 158.0 127.0 151.0 172.0 126.0 155.0 159.0 128.0 178.0 127.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.00 stddev:5.06 (3.1%) stddev-sans-first:5.29 10:27:10 INFO - PROCESS | 3783 | Values: 161.0 162.0 162.0 159.0 162.0 166.0 177.0 162.0 161.0 163.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:36.53 (48.1%) stddev-sans-first:38.15 10:27:10 INFO - PROCESS | 3783 | Values: 75.0 76.0 77.0 163.0 76.0 75.0 75.0 77.0 162.0 76.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:92.00 stddev:31.54 (34.3%) stddev-sans-first:32.63 10:27:10 INFO - PROCESS | 3783 | Values: 92.0 92.0 153.0 92.0 93.0 92.0 155.0 92.0 93.0 164.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:27:10 INFO - PROCESS | 3783 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 10:27:10 INFO - PROCESS | 3783 | Values: 146.0 146.0 147.0 147.0 147.0 147.0 147.0 145.0 148.0 147.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:27:10 INFO - PROCESS | 3783 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.50 stddev:4.07 (6.7%) stddev-sans-first:4.31 10:27:10 INFO - PROCESS | 3783 | Values: 61.0 58.0 61.0 58.0 60.0 58.0 59.0 71.0 65.0 60.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.71 (2.9%) stddev-sans-first:1.81 10:27:10 INFO - PROCESS | 3783 | Values: 60.0 60.0 61.0 59.0 60.0 60.0 60.0 60.0 65.0 59.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:1.95 (2.4%) stddev-sans-first:1.80 10:27:10 INFO - PROCESS | 3783 | Values: 84.0 82.0 80.0 78.0 83.0 80.0 80.0 84.0 81.0 81.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:132.50 stddev:10.74 (8.1%) stddev-sans-first:10.96 10:27:10 INFO - PROCESS | 3783 | Values: 124.0 141.0 125.0 124.0 137.0 136.0 123.0 129.0 157.0 127.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.50 stddev:1.89 (1.1%) stddev-sans-first:1.45 10:27:10 INFO - PROCESS | 3783 | Values: 166.0 169.0 170.0 171.0 171.0 169.0 172.0 168.0 172.0 169.0 10:27:10 INFO - PROCESS | 3783 | 10:27:10 INFO - PROCESS | 3783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.78 (2.7%) stddev-sans-first:1.88 10:27:10 INFO - PROCESS | 3783 | Values: 65.0 64.0 64.0 64.0 68.0 66.0 65.0 63.0 68.0 67.0 10:27:10 INFO - PROCESS | 3783 | -------- Summary: end -------- 10:27:10 INFO - PROCESS | 3783 | 10:27:11 INFO - TEST-INFO | 3783: exit 0 10:27:11 INFO - TEST-OK | kraken | took 62164ms 10:27:11 INFO - SUITE-END | took 1173s 10:27:12 INFO - Completed test suite (00:19:33) 10:27:12 INFO - javascript benchmark 10:27:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.497200447928, 3165.0663054398938, 3199.4400979828524, 3200.231944333359, 3237.3687131009447, 5222.0, 5262.57899368051, 5278.076336641092, 5390.380106287768, 5456.9181462278, 5293.655912365693, 5336.893262134765, 5400.78396864126, 5402.594805389592, 5482.342118945722, 4814.9037019259595, 4872.853814385574, 4961.479044700309, 4983.302337672729, 5041.344625198737, 654.8937756597018, 4822.614190864722, 4823.89050518381, 4926.2364333528185, 4942.233953737176, 4905.460399356068, 4919.803207871681, 4938.185199442088, 4940.925886111711, 4952.479989601094, 4953.2074868020945, 4964.553190212898, 4974.980129073531, 4977.576905962997, 4989.775460104304, 4799.13615549201, 4852.56326930578, 4854.732989685566, 4873.342098816685, 4888.73111978841, 5232.215167724834, 5245.213218017289, 5245.527902488756, 5253.55344795689, 5255.237990491358, 5570.582206334541, 5667.319921609434, 5688.232088668018, 5695.829125126253, 5697.7464957709235, 5766.567507436959, 5885.146653735227, 5896.469317761422, 5901.498372638331, 5946.345901950782, 5405.972970135124, 5431.2396264522995, 5433.728313584305, 5433.8369848904595, 5456.699881506515, 5719.628224165416, 5740.368559458456, 5762.250907382014, 5961.135635332853, 5983.581149319506, 5604.215409842625, 5615.2700148981185, 5624.831255062355, 5626.634268772516, 5664.660120392789, 5699.088145896637, 5701.116326969326, 5704.34400043992, 5713.942860571424, 5715.142728590745, 5566.053770858964, 5661.547076233891, 5686.232358631614, 5737.340205876294, 5748.741306641211, 5785.652860828363, 5789.363170051291, 5792.218050563204, 5792.4497172768515, 5809.564282678816, 4368.563143685606, 4370.694051416434, 4407.162639098561, 4410.6030457259, 4431.578999994996, 3809.0858194033785, 3863.34323165057, 3865.34289170836, 3892.0853599404118, 3923.156521347924, 5382.1119515280325, 5392.757325920343, 5401.6218864679095, 5452.427495112956, 5467.343918729778, 5712.857178570486, 5758.395368486333, 5761.0, 5763.711814409263, 5764.394738552475, 5319.308489896289, 5399.514043736082, 5414.756335964891, 5418.241446197536, 5450.1007333789485, 4932.975335123373, 4935.531124543163, 4949.752512374367, 4986.0, 4992.425871024879, 5869.383714709979, 5883.146943693226, 5913.497352725067, 5915.319738230159, 5926.2295901532525, 5725.6850873202375, 5777.91333129995, 5807.128930660435, 5810.331811841608, 5853.970730146322, 6027.939720602913, 6067.817965461043, 6068.696565171812, 6080.0, 6117.724702388492, 5738.368779434342, 5744.3681195067675, 5792.826215213382, 5795.072788353843, 5800.9419905800405, 5663.235463212578, 5699.7435115419075, 5748.051571490657, 5793.768249269982, 5912.970435147797, 5649.802256920988, 5664.660120392789, 5673.0, 5682.772689092555, 5683.147527870852, 5607.41122182165, 5659.320881494247, 5661.952538780339, 5682.232898558807, 5682.687452190169, 5428.891422171613, 5565.1374037024325, 5580.1629755537, 5631.408702086386, 5678.0915053591225, 5716.199732037601, 5761.164631128379, 5782.710864456676, 5792.942070579409, 5795.449432303924, 5424.728763561885, 5643.689597072201, 5647.971760141173, 5668.319801623831, 5681.715914204356], "value": 5284.026517291843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.2521572387343, 628.8396458902985, 634.9015902535107, 649.2663290481755, 652.8726898254843, 42958.57041429585, 44457.0, 44701.776491117496, 44825.551744482545, 47426.28860567094, 44011.3398299025, 44543.554564454345, 44720.552794472045, 44850.0, 44887.0, 8662.30701543875, 8823.117688231157, 8857.114288571123, 8894.599743011548, 8905.0, 8659.393842431, 8722.040575536686, 8764.430312029697, 8787.0, 8834.558272086402, 8776.07851175627, 8797.912020879774, 8837.823243535126, 8841.823163536725, 8846.911530884705, 8767.167119123706, 8845.911540884574, 8853.867191992125, 8857.734267971971, 8880.200781929658, 8806.987196472424, 8815.691450799191, 8865.556722163867, 8883.333749968713, 8930.553472326423, 41232.79383603093, 41427.0, 41814.0, 41922.37116443256, 41966.0, 3444.121748954001, 3498.912527186815, 3531.4702794581017, 3803.7717736935874, 4167.249895018896, 31800.0, 32209.355812883845, 32287.838560807282, 32388.514172287436, 34062.829685851415, 4268.59448352406, 4288.635465985395, 4295.570442955711, 4370.628496577795, 4549.47681016684, 233281.0, 322442.0, 322735.0, 322769.0, 325054.3747281272, 34978.0, 35834.104147396, 36123.63876361255, 37586.43620345697, 57182.428175718545, 36309.0, 36386.8180659095, 36527.26945461129, 36705.63294367075, 36771.81614091966, 14093.577192684235, 14213.076150050214, 14243.928780356031, 14259.429622815178, 14282.714345713235, 11835.11236657254, 11883.287002779862, 11942.223755455867, 11988.88011119895, 11994.940025299818, 8518.318534517224, 8530.616122274512, 8545.572721363907, 8598.785030374165, 8611.354148438892, 3305.173706573357, 3371.3425881953276, 3377.834647046765, 3378.054144839449, 3451.033710561047, 986.1962500562018, 1051.3481641382239, 1092.229977865603, 1193.3198077096145, 1254.5107408110844, 31387.0, 32002.0, 32069.0, 32817.0, 32825.50761738576, 1096.8957948994832, 1138.0610995928391, 1158.5365853658436, 1181.7518321152481, 1236.8082947143207, 16842.494725158263, 16886.57783555421, 17035.91482042582, 17072.02806961582, 17255.56861078483, 483106.0, 486101.0, 488183.0, 488273.0, 490496.0, 57695.42304576984, 58573.70713146407, 58626.0, 58649.0, 58663.413365865796, 1291.3414158778903, 1371.7119404924879, 1411.1039489923767, 1412.894032947533, 1422.5803388000566, 30178.69821301759, 30722.231944201572, 31055.68944310528, 31105.222369440944, 31408.842955785076, 51354.48645513497, 51660.22509662283, 51717.48282517127, 51794.22308665298, 51939.0, 389878.0, 390071.0, 390133.0, 390424.0, 390795.0, 28230.0, 28952.855235723688, 28957.85521072381, 29071.0, 29072.56391154092, 48188.5181148198, 48376.0, 48800.0, 48996.5100348992, 49077.0, 40017.1996560073, 40683.1863362737, 41256.79371603243, 41484.37773433341, 41818.58181418147, 39090.218195636495, 40515.79742101271, 41380.1723965525, 41894.0, 42242.0, 41028.384574232005, 41625.37561936513, 42423.787881060394, 42664.0, 45434.0, 35532.0, 36605.594021046745, 36855.81572092122, 37507.24985500329, 37508.81245593754, 28095.859520702266, 28469.0, 28474.0, 28518.714812851606, 28852.567211492264], "value": 18689.740753712194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.74933417280016, 396.2965735818921, 401.9075612609099, 406.4127335999482, 416.35049323056035, 13752.312384380766, 17438.73841892371, 18710.81289187111, 18896.527586810338, 18981.145848436838, 18288.908555457238, 18603.627927441445, 18643.720344194848, 18827.341043063494, 19032.2387104516, 5456.0, 5564.8052318168975, 5736.770529178828, 5774.018416869142, 5786.392428794979, 5762.481376676098, 5764.452377024197, 5780.161876527901, 5795.15970184323, 5821.301443826746, 5764.62128475552, 5777.566682498829, 5799.9130013049835, 5804.606894345347, 5824.796132135376, 5685.971570142144, 5762.30852297727, 5765.106408506667, 5787.074068149076, 5805.825825225229, 5394.0, 5598.300212473441, 5617.269754931874, 5628.915566266509, 5648.85877853057, 13243.668908277274, 13430.395632196574, 13445.32773361328, 13670.93164534171, 13700.52048178319, 2365.988170059156, 2492.8628925409093, 2574.0, 2836.4327134572964, 3031.272494601302, 10029.147522460527, 10138.341007834468, 10348.58605655773, 10360.79278414435, 10424.530896109618, 1970.7733610634816, 2032.2582257476063, 2059.3718915730697, 2071.337172104927, 2107.1782005018053, 63146.368536314505, 79515.0, 80698.0, 82693.0, 86537.13462865354, 8993.955030224806, 9564.713058608253, 9607.615695372107, 9834.508274586386, 9999.650012249682, 13191.736165276641, 13248.668783280495, 13250.867491325156, 13295.468181272641, 13309.0, 7636.541807491457, 7788.961055194688, 7848.7645370638975, 7902.288794008567, 7916.0, 7609.619519024027, 7759.7672069838, 7883.448158628956, 7889.566073865993, 7970.202979701983, 3982.123932734794, 4142.668586513072, 4143.129942712004, 4196.454460920122, 4202.957970420257, 1957.2366776956999, 2006.829419499359, 2045.6317862784842, 2056.7223424837753, 2091.7699053104147, 988.2439933450916, 1002.9589784787921, 1055.498638146874, 1138.1293310617218, 1153.423288355822, 17792.91103544474, 18174.18216180275, 18220.36228731988, 18275.177617007266, 18504.0, 994.537540043883, 1016.9644062457778, 1035.358077991635, 1044.4151275285865, 1112.8330750387345, 9949.816493146465, 10237.283390162765, 10244.64143754965, 10273.9486302568, 10317.74205644865, 492820.0, 505549.0, 506910.0, 510223.0, 527333.0, 56211.43788562062, 73210.63394682993, 93033.0, 93124.53437732904, 93167.5341623301, 1088.1892989722708, 1104.5305745058158, 1109.4064675398783, 1131.0668698323916, 1131.6605018494583, 15829.841701582836, 15989.280482378554, 16134.112623805804, 16149.838501615304, 16285.0, 37808.62191378051, 38313.233735325695, 38836.6116338833, 39312.803435982634, 39318.83746393976, 50903.0, 52740.736296318275, 58998.705006474695, 59662.0, 59788.0, 7615.65729542183, 8013.479123857164, 8260.545669987969, 9007.459552426875, 9036.774080648036, 13181.275029873448, 13584.0, 13629.0, 13642.0, 13681.452741890611, 11593.942030289794, 11812.881871181178, 11817.113716471471, 11836.934675879213, 11839.644810655695, 11624.186306958432, 11802.763944720886, 11874.287542747463, 11929.422319693036, 12063.517459301529, 11916.344601047025, 11940.820887686517, 12149.574764883188, 12197.634070977885, 12204.084693647834, 7490.662920168715, 7887.171846955987, 8068.636911338886, 8098.83802323962, 8238.423310368216, 8913.331500137387, 10423.895761042293, 10941.781164376827, 10944.179186560881, 11437.485313160762], "value": 8928.650576348919, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.6518600721834, 1522.7106849698557, 1692.737625668021, 1797.3799039331427, 1807.4758320087176, 7520.6991720331125, 7974.2823145916855, 8350.95824520878, 8507.829843403128, 8586.0, 8401.159884011597, 8625.309975201984, 8737.038925718165, 8743.387962842604, 8746.169113934182, 2272.8977196026176, 2306.9192578259763, 2307.5961706701346, 2312.4450131968374, 2312.5143719818857, 2250.414892128042, 2260.175036111824, 2312.8843557822124, 2321.93034208974, 2324.8023917966993, 2244.607193741097, 2258.1306197114145, 2264.841461097724, 2317.79139877411, 2322.6412548659055, 2230.152542034033, 2239.876806775627, 2265.1166045242367, 2267.8639281643154, 2277.87471689057, 2232.0848452134546, 2267.455810605459, 2271.205078222609, 2272.1138755885218, 2275.7382900966436, 8606.397552171351, 8636.39545231834, 8662.653493860238, 8665.263452606472, 8681.479111253282, 4998.375203099613, 5118.053160165344, 5142.922856157161, 5156.994386094713, 5183.896322073538, 3239.1092449576317, 3286.2277364819247, 3426.468897320919, 3441.208522039945, 3490.581130264359, 1050.9369437833677, 1070.1599244592958, 1075.8063548561256, 1089.624079692505, 1103.5530610102921, 11809.586664466788, 11815.0, 11838.230515016496, 11914.642560723192, 11930.642080737505, 4443.800028998703, 4450.931776373647, 4506.121306345297, 4530.524294949048, 4710.835120770825, 10035.899641003496, 10041.246906482043, 10046.19630429564, 10049.346792458467, 10065.0, 5169.689818610896, 5191.480851914778, 5202.4277329493725, 5216.63483556155, 5261.447548007481, 4198.1393814268, 4729.07782982322, 4753.857384278477, 4831.396075490564, 4874.147024270738, 3798.9430158547643, 3871.7483363581277, 3942.3889297158985, 3970.9801450993136, 4100.466939297872, 1195.6293548999663, 1198.7662405830954, 1205.1563905266173, 1206.8250103734908, 1212.4968138222716, 875.9605817738217, 979.588572799426, 1041.4063983529315, 1067.4769363012067, 1070.930389524694, 6198.907016394758, 6236.75052997875, 6274.968625156845, 6319.526035547352, 6353.745850166034, 464.5192226046026, 464.9628029757611, 466.7689493700572, 467.3503829676752, 468.6859803931306, 4345.087531618396, 4416.6025057744955, 4423.778811059434, 4437.711548749321, 4443.2224360736745, 10247.180225582084, 10659.84010239847, 10685.519151638195, 10689.0, 10699.0, 10048.447335396624, 10450.529726162342, 10522.736931576772, 10620.256582039183, 10645.148388128931, 7878.330341920886, 8080.474769139987, 8159.143289954588, 8176.877346839802, 8182.386321025947, 5903.734331954986, 6110.450059494667, 6132.59119371846, 6149.631022138686, 6153.907691384543, 9302.581383837609, 9352.485613291334, 9382.95308523453, 9434.575444104894, 9573.569189386355, 9390.24878009744, 9420.152186303265, 9496.14534691881, 9582.808343833223, 9687.079727425884, 7663.731769388268, 7707.383409327353, 7747.418943579141, 7786.143524212445, 7817.6872925084635, 8074.475159114639, 8146.511209327459, 8170.836583268182, 8190.303824175012, 8231.34149268069, 6922.273161317989, 7138.893293166356, 7336.669849856663, 7398.482106252511, 7440.962795185989, 7227.421806255382, 7243.818904527429, 7257.092863392076, 7257.854842903218, 7289.271072892669, 6981.441484681111, 6982.371586557234, 6988.301169882971, 6997.335253150943, 7043.049188359506, 5220.347456567929, 5285.63000589955, 5448.673079615236, 5482.890342193214, 5533.446655334435, 5332.200169974535, 5413.350397952271, 5440.455954404528, 5626.774929002794, 5633.126865335879], "value": 4497.453015546883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.21524347212414, 337.4314280437463, 341.3820984018926, 342.28804087497997, 345.0511094490152, 5438.945610543893, 5532.197831314457, 5560.777568897244, 5693.686847223401, 5694.515966142878, 5557.138358649847, 5572.4706152915505, 5575.330960284761, 5577.21918931349, 5586.458161536501, 4313.0, 4325.502567204764, 4337.652987760972, 4382.211201983634, 4393.450818647669, 4086.1010577672864, 4311.353297005443, 4312.361302704968, 4351.412559304501, 4364.061726728753, 4217.430646862665, 4238.766867822269, 4255.616924499534, 4273.29490634045, 4284.243460181327, 4286.271333873249, 4287.892802679927, 4290.034742182999, 4295.763732994684, 4296.720713153635, 3655.976326628548, 3780.546334439857, 3783.3190025795348, 3784.924301513954, 3795.203007368456, 5370.382406023279, 5370.462953704638, 5379.193121031837, 5382.892342153135, 5403.621746477748, 4953.529414705597, 4961.3798275215595, 4978.178600530908, 4978.975105124451, 4987.426445958725, 5479.369872464677, 5786.710664466802, 5807.970960145214, 5842.2405087338375, 5865.120231965197, 4194.622483976456, 4226.1336426032585, 4228.344606585984, 4231.032569855032, 4238.533761286256, 6013.218281623361, 6014.338422773491, 6025.789097381615, 6049.546284028672, 6057.575969682124, 4197.853075142355, 4274.380214868826, 4285.657147428198, 4293.475816085307, 4327.545607711208, 4317.395564620955, 4353.673474489426, 4357.8451710296795, 4376.993291542963, 4382.627476664456, 4957.7769000395065, 4975.676581022222, 5018.322526458955, 5019.598432125421, 5057.393112826484, 5765.942340576625, 5865.149553314745, 5865.20819689345, 5882.382349853289, 5887.057271100526, 1470.948271985514, 1480.2376775960388, 1486.680363721805, 1487.137460273039, 1504.0223854494448, 1007.2093406675724, 1032.5611615063567, 1036.2176556699644, 1050.2963014780116, 1051.7633532455136, 5531.612787104945, 5539.723013849291, 5548.77804887808, 5550.612346913272, 5562.833115006556, 5776.913346299809, 5807.448292412214, 5861.413858614104, 5913.201717768132, 5939.673317967467, 5197.818076367309, 5496.076373269324, 5496.862578435571, 5548.750306236229, 5589.217509548666, 3142.4972004479173, 3170.8097514149226, 3174.8888788892277, 3177.936441271208, 3179.666135055832, 5513.434887868194, 5822.650640961471, 5949.6430214187285, 6114.633122012693, 6115.082737589397, 5813.854653633693, 5882.55880808941, 5905.675187864623, 5918.869207085446, 5961.225040744675, 5880.852978675482, 5900.43945825146, 5941.792037278675, 5969.31352894414, 5977.790777322686, 5662.57530685192, 5811.680357580204, 6059.303180134341, 6116.235470566179, 6203.720832562455, 6050.761218349239, 6073.180120683651, 6132.693365331805, 6134.693265336626, 6137.7851775187655, 5992.850178745566, 6044.969775151272, 6211.65835879031, 6218.31598524171, 6286.402791734778, 4209.116085622054, 4238.0, 4242.809073591634, 4249.171411574837, 4251.277282861859, 5998.620317327127, 6076.848078798065, 6100.511959043355, 6118.969405152946, 6122.2959359674205, 5704.515116215168, 5872.618279811799, 5874.765009399747, 5944.197533332945, 5967.731452084753, 5883.705814709162, 5900.498457630978, 5918.970405147947, 5924.733386997682, 5946.494547963299, 5738.741756620879, 5762.683052432157, 5777.16231146473, 5814.331351894586, 5829.795957141479, 5524.640898341595, 5803.47768700819, 5835.533157347317, 5860.0, 5870.765169393177, 5667.761234312506, 5795.652260864362, 5811.796587119599, 5832.825015249549, 5845.824625261249], "value": 4440.183316941548, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.2005474197351, 817.1624085312556, 845.8392905347984, 847.2036285891262, 866.6490071521036, 14052.086614370059, 14090.436382544685, 14123.152610843357, 14135.151890886542, 14393.568192954215, 14240.501582444616, 14243.78634320486, 14244.643883902907, 14249.287535623229, 14305.0, 662.2979641579917, 797.8204903896635, 826.6817275348974, 826.9586520673943, 831.1522247307743, 823.8681810910256, 826.3389288569151, 828.9626966786509, 829.4732844643664, 829.7054545636303, 861.7371701631, 862.3187681731456, 863.4603372891943, 864.2912811494577, 870.8345414371249, 848.9151084891492, 853.9530325832077, 854.1842540373927, 854.5513605357144, 862.482510493705, 629.5058379172374, 630.1933525087849, 630.6783540394385, 631.6399652198248, 632.4687262699355, 12597.307148106851, 12615.747685046339, 12616.116871818977, 12654.683632909158, 12676.556320528738, 14276.286185690778, 14283.35724892372, 14332.0, 14457.132572045712, 14491.42034318626, 11610.535578576846, 11745.765084698343, 11776.175667703264, 11844.466998985066, 12051.0, 3774.830132644038, 3882.864099756495, 3886.0, 3941.7043721720984, 3999.42008408782, 54661.72669136629, 54804.451955480734, 55171.0, 55223.17165242484, 55882.720586396805, 10845.295055821347, 10935.179861510418, 11069.0, 11092.944535277433, 11187.832182517106, 18434.90782546079, 18850.15174317159, 18924.43226703201, 19601.80398196028, 19648.803511964696, 8836.0, 8915.643374265086, 8977.23693486061, 9039.728808135766, 9044.909550904407, 4809.302651115569, 4842.007388485352, 4928.334674818925, 4993.350864387607, 5040.31955685985, 3271.378438096754, 3348.2299071213756, 3348.8325583720716, 3352.9329413411597, 3356.429407000816, 617.6695467924638, 621.3941407128104, 621.4996927473337, 627.8399008252866, 639.216959224955, 738.4683028219673, 757.7499425189674, 767.5087943716027, 779.0, 790.6916302641974, 9336.813263734823, 9755.512224388753, 9799.11807937289, 9823.214142868554, 10220.0, 788.0700773087812, 797.2943944609062, 798.1659166171365, 803.9718609848627, 815.5106935838568, 4621.2837010263465, 4622.19111655459, 4757.048590281957, 4787.0904528139545, 4794.113089078532, 63450.36549634537, 63494.36505634977, 64657.35342646608, 65472.34527654663, 65515.67242163759, 57262.0, 58413.70793146007, 58592.12111818326, 59364.70317648384, 59365.0, 50830.49169508258, 53445.7327713359, 53672.46327536675, 53750.7312463443, 54194.7290263554, 9203.447793132433, 9267.87457205569, 9408.388454750419, 9434.811303774024, 9482.099200575934, 33123.33753324968, 33562.664373355954, 33899.15252118717, 34334.0, 34822.651773482954, 37950.810245949695, 38691.80654096712, 45721.0, 46127.07745845131, 46961.76519117383, 12277.815832762337, 12392.704664451445, 12439.813402798783, 12578.55975040869, 12829.166104203197, 12741.362931853186, 13067.869321306665, 13132.934335328644, 13534.390952406968, 14018.719625607635, 12811.231326120462, 12844.486220551073, 12994.675133121747, 13330.200187988752, 13845.446182152602, 12221.0, 12421.068419868727, 12832.743345133233, 12885.613431597067, 12890.806637900252, 10836.620718274822, 11080.335179889233, 12418.130730848754, 12562.937185314015, 12924.935375323063, 10426.843597346198, 10467.895321046692, 10679.0, 10952.390446190318, 11007.174461915549, 9884.703458896245, 9965.0, 10086.747831304276, 10613.893861061291, 10674.839877402], "value": 6862.174766195986, "unit": "score"}], "name": "dromaeo_css", "value": 7031.329034370942, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 105.0, 114.0, 112.0, 112.0, 111.0, 113.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 151.0, 172.0, 126.0, 155.0, 159.0, 128.0, 178.0, 127.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 159.0, 162.0, 166.0, 177.0, 162.0, 161.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 163.0, 76.0, 75.0, 75.0, 77.0, 162.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 153.0, 92.0, 93.0, 92.0, 155.0, 92.0, 93.0, 164.0], "value": 111.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 145.0, 148.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 61.0, 58.0, 60.0, 58.0, 59.0, 71.0, 65.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0, 60.0, 65.0, 59.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 80.0, 78.0, 83.0, 80.0, 80.0, 84.0, 81.0, 81.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 141.0, 125.0, 124.0, 137.0, 136.0, 123.0, 129.0, 157.0, 127.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 170.0, 171.0, 171.0, 169.0, 172.0, 168.0, 172.0, 169.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 68.0, 66.0, 65.0, 63.0, 68.0, 67.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1557.4, "alertThreshold": 2.0}]} 10:27:12 INFO - Return code: 0 10:27:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:27:12 ERROR - # TBPL SUCCESS # 10:27:12 INFO - Running post-action listener: _resource_record_post_action 10:27:12 INFO - ##### 10:27:12 INFO - ##### Finished run-tests step (success) 10:27:12 INFO - ##### 10:27:12 INFO - Running post-run listener: _resource_record_post_run 10:27:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7958528; Write bytes: 433668096; Read time: 2120; Write time: 453552 10:27:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 74424320; Read time: 0; Write time: 46164 10:27:13 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6221824; Write bytes: 344076288; Read time: 2040; Write time: 383396 10:27:13 INFO - Running post-run listener: _upload_blobber_files 10:27:13 INFO - Blob upload gear active. 10:27:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:13 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 10:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:27:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:14 INFO - (blobuploader) - INFO - Done attempting. 10:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:15 INFO - (blobuploader) - INFO - Done attempting. 10:27:15 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:15 INFO - Return code: 0 10:27:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac0699c43c086cc7b882e77be624d20a30572d657bf620407c01744a72345af236862c5dbb796c39bd7e368df724ff06713cace27cdf79044aae3fbe4f98f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/553372f992639991dc0b3bfca6e5540e9490b2f0696055c418b603704572781fdd3a5969525b7a2eaf175b153f22054084dc435007c99ee0c67adff92f3658f2"} 10:27:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:15 INFO - Contents: 10:27:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac0699c43c086cc7b882e77be624d20a30572d657bf620407c01744a72345af236862c5dbb796c39bd7e368df724ff06713cace27cdf79044aae3fbe4f98f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/553372f992639991dc0b3bfca6e5540e9490b2f0696055c418b603704572781fdd3a5969525b7a2eaf175b153f22054084dc435007c99ee0c67adff92f3658f2"} 10:27:15 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:15 INFO - Copying logs to upload dir... 10:27:15 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.208847 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-06 10:27:15.473571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 10:27:15.476922) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac0699c43c086cc7b882e77be624d20a30572d657bf620407c01744a72345af236862c5dbb796c39bd7e368df724ff06713cace27cdf79044aae3fbe4f98f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/553372f992639991dc0b3bfca6e5540e9490b2f0696055c418b603704572781fdd3a5969525b7a2eaf175b153f22054084dc435007c99ee0c67adff92f3658f2"} build_url:https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/KFic9jO5RFCuZbseslicWg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ac0699c43c086cc7b882e77be624d20a30572d657bf620407c01744a72345af236862c5dbb796c39bd7e368df724ff06713cace27cdf79044aae3fbe4f98f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/553372f992639991dc0b3bfca6e5540e9490b2f0696055c418b603704572781fdd3a5969525b7a2eaf175b153f22054084dc435007c99ee0c67adff92f3658f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 10:27:15.501305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:27:15.501619) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462552985.383078-1244400055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:27:15.583687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 10:27:15.584022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 10:27:15.584313) ========= ========= Total master_lag: 0.15 =========