builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1465219312.24 results: success (0) buildid: 20160602140837 builduid: 893fdbbbce3544769bc98c5128e2bb0b revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.241627) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.242036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.242299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.273484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.273753) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 06:21:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-06-06 06:21:52 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164681 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.463915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.464183) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018890 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.522885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:21:52.523182) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --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=74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 06:21:52,710 truncating revision to first 12 chars 2016-06-06 06:21:52,710 Setting DEBUG logging. 2016-06-06 06:21:52,710 attempt 1/10 2016-06-06 06:21:52,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e2399cf03e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:21:53,341 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.991160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:21:53.527475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:53.527874) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:53.528287) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:53.528542) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:53.539816) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-06 06:21:53.540188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:21:53 INFO - MultiFileLogger online at 20160606 06:21:53 in /builds/slave/test 06:21:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:21:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:53 INFO - {'append_to_log': False, 06:21:53 INFO - 'base_work_dir': '/builds/slave/test', 06:21:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:21:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:53 INFO - 'branch': 'Mozilla-Beta', 06:21:53 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:53 INFO - 'config_files': ('talos/linux_config.py',), 06:21:53 INFO - 'default_actions': ('clobber', 06:21:53 INFO - 'read-buildbot-config', 06:21:53 INFO - 'download-and-extract', 06:21:53 INFO - 'populate-webroot', 06:21:53 INFO - 'create-virtualenv', 06:21:53 INFO - 'install', 06:21:53 INFO - 'run-tests'), 06:21:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:53 INFO - 'download_minidump_stackwalk': True, 06:21:53 INFO - 'download_symbols': 'ondemand', 06:21:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:53 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:53 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:53 INFO - 'installer_path': 'installer.exe', 06:21:53 INFO - 'log_level': 'info', 06:21:53 INFO - 'log_name': 'talos', 06:21:53 INFO - 'log_to_console': True, 06:21:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:21:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:21:53 INFO - 'opt_config_files': (), 06:21:53 INFO - 'pip_index': False, 06:21:53 INFO - 'sps_profile': False, 06:21:53 INFO - 'sps_profile_interval': 0, 06:21:53 INFO - 'suite': 'dromaeojs-e10s', 06:21:53 INFO - 'system_bits': '32', 06:21:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:53 INFO - 'title': 'talos-linux64-ix-042', 06:21:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:53 INFO - 'use_talos_json': True, 06:21:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:53 INFO - 'work_dir': 'build'} 06:21:53 INFO - ##### 06:21:53 INFO - ##### Running clobber step. 06:21:53 INFO - ##### 06:21:53 INFO - Running pre-action listener: _resource_record_pre_action 06:21:53 INFO - Running main action method: clobber 06:21:53 INFO - rmtree: /builds/slave/test/build 06:21:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:54 INFO - Running post-action listener: _resource_record_post_action 06:21:54 INFO - ##### 06:21:54 INFO - ##### Running read-buildbot-config step. 06:21:54 INFO - ##### 06:21:54 INFO - Running pre-action listener: _resource_record_pre_action 06:21:54 INFO - Running main action method: read_buildbot_config 06:21:54 INFO - Using buildbot properties: 06:21:54 INFO - { 06:21:54 INFO - "project": "", 06:21:54 INFO - "product": "firefox", 06:21:54 INFO - "script_repo_revision": "production", 06:21:54 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:21:54 INFO - "repository": "", 06:21:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:21:54 INFO - "buildid": "20160602140837", 06:21:54 INFO - "pgo_build": "True", 06:21:54 INFO - "basedir": "/builds/slave/test", 06:21:54 INFO - "buildnumber": 126, 06:21:54 INFO - "slavename": "talos-linux64-ix-042", 06:21:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:21:54 INFO - "platform": "ubuntu64_hw", 06:21:54 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:21:54 INFO - "branch": "mozilla-beta", 06:21:54 INFO - "repo_path": "releases/mozilla-beta", 06:21:54 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 06:21:54 INFO - "stage_platform": "linux64-pgo", 06:21:54 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 06:21:54 INFO - "slavebuilddir": "test" 06:21:54 INFO - } 06:21:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 06:21:54 INFO - Running post-action listener: _resource_record_post_action 06:21:54 INFO - ##### 06:21:54 INFO - ##### Running download-and-extract step. 06:21:54 INFO - ##### 06:21:54 INFO - Running pre-action listener: _resource_record_pre_action 06:21:54 INFO - Running main action method: download_and_extract 06:21:54 INFO - mkdir: /builds/slave/test/build/tests 06:21:54 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')]} 06:21:54 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:21:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:21:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:21:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:22:06 INFO - Downloaded 1412 bytes. 06:22:06 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:22:06 INFO - Using the following test package requirements: 06:22:06 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:22:06 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:22:06 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 06:22:06 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'jsshell-linux-x86_64.zip'], 06:22:06 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:22:06 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:22:06 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 06:22:06 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 06:22:06 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:22:06 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:22:06 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:06 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:22:06 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:22: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')]} 06:22:06 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:22:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:10 INFO - Downloaded 23434647 bytes. 06:22:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:22:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:22:11 INFO - Return code: 0 06:22:11 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:22:11 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')]} 06:22:11 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:22:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:27 INFO - Downloaded 23434647 bytes. 06:22:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:22:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:22:29 INFO - Return code: 0 06:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:29 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:22:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:22:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:22:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:22:30 INFO - Downloaded 10845194 bytes. 06:22:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:22:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:22:30 INFO - Return code: 0 06:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:30 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:22:32 INFO - Downloaded 53855842 bytes. 06:22:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:32 INFO - mkdir: /builds/slave/test/properties 06:22:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:22:32 INFO - Writing to file /builds/slave/test/properties/build_url 06:22:32 INFO - Contents: 06:22:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:33 INFO - Running post-action listener: _resource_record_post_action 06:22:33 INFO - Running post-action listener: set_extra_try_arguments 06:22:33 INFO - ##### 06:22:33 INFO - ##### Running populate-webroot step. 06:22:33 INFO - ##### 06:22:33 INFO - Running pre-action listener: _resource_record_pre_action 06:22:33 INFO - Running main action method: populate_webroot 06:22:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:22:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:22:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:22:33 INFO - '--tppagecycles', 06:22:33 INFO - '7'], 06:22:33 INFO - 'tests': ['tsvgm']}}, 06:22:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:22:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:22:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:22:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:22:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'tests': ['damp', 'tps']}, 06:22:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['damp', 'tps']}, 06:22:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:22:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:22:33 INFO - 'other': {'tests': ['a11yr', 06:22:33 INFO - 'ts_paint', 06:22:33 INFO - 'tpaint', 06:22:33 INFO - 'sessionrestore', 06:22:33 INFO - 'sessionrestore_no_auto_restore', 06:22:33 INFO - 'tabpaint']}, 06:22:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['a11yr', 06:22:33 INFO - 'ts_paint', 06:22:33 INFO - 'tpaint', 06:22:33 INFO - 'sessionrestore', 06:22:33 INFO - 'sessionrestore_no_auto_restore', 06:22:33 INFO - 'tabpaint']}, 06:22:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['a11yr', 06:22:33 INFO - 'ts_paint', 06:22:33 INFO - 'tpaint', 06:22:33 INFO - 'sessionrestore', 06:22:33 INFO - 'sessionrestore_no_auto_restore', 06:22:33 INFO - 'tabpaint']}, 06:22:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['a11yr', 06:22:33 INFO - 'ts_paint', 06:22:33 INFO - 'tpaint', 06:22:33 INFO - 'sessionrestore', 06:22:33 INFO - 'sessionrestore_no_auto_restore', 06:22:33 INFO - 'tabpaint']}, 06:22:33 INFO - 'other_l64': {'tests': ['a11yr', 06:22:33 INFO - 'ts_paint', 06:22:33 INFO - 'tpaint', 06:22:33 INFO - 'sessionrestore', 06:22:33 INFO - 'sessionrestore_no_auto_restore', 06:22:33 INFO - 'tabpaint']}, 06:22:33 INFO - 'other_nol64': {'tests': ['a11yr', 06:22:33 INFO - 'ts_paint', 06:22:33 INFO - 'tpaint', 06:22:33 INFO - 'sessionrestore', 06:22:33 INFO - 'sessionrestore_no_auto_restore', 06:22:33 INFO - 'tabpaint']}, 06:22:33 INFO - 'svgr': {'tests': ['tsvgx', 06:22:33 INFO - 'tsvgr_opacity', 06:22:33 INFO - 'tart', 06:22:33 INFO - 'tscrollx', 06:22:33 INFO - 'cart']}, 06:22:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['tsvgx', 06:22:33 INFO - 'tsvgr_opacity', 06:22:33 INFO - 'tart', 06:22:33 INFO - 'tscrollx', 06:22:33 INFO - 'cart']}, 06:22:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'tests': ['tp5o']}, 06:22:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'talos_options': ['--e10s'], 06:22:33 INFO - 'tests': ['tp5o']}, 06:22:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'talos_options': ['--xperf_path', 06:22:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:33 INFO - 'tests': ['tp5n']}, 06:22:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:33 INFO - 'talos_options': ['--e10s', 06:22:33 INFO - '--xperf_path', 06:22:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:33 INFO - 'tests': ['tp5n']}}, 06:22:33 INFO - 'talos.zip': {'path': '', 06:22:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:22:33 INFO - Running post-action listener: _resource_record_post_action 06:22:33 INFO - ##### 06:22:33 INFO - ##### Running create-virtualenv step. 06:22:33 INFO - ##### 06:22:33 INFO - Running pre-action listener: _resource_record_pre_action 06:22:33 INFO - Running main action method: create_virtualenv 06:22:33 INFO - Creating virtualenv /builds/slave/test/build/venv 06:22:33 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 06:22:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:22:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:22:33 INFO - Using real prefix '/usr' 06:22:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:22:33 INFO - Installing distribute.............................................................................................................................................................................................done. 06:22:35 INFO - Installing pip.................done. 06:22:35 INFO - Return code: 0 06:22:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:35 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:35 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 06:22:35 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 06:22:35 INFO - Using env: {'DISPLAY': ':0', 06:22:35 INFO - 'HOME': '/home/cltbld', 06:22:35 INFO - 'LANG': 'en_US.UTF-8', 06:22:35 INFO - 'LANGUAGE': 'en_US:en', 06:22:35 INFO - 'LOGNAME': 'cltbld', 06:22:35 INFO - 'MAIL': '/var/mail/cltbld', 06:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:35 INFO - 'MOZ_NO_REMOTE': '1', 06:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:35 INFO - 'NO_EM_RESTART': '1', 06:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:35 INFO - 'PWD': '/builds/slave/test', 06:22:35 INFO - 'SHELL': '/bin/bash', 06:22:35 INFO - 'SHLVL': '1', 06:22:35 INFO - 'TERM': 'linux', 06:22:35 INFO - 'TMOUT': '86400', 06:22:35 INFO - 'USER': 'cltbld', 06:22:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:35 INFO - '_': '/tools/buildbot/bin/python'} 06:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:35 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 06:22:35 INFO - Cleaning up... 06:22:35 INFO - Return code: 0 06:22:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:35 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:35 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 06:22:35 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 06:22:35 INFO - Using env: {'DISPLAY': ':0', 06:22:35 INFO - 'HOME': '/home/cltbld', 06:22:35 INFO - 'LANG': 'en_US.UTF-8', 06:22:35 INFO - 'LANGUAGE': 'en_US:en', 06:22:35 INFO - 'LOGNAME': 'cltbld', 06:22:35 INFO - 'MAIL': '/var/mail/cltbld', 06:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:35 INFO - 'MOZ_NO_REMOTE': '1', 06:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:35 INFO - 'NO_EM_RESTART': '1', 06:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:35 INFO - 'PWD': '/builds/slave/test', 06:22:35 INFO - 'SHELL': '/bin/bash', 06:22:35 INFO - 'SHLVL': '1', 06:22:35 INFO - 'TERM': 'linux', 06:22:35 INFO - 'TMOUT': '86400', 06:22:35 INFO - 'USER': 'cltbld', 06:22:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:35 INFO - '_': '/tools/buildbot/bin/python'} 06:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:36 INFO - Downloading/unpacking psutil>=0.7.1 06:22:36 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 06:22:36 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 06:22:36 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 06:22:36 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 06:22:36 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 06:22:36 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 06:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:22:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:38 INFO - Installing collected packages: psutil 06:22:38 INFO - Running setup.py install for psutil 06:22:38 INFO - building 'psutil._psutil_linux' extension 06:22:38 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 06:22:38 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 06:22:38 INFO - building 'psutil._psutil_posix' extension 06:22:38 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 06:22:38 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 06:22:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:38 INFO - Successfully installed psutil 06:22:38 INFO - Cleaning up... 06:22:38 INFO - Return code: 0 06:22:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:22:38 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')]} 06:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:38 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')]} 06:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:38 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:38 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 06:22:38 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 06:22:38 INFO - Using env: {'DISPLAY': ':0', 06:22:38 INFO - 'HOME': '/home/cltbld', 06:22:38 INFO - 'LANG': 'en_US.UTF-8', 06:22:38 INFO - 'LANGUAGE': 'en_US:en', 06:22:38 INFO - 'LOGNAME': 'cltbld', 06:22:38 INFO - 'MAIL': '/var/mail/cltbld', 06:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:38 INFO - 'MOZ_NO_REMOTE': '1', 06:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:38 INFO - 'NO_EM_RESTART': '1', 06:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:38 INFO - 'PWD': '/builds/slave/test', 06:22:38 INFO - 'SHELL': '/bin/bash', 06:22:38 INFO - 'SHLVL': '1', 06:22:38 INFO - 'TERM': 'linux', 06:22:38 INFO - 'TMOUT': '86400', 06:22:38 INFO - 'USER': 'cltbld', 06:22:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:38 INFO - '_': '/tools/buildbot/bin/python'} 06:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:22:38 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 06:22:38 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 06:22:38 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 06:22:38 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 06:22:38 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 06:22:38 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 06:22:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:22:40 INFO - Installing collected packages: mozsystemmonitor 06:22:40 INFO - Running setup.py install for mozsystemmonitor 06:22:41 INFO - Successfully installed mozsystemmonitor 06:22:41 INFO - Cleaning up... 06:22:41 INFO - Return code: 0 06:22:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:22:41 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')]} 06:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:41 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')]} 06:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:41 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:41 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 06:22:41 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 06:22:41 INFO - Using env: {'DISPLAY': ':0', 06:22:41 INFO - 'HOME': '/home/cltbld', 06:22:41 INFO - 'LANG': 'en_US.UTF-8', 06:22:41 INFO - 'LANGUAGE': 'en_US:en', 06:22:41 INFO - 'LOGNAME': 'cltbld', 06:22:41 INFO - 'MAIL': '/var/mail/cltbld', 06:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:41 INFO - 'MOZ_NO_REMOTE': '1', 06:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:41 INFO - 'NO_EM_RESTART': '1', 06:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:41 INFO - 'PWD': '/builds/slave/test', 06:22:41 INFO - 'SHELL': '/bin/bash', 06:22:41 INFO - 'SHLVL': '1', 06:22:41 INFO - 'TERM': 'linux', 06:22:41 INFO - 'TMOUT': '86400', 06:22:41 INFO - 'USER': 'cltbld', 06:22:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:41 INFO - '_': '/tools/buildbot/bin/python'} 06:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:43 INFO - Downloading blobuploader-1.2.4.tar.gz 06:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:22:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:22:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:43 INFO - Downloading docopt-0.6.1.tar.gz 06:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:22:43 INFO - Installing collected packages: blobuploader, requests, docopt 06:22:43 INFO - Running setup.py install for blobuploader 06:22:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:22:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:22:44 INFO - Running setup.py install for requests 06:22:44 INFO - Running setup.py install for docopt 06:22:44 INFO - Successfully installed blobuploader requests docopt 06:22:44 INFO - Cleaning up... 06:22:44 INFO - Return code: 0 06:22:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:44 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:44 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 06:22:44 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 06:22:44 INFO - Using env: {'DISPLAY': ':0', 06:22:44 INFO - 'HOME': '/home/cltbld', 06:22:44 INFO - 'LANG': 'en_US.UTF-8', 06:22:44 INFO - 'LANGUAGE': 'en_US:en', 06:22:44 INFO - 'LOGNAME': 'cltbld', 06:22:44 INFO - 'MAIL': '/var/mail/cltbld', 06:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:44 INFO - 'MOZ_NO_REMOTE': '1', 06:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:44 INFO - 'NO_EM_RESTART': '1', 06:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:44 INFO - 'PWD': '/builds/slave/test', 06:22:44 INFO - 'SHELL': '/bin/bash', 06:22:44 INFO - 'SHLVL': '1', 06:22:44 INFO - 'TERM': 'linux', 06:22:44 INFO - 'TMOUT': '86400', 06:22:44 INFO - 'USER': 'cltbld', 06:22:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:44 INFO - '_': '/tools/buildbot/bin/python'} 06:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:44 INFO - Running setup.py (path:/tmp/pip-rTpgf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:44 INFO - Running setup.py (path:/tmp/pip-9CGpVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:44 INFO - Running setup.py (path:/tmp/pip-QAS89p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:44 INFO - Running setup.py (path:/tmp/pip-kDFPQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:45 INFO - Running setup.py (path:/tmp/pip-qVoDFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:45 INFO - Running setup.py (path:/tmp/pip-WDMj42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:45 INFO - Running setup.py (path:/tmp/pip-KQRTEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:45 INFO - Running setup.py (path:/tmp/pip-XxQ2GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:45 INFO - Running setup.py (path:/tmp/pip-MwGqum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:45 INFO - Running setup.py (path:/tmp/pip-M8Xite-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:45 INFO - Running setup.py (path:/tmp/pip-WCLILa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:45 INFO - Running setup.py (path:/tmp/pip-8XUzOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:45 INFO - Running setup.py (path:/tmp/pip-37XG4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:45 INFO - Running setup.py (path:/tmp/pip-pZf_xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:45 INFO - Running setup.py (path:/tmp/pip-ewbCQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:45 INFO - Running setup.py (path:/tmp/pip-vqSnt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:45 INFO - Running setup.py (path:/tmp/pip-QDtjJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:22:45 INFO - Running setup.py install for manifestparser 06:22:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Running setup.py install for mozcrash 06:22:46 INFO - Running setup.py install for mozdebug 06:22:46 INFO - Running setup.py install for mozdevice 06:22:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Running setup.py install for mozfile 06:22:46 INFO - Running setup.py install for mozhttpd 06:22:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Running setup.py install for mozinfo 06:22:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Running setup.py install for mozInstall 06:22:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:22:46 INFO - Running setup.py install for mozleak 06:22:46 INFO - Running setup.py install for mozlog 06:22:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Running setup.py install for moznetwork 06:22:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Running setup.py install for mozprocess 06:22:47 INFO - Running setup.py install for mozprofile 06:22:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Running setup.py install for mozrunner 06:22:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Running setup.py install for mozscreenshot 06:22:47 INFO - Running setup.py install for moztest 06:22:47 INFO - Running setup.py install for mozversion 06:22:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:22:47 INFO - Cleaning up... 06:22:47 INFO - Return code: 0 06:22:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:47 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:47 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 06:22:47 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 06:22:47 INFO - Using env: {'DISPLAY': ':0', 06:22:47 INFO - 'HOME': '/home/cltbld', 06:22:47 INFO - 'LANG': 'en_US.UTF-8', 06:22:47 INFO - 'LANGUAGE': 'en_US:en', 06:22:47 INFO - 'LOGNAME': 'cltbld', 06:22:47 INFO - 'MAIL': '/var/mail/cltbld', 06:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:47 INFO - 'MOZ_NO_REMOTE': '1', 06:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:47 INFO - 'NO_EM_RESTART': '1', 06:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:47 INFO - 'PWD': '/builds/slave/test', 06:22:47 INFO - 'SHELL': '/bin/bash', 06:22:47 INFO - 'SHLVL': '1', 06:22:47 INFO - 'TERM': 'linux', 06:22:47 INFO - 'TMOUT': '86400', 06:22:47 INFO - 'USER': 'cltbld', 06:22:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:47 INFO - '_': '/tools/buildbot/bin/python'} 06:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:47 INFO - Running setup.py (path:/tmp/pip-k9Mt2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:48 INFO - Running setup.py (path:/tmp/pip-PDmnaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:48 INFO - Running setup.py (path:/tmp/pip-4Hk7io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:48 INFO - Running setup.py (path:/tmp/pip-QvAQaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:48 INFO - Running setup.py (path:/tmp/pip-dokWCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:48 INFO - Running setup.py (path:/tmp/pip-IL4MZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:48 INFO - Running setup.py (path:/tmp/pip-t_vcpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:48 INFO - Running setup.py (path:/tmp/pip-Xx_2fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:48 INFO - Running setup.py (path:/tmp/pip-IfHTha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:48 INFO - Running setup.py (path:/tmp/pip-eD8BRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:48 INFO - Running setup.py (path:/tmp/pip-eK9kqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:48 INFO - Running setup.py (path:/tmp/pip-c_p3bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:48 INFO - Running setup.py (path:/tmp/pip-8zZVTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:48 INFO - Running setup.py (path:/tmp/pip-MrRTtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:48 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)) 06:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:48 INFO - Running setup.py (path:/tmp/pip-qtH1Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:49 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)) 06:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:49 INFO - Running setup.py (path:/tmp/pip-STeCqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:49 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)) 06:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:49 INFO - Running setup.py (path:/tmp/pip-maPDxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22:49 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)) 06:22:49 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)) 06:22:49 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)) 06:22:49 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)) 06:22:49 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)) 06:22:49 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)) 06:22:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:22:49 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 06:22:49 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 06:22:49 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 06:22:49 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 06:22:49 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 06:22:49 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 06:22:51 INFO - Downloading blessings-1.6.tar.gz 06:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:22:51 INFO - Installing collected packages: blessings 06:22:51 INFO - Running setup.py install for blessings 06:22:51 INFO - Successfully installed blessings 06:22:51 INFO - Cleaning up... 06:22:51 INFO - Return code: 0 06:22:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:51 INFO - Reading from file tmpfile_stdout 06:22:51 INFO - Current package versions: 06:22:51 INFO - argparse == 1.2.1 06:22:51 INFO - blessings == 1.6 06:22:51 INFO - blobuploader == 1.2.4 06:22:51 INFO - docopt == 0.6.1 06:22:51 INFO - manifestparser == 1.1 06:22:51 INFO - mozInstall == 1.12 06:22:51 INFO - mozcrash == 0.17 06:22:51 INFO - mozdebug == 0.1 06:22:51 INFO - mozdevice == 0.48 06:22:51 INFO - mozfile == 1.2 06:22:51 INFO - mozhttpd == 0.7 06:22:51 INFO - mozinfo == 0.9 06:22:51 INFO - mozleak == 0.1 06:22:51 INFO - mozlog == 3.1 06:22:51 INFO - moznetwork == 0.27 06:22:51 INFO - mozprocess == 0.22 06:22:51 INFO - mozprofile == 0.28 06:22:51 INFO - mozrunner == 6.11 06:22:51 INFO - mozscreenshot == 0.1 06:22:51 INFO - mozsystemmonitor == 0.0 06:22:51 INFO - moztest == 0.7 06:22:51 INFO - mozversion == 1.4 06:22:51 INFO - psutil == 3.1.1 06:22:51 INFO - requests == 1.2.3 06:22:51 INFO - wsgiref == 0.1.2 06:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:51 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:51 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 06:22:51 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 06:22:51 INFO - Using env: {'DISPLAY': ':0', 06:22:51 INFO - 'HOME': '/home/cltbld', 06:22:51 INFO - 'LANG': 'en_US.UTF-8', 06:22:51 INFO - 'LANGUAGE': 'en_US:en', 06:22:51 INFO - 'LOGNAME': 'cltbld', 06:22:51 INFO - 'MAIL': '/var/mail/cltbld', 06:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:51 INFO - 'MOZ_NO_REMOTE': '1', 06:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:51 INFO - 'NO_EM_RESTART': '1', 06:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:51 INFO - 'PWD': '/builds/slave/test', 06:22:51 INFO - 'SHELL': '/bin/bash', 06:22:51 INFO - 'SHLVL': '1', 06:22:51 INFO - 'TERM': 'linux', 06:22:51 INFO - 'TMOUT': '86400', 06:22:51 INFO - 'USER': 'cltbld', 06:22:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:51 INFO - '_': '/tools/buildbot/bin/python'} 06:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 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)) 06:22:51 INFO - Cleaning up... 06:22:51 INFO - Return code: 0 06:22:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:51 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:51 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 06:22:51 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 06:22:51 INFO - Using env: {'DISPLAY': ':0', 06:22:51 INFO - 'HOME': '/home/cltbld', 06:22:51 INFO - 'LANG': 'en_US.UTF-8', 06:22:51 INFO - 'LANGUAGE': 'en_US:en', 06:22:51 INFO - 'LOGNAME': 'cltbld', 06:22:51 INFO - 'MAIL': '/var/mail/cltbld', 06:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:51 INFO - 'MOZ_NO_REMOTE': '1', 06:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:51 INFO - 'NO_EM_RESTART': '1', 06:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:51 INFO - 'PWD': '/builds/slave/test', 06:22:51 INFO - 'SHELL': '/bin/bash', 06:22:51 INFO - 'SHLVL': '1', 06:22:51 INFO - 'TERM': 'linux', 06:22:51 INFO - 'TMOUT': '86400', 06:22:51 INFO - 'USER': 'cltbld', 06:22:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:51 INFO - '_': '/tools/buildbot/bin/python'} 06:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:51 INFO - Downloading/unpacking jsonschema 06:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:22:53 INFO - Downloading/unpacking functools32 (from jsonschema) 06:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:22:54 INFO - warning: no files found matching '*.txt' 06:22:54 INFO - no previously-included directories found matching 'build' 06:22:54 INFO - no previously-included directories found matching 'dist' 06:22:54 INFO - no previously-included directories found matching '.git*' 06:22:54 INFO - Installing collected packages: jsonschema, functools32 06:22:54 INFO - Running setup.py install for functools32 06:22:54 INFO - warning: no files found matching '*.txt' 06:22:54 INFO - no previously-included directories found matching 'build' 06:22:54 INFO - no previously-included directories found matching 'dist' 06:22:54 INFO - no previously-included directories found matching '.git*' 06:22:54 INFO - Successfully installed jsonschema functools32 06:22:54 INFO - Cleaning up... 06:22:54 INFO - Return code: 0 06:22:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:22:54 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')]} 06:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:54 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')]} 06:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:54 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 0x7f88f1ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', '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 06:22:54 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 06:22:54 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 06:22:54 INFO - Using env: {'DISPLAY': ':0', 06:22:54 INFO - 'HOME': '/home/cltbld', 06:22:54 INFO - 'LANG': 'en_US.UTF-8', 06:22:54 INFO - 'LANGUAGE': 'en_US:en', 06:22:54 INFO - 'LOGNAME': 'cltbld', 06:22:54 INFO - 'MAIL': '/var/mail/cltbld', 06:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:54 INFO - 'MOZ_NO_REMOTE': '1', 06:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:54 INFO - 'NO_EM_RESTART': '1', 06:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:54 INFO - 'PWD': '/builds/slave/test', 06:22:54 INFO - 'SHELL': '/bin/bash', 06:22:54 INFO - 'SHLVL': '1', 06:22:54 INFO - 'TERM': 'linux', 06:22:54 INFO - 'TMOUT': '86400', 06:22:54 INFO - 'USER': 'cltbld', 06:22:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:54 INFO - '_': '/tools/buildbot/bin/python'} 06:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:54 INFO - Downloading/unpacking flake8 06:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:22:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:22:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:22:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:57 INFO - no previously-included directories found matching 'docs/_build' 06:22:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:22:57 INFO - Running setup.py install for pep8 06:22:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:57 INFO - no previously-included directories found matching 'docs/_build' 06:22:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:22:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:22:57 INFO - Cleaning up... 06:22:57 INFO - Return code: 0 06:22:57 INFO - Running post-action listener: _resource_record_post_action 06:22:57 INFO - Running post-action listener: _start_resource_monitoring 06:22:57 INFO - Starting resource monitoring. 06:22:57 INFO - ##### 06:22:57 INFO - ##### Running install step. 06:22:57 INFO - ##### 06:22:57 INFO - Running pre-action listener: _resource_record_pre_action 06:22:57 INFO - Running main action method: install 06:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:57 INFO - Reading from file tmpfile_stdout 06:22:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:22:57 INFO - Reading from file tmpfile_stdout 06:22:57 INFO - Output received: 06:22:57 INFO - Usage: mozinstall [options] installer 06:22:57 INFO - Options: 06:22:57 INFO - -h, --help show this help message and exit 06:22:57 INFO - -d DEST, --destination=DEST 06:22:57 INFO - Directory to install application into. [default: 06:22:57 INFO - "/builds/slave/test"] 06:22:57 INFO - --app=APP Application being installed. [default: firefox] 06:22:57 INFO - mkdir: /builds/slave/test/build/application 06:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:23:10 INFO - Reading from file tmpfile_stdout 06:23:10 INFO - Output received: 06:23:10 INFO - /builds/slave/test/build/application/firefox/firefox 06:23:10 INFO - Running post-action listener: _resource_record_post_action 06:23:10 INFO - ##### 06:23:10 INFO - ##### Running run-tests step. 06:23:10 INFO - ##### 06:23:10 INFO - Running pre-action listener: _resource_record_pre_action 06:23:10 INFO - Running main action method: run_tests 06:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:23:10 INFO - Python 2.7.3 06:23:10 INFO - Return code: 0 06:23:10 INFO - grabbing minidump binary from tooltool 06:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:10 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 0x2049160>, '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 0x204a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:23:10 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 06:23:10 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 06:23:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:23:10 INFO - Return code: 0 06:23:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:23:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:23:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:23:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:23:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:23:11 INFO - Return code: 0 06:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 06:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 06:23:11 INFO - Using env: {'DISPLAY': ':0', 06:23:11 INFO - 'HOME': '/home/cltbld', 06:23:11 INFO - 'LANG': 'en_US.UTF-8', 06:23:11 INFO - 'LANGUAGE': 'en_US:en', 06:23:11 INFO - 'LOGNAME': 'cltbld', 06:23:11 INFO - 'MAIL': '/var/mail/cltbld', 06:23:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:23:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:11 INFO - 'MOZ_NO_REMOTE': '1', 06:23:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:11 INFO - 'NO_EM_RESTART': '1', 06:23:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:11 INFO - 'PWD': '/builds/slave/test', 06:23:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:23:11 INFO - 'SHELL': '/bin/bash', 06:23:11 INFO - 'SHLVL': '1', 06:23:11 INFO - 'TERM': 'linux', 06:23:11 INFO - 'TMOUT': '86400', 06:23:11 INFO - 'USER': 'cltbld', 06:23:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393', 06:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:11 INFO - '_': '/tools/buildbot/bin/python'} 06:23:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 06:23:11 INFO - mozversion application_buildid: 20160602140837 06:23:11 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:23:11 INFO - mozversion application_display_name: Firefox 06:23:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:23:11 INFO - mozversion application_name: Firefox 06:23:11 INFO - mozversion application_remotingname: firefox 06:23:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:23:11 INFO - mozversion application_vendor: Mozilla 06:23:11 INFO - mozversion application_version: 47.0 06:23:11 INFO - mozversion platform_buildid: 20160602140837 06:23:11 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:23:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:23:11 INFO - mozversion platform_version: 47.0 06:23:11 INFO - using testdate: 1465219391 06:23:11 INFO - actual date: 1465219391 06:23:11 INFO - starting webserver on 'localhost:34632' 06:23:11 INFO - SUITE-START | Running 2 tests 06:23:11 INFO - TEST-START | dromaeo_css 06:23:11 INFO - operating with platform_type : linux_ 06:23:11 INFO - Initialising browser for dromaeo_css test... 06:23:11 INFO - TEST-INFO | started process 9579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGkeXlp/profile http://localhost:34632/getInfo.html) 06:23:15 INFO - PROCESS | 9579 | 06:23:15 INFO - PROCESS | 9579 | (process:9655): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:23:16 INFO - PROCESS | 9579 | __metrics Screen width/height:1600/1200 06:23:16 INFO - PROCESS | 9579 | colorDepth:24 06:23:16 INFO - PROCESS | 9579 | Browser inner width/height: 1024/697 06:23:16 INFO - PROCESS | 9579 | __metrics 06:23:17 ERROR - PROCESS | 9579 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:23:18 INFO - TEST-INFO | 9579: exit 0 06:23:18 INFO - Browser initialized. 06:23:18 INFO - Running cycle 1/1 for dromaeo_css test... 06:23:18 INFO - TEST-INFO | started process 9705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGkeXlp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:23:20 INFO - PROCESS | 9705 | 06:23:20 INFO - PROCESS | 9705 | (process:9775): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:23:30 INFO - PROCESS | 9705 | RSS: Main: 149868544 06:23:30 INFO - PROCESS | 9705 | 06:24:19 INFO - PROCESS | 9705 | 1465219459702 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] 06:26:27 INFO - PROCESS | 9705 | Cycle 1(1): loaded http://localhost:34632/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34632/tests/dromaeo/cssquery-ext.html) 06:26:28 INFO - PROCESS | 9705 | RSS: Main: 154120192 06:26:28 INFO - PROCESS | 9705 | 06:29:30 INFO - PROCESS | 9705 | Cycle 1(1): loaded http://localhost:34632/tests/dromaeo/cssquery-ext.html (next: http://localhost:34632/tests/dromaeo/cssquery-jquery.html) 06:29:30 INFO - PROCESS | 9705 | RSS: Main: 152154112 06:29:30 INFO - PROCESS | 9705 | 06:32:32 INFO - PROCESS | 9705 | Cycle 1(1): loaded http://localhost:34632/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34632/tests/dromaeo/cssquery-mootools.html) 06:32:33 INFO - PROCESS | 9705 | RSS: Main: 151838720 06:32:33 INFO - PROCESS | 9705 | 06:35:34 INFO - PROCESS | 9705 | Cycle 1(1): loaded http://localhost:34632/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34632/tests/dromaeo/cssquery-prototype.html) 06:35:35 INFO - PROCESS | 9705 | RSS: Main: 152223744 06:35:35 INFO - PROCESS | 9705 | 06:38:37 INFO - PROCESS | 9705 | Cycle 1(1): loaded http://localhost:34632/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34632/tests/dromaeo/cssquery-yui.html) 06:38:38 INFO - PROCESS | 9705 | RSS: Main: 151552000 06:38:38 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | Cycle 1(1): loaded http://localhost:34632/tests/dromaeo/cssquery-yui.html (next: http://localhost:34632/tests/dromaeo/cssquery-dojo.html) 06:41:40 INFO - PROCESS | 9705 | RSS: Main: 155566080 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | __start_tp_report 06:41:40 INFO - PROCESS | 9705 | _x_x_mozilla_page_load 06:41:40 INFO - PROCESS | 9705 | _x_x_mozilla_page_load_details 06:41:40 INFO - PROCESS | 9705 | |i|pagename|runs| 06:41:40 INFO - PROCESS | 9705 | |0;dojo.html;3361.2941282330708;3412.556367672202;3421.948670769938;3468.445048792192;3475.200703838117;5452.400235974044;5462.481064298895;5493.862653433666;5510.366307874596;5515.117581187011;5493;5519.558435325174;5532.197831314457;5536.031194540959;5540.889182216363;5035.068512325213;5043.31915191449;5095.898082038357;5121.513456221653;5130.769115389798;5025.924611130836;5083.517065878736;5126.666766660155;5135.743212839362;5145.81989630363;5060.190369540875;5082.983403319351;5094.694318340893;5177.663451875616;5185.325907632003;5097.184450487923;5159.896802063975;5188.7146206958605;5189.896202075975;5203.323567936163;4912.975435122801;4982.5017498250245;5165.1219292720325;5187.19598462239;5188.662736922126;5324.7071411072375;5349.117395629716;5359.785608575652;5387.838364849061;5394.973025134888;5917.674527900964;5939.465448109648;5950.523958083343;5953.940460595425;5984.910226346608;5971.940280597225;6010.819675409701;6020.096985452174;6033.758649654009;6052.606580572293;5599.300087489064;5649.745761440745;5665.065264231397;5671.914921276184;5672.5178359839465;5917.52659787216;6118.296395914438;6147;6147.508199344042;6148.477379422709;5823.330317013513;5881.235439392852;5882.44116808911;5894.469497745224;5895.027320492157;5930.2883653960935;5932.40675932412;5933.881322373529;5943.64338139713;5965.79119730816;5789.53683705311;5878.823635290948;5883.499902508249;5907.468327850428;5955.13650520672;5901.468867801833;5903.58674892762;5915.349311575723;5920.052791553331;5946.018906880403;4479.148961697267;4487.237169681097;4490.034642551867;4491.865244042684;4517.706349087299;4024.959750402517;4045.4134150548007;4053.9594604054173;4070.8575199867864;4083.7958102094776;5580;5636.661800291914;5692.459216374438;5693.089105743061;5700.743466544015;6129.264488261348;6130.7183035492235;6147.754089836446;6153.2616086069065;6155.630662160284;5545;5628.634138780966;5756.7121643917635;5758.798442054508;5782.132680098019;5115.923261151086;5120.667156634807;5135.666181698178;5165.845024649267;5180.507851754077;6205.348438413902;6212.285587157445;6217.098520714471;6224.439800417894;6260.561760676709;5908.379620139824;6008.098785182083;6052.757889684363;6060.484858786876;6069.51443884497;6152.16945712341;6167.5682702210415;6267.749290028531;6268.561200715906;6273.341299163522;5915.378885217162;5942.2869255687865;5958.612690175125;5971.880562388815;5997.460228579449;5871.530277577869;6061.848453788691;6065.939340606537;6068.969655151696;6090.878182436238;5878.794242201502;5903.675297858659;5924.555658325729;5943.465088142088;5987.34139244674;5892.440218179266;5932.466078052823;5951.880962380642;5952.74992251632;5988.101784732325;5435.972820135874;5708.058170401837;5760.423957604206;5827.59206855516;5841.269841269841;5895.174675545512;5920;5922.851928701817;5930.851728706644;5958.076498142795;5800.361960184292;5851.180834683063;5858;5858.209141765807;5866.706664666664 06:41:40 INFO - PROCESS | 9705 | |1;ext.html;538.8572028412469;546.5381752419206;561.7051048199695;573.2433188191587;588.2529187931327;39402.802985985065;40313.395299070464;40328.79835600825;40342.59657403425;40389.3941590876;44701.32948005782;44726.77636611812;45142.77428612852;45270.32094518585;45358.54641453584;8826.91173088269;9007.459552426842;9066.229370503515;9090.954545227298;9091.18179363857;9097.181253687168;9271.675491357804;9277.257819374434;9290;9303.581338839735;9100.772480688003;9186.770330741752;9197.448153110834;9212.677556285531;9214.032526584713;9248.768780780467;9325.347225694204;9336.253099752004;9347.158755712018;9352.67265645699;9120.361574689774;9321.207697345733;9332.300077494216;9346.579403926771;9352.20506256969;44960.3255951161;45375;45547.31679024817;45570.31644525302;45570.31644525302;3451.913702157441;3461.7922924624604;3478.7912725236315;3773.2264885698364;4151.335786274181;32446.351072978643;32476.188095297806;33017.6698233017;33098.338033239444;33348.66651333504;3646.58064322601;3736;3756.1736417988;3777.508923839883;3816.103215744298;290921;291213;291237;291447;292515;46449.30326045112;46991.29513057307;63688.363116368244;64750.38124046842;64869;45357;45407;45490.090198196514;45502.08995820065;45527.77236113865;17223.052732099604;17525.123743812757;17562.209700563504;17572;17595;14013.859861401459;14104.85895141056;14126;14194.787078193835;14218.573442796733;15436.536903892902;15604.063756174666;15634.06195628266;15747.212639367986;15767.763483547757;5830.53355731549;5881.882362352729;5999.850003749942;6022.2171117754415;6051.394860513913;1036.5387402605768;1050.8056009638242;1054.0092313225543;1085.1969542538623;1151.9171978340332;29658.703412965595;29907.551386729217;30020.249493762392;30487.847560762053;30801.2299692505;1079.1205167788228;1118.5637601335486;1130.5929865248504;1136.3863513702672;1227.1164761371797;15478.458253961056;15484.845151548341;15732.68534629301;15848.92075539615;15959.920200398923;333109;493050;497430;500296;622298;57602.42397576055;58304;58822.70588647029;59151;59155;1448.6233579269256;1477.2023107521818;1481.222358261921;1507.4422463688506;1547.4970634543818;29122.854385727936;30752.077437676904;31785.682143178274;31819.20451988719;32931.50602741009;51169.744151279;51248.718782030744;51477.22784158315;51989;52086.47913520816;301308;303149;303222;304180;304942;34770;35609;35713.821430892676;35949;36011.0997225061;46516.7674161627;47146;47646.28530571975;48422.75788621034;58835.411645882996;39906.401403979544;41468.85311468829;42975;43187.784061079496;43709.12581748283;41508.792456037525;41587.168256635305;42504.362434562885;43126.78436607797;44565.331520027874;42892.78553607212;43472.34791478194;43930;44214;44297.11405771931;38934.6106538931;39205.80397097996;39441.40837887376;39648.40527392149;39904.800475997436;29435.705642944155;30023.399532009673;30058;30309.545356820105;30641.846790765903 06:41:40 INFO - PROCESS | 9705 | |2;jquery.html;362.95825980012296;367.5883011027649;371.35013725979536;378.81816727970573;386.21405439929714;17493;18617.53456163595;20055;20056.197752089898;20100.296489622866;18249.635007299847;18690.065496725176;18808.15363308651;18879.056047197653;18883.52791180221;5548.112302031675;5754;5788.218590490293;5801.680907550083;5823.06830907055;5269.6311258211945;5497.065498865182;5532.446755324476;5533.335999680044;5674.602777805555;5321.148616221405;5441.319835020622;5462.562994960394;5503.834884953458;5804.59367844251;5796.420357964191;5814.5057670097885;5829.8251052468495;5849.1226316052935;5872.354041055481;5598.916016259759;5614.550835933115;5628.296462942132;5632.239647647556;5669.461401166883;13585.184888906697;13647.658808529766;13909.443622255098;14039.298035098307;14042.508512202126;2210.16013914713;2284.3603790938564;2389;2876.525373313401;2919.313961219133;10258.640947566873;10300.536475858604;10344.741381465448;10547.472626368652;10654.414007229676;1861.6183682345086;1945.5330720626948;1995.2218634732467;2012.7383440152832;2022.7774944756065;64047;64658.676706616636;65456.3454365455;65548;69106.30893690999;9923.60305587783;10374.118199953089;10388.896111038945;10515.789684206273;10579.312344697724;15108.244587770787;15202.011869228465;15209.467668631545;15358.846411535966;15407.15260660652;8312.293455056268;8528.573571321409;8543.145685431407;8558.700445484377;8601.827963440695;8361.456505327134;8376.874346884802;8386.87419688705;8463.957680211683;8484;4573.336866154389;4787.688800227974;4803.78382972767;4885.706857588556;4889.657723959289;1948.4933917181352;1956.949115331279;1979.9307024254083;2010.8290795282273;2017.737694099787;942.641796117471;952.0431965874391;980.5097451274363;1002.4085789384299;1010.3887148275335;17618.559536011446;17626.294948202183;17699.292028318723;17960.371387001655;18201.99889006091;940.9764755881158;971.8785151856018;1005.9698209053594;1015.7968406318765;1027.4965267019106;8142.307903828122;10221.540030698636;10414.114800241912;10435.269531132899;10532.842007369896;320161;321002;321704;325747;451872;51357.743211283705;57094.42905570974;70226.29773702197;81805.59097204475;84393.15606843853;1055.8205105132147;1065.6909496246158;1089.3137323486153;1103.2718405851938;1104.7293413113678;15522.84477155214;15684.137372444626;15780.368785248462;15841.207939602744;15942.68114637724;24232.36680445654;31139.53290700596;32219.355612887142;33550;33766.66233337635;51871.74064129655;51949.22076168785;52431;52848.47151528436;52867.47132528779;8657.437266577652;8687.913120868963;8727.607257673548;8864.73405797827;8913.019567847661;10070.093691567794;11966.042716582479;12715;12896.226226426445;13235.40440680191;11041.171912106463;11295.887041129812;11482.540698372306;11654.883451165719;11729.824052639387;11078.944605276922;11142.27575207609;11194;11424;11464.197506174822;10837.133029357476;10880.238383313092;10940.288881222696;11219.60731374398;11356.659300221007;8038.63826127814;8099.230573095547;8124.268815806606;8199.79500512468;8281.130481299377;8550.82898342042;10238.539265733209;10908.290961087503;11026.062784663394;11127.22109452363 06:41:40 INFO - PROCESS | 9705 | |3;mootools.html;1582.564794681463;1612.838716128387;1719.957001074973;1758.1033672826863;1866.9813301866977;7240.131184257883;8060.717874874381;8205.958970205149;8366.037905640853;8435.915640843597;8144.633491492882;8186;8213.137620549845;8216.465929714564;8228.958855205716;2396.2332053742766;2414.7705967933107;2422.7213870404953;2426.1872272788637;2430.4166999920067;2239.85440946338;2242.215224671368;2267.093162734911;2274.1585613323095;2281.9657705134437;2408.0728919366084;2418.661387405765;2423.9151629692965;2426.46617744096;2437.0617312334703;2355.1874603262017;2355.305184970438;2366.183666635017;2366.337425520857;2392.9162479313313;2351.1183306260154;2357.5284943011466;2370.1230544698574;2380.6310021946624;2382.8808559572126;8381.58092095399;8390.706325278587;8391.370647201424;8402.495850249004;8412.747617571482;5106.259592359124;5217.713025783581;5218.295530103425;5228.843134705965;5260.552853007461;3220.6135263768265;3236.1747754322732;3281.5405843181975;3322.634510203876;3360.5463262459743;1081.864766904137;1088.4122573810132;1101.1631160318136;1101.564881871656;1109.4397329348628;11747.353895535742;11802.822957655642;11839.94080029603;11865.762684746256;11899.286042837371;4564.6348292136545;4569.634429245652;4606.078784243165;4614.7461889595725;4659.184642687516;10041.447720375303;10048.045435683598;10061.295709300279;10061.993800620026;10108.848367274497;5284.497972692588;5295.602829787781;5316.255724198615;5323.893522129613;5330.92003619946;4097.528784189856;4644.512326205768;4711.52884711533;4721.834735784231;4770.356001939694;3774.3960966245268;3845.8269377878064;3856.614338566177;3890.9416358754643;3953.426753120839;1196.318098683742;1201.9579314723942;1205.5659962413524;1227.8281040654315;1266;1435.964100897465;1442.0914823661026;1466.1789397937189;1482.0959214878915;1485.2202593638426;7863.646135923897;7900.802479938047;7932.206779322137;7939;7941.444098913021;526.076735329502;531.1315998342737;533.9839804805862;539.2962184349461;545.0271265790545;5961.552883533665;5962.25471816023;6008.459238668541;6033.3664965178905;6049.0926361046195;9931.155851752537;10228.693139205836;10335.793284134275;10355;10370.688879333633;9852.50737463124;10000.599976001024;10107.444090574942;10184.694459166238;10200;7897.60511974399;7976.0827504836525;7990.84018319642;7997.8400431992195;8027.15714849944;7306.817329566803;7383.187849336676;7424.406047516294;7443.441741869273;7492.587907665131;8828.117188281121;8991.190792828676;9020;9188.40275382098;9205.30960177976;8862.468251904906;8895.866562001445;9172.036936121878;9325;9361.344705870524;7089.751858685127;7208.927910720826;7280.672369743268;7285.453590980592;7336.156342020736;7949.165337639464;7969.641366138421;7978.601069946596;8011.519308841255;8024.719134830253;7150.213476517475;7255.165655949422;7313.085864266966;7361.4110871129105;7448.925510744823;7059.647017649199;7100.538464999759;7109.431245500451;7111.040009598638;7127.287271272831;7449.5902725350625;7525.3227209551405;7531.811704707207;7566.31903128721;7566.35685966699;6938.410235130071;6969.686364113526;7002.159740830929;7002.159740831133;7005.369516743517;6873.278305778022;6915.239323674492;6932.514723969273;6958.826029349307;6979.406750426067 06:41:40 INFO - PROCESS | 9705 | |4;prototype.html;346.55121617505336;347.3452541958408;350.6300852600505;351.2921463251549;351.52719592148566;6392.328805475422;6419.64691941943;6454.451371633411;6472.967635161829;6500.154979852618;6327.209098862642;6367.108604795332;6369.554131210817;6371.681415929208;6378.776742814002;4694.342792009122;4822.7829747661435;4828.951710482903;4839.782209800567;4843.927341089895;4837.7822997965;4846.3457433246585;4863.489333619972;4864.805407783684;4888.462269150391;4826.806927722887;4834.709917404949;4841.443234028079;4843.491433399495;4855.393075865517;4834.685745426554;4843.733594652275;4865.148598995197;4871.658983871131;4875.195592727196;4251.426057482262;4257.97871010646;4259.893502662428;4262.403263543076;4262.552431994658;5984.072468767348;6106.816795496142;6116.26604807426;6119.959606866843;6136.325004249529;5640.351359593658;5640.943590564083;5650.604457687963;5664.915026274609;5666.291713535808;6735.090762747064;6737.93262067378;6747.257801641816;6756.391924726749;6771.559848609824;4619.9076018479445;4668.976655116737;4671.48613652498;4674.065186962587;4683.250679891201;6918.861622767567;7046.4010559102535;7058.329458701415;7065.328793764585;7068.929310706879;4704.670673052853;4783.95216047842;4811.591014763784;4813.374261346003;4818.855434336975;4827.879303017382;4852.830150944771;4860.3195552622665;4866.124097662384;4876.390451193601;5614.9719251403485;5618.016847051749;5619.438056194348;5621.662700237999;5622.465865742748;6812.114425124702;6816.318368163144;6832.6925288362145;6845.281245469254;6855.520113592101;1685.1995302231587;1699.2013753535819;1700.2348942975711;1703.3016463250256;1703.7188863837575;1073.3238060022136;1106.3073497548764;1113.1762495753085;1129.5090480565739;1131.7849608574345;6494.675266236669;6499.545031847725;6523.151990241238;6529.053287273318;6532.869342613216;7067.752628657972;7069.116360454943;7076.32774886385;7082;7095.82260443493;6422.614643121335;6538.248101468297;6589.53873228879;6612.966935165389;6638.4689224861895;3848.807559622008;3880.4955355803563;3889.474920885644;3891.4746509220895;3891.922161556753;7405.481616286916;7409.147947985943;7411.5553066816165;7425.071866016748;7428.33145016951;7297;7305.744298949511;7310.342069213796;7331.670074846538;7334.633268336562;7295.306945840137;7347.228541003225;7411.4811963162065;7414.295641914117;7421;7084.787456376317;7091.716331346688;7133.429325653831;7140.6786694599905;7142.142942846892;6947.7220911162985;6989.161300643956;6991.196012458632;6994.440444764508;6996.895046574407;7333.816654583678;7334.669939852826;7365.926340736738;7369.963150184215;7385.8153546161775;4664.323673067454;4807.807687692593;4817.421909370898;4822.493638167942;4822.590079843252;7082.964585177041;7095.680694368662;7097.396721278543;7112.110986126734;7120;6883.036374907417;6884.690188941609;6890.931090689029;6900.447964162955;6902.033715279765;6849.1438570178725;6882.621455819978;6890.758823441155;6895;6901.275366086488;6553.934460655332;6758.357955994173;6791.117154770046;6801.455883529206;6808.217055038536;6898.724051038103;6925.930740692528;6941.444684425132;6956.408705259907;6958.443324533924;6822.590644561342;6847.760328388483;6861.725530978904;6864.588124712333;6894.24163342042 06:41:40 INFO - PROCESS | 9705 | |5;yui.html;635.6980434293711;786.8898354230405;799.4403917257921;833.3208435125372;864.9610767515461;14607.488737894177;14817;14867.107973521597;14889.181095039768;14916.627084322898;13263.469461221564;13367.532136375228;13378;13388.397522111503;13411.262380569065;926.9536523173848;939.1922946266205;947.1854205383365;948.4641177734593;953.9840070325082;963.6579014449875;964.3490643815431;966.0677446264353;966.8936416994125;968.3512046928539;999.170688328689;1000.194843151263;1000.7147962830595;1003.5634498992926;1004.829179039565;986.063239922077;989.0603926270072;992.7071513903416;998.4857798233916;999.0558921818885;736.3409748275263;736.4366259811248;736.7421402509133;736.91157061153;738.5088915870939;14911.179885106314;14987.700245995127;15129.773053404098;15151.848481515264;15166.545003649908;13422.328883555881;13495.730085398336;13591;13643.181409115485;13707.862921370759;10614.257002009863;10649.627263045833;10777.299475534066;10912.945435272773;10948.343099413982;3762.2099359134613;3792.27946690128;3819.618038196186;3863.729538932276;3888.47505586745;50706.7464662678;50935.49064509344;52927;53108.468915311125;53265;10919.454027298603;11029.283096598696;11100.777984440267;11266.493007814668;11382.317060976202;19493.122809473607;19509.609807803765;19511.902440487705;19566.21735130579;19589.51026224356;8171.836563268701;8177.304929081095;8396.622152003174;8511.319094472427;8645.524496152646;4607.861764147081;4687.95312046882;4737.147313483537;4741.099191153669;4960.677555958851;3366.7643264971707;3373.409653310661;3390.389729848651;3399.7620166588595;3413.232022794851;637.9170707808048;642.2389468479773;644.4361183964031;644.6196743921109;646.6669665122465;508.42547920849944;553.6235359955269;583.5448350286783;620.0544170140481;676.7191615479619;8605.95697021511;8679.869801952977;8764.56177191138;8765.211130998241;8933.553322333857;512.6129772022174;590.1354515634616;603.2941458493573;607.5716619783042;636.92359911749;3578.982105089458;3749.3063783200196;3760.191558814868;3783.432485127198;3871.090293780959;56416.717916410154;57132;57157;57389.42610573924;57401;51320.23019654708;52475;52552.47447525552;52801.735991319794;53826;45967.540324596324;46173.30740038902;46502.53497464982;47837.521624784;49243.753781230866;7488.138864030706;7574.5076570022775;7587.089549254125;7660.042494688164;7766.223377662189;34943;35494.29011419706;35703.10742231465;36270.27459450849;36363;40446.79776601098;40452.19095618012;46378.68106594724;47384.289235660806;48188.277175841686;11107.666769996913;11107.94446027797;11136.164787640797;11145.275557088764;11307.321560706385;12625.116241862981;12635.115541912346;12651.177673451197;12738.299393533445;13123.081384303006;11233.943830280796;11259.324440533594;11538.653391461952;11653.941730291293;11862.762744745229;10933.781324373309;11186;11215.214934954474;11515;11985.28088314704;11306.321620702784;11645.243059201124;11645.301281923112;11678.88321116778;11842.46708898119;9820.312578119749;9905.158061564847;10033.397996120257;10071.748206294902;10091.596336146766;9558.235341172829;9824.263180261367;9834.606615735576;9835.803283934425;9910.405375677483 06:41:40 INFO - PROCESS | 9705 | __end_tp_report 06:41:40 INFO - PROCESS | 9705 | __start_cc_report 06:41:40 INFO - PROCESS | 9705 | _x_x_mozilla_cycle_collect,331 06:41:40 INFO - PROCESS | 9705 | __end_cc_report 06:41:40 INFO - PROCESS | 9705 | __startTimestamp1465220500330__endTimestamp 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | ------- Summary: start ------- 06:41:40 INFO - PROCESS | 9705 | Number of tests: 6 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | [#0] dojo.html Cycles:165 Average:5566.83 Median:5841.27 stddev:623.65 (10.7%) stddev-sans-first:601.09 06:41:40 INFO - PROCESS | 9705 | Values: 3361.3 3412.6 3421.9 3468.4 3475.2 5452.4 5462.5 5493.9 5510.4 5515.1 5493.0 5519.6 5532.2 5536.0 5540.9 5035.1 5043.3 5095.9 5121.5 5130.8 5025.9 5083.5 5126.7 5135.7 5145.8 5060.2 5083.0 5094.7 5177.7 5185.3 5097.2 5159.9 5188.7 5189.9 5203.3 4913.0 4982.5 5165.1 5187.2 5188.7 5324.7 5349.1 5359.8 5387.8 5395.0 5917.7 5939.5 5950.5 5953.9 5984.9 5971.9 6010.8 6020.1 6033.8 6052.6 5599.3 5649.7 5665.1 5671.9 5672.5 5917.5 6118.3 6147.0 6147.5 6148.5 5823.3 5881.2 5882.4 5894.5 5895.0 5930.3 5932.4 5933.9 5943.6 5965.8 5789.5 5878.8 5883.5 5907.5 5955.1 5901.5 5903.6 5915.3 5920.1 5946.0 4479.1 4487.2 4490.0 4491.9 4517.7 4025.0 4045.4 4054.0 4070.9 4083.8 5580.0 5636.7 5692.5 5693.1 5700.7 6129.3 6130.7 6147.8 6153.3 6155.6 5545.0 5628.6 5756.7 5758.8 5782.1 5115.9 5120.7 5135.7 5165.8 5180.5 6205.3 6212.3 6217.1 6224.4 6260.6 5908.4 6008.1 6052.8 6060.5 6069.5 6152.2 6167.6 6267.7 6268.6 6273.3 5915.4 5942.3 5958.6 5971.9 5997.5 5871.5 6061.8 6065.9 6069.0 6090.9 5878.8 5903.7 5924.6 5943.5 5987.3 5892.4 5932.5 5951.9 5952.7 5988.1 5436.0 5708.1 5760.4 5827.6 5841.3 5895.2 5920.0 5922.9 5930.9 5958.1 5800.4 5851.2 5858.0 5858.2 5866.7 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | [#1] ext.html Cycles:180 Average:53671.79 Median:40929.12 stddev:99513.43 (243.1%) stddev-sans-first:99712.63 06:41:40 INFO - PROCESS | 9705 | Values: 538.9 546.5 561.7 573.2 588.3 39402.8 40313.4 40328.8 40342.6 40389.4 44701.3 44726.8 45142.8 45270.3 45358.5 8826.9 9007.5 9066.2 9091.0 9091.2 9097.2 9271.7 9277.3 9290.0 9303.6 9100.8 9186.8 9197.4 9212.7 9214.0 9248.8 9325.3 9336.3 9347.2 9352.7 9120.4 9321.2 9332.3 9346.6 9352.2 44960.3 45375.0 45547.3 45570.3 45570.3 3451.9 3461.8 3478.8 3773.2 4151.3 32446.4 32476.2 33017.7 33098.3 33348.7 3646.6 3736.0 3756.2 3777.5 3816.1 290921.0 291213.0 291237.0 291447.0 292515.0 46449.3 46991.3 63688.4 64750.4 64869.0 45357.0 45407.0 45490.1 45502.1 45527.8 17223.1 17525.1 17562.2 17572.0 17595.0 14013.9 14104.9 14126.0 14194.8 14218.6 15436.5 15604.1 15634.1 15747.2 15767.8 5830.5 5881.9 5999.9 6022.2 6051.4 1036.5 1050.8 1054.0 1085.2 1151.9 29658.7 29907.6 30020.2 30487.8 30801.2 1079.1 1118.6 1130.6 1136.4 1227.1 15478.5 15484.8 15732.7 15848.9 15959.9 333109.0 493050.0 497430.0 500296.0 622298.0 57602.4 58304.0 58822.7 59151.0 59155.0 1448.6 1477.2 1481.2 1507.4 1547.5 29122.9 30752.1 31785.7 31819.2 32931.5 51169.7 51248.7 51477.2 51989.0 52086.5 301308.0 303149.0 303222.0 304180.0 304942.0 34770.0 35609.0 35713.8 35949.0 36011.1 46516.8 47146.0 47646.3 48422.8 58835.4 39906.4 41468.9 42975.0 43187.8 43709.1 41508.8 41587.2 42504.4 43126.8 44565.3 42892.8 43472.3 43930.0 44214.0 44297.1 38934.6 39205.8 39441.4 39648.4 39904.8 29435.7 30023.4 30058.0 30309.5 30641.8 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | [#2] jquery.html Cycles:180 Average:23073.14 Median:13554.45 stddev:58095.66 (428.6%) stddev-sans-first:58233.61 06:41:40 INFO - PROCESS | 9705 | Values: 363.0 367.6 371.4 378.8 386.2 17493.0 18617.5 20055.0 20056.2 20100.3 18249.6 18690.1 18808.2 18879.1 18883.5 5548.1 5754.0 5788.2 5801.7 5823.1 5269.6 5497.1 5532.4 5533.3 5674.6 5321.1 5441.3 5462.6 5503.8 5804.6 5796.4 5814.5 5829.8 5849.1 5872.4 5598.9 5614.6 5628.3 5632.2 5669.5 13585.2 13647.7 13909.4 14039.3 14042.5 2210.2 2284.4 2389.0 2876.5 2919.3 10258.6 10300.5 10344.7 10547.5 10654.4 1861.6 1945.5 1995.2 2012.7 2022.8 64047.0 64658.7 65456.3 65548.0 69106.3 9923.6 10374.1 10388.9 10515.8 10579.3 15108.2 15202.0 15209.5 15358.8 15407.2 8312.3 8528.6 8543.1 8558.7 8601.8 8361.5 8376.9 8386.9 8464.0 8484.0 4573.3 4787.7 4803.8 4885.7 4889.7 1948.5 1956.9 1979.9 2010.8 2017.7 942.6 952.0 980.5 1002.4 1010.4 17618.6 17626.3 17699.3 17960.4 18202.0 941.0 971.9 1006.0 1015.8 1027.5 8142.3 10221.5 10414.1 10435.3 10532.8 320161.0 321002.0 321704.0 325747.0 451872.0 51357.7 57094.4 70226.3 81805.6 84393.2 1055.8 1065.7 1089.3 1103.3 1104.7 15522.8 15684.1 15780.4 15841.2 15942.7 24232.4 31139.5 32219.4 33550.0 33766.7 51871.7 51949.2 52431.0 52848.5 52867.5 8657.4 8687.9 8727.6 8864.7 8913.0 10070.1 11966.0 12715.0 12896.2 13235.4 11041.2 11295.9 11482.5 11654.9 11729.8 11078.9 11142.3 11194.0 11424.0 11464.2 10837.1 10880.2 10940.3 11219.6 11356.7 8038.6 8099.2 8124.3 8199.8 8281.1 8550.8 10238.5 10908.3 11026.1 11127.2 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | [#3] mootools.html Cycles:180 Average:5837.06 Median:2913.37 stddev:3078.57 (105.7%) stddev-sans-first:3070.60 06:41:40 INFO - PROCESS | 9705 | Values: 1582.6 1612.8 1720.0 1758.1 1867.0 7240.1 8060.7 8206.0 8366.0 8435.9 8144.6 8186.0 8213.1 8216.5 8229.0 2396.2 2414.8 2422.7 2426.2 2430.4 2239.9 2242.2 2267.1 2274.2 2282.0 2408.1 2418.7 2423.9 2426.5 2437.1 2355.2 2355.3 2366.2 2366.3 2392.9 2351.1 2357.5 2370.1 2380.6 2382.9 8381.6 8390.7 8391.4 8402.5 8412.7 5106.3 5217.7 5218.3 5228.8 5260.6 3220.6 3236.2 3281.5 3322.6 3360.5 1081.9 1088.4 1101.2 1101.6 1109.4 11747.4 11802.8 11839.9 11865.8 11899.3 4564.6 4569.6 4606.1 4614.7 4659.2 10041.4 10048.0 10061.3 10062.0 10108.8 5284.5 5295.6 5316.3 5323.9 5330.9 4097.5 4644.5 4711.5 4721.8 4770.4 3774.4 3845.8 3856.6 3890.9 3953.4 1196.3 1202.0 1205.6 1227.8 1266.0 1436.0 1442.1 1466.2 1482.1 1485.2 7863.6 7900.8 7932.2 7939.0 7941.4 526.1 531.1 534.0 539.3 545.0 5961.6 5962.3 6008.5 6033.4 6049.1 9931.2 10228.7 10335.8 10355.0 10370.7 9852.5 10000.6 10107.4 10184.7 10200.0 7897.6 7976.1 7990.8 7997.8 8027.2 7306.8 7383.2 7424.4 7443.4 7492.6 8828.1 8991.2 9020.0 9188.4 9205.3 8862.5 8895.9 9172.0 9325.0 9361.3 7089.8 7208.9 7280.7 7285.5 7336.2 7949.2 7969.6 7978.6 8011.5 8024.7 7150.2 7255.2 7313.1 7361.4 7448.9 7059.6 7100.5 7109.4 7111.0 7127.3 7449.6 7525.3 7531.8 7566.3 7566.4 6938.4 6969.7 7002.2 7002.2 7005.4 6873.3 6915.2 6932.5 6958.8 6979.4 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | [#4] prototype.html Cycles:180 Average:5713.45 Median:6497.11 stddev:1750.33 (26.9%) stddev-sans-first:1708.25 06:41:40 INFO - PROCESS | 9705 | Values: 346.6 347.3 350.6 351.3 351.5 6392.3 6419.6 6454.5 6473.0 6500.2 6327.2 6367.1 6369.6 6371.7 6378.8 4694.3 4822.8 4829.0 4839.8 4843.9 4837.8 4846.3 4863.5 4864.8 4888.5 4826.8 4834.7 4841.4 4843.5 4855.4 4834.7 4843.7 4865.1 4871.7 4875.2 4251.4 4258.0 4259.9 4262.4 4262.6 5984.1 6106.8 6116.3 6120.0 6136.3 5640.4 5640.9 5650.6 5664.9 5666.3 6735.1 6737.9 6747.3 6756.4 6771.6 4619.9 4669.0 4671.5 4674.1 4683.3 6918.9 7046.4 7058.3 7065.3 7068.9 4704.7 4784.0 4811.6 4813.4 4818.9 4827.9 4852.8 4860.3 4866.1 4876.4 5615.0 5618.0 5619.4 5621.7 5622.5 6812.1 6816.3 6832.7 6845.3 6855.5 1685.2 1699.2 1700.2 1703.3 1703.7 1073.3 1106.3 1113.2 1129.5 1131.8 6494.7 6499.5 6523.2 6529.1 6532.9 7067.8 7069.1 7076.3 7082.0 7095.8 6422.6 6538.2 6589.5 6613.0 6638.5 3848.8 3880.5 3889.5 3891.5 3891.9 7405.5 7409.1 7411.6 7425.1 7428.3 7297.0 7305.7 7310.3 7331.7 7334.6 7295.3 7347.2 7411.5 7414.3 7421.0 7084.8 7091.7 7133.4 7140.7 7142.1 6947.7 6989.2 6991.2 6994.4 6996.9 7333.8 7334.7 7365.9 7370.0 7385.8 4664.3 4807.8 4817.4 4822.5 4822.6 7083.0 7095.7 7097.4 7112.1 7120.0 6883.0 6884.7 6890.9 6900.4 6902.0 6849.1 6882.6 6890.8 6895.0 6901.3 6553.9 6758.4 6791.1 6801.5 6808.2 6898.7 6925.9 6941.4 6956.4 6958.4 6822.6 6847.8 6861.7 6864.6 6894.2 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - PROCESS | 9705 | [#5] yui.html Cycles:180 Average:14264.56 Median:25390.58 stddev:16301.12 (64.2%) stddev-sans-first:16314.71 06:41:40 INFO - PROCESS | 9705 | Values: 635.7 786.9 799.4 833.3 865.0 14607.5 14817.0 14867.1 14889.2 14916.6 13263.5 13367.5 13378.0 13388.4 13411.3 927.0 939.2 947.2 948.5 954.0 963.7 964.3 966.1 966.9 968.4 999.2 1000.2 1000.7 1003.6 1004.8 986.1 989.1 992.7 998.5 999.1 736.3 736.4 736.7 736.9 738.5 14911.2 14987.7 15129.8 15151.8 15166.5 13422.3 13495.7 13591.0 13643.2 13707.9 10614.3 10649.6 10777.3 10912.9 10948.3 3762.2 3792.3 3819.6 3863.7 3888.5 50706.7 50935.5 52927.0 53108.5 53265.0 10919.5 11029.3 11100.8 11266.5 11382.3 19493.1 19509.6 19511.9 19566.2 19589.5 8171.8 8177.3 8396.6 8511.3 8645.5 4607.9 4688.0 4737.1 4741.1 4960.7 3366.8 3373.4 3390.4 3399.8 3413.2 637.9 642.2 644.4 644.6 646.7 508.4 553.6 583.5 620.1 676.7 8606.0 8679.9 8764.6 8765.2 8933.6 512.6 590.1 603.3 607.6 636.9 3579.0 3749.3 3760.2 3783.4 3871.1 56416.7 57132.0 57157.0 57389.4 57401.0 51320.2 52475.0 52552.5 52801.7 53826.0 45967.5 46173.3 46502.5 47837.5 49243.8 7488.1 7574.5 7587.1 7660.0 7766.2 34943.0 35494.3 35703.1 36270.3 36363.0 40446.8 40452.2 46378.7 47384.3 48188.3 11107.7 11107.9 11136.2 11145.3 11307.3 12625.1 12635.1 12651.2 12738.3 13123.1 11233.9 11259.3 11538.7 11653.9 11862.8 10933.8 11186.0 11215.2 11515.0 11985.3 11306.3 11645.2 11645.3 11678.9 11842.5 9820.3 9905.2 10033.4 10071.7 10091.6 9558.2 9824.3 9834.6 9835.8 9910.4 06:41:40 INFO - PROCESS | 9705 | -------- Summary: end -------- 06:41:40 INFO - PROCESS | 9705 | 06:41:40 INFO - TEST-INFO | 9705: exit 0 06:41:41 INFO - TEST-OK | dromaeo_css | took 1109271ms 06:41:41 INFO - TEST-START | kraken 06:41:41 INFO - operating with platform_type : linux_ 06:41:41 INFO - Initialising browser for kraken test... 06:41:41 INFO - TEST-INFO | started process 9951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIfd5z/profile http://localhost:34632/getInfo.html) 06:41:44 INFO - PROCESS | 9951 | 06:41:44 INFO - PROCESS | 9951 | (process:10030): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:41:45 INFO - PROCESS | 9951 | __metrics Screen width/height:1600/1200 06:41:45 INFO - PROCESS | 9951 | colorDepth:24 06:41:45 INFO - PROCESS | 9951 | Browser inner width/height: 1024/697 06:41:45 INFO - PROCESS | 9951 | __metrics 06:41:46 ERROR - PROCESS | 9951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:41:47 INFO - TEST-INFO | 9951: exit 0 06:41:47 INFO - Browser initialized. 06:41:47 INFO - Running cycle 1/1 for kraken test... 06:41:47 INFO - TEST-INFO | started process 10080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIfd5z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:49 INFO - PROCESS | 10080 | 06:41:49 INFO - PROCESS | 10080 | (process:10147): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:41:59 INFO - PROCESS | 10080 | RSS: Main: 149266432 06:41:59 INFO - PROCESS | 10080 | 06:42:01 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34632/tests/kraken/driver.html?testName=audio-beat-detection) 06:42:02 INFO - PROCESS | 10080 | RSS: Main: 153182208 06:42:02 INFO - PROCESS | 10080 | 06:42:05 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34632/tests/kraken/driver.html?testName=audio-dft) 06:42:05 INFO - PROCESS | 10080 | RSS: Main: 153419776 06:42:05 INFO - PROCESS | 10080 | 06:42:08 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34632/tests/kraken/driver.html?testName=audio-fft) 06:42:09 INFO - PROCESS | 10080 | RSS: Main: 154378240 06:42:09 INFO - PROCESS | 10080 | 06:42:11 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34632/tests/kraken/driver.html?testName=audio-oscillator) 06:42:11 INFO - PROCESS | 10080 | RSS: Main: 153407488 06:42:11 INFO - PROCESS | 10080 | 06:42:13 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34632/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:42:14 INFO - PROCESS | 10080 | RSS: Main: 153686016 06:42:14 INFO - PROCESS | 10080 | 06:42:17 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34632/tests/kraken/driver.html?testName=imaging-darkroom) 06:42:18 INFO - PROCESS | 10080 | RSS: Main: 154243072 06:42:18 INFO - PROCESS | 10080 | 06:42:21 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34632/tests/kraken/driver.html?testName=imaging-desaturate) 06:42:22 INFO - PROCESS | 10080 | RSS: Main: 154845184 06:42:22 INFO - PROCESS | 10080 | 06:42:24 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34632/tests/kraken/driver.html?testName=json-parse-financial) 06:42:25 INFO - PROCESS | 10080 | RSS: Main: 154517504 06:42:25 INFO - PROCESS | 10080 | 06:42:27 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34632/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:42:27 INFO - PROCESS | 10080 | RSS: Main: 154308608 06:42:27 INFO - PROCESS | 10080 | 06:42:29 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:42:30 INFO - PROCESS | 10080 | RSS: Main: 154017792 06:42:30 INFO - PROCESS | 10080 | 06:42:32 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:42:32 INFO - PROCESS | 10080 | RSS: Main: 154411008 06:42:32 INFO - PROCESS | 10080 | 06:42:35 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:42:35 INFO - PROCESS | 10080 | RSS: Main: 154931200 06:42:35 INFO - PROCESS | 10080 | 06:42:38 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:42:38 INFO - PROCESS | 10080 | RSS: Main: 154849280 06:42:38 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:34632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34632/tests/kraken/driver.html?testName=ai-astar) 06:42:40 INFO - PROCESS | 10080 | RSS: Main: 156585984 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | __start_tp_report 06:42:40 INFO - PROCESS | 10080 | _x_x_mozilla_page_load 06:42:40 INFO - PROCESS | 10080 | _x_x_mozilla_page_load_details 06:42:40 INFO - PROCESS | 10080 | |i|pagename|runs| 06:42:40 INFO - PROCESS | 10080 | |0;ai-astar;108;112;104;110;110;110;100;110;111;111 06:42:40 INFO - PROCESS | 10080 | |1;audio-beat-detection;165;133;156;165;128;151;158;130;165;127 06:42:40 INFO - PROCESS | 10080 | |2;audio-dft;162;162;162;163;162;163;163;162;162;161 06:42:40 INFO - PROCESS | 10080 | |3;audio-fft;76;77;73;164;76;77;75;77;165;73 06:42:40 INFO - PROCESS | 10080 | |4;audio-oscillator;92;94;148;93;93;94;140;93;93;139 06:42:40 INFO - PROCESS | 10080 | |5;imaging-gaussian-blur;117;117;116;118;117;118;118;117;117;117 06:42:40 INFO - PROCESS | 10080 | |6;imaging-darkroom;147;147;146;147;148;147;148;147;147;147 06:42:40 INFO - PROCESS | 10080 | |7;imaging-desaturate;96;96;96;97;96;97;96;96;96;96 06:42:40 INFO - PROCESS | 10080 | |8;json-parse-financial;53;54;56;54;57;65;54;55;77;53 06:42:40 INFO - PROCESS | 10080 | |9;json-stringify-tinderbox;66;65;65;65;65;65;66;65;65;65 06:42:40 INFO - PROCESS | 10080 | |10;stanford-crypto-aes;79;80;81;88;80;80;83;82;81;81 06:42:40 INFO - PROCESS | 10080 | |11;stanford-crypto-ccm;118;117;123;113;124;121;122;119;116;117 06:42:40 INFO - PROCESS | 10080 | |12;stanford-crypto-pbkdf2;136;146;149;135;145;143;143;142;144;145 06:42:40 INFO - PROCESS | 10080 | |13;stanford-crypto-sha256-iterative;70;68;67;70;68;68;70;66;68;67 06:42:40 INFO - PROCESS | 10080 | __end_tp_report 06:42:40 INFO - PROCESS | 10080 | __start_cc_report 06:42:40 INFO - PROCESS | 10080 | _x_x_mozilla_cycle_collect,840 06:42:40 INFO - PROCESS | 10080 | __end_cc_report 06:42:40 INFO - PROCESS | 10080 | __startTimestamp1465220560658__endTimestamp 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | ------- Summary: start ------- 06:42:40 INFO - PROCESS | 10080 | Number of tests: 14 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.75 (3.4%) stddev-sans-first:3.97 06:42:40 INFO - PROCESS | 10080 | Values: 108.0 112.0 104.0 110.0 110.0 110.0 100.0 110.0 111.0 111.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:157.00 stddev:16.43 (10.5%) stddev-sans-first:16.21 06:42:40 INFO - PROCESS | 10080 | Values: 165.0 133.0 156.0 165.0 128.0 151.0 158.0 130.0 165.0 127.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:42:40 INFO - PROCESS | 10080 | Values: 162.0 162.0 162.0 163.0 162.0 163.0 163.0 162.0 162.0 161.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:37.56 (49.4%) stddev-sans-first:39.31 06:42:40 INFO - PROCESS | 10080 | Values: 76.0 77.0 73.0 164.0 76.0 77.0 75.0 77.0 165.0 73.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:23.88 (25.7%) stddev-sans-first:24.63 06:42:40 INFO - PROCESS | 10080 | Values: 92.0 94.0 148.0 93.0 93.0 94.0 140.0 93.0 93.0 139.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:42:40 INFO - PROCESS | 10080 | Values: 117.0 117.0 116.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:42:40 INFO - PROCESS | 10080 | Values: 147.0 147.0 146.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:42:40 INFO - PROCESS | 10080 | Values: 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:55.50 stddev:7.61 (13.7%) stddev-sans-first:7.87 06:42:40 INFO - PROCESS | 10080 | Values: 53.0 54.0 56.0 54.0 57.0 65.0 54.0 55.0 77.0 53.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 06:42:40 INFO - PROCESS | 10080 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.55 (3.1%) stddev-sans-first:2.54 06:42:40 INFO - PROCESS | 10080 | Values: 79.0 80.0 81.0 88.0 80.0 80.0 83.0 82.0 81.0 81.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:120.00 stddev:3.46 (2.9%) stddev-sans-first:3.66 06:42:40 INFO - PROCESS | 10080 | Values: 118.0 117.0 123.0 113.0 124.0 121.0 122.0 119.0 116.0 117.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:144.50 stddev:4.32 (3.0%) stddev-sans-first:3.81 06:42:40 INFO - PROCESS | 10080 | Values: 136.0 146.0 149.0 135.0 145.0 143.0 143.0 142.0 144.0 145.0 06:42:40 INFO - PROCESS | 10080 | 06:42:40 INFO - PROCESS | 10080 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.32 06:42:40 INFO - PROCESS | 10080 | Values: 70.0 68.0 67.0 70.0 68.0 68.0 70.0 66.0 68.0 67.0 06:42:40 INFO - PROCESS | 10080 | -------- Summary: end -------- 06:42:40 INFO - PROCESS | 10080 | 06:42:41 INFO - TEST-INFO | 10080: exit 0 06:42:41 INFO - TEST-OK | kraken | took 60585ms 06:42:41 INFO - SUITE-END | took 1169s 06:42:41 INFO - Completed test suite (00:19:30) 06:42:41 INFO - javascript benchmark 06:42:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3361.2941282330708, 3412.556367672202, 3421.948670769938, 3468.445048792192, 3475.200703838117, 5452.400235974044, 5462.481064298895, 5493.862653433666, 5510.366307874596, 5515.117581187011, 5493.0, 5519.558435325174, 5532.197831314457, 5536.031194540959, 5540.889182216363, 5035.068512325213, 5043.31915191449, 5095.898082038357, 5121.513456221653, 5130.769115389798, 5025.924611130836, 5083.517065878736, 5126.666766660155, 5135.743212839362, 5145.81989630363, 5060.190369540875, 5082.983403319351, 5094.694318340893, 5177.663451875616, 5185.325907632003, 5097.184450487923, 5159.896802063975, 5188.7146206958605, 5189.896202075975, 5203.323567936163, 4912.975435122801, 4982.5017498250245, 5165.1219292720325, 5187.19598462239, 5188.662736922126, 5324.7071411072375, 5349.117395629716, 5359.785608575652, 5387.838364849061, 5394.973025134888, 5917.674527900964, 5939.465448109648, 5950.523958083343, 5953.940460595425, 5984.910226346608, 5971.940280597225, 6010.819675409701, 6020.096985452174, 6033.758649654009, 6052.606580572293, 5599.300087489064, 5649.745761440745, 5665.065264231397, 5671.914921276184, 5672.5178359839465, 5917.52659787216, 6118.296395914438, 6147.0, 6147.508199344042, 6148.477379422709, 5823.330317013513, 5881.235439392852, 5882.44116808911, 5894.469497745224, 5895.027320492157, 5930.2883653960935, 5932.40675932412, 5933.881322373529, 5943.64338139713, 5965.79119730816, 5789.53683705311, 5878.823635290948, 5883.499902508249, 5907.468327850428, 5955.13650520672, 5901.468867801833, 5903.58674892762, 5915.349311575723, 5920.052791553331, 5946.018906880403, 4479.148961697267, 4487.237169681097, 4490.034642551867, 4491.865244042684, 4517.706349087299, 4024.959750402517, 4045.4134150548007, 4053.9594604054173, 4070.8575199867864, 4083.7958102094776, 5580.0, 5636.661800291914, 5692.459216374438, 5693.089105743061, 5700.743466544015, 6129.264488261348, 6130.7183035492235, 6147.754089836446, 6153.2616086069065, 6155.630662160284, 5545.0, 5628.634138780966, 5756.7121643917635, 5758.798442054508, 5782.132680098019, 5115.923261151086, 5120.667156634807, 5135.666181698178, 5165.845024649267, 5180.507851754077, 6205.348438413902, 6212.285587157445, 6217.098520714471, 6224.439800417894, 6260.561760676709, 5908.379620139824, 6008.098785182083, 6052.757889684363, 6060.484858786876, 6069.51443884497, 6152.16945712341, 6167.5682702210415, 6267.749290028531, 6268.561200715906, 6273.341299163522, 5915.378885217162, 5942.2869255687865, 5958.612690175125, 5971.880562388815, 5997.460228579449, 5871.530277577869, 6061.848453788691, 6065.939340606537, 6068.969655151696, 6090.878182436238, 5878.794242201502, 5903.675297858659, 5924.555658325729, 5943.465088142088, 5987.34139244674, 5892.440218179266, 5932.466078052823, 5951.880962380642, 5952.74992251632, 5988.101784732325, 5435.972820135874, 5708.058170401837, 5760.423957604206, 5827.59206855516, 5841.269841269841, 5895.174675545512, 5920.0, 5922.851928701817, 5930.851728706644, 5958.076498142795, 5800.361960184292, 5851.180834683063, 5858.0, 5858.209141765807, 5866.706664666664], "unit": "score", "name": "dojo.html", "value": 5526.395671509488}, {"lowerIsBetter": false, "replicates": [538.8572028412469, 546.5381752419206, 561.7051048199695, 573.2433188191587, 588.2529187931327, 39402.802985985065, 40313.395299070464, 40328.79835600825, 40342.59657403425, 40389.3941590876, 44701.32948005782, 44726.77636611812, 45142.77428612852, 45270.32094518585, 45358.54641453584, 8826.91173088269, 9007.459552426842, 9066.229370503515, 9090.954545227298, 9091.18179363857, 9097.181253687168, 9271.675491357804, 9277.257819374434, 9290.0, 9303.581338839735, 9100.772480688003, 9186.770330741752, 9197.448153110834, 9212.677556285531, 9214.032526584713, 9248.768780780467, 9325.347225694204, 9336.253099752004, 9347.158755712018, 9352.67265645699, 9120.361574689774, 9321.207697345733, 9332.300077494216, 9346.579403926771, 9352.20506256969, 44960.3255951161, 45375.0, 45547.31679024817, 45570.31644525302, 45570.31644525302, 3451.913702157441, 3461.7922924624604, 3478.7912725236315, 3773.2264885698364, 4151.335786274181, 32446.351072978643, 32476.188095297806, 33017.6698233017, 33098.338033239444, 33348.66651333504, 3646.58064322601, 3736.0, 3756.1736417988, 3777.508923839883, 3816.103215744298, 290921.0, 291213.0, 291237.0, 291447.0, 292515.0, 46449.30326045112, 46991.29513057307, 63688.363116368244, 64750.38124046842, 64869.0, 45357.0, 45407.0, 45490.090198196514, 45502.08995820065, 45527.77236113865, 17223.052732099604, 17525.123743812757, 17562.209700563504, 17572.0, 17595.0, 14013.859861401459, 14104.85895141056, 14126.0, 14194.787078193835, 14218.573442796733, 15436.536903892902, 15604.063756174666, 15634.06195628266, 15747.212639367986, 15767.763483547757, 5830.53355731549, 5881.882362352729, 5999.850003749942, 6022.2171117754415, 6051.394860513913, 1036.5387402605768, 1050.8056009638242, 1054.0092313225543, 1085.1969542538623, 1151.9171978340332, 29658.703412965595, 29907.551386729217, 30020.249493762392, 30487.847560762053, 30801.2299692505, 1079.1205167788228, 1118.5637601335486, 1130.5929865248504, 1136.3863513702672, 1227.1164761371797, 15478.458253961056, 15484.845151548341, 15732.68534629301, 15848.92075539615, 15959.920200398923, 333109.0, 493050.0, 497430.0, 500296.0, 622298.0, 57602.42397576055, 58304.0, 58822.70588647029, 59151.0, 59155.0, 1448.6233579269256, 1477.2023107521818, 1481.222358261921, 1507.4422463688506, 1547.4970634543818, 29122.854385727936, 30752.077437676904, 31785.682143178274, 31819.20451988719, 32931.50602741009, 51169.744151279, 51248.718782030744, 51477.22784158315, 51989.0, 52086.47913520816, 301308.0, 303149.0, 303222.0, 304180.0, 304942.0, 34770.0, 35609.0, 35713.821430892676, 35949.0, 36011.0997225061, 46516.7674161627, 47146.0, 47646.28530571975, 48422.75788621034, 58835.411645882996, 39906.401403979544, 41468.85311468829, 42975.0, 43187.784061079496, 43709.12581748283, 41508.792456037525, 41587.168256635305, 42504.362434562885, 43126.78436607797, 44565.331520027874, 42892.78553607212, 43472.34791478194, 43930.0, 44214.0, 44297.11405771931, 38934.6106538931, 39205.80397097996, 39441.40837887376, 39648.40527392149, 39904.800475997436, 29435.705642944155, 30023.399532009673, 30058.0, 30309.545356820105, 30641.846790765903], "unit": "score", "name": "ext.html", "value": 19811.582993071843}, {"lowerIsBetter": false, "replicates": [362.95825980012296, 367.5883011027649, 371.35013725979536, 378.81816727970573, 386.21405439929714, 17493.0, 18617.53456163595, 20055.0, 20056.197752089898, 20100.296489622866, 18249.635007299847, 18690.065496725176, 18808.15363308651, 18879.056047197653, 18883.52791180221, 5548.112302031675, 5754.0, 5788.218590490293, 5801.680907550083, 5823.06830907055, 5269.6311258211945, 5497.065498865182, 5532.446755324476, 5533.335999680044, 5674.602777805555, 5321.148616221405, 5441.319835020622, 5462.562994960394, 5503.834884953458, 5804.59367844251, 5796.420357964191, 5814.5057670097885, 5829.8251052468495, 5849.1226316052935, 5872.354041055481, 5598.916016259759, 5614.550835933115, 5628.296462942132, 5632.239647647556, 5669.461401166883, 13585.184888906697, 13647.658808529766, 13909.443622255098, 14039.298035098307, 14042.508512202126, 2210.16013914713, 2284.3603790938564, 2389.0, 2876.525373313401, 2919.313961219133, 10258.640947566873, 10300.536475858604, 10344.741381465448, 10547.472626368652, 10654.414007229676, 1861.6183682345086, 1945.5330720626948, 1995.2218634732467, 2012.7383440152832, 2022.7774944756065, 64047.0, 64658.676706616636, 65456.3454365455, 65548.0, 69106.30893690999, 9923.60305587783, 10374.118199953089, 10388.896111038945, 10515.789684206273, 10579.312344697724, 15108.244587770787, 15202.011869228465, 15209.467668631545, 15358.846411535966, 15407.15260660652, 8312.293455056268, 8528.573571321409, 8543.145685431407, 8558.700445484377, 8601.827963440695, 8361.456505327134, 8376.874346884802, 8386.87419688705, 8463.957680211683, 8484.0, 4573.336866154389, 4787.688800227974, 4803.78382972767, 4885.706857588556, 4889.657723959289, 1948.4933917181352, 1956.949115331279, 1979.9307024254083, 2010.8290795282273, 2017.737694099787, 942.641796117471, 952.0431965874391, 980.5097451274363, 1002.4085789384299, 1010.3887148275335, 17618.559536011446, 17626.294948202183, 17699.292028318723, 17960.371387001655, 18201.99889006091, 940.9764755881158, 971.8785151856018, 1005.9698209053594, 1015.7968406318765, 1027.4965267019106, 8142.307903828122, 10221.540030698636, 10414.114800241912, 10435.269531132899, 10532.842007369896, 320161.0, 321002.0, 321704.0, 325747.0, 451872.0, 51357.743211283705, 57094.42905570974, 70226.29773702197, 81805.59097204475, 84393.15606843853, 1055.8205105132147, 1065.6909496246158, 1089.3137323486153, 1103.2718405851938, 1104.7293413113678, 15522.84477155214, 15684.137372444626, 15780.368785248462, 15841.207939602744, 15942.68114637724, 24232.36680445654, 31139.53290700596, 32219.355612887142, 33550.0, 33766.66233337635, 51871.74064129655, 51949.22076168785, 52431.0, 52848.47151528436, 52867.47132528779, 8657.437266577652, 8687.913120868963, 8727.607257673548, 8864.73405797827, 8913.019567847661, 10070.093691567794, 11966.042716582479, 12715.0, 12896.226226426445, 13235.40440680191, 11041.171912106463, 11295.887041129812, 11482.540698372306, 11654.883451165719, 11729.824052639387, 11078.944605276922, 11142.27575207609, 11194.0, 11424.0, 11464.197506174822, 10837.133029357476, 10880.238383313092, 10940.288881222696, 11219.60731374398, 11356.659300221007, 8038.63826127814, 8099.230573095547, 8124.268815806606, 8199.79500512468, 8281.130481299377, 8550.82898342042, 10238.539265733209, 10908.290961087503, 11026.062784663394, 11127.22109452363], "unit": "score", "name": "jquery.html", "value": 8666.09152506688}, {"lowerIsBetter": false, "replicates": [1582.564794681463, 1612.838716128387, 1719.957001074973, 1758.1033672826863, 1866.9813301866977, 7240.131184257883, 8060.717874874381, 8205.958970205149, 8366.037905640853, 8435.915640843597, 8144.633491492882, 8186.0, 8213.137620549845, 8216.465929714564, 8228.958855205716, 2396.2332053742766, 2414.7705967933107, 2422.7213870404953, 2426.1872272788637, 2430.4166999920067, 2239.85440946338, 2242.215224671368, 2267.093162734911, 2274.1585613323095, 2281.9657705134437, 2408.0728919366084, 2418.661387405765, 2423.9151629692965, 2426.46617744096, 2437.0617312334703, 2355.1874603262017, 2355.305184970438, 2366.183666635017, 2366.337425520857, 2392.9162479313313, 2351.1183306260154, 2357.5284943011466, 2370.1230544698574, 2380.6310021946624, 2382.8808559572126, 8381.58092095399, 8390.706325278587, 8391.370647201424, 8402.495850249004, 8412.747617571482, 5106.259592359124, 5217.713025783581, 5218.295530103425, 5228.843134705965, 5260.552853007461, 3220.6135263768265, 3236.1747754322732, 3281.5405843181975, 3322.634510203876, 3360.5463262459743, 1081.864766904137, 1088.4122573810132, 1101.1631160318136, 1101.564881871656, 1109.4397329348628, 11747.353895535742, 11802.822957655642, 11839.94080029603, 11865.762684746256, 11899.286042837371, 4564.6348292136545, 4569.634429245652, 4606.078784243165, 4614.7461889595725, 4659.184642687516, 10041.447720375303, 10048.045435683598, 10061.295709300279, 10061.993800620026, 10108.848367274497, 5284.497972692588, 5295.602829787781, 5316.255724198615, 5323.893522129613, 5330.92003619946, 4097.528784189856, 4644.512326205768, 4711.52884711533, 4721.834735784231, 4770.356001939694, 3774.3960966245268, 3845.8269377878064, 3856.614338566177, 3890.9416358754643, 3953.426753120839, 1196.318098683742, 1201.9579314723942, 1205.5659962413524, 1227.8281040654315, 1266.0, 1435.964100897465, 1442.0914823661026, 1466.1789397937189, 1482.0959214878915, 1485.2202593638426, 7863.646135923897, 7900.802479938047, 7932.206779322137, 7939.0, 7941.444098913021, 526.076735329502, 531.1315998342737, 533.9839804805862, 539.2962184349461, 545.0271265790545, 5961.552883533665, 5962.25471816023, 6008.459238668541, 6033.3664965178905, 6049.0926361046195, 9931.155851752537, 10228.693139205836, 10335.793284134275, 10355.0, 10370.688879333633, 9852.50737463124, 10000.599976001024, 10107.444090574942, 10184.694459166238, 10200.0, 7897.60511974399, 7976.0827504836525, 7990.84018319642, 7997.8400431992195, 8027.15714849944, 7306.817329566803, 7383.187849336676, 7424.406047516294, 7443.441741869273, 7492.587907665131, 8828.117188281121, 8991.190792828676, 9020.0, 9188.40275382098, 9205.30960177976, 8862.468251904906, 8895.866562001445, 9172.036936121878, 9325.0, 9361.344705870524, 7089.751858685127, 7208.927910720826, 7280.672369743268, 7285.453590980592, 7336.156342020736, 7949.165337639464, 7969.641366138421, 7978.601069946596, 8011.519308841255, 8024.719134830253, 7150.213476517475, 7255.165655949422, 7313.085864266966, 7361.4110871129105, 7448.925510744823, 7059.647017649199, 7100.538464999759, 7109.431245500451, 7111.040009598638, 7127.287271272831, 7449.5902725350625, 7525.3227209551405, 7531.811704707207, 7566.31903128721, 7566.35685966699, 6938.410235130071, 6969.686364113526, 7002.159740830929, 7002.159740831133, 7005.369516743517, 6873.278305778022, 6915.239323674492, 6932.514723969273, 6958.826029349307, 6979.406750426067], "unit": "score", "name": "mootools.html", "value": 4710.883221299736}, {"lowerIsBetter": false, "replicates": [346.55121617505336, 347.3452541958408, 350.6300852600505, 351.2921463251549, 351.52719592148566, 6392.328805475422, 6419.64691941943, 6454.451371633411, 6472.967635161829, 6500.154979852618, 6327.209098862642, 6367.108604795332, 6369.554131210817, 6371.681415929208, 6378.776742814002, 4694.342792009122, 4822.7829747661435, 4828.951710482903, 4839.782209800567, 4843.927341089895, 4837.7822997965, 4846.3457433246585, 4863.489333619972, 4864.805407783684, 4888.462269150391, 4826.806927722887, 4834.709917404949, 4841.443234028079, 4843.491433399495, 4855.393075865517, 4834.685745426554, 4843.733594652275, 4865.148598995197, 4871.658983871131, 4875.195592727196, 4251.426057482262, 4257.97871010646, 4259.893502662428, 4262.403263543076, 4262.552431994658, 5984.072468767348, 6106.816795496142, 6116.26604807426, 6119.959606866843, 6136.325004249529, 5640.351359593658, 5640.943590564083, 5650.604457687963, 5664.915026274609, 5666.291713535808, 6735.090762747064, 6737.93262067378, 6747.257801641816, 6756.391924726749, 6771.559848609824, 4619.9076018479445, 4668.976655116737, 4671.48613652498, 4674.065186962587, 4683.250679891201, 6918.861622767567, 7046.4010559102535, 7058.329458701415, 7065.328793764585, 7068.929310706879, 4704.670673052853, 4783.95216047842, 4811.591014763784, 4813.374261346003, 4818.855434336975, 4827.879303017382, 4852.830150944771, 4860.3195552622665, 4866.124097662384, 4876.390451193601, 5614.9719251403485, 5618.016847051749, 5619.438056194348, 5621.662700237999, 5622.465865742748, 6812.114425124702, 6816.318368163144, 6832.6925288362145, 6845.281245469254, 6855.520113592101, 1685.1995302231587, 1699.2013753535819, 1700.2348942975711, 1703.3016463250256, 1703.7188863837575, 1073.3238060022136, 1106.3073497548764, 1113.1762495753085, 1129.5090480565739, 1131.7849608574345, 6494.675266236669, 6499.545031847725, 6523.151990241238, 6529.053287273318, 6532.869342613216, 7067.752628657972, 7069.116360454943, 7076.32774886385, 7082.0, 7095.82260443493, 6422.614643121335, 6538.248101468297, 6589.53873228879, 6612.966935165389, 6638.4689224861895, 3848.807559622008, 3880.4955355803563, 3889.474920885644, 3891.4746509220895, 3891.922161556753, 7405.481616286916, 7409.147947985943, 7411.5553066816165, 7425.071866016748, 7428.33145016951, 7297.0, 7305.744298949511, 7310.342069213796, 7331.670074846538, 7334.633268336562, 7295.306945840137, 7347.228541003225, 7411.4811963162065, 7414.295641914117, 7421.0, 7084.787456376317, 7091.716331346688, 7133.429325653831, 7140.6786694599905, 7142.142942846892, 6947.7220911162985, 6989.161300643956, 6991.196012458632, 6994.440444764508, 6996.895046574407, 7333.816654583678, 7334.669939852826, 7365.926340736738, 7369.963150184215, 7385.8153546161775, 4664.323673067454, 4807.807687692593, 4817.421909370898, 4822.493638167942, 4822.590079843252, 7082.964585177041, 7095.680694368662, 7097.396721278543, 7112.110986126734, 7120.0, 6883.036374907417, 6884.690188941609, 6890.931090689029, 6900.447964162955, 6902.033715279765, 6849.1438570178725, 6882.621455819978, 6890.758823441155, 6895.0, 6901.275366086488, 6553.934460655332, 6758.357955994173, 6791.117154770046, 6801.455883529206, 6808.217055038536, 6898.724051038103, 6925.930740692528, 6941.444684425132, 6956.408705259907, 6958.443324533924, 6822.590644561342, 6847.760328388483, 6861.725530978904, 6864.588124712333, 6894.24163342042], "unit": "score", "name": "prototype.html", "value": 5136.582405181223}, {"lowerIsBetter": false, "replicates": [635.6980434293711, 786.8898354230405, 799.4403917257921, 833.3208435125372, 864.9610767515461, 14607.488737894177, 14817.0, 14867.107973521597, 14889.181095039768, 14916.627084322898, 13263.469461221564, 13367.532136375228, 13378.0, 13388.397522111503, 13411.262380569065, 926.9536523173848, 939.1922946266205, 947.1854205383365, 948.4641177734593, 953.9840070325082, 963.6579014449875, 964.3490643815431, 966.0677446264353, 966.8936416994125, 968.3512046928539, 999.170688328689, 1000.194843151263, 1000.7147962830595, 1003.5634498992926, 1004.829179039565, 986.063239922077, 989.0603926270072, 992.7071513903416, 998.4857798233916, 999.0558921818885, 736.3409748275263, 736.4366259811248, 736.7421402509133, 736.91157061153, 738.5088915870939, 14911.179885106314, 14987.700245995127, 15129.773053404098, 15151.848481515264, 15166.545003649908, 13422.328883555881, 13495.730085398336, 13591.0, 13643.181409115485, 13707.862921370759, 10614.257002009863, 10649.627263045833, 10777.299475534066, 10912.945435272773, 10948.343099413982, 3762.2099359134613, 3792.27946690128, 3819.618038196186, 3863.729538932276, 3888.47505586745, 50706.7464662678, 50935.49064509344, 52927.0, 53108.468915311125, 53265.0, 10919.454027298603, 11029.283096598696, 11100.777984440267, 11266.493007814668, 11382.317060976202, 19493.122809473607, 19509.609807803765, 19511.902440487705, 19566.21735130579, 19589.51026224356, 8171.836563268701, 8177.304929081095, 8396.622152003174, 8511.319094472427, 8645.524496152646, 4607.861764147081, 4687.95312046882, 4737.147313483537, 4741.099191153669, 4960.677555958851, 3366.7643264971707, 3373.409653310661, 3390.389729848651, 3399.7620166588595, 3413.232022794851, 637.9170707808048, 642.2389468479773, 644.4361183964031, 644.6196743921109, 646.6669665122465, 508.42547920849944, 553.6235359955269, 583.5448350286783, 620.0544170140481, 676.7191615479619, 8605.95697021511, 8679.869801952977, 8764.56177191138, 8765.211130998241, 8933.553322333857, 512.6129772022174, 590.1354515634616, 603.2941458493573, 607.5716619783042, 636.92359911749, 3578.982105089458, 3749.3063783200196, 3760.191558814868, 3783.432485127198, 3871.090293780959, 56416.717916410154, 57132.0, 57157.0, 57389.42610573924, 57401.0, 51320.23019654708, 52475.0, 52552.47447525552, 52801.735991319794, 53826.0, 45967.540324596324, 46173.30740038902, 46502.53497464982, 47837.521624784, 49243.753781230866, 7488.138864030706, 7574.5076570022775, 7587.089549254125, 7660.042494688164, 7766.223377662189, 34943.0, 35494.29011419706, 35703.10742231465, 36270.27459450849, 36363.0, 40446.79776601098, 40452.19095618012, 46378.68106594724, 47384.289235660806, 48188.277175841686, 11107.666769996913, 11107.94446027797, 11136.164787640797, 11145.275557088764, 11307.321560706385, 12625.116241862981, 12635.115541912346, 12651.177673451197, 12738.299393533445, 13123.081384303006, 11233.943830280796, 11259.324440533594, 11538.653391461952, 11653.941730291293, 11862.762744745229, 10933.781324373309, 11186.0, 11215.214934954474, 11515.0, 11985.28088314704, 11306.321620702784, 11645.243059201124, 11645.301281923112, 11678.88321116778, 11842.46708898119, 9820.312578119749, 9905.158061564847, 10033.397996120257, 10071.748206294902, 10091.596336146766, 9558.235341172829, 9824.263180261367, 9834.606615735576, 9835.803283934425, 9910.405375677483], "unit": "score", "name": "yui.html", "value": 6622.233934590609}], "name": "dromaeo_css", "value": 7305.786341503103}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 104.0, 110.0, 110.0, 110.0, 100.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [165.0, 133.0, 156.0, 165.0, 128.0, 151.0, 158.0, 130.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 73.0, 164.0, 76.0, 77.0, 75.0, 77.0, 165.0, 73.0], "unit": "score", "name": "audio-fft", "value": 93.3}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 148.0, 93.0, 93.0, 94.0, 140.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 56.0, 54.0, 57.0, 65.0, 54.0, 55.0, 77.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 81.0, 88.0, 80.0, 80.0, 83.0, 82.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 123.0, 113.0, 124.0, 121.0, 122.0, 119.0, 116.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [136.0, 146.0, 149.0, 135.0, 145.0, 143.0, 143.0, 142.0, 144.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 67.0, 70.0, 68.0, 68.0, 70.0, 66.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1514.8000000000002}]} 06:42:41 INFO - Return code: 0 06:42:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:42:41 ERROR - # TBPL SUCCESS # 06:42:41 INFO - Running post-action listener: _resource_record_post_action 06:42:41 INFO - Running post-run listener: _resource_record_post_run 06:42:43 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 464109568; Read time: 12; Write time: 784860 06:42:43 INFO - install - Wall time: 13s; CPU: 18.0%; Read bytes: 0; Write bytes: 244408320; Read time: 0; Write time: 632832 06:42:43 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 12288; Write bytes: 219701248; Read time: 12; Write time: 152028 06:42:43 INFO - Running post-run listener: _upload_blobber_files 06:42:43 INFO - Blob upload gear active. 06:42:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:42:43 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 06:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:42:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:42:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:42:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:42:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:44 INFO - (blobuploader) - INFO - Done attempting. 06:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:42:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:44 INFO - (blobuploader) - INFO - Done attempting. 06:42:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:42:44 INFO - Return code: 0 06:42:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:42:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:42:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74e3fffa1fe62934801f18e69daa2712d13ec7163449fb440294e623155045ac3de0145a75512e5e2f1af2a017f8a10b05c9f2650a6747313fd11f54387d304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf03925418a99dc380490fc494211a04301003da9a940df971ca3811efe43e164dc2151d31175f0eca66006f37b9fd4bb54ead422af1b013f9b5190e4413982"} 06:42:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:42:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:42:44 INFO - Contents: 06:42:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74e3fffa1fe62934801f18e69daa2712d13ec7163449fb440294e623155045ac3de0145a75512e5e2f1af2a017f8a10b05c9f2650a6747313fd11f54387d304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf03925418a99dc380490fc494211a04301003da9a940df971ca3811efe43e164dc2151d31175f0eca66006f37b9fd4bb54ead422af1b013f9b5190e4413982"} 06:42:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:42:44 INFO - Copying logs to upload dir... 06:42:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:42:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.273657 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-06 06:42:44.822135) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:44.826072) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74e3fffa1fe62934801f18e69daa2712d13ec7163449fb440294e623155045ac3de0145a75512e5e2f1af2a017f8a10b05c9f2650a6747313fd11f54387d304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf03925418a99dc380490fc494211a04301003da9a940df971ca3811efe43e164dc2151d31175f0eca66006f37b9fd4bb54ead422af1b013f9b5190e4413982"} build_url:https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74e3fffa1fe62934801f18e69daa2712d13ec7163449fb440294e623155045ac3de0145a75512e5e2f1af2a017f8a10b05c9f2650a6747313fd11f54387d304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf03925418a99dc380490fc494211a04301003da9a940df971ca3811efe43e164dc2151d31175f0eca66006f37b9fd4bb54ead422af1b013f9b5190e4413982"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:44.851055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:44.851356) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465218801.449908-1632376393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:44.936560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:44.936876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:44.937170) ========= ========= Total master_lag: 0.18 =========