builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1461992372.94 results: success (0) buildid: 20160429193201 builduid: 2edcac09dacc44edabc36e8a243f73a8 revision: 774c838c19e217e177ba22876d57a344b54c33e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:32.941181) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:32.941863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:32.942175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.026603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.026924) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 21:59:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-04-29 21:59:33 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.136805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.137248) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022610 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.189282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.189887) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 774c838c19e217e177ba22876d57a344b54c33e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 774c838c19e217e177ba22876d57a344b54c33e4 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 21:59:33,558 truncating revision to first 12 chars 2016-04-29 21:59:33,559 Setting DEBUG logging. 2016-04-29 21:59:33,559 attempt 1/10 2016-04-29 21:59:33,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/774c838c19e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 21:59:33,810 unpacking tar archive at: mozilla-inbound-774c838c19e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.733871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.734180) ========= script_repo_revision: 774c838c19e217e177ba22876d57a344b54c33e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.734543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.735225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 21:59:33.744903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-29 21:59:33.745187) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:34 INFO - MultiFileLogger online at 20160429 21:59:34 in /builds/slave/test 21:59:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:34 INFO - {'append_to_log': False, 21:59:34 INFO - 'base_work_dir': '/builds/slave/test', 21:59:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:34 INFO - 'branch': 'Mozilla-Inbound', 21:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:34 INFO - 'config_files': ('talos/linux_config.py',), 21:59:34 INFO - 'default_actions': ('clobber', 21:59:34 INFO - 'read-buildbot-config', 21:59:34 INFO - 'download-and-extract', 21:59:34 INFO - 'populate-webroot', 21:59:34 INFO - 'create-virtualenv', 21:59:34 INFO - 'install', 21:59:34 INFO - 'run-tests'), 21:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:34 INFO - 'download_minidump_stackwalk': True, 21:59:34 INFO - 'download_symbols': 'ondemand', 21:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:34 INFO - 'installer_path': 'installer.exe', 21:59:34 INFO - 'log_level': 'info', 21:59:34 INFO - 'log_name': 'talos', 21:59:34 INFO - 'log_to_console': True, 21:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:34 INFO - 'opt_config_files': (), 21:59:34 INFO - 'pip_index': False, 21:59:34 INFO - 'sps_profile': False, 21:59:34 INFO - 'sps_profile_interval': 0, 21:59:34 INFO - 'suite': 'dromaeojs-e10s', 21:59:34 INFO - 'system_bits': '32', 21:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:34 INFO - 'title': 'talos-linux64-ix-041', 21:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:34 INFO - 'use_talos_json': True, 21:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:34 INFO - 'work_dir': 'build'} 21:59:34 INFO - ##### 21:59:34 INFO - ##### Running clobber step. 21:59:34 INFO - ##### 21:59:34 INFO - Running pre-action listener: _resource_record_pre_action 21:59:34 INFO - Running main action method: clobber 21:59:34 INFO - rmtree: /builds/slave/test/build 21:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:35 INFO - Running post-action listener: _resource_record_post_action 21:59:35 INFO - ##### 21:59:35 INFO - ##### Running read-buildbot-config step. 21:59:35 INFO - ##### 21:59:35 INFO - Running pre-action listener: _resource_record_pre_action 21:59:35 INFO - Running main action method: read_buildbot_config 21:59:35 INFO - Using buildbot properties: 21:59:35 INFO - { 21:59:35 INFO - "project": "", 21:59:35 INFO - "product": "firefox", 21:59:35 INFO - "script_repo_revision": "production", 21:59:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:59:35 INFO - "repository": "", 21:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:59:35 INFO - "buildid": "20160429193201", 21:59:35 INFO - "pgo_build": "True", 21:59:35 INFO - "basedir": "/builds/slave/test", 21:59:35 INFO - "buildnumber": 591, 21:59:35 INFO - "slavename": "talos-linux64-ix-041", 21:59:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:59:35 INFO - "platform": "ubuntu64_hw", 21:59:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:59:35 INFO - "branch": "mozilla-inbound", 21:59:35 INFO - "repo_path": "integration/mozilla-inbound", 21:59:35 INFO - "revision": "774c838c19e217e177ba22876d57a344b54c33e4", 21:59:35 INFO - "stage_platform": "linux64-pgo", 21:59:35 INFO - "builduid": "2edcac09dacc44edabc36e8a243f73a8", 21:59:35 INFO - "slavebuilddir": "test" 21:59:35 INFO - } 21:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:59:35 INFO - Running post-action listener: _resource_record_post_action 21:59:35 INFO - ##### 21:59:35 INFO - ##### Running download-and-extract step. 21:59:35 INFO - ##### 21:59:35 INFO - Running pre-action listener: _resource_record_pre_action 21:59:35 INFO - Running main action method: download_and_extract 21:59:35 INFO - mkdir: /builds/slave/test/build/tests 21:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:35 INFO - https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:59:39 INFO - Downloaded 1361 bytes. 21:59:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:59:39 INFO - Using the following test package requirements: 21:59:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'jsshell-linux-x86_64.zip'], 21:59:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:39 INFO - https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:44 INFO - Downloaded 23878527 bytes. 21:59:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:59:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:59:46 INFO - Return code: 0 21:59:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59: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')]} 21:59:46 INFO - https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:49 INFO - Downloaded 23878527 bytes. 21:59:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:59:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:59:51 INFO - Return code: 0 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:51 INFO - https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:52 INFO - Downloaded 10840152 bytes. 21:59:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:59:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:59:52 INFO - Return code: 0 21:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:52 INFO - https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:59:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:59:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:59:54 INFO - Downloaded 58639137 bytes. 21:59:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:59:54 INFO - mkdir: /builds/slave/test/properties 21:59:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:54 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:54 INFO - Contents: 21:59:54 INFO - build_url:https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:59:55 INFO - Running post-action listener: _resource_record_post_action 21:59:55 INFO - Running post-action listener: set_extra_try_arguments 21:59:55 INFO - ##### 21:59:55 INFO - ##### Running populate-webroot step. 21:59:55 INFO - ##### 21:59:55 INFO - Running pre-action listener: _resource_record_pre_action 21:59:55 INFO - Running main action method: populate_webroot 21:59:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:55 INFO - '--tppagecycles', 21:59:55 INFO - '7'], 21:59:55 INFO - 'tests': ['tsvgm']}}, 21:59:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['damp', 'tps']}, 21:59:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'tests': ['damp', 'tps']}, 21:59:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['dromaeo_dom']}, 21:59:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['a11yr', 21:59:55 INFO - 'ts_paint', 21:59:55 INFO - 'tpaint', 21:59:55 INFO - 'sessionrestore', 21:59:55 INFO - 'sessionrestore_no_auto_restore', 21:59:55 INFO - 'tabpaint']}, 21:59:55 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:55 INFO - 'ts_paint', 21:59:55 INFO - 'tpaint', 21:59:55 INFO - 'sessionrestore', 21:59:55 INFO - 'sessionrestore_no_auto_restore', 21:59:55 INFO - 'tabpaint']}, 21:59:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:55 INFO - 'ts_paint', 21:59:55 INFO - 'tpaint', 21:59:55 INFO - 'sessionrestore', 21:59:55 INFO - 'sessionrestore_no_auto_restore', 21:59:55 INFO - 'tabpaint']}, 21:59:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:55 INFO - 'ts_paint', 21:59:55 INFO - 'tpaint', 21:59:55 INFO - 'sessionrestore', 21:59:55 INFO - 'sessionrestore_no_auto_restore', 21:59:55 INFO - 'tabpaint']}, 21:59:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['a11yr', 21:59:55 INFO - 'ts_paint', 21:59:55 INFO - 'tpaint', 21:59:55 INFO - 'sessionrestore', 21:59:55 INFO - 'sessionrestore_no_auto_restore', 21:59:55 INFO - 'tabpaint']}, 21:59:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['a11yr', 21:59:55 INFO - 'ts_paint', 21:59:55 INFO - 'tpaint', 21:59:55 INFO - 'sessionrestore', 21:59:55 INFO - 'sessionrestore_no_auto_restore', 21:59:55 INFO - 'tabpaint']}, 21:59:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['tsvgx', 21:59:55 INFO - 'tsvgr_opacity', 21:59:55 INFO - 'tart', 21:59:55 INFO - 'tscrollx', 21:59:55 INFO - 'cart']}, 21:59:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:55 INFO - 'tsvgr_opacity', 21:59:55 INFO - 'tart', 21:59:55 INFO - 'tscrollx', 21:59:55 INFO - 'cart']}, 21:59:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'talos_options': ['--disable-e10s'], 21:59:55 INFO - 'tests': ['tp5o']}, 21:59:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'tests': ['tp5o']}, 21:59:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'talos_options': ['--disable-e10s', 21:59:55 INFO - '--xperf_path', 21:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:55 INFO - 'tests': ['tp5n']}, 21:59:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:55 INFO - 'talos_options': ['--xperf_path', 21:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:55 INFO - 'tests': ['tp5n']}}, 21:59:55 INFO - 'talos.zip': {'path': '', 21:59:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:55 INFO - Running post-action listener: _resource_record_post_action 21:59:55 INFO - ##### 21:59:55 INFO - ##### Running create-virtualenv step. 21:59:55 INFO - ##### 21:59:55 INFO - Running pre-action listener: _resource_record_pre_action 21:59:55 INFO - Running main action method: create_virtualenv 21:59:55 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:55 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 21:59:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:55 INFO - Using real prefix '/usr' 21:59:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:55 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:57 INFO - Installing pip.................done. 21:59:57 INFO - Return code: 0 21:59:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59:57 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')]} 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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')]} 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 21:59:57 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 21:59:57 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 21:59:57 INFO - Using env: {'DISPLAY': ':0', 21:59:57 INFO - 'HOME': '/home/cltbld', 21:59:57 INFO - 'LANG': 'en_US.UTF-8', 21:59:57 INFO - 'LANGUAGE': 'en_US:en', 21:59:57 INFO - 'LOGNAME': 'cltbld', 21:59:57 INFO - 'MAIL': '/var/mail/cltbld', 21:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:57 INFO - 'MOZ_NO_REMOTE': '1', 21:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:57 INFO - 'NO_EM_RESTART': '1', 21:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:57 INFO - 'PWD': '/builds/slave/test', 21:59:57 INFO - 'SHELL': '/bin/bash', 21:59:57 INFO - 'SHLVL': '1', 21:59:57 INFO - 'TERM': 'linux', 21:59:57 INFO - 'TMOUT': '86400', 21:59:57 INFO - 'USER': 'cltbld', 21:59:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 21:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:57 INFO - '_': '/tools/buildbot/bin/python'} 21:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:57 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 21:59:57 INFO - Cleaning up... 21:59:57 INFO - Return code: 0 21:59:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:59:57 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')]} 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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')]} 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 21:59:57 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 21:59:57 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 21:59:57 INFO - Using env: {'DISPLAY': ':0', 21:59:57 INFO - 'HOME': '/home/cltbld', 21:59:57 INFO - 'LANG': 'en_US.UTF-8', 21:59:57 INFO - 'LANGUAGE': 'en_US:en', 21:59:57 INFO - 'LOGNAME': 'cltbld', 21:59:57 INFO - 'MAIL': '/var/mail/cltbld', 21:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:57 INFO - 'MOZ_NO_REMOTE': '1', 21:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:57 INFO - 'NO_EM_RESTART': '1', 21:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:57 INFO - 'PWD': '/builds/slave/test', 21:59:57 INFO - 'SHELL': '/bin/bash', 21:59:57 INFO - 'SHLVL': '1', 21:59:57 INFO - 'TERM': 'linux', 21:59:57 INFO - 'TMOUT': '86400', 21:59:57 INFO - 'USER': 'cltbld', 21:59:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 21:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:57 INFO - '_': '/tools/buildbot/bin/python'} 21:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:58 INFO - Downloading/unpacking psutil>=0.7.1 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:00 INFO - Installing collected packages: psutil 22:00:00 INFO - Running setup.py install for psutil 22:00:00 INFO - building 'psutil._psutil_linux' extension 22:00:00 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 22:00:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:00:00 INFO - building 'psutil._psutil_posix' extension 22:00:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:00:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:00:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:00 INFO - Successfully installed psutil 22:00:00 INFO - Cleaning up... 22:00:00 INFO - Return code: 0 22:00:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 22:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:00:00 INFO - Using env: {'DISPLAY': ':0', 22:00:00 INFO - 'HOME': '/home/cltbld', 22:00:00 INFO - 'LANG': 'en_US.UTF-8', 22:00:00 INFO - 'LANGUAGE': 'en_US:en', 22:00:00 INFO - 'LOGNAME': 'cltbld', 22:00:00 INFO - 'MAIL': '/var/mail/cltbld', 22:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:00 INFO - 'MOZ_NO_REMOTE': '1', 22:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:00 INFO - 'NO_EM_RESTART': '1', 22:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:00 INFO - 'PWD': '/builds/slave/test', 22:00:00 INFO - 'SHELL': '/bin/bash', 22:00:00 INFO - 'SHLVL': '1', 22:00:00 INFO - 'TERM': 'linux', 22:00:00 INFO - 'TMOUT': '86400', 22:00:00 INFO - 'USER': 'cltbld', 22:00:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:00 INFO - '_': '/tools/buildbot/bin/python'} 22:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:00:02 INFO - Installing collected packages: mozsystemmonitor 22:00:02 INFO - Running setup.py install for mozsystemmonitor 22:00:02 INFO - Successfully installed mozsystemmonitor 22:00:02 INFO - Cleaning up... 22:00:03 INFO - Return code: 0 22:00:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 22:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:00:03 INFO - Using env: {'DISPLAY': ':0', 22:00:03 INFO - 'HOME': '/home/cltbld', 22:00:03 INFO - 'LANG': 'en_US.UTF-8', 22:00:03 INFO - 'LANGUAGE': 'en_US:en', 22:00:03 INFO - 'LOGNAME': 'cltbld', 22:00:03 INFO - 'MAIL': '/var/mail/cltbld', 22:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:03 INFO - 'MOZ_NO_REMOTE': '1', 22:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:03 INFO - 'NO_EM_RESTART': '1', 22:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:03 INFO - 'PWD': '/builds/slave/test', 22:00:03 INFO - 'SHELL': '/bin/bash', 22:00:03 INFO - 'SHLVL': '1', 22:00:03 INFO - 'TERM': 'linux', 22:00:03 INFO - 'TMOUT': '86400', 22:00:03 INFO - 'USER': 'cltbld', 22:00:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:03 INFO - '_': '/tools/buildbot/bin/python'} 22:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:03 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:00:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Downloading docopt-0.6.1.tar.gz 22:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:05 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:05 INFO - Running setup.py install for blobuploader 22:00:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:00:05 INFO - Running setup.py install for requests 22:00:06 INFO - Running setup.py install for docopt 22:00:06 INFO - Successfully installed blobuploader requests docopt 22:00:06 INFO - Cleaning up... 22:00:06 INFO - Return code: 0 22:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:06 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 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 22:00:06 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 22:00:06 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 22:00:06 INFO - Using env: {'DISPLAY': ':0', 22:00:06 INFO - 'HOME': '/home/cltbld', 22:00:06 INFO - 'LANG': 'en_US.UTF-8', 22:00:06 INFO - 'LANGUAGE': 'en_US:en', 22:00:06 INFO - 'LOGNAME': 'cltbld', 22:00:06 INFO - 'MAIL': '/var/mail/cltbld', 22:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:06 INFO - 'MOZ_NO_REMOTE': '1', 22:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:06 INFO - 'NO_EM_RESTART': '1', 22:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:06 INFO - 'PWD': '/builds/slave/test', 22:00:06 INFO - 'SHELL': '/bin/bash', 22:00:06 INFO - 'SHLVL': '1', 22:00:06 INFO - 'TERM': 'linux', 22:00:06 INFO - 'TMOUT': '86400', 22:00:06 INFO - 'USER': 'cltbld', 22:00:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:06 INFO - '_': '/tools/buildbot/bin/python'} 22:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:06 INFO - Running setup.py (path:/tmp/pip-ofHX7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:06 INFO - Running setup.py (path:/tmp/pip-JOFLYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:06 INFO - Running setup.py (path:/tmp/pip-ffYc4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:06 INFO - Running setup.py (path:/tmp/pip-gYfGYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:06 INFO - Running setup.py (path:/tmp/pip-ycNCnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:07 INFO - Running setup.py (path:/tmp/pip-jBuS5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:07 INFO - Running setup.py (path:/tmp/pip-L7bAHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:07 INFO - Running setup.py (path:/tmp/pip-DuEpM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:07 INFO - Running setup.py (path:/tmp/pip-xCLjMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:07 INFO - Running setup.py (path:/tmp/pip-L1e5yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:07 INFO - Running setup.py (path:/tmp/pip-wec4Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:07 INFO - Running setup.py (path:/tmp/pip-2RKNPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:07 INFO - Running setup.py (path:/tmp/pip-cbnJaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:07 INFO - Running setup.py (path:/tmp/pip-qvk0C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:07 INFO - Running setup.py (path:/tmp/pip-Hslc0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:07 INFO - Running setup.py (path:/tmp/pip-HfC5eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:07 INFO - Running setup.py (path:/tmp/pip-_0Ds8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:07 INFO - Running setup.py install for manifestparser 22:00:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Running setup.py install for mozcrash 22:00:08 INFO - Running setup.py install for mozdebug 22:00:08 INFO - Running setup.py install for mozdevice 22:00:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Running setup.py install for mozfile 22:00:08 INFO - Running setup.py install for mozhttpd 22:00:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Running setup.py install for mozinfo 22:00:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Running setup.py install for mozInstall 22:00:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Running setup.py install for mozleak 22:00:08 INFO - Running setup.py install for mozlog 22:00:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:00:08 INFO - Running setup.py install for moznetwork 22:00:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:00:09 INFO - Running setup.py install for mozprocess 22:00:09 INFO - Running setup.py install for mozprofile 22:00:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:00:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:00:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:00:09 INFO - Running setup.py install for mozrunner 22:00:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:00:09 INFO - Running setup.py install for mozscreenshot 22:00:09 INFO - Running setup.py install for moztest 22:00:09 INFO - Running setup.py install for mozversion 22:00:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:00:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:09 INFO - Cleaning up... 22:00:09 INFO - Return code: 0 22:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 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 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 22:00:09 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 22:00:09 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 22:00:09 INFO - Using env: {'DISPLAY': ':0', 22:00:09 INFO - 'HOME': '/home/cltbld', 22:00:09 INFO - 'LANG': 'en_US.UTF-8', 22:00:09 INFO - 'LANGUAGE': 'en_US:en', 22:00:09 INFO - 'LOGNAME': 'cltbld', 22:00:09 INFO - 'MAIL': '/var/mail/cltbld', 22:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:09 INFO - 'MOZ_NO_REMOTE': '1', 22:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:09 INFO - 'NO_EM_RESTART': '1', 22:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:09 INFO - 'PWD': '/builds/slave/test', 22:00:09 INFO - 'SHELL': '/bin/bash', 22:00:09 INFO - 'SHLVL': '1', 22:00:09 INFO - 'TERM': 'linux', 22:00:09 INFO - 'TMOUT': '86400', 22:00:09 INFO - 'USER': 'cltbld', 22:00:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:09 INFO - '_': '/tools/buildbot/bin/python'} 22:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:09 INFO - Running setup.py (path:/tmp/pip-DxyeOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:09 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)) 22:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:09 INFO - Running setup.py (path:/tmp/pip-VHcq0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:10 INFO - Running setup.py (path:/tmp/pip-MMhviR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:10 INFO - Running setup.py (path:/tmp/pip-mRXvcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:10 INFO - Running setup.py (path:/tmp/pip-bkt9jF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:10 INFO - Running setup.py (path:/tmp/pip-OF1Z3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:10 INFO - Running setup.py (path:/tmp/pip-YJPVEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:10 INFO - Running setup.py (path:/tmp/pip-8VDCTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:10 INFO - Running setup.py (path:/tmp/pip-L6LDjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:10 INFO - Running setup.py (path:/tmp/pip-l5iPal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:10 INFO - Running setup.py (path:/tmp/pip-JrMhQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:10 INFO - Running setup.py (path:/tmp/pip-1hxzp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:10 INFO - Running setup.py (path:/tmp/pip-7Oc0js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:10 INFO - Running setup.py (path:/tmp/pip-MH9A9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:10 INFO - Running setup.py (path:/tmp/pip-rFMvxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:10 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)) 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:10 INFO - Running setup.py (path:/tmp/pip-LEeUG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:11 INFO - Running setup.py (path:/tmp/pip-w8YE1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:13 INFO - Downloading blessings-1.6.tar.gz 22:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:13 INFO - Installing collected packages: blessings 22:00:13 INFO - Running setup.py install for blessings 22:00:13 INFO - Successfully installed blessings 22:00:13 INFO - Cleaning up... 22:00:13 INFO - Return code: 0 22:00:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:13 INFO - Reading from file tmpfile_stdout 22:00:13 INFO - Current package versions: 22:00:13 INFO - argparse == 1.2.1 22:00:13 INFO - blessings == 1.6 22:00:13 INFO - blobuploader == 1.2.4 22:00:13 INFO - docopt == 0.6.1 22:00:13 INFO - manifestparser == 1.1 22:00:13 INFO - mozInstall == 1.12 22:00:13 INFO - mozcrash == 0.17 22:00:13 INFO - mozdebug == 0.1 22:00:13 INFO - mozdevice == 0.48 22:00:13 INFO - mozfile == 1.2 22:00:13 INFO - mozhttpd == 0.7 22:00:13 INFO - mozinfo == 0.9 22:00:13 INFO - mozleak == 0.1 22:00:13 INFO - mozlog == 3.1 22:00:13 INFO - moznetwork == 0.27 22:00:13 INFO - mozprocess == 0.22 22:00:13 INFO - mozprofile == 0.28 22:00:13 INFO - mozrunner == 6.11 22:00:13 INFO - mozscreenshot == 0.1 22:00:13 INFO - mozsystemmonitor == 0.0 22:00:13 INFO - moztest == 0.7 22:00:13 INFO - mozversion == 1.4 22:00:13 INFO - psutil == 3.1.1 22:00:13 INFO - requests == 1.2.3 22:00:13 INFO - wsgiref == 0.1.2 22:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:13 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')]} 22:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:13 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')]} 22:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:13 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 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 22:00:13 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 22:00:13 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 22:00:13 INFO - Using env: {'DISPLAY': ':0', 22:00:13 INFO - 'HOME': '/home/cltbld', 22:00:13 INFO - 'LANG': 'en_US.UTF-8', 22:00:13 INFO - 'LANGUAGE': 'en_US:en', 22:00:13 INFO - 'LOGNAME': 'cltbld', 22:00:13 INFO - 'MAIL': '/var/mail/cltbld', 22:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:13 INFO - 'MOZ_NO_REMOTE': '1', 22:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:13 INFO - 'NO_EM_RESTART': '1', 22:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:13 INFO - 'PWD': '/builds/slave/test', 22:00:13 INFO - 'SHELL': '/bin/bash', 22:00:13 INFO - 'SHLVL': '1', 22:00:13 INFO - 'TERM': 'linux', 22:00:13 INFO - 'TMOUT': '86400', 22:00:13 INFO - 'USER': 'cltbld', 22:00:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:13 INFO - '_': '/tools/buildbot/bin/python'} 22:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 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)) 22:00:13 INFO - Cleaning up... 22:00:13 INFO - Return code: 0 22:00:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:00:13 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')]} 22:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:13 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')]} 22:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:13 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 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 22:00:13 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 22:00:13 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 22:00:13 INFO - Using env: {'DISPLAY': ':0', 22:00:13 INFO - 'HOME': '/home/cltbld', 22:00:13 INFO - 'LANG': 'en_US.UTF-8', 22:00:13 INFO - 'LANGUAGE': 'en_US:en', 22:00:13 INFO - 'LOGNAME': 'cltbld', 22:00:13 INFO - 'MAIL': '/var/mail/cltbld', 22:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:13 INFO - 'MOZ_NO_REMOTE': '1', 22:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:13 INFO - 'NO_EM_RESTART': '1', 22:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:13 INFO - 'PWD': '/builds/slave/test', 22:00:13 INFO - 'SHELL': '/bin/bash', 22:00:13 INFO - 'SHLVL': '1', 22:00:13 INFO - 'TERM': 'linux', 22:00:13 INFO - 'TMOUT': '86400', 22:00:13 INFO - 'USER': 'cltbld', 22:00:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:13 INFO - '_': '/tools/buildbot/bin/python'} 22:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:13 INFO - Downloading/unpacking jsonschema 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:15 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:16 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:16 INFO - warning: no files found matching '*.txt' 22:00:16 INFO - no previously-included directories found matching 'build' 22:00:16 INFO - no previously-included directories found matching 'dist' 22:00:16 INFO - no previously-included directories found matching '.git*' 22:00:16 INFO - Installing collected packages: jsonschema, functools32 22:00:16 INFO - Running setup.py install for functools32 22:00:16 INFO - warning: no files found matching '*.txt' 22:00:16 INFO - no previously-included directories found matching 'build' 22:00:16 INFO - no previously-included directories found matching 'dist' 22:00:16 INFO - no previously-included directories found matching '.git*' 22:00:16 INFO - Successfully installed jsonschema functools32 22:00:16 INFO - Cleaning up... 22:00:16 INFO - Return code: 0 22:00:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e39d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', '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 22:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:00:16 INFO - Using env: {'DISPLAY': ':0', 22:00:16 INFO - 'HOME': '/home/cltbld', 22:00:16 INFO - 'LANG': 'en_US.UTF-8', 22:00:16 INFO - 'LANGUAGE': 'en_US:en', 22:00:16 INFO - 'LOGNAME': 'cltbld', 22:00:16 INFO - 'MAIL': '/var/mail/cltbld', 22:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:16 INFO - 'MOZ_NO_REMOTE': '1', 22:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:16 INFO - 'NO_EM_RESTART': '1', 22:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:16 INFO - 'PWD': '/builds/slave/test', 22:00:16 INFO - 'SHELL': '/bin/bash', 22:00:16 INFO - 'SHLVL': '1', 22:00:16 INFO - 'TERM': 'linux', 22:00:16 INFO - 'TMOUT': '86400', 22:00:16 INFO - 'USER': 'cltbld', 22:00:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:16 INFO - '_': '/tools/buildbot/bin/python'} 22:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:16 INFO - Downloading/unpacking flake8 22:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:19 INFO - no previously-included directories found matching 'docs/_build' 22:00:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:19 INFO - Running setup.py install for pep8 22:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:19 INFO - no previously-included directories found matching 'docs/_build' 22:00:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:00:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:19 INFO - Cleaning up... 22:00:19 INFO - Return code: 0 22:00:19 INFO - Running post-action listener: _resource_record_post_action 22:00:19 INFO - Running post-action listener: _start_resource_monitoring 22:00:19 INFO - Starting resource monitoring. 22:00:19 INFO - ##### 22:00:19 INFO - ##### Running install step. 22:00:19 INFO - ##### 22:00:19 INFO - Running pre-action listener: _resource_record_pre_action 22:00:19 INFO - Running main action method: install 22:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:19 INFO - Reading from file tmpfile_stdout 22:00:19 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:19 INFO - Reading from file tmpfile_stdout 22:00:19 INFO - Output received: 22:00:19 INFO - Usage: mozinstall [options] installer 22:00:19 INFO - Options: 22:00:19 INFO - -h, --help show this help message and exit 22:00:19 INFO - -d DEST, --destination=DEST 22:00:19 INFO - Directory to install application into. [default: 22:00:19 INFO - "/builds/slave/test"] 22:00:19 INFO - --app=APP Application being installed. [default: firefox] 22:00:19 INFO - mkdir: /builds/slave/test/build/application 22:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:00:36 INFO - Reading from file tmpfile_stdout 22:00:36 INFO - Output received: 22:00:36 INFO - /builds/slave/test/build/application/firefox/firefox 22:00:36 INFO - Running post-action listener: _resource_record_post_action 22:00:36 INFO - ##### 22:00:36 INFO - ##### Running run-tests step. 22:00:36 INFO - ##### 22:00:36 INFO - Running pre-action listener: _resource_record_pre_action 22:00:36 INFO - Running main action method: run_tests 22:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:36 INFO - Python 2.7.3 22:00:36 INFO - Return code: 0 22:00:36 INFO - grabbing minidump binary from tooltool 22:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c410>, '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 0x115d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:00:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:00:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:36 INFO - Return code: 0 22:00:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:00:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:00:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:00:37 INFO - Return code: 0 22:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 22:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 22:00:37 INFO - Using env: {'DISPLAY': ':0', 22:00:37 INFO - 'HOME': '/home/cltbld', 22:00:37 INFO - 'LANG': 'en_US.UTF-8', 22:00:37 INFO - 'LANGUAGE': 'en_US:en', 22:00:37 INFO - 'LOGNAME': 'cltbld', 22:00:37 INFO - 'MAIL': '/var/mail/cltbld', 22:00:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:37 INFO - 'MOZ_NO_REMOTE': '1', 22:00:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:37 INFO - 'NO_EM_RESTART': '1', 22:00:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:37 INFO - 'PWD': '/builds/slave/test', 22:00:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:37 INFO - 'SHELL': '/bin/bash', 22:00:37 INFO - 'SHLVL': '1', 22:00:37 INFO - 'TERM': 'linux', 22:00:37 INFO - 'TMOUT': '86400', 22:00:37 INFO - 'USER': 'cltbld', 22:00:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008', 22:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:37 INFO - '_': '/tools/buildbot/bin/python'} 22:00:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 22:00:37 INFO - mozversion application_buildid: 20160429193201 22:00:37 INFO - mozversion application_changeset: 774c838c19e217e177ba22876d57a344b54c33e4 22:00:37 INFO - mozversion application_display_name: Nightly 22:00:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:37 INFO - mozversion application_name: Firefox 22:00:37 INFO - mozversion application_remotingname: firefox 22:00:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:37 INFO - mozversion application_vendor: Mozilla 22:00:37 INFO - mozversion application_version: 49.0a1 22:00:37 INFO - mozversion platform_buildid: 20160429193201 22:00:37 INFO - mozversion platform_changeset: 774c838c19e217e177ba22876d57a344b54c33e4 22:00:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:37 INFO - mozversion platform_version: 49.0a1 22:00:37 INFO - using testdate: 1461992437 22:00:37 INFO - actual date: 1461992437 22:00:37 INFO - starting webserver on 'localhost:53225' 22:00:37 INFO - SUITE-START | Running 2 tests 22:00:37 INFO - TEST-START | dromaeo_css 22:00:37 INFO - operating with platform_type : linux_ 22:00:37 INFO - Initialising browser for dromaeo_css test... 22:00:37 INFO - TEST-INFO | started process 31730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_diWM9/profile http://localhost:53225/getInfo.html) 22:00:41 INFO - PROCESS | 31730 | 22:00:41 INFO - PROCESS | 31730 | (process:31797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:00:42 INFO - PROCESS | 31730 | __metrics Screen width/height:1600/1200 22:00:42 INFO - PROCESS | 31730 | colorDepth:24 22:00:42 INFO - PROCESS | 31730 | Browser inner width/height: 1024/697 22:00:42 INFO - PROCESS | 31730 | __metrics 22:00:43 ERROR - PROCESS | 31730 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:00:44 INFO - TEST-INFO | 31730: exit 0 22:00:44 INFO - Browser initialized. 22:00:44 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:44 INFO - TEST-INFO | started process 31848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_diWM9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:46 INFO - PROCESS | 31848 | 22:00:46 INFO - PROCESS | 31848 | (process:31908): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:00:56 INFO - PROCESS | 31848 | RSS: Main: 165150720 22:00:56 INFO - PROCESS | 31848 | 22:01:45 INFO - PROCESS | 31848 | 1461992505734 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] 22:03:52 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:53225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53225/tests/dromaeo/cssquery-ext.html) 22:03:53 INFO - PROCESS | 31848 | RSS: Main: 168488960 22:03:53 INFO - PROCESS | 31848 | 22:06:55 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:53225/tests/dromaeo/cssquery-ext.html (next: http://localhost:53225/tests/dromaeo/cssquery-jquery.html) 22:06:56 INFO - PROCESS | 31848 | RSS: Main: 166764544 22:06:56 INFO - PROCESS | 31848 | 22:09:58 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:53225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53225/tests/dromaeo/cssquery-mootools.html) 22:09:58 INFO - PROCESS | 31848 | RSS: Main: 167690240 22:09:58 INFO - PROCESS | 31848 | 22:13:00 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:53225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53225/tests/dromaeo/cssquery-prototype.html) 22:13:01 INFO - PROCESS | 31848 | RSS: Main: 165261312 22:13:01 INFO - PROCESS | 31848 | 22:16:03 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:53225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53225/tests/dromaeo/cssquery-yui.html) 22:16:04 INFO - PROCESS | 31848 | RSS: Main: 166445056 22:16:04 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:53225/tests/dromaeo/cssquery-yui.html (next: http://localhost:53225/tests/dromaeo/cssquery-dojo.html) 22:19:06 INFO - PROCESS | 31848 | RSS: Main: 168398848 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | __start_tp_report 22:19:06 INFO - PROCESS | 31848 | _x_x_mozilla_page_load 22:19:06 INFO - PROCESS | 31848 | _x_x_mozilla_page_load_details 22:19:06 INFO - PROCESS | 31848 | |i|pagename|runs| 22:19:06 INFO - PROCESS | 31848 | |0;dojo.html;3102.519109538022;3143.9371212575743;3154.1168472827617;3173.412918610056;3181.6500184979664;5285;5304.708241046741;5311.442298558653;5312.548433383162;5396.244525766396;5261.0793111205485;5303.681779093247;5378.139497680372;5378.784848606061;5438.293021907157;4822.3972003499475;4844.563989240967;4877.756112194394;4883.536064073907;4972.428170760372;669.93049631218;4852.514748525155;4890.046440944017;4901.852944411673;4935.062338155739;4900.926486102711;4917.2869933859565;4935.901281974358;4951.826686066006;4974.0797952378925;4700.976495117503;4847.297141914402;4984.3021976923255;5020.397552293748;5061.44324124346;4813;4828.106800241966;4829.541193586604;4845.030993801219;4898.142825005645;5226.189940559219;5271.604629652753;5302.946970530284;5323.467653234684;5374.193870919355;5615.298087739033;5629.80295689653;5739.368669446358;5741.138829175616;5745.683987380692;5711.257536520267;5726.427357264281;5736.139579063132;5736.483716465496;5786.88426231473;5298.496642818926;5299.682019078868;5323.866903327409;5349.893002139936;5350.224217488481;5528.06022976095;5644;5699.839117444289;5747.540196784247;5780.566457515703;5599.216109744639;5601.8599535011135;5619;5634.126710359901;5658.688772117573;5686.090225563973;5714.114312281603;5736.311642602915;5741.052726300197;5752.9712351437975;5475.397706252309;5600.943990560042;5653.575981801381;5691.971540142273;5701;5499.312585926759;5538.501534861882;5556.555475561945;5604.4395560444445;5619.690916999604;4210;4226.1336426032585;4252.978735106305;4273.316269396882;4297.634701050446;3799.0692280390926;3814.3515602347666;3818.255440189192;3876.9224615507533;3880.359740642819;5332.893342133136;5334.333208348957;5334.3865455473115;5346.705931173745;5383.5962302826665;5597.076482380443;5605.299337582802;5618.4662457066515;5626.521745651584;5629.943700563023;5287.365516138088;5296.496832800878;5323.893522129536;5327.413984461706;5338.813141540028;4690.835820746258;4765.142274390643;4804.399450068741;4806.2310030394965;4845.442774080955;5655.80204692842;5702.857428564236;5727.5131613812455;5740.483356497935;5751.1373294006235;5731.77072917087;5755.769769209185;5786.710664466844;5800.303963524404;5833.6208146472045;5856.150858125633;5912.46787789101;5932.6143800654545;5938.287405511366;5953.880922381441;5412.621116521806;5493.176023596492;5579.107342825128;5648.802291919763;5664.433556644302;5647.29408823897;5661.037623603915;5663.03728366187;5688.687122208153;5735.36910939788;5525.640833345819;5529.336479622471;5530.585206109638;5534.1145416733125;5534.169874518693;5404.378496472956;5456.072467680425;5474.042042642602;5488.945110549003;5548.667079975215;5225.451327610698;5344.518993290467;5398.1902714593125;5441.619086663895;5452.645578037414;5504.752286147213;5534.308211473566;5536.889262214652;5537;5591.748371323219;5357.8392648220615;5460.453954604666;5463.07127788269;5466.863328416822;5468.562514998711 22:19:06 INFO - PROCESS | 31848 | |1;ext.html;598.1506261109224;636.5035272487462;642.8489305013322;650.2976785072123;655.3904868472318;35905.281894362095;36494.99999999996;36560;36688.81655591718;36958;39146;39798.40302395466;39878.601213987924;39913.40129898054;39994;8380.91619083809;8585.742427727178;8587.355948303903;8598.140185981414;8614.353923455767;8480.957595212016;8483.44857584255;8546.786330341729;8547.230749232567;8697.869531957025;8719.782005449882;8781.95609021954;8805.163509466622;8831.73504794854;8831.95584022079;8574.399792014561;8697.782555436133;8728.389012769108;8759.299256059532;8773.25427338677;8322.791930201733;8420.28427583656;8443.197896199852;8461.957690211571;8463.534505602189;39136.41295380572;39420.21159576821;39529.40705889414;39558.20883582312;39658.40512392316;3327.5674162358982;3336.966630333714;3347.2134048498583;3439.8624055038017;3948.9210215795524;27992.440151197065;29056.564151537743;29169;29232.707672923425;29356.853215733783;4101.425800387948;4104.56902025286;4181.6236538711355;4284.485861696617;4347.087111706545;302177;302336;303500;304367;304589.9999999978;57052;57509;57796.71101644465;57886;58007.709961449924;55396.446035539935;56099.71950140223;56316.718416408476;56523.86952260932;61817.38182618206;15975.281112349972;16339.428120015742;16354.754678679828;16357.345706171858;16361.100139492442;12300.138990270774;12317.876821231852;12327.260364378166;12357.135000549875;12419.565315213924;18637.7204341935;18662.53343666392;18745.7188142178;18879.244830206637;19020.144093515824;7143.678534465857;7247.16657584374;7354.595497247596;7365.963170184222;7394.852102958018;1024.3393011507535;1043.968680939573;1092.5411327242577;1110.134095405585;1194.2953657342036;30088.548671769942;30295.394092118033;30503.084907452812;30507.847460762998;30627.846860766;1113.4822307626991;1145.73075327298;1146.2721172055806;1183.810590305547;1187.6912002879315;16010.599735006484;16029.358825647078;16343.509694709177;16673.6665266694;16770.496885093467;480345;488933;489434;490653;493295;54371.72814135983;55747.44252557504;55842.16236756452;55901.72049139728;56129.43870561324;1404.4663028049276;1414.6039109049482;1414.9080309779831;1418.7729963205838;1508.894377393594;29440;30358.69641303559;30434.847825761615;30539.54190687097;30793.230169245948;47842.282365763844;48577.75711121422;48631.27053094277;48710.75644621754;48716.75641621769;335683;340024;340748;428267;430369;26786.464270714867;26871.731282686924;26942;26981.73018269792;27123.86438067797;44093.77953110214;44552.554474456134;44664.10671786481;45289.32066018946;45638.31542526798;35729.28541429209;37273.25453490969;38390.23219535538;38454.03864903288;38492.6150738489;33893.32213355768;34589.30821383508;34752.826235868655;34918.65081349154;35033.124171895906;34789.82605086958;35219.823900881354;36111.819440902626;36210.63789362178;36293.45559816552;30901.536476952413;31440;33475.665243347255;33750.83124584361;33857.49213761845;26485.470290594465;26715.465690686466;26803.463930721668;27046.864765676044;27178.72821271762 22:19:06 INFO - PROCESS | 31848 | |2;jquery.html;366.0811363477672;370.9591944886064;384.3657964358808;386.3972203362753;393.4668524149777;16725.83274167258;17996.640067198663;18163.636727265446;18749.34377296795;18809.717854232196;10294.382337059782;10528.526216320264;10577.947110264457;10596.364218146897;10657.680269591925;3789.5642001169804;4852.126617208901;4886.9511304886855;5046.772895219724;5060.114479965991;5132.666376685504;5367.892642147155;5402.810901618444;5418.83743487696;5439.700816455093;5372.892542149155;5378;5389.407165211824;5432.076546987002;5780.855478613047;6126.663033533154;6195.132681424604;6243.687815609202;6251.562390632657;6264.436200741932;5280.603954703374;5333.493318134771;5442.727863606804;5447.5641948644015;5657.830265092012;12037.939810300892;12328.19866708661;12352.38238088101;12394.070444716592;12509.311987840665;2159.492519257973;2220.5225876436643;2274.442761523421;2277.5900337939165;2437.0971509221163;9231.630734770668;9424.481653509054;9440.811183776355;9716.31985760997;9732.2214222862;1824.7262910563388;1859.6280743851285;1865.291189348039;1916.0132531746162;1980.4355758608872;80299.18204907724;83922;84353;85069;85620;9491.76270593227;9796.51017449139;10710.410927398912;10724.463776811284;10764.946175269073;14832.851671483362;14840.257987100602;14881.925590371979;14913.254337283093;14966.102033878002;7903.68385264583;7948.523088614702;7975.1626079262005;8040.15578364275;8062.7581172564915;7759.922400776033;7849.686012559434;7864.2922137007945;7927.603619818986;7953.483023603448;4257.489101307801;4258.701890867609;4472.642188624902;4529;4538.29656403258;1725.8274172582892;1795.9910200448915;1831.0478551153326;1888.612834368951;1898.411492437349;935.209747763139;975.6341371985505;978.6525783346809;1020.5458570935863;1056.957721691139;17592.472225833244;17706.822931770774;17710.822891770917;17975.640487190183;18553.628927421378;997.4663554998041;1021.9029192226726;1025.3796453145887;1043.0977204718015;1071.694567048403;9799.510024498746;10052.145567626834;10102.393856368495;10115.190784737204;10122.696319110439;472037;478587;480211;480705;483321;93890.53054734819;98278;101291.49354253181;102197;103229;1011.585250047477;1043.4574021508772;1050.564015933379;1060.867391576053;1071.1912506057877;16296.837031629531;16328.510144695678;16366.099864507567;16556.83443165553;16582;26608.334791630365;27900;37487.25025499529;37510;40505.797471012454;53522.450591700144;54449.455505444435;54682.726586366814;54818.725906370215;55077.44922550723;7916.525008499509;7946.841063178588;7997.360211182975;8014.238647328728;8044.3564514839845;11473.885261147281;12298.877011229773;12525.874741252472;12753.553625623059;12914.67713307175;8441.56493396112;10875.293105948089;11285.943570282096;11303.717407064889;11603.187776855877;11052.778944421227;11107.500162492546;11417.257878237888;11471.885281147415;11514;11364.204505684524;11661.358625275352;11671.416429178338;11836.70408239801;11850.822237666269;7932.6430310635005;8076.394270429624;8115.107338192676;8142.267195952392;8403.41176117666;9547.474888881177;11457.656270311903;11490.08079353633;11565;11686.649400517997 22:19:06 INFO - PROCESS | 31848 | |3;mootools.html;1314.8619394963528;1325.5691900132458;1427.3291552970106;1721.4749501402068;1737.209569645812;7122.821929451767;7464.328210461057;7763.301302882739;7763.844723105534;7774.5335279883175;7760.534367937914;7768.223177682243;7798.103218129917;7826.256505631955;7834.8041298967555;2178.9564208715815;2212.4247695599097;2213.8339624528144;2216.855904366219;2218.4232099654128;2164.1235299703644;2175;2213.424509627492;2216.2243214874825;2221.4335344487213;2202.8347873909443;2204.801567858892;2221.7889300516426;2222.555488902218;2256.187772401934;2162.686410470481;2164.372332023703;2165.7509386420606;2166.4150679316494;2175.3800166952424;2143.7856214378594;2160.621891169055;2165.53441010182;2192.8793916334594;2200.922967696123;8003.839923201562;8042.557659328734;8066.878996815052;8067.233612806774;8106.189381061847;4632.907341853178;4856.295837103636;4869.488703686097;4873.366462359871;4882.6826256293225;2958.881644734208;3092.335147943203;3111.984440077808;3121.843907804601;3138.544910987917;1013.0780989299775;1030.9845352319721;1040.017183761346;1056.3239526702916;1057.0803401041067;10845.674629761119;10913.39976301303;10942.23404361687;10962.451877406178;10968.725781855437;4151.4395556600075;4178.603032711888;4221.936670949938;4248.490181178278;4264.808083636244;9346.813063738688;9357.532123393803;9362.672306469241;9371.531423428938;9384.390014649027;4798.976005120022;4832.51674832521;4858.295547145644;4860.95139048605;4878.56092951636;3956.624120708528;4354.804033818486;4403.493598236179;4469.955300447019;4518.864434066983;3504.6144924058335;3515.7538972271695;3579.1231148368815;3585.1395665040204;3633.1462106404974;1144.2848219862585;1145.4330106597122;1150.8791576884307;1155.4049664422828;1168.9649310520697;805.8428606421809;915.839728047589;917.9357444978921;939.4691999020531;950.2587981374539;5445.83662490118;5449.346078470529;5482.890342193134;5497.835064948058;5514.09017512114;987.2595553334999;996.8903420623726;1029.0943969306961;1033.1012019543045;1070.1545778834634;3742.73800833939;3773.3585290500682;3780.7353485256317;3783.0731470789833;3784.905377365588;9748.317617766688;9857.260705446977;9998.550065247082;10003.399796012263;10007.699769006942;9832.262580306506;9853.359531630564;9863.80272394548;10001.749956251006;10002.699919002442;7386.704531818667;7504.362129218968;7560.432967527458;7638.961805190938;7655.1962043985695;5539.695316757617;5595.972020139873;5617.775288988395;5675.801346952837;5749.310082790092;9084.046175151514;9165.17513423795;9218.723438296862;9230.492322922304;9275.30435217348;8594.957025214833;8918.10818918129;8967.058458861726;8994.055624159631;9046.095390460901;6740.157480314961;7152.928470715435;7260;7379.446541509516;7435.776926692208;7462.96268518654;7512.699492020258;7544.773656790305;7550.5469671819865;7555.471117021756;6664.633445160563;6703.698333574904;6964.582125072512;7062.646867656699;7071.46963977714;6526;6649.667516624246;6655.933440665532;6738.59568425896;6828.419584335188;6336.778212762531;6393.073004414427;6435.066915297162;6497.057926600711;6499.512536559682;4780.11567859947;4812.446568644651;4851.345068415719;4881.194602890483;4955.108080545537;4851.660383773243;4866.829660961849;4871.610271178368;4898.363212782316;4943.307936888767 22:19:06 INFO - PROCESS | 31848 | |4;prototype.html;305.49898167006114;307.5801530910307;309.8326903472125;313.2950860563733;313.57667149348396;5513.17302404639;5567.220589117522;5579.302587176603;5585.2739143911285;5622.690752008638;5427.511523962852;5470.030788915987;5477.712737506683;5482.780688772445;5495.450454954503;4003.899902502439;4071.4503542021744;4128.649064829493;4176.352665336878;4225.366195070733;4179.582041795811;4201;4208.768517731523;4220.53574106848;4222.451081359419;4139.9793001035105;4168.374743788426;4187.748735075906;4209.452771139748;4224.605880059588;4122.773247471388;4172.18642364739;4190.895227619319;4198.551499732587;4206.810693518799;3673.963260367389;3683.355412802749;3687.9631203688155;3696.3346597612417;3697.8335974881193;5302.469753024705;5303.124984377573;5306.602004849652;5318.282031925679;5326.98787230425;4664.696794708333;4803.879903002418;4809.446913604946;4813.302071199691;4828.251620998751;5650.491455768959;5653.8586535336535;5662.716864156817;5709.9714501427225;5717;3990.501187351581;4011.2779699654343;4038.1318016626274;4039.6970227233073;4071.857484988041;5690.857728556778;5815.651060936358;5937.732802023919;6057.363976782419;6070.2108725865355;3989.2221016901426;4005.239004589177;4021.738586991836;4028.1943611277275;4029.093453972833;4080.6123418275215;4080.6735461163034;4085.101277718897;4089.6319331259733;4090.611391917763;4617.584417402382;4761.976190119027;4766.308885211694;4770.354227791407;4822.517748225149;5793.913091303634;5798.971005144947;5805.651660900359;5824.242848429677;5850.23946886902;1528.7248295306952;1529.4799768078906;1532.8773698104126;1534.8695360894226;1539.2457695729013;956.1920177450182;989.6738370583453;999.48526508848;1021.6271061062658;1045.5765415006933;5759.280089988752;5764.394738552392;5772.538196944234;5787.479126878601;5861.3552509223955;6254.74981000764;6286.8428289292215;6314.62112273265;6326.778562750282;6337.683115844189;5337.359516858002;5591.412901645269;5642.7178641067785;5684.147377893349;5883.470487656132;3440.9311813763584;3446.379651662725;3468.6357932417236;3476;3477.8087205203956;6414.454771344394;6692;6707.899381509281;6712.395884370332;6721.462283017347;6583.868322633521;6600.669966501656;6628.370304821035;6635.701393437211;6646.900296495556;6498.675066246668;6659.966700166468;6681;6687.6321802301345;6718.596884186867;6374.394432528902;6411.71147298382;6432.38892305249;6452.419282264431;6487.18910136233;6282.2147231596055;6353.856305864989;6411.647359395278;6413.198350206224;6415.262244841903;6509.804705858832;6693.431058360094;6710.865782684416;6727.562708423937;6749.595024298558;4200.222958752641;4250.893727656833;4254.276772948544;4280.464941882265;4282.700210985326;6325.9683701583035;6474.352564743488;6480.060391243338;6496.74013039492;6497.317781632861;6184.5980011299125;6201.937980620317;6220.782272620437;6282.403171698681;6287.339829318039;6028.819135425944;6181.84545386369;6214.5960512566535;6215.285242197205;6237.1891654084675;5342.9198562022375;5581.246531718166;5740;6053.364396738279;6059.454649081604;5835.56233282514;5837.241158649518;5848.473637372657;5870.647761134345;5872.236609240771;5477.9602765456675;5682.431756824284;5711.485966263056;5733.885322293448;5748.338941021669 22:19:06 INFO - PROCESS | 31848 | |5;yui.html;712.6294326949986;755.8223817402912;798.8482188384206;806.4717609965475;842.389267780859;13108.934455327722;13264.270465124415;13540.526081587133;13551.864481355184;13553.254570998592;12036.51853925844;12100.636980890566;12102.487189101363;12110.27338359699;12127.090468214876;662.7150325360093;774.5623722596742;791.0823444804029;806.6289506826837;810.623060276971;803.8271771569111;804.1154729797234;810.6878851642101;813.0730966697969;816.383630359081;862.9093945135764;866.0819531296814;868.2576397180414;871.2594294849359;873.3231745397304;854.8546747053016;859.1194026123211;860.9612567434449;862.7498025572577;863.1799790199336;621.1614320667063;627.7363507326888;627.789690453694;629.8614304852925;630.8517498387876;13029.34853257343;13042.54351097707;13051.282179480124;13056.86943130566;13063.86936130636;12869.935650321688;13032.86967130326;13133.080684352099;13281.136726112773;13403.86596134036;12094;12101.93949030258;12136.211146275553;12291.56979505722;12456.81314780279;4412.338149277602;4437.4009508716235;4494.662900282459;4495.078508905666;4517.6160026397465;50874.236886446735;51332;51352.48647513514;51446;52104.739476302755;9323.673671421468;10303.536340864679;10399.948000260101;10492.842607360895;10567.841482377771;17606.647867042586;17608.119594020503;17623.118844058;17643.55891102733;17681;7169.068021157216;7465.253474652492;7734.883976740353;7766.339861111755;7781.45529812919;3849.9037524062123;4407.625351845065;4471.329300604935;4589.128065667513;4593.19619066662;2972.7324540791433;3057.3121047764075;3065.7700672449655;3067.662557118715;3068.7851850370707;585.8125399872;598.8233471126028;599.1342510072902;608.4979891589456;612.3264409149899;582.3535875178549;617.6294223465974;649.2209348781481;706.8444942112727;719.5754504842168;8205.220504052106;8769.561521923879;8919.10808919103;8938.1508756668;8941;605.678990135229;610.5512448350458;619.2259675405743;662.7084083003463;670.9597424154566;4176.206520761046;4234.703570750018;4248.532661407243;4276.358546218092;4323.156984388014;52379.47620523822;54685.72657136689;54922.72538637361;55038;60006;53270.467295327326;53566.7321663397;53737;54678.453215467336;55075.17387239195;48876.266855997186;49328.753356233705;49422;50516;51505.71235719062;8543.829123417621;8579.65681372763;8622.568871556523;8706.259967902799;8884.112663384554;31694;31796.841015794773;31883.68116318807;32883.83558082194;32918;42927;43892.78053609712;44281.77859110813;44472.33291500695;45079.77460112678;11323;11363.602273920373;11653;11705.180637355303;11754.23597466162;12717.364131793189;12867.678308042;13018.218906865619;13056.543020994219;13964.092333998258;12602.432890519765;12618.242905425337;12672.429740661877;13096.279704616338;13322;11600.593979210687;11811.645650630495;11970.820437693268;12019.699507512381;12296.139270250997;11029.117670586495;11080.39057851826;11107.166962477684;11172.441377930909;11197.730699040014;10212.744681382728;10733.785324293627;10871.728206794893;11007.119430445386;11012.063974561932;10225.590976360862;10563.788724225626;10647.89352106469;10652.627158049741;10653 22:19:06 INFO - PROCESS | 31848 | __end_tp_report 22:19:06 INFO - PROCESS | 31848 | __start_cc_report 22:19:06 INFO - PROCESS | 31848 | _x_x_mozilla_cycle_collect,345 22:19:06 INFO - PROCESS | 31848 | __end_cc_report 22:19:06 INFO - PROCESS | 31848 | __startTimestamp1461993546567__endTimestamp 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | ------- Summary: start ------- 22:19:06 INFO - PROCESS | 31848 | Number of tests: 6 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | [#0] dojo.html Cycles:165 Average:5239.30 Median:5456.07 stddev:684.96 (12.6%) stddev-sans-first:666.23 22:19:06 INFO - PROCESS | 31848 | Values: 3102.5 3143.9 3154.1 3173.4 3181.7 5285.0 5304.7 5311.4 5312.5 5396.2 5261.1 5303.7 5378.1 5378.8 5438.3 4822.4 4844.6 4877.8 4883.5 4972.4 669.9 4852.5 4890.0 4901.9 4935.1 4900.9 4917.3 4935.9 4951.8 4974.1 4701.0 4847.3 4984.3 5020.4 5061.4 4813.0 4828.1 4829.5 4845.0 4898.1 5226.2 5271.6 5302.9 5323.5 5374.2 5615.3 5629.8 5739.4 5741.1 5745.7 5711.3 5726.4 5736.1 5736.5 5786.9 5298.5 5299.7 5323.9 5349.9 5350.2 5528.1 5644.0 5699.8 5747.5 5780.6 5599.2 5601.9 5619.0 5634.1 5658.7 5686.1 5714.1 5736.3 5741.1 5753.0 5475.4 5600.9 5653.6 5692.0 5701.0 5499.3 5538.5 5556.6 5604.4 5619.7 4210.0 4226.1 4253.0 4273.3 4297.6 3799.1 3814.4 3818.3 3876.9 3880.4 5332.9 5334.3 5334.4 5346.7 5383.6 5597.1 5605.3 5618.5 5626.5 5629.9 5287.4 5296.5 5323.9 5327.4 5338.8 4690.8 4765.1 4804.4 4806.2 4845.4 5655.8 5702.9 5727.5 5740.5 5751.1 5731.8 5755.8 5786.7 5800.3 5833.6 5856.2 5912.5 5932.6 5938.3 5953.9 5412.6 5493.2 5579.1 5648.8 5664.4 5647.3 5661.0 5663.0 5688.7 5735.4 5525.6 5529.3 5530.6 5534.1 5534.2 5404.4 5456.1 5474.0 5488.9 5548.7 5225.5 5344.5 5398.2 5441.6 5452.6 5504.8 5534.3 5536.9 5537.0 5591.7 5357.8 5460.5 5463.1 5466.9 5468.6 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | [#1] ext.html Cycles:180 Average:54355.11 Median:36624.41 stddev:105186.86 (287.2%) stddev-sans-first:105404.50 22:19:06 INFO - PROCESS | 31848 | Values: 598.2 636.5 642.8 650.3 655.4 35905.3 36495.0 36560.0 36688.8 36958.0 39146.0 39798.4 39878.6 39913.4 39994.0 8380.9 8585.7 8587.4 8598.1 8614.4 8481.0 8483.4 8546.8 8547.2 8697.9 8719.8 8782.0 8805.2 8831.7 8832.0 8574.4 8697.8 8728.4 8759.3 8773.3 8322.8 8420.3 8443.2 8462.0 8463.5 39136.4 39420.2 39529.4 39558.2 39658.4 3327.6 3337.0 3347.2 3439.9 3948.9 27992.4 29056.6 29169.0 29232.7 29356.9 4101.4 4104.6 4181.6 4284.5 4347.1 302177.0 302336.0 303500.0 304367.0 304590.0 57052.0 57509.0 57796.7 57886.0 58007.7 55396.4 56099.7 56316.7 56523.9 61817.4 15975.3 16339.4 16354.8 16357.3 16361.1 12300.1 12317.9 12327.3 12357.1 12419.6 18637.7 18662.5 18745.7 18879.2 19020.1 7143.7 7247.2 7354.6 7366.0 7394.9 1024.3 1044.0 1092.5 1110.1 1194.3 30088.5 30295.4 30503.1 30507.8 30627.8 1113.5 1145.7 1146.3 1183.8 1187.7 16010.6 16029.4 16343.5 16673.7 16770.5 480345.0 488933.0 489434.0 490653.0 493295.0 54371.7 55747.4 55842.2 55901.7 56129.4 1404.5 1414.6 1414.9 1418.8 1508.9 29440.0 30358.7 30434.8 30539.5 30793.2 47842.3 48577.8 48631.3 48710.8 48716.8 335683.0 340024.0 340748.0 428267.0 430369.0 26786.5 26871.7 26942.0 26981.7 27123.9 44093.8 44552.6 44664.1 45289.3 45638.3 35729.3 37273.3 38390.2 38454.0 38492.6 33893.3 34589.3 34752.8 34918.7 35033.1 34789.8 35219.8 36111.8 36210.6 36293.5 30901.5 31440.0 33475.7 33750.8 33857.5 26485.5 26715.5 26803.5 27046.9 27178.7 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | [#2] jquery.html Cycles:180 Average:27816.34 Median:14133.04 stddev:79371.54 (561.6%) stddev-sans-first:79567.44 22:19:06 INFO - PROCESS | 31848 | Values: 366.1 371.0 384.4 386.4 393.5 16725.8 17996.6 18163.6 18749.3 18809.7 10294.4 10528.5 10577.9 10596.4 10657.7 3789.6 4852.1 4887.0 5046.8 5060.1 5132.7 5367.9 5402.8 5418.8 5439.7 5372.9 5378.0 5389.4 5432.1 5780.9 6126.7 6195.1 6243.7 6251.6 6264.4 5280.6 5333.5 5442.7 5447.6 5657.8 12037.9 12328.2 12352.4 12394.1 12509.3 2159.5 2220.5 2274.4 2277.6 2437.1 9231.6 9424.5 9440.8 9716.3 9732.2 1824.7 1859.6 1865.3 1916.0 1980.4 80299.2 83922.0 84353.0 85069.0 85620.0 9491.8 9796.5 10710.4 10724.5 10764.9 14832.9 14840.3 14881.9 14913.3 14966.1 7903.7 7948.5 7975.2 8040.2 8062.8 7759.9 7849.7 7864.3 7927.6 7953.5 4257.5 4258.7 4472.6 4529.0 4538.3 1725.8 1796.0 1831.0 1888.6 1898.4 935.2 975.6 978.7 1020.5 1057.0 17592.5 17706.8 17710.8 17975.6 18553.6 997.5 1021.9 1025.4 1043.1 1071.7 9799.5 10052.1 10102.4 10115.2 10122.7 472037.0 478587.0 480211.0 480705.0 483321.0 93890.5 98278.0 101291.5 102197.0 103229.0 1011.6 1043.5 1050.6 1060.9 1071.2 16296.8 16328.5 16366.1 16556.8 16582.0 26608.3 27900.0 37487.3 37510.0 40505.8 53522.5 54449.5 54682.7 54818.7 55077.4 7916.5 7946.8 7997.4 8014.2 8044.4 11473.9 12298.9 12525.9 12753.6 12914.7 8441.6 10875.3 11285.9 11303.7 11603.2 11052.8 11107.5 11417.3 11471.9 11514.0 11364.2 11661.4 11671.4 11836.7 11850.8 7932.6 8076.4 8115.1 8142.3 8403.4 9547.5 11457.7 11490.1 11565.0 11686.6 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | [#3] mootools.html Cycles:180 Average:5278.45 Median:4875.96 stddev:2926.23 (60.0%) stddev-sans-first:2919.27 22:19:06 INFO - PROCESS | 31848 | Values: 1314.9 1325.6 1427.3 1721.5 1737.2 7122.8 7464.3 7763.3 7763.8 7774.5 7760.5 7768.2 7798.1 7826.3 7834.8 2179.0 2212.4 2213.8 2216.9 2218.4 2164.1 2175.0 2213.4 2216.2 2221.4 2202.8 2204.8 2221.8 2222.6 2256.2 2162.7 2164.4 2165.8 2166.4 2175.4 2143.8 2160.6 2165.5 2192.9 2200.9 8003.8 8042.6 8066.9 8067.2 8106.2 4632.9 4856.3 4869.5 4873.4 4882.7 2958.9 3092.3 3112.0 3121.8 3138.5 1013.1 1031.0 1040.0 1056.3 1057.1 10845.7 10913.4 10942.2 10962.5 10968.7 4151.4 4178.6 4221.9 4248.5 4264.8 9346.8 9357.5 9362.7 9371.5 9384.4 4799.0 4832.5 4858.3 4861.0 4878.6 3956.6 4354.8 4403.5 4470.0 4518.9 3504.6 3515.8 3579.1 3585.1 3633.1 1144.3 1145.4 1150.9 1155.4 1169.0 805.8 915.8 917.9 939.5 950.3 5445.8 5449.3 5482.9 5497.8 5514.1 987.3 996.9 1029.1 1033.1 1070.2 3742.7 3773.4 3780.7 3783.1 3784.9 9748.3 9857.3 9998.6 10003.4 10007.7 9832.3 9853.4 9863.8 10001.7 10002.7 7386.7 7504.4 7560.4 7639.0 7655.2 5539.7 5596.0 5617.8 5675.8 5749.3 9084.0 9165.2 9218.7 9230.5 9275.3 8595.0 8918.1 8967.1 8994.1 9046.1 6740.2 7152.9 7260.0 7379.4 7435.8 7463.0 7512.7 7544.8 7550.5 7555.5 6664.6 6703.7 6964.6 7062.6 7071.5 6526.0 6649.7 6655.9 6738.6 6828.4 6336.8 6393.1 6435.1 6497.1 6499.5 4780.1 4812.4 4851.3 4881.2 4955.1 4851.7 4866.8 4871.6 4898.4 4943.3 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | [#4] prototype.html Cycles:180 Average:4989.87 Median:5607.05 stddev:1562.12 (27.9%) stddev-sans-first:1526.42 22:19:06 INFO - PROCESS | 31848 | Values: 305.5 307.6 309.8 313.3 313.6 5513.2 5567.2 5579.3 5585.3 5622.7 5427.5 5470.0 5477.7 5482.8 5495.5 4003.9 4071.5 4128.6 4176.4 4225.4 4179.6 4201.0 4208.8 4220.5 4222.5 4140.0 4168.4 4187.7 4209.5 4224.6 4122.8 4172.2 4190.9 4198.6 4206.8 3674.0 3683.4 3688.0 3696.3 3697.8 5302.5 5303.1 5306.6 5318.3 5327.0 4664.7 4803.9 4809.4 4813.3 4828.3 5650.5 5653.9 5662.7 5710.0 5717.0 3990.5 4011.3 4038.1 4039.7 4071.9 5690.9 5815.7 5937.7 6057.4 6070.2 3989.2 4005.2 4021.7 4028.2 4029.1 4080.6 4080.7 4085.1 4089.6 4090.6 4617.6 4762.0 4766.3 4770.4 4822.5 5793.9 5799.0 5805.7 5824.2 5850.2 1528.7 1529.5 1532.9 1534.9 1539.2 956.2 989.7 999.5 1021.6 1045.6 5759.3 5764.4 5772.5 5787.5 5861.4 6254.7 6286.8 6314.6 6326.8 6337.7 5337.4 5591.4 5642.7 5684.1 5883.5 3440.9 3446.4 3468.6 3476.0 3477.8 6414.5 6692.0 6707.9 6712.4 6721.5 6583.9 6600.7 6628.4 6635.7 6646.9 6498.7 6660.0 6681.0 6687.6 6718.6 6374.4 6411.7 6432.4 6452.4 6487.2 6282.2 6353.9 6411.6 6413.2 6415.3 6509.8 6693.4 6710.9 6727.6 6749.6 4200.2 4250.9 4254.3 4280.5 4282.7 6326.0 6474.4 6480.1 6496.7 6497.3 6184.6 6201.9 6220.8 6282.4 6287.3 6028.8 6181.8 6214.6 6215.3 6237.2 5342.9 5581.2 5740.0 6053.4 6059.5 5835.6 5837.2 5848.5 5870.6 5872.2 5478.0 5682.4 5711.5 5733.9 5748.3 22:19:06 INFO - PROCESS | 31848 | 22:19:06 INFO - PROCESS | 31848 | [#5] yui.html Cycles:180 Average:14128.70 Median:24454.87 stddev:16220.43 (66.3%) stddev-sans-first:16234.65 22:19:06 INFO - PROCESS | 31848 | Values: 712.6 755.8 798.8 806.5 842.4 13108.9 13264.3 13540.5 13551.9 13553.3 12036.5 12100.6 12102.5 12110.3 12127.1 662.7 774.6 791.1 806.6 810.6 803.8 804.1 810.7 813.1 816.4 862.9 866.1 868.3 871.3 873.3 854.9 859.1 861.0 862.7 863.2 621.2 627.7 627.8 629.9 630.9 13029.3 13042.5 13051.3 13056.9 13063.9 12869.9 13032.9 13133.1 13281.1 13403.9 12094.0 12101.9 12136.2 12291.6 12456.8 4412.3 4437.4 4494.7 4495.1 4517.6 50874.2 51332.0 51352.5 51446.0 52104.7 9323.7 10303.5 10399.9 10492.8 10567.8 17606.6 17608.1 17623.1 17643.6 17681.0 7169.1 7465.3 7734.9 7766.3 7781.5 3849.9 4407.6 4471.3 4589.1 4593.2 2972.7 3057.3 3065.8 3067.7 3068.8 585.8 598.8 599.1 608.5 612.3 582.4 617.6 649.2 706.8 719.6 8205.2 8769.6 8919.1 8938.2 8941.0 605.7 610.6 619.2 662.7 671.0 4176.2 4234.7 4248.5 4276.4 4323.2 52379.5 54685.7 54922.7 55038.0 60006.0 53270.5 53566.7 53737.0 54678.5 55075.2 48876.3 49328.8 49422.0 50516.0 51505.7 8543.8 8579.7 8622.6 8706.3 8884.1 31694.0 31796.8 31883.7 32883.8 32918.0 42927.0 43892.8 44281.8 44472.3 45079.8 11323.0 11363.6 11653.0 11705.2 11754.2 12717.4 12867.7 13018.2 13056.5 13964.1 12602.4 12618.2 12672.4 13096.3 13322.0 11600.6 11811.6 11970.8 12019.7 12296.1 11029.1 11080.4 11107.2 11172.4 11197.7 10212.7 10733.8 10871.7 11007.1 11012.1 10225.6 10563.8 10647.9 10652.6 10653.0 22:19:06 INFO - PROCESS | 31848 | -------- Summary: end -------- 22:19:06 INFO - PROCESS | 31848 | 22:19:07 INFO - TEST-INFO | 31848: exit 0 22:19:07 INFO - TEST-OK | dromaeo_css | took 1109717ms 22:19:07 INFO - TEST-START | kraken 22:19:07 INFO - operating with platform_type : linux_ 22:19:07 INFO - Initialising browser for kraken test... 22:19:07 INFO - TEST-INFO | started process 32087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC5a3OT/profile http://localhost:53225/getInfo.html) 22:19:11 INFO - PROCESS | 32087 | 22:19:11 INFO - PROCESS | 32087 | (process:32156): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:12 INFO - PROCESS | 32087 | __metrics Screen width/height:1600/1200 22:19:12 INFO - PROCESS | 32087 | colorDepth:24 22:19:12 INFO - PROCESS | 32087 | Browser inner width/height: 1024/697 22:19:12 INFO - PROCESS | 32087 | __metrics 22:19:12 ERROR - PROCESS | 32087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:19:13 INFO - TEST-INFO | 32087: exit 0 22:19:13 INFO - Browser initialized. 22:19:13 INFO - Running cycle 1/1 for kraken test... 22:19:13 INFO - TEST-INFO | started process 32207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC5a3OT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:15 INFO - PROCESS | 32207 | 22:19:15 INFO - PROCESS | 32207 | (process:32271): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:25 INFO - PROCESS | 32207 | RSS: Main: 164925440 22:19:25 INFO - PROCESS | 32207 | 22:19:27 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53225/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:28 INFO - PROCESS | 32207 | RSS: Main: 169709568 22:19:28 INFO - PROCESS | 32207 | 22:19:31 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53225/tests/kraken/driver.html?testName=audio-dft) 22:19:32 INFO - PROCESS | 32207 | RSS: Main: 173047808 22:19:32 INFO - PROCESS | 32207 | 22:19:35 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53225/tests/kraken/driver.html?testName=audio-fft) 22:19:35 INFO - PROCESS | 32207 | RSS: Main: 164392960 22:19:35 INFO - PROCESS | 32207 | 22:19:38 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53225/tests/kraken/driver.html?testName=audio-oscillator) 22:19:38 INFO - PROCESS | 32207 | RSS: Main: 164315136 22:19:38 INFO - PROCESS | 32207 | 22:19:40 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:41 INFO - PROCESS | 32207 | RSS: Main: 164904960 22:19:41 INFO - PROCESS | 32207 | 22:19:44 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53225/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:45 INFO - PROCESS | 32207 | RSS: Main: 165027840 22:19:45 INFO - PROCESS | 32207 | 22:19:48 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53225/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:49 INFO - PROCESS | 32207 | RSS: Main: 167374848 22:19:49 INFO - PROCESS | 32207 | 22:19:52 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53225/tests/kraken/driver.html?testName=json-parse-financial) 22:19:52 INFO - PROCESS | 32207 | RSS: Main: 168112128 22:19:52 INFO - PROCESS | 32207 | 22:19:54 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:54 INFO - PROCESS | 32207 | RSS: Main: 167813120 22:19:54 INFO - PROCESS | 32207 | 22:19:56 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:57 INFO - PROCESS | 32207 | RSS: Main: 167632896 22:19:57 INFO - PROCESS | 32207 | 22:19:59 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:00 INFO - PROCESS | 32207 | RSS: Main: 168652800 22:20:00 INFO - PROCESS | 32207 | 22:20:02 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:03 INFO - PROCESS | 32207 | RSS: Main: 168448000 22:20:03 INFO - PROCESS | 32207 | 22:20:06 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:06 INFO - PROCESS | 32207 | RSS: Main: 168558592 22:20:06 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:53225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53225/tests/kraken/driver.html?testName=ai-astar) 22:20:08 INFO - PROCESS | 32207 | RSS: Main: 169771008 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | __start_tp_report 22:20:08 INFO - PROCESS | 32207 | _x_x_mozilla_page_load 22:20:08 INFO - PROCESS | 32207 | _x_x_mozilla_page_load_details 22:20:08 INFO - PROCESS | 32207 | |i|pagename|runs| 22:20:08 INFO - PROCESS | 32207 | |0;ai-astar;114;107;114;114;115;125;113;112;113;113 22:20:08 INFO - PROCESS | 32207 | |1;audio-beat-detection;160;130;154;184;133;160;156;131;181;131 22:20:08 INFO - PROCESS | 32207 | |2;audio-dft;163;164;163;161;162;166;168;162;165;164 22:20:08 INFO - PROCESS | 32207 | |3;audio-fft;78;81;79;152;77;79;76;78;176;76 22:20:08 INFO - PROCESS | 32207 | |4;audio-oscillator;93;94;148;93;93;95;150;94;94;147 22:20:08 INFO - PROCESS | 32207 | |5;imaging-gaussian-blur;118;117;117;118;118;116;117;118;118;118 22:20:08 INFO - PROCESS | 32207 | |6;imaging-darkroom;146;148;147;146;146;149;145;147;146;146 22:20:08 INFO - PROCESS | 32207 | |7;imaging-desaturate;95;96;97;95;96;95;95;95;96;95 22:20:08 INFO - PROCESS | 32207 | |8;json-parse-financial;61;59;58;57;57;60;63;79;55;58 22:20:08 INFO - PROCESS | 32207 | |9;json-stringify-tinderbox;63;64;63;62;63;63;63;64;64;65 22:20:08 INFO - PROCESS | 32207 | |10;stanford-crypto-aes;80;79;80;80;81;82;81;83;81;88 22:20:08 INFO - PROCESS | 32207 | |11;stanford-crypto-ccm;132;131;128;127;128;124;128;137;157;134 22:20:08 INFO - PROCESS | 32207 | |12;stanford-crypto-pbkdf2;171;180;172;175;171;170;171;173;172;176 22:20:08 INFO - PROCESS | 32207 | |13;stanford-crypto-sha256-iterative;72;73;71;72;70;69;70;71;69;71 22:20:08 INFO - PROCESS | 32207 | __end_tp_report 22:20:08 INFO - PROCESS | 32207 | __start_cc_report 22:20:08 INFO - PROCESS | 32207 | _x_x_mozilla_cycle_collect,825 22:20:08 INFO - PROCESS | 32207 | __end_cc_report 22:20:08 INFO - PROCESS | 32207 | __startTimestamp1461993608755__endTimestamp 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | ------- Summary: start ------- 22:20:08 INFO - PROCESS | 32207 | Number of tests: 14 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:4.45 (3.9%) stddev-sans-first:4.72 22:20:08 INFO - PROCESS | 32207 | Values: 114.0 107.0 114.0 114.0 115.0 125.0 113.0 112.0 113.0 113.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:158.00 stddev:20.39 (12.9%) stddev-sans-first:21.42 22:20:08 INFO - PROCESS | 32207 | Values: 160.0 130.0 154.0 184.0 133.0 160.0 156.0 131.0 181.0 131.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.10 (1.3%) stddev-sans-first:2.20 22:20:08 INFO - PROCESS | 32207 | Values: 163.0 164.0 163.0 161.0 162.0 166.0 168.0 162.0 165.0 164.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#3] audio-fft Cycles:10 Average:95.20 Median:78.00 stddev:36.73 (47.1%) stddev-sans-first:38.43 22:20:08 INFO - PROCESS | 32207 | Values: 78.0 81.0 79.0 152.0 77.0 79.0 76.0 78.0 176.0 76.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.50 stddev:26.40 (28.2%) stddev-sans-first:27.27 22:20:08 INFO - PROCESS | 32207 | Values: 93.0 94.0 148.0 93.0 93.0 95.0 150.0 94.0 94.0 147.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 22:20:08 INFO - PROCESS | 32207 | Values: 118.0 117.0 117.0 118.0 118.0 116.0 117.0 118.0 118.0 118.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:1.17 (0.8%) stddev-sans-first:1.22 22:20:08 INFO - PROCESS | 32207 | Values: 146.0 148.0 147.0 146.0 146.0 149.0 145.0 147.0 146.0 146.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 22:20:08 INFO - PROCESS | 32207 | Values: 95.0 96.0 97.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:59.50 stddev:6.82 (11.5%) stddev-sans-first:7.23 22:20:08 INFO - PROCESS | 32207 | Values: 61.0 59.0 58.0 57.0 57.0 60.0 63.0 79.0 55.0 58.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 22:20:08 INFO - PROCESS | 32207 | Values: 63.0 64.0 63.0 62.0 63.0 63.0 63.0 64.0 64.0 65.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.55 (3.1%) stddev-sans-first:2.65 22:20:08 INFO - PROCESS | 32207 | Values: 80.0 79.0 80.0 80.0 81.0 82.0 81.0 83.0 81.0 88.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:131.50 stddev:9.36 (7.1%) stddev-sans-first:9.92 22:20:08 INFO - PROCESS | 32207 | Values: 132.0 131.0 128.0 127.0 128.0 124.0 128.0 137.0 157.0 134.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:172.50 stddev:3.07 (1.8%) stddev-sans-first:3.16 22:20:08 INFO - PROCESS | 32207 | Values: 171.0 180.0 172.0 175.0 171.0 170.0 171.0 173.0 172.0 176.0 22:20:08 INFO - PROCESS | 32207 | 22:20:08 INFO - PROCESS | 32207 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.32 (1.9%) stddev-sans-first:1.32 22:20:08 INFO - PROCESS | 32207 | Values: 72.0 73.0 71.0 72.0 70.0 69.0 70.0 71.0 69.0 71.0 22:20:08 INFO - PROCESS | 32207 | -------- Summary: end -------- 22:20:08 INFO - PROCESS | 32207 | 22:20:09 INFO - TEST-INFO | 32207: exit 0 22:20:09 INFO - TEST-OK | kraken | took 62387ms 22:20:09 INFO - SUITE-END | took 1172s 22:20:09 INFO - Completed test suite (00:19:32) 22:20:09 INFO - javascript benchmark 22:20:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.519109538022, 3143.9371212575743, 3154.1168472827617, 3173.412918610056, 3181.6500184979664, 5285.0, 5304.708241046741, 5311.442298558653, 5312.548433383162, 5396.244525766396, 5261.0793111205485, 5303.681779093247, 5378.139497680372, 5378.784848606061, 5438.293021907157, 4822.3972003499475, 4844.563989240967, 4877.756112194394, 4883.536064073907, 4972.428170760372, 669.93049631218, 4852.514748525155, 4890.046440944017, 4901.852944411673, 4935.062338155739, 4900.926486102711, 4917.2869933859565, 4935.901281974358, 4951.826686066006, 4974.0797952378925, 4700.976495117503, 4847.297141914402, 4984.3021976923255, 5020.397552293748, 5061.44324124346, 4813.0, 4828.106800241966, 4829.541193586604, 4845.030993801219, 4898.142825005645, 5226.189940559219, 5271.604629652753, 5302.946970530284, 5323.467653234684, 5374.193870919355, 5615.298087739033, 5629.80295689653, 5739.368669446358, 5741.138829175616, 5745.683987380692, 5711.257536520267, 5726.427357264281, 5736.139579063132, 5736.483716465496, 5786.88426231473, 5298.496642818926, 5299.682019078868, 5323.866903327409, 5349.893002139936, 5350.224217488481, 5528.06022976095, 5644.0, 5699.839117444289, 5747.540196784247, 5780.566457515703, 5599.216109744639, 5601.8599535011135, 5619.0, 5634.126710359901, 5658.688772117573, 5686.090225563973, 5714.114312281603, 5736.311642602915, 5741.052726300197, 5752.9712351437975, 5475.397706252309, 5600.943990560042, 5653.575981801381, 5691.971540142273, 5701.0, 5499.312585926759, 5538.501534861882, 5556.555475561945, 5604.4395560444445, 5619.690916999604, 4210.0, 4226.1336426032585, 4252.978735106305, 4273.316269396882, 4297.634701050446, 3799.0692280390926, 3814.3515602347666, 3818.255440189192, 3876.9224615507533, 3880.359740642819, 5332.893342133136, 5334.333208348957, 5334.3865455473115, 5346.705931173745, 5383.5962302826665, 5597.076482380443, 5605.299337582802, 5618.4662457066515, 5626.521745651584, 5629.943700563023, 5287.365516138088, 5296.496832800878, 5323.893522129536, 5327.413984461706, 5338.813141540028, 4690.835820746258, 4765.142274390643, 4804.399450068741, 4806.2310030394965, 4845.442774080955, 5655.80204692842, 5702.857428564236, 5727.5131613812455, 5740.483356497935, 5751.1373294006235, 5731.77072917087, 5755.769769209185, 5786.710664466844, 5800.303963524404, 5833.6208146472045, 5856.150858125633, 5912.46787789101, 5932.6143800654545, 5938.287405511366, 5953.880922381441, 5412.621116521806, 5493.176023596492, 5579.107342825128, 5648.802291919763, 5664.433556644302, 5647.29408823897, 5661.037623603915, 5663.03728366187, 5688.687122208153, 5735.36910939788, 5525.640833345819, 5529.336479622471, 5530.585206109638, 5534.1145416733125, 5534.169874518693, 5404.378496472956, 5456.072467680425, 5474.042042642602, 5488.945110549003, 5548.667079975215, 5225.451327610698, 5344.518993290467, 5398.1902714593125, 5441.619086663895, 5452.645578037414, 5504.752286147213, 5534.308211473566, 5536.889262214652, 5537.0, 5591.748371323219, 5357.8392648220615, 5460.453954604666, 5463.07127788269, 5466.863328416822, 5468.562514998711], "value": 5196.599437093822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.1506261109224, 636.5035272487462, 642.8489305013322, 650.2976785072123, 655.3904868472318, 35905.281894362095, 36494.99999999996, 36560.0, 36688.81655591718, 36958.0, 39146.0, 39798.40302395466, 39878.601213987924, 39913.40129898054, 39994.0, 8380.91619083809, 8585.742427727178, 8587.355948303903, 8598.140185981414, 8614.353923455767, 8480.957595212016, 8483.44857584255, 8546.786330341729, 8547.230749232567, 8697.869531957025, 8719.782005449882, 8781.95609021954, 8805.163509466622, 8831.73504794854, 8831.95584022079, 8574.399792014561, 8697.782555436133, 8728.389012769108, 8759.299256059532, 8773.25427338677, 8322.791930201733, 8420.28427583656, 8443.197896199852, 8461.957690211571, 8463.534505602189, 39136.41295380572, 39420.21159576821, 39529.40705889414, 39558.20883582312, 39658.40512392316, 3327.5674162358982, 3336.966630333714, 3347.2134048498583, 3439.8624055038017, 3948.9210215795524, 27992.440151197065, 29056.564151537743, 29169.0, 29232.707672923425, 29356.853215733783, 4101.425800387948, 4104.56902025286, 4181.6236538711355, 4284.485861696617, 4347.087111706545, 302177.0, 302336.0, 303500.0, 304367.0, 304589.9999999978, 57052.0, 57509.0, 57796.71101644465, 57886.0, 58007.709961449924, 55396.446035539935, 56099.71950140223, 56316.718416408476, 56523.86952260932, 61817.38182618206, 15975.281112349972, 16339.428120015742, 16354.754678679828, 16357.345706171858, 16361.100139492442, 12300.138990270774, 12317.876821231852, 12327.260364378166, 12357.135000549875, 12419.565315213924, 18637.7204341935, 18662.53343666392, 18745.7188142178, 18879.244830206637, 19020.144093515824, 7143.678534465857, 7247.16657584374, 7354.595497247596, 7365.963170184222, 7394.852102958018, 1024.3393011507535, 1043.968680939573, 1092.5411327242577, 1110.134095405585, 1194.2953657342036, 30088.548671769942, 30295.394092118033, 30503.084907452812, 30507.847460762998, 30627.846860766, 1113.4822307626991, 1145.73075327298, 1146.2721172055806, 1183.810590305547, 1187.6912002879315, 16010.599735006484, 16029.358825647078, 16343.509694709177, 16673.6665266694, 16770.496885093467, 480345.0, 488933.0, 489434.0, 490653.0, 493295.0, 54371.72814135983, 55747.44252557504, 55842.16236756452, 55901.72049139728, 56129.43870561324, 1404.4663028049276, 1414.6039109049482, 1414.9080309779831, 1418.7729963205838, 1508.894377393594, 29440.0, 30358.69641303559, 30434.847825761615, 30539.54190687097, 30793.230169245948, 47842.282365763844, 48577.75711121422, 48631.27053094277, 48710.75644621754, 48716.75641621769, 335683.0, 340024.0, 340748.0, 428267.0, 430369.0, 26786.464270714867, 26871.731282686924, 26942.0, 26981.73018269792, 27123.86438067797, 44093.77953110214, 44552.554474456134, 44664.10671786481, 45289.32066018946, 45638.31542526798, 35729.28541429209, 37273.25453490969, 38390.23219535538, 38454.03864903288, 38492.6150738489, 33893.32213355768, 34589.30821383508, 34752.826235868655, 34918.65081349154, 35033.124171895906, 34789.82605086958, 35219.823900881354, 36111.819440902626, 36210.63789362178, 36293.45559816552, 30901.536476952413, 31440.0, 33475.665243347255, 33750.83124584361, 33857.49213761845, 26485.470290594465, 26715.465690686466, 26803.463930721668, 27046.864765676044, 27178.72821271762], "value": 19114.05096916696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.0811363477672, 370.9591944886064, 384.3657964358808, 386.3972203362753, 393.4668524149777, 16725.83274167258, 17996.640067198663, 18163.636727265446, 18749.34377296795, 18809.717854232196, 10294.382337059782, 10528.526216320264, 10577.947110264457, 10596.364218146897, 10657.680269591925, 3789.5642001169804, 4852.126617208901, 4886.9511304886855, 5046.772895219724, 5060.114479965991, 5132.666376685504, 5367.892642147155, 5402.810901618444, 5418.83743487696, 5439.700816455093, 5372.892542149155, 5378.0, 5389.407165211824, 5432.076546987002, 5780.855478613047, 6126.663033533154, 6195.132681424604, 6243.687815609202, 6251.562390632657, 6264.436200741932, 5280.603954703374, 5333.493318134771, 5442.727863606804, 5447.5641948644015, 5657.830265092012, 12037.939810300892, 12328.19866708661, 12352.38238088101, 12394.070444716592, 12509.311987840665, 2159.492519257973, 2220.5225876436643, 2274.442761523421, 2277.5900337939165, 2437.0971509221163, 9231.630734770668, 9424.481653509054, 9440.811183776355, 9716.31985760997, 9732.2214222862, 1824.7262910563388, 1859.6280743851285, 1865.291189348039, 1916.0132531746162, 1980.4355758608872, 80299.18204907724, 83922.0, 84353.0, 85069.0, 85620.0, 9491.76270593227, 9796.51017449139, 10710.410927398912, 10724.463776811284, 10764.946175269073, 14832.851671483362, 14840.257987100602, 14881.925590371979, 14913.254337283093, 14966.102033878002, 7903.68385264583, 7948.523088614702, 7975.1626079262005, 8040.15578364275, 8062.7581172564915, 7759.922400776033, 7849.686012559434, 7864.2922137007945, 7927.603619818986, 7953.483023603448, 4257.489101307801, 4258.701890867609, 4472.642188624902, 4529.0, 4538.29656403258, 1725.8274172582892, 1795.9910200448915, 1831.0478551153326, 1888.612834368951, 1898.411492437349, 935.209747763139, 975.6341371985505, 978.6525783346809, 1020.5458570935863, 1056.957721691139, 17592.472225833244, 17706.822931770774, 17710.822891770917, 17975.640487190183, 18553.628927421378, 997.4663554998041, 1021.9029192226726, 1025.3796453145887, 1043.0977204718015, 1071.694567048403, 9799.510024498746, 10052.145567626834, 10102.393856368495, 10115.190784737204, 10122.696319110439, 472037.0, 478587.0, 480211.0, 480705.0, 483321.0, 93890.53054734819, 98278.0, 101291.49354253181, 102197.0, 103229.0, 1011.585250047477, 1043.4574021508772, 1050.564015933379, 1060.867391576053, 1071.1912506057877, 16296.837031629531, 16328.510144695678, 16366.099864507567, 16556.83443165553, 16582.0, 26608.334791630365, 27900.0, 37487.25025499529, 37510.0, 40505.797471012454, 53522.450591700144, 54449.455505444435, 54682.726586366814, 54818.725906370215, 55077.44922550723, 7916.525008499509, 7946.841063178588, 7997.360211182975, 8014.238647328728, 8044.3564514839845, 11473.885261147281, 12298.877011229773, 12525.874741252472, 12753.553625623059, 12914.67713307175, 8441.56493396112, 10875.293105948089, 11285.943570282096, 11303.717407064889, 11603.187776855877, 11052.778944421227, 11107.500162492546, 11417.257878237888, 11471.885281147415, 11514.0, 11364.204505684524, 11661.358625275352, 11671.416429178338, 11836.70408239801, 11850.822237666269, 7932.6430310635005, 8076.394270429624, 8115.107338192676, 8142.267195952392, 8403.41176117666, 9547.474888881177, 11457.656270311903, 11490.08079353633, 11565.0, 11686.649400517997], "value": 8576.888479697356, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.8619394963528, 1325.5691900132458, 1427.3291552970106, 1721.4749501402068, 1737.209569645812, 7122.821929451767, 7464.328210461057, 7763.301302882739, 7763.844723105534, 7774.5335279883175, 7760.534367937914, 7768.223177682243, 7798.103218129917, 7826.256505631955, 7834.8041298967555, 2178.9564208715815, 2212.4247695599097, 2213.8339624528144, 2216.855904366219, 2218.4232099654128, 2164.1235299703644, 2175.0, 2213.424509627492, 2216.2243214874825, 2221.4335344487213, 2202.8347873909443, 2204.801567858892, 2221.7889300516426, 2222.555488902218, 2256.187772401934, 2162.686410470481, 2164.372332023703, 2165.7509386420606, 2166.4150679316494, 2175.3800166952424, 2143.7856214378594, 2160.621891169055, 2165.53441010182, 2192.8793916334594, 2200.922967696123, 8003.839923201562, 8042.557659328734, 8066.878996815052, 8067.233612806774, 8106.189381061847, 4632.907341853178, 4856.295837103636, 4869.488703686097, 4873.366462359871, 4882.6826256293225, 2958.881644734208, 3092.335147943203, 3111.984440077808, 3121.843907804601, 3138.544910987917, 1013.0780989299775, 1030.9845352319721, 1040.017183761346, 1056.3239526702916, 1057.0803401041067, 10845.674629761119, 10913.39976301303, 10942.23404361687, 10962.451877406178, 10968.725781855437, 4151.4395556600075, 4178.603032711888, 4221.936670949938, 4248.490181178278, 4264.808083636244, 9346.813063738688, 9357.532123393803, 9362.672306469241, 9371.531423428938, 9384.390014649027, 4798.976005120022, 4832.51674832521, 4858.295547145644, 4860.95139048605, 4878.56092951636, 3956.624120708528, 4354.804033818486, 4403.493598236179, 4469.955300447019, 4518.864434066983, 3504.6144924058335, 3515.7538972271695, 3579.1231148368815, 3585.1395665040204, 3633.1462106404974, 1144.2848219862585, 1145.4330106597122, 1150.8791576884307, 1155.4049664422828, 1168.9649310520697, 805.8428606421809, 915.839728047589, 917.9357444978921, 939.4691999020531, 950.2587981374539, 5445.83662490118, 5449.346078470529, 5482.890342193134, 5497.835064948058, 5514.09017512114, 987.2595553334999, 996.8903420623726, 1029.0943969306961, 1033.1012019543045, 1070.1545778834634, 3742.73800833939, 3773.3585290500682, 3780.7353485256317, 3783.0731470789833, 3784.905377365588, 9748.317617766688, 9857.260705446977, 9998.550065247082, 10003.399796012263, 10007.699769006942, 9832.262580306506, 9853.359531630564, 9863.80272394548, 10001.749956251006, 10002.699919002442, 7386.704531818667, 7504.362129218968, 7560.432967527458, 7638.961805190938, 7655.1962043985695, 5539.695316757617, 5595.972020139873, 5617.775288988395, 5675.801346952837, 5749.310082790092, 9084.046175151514, 9165.17513423795, 9218.723438296862, 9230.492322922304, 9275.30435217348, 8594.957025214833, 8918.10818918129, 8967.058458861726, 8994.055624159631, 9046.095390460901, 6740.157480314961, 7152.928470715435, 7260.0, 7379.446541509516, 7435.776926692208, 7462.96268518654, 7512.699492020258, 7544.773656790305, 7550.5469671819865, 7555.471117021756, 6664.633445160563, 6703.698333574904, 6964.582125072512, 7062.646867656699, 7071.46963977714, 6526.0, 6649.667516624246, 6655.933440665532, 6738.59568425896, 6828.419584335188, 6336.778212762531, 6393.073004414427, 6435.066915297162, 6497.057926600711, 6499.512536559682, 4780.11567859947, 4812.446568644651, 4851.345068415719, 4881.194602890483, 4955.108080545537, 4851.660383773243, 4866.829660961849, 4871.610271178368, 4898.363212782316, 4943.307936888767], "value": 4276.744052309012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.49898167006114, 307.5801530910307, 309.8326903472125, 313.2950860563733, 313.57667149348396, 5513.17302404639, 5567.220589117522, 5579.302587176603, 5585.2739143911285, 5622.690752008638, 5427.511523962852, 5470.030788915987, 5477.712737506683, 5482.780688772445, 5495.450454954503, 4003.899902502439, 4071.4503542021744, 4128.649064829493, 4176.352665336878, 4225.366195070733, 4179.582041795811, 4201.0, 4208.768517731523, 4220.53574106848, 4222.451081359419, 4139.9793001035105, 4168.374743788426, 4187.748735075906, 4209.452771139748, 4224.605880059588, 4122.773247471388, 4172.18642364739, 4190.895227619319, 4198.551499732587, 4206.810693518799, 3673.963260367389, 3683.355412802749, 3687.9631203688155, 3696.3346597612417, 3697.8335974881193, 5302.469753024705, 5303.124984377573, 5306.602004849652, 5318.282031925679, 5326.98787230425, 4664.696794708333, 4803.879903002418, 4809.446913604946, 4813.302071199691, 4828.251620998751, 5650.491455768959, 5653.8586535336535, 5662.716864156817, 5709.9714501427225, 5717.0, 3990.501187351581, 4011.2779699654343, 4038.1318016626274, 4039.6970227233073, 4071.857484988041, 5690.857728556778, 5815.651060936358, 5937.732802023919, 6057.363976782419, 6070.2108725865355, 3989.2221016901426, 4005.239004589177, 4021.738586991836, 4028.1943611277275, 4029.093453972833, 4080.6123418275215, 4080.6735461163034, 4085.101277718897, 4089.6319331259733, 4090.611391917763, 4617.584417402382, 4761.976190119027, 4766.308885211694, 4770.354227791407, 4822.517748225149, 5793.913091303634, 5798.971005144947, 5805.651660900359, 5824.242848429677, 5850.23946886902, 1528.7248295306952, 1529.4799768078906, 1532.8773698104126, 1534.8695360894226, 1539.2457695729013, 956.1920177450182, 989.6738370583453, 999.48526508848, 1021.6271061062658, 1045.5765415006933, 5759.280089988752, 5764.394738552392, 5772.538196944234, 5787.479126878601, 5861.3552509223955, 6254.74981000764, 6286.8428289292215, 6314.62112273265, 6326.778562750282, 6337.683115844189, 5337.359516858002, 5591.412901645269, 5642.7178641067785, 5684.147377893349, 5883.470487656132, 3440.9311813763584, 3446.379651662725, 3468.6357932417236, 3476.0, 3477.8087205203956, 6414.454771344394, 6692.0, 6707.899381509281, 6712.395884370332, 6721.462283017347, 6583.868322633521, 6600.669966501656, 6628.370304821035, 6635.701393437211, 6646.900296495556, 6498.675066246668, 6659.966700166468, 6681.0, 6687.6321802301345, 6718.596884186867, 6374.394432528902, 6411.71147298382, 6432.38892305249, 6452.419282264431, 6487.18910136233, 6282.2147231596055, 6353.856305864989, 6411.647359395278, 6413.198350206224, 6415.262244841903, 6509.804705858832, 6693.431058360094, 6710.865782684416, 6727.562708423937, 6749.595024298558, 4200.222958752641, 4250.893727656833, 4254.276772948544, 4280.464941882265, 4282.700210985326, 6325.9683701583035, 6474.352564743488, 6480.060391243338, 6496.74013039492, 6497.317781632861, 6184.5980011299125, 6201.937980620317, 6220.782272620437, 6282.403171698681, 6287.339829318039, 6028.819135425944, 6181.84545386369, 6214.5960512566535, 6215.285242197205, 6237.1891654084675, 5342.9198562022375, 5581.246531718166, 5740.0, 6053.364396738279, 6059.454649081604, 5835.56233282514, 5837.241158649518, 5848.473637372657, 5870.647761134345, 5872.236609240771, 5477.9602765456675, 5682.431756824284, 5711.485966263056, 5733.885322293448, 5748.338941021669], "value": 4485.573359722492, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.6294326949986, 755.8223817402912, 798.8482188384206, 806.4717609965475, 842.389267780859, 13108.934455327722, 13264.270465124415, 13540.526081587133, 13551.864481355184, 13553.254570998592, 12036.51853925844, 12100.636980890566, 12102.487189101363, 12110.27338359699, 12127.090468214876, 662.7150325360093, 774.5623722596742, 791.0823444804029, 806.6289506826837, 810.623060276971, 803.8271771569111, 804.1154729797234, 810.6878851642101, 813.0730966697969, 816.383630359081, 862.9093945135764, 866.0819531296814, 868.2576397180414, 871.2594294849359, 873.3231745397304, 854.8546747053016, 859.1194026123211, 860.9612567434449, 862.7498025572577, 863.1799790199336, 621.1614320667063, 627.7363507326888, 627.789690453694, 629.8614304852925, 630.8517498387876, 13029.34853257343, 13042.54351097707, 13051.282179480124, 13056.86943130566, 13063.86936130636, 12869.935650321688, 13032.86967130326, 13133.080684352099, 13281.136726112773, 13403.86596134036, 12094.0, 12101.93949030258, 12136.211146275553, 12291.56979505722, 12456.81314780279, 4412.338149277602, 4437.4009508716235, 4494.662900282459, 4495.078508905666, 4517.6160026397465, 50874.236886446735, 51332.0, 51352.48647513514, 51446.0, 52104.739476302755, 9323.673671421468, 10303.536340864679, 10399.948000260101, 10492.842607360895, 10567.841482377771, 17606.647867042586, 17608.119594020503, 17623.118844058, 17643.55891102733, 17681.0, 7169.068021157216, 7465.253474652492, 7734.883976740353, 7766.339861111755, 7781.45529812919, 3849.9037524062123, 4407.625351845065, 4471.329300604935, 4589.128065667513, 4593.19619066662, 2972.7324540791433, 3057.3121047764075, 3065.7700672449655, 3067.662557118715, 3068.7851850370707, 585.8125399872, 598.8233471126028, 599.1342510072902, 608.4979891589456, 612.3264409149899, 582.3535875178549, 617.6294223465974, 649.2209348781481, 706.8444942112727, 719.5754504842168, 8205.220504052106, 8769.561521923879, 8919.10808919103, 8938.1508756668, 8941.0, 605.678990135229, 610.5512448350458, 619.2259675405743, 662.7084083003463, 670.9597424154566, 4176.206520761046, 4234.703570750018, 4248.532661407243, 4276.358546218092, 4323.156984388014, 52379.47620523822, 54685.72657136689, 54922.72538637361, 55038.0, 60006.0, 53270.467295327326, 53566.7321663397, 53737.0, 54678.453215467336, 55075.17387239195, 48876.266855997186, 49328.753356233705, 49422.0, 50516.0, 51505.71235719062, 8543.829123417621, 8579.65681372763, 8622.568871556523, 8706.259967902799, 8884.112663384554, 31694.0, 31796.841015794773, 31883.68116318807, 32883.83558082194, 32918.0, 42927.0, 43892.78053609712, 44281.77859110813, 44472.33291500695, 45079.77460112678, 11323.0, 11363.602273920373, 11653.0, 11705.180637355303, 11754.23597466162, 12717.364131793189, 12867.678308042, 13018.218906865619, 13056.543020994219, 13964.092333998258, 12602.432890519765, 12618.242905425337, 12672.429740661877, 13096.279704616338, 13322.0, 11600.593979210687, 11811.645650630495, 11970.820437693268, 12019.699507512381, 12296.139270250997, 11029.117670586495, 11080.39057851826, 11107.166962477684, 11172.441377930909, 11197.730699040014, 10212.744681382728, 10733.785324293627, 10871.728206794893, 11007.119430445386, 11012.063974561932, 10225.590976360862, 10563.788724225626, 10647.89352106469, 10652.627158049741, 10653.0], "value": 6481.072548041204, "unit": "score"}], "name": "dromaeo_css", "value": 6878.660704259389, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 114.0, 114.0, 115.0, 125.0, 113.0, 112.0, 113.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 154.0, 184.0, 133.0, 160.0, 156.0, 131.0, 181.0, 131.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 161.0, 162.0, 166.0, 168.0, 162.0, 165.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 79.0, 152.0, 77.0, 79.0, 76.0, 78.0, 176.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 148.0, 93.0, 93.0, 95.0, 150.0, 94.0, 94.0, 147.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 116.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 149.0, 145.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 57.0, 57.0, 60.0, 63.0, 79.0, 55.0, 58.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 63.0, 63.0, 63.0, 64.0, 64.0, 65.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 80.0, 81.0, 82.0, 81.0, 83.0, 81.0, 88.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 128.0, 127.0, 128.0, 124.0, 128.0, 137.0, 157.0, 134.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 180.0, 172.0, 175.0, 171.0, 170.0, 171.0, 173.0, 172.0, 176.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 72.0, 70.0, 69.0, 70.0, 71.0, 69.0, 71.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1576.8, "alertThreshold": 2.0}]} 22:20:10 INFO - Return code: 0 22:20:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:20:10 ERROR - # TBPL SUCCESS # 22:20:10 INFO - Running post-action listener: _resource_record_post_action 22:20:10 INFO - Running post-run listener: _resource_record_post_run 22:20:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 535654400; Read time: 0; Write time: 516412 22:20:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245018624; Read time: 0; Write time: 264880 22:20:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 290635776; Read time: 0; Write time: 251532 22:20:11 INFO - Running post-run listener: _upload_blobber_files 22:20:11 INFO - Blob upload gear active. 22:20:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:20:11 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 22:20:11 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:20:11 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:20:11 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:12 INFO - (blobuploader) - INFO - Done attempting. 22:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:13 INFO - (blobuploader) - INFO - Done attempting. 22:20:13 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:13 INFO - Return code: 0 22:20:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:20:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20452390b4bbb4bc116b2ed004f969f90985cfa58eb5b344fed14a648b855824d372dbe3329aa04c689b2b16a5aee965cb0933225611d5d85440a6e40236b95e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c74f92785b79890f09efd5c200b3ce71aae0e268ad1afb2437fd16864356c54dfe0023c17fc36636dee0c6768b87c5b45ea6021d7d6e2510ecad4d2eca6f9dae"} 22:20:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:20:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:20:13 INFO - Contents: 22:20:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20452390b4bbb4bc116b2ed004f969f90985cfa58eb5b344fed14a648b855824d372dbe3329aa04c689b2b16a5aee965cb0933225611d5d85440a6e40236b95e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c74f92785b79890f09efd5c200b3ce71aae0e268ad1afb2437fd16864356c54dfe0023c17fc36636dee0c6768b87c5b45ea6021d7d6e2510ecad4d2eca6f9dae"} 22:20:13 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:13 INFO - Copying logs to upload dir... 22:20:13 INFO - mkdir: /builds/slave/test/build/upload/logs 22:20:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.032342 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-29 22:20:12.794536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 22:20:12.798393) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008 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-Inbound/sha512/20452390b4bbb4bc116b2ed004f969f90985cfa58eb5b344fed14a648b855824d372dbe3329aa04c689b2b16a5aee965cb0933225611d5d85440a6e40236b95e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c74f92785b79890f09efd5c200b3ce71aae0e268ad1afb2437fd16864356c54dfe0023c17fc36636dee0c6768b87c5b45ea6021d7d6e2510ecad4d2eca6f9dae"} build_url:https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/fFQSdN-wTXutsHTiWLIcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20452390b4bbb4bc116b2ed004f969f90985cfa58eb5b344fed14a648b855824d372dbe3329aa04c689b2b16a5aee965cb0933225611d5d85440a6e40236b95e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c74f92785b79890f09efd5c200b3ce71aae0e268ad1afb2437fd16864356c54dfe0023c17fc36636dee0c6768b87c5b45ea6021d7d6e2510ecad4d2eca6f9dae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 22:20:12.822582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 22:20:12.822921) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461991746.99588-1045967008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 22:20:12.907873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 22:20:12.908216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 22:20:12.908579) ========= ========= Total master_lag: 0.18 =========