builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1461021135.93 results: success (0) buildid: 20160418151421 builduid: c837f8bcbe4e4b449ba5f5ddb31d122d revision: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:15.934034) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:15.934397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:15.934714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:15.953158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:15.953568) ========= 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=0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 16:12:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-04-18 16:12:16 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.078225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.078538) ========= 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=0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.132042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.132880) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 67ac40fb8f680ea5e03805552187ba1b5e8392a1 --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 67ac40fb8f680ea5e03805552187ba1b5e8392a1 --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=0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 16:12:16,269 truncating revision to first 12 chars 2016-04-18 16:12:16,269 Setting DEBUG logging. 2016-04-18 16:12:16,269 attempt 1/10 2016-04-18 16:12:16,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/67ac40fb8f68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 16:12:16,616 unpacking tar archive at: mozilla-central-67ac40fb8f68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.791333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.791639) ========= script_repo_revision: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.792050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.792318) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:12:16.803303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-18 16:12:16.803572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:12:17 INFO - MultiFileLogger online at 20160418 16:12:17 in /builds/slave/test 16:12:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:12:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:17 INFO - {'append_to_log': False, 16:12:17 INFO - 'base_work_dir': '/builds/slave/test', 16:12:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:12:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:17 INFO - 'branch': 'Firefox-Non-PGO', 16:12:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:17 INFO - 'config_files': ('talos/linux_config.py',), 16:12:17 INFO - 'default_actions': ('clobber', 16:12:17 INFO - 'read-buildbot-config', 16:12:17 INFO - 'download-and-extract', 16:12:17 INFO - 'populate-webroot', 16:12:17 INFO - 'create-virtualenv', 16:12:17 INFO - 'install', 16:12:17 INFO - 'run-tests'), 16:12:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:17 INFO - 'download_minidump_stackwalk': True, 16:12:17 INFO - 'download_symbols': 'ondemand', 16:12:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:17 INFO - 'installer_path': 'installer.exe', 16:12:17 INFO - 'log_level': 'info', 16:12:17 INFO - 'log_name': 'talos', 16:12:17 INFO - 'log_to_console': True, 16:12:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:12:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:12:17 INFO - 'opt_config_files': (), 16:12:17 INFO - 'pip_index': False, 16:12:17 INFO - 'sps_profile': False, 16:12:17 INFO - 'sps_profile_interval': 0, 16:12:17 INFO - 'suite': 'dromaeojs-e10s', 16:12:17 INFO - 'system_bits': '32', 16:12:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:17 INFO - 'title': 'talos-linux64-ix-058', 16:12:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:17 INFO - 'use_talos_json': True, 16:12:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:17 INFO - 'work_dir': 'build'} 16:12:17 INFO - ##### 16:12:17 INFO - ##### Running clobber step. 16:12:17 INFO - ##### 16:12:17 INFO - Running pre-action listener: _resource_record_pre_action 16:12:17 INFO - Running main action method: clobber 16:12:17 INFO - rmtree: /builds/slave/test/build 16:12:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:17 INFO - Running post-action listener: _resource_record_post_action 16:12:17 INFO - ##### 16:12:17 INFO - ##### Running read-buildbot-config step. 16:12:17 INFO - ##### 16:12:17 INFO - Running pre-action listener: _resource_record_pre_action 16:12:17 INFO - Running main action method: read_buildbot_config 16:12:17 INFO - Using buildbot properties: 16:12:17 INFO - { 16:12:17 INFO - "project": "", 16:12:17 INFO - "product": "firefox", 16:12:17 INFO - "script_repo_revision": "production", 16:12:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:12:17 INFO - "repository": "", 16:12:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:12:17 INFO - "buildid": "20160418151421", 16:12:17 INFO - "pgo_build": "False", 16:12:17 INFO - "basedir": "/builds/slave/test", 16:12:17 INFO - "buildnumber": 31, 16:12:17 INFO - "slavename": "talos-linux64-ix-058", 16:12:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:12:17 INFO - "platform": "ubuntu64_hw", 16:12:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:12:17 INFO - "branch": "mozilla-central", 16:12:17 INFO - "repo_path": "mozilla-central", 16:12:17 INFO - "revision": "67ac40fb8f680ea5e03805552187ba1b5e8392a1", 16:12:17 INFO - "stage_platform": "linux64", 16:12:17 INFO - "builduid": "c837f8bcbe4e4b449ba5f5ddb31d122d", 16:12:17 INFO - "slavebuilddir": "test" 16:12:17 INFO - } 16:12:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:12:17 INFO - Running post-action listener: _resource_record_post_action 16:12:17 INFO - ##### 16:12:17 INFO - ##### Running download-and-extract step. 16:12:17 INFO - ##### 16:12:17 INFO - Running pre-action listener: _resource_record_pre_action 16:12:17 INFO - Running main action method: download_and_extract 16:12:17 INFO - mkdir: /builds/slave/test/build/tests 16:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:17 INFO - https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:12:23 INFO - Downloaded 1361 bytes. 16:12:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:12:23 INFO - Using the following test package requirements: 16:12:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:12:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:12:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'jsshell-linux-x86_64.zip'], 16:12:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:12:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:12:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:12:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:12:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:12:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:23 INFO - https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:27 INFO - Downloaded 22209820 bytes. 16:12:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:12:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:12:28 INFO - Return code: 0 16:12:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:28 INFO - https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:31 INFO - Downloaded 22209820 bytes. 16:12:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:12:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:12:32 INFO - Return code: 0 16:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:32 INFO - https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:12:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:12:34 INFO - Downloaded 10845952 bytes. 16:12:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:12:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:12:34 INFO - Return code: 0 16:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:34 INFO - https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:12:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:12:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:12:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:12:39 INFO - Downloaded 54451002 bytes. 16:12:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:12:39 INFO - mkdir: /builds/slave/test/properties 16:12:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:39 INFO - Contents: 16:12:39 INFO - build_url:https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:12:40 INFO - Running post-action listener: _resource_record_post_action 16:12:40 INFO - Running post-action listener: set_extra_try_arguments 16:12:40 INFO - ##### 16:12:40 INFO - ##### Running populate-webroot step. 16:12:40 INFO - ##### 16:12:40 INFO - Running pre-action listener: _resource_record_pre_action 16:12:40 INFO - Running main action method: populate_webroot 16:12:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:40 INFO - '--tppagecycles', 16:12:40 INFO - '7'], 16:12:40 INFO - 'tests': ['tsvgm']}}, 16:12:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['damp', 'tps']}, 16:12:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'tests': ['damp', 'tps']}, 16:12:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['dromaeo_dom']}, 16:12:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['a11yr', 16:12:40 INFO - 'ts_paint', 16:12:40 INFO - 'tpaint', 16:12:40 INFO - 'sessionrestore', 16:12:40 INFO - 'sessionrestore_no_auto_restore', 16:12:40 INFO - 'tabpaint']}, 16:12:40 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:40 INFO - 'ts_paint', 16:12:40 INFO - 'tpaint', 16:12:40 INFO - 'sessionrestore', 16:12:40 INFO - 'sessionrestore_no_auto_restore', 16:12:40 INFO - 'tabpaint']}, 16:12:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:12:40 INFO - 'ts_paint', 16:12:40 INFO - 'tpaint', 16:12:40 INFO - 'sessionrestore', 16:12:40 INFO - 'sessionrestore_no_auto_restore', 16:12:40 INFO - 'tabpaint']}, 16:12:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:12:40 INFO - 'ts_paint', 16:12:40 INFO - 'tpaint', 16:12:40 INFO - 'sessionrestore', 16:12:40 INFO - 'sessionrestore_no_auto_restore', 16:12:40 INFO - 'tabpaint']}, 16:12:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['a11yr', 16:12:40 INFO - 'ts_paint', 16:12:40 INFO - 'tpaint', 16:12:40 INFO - 'sessionrestore', 16:12:40 INFO - 'sessionrestore_no_auto_restore', 16:12:40 INFO - 'tabpaint']}, 16:12:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['a11yr', 16:12:40 INFO - 'ts_paint', 16:12:40 INFO - 'tpaint', 16:12:40 INFO - 'sessionrestore', 16:12:40 INFO - 'sessionrestore_no_auto_restore', 16:12:40 INFO - 'tabpaint']}, 16:12:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['tsvgx', 16:12:40 INFO - 'tsvgr_opacity', 16:12:40 INFO - 'tart', 16:12:40 INFO - 'tscrollx', 16:12:40 INFO - 'cart']}, 16:12:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:40 INFO - 'tsvgr_opacity', 16:12:40 INFO - 'tart', 16:12:40 INFO - 'tscrollx', 16:12:40 INFO - 'cart']}, 16:12:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'talos_options': ['--disable-e10s'], 16:12:40 INFO - 'tests': ['tp5o']}, 16:12:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'tests': ['tp5o']}, 16:12:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'talos_options': ['--disable-e10s', 16:12:40 INFO - '--xperf_path', 16:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:40 INFO - 'tests': ['tp5n']}, 16:12:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:40 INFO - 'talos_options': ['--xperf_path', 16:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:41 INFO - 'tests': ['tp5n']}}, 16:12:41 INFO - 'talos.zip': {'path': '', 16:12:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:41 INFO - Running post-action listener: _resource_record_post_action 16:12:41 INFO - ##### 16:12:41 INFO - ##### Running create-virtualenv step. 16:12:41 INFO - ##### 16:12:41 INFO - Running pre-action listener: _resource_record_pre_action 16:12:41 INFO - Running main action method: create_virtualenv 16:12:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:41 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 16:12:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:41 INFO - Using real prefix '/usr' 16:12:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:41 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:43 INFO - Installing pip.................done. 16:12:43 INFO - Return code: 0 16:12:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:12:43 INFO - Using env: {'DISPLAY': ':0', 16:12:43 INFO - 'HOME': '/home/cltbld', 16:12:43 INFO - 'LANG': 'en_US.UTF-8', 16:12:43 INFO - 'LANGUAGE': 'en_US:en', 16:12:43 INFO - 'LOGNAME': 'cltbld', 16:12:43 INFO - 'MAIL': '/var/mail/cltbld', 16:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:43 INFO - 'MOZ_NO_REMOTE': '1', 16:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:43 INFO - 'NO_EM_RESTART': '1', 16:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:43 INFO - 'PWD': '/builds/slave/test', 16:12:43 INFO - 'SHELL': '/bin/bash', 16:12:43 INFO - 'SHLVL': '1', 16:12:43 INFO - 'TERM': 'linux', 16:12:43 INFO - 'TMOUT': '86400', 16:12:43 INFO - 'USER': 'cltbld', 16:12:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:43 INFO - '_': '/tools/buildbot/bin/python'} 16:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:43 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 16:12:43 INFO - Cleaning up... 16:12:43 INFO - Return code: 0 16:12:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:12:43 INFO - Using env: {'DISPLAY': ':0', 16:12:43 INFO - 'HOME': '/home/cltbld', 16:12:43 INFO - 'LANG': 'en_US.UTF-8', 16:12:43 INFO - 'LANGUAGE': 'en_US:en', 16:12:43 INFO - 'LOGNAME': 'cltbld', 16:12:43 INFO - 'MAIL': '/var/mail/cltbld', 16:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:43 INFO - 'MOZ_NO_REMOTE': '1', 16:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:43 INFO - 'NO_EM_RESTART': '1', 16:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:43 INFO - 'PWD': '/builds/slave/test', 16:12:43 INFO - 'SHELL': '/bin/bash', 16:12:43 INFO - 'SHLVL': '1', 16:12:43 INFO - 'TERM': 'linux', 16:12:43 INFO - 'TMOUT': '86400', 16:12:43 INFO - 'USER': 'cltbld', 16:12:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:43 INFO - '_': '/tools/buildbot/bin/python'} 16:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:44 INFO - Downloading/unpacking psutil>=0.7.1 16:12:44 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 16:12:44 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 16:12:44 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 16:12:44 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 16:12:44 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 16:12:44 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 16:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:46 INFO - Installing collected packages: psutil 16:12:46 INFO - Running setup.py install for psutil 16:12:46 INFO - building 'psutil._psutil_linux' extension 16:12:46 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 16:12:46 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 16:12:46 INFO - building 'psutil._psutil_posix' extension 16:12:46 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 16:12:46 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 16:12:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:46 INFO - Successfully installed psutil 16:12:46 INFO - Cleaning up... 16:12:47 INFO - Return code: 0 16:12:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:12:47 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')]} 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:47 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')]} 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:47 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 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:12:47 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 16:12:47 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 16:12:47 INFO - Using env: {'DISPLAY': ':0', 16:12:47 INFO - 'HOME': '/home/cltbld', 16:12:47 INFO - 'LANG': 'en_US.UTF-8', 16:12:47 INFO - 'LANGUAGE': 'en_US:en', 16:12:47 INFO - 'LOGNAME': 'cltbld', 16:12:47 INFO - 'MAIL': '/var/mail/cltbld', 16:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:47 INFO - 'MOZ_NO_REMOTE': '1', 16:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:47 INFO - 'NO_EM_RESTART': '1', 16:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:47 INFO - 'PWD': '/builds/slave/test', 16:12:47 INFO - 'SHELL': '/bin/bash', 16:12:47 INFO - 'SHLVL': '1', 16:12:47 INFO - 'TERM': 'linux', 16:12:47 INFO - 'TMOUT': '86400', 16:12:47 INFO - 'USER': 'cltbld', 16:12:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:47 INFO - '_': '/tools/buildbot/bin/python'} 16:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:12:49 INFO - Installing collected packages: mozsystemmonitor 16:12:49 INFO - Running setup.py install for mozsystemmonitor 16:12:50 INFO - Successfully installed mozsystemmonitor 16:12:50 INFO - Cleaning up... 16:12:50 INFO - Return code: 0 16:12:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:12:50 INFO - Using env: {'DISPLAY': ':0', 16:12:50 INFO - 'HOME': '/home/cltbld', 16:12:50 INFO - 'LANG': 'en_US.UTF-8', 16:12:50 INFO - 'LANGUAGE': 'en_US:en', 16:12:50 INFO - 'LOGNAME': 'cltbld', 16:12:50 INFO - 'MAIL': '/var/mail/cltbld', 16:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:50 INFO - 'MOZ_NO_REMOTE': '1', 16:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:50 INFO - 'NO_EM_RESTART': '1', 16:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:50 INFO - 'PWD': '/builds/slave/test', 16:12:50 INFO - 'SHELL': '/bin/bash', 16:12:50 INFO - 'SHLVL': '1', 16:12:50 INFO - 'TERM': 'linux', 16:12:50 INFO - 'TMOUT': '86400', 16:12:50 INFO - 'USER': 'cltbld', 16:12:50 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:50 INFO - '_': '/tools/buildbot/bin/python'} 16:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:52 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 INFO - Downloading docopt-0.6.1.tar.gz 16:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:52 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:52 INFO - Running setup.py install for blobuploader 16:12:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:53 INFO - Running setup.py install for requests 16:12:53 INFO - Running setup.py install for docopt 16:12:53 INFO - Successfully installed blobuploader requests docopt 16:12:53 INFO - Cleaning up... 16:12:53 INFO - Return code: 0 16:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:53 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')]} 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:53 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')]} 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:53 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 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:12:53 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 16:12:53 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 16:12:53 INFO - Using env: {'DISPLAY': ':0', 16:12:53 INFO - 'HOME': '/home/cltbld', 16:12:53 INFO - 'LANG': 'en_US.UTF-8', 16:12:53 INFO - 'LANGUAGE': 'en_US:en', 16:12:53 INFO - 'LOGNAME': 'cltbld', 16:12:53 INFO - 'MAIL': '/var/mail/cltbld', 16:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:53 INFO - 'MOZ_NO_REMOTE': '1', 16:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:53 INFO - 'NO_EM_RESTART': '1', 16:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:53 INFO - 'PWD': '/builds/slave/test', 16:12:53 INFO - 'SHELL': '/bin/bash', 16:12:53 INFO - 'SHLVL': '1', 16:12:53 INFO - 'TERM': 'linux', 16:12:53 INFO - 'TMOUT': '86400', 16:12:53 INFO - 'USER': 'cltbld', 16:12:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:53 INFO - '_': '/tools/buildbot/bin/python'} 16:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:53 INFO - Running setup.py (path:/tmp/pip-8RoB0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:53 INFO - Running setup.py (path:/tmp/pip-7atS3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:53 INFO - Running setup.py (path:/tmp/pip-uC9eeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:53 INFO - Running setup.py (path:/tmp/pip-lf8Obs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:54 INFO - Running setup.py (path:/tmp/pip-MMHWse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:54 INFO - Running setup.py (path:/tmp/pip-eCeN1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:54 INFO - Running setup.py (path:/tmp/pip-yfhkxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:54 INFO - Running setup.py (path:/tmp/pip-po5N9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:54 INFO - Running setup.py (path:/tmp/pip-R70Ldx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:54 INFO - Running setup.py (path:/tmp/pip-iSMzOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:54 INFO - Running setup.py (path:/tmp/pip-TI3_3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:54 INFO - Running setup.py (path:/tmp/pip-0xQqbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:54 INFO - Running setup.py (path:/tmp/pip-zGQYCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:54 INFO - Running setup.py (path:/tmp/pip-UmW9PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:54 INFO - Running setup.py (path:/tmp/pip-1j0jpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:54 INFO - Running setup.py (path:/tmp/pip-CfZnf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:54 INFO - Running setup.py (path:/tmp/pip-uVLpyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:54 INFO - Running setup.py install for manifestparser 16:12:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Running setup.py install for mozcrash 16:12:55 INFO - Running setup.py install for mozdebug 16:12:55 INFO - Running setup.py install for mozdevice 16:12:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Running setup.py install for mozfile 16:12:55 INFO - Running setup.py install for mozhttpd 16:12:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Running setup.py install for mozinfo 16:12:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Running setup.py install for mozInstall 16:12:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Running setup.py install for mozleak 16:12:55 INFO - Running setup.py install for mozlog 16:12:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Running setup.py install for moznetwork 16:12:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:56 INFO - Running setup.py install for mozprocess 16:12:56 INFO - Running setup.py install for mozprofile 16:12:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:56 INFO - Running setup.py install for mozrunner 16:12:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:56 INFO - Running setup.py install for mozscreenshot 16:12:56 INFO - Running setup.py install for moztest 16:12:56 INFO - Running setup.py install for mozversion 16:12:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:56 INFO - Cleaning up... 16:12:56 INFO - Return code: 0 16:12:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:12:56 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 16:12:56 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 16:12:56 INFO - Using env: {'DISPLAY': ':0', 16:12:56 INFO - 'HOME': '/home/cltbld', 16:12:56 INFO - 'LANG': 'en_US.UTF-8', 16:12:56 INFO - 'LANGUAGE': 'en_US:en', 16:12:56 INFO - 'LOGNAME': 'cltbld', 16:12:56 INFO - 'MAIL': '/var/mail/cltbld', 16:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:56 INFO - 'MOZ_NO_REMOTE': '1', 16:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:56 INFO - 'NO_EM_RESTART': '1', 16:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:56 INFO - 'PWD': '/builds/slave/test', 16:12:56 INFO - 'SHELL': '/bin/bash', 16:12:56 INFO - 'SHLVL': '1', 16:12:56 INFO - 'TERM': 'linux', 16:12:56 INFO - 'TMOUT': '86400', 16:12:56 INFO - 'USER': 'cltbld', 16:12:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:56 INFO - '_': '/tools/buildbot/bin/python'} 16:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:56 INFO - Running setup.py (path:/tmp/pip-d_DcBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:57 INFO - Running setup.py (path:/tmp/pip-KUmV7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:57 INFO - Running setup.py (path:/tmp/pip-db7Lwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:57 INFO - Running setup.py (path:/tmp/pip-cfzePU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:57 INFO - Running setup.py (path:/tmp/pip-wFzwXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:57 INFO - Running setup.py (path:/tmp/pip-ZDS0yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:57 INFO - Running setup.py (path:/tmp/pip-cOX421-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:57 INFO - Running setup.py (path:/tmp/pip-zZcYcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:57 INFO - Running setup.py (path:/tmp/pip-_KWmcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:57 INFO - Running setup.py (path:/tmp/pip-kGZm3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:57 INFO - Running setup.py (path:/tmp/pip-IGCqm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:57 INFO - Running setup.py (path:/tmp/pip-23pmDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:57 INFO - Running setup.py (path:/tmp/pip-7vtxj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:57 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)) 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:57 INFO - Running setup.py (path:/tmp/pip-HZgPLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:58 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)) 16:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:58 INFO - Running setup.py (path:/tmp/pip-TKVNqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:58 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)) 16:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:58 INFO - Running setup.py (path:/tmp/pip-8iJAwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:58 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)) 16:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:58 INFO - Running setup.py (path:/tmp/pip-8Q2Jze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:00 INFO - Downloading blessings-1.6.tar.gz 16:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:00 INFO - Installing collected packages: blessings 16:13:00 INFO - Running setup.py install for blessings 16:13:00 INFO - Successfully installed blessings 16:13:00 INFO - Cleaning up... 16:13:00 INFO - Return code: 0 16:13:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:00 INFO - Reading from file tmpfile_stdout 16:13:00 INFO - Current package versions: 16:13:00 INFO - argparse == 1.2.1 16:13:00 INFO - blessings == 1.6 16:13:00 INFO - blobuploader == 1.2.4 16:13:00 INFO - docopt == 0.6.1 16:13:00 INFO - manifestparser == 1.1 16:13:00 INFO - mozInstall == 1.12 16:13:00 INFO - mozcrash == 0.17 16:13:00 INFO - mozdebug == 0.1 16:13:00 INFO - mozdevice == 0.48 16:13:00 INFO - mozfile == 1.2 16:13:00 INFO - mozhttpd == 0.7 16:13:00 INFO - mozinfo == 0.9 16:13:00 INFO - mozleak == 0.1 16:13:00 INFO - mozlog == 3.1 16:13:00 INFO - moznetwork == 0.27 16:13:00 INFO - mozprocess == 0.22 16:13:00 INFO - mozprofile == 0.28 16:13:00 INFO - mozrunner == 6.11 16:13:00 INFO - mozscreenshot == 0.1 16:13:00 INFO - mozsystemmonitor == 0.0 16:13:00 INFO - moztest == 0.7 16:13:00 INFO - mozversion == 1.4 16:13:00 INFO - psutil == 3.1.1 16:13:00 INFO - requests == 1.2.3 16:13:00 INFO - wsgiref == 0.1.2 16:13:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:00 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')]} 16:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:00 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')]} 16:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:00 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 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:13:00 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 16:13:00 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 16:13:00 INFO - Using env: {'DISPLAY': ':0', 16:13:00 INFO - 'HOME': '/home/cltbld', 16:13:00 INFO - 'LANG': 'en_US.UTF-8', 16:13:00 INFO - 'LANGUAGE': 'en_US:en', 16:13:00 INFO - 'LOGNAME': 'cltbld', 16:13:00 INFO - 'MAIL': '/var/mail/cltbld', 16:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:00 INFO - 'MOZ_NO_REMOTE': '1', 16:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:00 INFO - 'NO_EM_RESTART': '1', 16:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:00 INFO - 'PWD': '/builds/slave/test', 16:13:00 INFO - 'SHELL': '/bin/bash', 16:13:00 INFO - 'SHLVL': '1', 16:13:00 INFO - 'TERM': 'linux', 16:13:00 INFO - 'TMOUT': '86400', 16:13:00 INFO - 'USER': 'cltbld', 16:13:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:00 INFO - '_': '/tools/buildbot/bin/python'} 16:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 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)) 16:13:00 INFO - Cleaning up... 16:13:00 INFO - Return code: 0 16:13:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:00 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')]} 16:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:00 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')]} 16:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:00 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 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:13:00 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 16:13:00 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 16:13:00 INFO - Using env: {'DISPLAY': ':0', 16:13:00 INFO - 'HOME': '/home/cltbld', 16:13:00 INFO - 'LANG': 'en_US.UTF-8', 16:13:00 INFO - 'LANGUAGE': 'en_US:en', 16:13:00 INFO - 'LOGNAME': 'cltbld', 16:13:00 INFO - 'MAIL': '/var/mail/cltbld', 16:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:00 INFO - 'MOZ_NO_REMOTE': '1', 16:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:00 INFO - 'NO_EM_RESTART': '1', 16:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:00 INFO - 'PWD': '/builds/slave/test', 16:13:00 INFO - 'SHELL': '/bin/bash', 16:13:00 INFO - 'SHLVL': '1', 16:13:00 INFO - 'TERM': 'linux', 16:13:00 INFO - 'TMOUT': '86400', 16:13:00 INFO - 'USER': 'cltbld', 16:13:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:00 INFO - '_': '/tools/buildbot/bin/python'} 16:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:00 INFO - Downloading/unpacking jsonschema 16:13:00 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 16:13:00 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 16:13:00 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 16:13:00 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 16:13:00 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 16:13:00 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 16:13:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:13:02 INFO - Downloading/unpacking functools32 (from jsonschema) 16:13:02 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 16:13:02 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 16:13:02 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 16:13:02 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 16:13:02 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 16:13:02 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 16:13:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:13:03 INFO - warning: no files found matching '*.txt' 16:13:03 INFO - no previously-included directories found matching 'build' 16:13:03 INFO - no previously-included directories found matching 'dist' 16:13:03 INFO - no previously-included directories found matching '.git*' 16:13:03 INFO - Installing collected packages: jsonschema, functools32 16:13:03 INFO - Running setup.py install for functools32 16:13:03 INFO - warning: no files found matching '*.txt' 16:13:03 INFO - no previously-included directories found matching 'build' 16:13:03 INFO - no previously-included directories found matching 'dist' 16:13:03 INFO - no previously-included directories found matching '.git*' 16:13:03 INFO - Successfully installed jsonschema functools32 16:13:03 INFO - Cleaning up... 16:13:03 INFO - Return code: 0 16:13:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe48b29bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, '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': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', '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 16:13: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', 'flake8'] in /builds/slave/test/build 16:13: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 flake8 16:13:03 INFO - Using env: {'DISPLAY': ':0', 16:13:03 INFO - 'HOME': '/home/cltbld', 16:13:03 INFO - 'LANG': 'en_US.UTF-8', 16:13:03 INFO - 'LANGUAGE': 'en_US:en', 16:13:03 INFO - 'LOGNAME': 'cltbld', 16:13:03 INFO - 'MAIL': '/var/mail/cltbld', 16:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:03 INFO - 'MOZ_NO_REMOTE': '1', 16:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:03 INFO - 'NO_EM_RESTART': '1', 16:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:03 INFO - 'PWD': '/builds/slave/test', 16:13:03 INFO - 'SHELL': '/bin/bash', 16:13:03 INFO - 'SHLVL': '1', 16:13:03 INFO - 'TERM': 'linux', 16:13:03 INFO - 'TMOUT': '86400', 16:13:03 INFO - 'USER': 'cltbld', 16:13:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:03 INFO - '_': '/tools/buildbot/bin/python'} 16:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:03 INFO - Downloading/unpacking flake8 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:13:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:13:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:13:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:13:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:13:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:13:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:13:06 INFO - no previously-included directories found matching 'docs/_build' 16:13:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:13:06 INFO - Running setup.py install for pep8 16:13:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:13:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:13:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:13:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:13:06 INFO - no previously-included directories found matching 'docs/_build' 16:13:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:13:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:13:06 INFO - Cleaning up... 16:13:06 INFO - Return code: 0 16:13:06 INFO - Running post-action listener: _resource_record_post_action 16:13:06 INFO - Running post-action listener: _start_resource_monitoring 16:13:06 INFO - Starting resource monitoring. 16:13:06 INFO - ##### 16:13:06 INFO - ##### Running install step. 16:13:06 INFO - ##### 16:13:06 INFO - Running pre-action listener: _resource_record_pre_action 16:13:06 INFO - Running main action method: install 16:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:06 INFO - Reading from file tmpfile_stdout 16:13:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:06 INFO - Reading from file tmpfile_stdout 16:13:06 INFO - Output received: 16:13:06 INFO - Usage: mozinstall [options] installer 16:13:06 INFO - Options: 16:13:06 INFO - -h, --help show this help message and exit 16:13:06 INFO - -d DEST, --destination=DEST 16:13:06 INFO - Directory to install application into. [default: 16:13:06 INFO - "/builds/slave/test"] 16:13:06 INFO - --app=APP Application being installed. [default: firefox] 16:13:06 INFO - mkdir: /builds/slave/test/build/application 16:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:13:22 INFO - Reading from file tmpfile_stdout 16:13:22 INFO - Output received: 16:13:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:22 INFO - Running post-action listener: _resource_record_post_action 16:13:22 INFO - ##### 16:13:22 INFO - ##### Running run-tests step. 16:13:22 INFO - ##### 16:13:22 INFO - Running pre-action listener: _resource_record_pre_action 16:13:22 INFO - Running main action method: run_tests 16:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:22 INFO - Python 2.7.3 16:13:22 INFO - Return code: 0 16:13:22 INFO - grabbing minidump binary from tooltool 16:13:22 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')]} 16:13:22 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 0x19b4640>, '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 0x19b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b59d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:22 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 16:13:22 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 16:13:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:22 INFO - Return code: 0 16:13:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:13:23 INFO - Return code: 0 16:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 16:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 16:13:23 INFO - Using env: {'DISPLAY': ':0', 16:13:23 INFO - 'HOME': '/home/cltbld', 16:13:23 INFO - 'LANG': 'en_US.UTF-8', 16:13:23 INFO - 'LANGUAGE': 'en_US:en', 16:13:23 INFO - 'LOGNAME': 'cltbld', 16:13:23 INFO - 'MAIL': '/var/mail/cltbld', 16:13:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:23 INFO - 'MOZ_NO_REMOTE': '1', 16:13:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:23 INFO - 'NO_EM_RESTART': '1', 16:13:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:23 INFO - 'PWD': '/builds/slave/test', 16:13:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:23 INFO - 'SHELL': '/bin/bash', 16:13:23 INFO - 'SHLVL': '1', 16:13:23 INFO - 'TERM': 'linux', 16:13:23 INFO - 'TMOUT': '86400', 16:13:23 INFO - 'USER': 'cltbld', 16:13:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939', 16:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:23 INFO - '_': '/tools/buildbot/bin/python'} 16:13:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 16:13:23 INFO - mozversion application_buildid: 20160418151421 16:13:23 INFO - mozversion application_changeset: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 16:13:23 INFO - mozversion application_display_name: Nightly 16:13:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:23 INFO - mozversion application_name: Firefox 16:13:23 INFO - mozversion application_remotingname: firefox 16:13:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:13:23 INFO - mozversion application_vendor: Mozilla 16:13:23 INFO - mozversion application_version: 48.0a1 16:13:23 INFO - mozversion platform_buildid: 20160418151421 16:13:23 INFO - mozversion platform_changeset: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 16:13:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:13:23 INFO - mozversion platform_version: 48.0a1 16:13:23 INFO - using testdate: 1461021203 16:13:23 INFO - actual date: 1461021203 16:13:23 INFO - starting webserver on 'localhost:42705' 16:13:23 INFO - SUITE-START | Running 2 tests 16:13:23 INFO - TEST-START | dromaeo_css 16:13:23 INFO - operating with platform_type : linux_ 16:13:23 INFO - Initialising browser for dromaeo_css test... 16:13:23 INFO - TEST-INFO | started process 4856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtdSZn/profile http://localhost:42705/getInfo.html) 16:13:27 INFO - PROCESS | 4856 | 16:13:27 INFO - PROCESS | 4856 | (process:4924): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:13:28 INFO - PROCESS | 4856 | __metrics Screen width/height:1600/1200 16:13:28 INFO - PROCESS | 4856 | colorDepth:24 16:13:28 INFO - PROCESS | 4856 | Browser inner width/height: 1024/697 16:13:28 INFO - PROCESS | 4856 | __metrics 16:13:29 ERROR - PROCESS | 4856 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:13:29 INFO - TEST-INFO | 4856: exit 0 16:13:29 INFO - Browser initialized. 16:13:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:29 INFO - TEST-INFO | started process 4975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtdSZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:31 INFO - PROCESS | 4975 | 16:13:31 INFO - PROCESS | 4975 | (process:5037): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:13:41 INFO - PROCESS | 4975 | RSS: Main: 164659200 16:13:41 INFO - PROCESS | 4975 | 16:14:31 INFO - PROCESS | 4975 | 1461021271381 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] 16:16:43 INFO - PROCESS | 4975 | Cycle 1(1): loaded http://localhost:42705/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42705/tests/dromaeo/cssquery-ext.html) 16:16:44 INFO - PROCESS | 4975 | RSS: Main: 168337408 16:16:44 INFO - PROCESS | 4975 | 16:19:46 INFO - PROCESS | 4975 | Cycle 1(1): loaded http://localhost:42705/tests/dromaeo/cssquery-ext.html (next: http://localhost:42705/tests/dromaeo/cssquery-jquery.html) 16:19:47 INFO - PROCESS | 4975 | RSS: Main: 165298176 16:19:47 INFO - PROCESS | 4975 | 16:22:48 INFO - PROCESS | 4975 | Cycle 1(1): loaded http://localhost:42705/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42705/tests/dromaeo/cssquery-mootools.html) 16:22:49 INFO - PROCESS | 4975 | RSS: Main: 166809600 16:22:49 INFO - PROCESS | 4975 | 16:25:51 INFO - PROCESS | 4975 | Cycle 1(1): loaded http://localhost:42705/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42705/tests/dromaeo/cssquery-prototype.html) 16:25:51 INFO - PROCESS | 4975 | RSS: Main: 164098048 16:25:51 INFO - PROCESS | 4975 | 16:28:54 INFO - PROCESS | 4975 | Cycle 1(1): loaded http://localhost:42705/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42705/tests/dromaeo/cssquery-yui.html) 16:28:55 INFO - PROCESS | 4975 | RSS: Main: 165728256 16:28:55 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | Cycle 1(1): loaded http://localhost:42705/tests/dromaeo/cssquery-yui.html (next: http://localhost:42705/tests/dromaeo/cssquery-dojo.html) 16:31:57 INFO - PROCESS | 4975 | RSS: Main: 167415808 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | __start_tp_report 16:31:57 INFO - PROCESS | 4975 | _x_x_mozilla_page_load 16:31:57 INFO - PROCESS | 4975 | _x_x_mozilla_page_load_details 16:31:57 INFO - PROCESS | 4975 | |i|pagename|runs| 16:31:57 INFO - PROCESS | 4975 | |0;dojo.html;2617.3587471069586;2679.26320261928;2691.5693489041732;2720.4695084458526;2730.836149831009;4767.5709186173235;4773.832915847946;4786.1145688047645;4794.496577859318;4845.61235101192;4632.86101416958;4724.5984091352275;4752.049590081981;4783.9760801196035;4839.443464001641;4340.587644173806;4404.097160082191;4404.207242696313;4413;4432.734035957837;532.6339366087802;4269.338252570857;4307.606381121931;4325.178216138924;4376.803043863034;4408.382826404306;4412.867613971586;4418.734875907424;4427.490838553559;4468.597826195625;4375.343698445258;4424.513303536608;4432.335149727534;4433.202023635777;4441.822327106912;4289.356596510517;4292.892677683051;4306.181825453154;4357.3899654048455;4378.124375124956;4645.907081858378;4653.255479123324;4680.227762419197;4682.204025315705;4693.9765301173275;4957.256411538262;5077.339945807022;5080.898382032376;5084.694918304914;5092.337996060525;5172.250023746536;5191.299174611417;5193.065248255312;5204.42751297357;5243.764030618631;4757.833475828364;4842.055799119208;4844.031193761261;4851.708897466093;4887.218045112765;5112.182050871843;5221.425643179247;5289.656172348785;5294.126469132627;5311.362636483569;5031.849044528597;5033.119204139261;5066.620003499752;5071.112555302807;5077.593792496591;5132.384113906355;5148.9742551287;5149.871253218699;5153.5361817436615;5178.741062946838;4948.05986862495;5007.223880298559;5060.84817455477;5067.442581316052;5115.974420127875;4969.0807200668;4995.875103122451;5004.624653150955;5029.044481548494;5066.088104141216;4201.663866890642;4216.873493795191;4225.239456897726;4231.069164783804;4252.022034931922;3632.110133017428;3639.090227443139;3659.396199627032;3738.3831667775057;3792.6207379261855;4421.248387774086;4446.822127114944;4468.798904049326;4488.842890498817;4495.88760280989;5163.225516172529;5169.767360468788;5181.611379146579;5185.922211166836;5187.014467251211;4313.0295683471595;4399.208142534375;4481.955180448153;4492;4501.212287849613;4464.196444639996;4475.70907890986;4475.843345482893;4499.932501012488;4509.954900451019;4713.128071306751;4779.952200477951;4783.593394561362;4792.185328494094;4835.323054772335;4977.054359671651;5075.467075956972;5128.999845030184;5165.405978312392;5179.766910488962;4806.870385459344;4819.518048195152;4837.806487740451;4848.539388758062;4878.243872199815;4853.6359773017875;5023.372078490189;5028.019536190408;5053.7473126344275;5066.544011039025;5099.158638824701;5127.846164615067;5163.974180129076;5166.199239117943;5198.0643484173215;4902.2156454967035;4930.359053323045;4946.629002824874;4964.304997300453;4996.100701873697;4840.249761287007;4940.184869496493;4965.031818795444;4965.50344965515;4990.201567749143;4885.193942999507;4945.480724524017;4955.6531042826655;4956.281339205723;5000.499950004971;5051.62112841531;5057.721825299644;5063.265826455217;5065.848024559269;5129.743512824419;4779.569838714532;4887.975560122177;4960;4960.8759781005765;5016.297718319511 16:31:57 INFO - PROCESS | 4975 | |1;ext.html;567.0671744979509;603.4177019176494;623.9719212635431;624.3132554190388;626.4612433307354;33266;33964.320713585716;34025.14937126573;34163;34170.31659366811;34846;35188.12029699259;35267;35288.117797055085;35292.823535882286;7415.925840741591;7592.126905405894;7624.313811756941;7626.38988880891;7633.6564854581675;7587.810304742398;7806.921930780704;7839.529628222325;7846.725364612211;7848.2151784821635;7769.223077692242;7802.180771019046;7849.25432083954;7877.606119693993;7879;7579.924200757977;7850.411219158557;7862.292393684567;7863.292303692638;7867;7582.924170758332;7672.079350477979;7683.923160768377;7698.653560589731;7710.922890771077;31664.208394790083;34974.825125874464;35126.64873351285;35137.12157196065;35203.64796352055;2734.5487994480886;2742.3966727319957;2746.8626568671684;2834.093090211133;2899.5505696616847;24199.395015124588;25720.228393148234;25890.87054564734;25944;26286.342841428926;3100.875964961399;3104.8602812873473;3109.315950490911;3237.14215732831;3239.352129574071;180930;181503;182728;182828;183470;31055.68944310573;31237.53143702846;31265.531017034307;31321.530177047363;31324.06027819169;60370.396296037354;61885.38114618886;61897.690511548055;62029;62203.68898155571;14879.479218227527;15113.848861511464;15202.315895784715;15261.389544418322;15291.311890964933;10575.735606609742;10580.629677961235;10588.205884558689;10617.787644247072;10646.893531064745;17999.910000449912;18036;18086.638267234583;18100.728489072673;18141.909290453463;6792.354726300993;6859.794206173823;6923.6884340204815;7074.434045276365;7165.749198778018;890.3411475508077;909.8726178335038;910.535626830308;976.3409698453515;1003.3428104591504;28125.859370703423;28246.293842653686;29005.56491652627;29007.85496072506;29136.271593209916;984.9803003939882;986.8717066781272;1010.6311196413257;1058.7617785998088;1061.6888143143212;14720;15378.615534611725;15390.615234619225;15532.767008494882;15561.988470749366;316948;322230;322745;324005;324017;48628.513714863104;49849.50150498521;49869;50026;50046.24930626043;1197.461142485885;1206.5354838387284;1262.8358313419196;1266.8543117541417;1278.0989402471234;26396.736032639426;27517.174484765488;27934.441311173257;28006.57990130109;28227.858860706387;41483.792581036905;42389.57610423979;42474.78762606167;42698.57301426946;42752;301325;302107;304019;304255;305681;25427.87286063632;25636.23091307264;25705.10032148866;25788.871055644602;38444.807775960944;37017.259654806214;37678.2464350706;38206.42690359702;38426.61573384231;38432.2313553733;32298.677013229568;34136.658633413346;35089.824550877085;35344.646553534134;35410.46884296789;33216.1695957603;34425.827870860485;34556.82721586376;34749.13127171841;34935.30129397347;31798.523022154222;34677.65322346845;35312.11719707028;37562.2487550242;39423.60576394314;30530.84734576313;30671.39220286545;31684;31690.524642129927;32080;24708.258752237463;24900.750992489844;25017;25070.874645626656;25173 16:31:57 INFO - PROCESS | 4975 | |2;jquery.html;373.149219778904;382.12493390136586;386.3162202900864;388.8366885907918;394.49504634068404;15309.38762449502;16199.352025918965;16823;16845;17066.999999999985;15527.6708493726;16074.517764467055;16609.91695041526;16611.671066314695;16614.169291535436;4642.257238841786;4771.475137734847;4801.4718380978065;4833.830815921444;4833.903321933559;3465.8093804840723;5174.249733788598;5435.728213589325;5482.862928426801;5483.2049352843815;5475.397706252309;5480.862978425532;5484;5487.6981766003055;5492.835214943538;5061;5401.43284955078;5434.429384914606;5436.891262174774;5447.809326673548;5031.144705400091;5244.737763111829;5254.4220135785035;5265.341832270966;5265.842024739264;12576.11967162299;12633.747325053539;12764.234145951179;12770.744585108247;12783.29691866947;1862.5716085300458;1926.364299781069;1944.9708254376196;2008.9296874609317;2072.5958438104576;9316.8602470963;9322.831525238962;9356.298277629205;9782;9791.314607977445;1735.158448152645;1745.4589077385924;1751.4132765523566;1784.2684499355203;1786.9553261168576;69065.65467172682;71688;71702.64148679223;72143;72889;9907.653232136985;9953.701388958343;10079.798404031879;10134.442605656759;10272.12686921605;14137.78793318101;14228.644283892778;14271.357788899524;14281.071730337495;14296.642583935485;7282.745103921337;7377.668004939684;7397.445191610651;7473.887891681629;7581.848363032708;6906.585604863724;7041.366277035091;7075.080239568823;7098.36114749675;7157.606331651705;4386.692931494765;4432.977835110868;4444.511103778582;4467.508574056851;4484.282514797616;1695.8388953049441;1782.6345599152144;1822.6081392500412;1850.5068996050445;1883.1619929131405;833.6457005772522;866.27233124176;875.4747151708924;883.2183517586982;899.3165194452264;16557.83442165563;16903.66192676164;16957.15214239283;17227.138643067796;17284.91357543204;850.8936382952131;852.2755657690913;863.3050394432543;881.4358810361374;899.8785164002907;9456.8581471278;9476.384035037701;9504.857427138599;9629.855552166724;9630.903690963141;389373;391373;397785;400488;402454;76150.23849761543;76409.617951911;77430.61284693654;78681.60659196782;79834.60082699666;880.0715245416147;900.3922352412096;900.6082354175954;903.2954295649404;914.1133100892257;14928.133560707412;15009.174495402858;15017.474388396791;15140.206525485946;15467.690646186787;31685.683143169197;32724.672753272163;33426;33770.66229337773;34427.31145377128;45463.77268113771;46700.06599867916;47513.76243118762;48731.512684872694;49138.50861491483;6636.767713130017;6997.475189360716;7212.4951253411755;7833.216678332349;8016.799580010546;11347.716307092058;11625.825612615648;11649.708757281136;11771.117166212398;12133.272003679807;10361.481925903825;10445.843312350473;10484;10510.421926794099;10688.251822372671;9819.312648114563;9879.456629885426;9944.950275248577;10068.69793906184;10172.389656620626;9330.393524420891;10508.737281568023;10599.200267575978;10618.575256989943;10774.138068954308;7280.927190728236;7298.2701729826595;7313.707451702086;7348.52234604749;7458.888116678146;10179.38923664553;10212.795744084928;10316;10405.63580274717;10407.739806504898 16:31:57 INFO - PROCESS | 4975 | |3;mootools.html;1434.8493408192137;1457.3004957620342;1561.836007219242;1732.722764357703;1740.5822602575379;6984.790456286307;7479.139898911627;7573.204813494586;7768.533887966719;7846.489978151423;7653.043369578802;7680.3087722105;7701.614919254043;7731.45879788415;7735.961320193391;2264.1509433962224;2275.2946586558137;2300.3329034580033;2304.2280835919987;2306.0199415248535;2207.0840601150503;2212.1704360864674;2236.6756820261053;2246.8314876384256;2257.3679369776405;2218.301235110935;2233.6761169630395;2245.3376254005025;2250.5273892482514;2266.4900397410534;2194.813440857529;2214.534947660993;2221.3891179925567;2230.119102954332;2232.821374290053;2187.147012665062;2191.879446630435;2203.10774136475;2205.4817117977263;2212.982028266983;7637.121731000951;7758.573278469682;7760.844783104363;7768;7789.532628042336;4477.48508921475;4539.228331183706;4666.673332866701;4669.789859456333;4697.436307643071;2916.3729798093514;2948.631421072366;2964.0515035188746;2975.2561859535117;2988.3276262840686;901.6123067081153;913.8035322405715;919.9310051746146;924.9861252081224;929.7675581104724;10219.795604087876;10278;10408.3754974701;10433.16534677224;10446.529906154241;4037.4953130858644;4145.3781932710335;4206.810693518799;4298.978505107517;4328.264195086843;8426.157384261647;8436.325093992466;8484.745457636282;8508.10664880191;8545.529995850287;4642.1644104060915;4665.043666048452;4676.321933319718;4678.087772884323;4702.623790096784;3722.3299806035175;4145.461090058334;4272.850450234227;4340.782960851945;4342;3436.244026314207;3474.513568100468;3547.077759782475;3588.946165807515;3611.6930060945115;1102.1348241630283;1115.1580556679655;1129.170060005895;1137.0278411957822;1143.7540928700369;699.4124935054579;729.4930023633524;795.0102122856964;857.9485230886166;858.4677499949946;5303.071962406563;5316.175992721134;5331.040412725747;5344.305240318734;5412.56699464042;861.6338056326036;881.5856547422829;922.34513495419;939.0703203828298;943.5989704375613;3700.870469533553;3786.072412259014;3790.56408513019;3800.3349413853016;3810.9237815244096;8912.108789121166;9505.097015783489;9915.405075695337;9921;9985.850212246822;9083.636654533877;9095.772605684911;9142.131497507726;9206.723798286062;9208.26333893287;7000.964995174992;7026.26224246457;7065.50541462103;7189.1373035235065;7265.382442492447;5367.812126575551;5389.218563308376;5397.190421436816;5408.675479471244;5423.267858839164;8619.65521379163;8702.47785132894;8726.82546349082;8774.692885748967;8819;8529.275011624082;8801.515916624647;8916.108389161032;9017.233535149586;9121.908780912372;6601.933980660132;6765.323467653196;6816.318368163343;6822.454203663596;6902.516823822284;7243;7306;7306.780796576111;7313.049303590499;7330.120385553768;6678.7328506859185;6700.564463309869;6791.45668346541;6852.246252912076;6918.0314755933205;6622.503312251504;6647.135872336566;6665.7668331358855;6711.228208756055;6723.865522689421;6277;6346.143270658402;6399.296077431572;6441.935580644321;6442.8389290268115;4613.769311534477;4631.791569379453;4674.953250467452;4800.7599620019555;4814.109389762905;4533;4664.836730714409;4741.691790033637;4742.928856067093;4752.809887604595 16:31:57 INFO - PROCESS | 4975 | |4;prototype.html;305.07866243943295;310.1610144558968;318.19179284617076;320.8107216742122;324.1022368040526;5101.464346243647;5200.4019537753165;5207.323048003759;5255.632105752599;5295.087701764024;5213.497521189831;5230.9738451307785;5232.7122008289525;5238.3237364043525;5253.553447956928;4084.611961863633;4091.8158682859266;4092.0588264699136;4092.877213683594;4117.197146556423;3820.9044773880596;4065.146319272956;4087.3650539784026;4118.629323360897;4126.195391898581;3977.9204415911663;4009.9799501002453;4010.8195131219163;4023.436718859362;4025.7987100644996;3992.7803970781597;3997.1406147678244;3997.600239976008;4009.6391324780616;4027.456293400412;3500.2299494111508;3536.29274145172;3537.204129070964;3539.1152211947015;3545.804980726059;4805.9667171558285;5059.949400506021;5095.8534329775875;5112.156494178456;5114.411842638107;4631.374764406829;4674.2053850845095;4675.672702910798;4683.508231635663;4685.2269375553;5558.499735023867;5604.887902241973;5613.635113717595;5618.101103823409;5627.6904770237625;3794.3739283018267;3863.3818589025623;3875.9418608720894;3888.0279930017496;3889.4360317753767;5755.309362876482;5814.156947242626;5819.388964158745;5865.794697185621;5868.735906884243;3912.726109172331;3921.9019524511546;3930.7051971102283;3940.4877365942243;3951;3795.791231482295;3966.2265858157384;3985.5416627087675;4009.097952960619;4049.028233224064;4580.221362368406;4598.885027874263;4604.884877878013;4635.2120139576355;4643.512431194676;5277.815276465305;5540.9168862467095;5550.555955523549;5563.471470210324;5569.275994120739;1349.7300539891864;1381.1505923856755;1382.5783136143573;1387.6808334083016;1399.2583930516842;913.8720579118929;916.2624087609538;937.6530683647094;944.6079876851168;947.7393716727955;4762.14281429346;4784.641151913551;4817.084753896748;4825.324454576362;4842.982973575588;5629.549636029108;5632.633878797865;5662.490375866109;5698.1452782083015;5710.200571919934;4663.48701642819;4777.95222047775;4786.401699787527;4794.904101917942;4798.47216806151;3003.6695963444004;3029.5001324781606;3031.9545206821917;3044.695530446982;3048.2531779714113;5280.788768449296;5318.65428747138;5326.147816349443;5345.251664766935;5349.170878513836;5553.222548843165;5747.540196784247;5767.019606666877;5772.105323674838;5788.855278618068;5270.841874743764;5287;5311.9734401328515;5338.813141540105;5346.732663366738;5528.087865502147;5650.350209725934;5658.321001479684;5659.660420374791;5663.631863928831;5480.479354461319;5510.614257001971;5513.255710479194;5528.28623126832;5533.114701647717;5263.815766448156;5278.630495865253;5288.259643649815;5315.893682126413;5321.727137810141;3725.6088110747983;3906.667933225594;3929.292727309112;3943.8422463101156;3955.960440395559;5469.617126801086;5635.577331700221;5701.173329867229;5707.315122185364;5723.227364305932;5551.916721249266;5577.2191893135805;5586.217929489956;5589.357223919302;5609.186667933045;5564.387917329172;5567.526760225426;5581.330240371181;5582.078956972054;5586.078297080936;5194.4805519447755;5467.336884287457;5491.368492623399;5498.532624726943;5525.944740552543;5557;5636.9436305638055;5644.641438344179;5648.491635752802;5655.1517272409465;5200.453952335101;5512.834614961557;5523.171524271231;5523.658186797091;5526.640768350045 16:31:57 INFO - PROCESS | 4975 | |5;yui.html;601.70516446941;675.2066322071564;680.874038302914;683.7401787320817;691.0360047733415;10123.24075694323;10141.797164056714;10212.693619191417;10318.329308594955;11786.292822430649;12059.819102713443;12425.813612795793;12430.12989090764;12441.68895777606;12476.563320283793;640.6700549217157;827.234807802783;833.1418638802044;833.262562632072;834.6828205282014;799.3884678221166;818.0755746007004;822.01358369956;823.4482896459386;823.9876401853977;852.3053711225363;852.9360297977645;856.5460306037779;857.8327226190895;858.0989960541438;845.7124577643569;852.4970267542149;854.8418542569614;855.2901092093579;858.4420126917491;624.8250489862845;628.2837565175703;631.3591704420018;632.216052095403;633.2021652717609;11993.340366279852;12086.33525156116;12089.39553022354;12101.69745756363;12113.515459381702;12348.567800126952;12578.371081445892;12644.873551264554;12649.683757906034;12735.55425560101;9798.363106398061;9974.650887218984;10026.298159128864;10315.381077135396;10405.271630985833;3205.439048166585;3221.09949651646;3293.967060329414;3301.7853839500353;3378.831058447068;43793.78103109496;44047;44071.77964110159;44237.77881110574;45072.098558028985;9462.810743785085;9695.660651877291;9697.854532182022;9789.951050244703;9823.508824558743;15211.391544338103;15222.771658425132;15280.694386112438;15313.157776322409;15393.153376564396;6092.822127456064;6881.311868813179;6890.655467226618;6997.195322537871;7142.9999800027;3739.5886452490204;3754.924901502009;3779.4519794629623;3780.281746468217;3812.656860882478;2701.3651791828906;2768.4878297515024;2769.1692492252246;2769.1692492252246;2773.9029133980616;494.658685506999;496.5258178439582;500.88730035742395;503.3154909323317;521.8669239344019;588.4909553236505;614.6527212125135;615.5075939248583;620.736187120472;625.8591816841265;7835.333996610238;7859.331956783737;7892.250236227549;8020;8258.380621453414;483.835495931385;559.9524040456607;585.0492948957943;592.4726992976255;602.3675141101826;3805.9809700951873;3806.1436176859984;3869.903252418712;3965.900852478711;4075.9796201018803;53266;53712.73143634257;54041.459585403645;55002.44997549973;55062.449375505734;46251.76874115608;46486;46580.5341946583;46716.76641616838;47436.288455673195;43174.568254317055;43730.90672733207;44149.33775993362;44399.112017759464;44900.77549612231;7491.438142139253;7586.468947173645;7660.2722741339485;7742;7811.765647030598;27790.305242369104;28568.285792855346;28968.42063158683;28974.27564310909;29284.414311714074;37263;38223.426648599736;38379.2324153521;38490;38881.416778748906;9395.24838012971;9404.294677899321;9427.481488518197;9441.763955901157;9538.666146684833;9540.475273860004;9831.213502919607;10017.348872323275;10151.187904967732;10283.691489255334;9430.528473576156;9489.525523723649;9545.236381089635;9554.474503902353;9569.760755981157;8425.747227583182;8494.19305166033;8554.615042322986;8779.648814047621;9014.639414423613;9280.767980800534;9462.952685236529;9594.712158635251;9635.22918166559;9651.131398174199;8130.000398041531;8276.462029968034;8386.37102217324;8650.740477785677;8681.479111253346;8317.376196785386;8441.70454034106;8472.3645726572;8551.657933682583;8824.161704638049 16:31:57 INFO - PROCESS | 4975 | __end_tp_report 16:31:57 INFO - PROCESS | 4975 | __start_cc_report 16:31:57 INFO - PROCESS | 4975 | _x_x_mozilla_cycle_collect,381 16:31:57 INFO - PROCESS | 4975 | __end_cc_report 16:31:57 INFO - PROCESS | 4975 | __startTimestamp1461022317900__endTimestamp 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | ------- Summary: start ------- 16:31:57 INFO - PROCESS | 4975 | Number of tests: 6 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | [#0] dojo.html Cycles:165 Average:4691.85 Median:4848.54 stddev:600.61 (12.4%) stddev-sans-first:579.99 16:31:57 INFO - PROCESS | 4975 | Values: 2617.4 2679.3 2691.6 2720.5 2730.8 4767.6 4773.8 4786.1 4794.5 4845.6 4632.9 4724.6 4752.0 4784.0 4839.4 4340.6 4404.1 4404.2 4413.0 4432.7 532.6 4269.3 4307.6 4325.2 4376.8 4408.4 4412.9 4418.7 4427.5 4468.6 4375.3 4424.5 4432.3 4433.2 4441.8 4289.4 4292.9 4306.2 4357.4 4378.1 4645.9 4653.3 4680.2 4682.2 4694.0 4957.3 5077.3 5080.9 5084.7 5092.3 5172.3 5191.3 5193.1 5204.4 5243.8 4757.8 4842.1 4844.0 4851.7 4887.2 5112.2 5221.4 5289.7 5294.1 5311.4 5031.8 5033.1 5066.6 5071.1 5077.6 5132.4 5149.0 5149.9 5153.5 5178.7 4948.1 5007.2 5060.8 5067.4 5116.0 4969.1 4995.9 5004.6 5029.0 5066.1 4201.7 4216.9 4225.2 4231.1 4252.0 3632.1 3639.1 3659.4 3738.4 3792.6 4421.2 4446.8 4468.8 4488.8 4495.9 5163.2 5169.8 5181.6 5185.9 5187.0 4313.0 4399.2 4482.0 4492.0 4501.2 4464.2 4475.7 4475.8 4499.9 4510.0 4713.1 4780.0 4783.6 4792.2 4835.3 4977.1 5075.5 5129.0 5165.4 5179.8 4806.9 4819.5 4837.8 4848.5 4878.2 4853.6 5023.4 5028.0 5053.7 5066.5 5099.2 5127.8 5164.0 5166.2 5198.1 4902.2 4930.4 4946.6 4964.3 4996.1 4840.2 4940.2 4965.0 4965.5 4990.2 4885.2 4945.5 4955.7 4956.3 5000.5 5051.6 5057.7 5063.3 5065.8 5129.7 4779.6 4888.0 4960.0 4960.9 5016.3 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | [#1] ext.html Cycles:180 Average:42215.24 Median:178616.58 stddev:72566.25 (40.6%) stddev-sans-first:72702.44 16:31:57 INFO - PROCESS | 4975 | Values: 567.1 603.4 624.0 624.3 626.5 33266.0 33964.3 34025.1 34163.0 34170.3 34846.0 35188.1 35267.0 35288.1 35292.8 7415.9 7592.1 7624.3 7626.4 7633.7 7587.8 7806.9 7839.5 7846.7 7848.2 7769.2 7802.2 7849.3 7877.6 7879.0 7579.9 7850.4 7862.3 7863.3 7867.0 7582.9 7672.1 7683.9 7698.7 7710.9 31664.2 34974.8 35126.6 35137.1 35203.6 2734.5 2742.4 2746.9 2834.1 2899.6 24199.4 25720.2 25890.9 25944.0 26286.3 3100.9 3104.9 3109.3 3237.1 3239.4 180930.0 181503.0 182728.0 182828.0 183470.0 31055.7 31237.5 31265.5 31321.5 31324.1 60370.4 61885.4 61897.7 62029.0 62203.7 14879.5 15113.8 15202.3 15261.4 15291.3 10575.7 10580.6 10588.2 10617.8 10646.9 17999.9 18036.0 18086.6 18100.7 18141.9 6792.4 6859.8 6923.7 7074.4 7165.7 890.3 909.9 910.5 976.3 1003.3 28125.9 28246.3 29005.6 29007.9 29136.3 985.0 986.9 1010.6 1058.8 1061.7 14720.0 15378.6 15390.6 15532.8 15562.0 316948.0 322230.0 322745.0 324005.0 324017.0 48628.5 49849.5 49869.0 50026.0 50046.2 1197.5 1206.5 1262.8 1266.9 1278.1 26396.7 27517.2 27934.4 28006.6 28227.9 41483.8 42389.6 42474.8 42698.6 42752.0 301325.0 302107.0 304019.0 304255.0 305681.0 25427.9 25636.2 25705.1 25788.9 38444.8 37017.3 37678.2 38206.4 38426.6 38432.2 32298.7 34136.7 35089.8 35344.6 35410.5 33216.2 34425.8 34556.8 34749.1 34935.3 31798.5 34677.7 35312.1 37562.2 39423.6 30530.8 30671.4 31684.0 31690.5 32080.0 24708.3 24900.8 25017.0 25070.9 25173.0 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | [#2] jquery.html Cycles:180 Average:24110.09 Median:25053.01 stddev:65439.13 (261.2%) stddev-sans-first:65598.44 16:31:57 INFO - PROCESS | 4975 | Values: 373.1 382.1 386.3 388.8 394.5 15309.4 16199.4 16823.0 16845.0 17067.0 15527.7 16074.5 16609.9 16611.7 16614.2 4642.3 4771.5 4801.5 4833.8 4833.9 3465.8 5174.2 5435.7 5482.9 5483.2 5475.4 5480.9 5484.0 5487.7 5492.8 5061.0 5401.4 5434.4 5436.9 5447.8 5031.1 5244.7 5254.4 5265.3 5265.8 12576.1 12633.7 12764.2 12770.7 12783.3 1862.6 1926.4 1945.0 2008.9 2072.6 9316.9 9322.8 9356.3 9782.0 9791.3 1735.2 1745.5 1751.4 1784.3 1787.0 69065.7 71688.0 71702.6 72143.0 72889.0 9907.7 9953.7 10079.8 10134.4 10272.1 14137.8 14228.6 14271.4 14281.1 14296.6 7282.7 7377.7 7397.4 7473.9 7581.8 6906.6 7041.4 7075.1 7098.4 7157.6 4386.7 4433.0 4444.5 4467.5 4484.3 1695.8 1782.6 1822.6 1850.5 1883.2 833.6 866.3 875.5 883.2 899.3 16557.8 16903.7 16957.2 17227.1 17284.9 850.9 852.3 863.3 881.4 899.9 9456.9 9476.4 9504.9 9629.9 9630.9 389373.0 391373.0 397785.0 400488.0 402454.0 76150.2 76409.6 77430.6 78681.6 79834.6 880.1 900.4 900.6 903.3 914.1 14928.1 15009.2 15017.5 15140.2 15467.7 31685.7 32724.7 33426.0 33770.7 34427.3 45463.8 46700.1 47513.8 48731.5 49138.5 6636.8 6997.5 7212.5 7833.2 8016.8 11347.7 11625.8 11649.7 11771.1 12133.3 10361.5 10445.8 10484.0 10510.4 10688.3 9819.3 9879.5 9945.0 10068.7 10172.4 9330.4 10508.7 10599.2 10618.6 10774.1 7280.9 7298.3 7313.7 7348.5 7458.9 10179.4 10212.8 10316.0 10405.6 10407.7 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | [#3] mootools.html Cycles:180 Average:5105.80 Median:5393.20 stddev:2779.18 (51.5%) stddev-sans-first:2773.29 16:31:57 INFO - PROCESS | 4975 | Values: 1434.8 1457.3 1561.8 1732.7 1740.6 6984.8 7479.1 7573.2 7768.5 7846.5 7653.0 7680.3 7701.6 7731.5 7736.0 2264.2 2275.3 2300.3 2304.2 2306.0 2207.1 2212.2 2236.7 2246.8 2257.4 2218.3 2233.7 2245.3 2250.5 2266.5 2194.8 2214.5 2221.4 2230.1 2232.8 2187.1 2191.9 2203.1 2205.5 2213.0 7637.1 7758.6 7760.8 7768.0 7789.5 4477.5 4539.2 4666.7 4669.8 4697.4 2916.4 2948.6 2964.1 2975.3 2988.3 901.6 913.8 919.9 925.0 929.8 10219.8 10278.0 10408.4 10433.2 10446.5 4037.5 4145.4 4206.8 4299.0 4328.3 8426.2 8436.3 8484.7 8508.1 8545.5 4642.2 4665.0 4676.3 4678.1 4702.6 3722.3 4145.5 4272.9 4340.8 4342.0 3436.2 3474.5 3547.1 3588.9 3611.7 1102.1 1115.2 1129.2 1137.0 1143.8 699.4 729.5 795.0 857.9 858.5 5303.1 5316.2 5331.0 5344.3 5412.6 861.6 881.6 922.3 939.1 943.6 3700.9 3786.1 3790.6 3800.3 3810.9 8912.1 9505.1 9915.4 9921.0 9985.9 9083.6 9095.8 9142.1 9206.7 9208.3 7001.0 7026.3 7065.5 7189.1 7265.4 5367.8 5389.2 5397.2 5408.7 5423.3 8619.7 8702.5 8726.8 8774.7 8819.0 8529.3 8801.5 8916.1 9017.2 9121.9 6601.9 6765.3 6816.3 6822.5 6902.5 7243.0 7306.0 7306.8 7313.0 7330.1 6678.7 6700.6 6791.5 6852.2 6918.0 6622.5 6647.1 6665.8 6711.2 6723.9 6277.0 6346.1 6399.3 6441.9 6442.8 4613.8 4631.8 4675.0 4800.8 4814.1 4533.0 4664.8 4741.7 4742.9 4752.8 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | [#4] prototype.html Cycles:180 Average:4557.01 Median:5222.24 stddev:1344.20 (25.7%) stddev-sans-first:1309.54 16:31:57 INFO - PROCESS | 4975 | Values: 305.1 310.2 318.2 320.8 324.1 5101.5 5200.4 5207.3 5255.6 5295.1 5213.5 5231.0 5232.7 5238.3 5253.6 4084.6 4091.8 4092.1 4092.9 4117.2 3820.9 4065.1 4087.4 4118.6 4126.2 3977.9 4010.0 4010.8 4023.4 4025.8 3992.8 3997.1 3997.6 4009.6 4027.5 3500.2 3536.3 3537.2 3539.1 3545.8 4806.0 5059.9 5095.9 5112.2 5114.4 4631.4 4674.2 4675.7 4683.5 4685.2 5558.5 5604.9 5613.6 5618.1 5627.7 3794.4 3863.4 3875.9 3888.0 3889.4 5755.3 5814.2 5819.4 5865.8 5868.7 3912.7 3921.9 3930.7 3940.5 3951.0 3795.8 3966.2 3985.5 4009.1 4049.0 4580.2 4598.9 4604.9 4635.2 4643.5 5277.8 5540.9 5550.6 5563.5 5569.3 1349.7 1381.2 1382.6 1387.7 1399.3 913.9 916.3 937.7 944.6 947.7 4762.1 4784.6 4817.1 4825.3 4843.0 5629.5 5632.6 5662.5 5698.1 5710.2 4663.5 4778.0 4786.4 4794.9 4798.5 3003.7 3029.5 3032.0 3044.7 3048.3 5280.8 5318.7 5326.1 5345.3 5349.2 5553.2 5747.5 5767.0 5772.1 5788.9 5270.8 5287.0 5312.0 5338.8 5346.7 5528.1 5650.4 5658.3 5659.7 5663.6 5480.5 5510.6 5513.3 5528.3 5533.1 5263.8 5278.6 5288.3 5315.9 5321.7 3725.6 3906.7 3929.3 3943.8 3956.0 5469.6 5635.6 5701.2 5707.3 5723.2 5551.9 5577.2 5586.2 5589.4 5609.2 5564.4 5567.5 5581.3 5582.1 5586.1 5194.5 5467.3 5491.4 5498.5 5525.9 5557.0 5636.9 5644.6 5648.5 5655.2 5200.5 5512.8 5523.2 5523.7 5526.6 16:31:57 INFO - PROCESS | 4975 | 16:31:57 INFO - PROCESS | 4975 | [#5] yui.html Cycles:180 Average:12369.98 Median:597.09 stddev:14577.86 (2441.5%) stddev-sans-first:14591.96 16:31:57 INFO - PROCESS | 4975 | Values: 601.7 675.2 680.9 683.7 691.0 10123.2 10141.8 10212.7 10318.3 11786.3 12059.8 12425.8 12430.1 12441.7 12476.6 640.7 827.2 833.1 833.3 834.7 799.4 818.1 822.0 823.4 824.0 852.3 852.9 856.5 857.8 858.1 845.7 852.5 854.8 855.3 858.4 624.8 628.3 631.4 632.2 633.2 11993.3 12086.3 12089.4 12101.7 12113.5 12348.6 12578.4 12644.9 12649.7 12735.6 9798.4 9974.7 10026.3 10315.4 10405.3 3205.4 3221.1 3294.0 3301.8 3378.8 43793.8 44047.0 44071.8 44237.8 45072.1 9462.8 9695.7 9697.9 9790.0 9823.5 15211.4 15222.8 15280.7 15313.2 15393.2 6092.8 6881.3 6890.7 6997.2 7143.0 3739.6 3754.9 3779.5 3780.3 3812.7 2701.4 2768.5 2769.2 2769.2 2773.9 494.7 496.5 500.9 503.3 521.9 588.5 614.7 615.5 620.7 625.9 7835.3 7859.3 7892.3 8020.0 8258.4 483.8 560.0 585.0 592.5 602.4 3806.0 3806.1 3869.9 3965.9 4076.0 53266.0 53712.7 54041.5 55002.4 55062.4 46251.8 46486.0 46580.5 46716.8 47436.3 43174.6 43730.9 44149.3 44399.1 44900.8 7491.4 7586.5 7660.3 7742.0 7811.8 27790.3 28568.3 28968.4 28974.3 29284.4 37263.0 38223.4 38379.2 38490.0 38881.4 9395.2 9404.3 9427.5 9441.8 9538.7 9540.5 9831.2 10017.3 10151.2 10283.7 9430.5 9489.5 9545.2 9554.5 9569.8 8425.7 8494.2 8554.6 8779.6 9014.6 9280.8 9463.0 9594.7 9635.2 9651.1 8130.0 8276.5 8386.4 8650.7 8681.5 8317.4 8441.7 8472.4 8551.7 8824.2 16:31:57 INFO - PROCESS | 4975 | -------- Summary: end -------- 16:31:57 INFO - PROCESS | 4975 | 16:31:58 INFO - TEST-INFO | 4975: exit 0 16:31:58 INFO - TEST-OK | dromaeo_css | took 1114966ms 16:31:58 INFO - TEST-START | kraken 16:31:58 INFO - operating with platform_type : linux_ 16:31:58 INFO - Initialising browser for kraken test... 16:31:58 INFO - TEST-INFO | started process 5214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt0UptR/profile http://localhost:42705/getInfo.html) 16:32:02 INFO - PROCESS | 5214 | 16:32:02 INFO - PROCESS | 5214 | (process:5281): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:32:03 INFO - PROCESS | 5214 | __metrics Screen width/height:1600/1200 16:32:03 INFO - PROCESS | 5214 | colorDepth:24 16:32:03 INFO - PROCESS | 5214 | Browser inner width/height: 1024/697 16:32:03 INFO - PROCESS | 5214 | __metrics 16:32:03 ERROR - PROCESS | 5214 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:32:04 INFO - TEST-INFO | 5214: exit 0 16:32:04 INFO - Browser initialized. 16:32:04 INFO - Running cycle 1/1 for kraken test... 16:32:04 INFO - TEST-INFO | started process 5332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt0UptR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:06 INFO - PROCESS | 5332 | 16:32:06 INFO - PROCESS | 5332 | (process:5392): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:32:16 INFO - PROCESS | 5332 | RSS: Main: 164605952 16:32:16 INFO - PROCESS | 5332 | 16:32:19 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42705/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:20 INFO - PROCESS | 5332 | RSS: Main: 167432192 16:32:20 INFO - PROCESS | 5332 | 16:32:23 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42705/tests/kraken/driver.html?testName=audio-dft) 16:32:23 INFO - PROCESS | 5332 | RSS: Main: 171155456 16:32:23 INFO - PROCESS | 5332 | 16:32:26 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42705/tests/kraken/driver.html?testName=audio-fft) 16:32:27 INFO - PROCESS | 5332 | RSS: Main: 163278848 16:32:27 INFO - PROCESS | 5332 | 16:32:29 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42705/tests/kraken/driver.html?testName=audio-oscillator) 16:32:29 INFO - PROCESS | 5332 | RSS: Main: 163733504 16:32:29 INFO - PROCESS | 5332 | 16:32:32 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42705/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:32 INFO - PROCESS | 5332 | RSS: Main: 163745792 16:32:32 INFO - PROCESS | 5332 | 16:32:36 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42705/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:36 INFO - PROCESS | 5332 | RSS: Main: 164245504 16:32:36 INFO - PROCESS | 5332 | 16:32:40 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42705/tests/kraken/driver.html?testName=imaging-desaturate) 16:32:40 INFO - PROCESS | 5332 | RSS: Main: 163700736 16:32:40 INFO - PROCESS | 5332 | 16:32:43 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42705/tests/kraken/driver.html?testName=json-parse-financial) 16:32:44 INFO - PROCESS | 5332 | RSS: Main: 164470784 16:32:44 INFO - PROCESS | 5332 | 16:32:46 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42705/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:46 INFO - PROCESS | 5332 | RSS: Main: 164823040 16:32:46 INFO - PROCESS | 5332 | 16:32:48 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:49 INFO - PROCESS | 5332 | RSS: Main: 165285888 16:32:49 INFO - PROCESS | 5332 | 16:32:51 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:52 INFO - PROCESS | 5332 | RSS: Main: 165203968 16:32:52 INFO - PROCESS | 5332 | 16:32:54 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:55 INFO - PROCESS | 5332 | RSS: Main: 165441536 16:32:55 INFO - PROCESS | 5332 | 16:32:58 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:59 INFO - PROCESS | 5332 | RSS: Main: 165552128 16:32:59 INFO - PROCESS | 5332 | 16:33:00 INFO - PROCESS | 5332 | Cycle 1(1): loaded http://localhost:42705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42705/tests/kraken/driver.html?testName=ai-astar) 16:33:01 INFO - PROCESS | 5332 | RSS: Main: 166895616 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | __start_tp_report 16:33:01 INFO - PROCESS | 5332 | _x_x_mozilla_page_load 16:33:01 INFO - PROCESS | 5332 | _x_x_mozilla_page_load_details 16:33:01 INFO - PROCESS | 5332 | |i|pagename|runs| 16:33:01 INFO - PROCESS | 5332 | |0;ai-astar;116;109;114;112;116;127;115;114;115;113 16:33:01 INFO - PROCESS | 5332 | |1;audio-beat-detection;164;131;157;178;134;164;159;141;200;133 16:33:01 INFO - PROCESS | 5332 | |2;audio-dft;162;166;164;174;163;164;163;164;165;162 16:33:01 INFO - PROCESS | 5332 | |3;audio-fft;75;74;78;166;74;75;73;74;160;79 16:33:01 INFO - PROCESS | 5332 | |4;audio-oscillator;94;96;154;94;94;95;151;95;94;143 16:33:01 INFO - PROCESS | 5332 | |5;imaging-gaussian-blur;118;118;118;118;118;117;117;118;118;117 16:33:01 INFO - PROCESS | 5332 | |6;imaging-darkroom;148;150;147;146;147;147;147;147;146;148 16:33:01 INFO - PROCESS | 5332 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;96;96 16:33:01 INFO - PROCESS | 5332 | |8;json-parse-financial;65;65;65;69;65;68;69;90;63;62 16:33:01 INFO - PROCESS | 5332 | |9;json-stringify-tinderbox;64;65;66;66;65;65;65;66;65;64 16:33:01 INFO - PROCESS | 5332 | |10;stanford-crypto-aes;81;89;87;81;81;79;82;80;89;80 16:33:01 INFO - PROCESS | 5332 | |11;stanford-crypto-ccm;135;132;138;144;144;136;135;135;167;135 16:33:01 INFO - PROCESS | 5332 | |12;stanford-crypto-pbkdf2;187;180;185;172;177;179;176;175;176;182 16:33:01 INFO - PROCESS | 5332 | |13;stanford-crypto-sha256-iterative;73;74;73;76;76;75;72;72;71;76 16:33:01 INFO - PROCESS | 5332 | __end_tp_report 16:33:01 INFO - PROCESS | 5332 | __start_cc_report 16:33:01 INFO - PROCESS | 5332 | _x_x_mozilla_cycle_collect,899 16:33:01 INFO - PROCESS | 5332 | __end_cc_report 16:33:01 INFO - PROCESS | 5332 | __startTimestamp1461022381188__endTimestamp 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | ------- Summary: start ------- 16:33:01 INFO - PROCESS | 5332 | Number of tests: 14 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:4.68 (4.1%) stddev-sans-first:4.95 16:33:01 INFO - PROCESS | 5332 | Values: 116.0 109.0 114.0 112.0 116.0 127.0 115.0 114.0 115.0 113.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:161.50 stddev:22.16 (13.7%) stddev-sans-first:23.32 16:33:01 INFO - PROCESS | 5332 | Values: 164.0 131.0 157.0 178.0 134.0 164.0 159.0 141.0 200.0 133.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.50 (2.1%) stddev-sans-first:3.57 16:33:01 INFO - PROCESS | 5332 | Values: 162.0 166.0 164.0 174.0 163.0 164.0 163.0 164.0 165.0 162.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.50 stddev:37.07 (49.8%) stddev-sans-first:38.76 16:33:01 INFO - PROCESS | 5332 | Values: 75.0 74.0 78.0 166.0 74.0 75.0 73.0 74.0 160.0 79.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:94.00 stddev:26.60 (28.3%) stddev-sans-first:27.49 16:33:01 INFO - PROCESS | 5332 | Values: 94.0 96.0 154.0 94.0 94.0 95.0 151.0 95.0 94.0 143.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:33:01 INFO - PROCESS | 5332 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 16:33:01 INFO - PROCESS | 5332 | Values: 148.0 150.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 148.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:33:01 INFO - PROCESS | 5332 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:66.50 stddev:8.05 (12.1%) stddev-sans-first:8.46 16:33:01 INFO - PROCESS | 5332 | Values: 65.0 65.0 65.0 69.0 65.0 68.0 69.0 90.0 63.0 62.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 16:33:01 INFO - PROCESS | 5332 | Values: 64.0 65.0 66.0 66.0 65.0 65.0 65.0 66.0 65.0 64.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:81.50 stddev:3.87 (4.8%) stddev-sans-first:4.04 16:33:01 INFO - PROCESS | 5332 | Values: 81.0 89.0 87.0 81.0 81.0 79.0 82.0 80.0 89.0 80.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:137.00 stddev:10.25 (7.5%) stddev-sans-first:10.70 16:33:01 INFO - PROCESS | 5332 | Values: 135.0 132.0 138.0 144.0 144.0 136.0 135.0 135.0 167.0 135.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:179.50 stddev:4.68 (2.6%) stddev-sans-first:3.94 16:33:01 INFO - PROCESS | 5332 | Values: 187.0 180.0 185.0 172.0 177.0 179.0 176.0 175.0 176.0 182.0 16:33:01 INFO - PROCESS | 5332 | 16:33:01 INFO - PROCESS | 5332 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.50 stddev:1.87 (2.5%) stddev-sans-first:1.96 16:33:01 INFO - PROCESS | 5332 | Values: 73.0 74.0 73.0 76.0 76.0 75.0 72.0 72.0 71.0 76.0 16:33:01 INFO - PROCESS | 5332 | -------- Summary: end -------- 16:33:01 INFO - PROCESS | 5332 | 16:33:02 INFO - TEST-INFO | 5332: exit 0 16:33:02 INFO - TEST-OK | kraken | took 63634ms 16:33:02 INFO - SUITE-END | took 1178s 16:33:02 INFO - Completed test suite (00:19:38) 16:33:02 INFO - javascript benchmark 16:33:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.3587471069586, 2679.26320261928, 2691.5693489041732, 2720.4695084458526, 2730.836149831009, 4767.5709186173235, 4773.832915847946, 4786.1145688047645, 4794.496577859318, 4845.61235101192, 4632.86101416958, 4724.5984091352275, 4752.049590081981, 4783.9760801196035, 4839.443464001641, 4340.587644173806, 4404.097160082191, 4404.207242696313, 4413.0, 4432.734035957837, 532.6339366087802, 4269.338252570857, 4307.606381121931, 4325.178216138924, 4376.803043863034, 4408.382826404306, 4412.867613971586, 4418.734875907424, 4427.490838553559, 4468.597826195625, 4375.343698445258, 4424.513303536608, 4432.335149727534, 4433.202023635777, 4441.822327106912, 4289.356596510517, 4292.892677683051, 4306.181825453154, 4357.3899654048455, 4378.124375124956, 4645.907081858378, 4653.255479123324, 4680.227762419197, 4682.204025315705, 4693.9765301173275, 4957.256411538262, 5077.339945807022, 5080.898382032376, 5084.694918304914, 5092.337996060525, 5172.250023746536, 5191.299174611417, 5193.065248255312, 5204.42751297357, 5243.764030618631, 4757.833475828364, 4842.055799119208, 4844.031193761261, 4851.708897466093, 4887.218045112765, 5112.182050871843, 5221.425643179247, 5289.656172348785, 5294.126469132627, 5311.362636483569, 5031.849044528597, 5033.119204139261, 5066.620003499752, 5071.112555302807, 5077.593792496591, 5132.384113906355, 5148.9742551287, 5149.871253218699, 5153.5361817436615, 5178.741062946838, 4948.05986862495, 5007.223880298559, 5060.84817455477, 5067.442581316052, 5115.974420127875, 4969.0807200668, 4995.875103122451, 5004.624653150955, 5029.044481548494, 5066.088104141216, 4201.663866890642, 4216.873493795191, 4225.239456897726, 4231.069164783804, 4252.022034931922, 3632.110133017428, 3639.090227443139, 3659.396199627032, 3738.3831667775057, 3792.6207379261855, 4421.248387774086, 4446.822127114944, 4468.798904049326, 4488.842890498817, 4495.88760280989, 5163.225516172529, 5169.767360468788, 5181.611379146579, 5185.922211166836, 5187.014467251211, 4313.0295683471595, 4399.208142534375, 4481.955180448153, 4492.0, 4501.212287849613, 4464.196444639996, 4475.70907890986, 4475.843345482893, 4499.932501012488, 4509.954900451019, 4713.128071306751, 4779.952200477951, 4783.593394561362, 4792.185328494094, 4835.323054772335, 4977.054359671651, 5075.467075956972, 5128.999845030184, 5165.405978312392, 5179.766910488962, 4806.870385459344, 4819.518048195152, 4837.806487740451, 4848.539388758062, 4878.243872199815, 4853.6359773017875, 5023.372078490189, 5028.019536190408, 5053.7473126344275, 5066.544011039025, 5099.158638824701, 5127.846164615067, 5163.974180129076, 5166.199239117943, 5198.0643484173215, 4902.2156454967035, 4930.359053323045, 4946.629002824874, 4964.304997300453, 4996.100701873697, 4840.249761287007, 4940.184869496493, 4965.031818795444, 4965.50344965515, 4990.201567749143, 4885.193942999507, 4945.480724524017, 4955.6531042826655, 4956.281339205723, 5000.499950004971, 5051.62112841531, 5057.721825299644, 5063.265826455217, 5065.848024559269, 5129.743512824419, 4779.569838714532, 4887.975560122177, 4960.0, 4960.8759781005765, 5016.297718319511], "value": 4654.868112973095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.0671744979509, 603.4177019176494, 623.9719212635431, 624.3132554190388, 626.4612433307354, 33266.0, 33964.320713585716, 34025.14937126573, 34163.0, 34170.31659366811, 34846.0, 35188.12029699259, 35267.0, 35288.117797055085, 35292.823535882286, 7415.925840741591, 7592.126905405894, 7624.313811756941, 7626.38988880891, 7633.6564854581675, 7587.810304742398, 7806.921930780704, 7839.529628222325, 7846.725364612211, 7848.2151784821635, 7769.223077692242, 7802.180771019046, 7849.25432083954, 7877.606119693993, 7879.0, 7579.924200757977, 7850.411219158557, 7862.292393684567, 7863.292303692638, 7867.0, 7582.924170758332, 7672.079350477979, 7683.923160768377, 7698.653560589731, 7710.922890771077, 31664.208394790083, 34974.825125874464, 35126.64873351285, 35137.12157196065, 35203.64796352055, 2734.5487994480886, 2742.3966727319957, 2746.8626568671684, 2834.093090211133, 2899.5505696616847, 24199.395015124588, 25720.228393148234, 25890.87054564734, 25944.0, 26286.342841428926, 3100.875964961399, 3104.8602812873473, 3109.315950490911, 3237.14215732831, 3239.352129574071, 180930.0, 181503.0, 182728.0, 182828.0, 183470.0, 31055.68944310573, 31237.53143702846, 31265.531017034307, 31321.530177047363, 31324.06027819169, 60370.396296037354, 61885.38114618886, 61897.690511548055, 62029.0, 62203.68898155571, 14879.479218227527, 15113.848861511464, 15202.315895784715, 15261.389544418322, 15291.311890964933, 10575.735606609742, 10580.629677961235, 10588.205884558689, 10617.787644247072, 10646.893531064745, 17999.910000449912, 18036.0, 18086.638267234583, 18100.728489072673, 18141.909290453463, 6792.354726300993, 6859.794206173823, 6923.6884340204815, 7074.434045276365, 7165.749198778018, 890.3411475508077, 909.8726178335038, 910.535626830308, 976.3409698453515, 1003.3428104591504, 28125.859370703423, 28246.293842653686, 29005.56491652627, 29007.85496072506, 29136.271593209916, 984.9803003939882, 986.8717066781272, 1010.6311196413257, 1058.7617785998088, 1061.6888143143212, 14720.0, 15378.615534611725, 15390.615234619225, 15532.767008494882, 15561.988470749366, 316948.0, 322230.0, 322745.0, 324005.0, 324017.0, 48628.513714863104, 49849.50150498521, 49869.0, 50026.0, 50046.24930626043, 1197.461142485885, 1206.5354838387284, 1262.8358313419196, 1266.8543117541417, 1278.0989402471234, 26396.736032639426, 27517.174484765488, 27934.441311173257, 28006.57990130109, 28227.858860706387, 41483.792581036905, 42389.57610423979, 42474.78762606167, 42698.57301426946, 42752.0, 301325.0, 302107.0, 304019.0, 304255.0, 305681.0, 25427.87286063632, 25636.23091307264, 25705.10032148866, 25788.871055644602, 38444.807775960944, 37017.259654806214, 37678.2464350706, 38206.42690359702, 38426.61573384231, 38432.2313553733, 32298.677013229568, 34136.658633413346, 35089.824550877085, 35344.646553534134, 35410.46884296789, 33216.1695957603, 34425.827870860485, 34556.82721586376, 34749.13127171841, 34935.30129397347, 31798.523022154222, 34677.65322346845, 35312.11719707028, 37562.2487550242, 39423.60576394314, 30530.84734576313, 30671.39220286545, 31684.0, 31690.524642129927, 32080.0, 24708.258752237463, 24900.750992489844, 25017.0, 25070.874645626656, 25173.0], "value": 16755.57148709454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.149219778904, 382.12493390136586, 386.3162202900864, 388.8366885907918, 394.49504634068404, 15309.38762449502, 16199.352025918965, 16823.0, 16845.0, 17066.999999999985, 15527.6708493726, 16074.517764467055, 16609.91695041526, 16611.671066314695, 16614.169291535436, 4642.257238841786, 4771.475137734847, 4801.4718380978065, 4833.830815921444, 4833.903321933559, 3465.8093804840723, 5174.249733788598, 5435.728213589325, 5482.862928426801, 5483.2049352843815, 5475.397706252309, 5480.862978425532, 5484.0, 5487.6981766003055, 5492.835214943538, 5061.0, 5401.43284955078, 5434.429384914606, 5436.891262174774, 5447.809326673548, 5031.144705400091, 5244.737763111829, 5254.4220135785035, 5265.341832270966, 5265.842024739264, 12576.11967162299, 12633.747325053539, 12764.234145951179, 12770.744585108247, 12783.29691866947, 1862.5716085300458, 1926.364299781069, 1944.9708254376196, 2008.9296874609317, 2072.5958438104576, 9316.8602470963, 9322.831525238962, 9356.298277629205, 9782.0, 9791.314607977445, 1735.158448152645, 1745.4589077385924, 1751.4132765523566, 1784.2684499355203, 1786.9553261168576, 69065.65467172682, 71688.0, 71702.64148679223, 72143.0, 72889.0, 9907.653232136985, 9953.701388958343, 10079.798404031879, 10134.442605656759, 10272.12686921605, 14137.78793318101, 14228.644283892778, 14271.357788899524, 14281.071730337495, 14296.642583935485, 7282.745103921337, 7377.668004939684, 7397.445191610651, 7473.887891681629, 7581.848363032708, 6906.585604863724, 7041.366277035091, 7075.080239568823, 7098.36114749675, 7157.606331651705, 4386.692931494765, 4432.977835110868, 4444.511103778582, 4467.508574056851, 4484.282514797616, 1695.8388953049441, 1782.6345599152144, 1822.6081392500412, 1850.5068996050445, 1883.1619929131405, 833.6457005772522, 866.27233124176, 875.4747151708924, 883.2183517586982, 899.3165194452264, 16557.83442165563, 16903.66192676164, 16957.15214239283, 17227.138643067796, 17284.91357543204, 850.8936382952131, 852.2755657690913, 863.3050394432543, 881.4358810361374, 899.8785164002907, 9456.8581471278, 9476.384035037701, 9504.857427138599, 9629.855552166724, 9630.903690963141, 389373.0, 391373.0, 397785.0, 400488.0, 402454.0, 76150.23849761543, 76409.617951911, 77430.61284693654, 78681.60659196782, 79834.60082699666, 880.0715245416147, 900.3922352412096, 900.6082354175954, 903.2954295649404, 914.1133100892257, 14928.133560707412, 15009.174495402858, 15017.474388396791, 15140.206525485946, 15467.690646186787, 31685.683143169197, 32724.672753272163, 33426.0, 33770.66229337773, 34427.31145377128, 45463.77268113771, 46700.06599867916, 47513.76243118762, 48731.512684872694, 49138.50861491483, 6636.767713130017, 6997.475189360716, 7212.4951253411755, 7833.216678332349, 8016.799580010546, 11347.716307092058, 11625.825612615648, 11649.708757281136, 11771.117166212398, 12133.272003679807, 10361.481925903825, 10445.843312350473, 10484.0, 10510.421926794099, 10688.251822372671, 9819.312648114563, 9879.456629885426, 9944.950275248577, 10068.69793906184, 10172.389656620626, 9330.393524420891, 10508.737281568023, 10599.200267575978, 10618.575256989943, 10774.138068954308, 7280.927190728236, 7298.2701729826595, 7313.707451702086, 7348.52234604749, 7458.888116678146, 10179.38923664553, 10212.795744084928, 10316.0, 10405.63580274717, 10407.739806504898], "value": 8042.033454337224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.8493408192137, 1457.3004957620342, 1561.836007219242, 1732.722764357703, 1740.5822602575379, 6984.790456286307, 7479.139898911627, 7573.204813494586, 7768.533887966719, 7846.489978151423, 7653.043369578802, 7680.3087722105, 7701.614919254043, 7731.45879788415, 7735.961320193391, 2264.1509433962224, 2275.2946586558137, 2300.3329034580033, 2304.2280835919987, 2306.0199415248535, 2207.0840601150503, 2212.1704360864674, 2236.6756820261053, 2246.8314876384256, 2257.3679369776405, 2218.301235110935, 2233.6761169630395, 2245.3376254005025, 2250.5273892482514, 2266.4900397410534, 2194.813440857529, 2214.534947660993, 2221.3891179925567, 2230.119102954332, 2232.821374290053, 2187.147012665062, 2191.879446630435, 2203.10774136475, 2205.4817117977263, 2212.982028266983, 7637.121731000951, 7758.573278469682, 7760.844783104363, 7768.0, 7789.532628042336, 4477.48508921475, 4539.228331183706, 4666.673332866701, 4669.789859456333, 4697.436307643071, 2916.3729798093514, 2948.631421072366, 2964.0515035188746, 2975.2561859535117, 2988.3276262840686, 901.6123067081153, 913.8035322405715, 919.9310051746146, 924.9861252081224, 929.7675581104724, 10219.795604087876, 10278.0, 10408.3754974701, 10433.16534677224, 10446.529906154241, 4037.4953130858644, 4145.3781932710335, 4206.810693518799, 4298.978505107517, 4328.264195086843, 8426.157384261647, 8436.325093992466, 8484.745457636282, 8508.10664880191, 8545.529995850287, 4642.1644104060915, 4665.043666048452, 4676.321933319718, 4678.087772884323, 4702.623790096784, 3722.3299806035175, 4145.461090058334, 4272.850450234227, 4340.782960851945, 4342.0, 3436.244026314207, 3474.513568100468, 3547.077759782475, 3588.946165807515, 3611.6930060945115, 1102.1348241630283, 1115.1580556679655, 1129.170060005895, 1137.0278411957822, 1143.7540928700369, 699.4124935054579, 729.4930023633524, 795.0102122856964, 857.9485230886166, 858.4677499949946, 5303.071962406563, 5316.175992721134, 5331.040412725747, 5344.305240318734, 5412.56699464042, 861.6338056326036, 881.5856547422829, 922.34513495419, 939.0703203828298, 943.5989704375613, 3700.870469533553, 3786.072412259014, 3790.56408513019, 3800.3349413853016, 3810.9237815244096, 8912.108789121166, 9505.097015783489, 9915.405075695337, 9921.0, 9985.850212246822, 9083.636654533877, 9095.772605684911, 9142.131497507726, 9206.723798286062, 9208.26333893287, 7000.964995174992, 7026.26224246457, 7065.50541462103, 7189.1373035235065, 7265.382442492447, 5367.812126575551, 5389.218563308376, 5397.190421436816, 5408.675479471244, 5423.267858839164, 8619.65521379163, 8702.47785132894, 8726.82546349082, 8774.692885748967, 8819.0, 8529.275011624082, 8801.515916624647, 8916.108389161032, 9017.233535149586, 9121.908780912372, 6601.933980660132, 6765.323467653196, 6816.318368163343, 6822.454203663596, 6902.516823822284, 7243.0, 7306.0, 7306.780796576111, 7313.049303590499, 7330.120385553768, 6678.7328506859185, 6700.564463309869, 6791.45668346541, 6852.246252912076, 6918.0314755933205, 6622.503312251504, 6647.135872336566, 6665.7668331358855, 6711.228208756055, 6723.865522689421, 6277.0, 6346.143270658402, 6399.296077431572, 6441.935580644321, 6442.8389290268115, 4613.769311534477, 4631.791569379453, 4674.953250467452, 4800.7599620019555, 4814.109389762905, 4533.0, 4664.836730714409, 4741.691790033637, 4742.928856067093, 4752.809887604595], "value": 4145.7223040271965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.07866243943295, 310.1610144558968, 318.19179284617076, 320.8107216742122, 324.1022368040526, 5101.464346243647, 5200.4019537753165, 5207.323048003759, 5255.632105752599, 5295.087701764024, 5213.497521189831, 5230.9738451307785, 5232.7122008289525, 5238.3237364043525, 5253.553447956928, 4084.611961863633, 4091.8158682859266, 4092.0588264699136, 4092.877213683594, 4117.197146556423, 3820.9044773880596, 4065.146319272956, 4087.3650539784026, 4118.629323360897, 4126.195391898581, 3977.9204415911663, 4009.9799501002453, 4010.8195131219163, 4023.436718859362, 4025.7987100644996, 3992.7803970781597, 3997.1406147678244, 3997.600239976008, 4009.6391324780616, 4027.456293400412, 3500.2299494111508, 3536.29274145172, 3537.204129070964, 3539.1152211947015, 3545.804980726059, 4805.9667171558285, 5059.949400506021, 5095.8534329775875, 5112.156494178456, 5114.411842638107, 4631.374764406829, 4674.2053850845095, 4675.672702910798, 4683.508231635663, 4685.2269375553, 5558.499735023867, 5604.887902241973, 5613.635113717595, 5618.101103823409, 5627.6904770237625, 3794.3739283018267, 3863.3818589025623, 3875.9418608720894, 3888.0279930017496, 3889.4360317753767, 5755.309362876482, 5814.156947242626, 5819.388964158745, 5865.794697185621, 5868.735906884243, 3912.726109172331, 3921.9019524511546, 3930.7051971102283, 3940.4877365942243, 3951.0, 3795.791231482295, 3966.2265858157384, 3985.5416627087675, 4009.097952960619, 4049.028233224064, 4580.221362368406, 4598.885027874263, 4604.884877878013, 4635.2120139576355, 4643.512431194676, 5277.815276465305, 5540.9168862467095, 5550.555955523549, 5563.471470210324, 5569.275994120739, 1349.7300539891864, 1381.1505923856755, 1382.5783136143573, 1387.6808334083016, 1399.2583930516842, 913.8720579118929, 916.2624087609538, 937.6530683647094, 944.6079876851168, 947.7393716727955, 4762.14281429346, 4784.641151913551, 4817.084753896748, 4825.324454576362, 4842.982973575588, 5629.549636029108, 5632.633878797865, 5662.490375866109, 5698.1452782083015, 5710.200571919934, 4663.48701642819, 4777.95222047775, 4786.401699787527, 4794.904101917942, 4798.47216806151, 3003.6695963444004, 3029.5001324781606, 3031.9545206821917, 3044.695530446982, 3048.2531779714113, 5280.788768449296, 5318.65428747138, 5326.147816349443, 5345.251664766935, 5349.170878513836, 5553.222548843165, 5747.540196784247, 5767.019606666877, 5772.105323674838, 5788.855278618068, 5270.841874743764, 5287.0, 5311.9734401328515, 5338.813141540105, 5346.732663366738, 5528.087865502147, 5650.350209725934, 5658.321001479684, 5659.660420374791, 5663.631863928831, 5480.479354461319, 5510.614257001971, 5513.255710479194, 5528.28623126832, 5533.114701647717, 5263.815766448156, 5278.630495865253, 5288.259643649815, 5315.893682126413, 5321.727137810141, 3725.6088110747983, 3906.667933225594, 3929.292727309112, 3943.8422463101156, 3955.960440395559, 5469.617126801086, 5635.577331700221, 5701.173329867229, 5707.315122185364, 5723.227364305932, 5551.916721249266, 5577.2191893135805, 5586.217929489956, 5589.357223919302, 5609.186667933045, 5564.387917329172, 5567.526760225426, 5581.330240371181, 5582.078956972054, 5586.078297080936, 5194.4805519447755, 5467.336884287457, 5491.368492623399, 5498.532624726943, 5525.944740552543, 5557.0, 5636.9436305638055, 5644.641438344179, 5648.491635752802, 5655.1517272409465, 5200.453952335101, 5512.834614961557, 5523.171524271231, 5523.658186797091, 5526.640768350045], "value": 4127.62095239641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.70516446941, 675.2066322071564, 680.874038302914, 683.7401787320817, 691.0360047733415, 10123.24075694323, 10141.797164056714, 10212.693619191417, 10318.329308594955, 11786.292822430649, 12059.819102713443, 12425.813612795793, 12430.12989090764, 12441.68895777606, 12476.563320283793, 640.6700549217157, 827.234807802783, 833.1418638802044, 833.262562632072, 834.6828205282014, 799.3884678221166, 818.0755746007004, 822.01358369956, 823.4482896459386, 823.9876401853977, 852.3053711225363, 852.9360297977645, 856.5460306037779, 857.8327226190895, 858.0989960541438, 845.7124577643569, 852.4970267542149, 854.8418542569614, 855.2901092093579, 858.4420126917491, 624.8250489862845, 628.2837565175703, 631.3591704420018, 632.216052095403, 633.2021652717609, 11993.340366279852, 12086.33525156116, 12089.39553022354, 12101.69745756363, 12113.515459381702, 12348.567800126952, 12578.371081445892, 12644.873551264554, 12649.683757906034, 12735.55425560101, 9798.363106398061, 9974.650887218984, 10026.298159128864, 10315.381077135396, 10405.271630985833, 3205.439048166585, 3221.09949651646, 3293.967060329414, 3301.7853839500353, 3378.831058447068, 43793.78103109496, 44047.0, 44071.77964110159, 44237.77881110574, 45072.098558028985, 9462.810743785085, 9695.660651877291, 9697.854532182022, 9789.951050244703, 9823.508824558743, 15211.391544338103, 15222.771658425132, 15280.694386112438, 15313.157776322409, 15393.153376564396, 6092.822127456064, 6881.311868813179, 6890.655467226618, 6997.195322537871, 7142.9999800027, 3739.5886452490204, 3754.924901502009, 3779.4519794629623, 3780.281746468217, 3812.656860882478, 2701.3651791828906, 2768.4878297515024, 2769.1692492252246, 2769.1692492252246, 2773.9029133980616, 494.658685506999, 496.5258178439582, 500.88730035742395, 503.3154909323317, 521.8669239344019, 588.4909553236505, 614.6527212125135, 615.5075939248583, 620.736187120472, 625.8591816841265, 7835.333996610238, 7859.331956783737, 7892.250236227549, 8020.0, 8258.380621453414, 483.835495931385, 559.9524040456607, 585.0492948957943, 592.4726992976255, 602.3675141101826, 3805.9809700951873, 3806.1436176859984, 3869.903252418712, 3965.900852478711, 4075.9796201018803, 53266.0, 53712.73143634257, 54041.459585403645, 55002.44997549973, 55062.449375505734, 46251.76874115608, 46486.0, 46580.5341946583, 46716.76641616838, 47436.288455673195, 43174.568254317055, 43730.90672733207, 44149.33775993362, 44399.112017759464, 44900.77549612231, 7491.438142139253, 7586.468947173645, 7660.2722741339485, 7742.0, 7811.765647030598, 27790.305242369104, 28568.285792855346, 28968.42063158683, 28974.27564310909, 29284.414311714074, 37263.0, 38223.426648599736, 38379.2324153521, 38490.0, 38881.416778748906, 9395.24838012971, 9404.294677899321, 9427.481488518197, 9441.763955901157, 9538.666146684833, 9540.475273860004, 9831.213502919607, 10017.348872323275, 10151.187904967732, 10283.691489255334, 9430.528473576156, 9489.525523723649, 9545.236381089635, 9554.474503902353, 9569.760755981157, 8425.747227583182, 8494.19305166033, 8554.615042322986, 8779.648814047621, 9014.639414423613, 9280.767980800534, 9462.952685236529, 9594.712158635251, 9635.22918166559, 9651.131398174199, 8130.000398041531, 8276.462029968034, 8386.37102217324, 8650.740477785677, 8681.479111253346, 8317.376196785386, 8441.70454034106, 8472.3645726572, 8551.657933682583, 8824.161704638049], "value": 5702.000612558386, "unit": "score"}], "name": "dromaeo_css", "value": 6277.7016751995425, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 114.0, 112.0, 116.0, 127.0, 115.0, 114.0, 115.0, 113.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 157.0, 178.0, 134.0, 164.0, 159.0, 141.0, 200.0, 133.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 174.0, 163.0, 164.0, 163.0, 164.0, 165.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 166.0, 74.0, 75.0, 73.0, 74.0, 160.0, 79.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 154.0, 94.0, 94.0, 95.0, 151.0, 95.0, 94.0, 143.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 69.0, 65.0, 68.0, 69.0, 90.0, 63.0, 62.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 87.0, 81.0, 81.0, 79.0, 82.0, 80.0, 89.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 138.0, 144.0, 144.0, 136.0, 135.0, 135.0, 167.0, 135.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 180.0, 185.0, 172.0, 177.0, 179.0, 176.0, 175.0, 176.0, 182.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 76.0, 76.0, 75.0, 72.0, 72.0, 71.0, 76.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1609.0, "alertThreshold": 2.0}]} 16:33:02 INFO - Return code: 0 16:33:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:33:02 ERROR - # TBPL SUCCESS # 16:33:02 INFO - Running post-action listener: _resource_record_post_action 16:33:02 INFO - Running post-run listener: _resource_record_post_run 16:33:03 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 237568; Write bytes: 295456768; Read time: 176; Write time: 215656 16:33:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14036992; Read time: 0; Write time: 2820 16:33:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 237568; Write bytes: 281419776; Read time: 176; Write time: 212836 16:33:03 INFO - Running post-run listener: _upload_blobber_files 16:33:03 INFO - Blob upload gear active. 16:33:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:33:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:33:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:33:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:04 INFO - (blobuploader) - INFO - Done attempting. 16:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:33:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:05 INFO - (blobuploader) - INFO - Done attempting. 16:33:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:05 INFO - Return code: 0 16:33:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6994c24beaea308d612a35bcc64b9d1d0bf9c5b062c5d4ac2eae70a71e2cdcf8a4618302ee668429b3cb22be405dfd3c68659359410cde54a08fdaf68a6521b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6805152dbd30ba3d9e60ea7a468c83b7f93345f26994351a6e34c35da49d37753baef0803be0d046c70d23a647965274bec874d78f4c7e6f93f1d5bbe1f0e740"} 16:33:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:05 INFO - Contents: 16:33:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6994c24beaea308d612a35bcc64b9d1d0bf9c5b062c5d4ac2eae70a71e2cdcf8a4618302ee668429b3cb22be405dfd3c68659359410cde54a08fdaf68a6521b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6805152dbd30ba3d9e60ea7a468c83b7f93345f26994351a6e34c35da49d37753baef0803be0d046c70d23a647965274bec874d78f4c7e6f93f1d5bbe1f0e740"} 16:33:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:05 INFO - Copying logs to upload dir... 16:33:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.841181 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-18 16:33:05.665371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:33:05.668378) ========= 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=0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939 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-Non-PGO/sha512/6994c24beaea308d612a35bcc64b9d1d0bf9c5b062c5d4ac2eae70a71e2cdcf8a4618302ee668429b3cb22be405dfd3c68659359410cde54a08fdaf68a6521b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6805152dbd30ba3d9e60ea7a468c83b7f93345f26994351a6e34c35da49d37753baef0803be0d046c70d23a647965274bec874d78f4c7e6f93f1d5bbe1f0e740"} build_url:https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/VooVRGqdTsm7Tw_FNquKKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6994c24beaea308d612a35bcc64b9d1d0bf9c5b062c5d4ac2eae70a71e2cdcf8a4618302ee668429b3cb22be405dfd3c68659359410cde54a08fdaf68a6521b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6805152dbd30ba3d9e60ea7a468c83b7f93345f26994351a6e34c35da49d37753baef0803be0d046c70d23a647965274bec874d78f4c7e6f93f1d5bbe1f0e740"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:33:05.696459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:33:05.697085) ========= 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=0e2a256762fed810e2f0f810000001b3-1461018745.4584-942473939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004759 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:33:05.779228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:33:05.779804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:33:05.780431) ========= ========= Total master_lag: 0.18 =========