builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1466592265.46 results: success (0) buildid: 20160622010102 builduid: 15a2bdba63f94b45ac0a712a9a170911 revision: 800dc20aca781026226a03c3f43ff132b5cfdc1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.458549) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.458961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.459244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.477344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.477630) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 03:44:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.6M=0s 2016-06-22 03:44:26 (41.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.592834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.593154) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020439 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.650588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.651045) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 800dc20aca781026226a03c3f43ff132b5cfdc1d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 800dc20aca781026226a03c3f43ff132b5cfdc1d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 03:44:26,380 truncating revision to first 12 chars 2016-06-22 03:44:26,380 Setting DEBUG logging. 2016-06-22 03:44:26,380 attempt 1/10 2016-06-22 03:44:26,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/800dc20aca78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 03:44:26,696 unpacking tar archive at: mozilla-beta-800dc20aca78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.305315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.305637) ========= script_repo_revision: 800dc20aca781026226a03c3f43ff132b5cfdc1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.306041) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.306310) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.320700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-22 03:44:26.320967) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:27 INFO - MultiFileLogger online at 20160622 03:44:27 in /builds/slave/test 03:44:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:44:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:27 INFO - {'append_to_log': False, 03:44:27 INFO - 'base_work_dir': '/builds/slave/test', 03:44:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:44:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:27 INFO - 'branch': 'Mozilla-Beta', 03:44:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:27 INFO - 'config_files': ('talos/linux_config.py',), 03:44:27 INFO - 'default_actions': ('clobber', 03:44:27 INFO - 'read-buildbot-config', 03:44:27 INFO - 'download-and-extract', 03:44:27 INFO - 'populate-webroot', 03:44:27 INFO - 'create-virtualenv', 03:44:27 INFO - 'install', 03:44:27 INFO - 'run-tests'), 03:44:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:27 INFO - 'download_minidump_stackwalk': True, 03:44:27 INFO - 'download_symbols': 'ondemand', 03:44:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:27 INFO - 'installer_path': 'installer.exe', 03:44:27 INFO - 'log_level': 'info', 03:44:27 INFO - 'log_name': 'talos', 03:44:27 INFO - 'log_to_console': True, 03:44:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:27 INFO - 'opt_config_files': (), 03:44:27 INFO - 'pip_index': False, 03:44:27 INFO - 'sps_profile': False, 03:44:27 INFO - 'sps_profile_interval': 0, 03:44:27 INFO - 'suite': 'dromaeojs-e10s', 03:44:27 INFO - 'system_bits': '32', 03:44:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:27 INFO - 'title': 'talos-linux64-ix-066', 03:44:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:27 INFO - 'use_talos_json': True, 03:44:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:27 INFO - 'work_dir': 'build'} 03:44:27 INFO - ##### 03:44:27 INFO - ##### Running clobber step. 03:44:27 INFO - ##### 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: clobber 03:44:27 INFO - rmtree: /builds/slave/test/build 03:44:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - ##### 03:44:27 INFO - ##### Running read-buildbot-config step. 03:44:27 INFO - ##### 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: read_buildbot_config 03:44:27 INFO - Using buildbot properties: 03:44:27 INFO - { 03:44:27 INFO - "project": "", 03:44:27 INFO - "product": "firefox", 03:44:27 INFO - "script_repo_revision": "production", 03:44:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:44:27 INFO - "repository": "", 03:44:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 03:44:27 INFO - "buildid": "20160622010102", 03:44:27 INFO - "pgo_build": "True", 03:44:27 INFO - "basedir": "/builds/slave/test", 03:44:27 INFO - "buildnumber": 49, 03:44:27 INFO - "slavename": "talos-linux64-ix-066", 03:44:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:44:27 INFO - "platform": "ubuntu64_hw", 03:44:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:44:27 INFO - "branch": "mozilla-beta", 03:44:27 INFO - "repo_path": "releases/mozilla-beta", 03:44:27 INFO - "revision": "800dc20aca781026226a03c3f43ff132b5cfdc1d", 03:44:27 INFO - "stage_platform": "linux64-pgo", 03:44:27 INFO - "builduid": "15a2bdba63f94b45ac0a712a9a170911", 03:44:27 INFO - "slavebuilddir": "test" 03:44:27 INFO - } 03:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - ##### 03:44:27 INFO - ##### Running download-and-extract step. 03:44:27 INFO - ##### 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: download_and_extract 03:44:27 INFO - mkdir: /builds/slave/test/build/tests 03:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:27 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:28 INFO - Downloaded 1327 bytes. 03:44:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:28 INFO - Using the following test package requirements: 03:44:28 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:44:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:28 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 03:44:28 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'jsshell-linux-x86_64.zip'], 03:44:28 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:28 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:44:28 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 03:44:28 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 03:44:28 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:28 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44: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')]} 03:44:28 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:29 INFO - Downloaded 24185922 bytes. 03:44:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:30 INFO - Return code: 0 03:44:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:30 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:43 INFO - Downloaded 24185922 bytes. 03:44:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:44 INFO - Return code: 0 03:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:44 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:45 INFO - Downloaded 10840145 bytes. 03:44:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:44:46 INFO - Return code: 0 03:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:46 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:44:47 INFO - Downloaded 55991552 bytes. 03:44:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:47 INFO - mkdir: /builds/slave/test/properties 03:44:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:47 INFO - Contents: 03:44:47 INFO - build_url:https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:48 INFO - Running post-action listener: _resource_record_post_action 03:44:48 INFO - Running post-action listener: set_extra_try_arguments 03:44:48 INFO - ##### 03:44:48 INFO - ##### Running populate-webroot step. 03:44:48 INFO - ##### 03:44:48 INFO - Running pre-action listener: _resource_record_pre_action 03:44:48 INFO - Running main action method: populate_webroot 03:44:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:48 INFO - '--tppagecycles', 03:44:48 INFO - '7'], 03:44:48 INFO - 'tests': ['tsvgm']}}, 03:44:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['damp', 'tps']}, 03:44:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'tests': ['damp', 'tps']}, 03:44:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['dromaeo_dom']}, 03:44:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['tsvgx', 03:44:48 INFO - 'tsvgr_opacity', 03:44:48 INFO - 'tart', 03:44:48 INFO - 'tscrollx', 03:44:48 INFO - 'cart']}, 03:44:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:48 INFO - 'tsvgr_opacity', 03:44:48 INFO - 'tart', 03:44:48 INFO - 'tscrollx', 03:44:48 INFO - 'cart']}, 03:44:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['tp5o']}, 03:44:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'tests': ['tp5o']}, 03:44:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s', 03:44:48 INFO - '--xperf_path', 03:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:48 INFO - 'tests': ['tp5n']}, 03:44:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:48 INFO - 'talos_options': ['--xperf_path', 03:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:48 INFO - 'tests': ['tp5n']}}, 03:44:48 INFO - 'talos.zip': {'path': '', 03:44:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:48 INFO - Running post-action listener: _resource_record_post_action 03:44:48 INFO - ##### 03:44:48 INFO - ##### Running create-virtualenv step. 03:44:48 INFO - ##### 03:44:48 INFO - Running pre-action listener: _resource_record_pre_action 03:44:48 INFO - Running main action method: create_virtualenv 03:44:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:44:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:48 INFO - Using real prefix '/usr' 03:44:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:50 INFO - Installing pip.................done. 03:44:50 INFO - Return code: 0 03:44:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44: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', 'pip>=1.5'] in /builds/slave/test/build 03:44: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 pip>=1.5 03:44:50 INFO - Using env: {'DISPLAY': ':0', 03:44:50 INFO - 'HOME': '/home/cltbld', 03:44:50 INFO - 'LANG': 'en_US.UTF-8', 03:44:50 INFO - 'LANGUAGE': 'en_US:en', 03:44:50 INFO - 'LOGNAME': 'cltbld', 03:44:50 INFO - 'MAIL': '/var/mail/cltbld', 03:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:50 INFO - 'MOZ_NO_REMOTE': '1', 03:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:50 INFO - 'NO_EM_RESTART': '1', 03:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:50 INFO - 'PWD': '/builds/slave/test', 03:44:50 INFO - 'SHELL': '/bin/bash', 03:44:50 INFO - 'SHLVL': '1', 03:44:50 INFO - 'TERM': 'linux', 03:44:50 INFO - 'TMOUT': '86400', 03:44:50 INFO - 'USER': 'cltbld', 03:44:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:50 INFO - '_': '/tools/buildbot/bin/python'} 03:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:44:50 INFO - Cleaning up... 03:44:50 INFO - Return code: 0 03:44:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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', '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 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:44: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 psutil>=0.7.1 03:44:50 INFO - Using env: {'DISPLAY': ':0', 03:44:50 INFO - 'HOME': '/home/cltbld', 03:44:50 INFO - 'LANG': 'en_US.UTF-8', 03:44:50 INFO - 'LANGUAGE': 'en_US:en', 03:44:50 INFO - 'LOGNAME': 'cltbld', 03:44:50 INFO - 'MAIL': '/var/mail/cltbld', 03:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:50 INFO - 'MOZ_NO_REMOTE': '1', 03:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:50 INFO - 'NO_EM_RESTART': '1', 03:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:50 INFO - 'PWD': '/builds/slave/test', 03:44:50 INFO - 'SHELL': '/bin/bash', 03:44:50 INFO - 'SHLVL': '1', 03:44:50 INFO - 'TERM': 'linux', 03:44:50 INFO - 'TMOUT': '86400', 03:44:50 INFO - 'USER': 'cltbld', 03:44:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:50 INFO - '_': '/tools/buildbot/bin/python'} 03:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:51 INFO - Downloading/unpacking psutil>=0.7.1 03:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:53 INFO - Installing collected packages: psutil 03:44:53 INFO - Running setup.py install for psutil 03:44:53 INFO - building 'psutil._psutil_linux' extension 03:44:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:44:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:44:53 INFO - building 'psutil._psutil_posix' extension 03:44:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:44:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:44:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:53 INFO - Successfully installed psutil 03:44:53 INFO - Cleaning up... 03:44:53 INFO - Return code: 0 03:44:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:53 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 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:44:53 INFO - Using env: {'DISPLAY': ':0', 03:44:53 INFO - 'HOME': '/home/cltbld', 03:44:53 INFO - 'LANG': 'en_US.UTF-8', 03:44:53 INFO - 'LANGUAGE': 'en_US:en', 03:44:53 INFO - 'LOGNAME': 'cltbld', 03:44:53 INFO - 'MAIL': '/var/mail/cltbld', 03:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:53 INFO - 'MOZ_NO_REMOTE': '1', 03:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:53 INFO - 'NO_EM_RESTART': '1', 03:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:53 INFO - 'PWD': '/builds/slave/test', 03:44:53 INFO - 'SHELL': '/bin/bash', 03:44:53 INFO - 'SHLVL': '1', 03:44:53 INFO - 'TERM': 'linux', 03:44:53 INFO - 'TMOUT': '86400', 03:44:53 INFO - 'USER': 'cltbld', 03:44:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:53 INFO - '_': '/tools/buildbot/bin/python'} 03:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:44:55 INFO - Installing collected packages: mozsystemmonitor 03:44:55 INFO - Running setup.py install for mozsystemmonitor 03:44:56 INFO - Successfully installed mozsystemmonitor 03:44:56 INFO - Cleaning up... 03:44:56 INFO - Return code: 0 03:44:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:44:56 INFO - Using env: {'DISPLAY': ':0', 03:44:56 INFO - 'HOME': '/home/cltbld', 03:44:56 INFO - 'LANG': 'en_US.UTF-8', 03:44:56 INFO - 'LANGUAGE': 'en_US:en', 03:44:56 INFO - 'LOGNAME': 'cltbld', 03:44:56 INFO - 'MAIL': '/var/mail/cltbld', 03:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:56 INFO - 'MOZ_NO_REMOTE': '1', 03:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:56 INFO - 'NO_EM_RESTART': '1', 03:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:56 INFO - 'PWD': '/builds/slave/test', 03:44:56 INFO - 'SHELL': '/bin/bash', 03:44:56 INFO - 'SHLVL': '1', 03:44:56 INFO - 'TERM': 'linux', 03:44:56 INFO - 'TMOUT': '86400', 03:44:56 INFO - 'USER': 'cltbld', 03:44:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:56 INFO - '_': '/tools/buildbot/bin/python'} 03:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:58 INFO - Downloading docopt-0.6.1.tar.gz 03:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:59 INFO - Running setup.py install for blobuploader 03:44:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:59 INFO - Running setup.py install for requests 03:44:59 INFO - Running setup.py install for docopt 03:44:59 INFO - Successfully installed blobuploader requests docopt 03:44:59 INFO - Cleaning up... 03:44:59 INFO - Return code: 0 03:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:44:59 INFO - Using env: {'DISPLAY': ':0', 03:44:59 INFO - 'HOME': '/home/cltbld', 03:44:59 INFO - 'LANG': 'en_US.UTF-8', 03:44:59 INFO - 'LANGUAGE': 'en_US:en', 03:44:59 INFO - 'LOGNAME': 'cltbld', 03:44:59 INFO - 'MAIL': '/var/mail/cltbld', 03:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:59 INFO - 'MOZ_NO_REMOTE': '1', 03:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:59 INFO - 'NO_EM_RESTART': '1', 03:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:59 INFO - 'PWD': '/builds/slave/test', 03:44:59 INFO - 'SHELL': '/bin/bash', 03:44:59 INFO - 'SHLVL': '1', 03:44:59 INFO - 'TERM': 'linux', 03:44:59 INFO - 'TMOUT': '86400', 03:44:59 INFO - 'USER': 'cltbld', 03:44:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:59 INFO - '_': '/tools/buildbot/bin/python'} 03:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:59 INFO - Running setup.py (path:/tmp/pip-kMSeYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:59 INFO - Running setup.py (path:/tmp/pip-NJd63_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:59 INFO - Running setup.py (path:/tmp/pip-JJki3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:00 INFO - Running setup.py (path:/tmp/pip-vdWfu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:00 INFO - Running setup.py (path:/tmp/pip-jpksqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:00 INFO - Running setup.py (path:/tmp/pip-gMw9VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:00 INFO - Running setup.py (path:/tmp/pip-p9JNh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:00 INFO - Running setup.py (path:/tmp/pip-DLW3Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:00 INFO - Running setup.py (path:/tmp/pip-esSgKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:00 INFO - Running setup.py (path:/tmp/pip-nkAX06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:00 INFO - Running setup.py (path:/tmp/pip-PMX6xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:00 INFO - Running setup.py (path:/tmp/pip-UnYun4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:00 INFO - Running setup.py (path:/tmp/pip-w2BPe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:00 INFO - Running setup.py (path:/tmp/pip-Z9FWI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:00 INFO - Running setup.py (path:/tmp/pip-LAyvv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:00 INFO - Running setup.py (path:/tmp/pip-33obo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:00 INFO - Running setup.py (path:/tmp/pip-cLihiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:01 INFO - Running setup.py install for manifestparser 03:45:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Running setup.py install for mozcrash 03:45:01 INFO - Running setup.py install for mozdebug 03:45:01 INFO - Running setup.py install for mozdevice 03:45:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Running setup.py install for mozfile 03:45:01 INFO - Running setup.py install for mozhttpd 03:45:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Running setup.py install for mozinfo 03:45:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Running setup.py install for mozInstall 03:45:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:01 INFO - Running setup.py install for mozleak 03:45:01 INFO - Running setup.py install for mozlog 03:45:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:02 INFO - Running setup.py install for moznetwork 03:45:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:02 INFO - Running setup.py install for mozprocess 03:45:02 INFO - Running setup.py install for mozprofile 03:45:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:02 INFO - Running setup.py install for mozrunner 03:45:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:02 INFO - Running setup.py install for mozscreenshot 03:45:02 INFO - Running setup.py install for moztest 03:45:02 INFO - Running setup.py install for mozversion 03:45:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:02 INFO - Cleaning up... 03:45:02 INFO - Return code: 0 03:45:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:02 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 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:02 INFO - Using env: {'DISPLAY': ':0', 03:45:02 INFO - 'HOME': '/home/cltbld', 03:45:02 INFO - 'LANG': 'en_US.UTF-8', 03:45:02 INFO - 'LANGUAGE': 'en_US:en', 03:45:02 INFO - 'LOGNAME': 'cltbld', 03:45:02 INFO - 'MAIL': '/var/mail/cltbld', 03:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:02 INFO - 'MOZ_NO_REMOTE': '1', 03:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:02 INFO - 'NO_EM_RESTART': '1', 03:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:02 INFO - 'PWD': '/builds/slave/test', 03:45:02 INFO - 'SHELL': '/bin/bash', 03:45:02 INFO - 'SHLVL': '1', 03:45:02 INFO - 'TERM': 'linux', 03:45:02 INFO - 'TMOUT': '86400', 03:45:02 INFO - 'USER': 'cltbld', 03:45:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:02 INFO - '_': '/tools/buildbot/bin/python'} 03:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:03 INFO - Running setup.py (path:/tmp/pip-StlFrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:03 INFO - Running setup.py (path:/tmp/pip-Sba4i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:03 INFO - Running setup.py (path:/tmp/pip-bBeZo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:03 INFO - Running setup.py (path:/tmp/pip-csmrqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:03 INFO - Running setup.py (path:/tmp/pip-ArprNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:03 INFO - Running setup.py (path:/tmp/pip-nqsPjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:03 INFO - Running setup.py (path:/tmp/pip-qh8qi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:03 INFO - Running setup.py (path:/tmp/pip-bp2EI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:03 INFO - Running setup.py (path:/tmp/pip-nGFdcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:03 INFO - Running setup.py (path:/tmp/pip-LhgmBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:03 INFO - Running setup.py (path:/tmp/pip-OqzK7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:03 INFO - Running setup.py (path:/tmp/pip-xQXF6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:03 INFO - Running setup.py (path:/tmp/pip-0rp76n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:04 INFO - Running setup.py (path:/tmp/pip-3AXpb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:04 INFO - Running setup.py (path:/tmp/pip-JdsGSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:04 INFO - Running setup.py (path:/tmp/pip-ahasuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:04 INFO - Running setup.py (path:/tmp/pip-w5gdsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:06 INFO - Downloading blessings-1.6.tar.gz 03:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:06 INFO - Installing collected packages: blessings 03:45:06 INFO - Running setup.py install for blessings 03:45:06 INFO - Successfully installed blessings 03:45:06 INFO - Cleaning up... 03:45:06 INFO - Return code: 0 03:45:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:06 INFO - Reading from file tmpfile_stdout 03:45:06 INFO - Current package versions: 03:45:06 INFO - argparse == 1.2.1 03:45:06 INFO - blessings == 1.6 03:45:06 INFO - blobuploader == 1.2.4 03:45:06 INFO - docopt == 0.6.1 03:45:06 INFO - manifestparser == 1.1 03:45:06 INFO - mozInstall == 1.12 03:45:06 INFO - mozcrash == 0.17 03:45:06 INFO - mozdebug == 0.1 03:45:06 INFO - mozdevice == 0.48 03:45:06 INFO - mozfile == 1.2 03:45:06 INFO - mozhttpd == 0.7 03:45:06 INFO - mozinfo == 0.9 03:45:06 INFO - mozleak == 0.1 03:45:06 INFO - mozlog == 3.1 03:45:06 INFO - moznetwork == 0.27 03:45:06 INFO - mozprocess == 0.22 03:45:06 INFO - mozprofile == 0.28 03:45:06 INFO - mozrunner == 6.11 03:45:06 INFO - mozscreenshot == 0.1 03:45:06 INFO - mozsystemmonitor == 0.0 03:45:06 INFO - moztest == 0.7 03:45:06 INFO - mozversion == 1.4 03:45:06 INFO - psutil == 3.1.1 03:45:06 INFO - requests == 1.2.3 03:45:06 INFO - wsgiref == 0.1.2 03:45:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:06 INFO - Using env: {'DISPLAY': ':0', 03:45:06 INFO - 'HOME': '/home/cltbld', 03:45:06 INFO - 'LANG': 'en_US.UTF-8', 03:45:06 INFO - 'LANGUAGE': 'en_US:en', 03:45:06 INFO - 'LOGNAME': 'cltbld', 03:45:06 INFO - 'MAIL': '/var/mail/cltbld', 03:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:06 INFO - 'MOZ_NO_REMOTE': '1', 03:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:06 INFO - 'NO_EM_RESTART': '1', 03:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:06 INFO - 'PWD': '/builds/slave/test', 03:45:06 INFO - 'SHELL': '/bin/bash', 03:45:06 INFO - 'SHLVL': '1', 03:45:06 INFO - 'TERM': 'linux', 03:45:06 INFO - 'TMOUT': '86400', 03:45:06 INFO - 'USER': 'cltbld', 03:45:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:06 INFO - '_': '/tools/buildbot/bin/python'} 03:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:06 INFO - Cleaning up... 03:45:06 INFO - Return code: 0 03:45:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:06 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 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:45:06 INFO - Using env: {'DISPLAY': ':0', 03:45:06 INFO - 'HOME': '/home/cltbld', 03:45:06 INFO - 'LANG': 'en_US.UTF-8', 03:45:06 INFO - 'LANGUAGE': 'en_US:en', 03:45:06 INFO - 'LOGNAME': 'cltbld', 03:45:06 INFO - 'MAIL': '/var/mail/cltbld', 03:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:06 INFO - 'MOZ_NO_REMOTE': '1', 03:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:06 INFO - 'NO_EM_RESTART': '1', 03:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:06 INFO - 'PWD': '/builds/slave/test', 03:45:06 INFO - 'SHELL': '/bin/bash', 03:45:06 INFO - 'SHLVL': '1', 03:45:06 INFO - 'TERM': 'linux', 03:45:06 INFO - 'TMOUT': '86400', 03:45:06 INFO - 'USER': 'cltbld', 03:45:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:06 INFO - '_': '/tools/buildbot/bin/python'} 03:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:07 INFO - Downloading/unpacking jsonschema 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:09 INFO - Downloading/unpacking functools32 (from jsonschema) 03:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:09 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:09 INFO - warning: no files found matching '*.txt' 03:45:09 INFO - no previously-included directories found matching 'build' 03:45:09 INFO - no previously-included directories found matching 'dist' 03:45:09 INFO - no previously-included directories found matching '.git*' 03:45:09 INFO - Installing collected packages: jsonschema, functools32 03:45:09 INFO - Running setup.py install for functools32 03:45:09 INFO - warning: no files found matching '*.txt' 03:45:09 INFO - no previously-included directories found matching 'build' 03:45:09 INFO - no previously-included directories found matching 'dist' 03:45:09 INFO - no previously-included directories found matching '.git*' 03:45:09 INFO - Successfully installed jsonschema functools32 03:45:09 INFO - Cleaning up... 03:45:09 INFO - Return code: 0 03:45:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2478bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:45:09 INFO - Using env: {'DISPLAY': ':0', 03:45:09 INFO - 'HOME': '/home/cltbld', 03:45:09 INFO - 'LANG': 'en_US.UTF-8', 03:45:09 INFO - 'LANGUAGE': 'en_US:en', 03:45:09 INFO - 'LOGNAME': 'cltbld', 03:45:09 INFO - 'MAIL': '/var/mail/cltbld', 03:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:09 INFO - 'MOZ_NO_REMOTE': '1', 03:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:09 INFO - 'NO_EM_RESTART': '1', 03:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:09 INFO - 'PWD': '/builds/slave/test', 03:45:09 INFO - 'SHELL': '/bin/bash', 03:45:09 INFO - 'SHLVL': '1', 03:45:09 INFO - 'TERM': 'linux', 03:45:09 INFO - 'TMOUT': '86400', 03:45:09 INFO - 'USER': 'cltbld', 03:45:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:09 INFO - '_': '/tools/buildbot/bin/python'} 03:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:09 INFO - Downloading/unpacking flake8 03:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:45:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:45:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:45:12 INFO - no previously-included directories found matching 'docs/_build' 03:45:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:45:12 INFO - Running setup.py install for pep8 03:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:45:12 INFO - no previously-included directories found matching 'docs/_build' 03:45:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:45:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:45:12 INFO - Cleaning up... 03:45:12 INFO - Return code: 0 03:45:12 INFO - Running post-action listener: _resource_record_post_action 03:45:12 INFO - Running post-action listener: _start_resource_monitoring 03:45:12 INFO - Starting resource monitoring. 03:45:12 INFO - ##### 03:45:12 INFO - ##### Running install step. 03:45:12 INFO - ##### 03:45:12 INFO - Running pre-action listener: _resource_record_pre_action 03:45:12 INFO - Running main action method: install 03:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:12 INFO - Reading from file tmpfile_stdout 03:45:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:12 INFO - Reading from file tmpfile_stdout 03:45:12 INFO - Output received: 03:45:12 INFO - Usage: mozinstall [options] installer 03:45:12 INFO - Options: 03:45:12 INFO - -h, --help show this help message and exit 03:45:12 INFO - -d DEST, --destination=DEST 03:45:12 INFO - Directory to install application into. [default: 03:45:12 INFO - "/builds/slave/test"] 03:45:12 INFO - --app=APP Application being installed. [default: firefox] 03:45:12 INFO - mkdir: /builds/slave/test/build/application 03:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:45:26 INFO - Reading from file tmpfile_stdout 03:45:26 INFO - Output received: 03:45:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:45:26 INFO - Running post-action listener: _resource_record_post_action 03:45:26 INFO - ##### 03:45:26 INFO - ##### Running run-tests step. 03:45:26 INFO - ##### 03:45:26 INFO - Running pre-action listener: _resource_record_pre_action 03:45:26 INFO - Running main action method: run_tests 03:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:26 INFO - Python 2.7.3 03:45:26 INFO - Return code: 0 03:45:26 INFO - grabbing minidump binary from tooltool 03:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:26 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 0x26e5410>, '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 0x26e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:45:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:45:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:26 INFO - Return code: 0 03:45:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:45:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:45:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:45:27 INFO - Return code: 0 03:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:45:27 INFO - Using env: {'DISPLAY': ':0', 03:45:27 INFO - 'HOME': '/home/cltbld', 03:45:27 INFO - 'LANG': 'en_US.UTF-8', 03:45:27 INFO - 'LANGUAGE': 'en_US:en', 03:45:27 INFO - 'LOGNAME': 'cltbld', 03:45:27 INFO - 'MAIL': '/var/mail/cltbld', 03:45:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:27 INFO - 'MOZ_NO_REMOTE': '1', 03:45:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:27 INFO - 'NO_EM_RESTART': '1', 03:45:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:27 INFO - 'PWD': '/builds/slave/test', 03:45:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:27 INFO - 'SHELL': '/bin/bash', 03:45:27 INFO - 'SHLVL': '1', 03:45:27 INFO - 'TERM': 'linux', 03:45:27 INFO - 'TMOUT': '86400', 03:45:27 INFO - 'USER': 'cltbld', 03:45:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547', 03:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:27 INFO - '_': '/tools/buildbot/bin/python'} 03:45:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:45:27 INFO - mozversion application_buildid: 20160622010102 03:45:27 INFO - mozversion application_changeset: 800dc20aca781026226a03c3f43ff132b5cfdc1d 03:45:27 INFO - mozversion application_display_name: Firefox 03:45:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:27 INFO - mozversion application_name: Firefox 03:45:27 INFO - mozversion application_remotingname: firefox 03:45:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:45:27 INFO - mozversion application_vendor: Mozilla 03:45:27 INFO - mozversion application_version: 48.0 03:45:27 INFO - mozversion platform_buildid: 20160622010102 03:45:27 INFO - mozversion platform_changeset: 800dc20aca781026226a03c3f43ff132b5cfdc1d 03:45:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:45:27 INFO - mozversion platform_version: 48.0 03:45:27 INFO - using testdate: 1466592327 03:45:27 INFO - actual date: 1466592327 03:45:27 INFO - starting webserver on 'localhost:35171' 03:45:27 INFO - SUITE-START | Running 2 tests 03:45:27 INFO - TEST-START | dromaeo_css 03:45:27 INFO - operating with platform_type : linux_ 03:45:27 INFO - Initialising browser for dromaeo_css test... 03:45:27 INFO - TEST-INFO | started process 5105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGsE8d/profile http://localhost:35171/getInfo.html) 03:45:31 INFO - PROCESS | 5105 | 03:45:31 INFO - PROCESS | 5105 | (process:5184): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:31 INFO - PROCESS | 5105 | __metrics Screen width/height:1600/1200 03:45:31 INFO - PROCESS | 5105 | colorDepth:24 03:45:31 INFO - PROCESS | 5105 | Browser inner width/height: 1024/697 03:45:31 INFO - PROCESS | 5105 | __metrics 03:45:32 ERROR - PROCESS | 5105 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 03:45:33 INFO - TEST-INFO | 5105: exit 0 03:45:33 INFO - Browser initialized. 03:45:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:33 INFO - TEST-INFO | started process 5234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGsE8d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:35 INFO - PROCESS | 5234 | 03:45:35 INFO - PROCESS | 5234 | (process:5300): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:45 INFO - PROCESS | 5234 | RSS: Main: 151425024 03:45:45 INFO - PROCESS | 5234 | 03:46:34 INFO - PROCESS | 5234 | 1466592394789 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] 03:48:42 INFO - PROCESS | 5234 | Cycle 1(1): loaded http://localhost:35171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35171/tests/dromaeo/cssquery-ext.html) 03:48:43 INFO - PROCESS | 5234 | RSS: Main: 155742208 03:48:43 INFO - PROCESS | 5234 | 03:51:45 INFO - PROCESS | 5234 | Cycle 1(1): loaded http://localhost:35171/tests/dromaeo/cssquery-ext.html (next: http://localhost:35171/tests/dromaeo/cssquery-jquery.html) 03:51:45 INFO - PROCESS | 5234 | RSS: Main: 153026560 03:51:45 INFO - PROCESS | 5234 | 03:54:47 INFO - PROCESS | 5234 | Cycle 1(1): loaded http://localhost:35171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35171/tests/dromaeo/cssquery-mootools.html) 03:54:48 INFO - PROCESS | 5234 | RSS: Main: 152813568 03:54:48 INFO - PROCESS | 5234 | 03:57:49 INFO - PROCESS | 5234 | Cycle 1(1): loaded http://localhost:35171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35171/tests/dromaeo/cssquery-prototype.html) 03:57:50 INFO - PROCESS | 5234 | RSS: Main: 154050560 03:57:50 INFO - PROCESS | 5234 | 04:00:52 INFO - PROCESS | 5234 | Cycle 1(1): loaded http://localhost:35171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35171/tests/dromaeo/cssquery-yui.html) 04:00:53 INFO - PROCESS | 5234 | RSS: Main: 152465408 04:00:53 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | Cycle 1(1): loaded http://localhost:35171/tests/dromaeo/cssquery-yui.html (next: http://localhost:35171/tests/dromaeo/cssquery-dojo.html) 04:03:55 INFO - PROCESS | 5234 | RSS: Main: 156135424 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | __start_tp_report 04:03:55 INFO - PROCESS | 5234 | _x_x_mozilla_page_load 04:03:55 INFO - PROCESS | 5234 | _x_x_mozilla_page_load_details 04:03:55 INFO - PROCESS | 5234 | |i|pagename|runs| 04:03:55 INFO - PROCESS | 5234 | |0;dojo.html;3375.6455572164923;3453.620101788803;3453.7064349530287;3493.45851393034;3495.091276268171;5670.68811215383;5675.3189617245935;5677.744501497432;5679.659220446776;5691.601587888844;5676.460736230062;5681.8579535511635;5704.286964129484;5715.828525144242;5721.370649228592;5116.692998420088;5125.820596279131;5150.098732721777;5209.895802083956;5220.190870415092;5137.2037334213255;5199.428062913076;5220.6606570572985;5223.085959957011;5237.947620523784;5177.58579313654;5193.584513238932;5198.7660555274915;5256.710880901549;5275.28783614211;5314.893702125955;5321.042212401766;5321.547668448186;5330.626856120073;5331.920021199685;5038.84883453497;5147.922781158248;5229.47705229474;5272.446393128743;5277;5632.971835140839;5676.659400435987;5710.2862142232225;5728.856778580527;5762.510186634141;6057.091436284549;6081.057436097412;6095.299040610343;6125.816225513242;6146.262448506163;5964.194833697438;6113.050656958994;6128.3258841527395;6151.5386346024225;6164.568480206387;5740.5981581289325;5740.655560666331;5740.655560666373;5754.280714910678;5792.131180322943;6255.218097737783;6283.748650054038;6300.779472718433;6302.4958003359625;6311.589746666452;5877.529797616266;6018.789342372996;6051.0923361496125;6060.2424696912885;6074.726637301332;6111.500579230309;6111.829668689647;6125.572745538934;6125.998614523584;6146.846328841814;5994.910076348859;6004.369541198199;6062.42406971337;6080.118382834465;6107.84730381744;6017.0974353846395;6084.178635884187;6112.419320164578;6133.73253493014;6151.046587778901;4628.190066738307;4630.189716799547;4635.559621835921;4641.512641172696;4648.395708557933;4141.378793180987;4150.27370210218;4161.146964872194;4166.604172603658;4167.291560434734;5819.854503637443;5993.850153746104;6005.219321488178;6022.608530445507;6053.303870055;6210.627362358273;6215.875682486416;6265.122882796412;6291.339409362043;6292.528060395489;5860.560457965669;5972.641641501524;6019.637687647319;6025.457708806229;6039.7282122304605;5221.765020574083;5259.21111833228;5272.393674727378;5284.656497327662;5300.946990530122;6254.781082662085;6292.937070629235;6293.622382657055;6294;6322.33615470369;6091.42131497507;6175.567710260419;6176.227971503562;6181.196444462191;6283.057541368831;6362.045693146065;6441.452476539359;6442.645654489048;6446.645434501147;6451.1936007999;6030.819075427744;6075.483583895419;6078.149059131637;6104.816855494342;6107.6640784757265;6068.8786224276155;6119.898632333192;6154.169187159676;6201.565890387629;6206.441420272197;5839.357670656309;5846.210761547137;5858.502027327554;5907.5273978080795;5929.1995580597795;5876.294844618673;5879.412058794257;5879.882402352015;5889.852753681193;5893.410658934073;5812.273465816773;5834.27071616048;5896.439838215363;5965.224520812267;6009.879802404015;6005.798840231883;6013.368596297326;6019.398060194121;6028.487578555872;6030.698465076816;5889.352171261072;5903.498202652822;5906.70466476683;5909.970450147722;5921.5854890159 04:03:55 INFO - PROCESS | 5234 | |1;ext.html;670.7920544631164;671.2448495442626;687.8968154776779;731.9743808966684;732.6007326007325;31630.367392652162;38261;38731.61268387315;38742.41886371703;38925;42359.36460953081;43049.35425968613;43074.56925430745;43096;43143.35284970728;8977.955110224457;9135.497547634877;9162.72511824643;9166.770830729218;9192.35653504255;8906.599203035847;9022.233110185642;9043.909560904372;9049.683261085864;9091.090890910922;9058.547072646374;9112.134347237003;9118.316126290521;9120.31597630177;9127.406718563272;9009.144131307516;9051.094890510962;9058.411203271766;9066.138716821892;9085;8900.154485323885;8912.420692654956;8922.598483068212;8934.329925255632;8987.910120898772;42901;43260.13479730419;43301;43317.35023974643;43518.56481435177;3835.789031603261;3981.6416522512823;4043.2722110020186;4075.572064933169;4247.200663250507;33360.49959250589;33444.355116572864;33934.660653393395;33952;35255.471167932505;4476.55234476553;4479.596836284717;4498.190325741365;4539.500654927955;4551.5676010778925;305667;306424;306651;306912;308532;61964;61996.690016549626;62021.689891551156;62300;62417.37582624207;64095;69443.65278173577;70772.64613677001;71289.6435517819;71334;19351.322703705584;19638.90180549088;19640.116194771268;19649.115789789495;19655.803441965396;15232.695346093016;15262.771058433911;15272.31274592646;15287.235638218044;15297.005694629814;20217.595648086957;20292.289769857984;21072.789272107082;21198.576028479343;21271.8936405317;7629.3133617974645;7783.455158138876;7834.451588388872;7936.2857342839425;7948.602569871483;1096.950637221327;1121.1199208621192;1173.7359094203737;1193.7254431480808;1198.7782260281701;33290.334193316485;33448.66551334504;33507.664923350945;33670.137883522635;34500.82749586286;1206.9517219311128;1245.4893493667553;1249.4752204074312;1259.4080782032431;1279.7842050052302;17375.826241737675;17463.21415536304;17611.55971100733;17639.206235719423;17682;457814;527113;535516;539146.3042684762;779271;61633.69183154145;63666;63917;64015;64125.67937160378;1544.7760074789317;1552.301464341051;1555.7899683542803;1559.7504399296058;1652.628158664315;32682.509762353107;33702.49446258259;33746.15634609154;34060.1484962868;34516;55520.72239638776;56335;56380;56423.43576564182;56565.43434565602;436380;441597;442213;444410;445420;45018.549814501435;45654;46591.30113048239;46849.2972605418;47207;50660.24009639932;50967;51493.742531288604;51627.48372516227;52119.73940130275;42359;43731.34402984021;43829.34255986099;43901;43984.780076099414;42979.14041719211;43492.56507434885;43835.56164438443;44312.335314970944;44435.889102772686;44372.33441498445;44617.33074003957;44804.55195448134;45244.77377613223;45271.320930185415;37618.43572346472;37851.810740946115;38742.418863716506;39020.804895975336;39650;29440.26399339948;29895;29960.70039299579;30436.695633043386;30467.238319041313 04:03:55 INFO - PROCESS | 5234 | |2;jquery.html;435.5927208060465;444.0807528416178;445.0986751827549;452.2741000693884;458.40636375893234;19118.33085841996;19301.99999999998;19782.505437364056;20377.28679496218;20385.49036274094;19758.506037349074;20195.495112622193;20310;20749.792502074975;20752.06615702293;5647.774089036434;5867.765289388441;5944.316403613575;5963.761449542013;5977.1034344848185;5803.593748437611;5872.207252020965;5879.617824841393;5894.970525147368;5915.911261331084;5677.886442271152;5863.149843272723;5927.792527261547;5928.1404196391495;5942.376050514698;5759.280089988752;5808.506276966484;5852.590318677694;5857.707114644293;5886.411358864122;5097.1844504879045;5325.227841962933;5326.92009619856;5331.5734741220995;5339.3058902342445;23358.416039598975;23825.642615360783;24520.264392068268;24594.385140371454;24624.138155164484;2435.342457536473;2451.3136321829916;2521.4957008598353;2608.0480624571896;3079.9846000769853;7610.961945190294;14660;15561.922190388976;15667.92166039174;15888.841111588852;2063.8142567168875;2114.238874005357;2128.8509804313703;2168.6530155175255;2189.7372315322104;73084.63457682784;78215;80187.59906200432;81398.18601813965;81954.59022704848;10239.692809215736;11178.329300242012;11741.706457338463;11830.822537661941;11884.049276057895;16873.831261687472;17072.658546828992;17173.91413042952;17223.39718109885;17259.137043148043;9232.353735238468;9425.151736343762;9448.149666530046;9456.574454149442;9530.142287194185;9202.217811486098;9257.61135829631;9257.861132083024;9265.119813617695;9362.391444556082;5118.462561431071;5205.375354957354;5210.244514545446;5224.216367544898;5243.554297884646;2119.311223852254;2128.5636444528836;2151.354593621907;2161.5352699169753;2165.101482884617;1004.9547770350351;1021.5957584378702;1023.3399457350116;1030.845373194012;1142.2575326037975;19247.807521924882;19629.116689748997;19643.31248406299;19729;20208.797912020986;1083.9241253112364;1091.8471414002047;1107.1364335818075;1137.7440075982838;1151.4300421291514;10946.945265273622;11171.16216283782;11287.548498059985;11337.773244535063;11412.714682133013;540454;544452;546058.3485412897;550553;558933;77267.61366193133;87284;97266;98233;101158;1038.3665963762098;1054.746860753429;1110.294962698676;1154.9826752598717;1158.264502041193;17045.744313835054;18004.819951800313;18293.26826926908;18312;18328.725069123706;38190.80904595459;38540.22919541538;39058.218835623695;39101.80449097736;39723.60276397199;49528.50471495239;51326.74336628293;51389;51563.48436515587;56622.71688641531;9353.579088940878;9423.905760942303;9454.669086581936;9467.66863159786;9594.520273986132;12449.751004980031;13916;13938.651533711738;14174.433022678977;14289.64275893111;12179.87820121823;12318.507259709511;12376.257424554555;12396.504139834306;12446.43991020388;11163;11752.70618234551;11762.235454695418;12052.156349055833;12191.573294934635;6446.742130314922;8468.830623387374;12327.506899724269;12460.626181214579;12888.226706397647;9400.29497787655;9517.809643806946;9677.467739274407;9695.66065187715;9699.981501942195;10867.51096200657;11535.192536522363;12162.756744864877;12340.938295308466;12598.307093109966 04:03:55 INFO - PROCESS | 5234 | |3;mootools.html;1530.4490383461955;1559.9844001559984;1796.4251439539344;1906.961860762784;1913.8086191380855;7707.190744971767;8376.41365104443;8522.701705440302;8748.693795717143;8765.123487651239;8427.536485493296;8483.575821208946;8582.613782379793;8647.092055334193;8675.219230269275;2437.463757973243;2470.147799009339;2474.5174690935273;2481.2432208176497;2487.763662452064;2470.6170543565777;2522.533331333709;2527.0523553667376;2532.11376018393;2532.8353657012235;2455.2511483997373;2459.3359792855917;2464.322311364371;2465.0263146057296;2469.901203951849;2406.3743426709007;2409.3494756415757;2416.565018296706;2500.037485568051;2509.749025097494;2452.828302018859;2455.177515532299;2480.379905023744;2482.7765501104986;2483.3046746910895;8711.956440217822;8913.974892887336;8917.42036767608;8924.241439477652;8987.820243595157;5356.946430535684;5442.12925931849;5470.507654311092;5476.342838859362;5476.561875049986;3527.065327688165;3539.876104336336;3566.892993210208;3613.7109031277437;3625.4743062255825;1165.2251252916801;1172.1033409441784;1177.2524446976147;1187.4953144913463;1192.7614477104614;12288.877111228952;12326.50693972249;12333.198342107735;12353.691157721129;12395.256284622861;4704.647151463654;4713.457952335457;4736.579026292098;4793.9280910786365;4871.8294859679745;9900.059494348025;9909.108180263811;9912.55393507294;9938.801223975624;9956.203503719686;5496.7526461309335;5540.252065971123;5556.222128901876;5558.722063896789;5585.609007369527;4518.480374756879;4963.925541116886;5081.441041485434;5086.92369614456;5180.4560521145495;3964;4068.105016896278;4073.042834933788;4157.688173387008;4168.979155104205;1195.3306148556835;1222.6611860013272;1228.668259569911;1229.3791635224154;1233.2045830439317;919.5861862162054;1058.2803693488347;1060.4803646213454;1066.3708412036935;1087.6193332333619;5785.987452195849;5911.615744976562;6016.1878146450545;6206.06908963659;6215.285242197115;433.28075394844404;442.4756663353936;448.2849854482161;455.77666943198255;461.0686413444823;4050.9797451012555;4062.7765472899273;4084.81618327176;4088.9182216356103;4098.713090083726;10710.946445267724;10992.28550144238;11164.944175279072;11177.329360238411;11204;10948.178886583379;10949.014588687056;10964.945175274073;11042.282251653778;11060.778784424427;8492.40553161285;8558.144185581392;8606.698765543177;8611.61247743853;8625.568721563897;5666.376698563073;5859.853503662443;5867.266591676041;5907.113932910098;5942.346341902301;9900.50497475109;9934.652287170204;9944.651937182163;10030.749231269278;10031.097201251923;9482.38364506305;9984.60061597528;10180.847287290844;10232.693019209435;10336.328138670962;7505.136909255505;7540.585267810104;7570.356519695888;7704.884426733492;7706;8357.916420835714;8394.916050839414;8417.789555261168;8435.198656127657;8441.620127094418;7452.105747310357;7646.235376462309;7918.049834019724;7969.681212751425;7972.720954766787;7523.398128149625;7526.285002924714;7576.090869095744;7613;7615.390768738377;6953.756618518328;6966.686499107654;6973.895391569029;6993.950907363733;6995.790126296016;5073.137566613758;5157.819476318311;5194.766235519335;5203.5576975957465;5228.241904923689;5043.798248070183;5045.722485263345;5091.92362114576;5114.769835357343;5184 04:03:55 INFO - PROCESS | 5234 | |4;prototype.html;336.45998172932445;368.13855577947595;370.6960292560102;374.31687170913085;378.1378457117772;6500.902486462707;6548.214214294279;6583;6623.006549017644;6635.137432133828;6722.428593569541;6724.193096828388;6733.562318449297;6743.932560674391;6750.054992301082;5112.079825631385;5126.92309615356;5128.076946149691;5129.615278854101;5132.97433512832;5120.513551212647;5126.794928202886;5129.487051294878;5135.435102138762;5138.614603904722;5075.289459475676;5076.340075790142;5088.92366614501;5097.311862898517;5099.311592934962;4932.753362331887;5067.898642027176;5081.618878584102;5089.796408143669;5096.05722941257;4413.955860441419;4431.667624928144;4456.598906098434;4462.665300102472;4466.955330446686;6422.550421470499;6426.164598602152;6427.357264273582;6435.806925792233;6465.191851018622;5612.186232996233;5718.656880587178;5726.398728133569;5729.512991395736;5731.484166425;6979.4416446684145;7008.3880707437065;7013.333733295329;7017.824554386181;7026.824329391755;4697.577218050357;4730.385049943486;4732.384789977315;4737.194676904935;4739.526047395268;7359.595222262774;7379.631018449109;7417.666205020787;7426.777196684054;7450.552966821954;4824.300476430898;4941.43173535048;4947.826826061142;4966.975165124151;4967.056259310792;4993.550580447777;5006;5008.248762685626;5019.0463811875625;5032.723200224023;5787.218725472091;5787.594868359259;5788.1028440590935;5802.79690210849;5802.854928626733;7020.508564400443;7029.472789540805;7102.041224434635;7110;7131.643417829087;1755.806861245262;1759.9736003959952;1761.9692479899402;1763.6120053588447;1763.7971633262082;1138.9259698119595;1144.250515912079;1160.5995931403652;1167.3404526442532;1176.8587769467547;6719.630420326831;6746.595204287661;6750.493712971547;6760.425363844129;6762.492813039042;7204.603746793977;7210.96394518024;7217.6030318333;7218.963905180441;7233.240509746401;6709.6980635871505;6744.055832183498;6752.763653272112;6754.493412993947;6767.898481522781;3867.903302417406;3896.8051597420017;3914.530256369197;3923.7841918694744;3935.9212815743526;7457.7389791357045;7730.806729831799;7796.649150788228;7803.531788092619;7805.219478052263;7583.658735356922;7603.46775725705;7603.543787372775;7624.313811756969;7645.044369453818;7741.845163096819;7763.805904852424;7766.728164514215;7769.728059518003;7771.961140194263;7298.489105762758;7415.925840741524;7420.851582968203;7421.220771818881;7442.627868606656;7226.168990566152;7288.562686238843;7299.781006569811;7315.451341149542;7320.304571065741;7729.420293478124;7739.071311442663;7740.729074482366;7748.8450230996195;7756.457048006585;4955.984023275148;4998.900021999612;5009.073321435546;5015;5022.748862556785;7187.892181617384;7368.668409921674;7372.078490188726;7374.151972523228;7389;7098.219195888551;7122.323379278961;7123.465740069412;7140;7145.964270178616;7083.539569927938;7109.4667899908745;7118.786436406916;7125.608091554807;7129.679164437716;6938.930610693828;6943.722251109899;6944.305569443015;6946.305369463215;6975.720971161097;6980.197277312971;7062.682179302046;7179.9641001796745;7183.20984691694;7199.280071992759;6833.555818871956;6992.475564332593;7014;7018.368346848604;7019.333163349474 04:03:55 INFO - PROCESS | 5234 | |5;yui.html;820.9507429554224;840.2941529115542;916.5050872528835;923.9076092390761;942.0438255171002;14792.334344954475;14947.252637368143;15003.924980375097;15015.92492037541;15060.698786024273;13879.097858639181;13932.791008134885;13983.091099078552;14376.784348234785;14448.783268250985;916.1891725822628;921.6083164655029;927.596495524449;928.0394791390912;928.5635751196927;911.680911680913;912.5984566790625;914.0448231597996;915.4873270968246;915.9908400916006;943.2359788571245;947.9763005924838;950.0926615082614;952.200151872427;952.7665721898145;930.9674161404353;951.1344676344494;951.9904800952006;952.1906379577373;952.7332346942798;700.7582384077485;702.9156501219835;703.3739971425384;704.5737328916034;705.4215543254534;12784.232946023269;12822.679433014157;12862.421191046426;12868.549600763929;12869.67825804353;12939.417726202344;12985.80521292172;13015.934920325337;13029.283389413578;13046.543370982065;10734.355938643706;10822.24244302899;10908.34549927007;11029.83455248172;11253.831192532118;3904.746191497572;3906.902327441808;3972.801359931992;4000.599940006005;4021.416894550274;56663;57140.14289785657;57866.132008019915;57987.13019304756;58385.416145838426;11168.888311116785;11255;11551;11640.650780476599;11671.649850504498;18722.625547488973;18725.344612938483;18816.717749233772;18885.811141888404;18930.90534547346;8812.603432845537;8822;8830.823383532294;8919.10808919103;9060.093990600888;4744.7390393528685;4808.495108013678;4998.325226094504;5009.749512524432;5054.949450505448;3680.3743363628246;3750.512433383697;3753.174301653632;3756.398976163801;3762.4544441055896;671.9328067193339;682.7610336382227;685.4242436353487;689.6930865764687;704.9083619129481;611.782817099932;638.2723694987718;659.788867562385;666.9166354205724;752.8117970507374;9780;9913.603455861828;10040.598376065022;10122;10151.695449136538;697.4106879686657;724.0442615747269;771.3828936850497;798.0144521515923;832;4343.956560434419;4644.349791029259;4659.394278743809;4700.6474514410875;4708.317293992352;65617.34382656208;66337.66831165813;66430.66784666046;68427.3157268431;69110.30889691038;50680.746596266785;53876.191857122176;59272.40727592755;59532.70233648891;60106.398936010955;55343;55421.72289138528;55538.44461555333;55767;56346.43653563494;9209.815803684023;9487.952560237154;9592.328537002342;9629.32594718363;9786.510674466106;39770.403443947784;40627.390589141774;41014.179716404906;41053.79473102735;42151.36772948347;50905;53797;54482.7275863634;54626.18060729013;55085.724571376886;11789.469473873525;11887.28676279426;12070.991832666317;12157;12591.181573197713;13168.868311316764;13392.397342119433;13497.460101595827;13628.65928351799;14258.928705356408;12883.291418972047;12883.420246089136;12933.094683372074;13011.934940325238;13094.214347139203;13085.149465284727;13460.46158153702;13510.594682159552;13518.459261629425;13654.112482688593;12293.56972505958;12390.442430090487;12429.12996090265;12444.751104978031;12506.124571279923;11218.270812397168;11242.381669008282;11354.26197297173;11371.14716396257;11493;11038.668839934815;11072.501737421675;11352;11381.089512839118;11401.600943966921 04:03:55 INFO - PROCESS | 5234 | __end_tp_report 04:03:55 INFO - PROCESS | 5234 | __start_cc_report 04:03:55 INFO - PROCESS | 5234 | _x_x_mozilla_cycle_collect,314 04:03:55 INFO - PROCESS | 5234 | __end_cc_report 04:03:55 INFO - PROCESS | 5234 | __startTimestamp1466593435680__endTimestamp 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | ------- Summary: start ------- 04:03:55 INFO - PROCESS | 5234 | Number of tests: 6 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | [#0] dojo.html Cycles:165 Average:5702.48 Median:5907.53 stddev:638.69 (10.8%) stddev-sans-first:614.01 04:03:55 INFO - PROCESS | 5234 | Values: 3375.6 3453.6 3453.7 3493.5 3495.1 5670.7 5675.3 5677.7 5679.7 5691.6 5676.5 5681.9 5704.3 5715.8 5721.4 5116.7 5125.8 5150.1 5209.9 5220.2 5137.2 5199.4 5220.7 5223.1 5237.9 5177.6 5193.6 5198.8 5256.7 5275.3 5314.9 5321.0 5321.5 5330.6 5331.9 5038.8 5147.9 5229.5 5272.4 5277.0 5633.0 5676.7 5710.3 5728.9 5762.5 6057.1 6081.1 6095.3 6125.8 6146.3 5964.2 6113.1 6128.3 6151.5 6164.6 5740.6 5740.7 5740.7 5754.3 5792.1 6255.2 6283.7 6300.8 6302.5 6311.6 5877.5 6018.8 6051.1 6060.2 6074.7 6111.5 6111.8 6125.6 6126.0 6146.8 5994.9 6004.4 6062.4 6080.1 6107.8 6017.1 6084.2 6112.4 6133.7 6151.0 4628.2 4630.2 4635.6 4641.5 4648.4 4141.4 4150.3 4161.1 4166.6 4167.3 5819.9 5993.9 6005.2 6022.6 6053.3 6210.6 6215.9 6265.1 6291.3 6292.5 5860.6 5972.6 6019.6 6025.5 6039.7 5221.8 5259.2 5272.4 5284.7 5300.9 6254.8 6292.9 6293.6 6294.0 6322.3 6091.4 6175.6 6176.2 6181.2 6283.1 6362.0 6441.5 6442.6 6446.6 6451.2 6030.8 6075.5 6078.1 6104.8 6107.7 6068.9 6119.9 6154.2 6201.6 6206.4 5839.4 5846.2 5858.5 5907.5 5929.2 5876.3 5879.4 5879.9 5889.9 5893.4 5812.3 5834.3 5896.4 5965.2 6009.9 6005.8 6013.4 6019.4 6028.5 6030.7 5889.4 5903.5 5906.7 5910.0 5921.6 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | [#1] ext.html Cycles:180 Average:61964.89 Median:43832.45 stddev:121101.06 (276.3%) stddev-sans-first:121353.34 04:03:55 INFO - PROCESS | 5234 | Values: 670.8 671.2 687.9 732.0 732.6 31630.4 38261.0 38731.6 38742.4 38925.0 42359.4 43049.4 43074.6 43096.0 43143.4 8978.0 9135.5 9162.7 9166.8 9192.4 8906.6 9022.2 9043.9 9049.7 9091.1 9058.5 9112.1 9118.3 9120.3 9127.4 9009.1 9051.1 9058.4 9066.1 9085.0 8900.2 8912.4 8922.6 8934.3 8987.9 42901.0 43260.1 43301.0 43317.4 43518.6 3835.8 3981.6 4043.3 4075.6 4247.2 33360.5 33444.4 33934.7 33952.0 35255.5 4476.6 4479.6 4498.2 4539.5 4551.6 305667.0 306424.0 306651.0 306912.0 308532.0 61964.0 61996.7 62021.7 62300.0 62417.4 64095.0 69443.7 70772.6 71289.6 71334.0 19351.3 19638.9 19640.1 19649.1 19655.8 15232.7 15262.8 15272.3 15287.2 15297.0 20217.6 20292.3 21072.8 21198.6 21271.9 7629.3 7783.5 7834.5 7936.3 7948.6 1097.0 1121.1 1173.7 1193.7 1198.8 33290.3 33448.7 33507.7 33670.1 34500.8 1207.0 1245.5 1249.5 1259.4 1279.8 17375.8 17463.2 17611.6 17639.2 17682.0 457814.0 527113.0 535516.0 539146.3 779271.0 61633.7 63666.0 63917.0 64015.0 64125.7 1544.8 1552.3 1555.8 1559.8 1652.6 32682.5 33702.5 33746.2 34060.1 34516.0 55520.7 56335.0 56380.0 56423.4 56565.4 436380.0 441597.0 442213.0 444410.0 445420.0 45018.5 45654.0 46591.3 46849.3 47207.0 50660.2 50967.0 51493.7 51627.5 52119.7 42359.0 43731.3 43829.3 43901.0 43984.8 42979.1 43492.6 43835.6 44312.3 44435.9 44372.3 44617.3 44804.6 45244.8 45271.3 37618.4 37851.8 38742.4 39020.8 39650.0 29440.3 29895.0 29960.7 30436.7 30467.2 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | [#2] jquery.html Cycles:180 Average:30792.33 Median:2443.33 stddev:89931.59 (3680.7%) stddev-sans-first:90154.98 04:03:55 INFO - PROCESS | 5234 | Values: 435.6 444.1 445.1 452.3 458.4 19118.3 19302.0 19782.5 20377.3 20385.5 19758.5 20195.5 20310.0 20749.8 20752.1 5647.8 5867.8 5944.3 5963.8 5977.1 5803.6 5872.2 5879.6 5895.0 5915.9 5677.9 5863.1 5927.8 5928.1 5942.4 5759.3 5808.5 5852.6 5857.7 5886.4 5097.2 5325.2 5326.9 5331.6 5339.3 23358.4 23825.6 24520.3 24594.4 24624.1 2435.3 2451.3 2521.5 2608.0 3080.0 7611.0 14660.0 15561.9 15667.9 15888.8 2063.8 2114.2 2128.9 2168.7 2189.7 73084.6 78215.0 80187.6 81398.2 81954.6 10239.7 11178.3 11741.7 11830.8 11884.0 16873.8 17072.7 17173.9 17223.4 17259.1 9232.4 9425.2 9448.1 9456.6 9530.1 9202.2 9257.6 9257.9 9265.1 9362.4 5118.5 5205.4 5210.2 5224.2 5243.6 2119.3 2128.6 2151.4 2161.5 2165.1 1005.0 1021.6 1023.3 1030.8 1142.3 19247.8 19629.1 19643.3 19729.0 20208.8 1083.9 1091.8 1107.1 1137.7 1151.4 10946.9 11171.2 11287.5 11337.8 11412.7 540454.0 544452.0 546058.3 550553.0 558933.0 77267.6 87284.0 97266.0 98233.0 101158.0 1038.4 1054.7 1110.3 1155.0 1158.3 17045.7 18004.8 18293.3 18312.0 18328.7 38190.8 38540.2 39058.2 39101.8 39723.6 49528.5 51326.7 51389.0 51563.5 56622.7 9353.6 9423.9 9454.7 9467.7 9594.5 12449.8 13916.0 13938.7 14174.4 14289.6 12179.9 12318.5 12376.3 12396.5 12446.4 11163.0 11752.7 11762.2 12052.2 12191.6 6446.7 8468.8 12327.5 12460.6 12888.2 9400.3 9517.8 9677.5 9695.7 9700.0 10867.5 11535.2 12162.8 12340.9 12598.3 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | [#3] mootools.html Cycles:180 Average:5825.86 Median:5003.86 stddev:3256.65 (65.1%) stddev-sans-first:3249.79 04:03:55 INFO - PROCESS | 5234 | Values: 1530.4 1560.0 1796.4 1907.0 1913.8 7707.2 8376.4 8522.7 8748.7 8765.1 8427.5 8483.6 8582.6 8647.1 8675.2 2437.5 2470.1 2474.5 2481.2 2487.8 2470.6 2522.5 2527.1 2532.1 2532.8 2455.3 2459.3 2464.3 2465.0 2469.9 2406.4 2409.3 2416.6 2500.0 2509.7 2452.8 2455.2 2480.4 2482.8 2483.3 8712.0 8914.0 8917.4 8924.2 8987.8 5356.9 5442.1 5470.5 5476.3 5476.6 3527.1 3539.9 3566.9 3613.7 3625.5 1165.2 1172.1 1177.3 1187.5 1192.8 12288.9 12326.5 12333.2 12353.7 12395.3 4704.6 4713.5 4736.6 4793.9 4871.8 9900.1 9909.1 9912.6 9938.8 9956.2 5496.8 5540.3 5556.2 5558.7 5585.6 4518.5 4963.9 5081.4 5086.9 5180.5 3964.0 4068.1 4073.0 4157.7 4169.0 1195.3 1222.7 1228.7 1229.4 1233.2 919.6 1058.3 1060.5 1066.4 1087.6 5786.0 5911.6 6016.2 6206.1 6215.3 433.3 442.5 448.3 455.8 461.1 4051.0 4062.8 4084.8 4088.9 4098.7 10710.9 10992.3 11164.9 11177.3 11204.0 10948.2 10949.0 10964.9 11042.3 11060.8 8492.4 8558.1 8606.7 8611.6 8625.6 5666.4 5859.9 5867.3 5907.1 5942.3 9900.5 9934.7 9944.7 10030.7 10031.1 9482.4 9984.6 10180.8 10232.7 10336.3 7505.1 7540.6 7570.4 7704.9 7706.0 8357.9 8394.9 8417.8 8435.2 8441.6 7452.1 7646.2 7918.0 7969.7 7972.7 7523.4 7526.3 7576.1 7613.0 7615.4 6953.8 6966.7 6973.9 6994.0 6995.8 5073.1 5157.8 5194.8 5203.6 5228.2 5043.8 5045.7 5091.9 5114.8 5184.0 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | [#4] prototype.html Cycles:180 Average:5925.18 Median:6743.99 stddev:1819.26 (27.0%) stddev-sans-first:1775.34 04:03:55 INFO - PROCESS | 5234 | Values: 336.5 368.1 370.7 374.3 378.1 6500.9 6548.2 6583.0 6623.0 6635.1 6722.4 6724.2 6733.6 6743.9 6750.1 5112.1 5126.9 5128.1 5129.6 5133.0 5120.5 5126.8 5129.5 5135.4 5138.6 5075.3 5076.3 5088.9 5097.3 5099.3 4932.8 5067.9 5081.6 5089.8 5096.1 4414.0 4431.7 4456.6 4462.7 4467.0 6422.6 6426.2 6427.4 6435.8 6465.2 5612.2 5718.7 5726.4 5729.5 5731.5 6979.4 7008.4 7013.3 7017.8 7026.8 4697.6 4730.4 4732.4 4737.2 4739.5 7359.6 7379.6 7417.7 7426.8 7450.6 4824.3 4941.4 4947.8 4967.0 4967.1 4993.6 5006.0 5008.2 5019.0 5032.7 5787.2 5787.6 5788.1 5802.8 5802.9 7020.5 7029.5 7102.0 7110.0 7131.6 1755.8 1760.0 1762.0 1763.6 1763.8 1138.9 1144.3 1160.6 1167.3 1176.9 6719.6 6746.6 6750.5 6760.4 6762.5 7204.6 7211.0 7217.6 7219.0 7233.2 6709.7 6744.1 6752.8 6754.5 6767.9 3867.9 3896.8 3914.5 3923.8 3935.9 7457.7 7730.8 7796.6 7803.5 7805.2 7583.7 7603.5 7603.5 7624.3 7645.0 7741.8 7763.8 7766.7 7769.7 7772.0 7298.5 7415.9 7420.9 7421.2 7442.6 7226.2 7288.6 7299.8 7315.5 7320.3 7729.4 7739.1 7740.7 7748.8 7756.5 4956.0 4998.9 5009.1 5015.0 5022.7 7187.9 7368.7 7372.1 7374.2 7389.0 7098.2 7122.3 7123.5 7140.0 7146.0 7083.5 7109.5 7118.8 7125.6 7129.7 6938.9 6943.7 6944.3 6946.3 6975.7 6980.2 7062.7 7180.0 7183.2 7199.3 6833.6 6992.5 7014.0 7018.4 7019.3 04:03:55 INFO - PROCESS | 5234 | 04:03:55 INFO - PROCESS | 5234 | [#5] yui.html Cycles:180 Average:15784.32 Median:4680.02 stddev:18736.60 (400.4%) stddev-sans-first:18755.46 04:03:55 INFO - PROCESS | 5234 | Values: 821.0 840.3 916.5 923.9 942.0 14792.3 14947.3 15003.9 15015.9 15060.7 13879.1 13932.8 13983.1 14376.8 14448.8 916.2 921.6 927.6 928.0 928.6 911.7 912.6 914.0 915.5 916.0 943.2 948.0 950.1 952.2 952.8 931.0 951.1 952.0 952.2 952.7 700.8 702.9 703.4 704.6 705.4 12784.2 12822.7 12862.4 12868.5 12869.7 12939.4 12985.8 13015.9 13029.3 13046.5 10734.4 10822.2 10908.3 11029.8 11253.8 3904.7 3906.9 3972.8 4000.6 4021.4 56663.0 57140.1 57866.1 57987.1 58385.4 11168.9 11255.0 11551.0 11640.7 11671.6 18722.6 18725.3 18816.7 18885.8 18930.9 8812.6 8822.0 8830.8 8919.1 9060.1 4744.7 4808.5 4998.3 5009.7 5054.9 3680.4 3750.5 3753.2 3756.4 3762.5 671.9 682.8 685.4 689.7 704.9 611.8 638.3 659.8 666.9 752.8 9780.0 9913.6 10040.6 10122.0 10151.7 697.4 724.0 771.4 798.0 832.0 4344.0 4644.3 4659.4 4700.6 4708.3 65617.3 66337.7 66430.7 68427.3 69110.3 50680.7 53876.2 59272.4 59532.7 60106.4 55343.0 55421.7 55538.4 55767.0 56346.4 9209.8 9488.0 9592.3 9629.3 9786.5 39770.4 40627.4 41014.2 41053.8 42151.4 50905.0 53797.0 54482.7 54626.2 55085.7 11789.5 11887.3 12071.0 12157.0 12591.2 13168.9 13392.4 13497.5 13628.7 14258.9 12883.3 12883.4 12933.1 13011.9 13094.2 13085.1 13460.5 13510.6 13518.5 13654.1 12293.6 12390.4 12429.1 12444.8 12506.1 11218.3 11242.4 11354.3 11371.1 11493.0 11038.7 11072.5 11352.0 11381.1 11401.6 04:03:55 INFO - PROCESS | 5234 | -------- Summary: end -------- 04:03:55 INFO - PROCESS | 5234 | 04:03:56 INFO - TEST-INFO | 5234: exit 0 04:03:56 INFO - TEST-OK | dromaeo_css | took 1108977ms 04:03:56 INFO - TEST-START | kraken 04:03:56 INFO - operating with platform_type : linux_ 04:03:56 INFO - Initialising browser for kraken test... 04:03:56 INFO - TEST-INFO | started process 5470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjpeUU8/profile http://localhost:35171/getInfo.html) 04:04:00 INFO - PROCESS | 5470 | 04:04:00 INFO - PROCESS | 5470 | (process:5549): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:04:01 INFO - PROCESS | 5470 | __metrics Screen width/height:1600/1200 04:04:01 INFO - PROCESS | 5470 | colorDepth:24 04:04:01 INFO - PROCESS | 5470 | Browser inner width/height: 1024/697 04:04:01 INFO - PROCESS | 5470 | __metrics 04:04:01 ERROR - PROCESS | 5470 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 04:04:02 INFO - TEST-INFO | 5470: exit 0 04:04:02 INFO - Browser initialized. 04:04:02 INFO - Running cycle 1/1 for kraken test... 04:04:02 INFO - TEST-INFO | started process 5599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjpeUU8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:04 INFO - PROCESS | 5599 | 04:04:04 INFO - PROCESS | 5599 | (process:5666): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:04:14 INFO - PROCESS | 5599 | RSS: Main: 151142400 04:04:14 INFO - PROCESS | 5599 | 04:04:16 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35171/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:17 INFO - PROCESS | 5599 | RSS: Main: 156114944 04:04:17 INFO - PROCESS | 5599 | 04:04:20 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35171/tests/kraken/driver.html?testName=audio-dft) 04:04:21 INFO - PROCESS | 5599 | RSS: Main: 156078080 04:04:21 INFO - PROCESS | 5599 | 04:04:23 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35171/tests/kraken/driver.html?testName=audio-fft) 04:04:24 INFO - PROCESS | 5599 | RSS: Main: 156635136 04:04:24 INFO - PROCESS | 5599 | 04:04:26 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35171/tests/kraken/driver.html?testName=audio-oscillator) 04:04:27 INFO - PROCESS | 5599 | RSS: Main: 156667904 04:04:27 INFO - PROCESS | 5599 | 04:04:29 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:30 INFO - PROCESS | 5599 | RSS: Main: 156684288 04:04:30 INFO - PROCESS | 5599 | 04:04:33 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35171/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:33 INFO - PROCESS | 5599 | RSS: Main: 156991488 04:04:33 INFO - PROCESS | 5599 | 04:04:36 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35171/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:37 INFO - PROCESS | 5599 | RSS: Main: 157257728 04:04:37 INFO - PROCESS | 5599 | 04:04:40 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35171/tests/kraken/driver.html?testName=json-parse-financial) 04:04:41 INFO - PROCESS | 5599 | RSS: Main: 156962816 04:04:41 INFO - PROCESS | 5599 | 04:04:42 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:43 INFO - PROCESS | 5599 | RSS: Main: 156266496 04:04:43 INFO - PROCESS | 5599 | 04:04:44 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:45 INFO - PROCESS | 5599 | RSS: Main: 156332032 04:04:45 INFO - PROCESS | 5599 | 04:04:47 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:48 INFO - PROCESS | 5599 | RSS: Main: 157020160 04:04:48 INFO - PROCESS | 5599 | 04:04:50 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:51 INFO - PROCESS | 5599 | RSS: Main: 157421568 04:04:51 INFO - PROCESS | 5599 | 04:04:53 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:54 INFO - PROCESS | 5599 | RSS: Main: 157560832 04:04:54 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | Cycle 1(1): loaded http://localhost:35171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35171/tests/kraken/driver.html?testName=ai-astar) 04:04:56 INFO - PROCESS | 5599 | RSS: Main: 158728192 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | __start_tp_report 04:04:56 INFO - PROCESS | 5599 | _x_x_mozilla_page_load 04:04:56 INFO - PROCESS | 5599 | _x_x_mozilla_page_load_details 04:04:56 INFO - PROCESS | 5599 | |i|pagename|runs| 04:04:56 INFO - PROCESS | 5599 | |0;ai-astar;110;113;106;109;112;111;101;110;109;109 04:04:56 INFO - PROCESS | 5599 | |1;audio-beat-detection;162;131;158;183;127;156;153;130;183;128 04:04:56 INFO - PROCESS | 5599 | |2;audio-dft;163;163;164;162;161;162;161;161;161;162 04:04:56 INFO - PROCESS | 5599 | |3;audio-fft;76;80;73;163;74;76;74;73;174;76 04:04:56 INFO - PROCESS | 5599 | |4;audio-oscillator;92;94;162;92;94;93;149;93;92;140 04:04:56 INFO - PROCESS | 5599 | |5;imaging-gaussian-blur;118;117;116;118;118;117;117;117;117;117 04:04:56 INFO - PROCESS | 5599 | |6;imaging-darkroom;145;148;145;147;147;146;146;146;146;146 04:04:56 INFO - PROCESS | 5599 | |7;imaging-desaturate;95;96;98;101;95;95;94;95;95;95 04:04:56 INFO - PROCESS | 5599 | |8;json-parse-financial;57;62;67;56;58;61;57;75;56;54 04:04:56 INFO - PROCESS | 5599 | |9;json-stringify-tinderbox;57;58;58;58;58;58;57;59;59;59 04:04:56 INFO - PROCESS | 5599 | |10;stanford-crypto-aes;74;81;79;74;74;81;73;76;74;73 04:04:56 INFO - PROCESS | 5599 | |11;stanford-crypto-ccm;124;119;113;121;117;115;116;113;128;134 04:04:56 INFO - PROCESS | 5599 | |12;stanford-crypto-pbkdf2;159;158;161;167;163;165;159;159;156;156 04:04:56 INFO - PROCESS | 5599 | |13;stanford-crypto-sha256-iterative;66;73;70;66;67;67;65;68;66;66 04:04:56 INFO - PROCESS | 5599 | __end_tp_report 04:04:56 INFO - PROCESS | 5599 | __start_cc_report 04:04:56 INFO - PROCESS | 5599 | _x_x_mozilla_cycle_collect,864 04:04:56 INFO - PROCESS | 5599 | __end_cc_report 04:04:56 INFO - PROCESS | 5599 | __startTimestamp1466593496449__endTimestamp 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | ------- Summary: start ------- 04:04:56 INFO - PROCESS | 5599 | Number of tests: 14 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.40 (3.1%) stddev-sans-first:3.59 04:04:56 INFO - PROCESS | 5599 | Values: 110.0 113.0 106.0 109.0 112.0 111.0 101.0 110.0 109.0 109.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:157.00 stddev:21.58 (13.7%) stddev-sans-first:22.53 04:04:56 INFO - PROCESS | 5599 | Values: 162.0 131.0 158.0 183.0 127.0 156.0 153.0 130.0 183.0 128.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 04:04:56 INFO - PROCESS | 5599 | Values: 163.0 163.0 164.0 162.0 161.0 162.0 161.0 161.0 161.0 162.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.00 stddev:39.46 (52.6%) stddev-sans-first:41.31 04:04:56 INFO - PROCESS | 5599 | Values: 76.0 80.0 73.0 163.0 74.0 76.0 74.0 73.0 174.0 76.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.50 stddev:28.26 (30.5%) stddev-sans-first:29.20 04:04:56 INFO - PROCESS | 5599 | Values: 92.0 94.0 162.0 92.0 94.0 93.0 149.0 93.0 92.0 140.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 04:04:56 INFO - PROCESS | 5599 | Values: 118.0 117.0 116.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:04:56 INFO - PROCESS | 5599 | Values: 145.0 148.0 145.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.08 (2.2%) stddev-sans-first:2.18 04:04:56 INFO - PROCESS | 5599 | Values: 95.0 96.0 98.0 101.0 95.0 95.0 94.0 95.0 95.0 95.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.50 stddev:6.40 (10.7%) stddev-sans-first:6.67 04:04:56 INFO - PROCESS | 5599 | Values: 57.0 62.0 67.0 56.0 58.0 61.0 57.0 75.0 56.0 54.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 04:04:56 INFO - PROCESS | 5599 | Values: 57.0 58.0 58.0 58.0 58.0 58.0 57.0 59.0 59.0 59.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:3.21 (4.3%) stddev-sans-first:3.33 04:04:56 INFO - PROCESS | 5599 | Values: 74.0 81.0 79.0 74.0 74.0 81.0 73.0 76.0 74.0 73.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.00 stddev:6.88 (5.7%) stddev-sans-first:7.14 04:04:56 INFO - PROCESS | 5599 | Values: 124.0 119.0 113.0 121.0 117.0 115.0 116.0 113.0 128.0 134.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.00 stddev:3.68 (2.3%) stddev-sans-first:3.88 04:04:56 INFO - PROCESS | 5599 | Values: 159.0 158.0 161.0 167.0 163.0 165.0 159.0 159.0 156.0 156.0 04:04:56 INFO - PROCESS | 5599 | 04:04:56 INFO - PROCESS | 5599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:2.41 (3.6%) stddev-sans-first:2.51 04:04:56 INFO - PROCESS | 5599 | Values: 66.0 73.0 70.0 66.0 67.0 67.0 65.0 68.0 66.0 66.0 04:04:56 INFO - PROCESS | 5599 | -------- Summary: end -------- 04:04:56 INFO - PROCESS | 5599 | 04:04:57 INFO - TEST-INFO | 5599: exit 0 04:04:57 INFO - TEST-OK | kraken | took 60929ms 04:04:57 INFO - SUITE-END | took 1169s 04:04:57 INFO - Completed test suite (00:19:30) 04:04:57 INFO - javascript benchmark 04:04:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.6455572164923, 3453.620101788803, 3453.7064349530287, 3493.45851393034, 3495.091276268171, 5670.68811215383, 5675.3189617245935, 5677.744501497432, 5679.659220446776, 5691.601587888844, 5676.460736230062, 5681.8579535511635, 5704.286964129484, 5715.828525144242, 5721.370649228592, 5116.692998420088, 5125.820596279131, 5150.098732721777, 5209.895802083956, 5220.190870415092, 5137.2037334213255, 5199.428062913076, 5220.6606570572985, 5223.085959957011, 5237.947620523784, 5177.58579313654, 5193.584513238932, 5198.7660555274915, 5256.710880901549, 5275.28783614211, 5314.893702125955, 5321.042212401766, 5321.547668448186, 5330.626856120073, 5331.920021199685, 5038.84883453497, 5147.922781158248, 5229.47705229474, 5272.446393128743, 5277.0, 5632.971835140839, 5676.659400435987, 5710.2862142232225, 5728.856778580527, 5762.510186634141, 6057.091436284549, 6081.057436097412, 6095.299040610343, 6125.816225513242, 6146.262448506163, 5964.194833697438, 6113.050656958994, 6128.3258841527395, 6151.5386346024225, 6164.568480206387, 5740.5981581289325, 5740.655560666331, 5740.655560666373, 5754.280714910678, 5792.131180322943, 6255.218097737783, 6283.748650054038, 6300.779472718433, 6302.4958003359625, 6311.589746666452, 5877.529797616266, 6018.789342372996, 6051.0923361496125, 6060.2424696912885, 6074.726637301332, 6111.500579230309, 6111.829668689647, 6125.572745538934, 6125.998614523584, 6146.846328841814, 5994.910076348859, 6004.369541198199, 6062.42406971337, 6080.118382834465, 6107.84730381744, 6017.0974353846395, 6084.178635884187, 6112.419320164578, 6133.73253493014, 6151.046587778901, 4628.190066738307, 4630.189716799547, 4635.559621835921, 4641.512641172696, 4648.395708557933, 4141.378793180987, 4150.27370210218, 4161.146964872194, 4166.604172603658, 4167.291560434734, 5819.854503637443, 5993.850153746104, 6005.219321488178, 6022.608530445507, 6053.303870055, 6210.627362358273, 6215.875682486416, 6265.122882796412, 6291.339409362043, 6292.528060395489, 5860.560457965669, 5972.641641501524, 6019.637687647319, 6025.457708806229, 6039.7282122304605, 5221.765020574083, 5259.21111833228, 5272.393674727378, 5284.656497327662, 5300.946990530122, 6254.781082662085, 6292.937070629235, 6293.622382657055, 6294.0, 6322.33615470369, 6091.42131497507, 6175.567710260419, 6176.227971503562, 6181.196444462191, 6283.057541368831, 6362.045693146065, 6441.452476539359, 6442.645654489048, 6446.645434501147, 6451.1936007999, 6030.819075427744, 6075.483583895419, 6078.149059131637, 6104.816855494342, 6107.6640784757265, 6068.8786224276155, 6119.898632333192, 6154.169187159676, 6201.565890387629, 6206.441420272197, 5839.357670656309, 5846.210761547137, 5858.502027327554, 5907.5273978080795, 5929.1995580597795, 5876.294844618673, 5879.412058794257, 5879.882402352015, 5889.852753681193, 5893.410658934073, 5812.273465816773, 5834.27071616048, 5896.439838215363, 5965.224520812267, 6009.879802404015, 6005.798840231883, 6013.368596297326, 6019.398060194121, 6028.487578555872, 6030.698465076816, 5889.352171261072, 5903.498202652822, 5906.70466476683, 5909.970450147722, 5921.5854890159], "value": 5660.5736081865825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.7920544631164, 671.2448495442626, 687.8968154776779, 731.9743808966684, 732.6007326007325, 31630.367392652162, 38261.0, 38731.61268387315, 38742.41886371703, 38925.0, 42359.36460953081, 43049.35425968613, 43074.56925430745, 43096.0, 43143.35284970728, 8977.955110224457, 9135.497547634877, 9162.72511824643, 9166.770830729218, 9192.35653504255, 8906.599203035847, 9022.233110185642, 9043.909560904372, 9049.683261085864, 9091.090890910922, 9058.547072646374, 9112.134347237003, 9118.316126290521, 9120.31597630177, 9127.406718563272, 9009.144131307516, 9051.094890510962, 9058.411203271766, 9066.138716821892, 9085.0, 8900.154485323885, 8912.420692654956, 8922.598483068212, 8934.329925255632, 8987.910120898772, 42901.0, 43260.13479730419, 43301.0, 43317.35023974643, 43518.56481435177, 3835.789031603261, 3981.6416522512823, 4043.2722110020186, 4075.572064933169, 4247.200663250507, 33360.49959250589, 33444.355116572864, 33934.660653393395, 33952.0, 35255.471167932505, 4476.55234476553, 4479.596836284717, 4498.190325741365, 4539.500654927955, 4551.5676010778925, 305667.0, 306424.0, 306651.0, 306912.0, 308532.0, 61964.0, 61996.690016549626, 62021.689891551156, 62300.0, 62417.37582624207, 64095.0, 69443.65278173577, 70772.64613677001, 71289.6435517819, 71334.0, 19351.322703705584, 19638.90180549088, 19640.116194771268, 19649.115789789495, 19655.803441965396, 15232.695346093016, 15262.771058433911, 15272.31274592646, 15287.235638218044, 15297.005694629814, 20217.595648086957, 20292.289769857984, 21072.789272107082, 21198.576028479343, 21271.8936405317, 7629.3133617974645, 7783.455158138876, 7834.451588388872, 7936.2857342839425, 7948.602569871483, 1096.950637221327, 1121.1199208621192, 1173.7359094203737, 1193.7254431480808, 1198.7782260281701, 33290.334193316485, 33448.66551334504, 33507.664923350945, 33670.137883522635, 34500.82749586286, 1206.9517219311128, 1245.4893493667553, 1249.4752204074312, 1259.4080782032431, 1279.7842050052302, 17375.826241737675, 17463.21415536304, 17611.55971100733, 17639.206235719423, 17682.0, 457814.0, 527113.0, 535516.0, 539146.3042684762, 779271.0, 61633.69183154145, 63666.0, 63917.0, 64015.0, 64125.67937160378, 1544.7760074789317, 1552.301464341051, 1555.7899683542803, 1559.7504399296058, 1652.628158664315, 32682.509762353107, 33702.49446258259, 33746.15634609154, 34060.1484962868, 34516.0, 55520.72239638776, 56335.0, 56380.0, 56423.43576564182, 56565.43434565602, 436380.0, 441597.0, 442213.0, 444410.0, 445420.0, 45018.549814501435, 45654.0, 46591.30113048239, 46849.2972605418, 47207.0, 50660.24009639932, 50967.0, 51493.742531288604, 51627.48372516227, 52119.73940130275, 42359.0, 43731.34402984021, 43829.34255986099, 43901.0, 43984.780076099414, 42979.14041719211, 43492.56507434885, 43835.56164438443, 44312.335314970944, 44435.889102772686, 44372.33441498445, 44617.33074003957, 44804.55195448134, 45244.77377613223, 45271.320930185415, 37618.43572346472, 37851.810740946115, 38742.418863716506, 39020.804895975336, 39650.0, 29440.26399339948, 29895.0, 29960.70039299579, 30436.695633043386, 30467.238319041313], "value": 21614.61810623881, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.5927208060465, 444.0807528416178, 445.0986751827549, 452.2741000693884, 458.40636375893234, 19118.33085841996, 19301.99999999998, 19782.505437364056, 20377.28679496218, 20385.49036274094, 19758.506037349074, 20195.495112622193, 20310.0, 20749.792502074975, 20752.06615702293, 5647.774089036434, 5867.765289388441, 5944.316403613575, 5963.761449542013, 5977.1034344848185, 5803.593748437611, 5872.207252020965, 5879.617824841393, 5894.970525147368, 5915.911261331084, 5677.886442271152, 5863.149843272723, 5927.792527261547, 5928.1404196391495, 5942.376050514698, 5759.280089988752, 5808.506276966484, 5852.590318677694, 5857.707114644293, 5886.411358864122, 5097.1844504879045, 5325.227841962933, 5326.92009619856, 5331.5734741220995, 5339.3058902342445, 23358.416039598975, 23825.642615360783, 24520.264392068268, 24594.385140371454, 24624.138155164484, 2435.342457536473, 2451.3136321829916, 2521.4957008598353, 2608.0480624571896, 3079.9846000769853, 7610.961945190294, 14660.0, 15561.922190388976, 15667.92166039174, 15888.841111588852, 2063.8142567168875, 2114.238874005357, 2128.8509804313703, 2168.6530155175255, 2189.7372315322104, 73084.63457682784, 78215.0, 80187.59906200432, 81398.18601813965, 81954.59022704848, 10239.692809215736, 11178.329300242012, 11741.706457338463, 11830.822537661941, 11884.049276057895, 16873.831261687472, 17072.658546828992, 17173.91413042952, 17223.39718109885, 17259.137043148043, 9232.353735238468, 9425.151736343762, 9448.149666530046, 9456.574454149442, 9530.142287194185, 9202.217811486098, 9257.61135829631, 9257.861132083024, 9265.119813617695, 9362.391444556082, 5118.462561431071, 5205.375354957354, 5210.244514545446, 5224.216367544898, 5243.554297884646, 2119.311223852254, 2128.5636444528836, 2151.354593621907, 2161.5352699169753, 2165.101482884617, 1004.9547770350351, 1021.5957584378702, 1023.3399457350116, 1030.845373194012, 1142.2575326037975, 19247.807521924882, 19629.116689748997, 19643.31248406299, 19729.0, 20208.797912020986, 1083.9241253112364, 1091.8471414002047, 1107.1364335818075, 1137.7440075982838, 1151.4300421291514, 10946.945265273622, 11171.16216283782, 11287.548498059985, 11337.773244535063, 11412.714682133013, 540454.0, 544452.0, 546058.3485412897, 550553.0, 558933.0, 77267.61366193133, 87284.0, 97266.0, 98233.0, 101158.0, 1038.3665963762098, 1054.746860753429, 1110.294962698676, 1154.9826752598717, 1158.264502041193, 17045.744313835054, 18004.819951800313, 18293.26826926908, 18312.0, 18328.725069123706, 38190.80904595459, 38540.22919541538, 39058.218835623695, 39101.80449097736, 39723.60276397199, 49528.50471495239, 51326.74336628293, 51389.0, 51563.48436515587, 56622.71688641531, 9353.579088940878, 9423.905760942303, 9454.669086581936, 9467.66863159786, 9594.520273986132, 12449.751004980031, 13916.0, 13938.651533711738, 14174.433022678977, 14289.64275893111, 12179.87820121823, 12318.507259709511, 12376.257424554555, 12396.504139834306, 12446.43991020388, 11163.0, 11752.70618234551, 11762.235454695418, 12052.156349055833, 12191.573294934635, 6446.742130314922, 8468.830623387374, 12327.506899724269, 12460.626181214579, 12888.226706397647, 9400.29497787655, 9517.809643806946, 9677.467739274407, 9695.66065187715, 9699.981501942195, 10867.51096200657, 11535.192536522363, 12162.756744864877, 12340.938295308466, 12598.307093109966], "value": 9733.624365642721, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.4490383461955, 1559.9844001559984, 1796.4251439539344, 1906.961860762784, 1913.8086191380855, 7707.190744971767, 8376.41365104443, 8522.701705440302, 8748.693795717143, 8765.123487651239, 8427.536485493296, 8483.575821208946, 8582.613782379793, 8647.092055334193, 8675.219230269275, 2437.463757973243, 2470.147799009339, 2474.5174690935273, 2481.2432208176497, 2487.763662452064, 2470.6170543565777, 2522.533331333709, 2527.0523553667376, 2532.11376018393, 2532.8353657012235, 2455.2511483997373, 2459.3359792855917, 2464.322311364371, 2465.0263146057296, 2469.901203951849, 2406.3743426709007, 2409.3494756415757, 2416.565018296706, 2500.037485568051, 2509.749025097494, 2452.828302018859, 2455.177515532299, 2480.379905023744, 2482.7765501104986, 2483.3046746910895, 8711.956440217822, 8913.974892887336, 8917.42036767608, 8924.241439477652, 8987.820243595157, 5356.946430535684, 5442.12925931849, 5470.507654311092, 5476.342838859362, 5476.561875049986, 3527.065327688165, 3539.876104336336, 3566.892993210208, 3613.7109031277437, 3625.4743062255825, 1165.2251252916801, 1172.1033409441784, 1177.2524446976147, 1187.4953144913463, 1192.7614477104614, 12288.877111228952, 12326.50693972249, 12333.198342107735, 12353.691157721129, 12395.256284622861, 4704.647151463654, 4713.457952335457, 4736.579026292098, 4793.9280910786365, 4871.8294859679745, 9900.059494348025, 9909.108180263811, 9912.55393507294, 9938.801223975624, 9956.203503719686, 5496.7526461309335, 5540.252065971123, 5556.222128901876, 5558.722063896789, 5585.609007369527, 4518.480374756879, 4963.925541116886, 5081.441041485434, 5086.92369614456, 5180.4560521145495, 3964.0, 4068.105016896278, 4073.042834933788, 4157.688173387008, 4168.979155104205, 1195.3306148556835, 1222.6611860013272, 1228.668259569911, 1229.3791635224154, 1233.2045830439317, 919.5861862162054, 1058.2803693488347, 1060.4803646213454, 1066.3708412036935, 1087.6193332333619, 5785.987452195849, 5911.615744976562, 6016.1878146450545, 6206.06908963659, 6215.285242197115, 433.28075394844404, 442.4756663353936, 448.2849854482161, 455.77666943198255, 461.0686413444823, 4050.9797451012555, 4062.7765472899273, 4084.81618327176, 4088.9182216356103, 4098.713090083726, 10710.946445267724, 10992.28550144238, 11164.944175279072, 11177.329360238411, 11204.0, 10948.178886583379, 10949.014588687056, 10964.945175274073, 11042.282251653778, 11060.778784424427, 8492.40553161285, 8558.144185581392, 8606.698765543177, 8611.61247743853, 8625.568721563897, 5666.376698563073, 5859.853503662443, 5867.266591676041, 5907.113932910098, 5942.346341902301, 9900.50497475109, 9934.652287170204, 9944.651937182163, 10030.749231269278, 10031.097201251923, 9482.38364506305, 9984.60061597528, 10180.847287290844, 10232.693019209435, 10336.328138670962, 7505.136909255505, 7540.585267810104, 7570.356519695888, 7704.884426733492, 7706.0, 8357.916420835714, 8394.916050839414, 8417.789555261168, 8435.198656127657, 8441.620127094418, 7452.105747310357, 7646.235376462309, 7918.049834019724, 7969.681212751425, 7972.720954766787, 7523.398128149625, 7526.285002924714, 7576.090869095744, 7613.0, 7615.390768738377, 6953.756618518328, 6966.686499107654, 6973.895391569029, 6993.950907363733, 6995.790126296016, 5073.137566613758, 5157.819476318311, 5194.766235519335, 5203.5576975957465, 5228.241904923689, 5043.798248070183, 5045.722485263345, 5091.92362114576, 5114.769835357343, 5184.0], "value": 4631.642404114832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.45998172932445, 368.13855577947595, 370.6960292560102, 374.31687170913085, 378.1378457117772, 6500.902486462707, 6548.214214294279, 6583.0, 6623.006549017644, 6635.137432133828, 6722.428593569541, 6724.193096828388, 6733.562318449297, 6743.932560674391, 6750.054992301082, 5112.079825631385, 5126.92309615356, 5128.076946149691, 5129.615278854101, 5132.97433512832, 5120.513551212647, 5126.794928202886, 5129.487051294878, 5135.435102138762, 5138.614603904722, 5075.289459475676, 5076.340075790142, 5088.92366614501, 5097.311862898517, 5099.311592934962, 4932.753362331887, 5067.898642027176, 5081.618878584102, 5089.796408143669, 5096.05722941257, 4413.955860441419, 4431.667624928144, 4456.598906098434, 4462.665300102472, 4466.955330446686, 6422.550421470499, 6426.164598602152, 6427.357264273582, 6435.806925792233, 6465.191851018622, 5612.186232996233, 5718.656880587178, 5726.398728133569, 5729.512991395736, 5731.484166425, 6979.4416446684145, 7008.3880707437065, 7013.333733295329, 7017.824554386181, 7026.824329391755, 4697.577218050357, 4730.385049943486, 4732.384789977315, 4737.194676904935, 4739.526047395268, 7359.595222262774, 7379.631018449109, 7417.666205020787, 7426.777196684054, 7450.552966821954, 4824.300476430898, 4941.43173535048, 4947.826826061142, 4966.975165124151, 4967.056259310792, 4993.550580447777, 5006.0, 5008.248762685626, 5019.0463811875625, 5032.723200224023, 5787.218725472091, 5787.594868359259, 5788.1028440590935, 5802.79690210849, 5802.854928626733, 7020.508564400443, 7029.472789540805, 7102.041224434635, 7110.0, 7131.643417829087, 1755.806861245262, 1759.9736003959952, 1761.9692479899402, 1763.6120053588447, 1763.7971633262082, 1138.9259698119595, 1144.250515912079, 1160.5995931403652, 1167.3404526442532, 1176.8587769467547, 6719.630420326831, 6746.595204287661, 6750.493712971547, 6760.425363844129, 6762.492813039042, 7204.603746793977, 7210.96394518024, 7217.6030318333, 7218.963905180441, 7233.240509746401, 6709.6980635871505, 6744.055832183498, 6752.763653272112, 6754.493412993947, 6767.898481522781, 3867.903302417406, 3896.8051597420017, 3914.530256369197, 3923.7841918694744, 3935.9212815743526, 7457.7389791357045, 7730.806729831799, 7796.649150788228, 7803.531788092619, 7805.219478052263, 7583.658735356922, 7603.46775725705, 7603.543787372775, 7624.313811756969, 7645.044369453818, 7741.845163096819, 7763.805904852424, 7766.728164514215, 7769.728059518003, 7771.961140194263, 7298.489105762758, 7415.925840741524, 7420.851582968203, 7421.220771818881, 7442.627868606656, 7226.168990566152, 7288.562686238843, 7299.781006569811, 7315.451341149542, 7320.304571065741, 7729.420293478124, 7739.071311442663, 7740.729074482366, 7748.8450230996195, 7756.457048006585, 4955.984023275148, 4998.900021999612, 5009.073321435546, 5015.0, 5022.748862556785, 7187.892181617384, 7368.668409921674, 7372.078490188726, 7374.151972523228, 7389.0, 7098.219195888551, 7122.323379278961, 7123.465740069412, 7140.0, 7145.964270178616, 7083.539569927938, 7109.4667899908745, 7118.786436406916, 7125.608091554807, 7129.679164437716, 6938.930610693828, 6943.722251109899, 6944.305569443015, 6946.305369463215, 6975.720971161097, 6980.197277312971, 7062.682179302046, 7179.9641001796745, 7183.20984691694, 7199.280071992759, 6833.555818871956, 6992.475564332593, 7014.0, 7018.368346848604, 7019.333163349474], "value": 5327.322077287674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.9507429554224, 840.2941529115542, 916.5050872528835, 923.9076092390761, 942.0438255171002, 14792.334344954475, 14947.252637368143, 15003.924980375097, 15015.92492037541, 15060.698786024273, 13879.097858639181, 13932.791008134885, 13983.091099078552, 14376.784348234785, 14448.783268250985, 916.1891725822628, 921.6083164655029, 927.596495524449, 928.0394791390912, 928.5635751196927, 911.680911680913, 912.5984566790625, 914.0448231597996, 915.4873270968246, 915.9908400916006, 943.2359788571245, 947.9763005924838, 950.0926615082614, 952.200151872427, 952.7665721898145, 930.9674161404353, 951.1344676344494, 951.9904800952006, 952.1906379577373, 952.7332346942798, 700.7582384077485, 702.9156501219835, 703.3739971425384, 704.5737328916034, 705.4215543254534, 12784.232946023269, 12822.679433014157, 12862.421191046426, 12868.549600763929, 12869.67825804353, 12939.417726202344, 12985.80521292172, 13015.934920325337, 13029.283389413578, 13046.543370982065, 10734.355938643706, 10822.24244302899, 10908.34549927007, 11029.83455248172, 11253.831192532118, 3904.746191497572, 3906.902327441808, 3972.801359931992, 4000.599940006005, 4021.416894550274, 56663.0, 57140.14289785657, 57866.132008019915, 57987.13019304756, 58385.416145838426, 11168.888311116785, 11255.0, 11551.0, 11640.650780476599, 11671.649850504498, 18722.625547488973, 18725.344612938483, 18816.717749233772, 18885.811141888404, 18930.90534547346, 8812.603432845537, 8822.0, 8830.823383532294, 8919.10808919103, 9060.093990600888, 4744.7390393528685, 4808.495108013678, 4998.325226094504, 5009.749512524432, 5054.949450505448, 3680.3743363628246, 3750.512433383697, 3753.174301653632, 3756.398976163801, 3762.4544441055896, 671.9328067193339, 682.7610336382227, 685.4242436353487, 689.6930865764687, 704.9083619129481, 611.782817099932, 638.2723694987718, 659.788867562385, 666.9166354205724, 752.8117970507374, 9780.0, 9913.603455861828, 10040.598376065022, 10122.0, 10151.695449136538, 697.4106879686657, 724.0442615747269, 771.3828936850497, 798.0144521515923, 832.0, 4343.956560434419, 4644.349791029259, 4659.394278743809, 4700.6474514410875, 4708.317293992352, 65617.34382656208, 66337.66831165813, 66430.66784666046, 68427.3157268431, 69110.30889691038, 50680.746596266785, 53876.191857122176, 59272.40727592755, 59532.70233648891, 60106.398936010955, 55343.0, 55421.72289138528, 55538.44461555333, 55767.0, 56346.43653563494, 9209.815803684023, 9487.952560237154, 9592.328537002342, 9629.32594718363, 9786.510674466106, 39770.403443947784, 40627.390589141774, 41014.179716404906, 41053.79473102735, 42151.36772948347, 50905.0, 53797.0, 54482.7275863634, 54626.18060729013, 55085.724571376886, 11789.469473873525, 11887.28676279426, 12070.991832666317, 12157.0, 12591.181573197713, 13168.868311316764, 13392.397342119433, 13497.460101595827, 13628.65928351799, 14258.928705356408, 12883.291418972047, 12883.420246089136, 12933.094683372074, 13011.934940325238, 13094.214347139203, 13085.149465284727, 13460.46158153702, 13510.594682159552, 13518.459261629425, 13654.112482688593, 12293.56972505958, 12390.442430090487, 12429.12996090265, 12444.751104978031, 12506.124571279923, 11218.270812397168, 11242.381669008282, 11354.26197297173, 11371.14716396257, 11493.0, 11038.668839934815, 11072.501737421675, 11352.0, 11381.089512839118, 11401.600943966921], "value": 7118.791179530657, "unit": "score"}], "name": "dromaeo_css", "value": 7704.812183384653, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 106.0, 109.0, 112.0, 111.0, 101.0, 110.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 158.0, 183.0, 127.0, 156.0, 153.0, 130.0, 183.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 73.0, 163.0, 74.0, 76.0, 74.0, 73.0, 174.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 162.0, 92.0, 94.0, 93.0, 149.0, 93.0, 92.0, 140.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 101.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 67.0, 56.0, 58.0, 61.0, 57.0, 75.0, 56.0, 54.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 59.0, 59.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 79.0, 74.0, 74.0, 81.0, 73.0, 76.0, 74.0, 73.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 119.0, 113.0, 121.0, 117.0, 115.0, 116.0, 113.0, 128.0, 134.0], "value": 120.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 161.0, 167.0, 163.0, 165.0, 159.0, 159.0, 156.0, 156.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 70.0, 66.0, 67.0, 67.0, 65.0, 68.0, 66.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1527.4, "alertThreshold": 2.0}]} 04:04:57 INFO - Return code: 0 04:04:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:04:57 ERROR - # TBPL SUCCESS # 04:04:57 INFO - Running post-action listener: _resource_record_post_action 04:04:57 INFO - Running post-run listener: _resource_record_post_run 04:04:58 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 460791808; Read time: 4; Write time: 472520 04:04:58 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 241737728; Read time: 0; Write time: 342396 04:04:58 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218738688; Read time: 4; Write time: 130088 04:04:58 INFO - Running post-run listener: _upload_blobber_files 04:04:58 INFO - Blob upload gear active. 04:04:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:04:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:04:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:59 INFO - (blobuploader) - INFO - Done attempting. 04:04:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:04:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:00 INFO - (blobuploader) - INFO - Done attempting. 04:05:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:00 INFO - Return code: 0 04:05:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a43580d60058c58afb03b538df7f966bdd567c08b792bde328bfb79fe1c0866ecdc5969e1f07bae98a84c31d298ffdf7bf36bd66fae02b7937dd373dec4846f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6595abaa3b3eab9e889a32b884e118b8b5b10dd25dc52444dda36da9af6f93afcd3094369f56362c7eb6b0dd497d907fad59ee35fe6d2dacbb087f3641814a9d"} 04:05:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:00 INFO - Contents: 04:05:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a43580d60058c58afb03b538df7f966bdd567c08b792bde328bfb79fe1c0866ecdc5969e1f07bae98a84c31d298ffdf7bf36bd66fae02b7937dd373dec4846f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6595abaa3b3eab9e889a32b884e118b8b5b10dd25dc52444dda36da9af6f93afcd3094369f56362c7eb6b0dd497d907fad59ee35fe6d2dacbb087f3641814a9d"} 04:05:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:00 INFO - Copying logs to upload dir... 04:05:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.691997 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-22 04:05:00.019323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 04:05:00.024527) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a43580d60058c58afb03b538df7f966bdd567c08b792bde328bfb79fe1c0866ecdc5969e1f07bae98a84c31d298ffdf7bf36bd66fae02b7937dd373dec4846f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6595abaa3b3eab9e889a32b884e118b8b5b10dd25dc52444dda36da9af6f93afcd3094369f56362c7eb6b0dd497d907fad59ee35fe6d2dacbb087f3641814a9d"} build_url:https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a43580d60058c58afb03b538df7f966bdd567c08b792bde328bfb79fe1c0866ecdc5969e1f07bae98a84c31d298ffdf7bf36bd66fae02b7937dd373dec4846f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6595abaa3b3eab9e889a32b884e118b8b5b10dd25dc52444dda36da9af6f93afcd3094369f56362c7eb6b0dd497d907fad59ee35fe6d2dacbb087f3641814a9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 04:05:00.054658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:05:00.054982) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1466591682.184363-263361547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:05:00.138551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 04:05:00.139014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 04:05:00.139552) ========= ========= Total master_lag: 0.17 =========