builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1465219615.68 results: success (0) buildid: 20160602140837 builduid: 893fdbbbce3544769bc98c5128e2bb0b revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.680278) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.680781) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.681054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.696862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.697217) ========= 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=d2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 06:26:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.9M=0s 2016-06-06 06:26:56 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.792570) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.792883) ========= 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=d2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016662 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.842221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:55.842616) ========= 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=d2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 06:26:56,607 truncating revision to first 12 chars 2016-06-06 06:26:56,607 Setting DEBUG logging. 2016-06-06 06:26:56,607 attempt 1/10 2016-06-06 06:26:56,607 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:26:56,934 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:56.515140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:56.515505) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:56.515951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:56.516215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:26:56.527740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-06-06 06:26:56.528100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:26:57 INFO - MultiFileLogger online at 20160606 06:26:57 in /builds/slave/test 06:26:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:26:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:57 INFO - {'append_to_log': False, 06:26:57 INFO - 'base_work_dir': '/builds/slave/test', 06:26:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:26:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:57 INFO - 'branch': 'Mozilla-Beta', 06:26:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:57 INFO - 'config_files': ('talos/linux_config.py',), 06:26:57 INFO - 'default_actions': ('clobber', 06:26:57 INFO - 'read-buildbot-config', 06:26:57 INFO - 'download-and-extract', 06:26:57 INFO - 'populate-webroot', 06:26:57 INFO - 'create-virtualenv', 06:26:57 INFO - 'install', 06:26:57 INFO - 'run-tests'), 06:26:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:57 INFO - 'download_minidump_stackwalk': True, 06:26:57 INFO - 'download_symbols': 'ondemand', 06:26:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:57 INFO - 'installer_path': 'installer.exe', 06:26:57 INFO - 'log_level': 'info', 06:26:57 INFO - 'log_name': 'talos', 06:26:57 INFO - 'log_to_console': True, 06:26:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:26:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:26:57 INFO - 'opt_config_files': (), 06:26:57 INFO - 'pip_index': False, 06:26:57 INFO - 'sps_profile': False, 06:26:57 INFO - 'sps_profile_interval': 0, 06:26:57 INFO - 'suite': 'dromaeojs', 06:26:57 INFO - 'system_bits': '32', 06:26:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:57 INFO - 'title': 'talos-linux64-ix-043', 06:26:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:57 INFO - 'use_talos_json': True, 06:26:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:57 INFO - 'work_dir': 'build'} 06:26:57 INFO - ##### 06:26:57 INFO - ##### Running clobber step. 06:26:57 INFO - ##### 06:26:57 INFO - Running pre-action listener: _resource_record_pre_action 06:26:57 INFO - Running main action method: clobber 06:26:57 INFO - rmtree: /builds/slave/test/build 06:26:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:57 INFO - Running post-action listener: _resource_record_post_action 06:26:57 INFO - ##### 06:26:57 INFO - ##### Running read-buildbot-config step. 06:26:57 INFO - ##### 06:26:57 INFO - Running pre-action listener: _resource_record_pre_action 06:26:57 INFO - Running main action method: read_buildbot_config 06:26:57 INFO - Using buildbot properties: 06:26:57 INFO - { 06:26:57 INFO - "project": "", 06:26:57 INFO - "product": "firefox", 06:26:57 INFO - "script_repo_revision": "production", 06:26:57 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:26:57 INFO - "repository": "", 06:26:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:26:57 INFO - "buildid": "20160602140837", 06:26:57 INFO - "pgo_build": "True", 06:26:57 INFO - "basedir": "/builds/slave/test", 06:26:57 INFO - "buildnumber": 118, 06:26:57 INFO - "slavename": "talos-linux64-ix-043", 06:26:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:26:57 INFO - "platform": "ubuntu64_hw", 06:26:57 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:26:57 INFO - "branch": "mozilla-beta", 06:26:57 INFO - "repo_path": "releases/mozilla-beta", 06:26:57 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 06:26:57 INFO - "stage_platform": "linux64-pgo", 06:26:57 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 06:26:57 INFO - "slavebuilddir": "test" 06:26:57 INFO - } 06:26:57 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:26:57 INFO - Running post-action listener: _resource_record_post_action 06:26:57 INFO - ##### 06:26:57 INFO - ##### Running download-and-extract step. 06:26:57 INFO - ##### 06:26:57 INFO - Running pre-action listener: _resource_record_pre_action 06:26:57 INFO - Running main action method: download_and_extract 06:26:57 INFO - mkdir: /builds/slave/test/build/tests 06:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:57 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:26:57 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:26:57 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:26:57 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:26:57 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:26:58 INFO - Downloaded 1412 bytes. 06:26:58 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:26:58 INFO - Using the following test package requirements: 06:26:58 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:26:58 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:26:58 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 06:26:58 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'jsshell-linux-x86_64.zip'], 06:26:58 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:26:58 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:26:58 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 06:26:58 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 06:26:58 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:26:58 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:26:58 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:26:58 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:26:58 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:27:00 INFO - Downloaded 23434647 bytes. 06:27:00 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:27:00 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:27:01 INFO - Return code: 0 06:27:01 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:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:01 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:27:01 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:27:01 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:27:01 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:27:01 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:27:02 INFO - Downloaded 23434647 bytes. 06:27:02 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:27:02 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:27:03 INFO - Return code: 0 06:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:03 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:27:03 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:27:03 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:27:03 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:27:03 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:27:04 INFO - Downloaded 10845194 bytes. 06:27:04 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:27:04 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:27:05 INFO - Return code: 0 06:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:06 INFO - Downloaded 53855842 bytes. 06:27:06 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:27:06 INFO - mkdir: /builds/slave/test/properties 06:27:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:27:06 INFO - Writing to file /builds/slave/test/properties/build_url 06:27:06 INFO - Contents: 06:27:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:27:07 INFO - Running post-action listener: _resource_record_post_action 06:27:07 INFO - Running post-action listener: set_extra_try_arguments 06:27:07 INFO - ##### 06:27:07 INFO - ##### Running populate-webroot step. 06:27:07 INFO - ##### 06:27:07 INFO - Running pre-action listener: _resource_record_pre_action 06:27:07 INFO - Running main action method: populate_webroot 06:27:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:27:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:27:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:27:07 INFO - '--tppagecycles', 06:27:07 INFO - '7'], 06:27:07 INFO - 'tests': ['tsvgm']}}, 06:27:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:27:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:27:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:27:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:27:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'tests': ['damp', 'tps']}, 06:27:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['damp', 'tps']}, 06:27:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:27:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:27:07 INFO - 'other': {'tests': ['a11yr', 06:27:07 INFO - 'ts_paint', 06:27:07 INFO - 'tpaint', 06:27:07 INFO - 'sessionrestore', 06:27:07 INFO - 'sessionrestore_no_auto_restore', 06:27:07 INFO - 'tabpaint']}, 06:27:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['a11yr', 06:27:07 INFO - 'ts_paint', 06:27:07 INFO - 'tpaint', 06:27:07 INFO - 'sessionrestore', 06:27:07 INFO - 'sessionrestore_no_auto_restore', 06:27:07 INFO - 'tabpaint']}, 06:27:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['a11yr', 06:27:07 INFO - 'ts_paint', 06:27:07 INFO - 'tpaint', 06:27:07 INFO - 'sessionrestore', 06:27:07 INFO - 'sessionrestore_no_auto_restore', 06:27:07 INFO - 'tabpaint']}, 06:27:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['a11yr', 06:27:07 INFO - 'ts_paint', 06:27:07 INFO - 'tpaint', 06:27:07 INFO - 'sessionrestore', 06:27:07 INFO - 'sessionrestore_no_auto_restore', 06:27:07 INFO - 'tabpaint']}, 06:27:07 INFO - 'other_l64': {'tests': ['a11yr', 06:27:07 INFO - 'ts_paint', 06:27:07 INFO - 'tpaint', 06:27:07 INFO - 'sessionrestore', 06:27:07 INFO - 'sessionrestore_no_auto_restore', 06:27:07 INFO - 'tabpaint']}, 06:27:07 INFO - 'other_nol64': {'tests': ['a11yr', 06:27:07 INFO - 'ts_paint', 06:27:07 INFO - 'tpaint', 06:27:07 INFO - 'sessionrestore', 06:27:07 INFO - 'sessionrestore_no_auto_restore', 06:27:07 INFO - 'tabpaint']}, 06:27:07 INFO - 'svgr': {'tests': ['tsvgx', 06:27:07 INFO - 'tsvgr_opacity', 06:27:07 INFO - 'tart', 06:27:07 INFO - 'tscrollx', 06:27:07 INFO - 'cart']}, 06:27:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['tsvgx', 06:27:07 INFO - 'tsvgr_opacity', 06:27:07 INFO - 'tart', 06:27:07 INFO - 'tscrollx', 06:27:07 INFO - 'cart']}, 06:27:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'tests': ['tp5o']}, 06:27:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'talos_options': ['--e10s'], 06:27:07 INFO - 'tests': ['tp5o']}, 06:27:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'talos_options': ['--xperf_path', 06:27:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:07 INFO - 'tests': ['tp5n']}, 06:27:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:07 INFO - 'talos_options': ['--e10s', 06:27:07 INFO - '--xperf_path', 06:27:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:07 INFO - 'tests': ['tp5n']}}, 06:27:07 INFO - 'talos.zip': {'path': '', 06:27:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:27:07 INFO - Running post-action listener: _resource_record_post_action 06:27:07 INFO - ##### 06:27:07 INFO - ##### Running create-virtualenv step. 06:27:07 INFO - ##### 06:27:07 INFO - Running pre-action listener: _resource_record_pre_action 06:27:07 INFO - Running main action method: create_virtualenv 06:27:07 INFO - Creating virtualenv /builds/slave/test/build/venv 06:27:07 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:27:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:27:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:27:07 INFO - Using real prefix '/usr' 06:27:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:27:07 INFO - Installing distribute.............................................................................................................................................................................................done. 06:27:09 INFO - Installing pip.................done. 06:27:09 INFO - Return code: 0 06:27:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:27:09 INFO - Using env: {'DISPLAY': ':0', 06:27:09 INFO - 'HOME': '/home/cltbld', 06:27:09 INFO - 'LANG': 'en_US.UTF-8', 06:27:09 INFO - 'LANGUAGE': 'en_US:en', 06:27:09 INFO - 'LOGNAME': 'cltbld', 06:27:09 INFO - 'MAIL': '/var/mail/cltbld', 06:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:09 INFO - 'MOZ_NO_REMOTE': '1', 06:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:09 INFO - 'NO_EM_RESTART': '1', 06:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:09 INFO - 'PWD': '/builds/slave/test', 06:27:09 INFO - 'SHELL': '/bin/bash', 06:27:09 INFO - 'SHLVL': '1', 06:27:09 INFO - 'TERM': 'linux', 06:27:09 INFO - 'TMOUT': '86400', 06:27:09 INFO - 'USER': 'cltbld', 06:27:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:09 INFO - '_': '/tools/buildbot/bin/python'} 06:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:10 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:27:10 INFO - Cleaning up... 06:27:10 INFO - Return code: 0 06:27:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:27: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:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:10 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:10 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:27:10 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:27:10 INFO - Using env: {'DISPLAY': ':0', 06:27:10 INFO - 'HOME': '/home/cltbld', 06:27:10 INFO - 'LANG': 'en_US.UTF-8', 06:27:10 INFO - 'LANGUAGE': 'en_US:en', 06:27:10 INFO - 'LOGNAME': 'cltbld', 06:27:10 INFO - 'MAIL': '/var/mail/cltbld', 06:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:10 INFO - 'MOZ_NO_REMOTE': '1', 06:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:10 INFO - 'NO_EM_RESTART': '1', 06:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:10 INFO - 'PWD': '/builds/slave/test', 06:27:10 INFO - 'SHELL': '/bin/bash', 06:27:10 INFO - 'SHLVL': '1', 06:27:10 INFO - 'TERM': 'linux', 06:27:10 INFO - 'TMOUT': '86400', 06:27:10 INFO - 'USER': 'cltbld', 06:27:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:10 INFO - '_': '/tools/buildbot/bin/python'} 06:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:10 INFO - Downloading/unpacking psutil>=0.7.1 06:27:10 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:27:10 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:27:10 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:27:10 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:27:10 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:27:10 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:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:27:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:12 INFO - Installing collected packages: psutil 06:27:12 INFO - Running setup.py install for psutil 06:27:12 INFO - building 'psutil._psutil_linux' extension 06:27:12 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:27:12 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:27:12 INFO - building 'psutil._psutil_posix' extension 06:27:12 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:27:12 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:27:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:12 INFO - Successfully installed psutil 06:27:12 INFO - Cleaning up... 06:27:12 INFO - Return code: 0 06:27:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:27:12 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:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:12 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:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:12 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:12 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:27:12 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:27:12 INFO - Using env: {'DISPLAY': ':0', 06:27:12 INFO - 'HOME': '/home/cltbld', 06:27:12 INFO - 'LANG': 'en_US.UTF-8', 06:27:12 INFO - 'LANGUAGE': 'en_US:en', 06:27:12 INFO - 'LOGNAME': 'cltbld', 06:27:12 INFO - 'MAIL': '/var/mail/cltbld', 06:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:12 INFO - 'MOZ_NO_REMOTE': '1', 06:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:12 INFO - 'NO_EM_RESTART': '1', 06:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:12 INFO - 'PWD': '/builds/slave/test', 06:27:12 INFO - 'SHELL': '/bin/bash', 06:27:12 INFO - 'SHLVL': '1', 06:27:12 INFO - 'TERM': 'linux', 06:27:12 INFO - 'TMOUT': '86400', 06:27:12 INFO - 'USER': 'cltbld', 06:27:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:12 INFO - '_': '/tools/buildbot/bin/python'} 06:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:27:14 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:27:14 INFO - Installing collected packages: mozsystemmonitor 06:27:14 INFO - Running setup.py install for mozsystemmonitor 06:27:15 INFO - Successfully installed mozsystemmonitor 06:27:15 INFO - Cleaning up... 06:27:15 INFO - Return code: 0 06:27:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:27:15 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:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:15 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:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:15 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:15 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:27:15 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:27:15 INFO - Using env: {'DISPLAY': ':0', 06:27:15 INFO - 'HOME': '/home/cltbld', 06:27:15 INFO - 'LANG': 'en_US.UTF-8', 06:27:15 INFO - 'LANGUAGE': 'en_US:en', 06:27:15 INFO - 'LOGNAME': 'cltbld', 06:27:15 INFO - 'MAIL': '/var/mail/cltbld', 06:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:15 INFO - 'MOZ_NO_REMOTE': '1', 06:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:15 INFO - 'NO_EM_RESTART': '1', 06:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:15 INFO - 'PWD': '/builds/slave/test', 06:27:15 INFO - 'SHELL': '/bin/bash', 06:27:15 INFO - 'SHLVL': '1', 06:27:15 INFO - 'TERM': 'linux', 06:27:15 INFO - 'TMOUT': '86400', 06:27:15 INFO - 'USER': 'cltbld', 06:27:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:15 INFO - '_': '/tools/buildbot/bin/python'} 06:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:15 INFO - Downloading/unpacking blobuploader==1.2.4 06:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:17 INFO - Downloading blobuploader-1.2.4.tar.gz 06:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:27:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:27:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:17 INFO - Downloading docopt-0.6.1.tar.gz 06:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:27:17 INFO - Installing collected packages: blobuploader, requests, docopt 06:27:17 INFO - Running setup.py install for blobuploader 06:27:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:27:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:27:18 INFO - Running setup.py install for requests 06:27:18 INFO - Running setup.py install for docopt 06:27:18 INFO - Successfully installed blobuploader requests docopt 06:27:18 INFO - Cleaning up... 06:27:18 INFO - Return code: 0 06:27:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:18 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:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:18 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:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:18 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:18 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:27:18 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:27:18 INFO - Using env: {'DISPLAY': ':0', 06:27:18 INFO - 'HOME': '/home/cltbld', 06:27:18 INFO - 'LANG': 'en_US.UTF-8', 06:27:18 INFO - 'LANGUAGE': 'en_US:en', 06:27:18 INFO - 'LOGNAME': 'cltbld', 06:27:18 INFO - 'MAIL': '/var/mail/cltbld', 06:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:18 INFO - 'MOZ_NO_REMOTE': '1', 06:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:18 INFO - 'NO_EM_RESTART': '1', 06:27:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:18 INFO - 'PWD': '/builds/slave/test', 06:27:18 INFO - 'SHELL': '/bin/bash', 06:27:18 INFO - 'SHLVL': '1', 06:27:18 INFO - 'TERM': 'linux', 06:27:18 INFO - 'TMOUT': '86400', 06:27:18 INFO - 'USER': 'cltbld', 06:27:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:18 INFO - '_': '/tools/buildbot/bin/python'} 06:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:18 INFO - Running setup.py (path:/tmp/pip-Jmw_6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:18 INFO - Running setup.py (path:/tmp/pip-sfIRI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:18 INFO - Running setup.py (path:/tmp/pip-3HwGnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:19 INFO - Running setup.py (path:/tmp/pip-9uh1k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:19 INFO - Running setup.py (path:/tmp/pip-lZGQxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:19 INFO - Running setup.py (path:/tmp/pip-cxXxkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:19 INFO - Running setup.py (path:/tmp/pip-BTbcG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:19 INFO - Running setup.py (path:/tmp/pip-b9T9HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:19 INFO - Running setup.py (path:/tmp/pip-ImuRDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:19 INFO - Running setup.py (path:/tmp/pip-DYKfDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:19 INFO - Running setup.py (path:/tmp/pip-OvvWXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:19 INFO - Running setup.py (path:/tmp/pip-QSWszI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:19 INFO - Running setup.py (path:/tmp/pip-qfcJOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:19 INFO - Running setup.py (path:/tmp/pip-w7nWZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:19 INFO - Running setup.py (path:/tmp/pip-Rj61cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:19 INFO - Running setup.py (path:/tmp/pip-MxxzVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:19 INFO - Running setup.py (path:/tmp/pip-fk2Oej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:20 INFO - Running setup.py install for manifestparser 06:27:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Running setup.py install for mozcrash 06:27:20 INFO - Running setup.py install for mozdebug 06:27:20 INFO - Running setup.py install for mozdevice 06:27:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Running setup.py install for mozfile 06:27:20 INFO - Running setup.py install for mozhttpd 06:27:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Running setup.py install for mozinfo 06:27:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Running setup.py install for mozInstall 06:27:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:20 INFO - Running setup.py install for mozleak 06:27:20 INFO - Running setup.py install for mozlog 06:27:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:21 INFO - Running setup.py install for moznetwork 06:27:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:21 INFO - Running setup.py install for mozprocess 06:27:21 INFO - Running setup.py install for mozprofile 06:27:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:21 INFO - Running setup.py install for mozrunner 06:27:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:21 INFO - Running setup.py install for mozscreenshot 06:27:21 INFO - Running setup.py install for moztest 06:27:21 INFO - Running setup.py install for mozversion 06:27:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:21 INFO - Cleaning up... 06:27:21 INFO - Return code: 0 06:27:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:21 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:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:21 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:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:21 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:21 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:27:21 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:27:21 INFO - Using env: {'DISPLAY': ':0', 06:27:21 INFO - 'HOME': '/home/cltbld', 06:27:21 INFO - 'LANG': 'en_US.UTF-8', 06:27:21 INFO - 'LANGUAGE': 'en_US:en', 06:27:21 INFO - 'LOGNAME': 'cltbld', 06:27:21 INFO - 'MAIL': '/var/mail/cltbld', 06:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:21 INFO - 'MOZ_NO_REMOTE': '1', 06:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:21 INFO - 'NO_EM_RESTART': '1', 06:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:21 INFO - 'PWD': '/builds/slave/test', 06:27:21 INFO - 'SHELL': '/bin/bash', 06:27:21 INFO - 'SHLVL': '1', 06:27:21 INFO - 'TERM': 'linux', 06:27:21 INFO - 'TMOUT': '86400', 06:27:21 INFO - 'USER': 'cltbld', 06:27:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:21 INFO - '_': '/tools/buildbot/bin/python'} 06:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:22 INFO - Running setup.py (path:/tmp/pip-QSf7lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:22 INFO - Running setup.py (path:/tmp/pip-idssq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:22 INFO - Running setup.py (path:/tmp/pip-hebZM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:22 INFO - Running setup.py (path:/tmp/pip-LVxyKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:22 INFO - Running setup.py (path:/tmp/pip-iOlMl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:22 INFO - Running setup.py (path:/tmp/pip-ZKsU1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:22 INFO - Running setup.py (path:/tmp/pip-N1YrIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:22 INFO - Running setup.py (path:/tmp/pip-0KHFuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:22 INFO - Running setup.py (path:/tmp/pip-YITiGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:22 INFO - Running setup.py (path:/tmp/pip-NpbSUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:22 INFO - Running setup.py (path:/tmp/pip-2AUXEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:22 INFO - Running setup.py (path:/tmp/pip-a38PqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:22 INFO - Running setup.py (path:/tmp/pip-CHSWi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:22 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:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:22 INFO - Running setup.py (path:/tmp/pip-OwCZsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:23 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:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:23 INFO - Running setup.py (path:/tmp/pip-AhY9Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:23 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:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:23 INFO - Running setup.py (path:/tmp/pip-a1XwCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:23 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:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:23 INFO - Running setup.py (path:/tmp/pip-Hii_Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:23 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:27:23 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:27:23 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:27:23 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:27:23 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:27:23 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:27:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27:23 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:27:23 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:27:23 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:27:23 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:27:23 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:27:23 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:27:25 INFO - Downloading blessings-1.6.tar.gz 06:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:27:25 INFO - Installing collected packages: blessings 06:27:25 INFO - Running setup.py install for blessings 06:27:25 INFO - Successfully installed blessings 06:27:25 INFO - Cleaning up... 06:27:25 INFO - Return code: 0 06:27:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:27:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:25 INFO - Reading from file tmpfile_stdout 06:27:25 INFO - Current package versions: 06:27:25 INFO - argparse == 1.2.1 06:27:25 INFO - blessings == 1.6 06:27:25 INFO - blobuploader == 1.2.4 06:27:25 INFO - docopt == 0.6.1 06:27:25 INFO - manifestparser == 1.1 06:27:25 INFO - mozInstall == 1.12 06:27:25 INFO - mozcrash == 0.17 06:27:25 INFO - mozdebug == 0.1 06:27:25 INFO - mozdevice == 0.48 06:27:25 INFO - mozfile == 1.2 06:27:25 INFO - mozhttpd == 0.7 06:27:25 INFO - mozinfo == 0.9 06:27:25 INFO - mozleak == 0.1 06:27:25 INFO - mozlog == 3.1 06:27:25 INFO - moznetwork == 0.27 06:27:25 INFO - mozprocess == 0.22 06:27:25 INFO - mozprofile == 0.28 06:27:25 INFO - mozrunner == 6.11 06:27:25 INFO - mozscreenshot == 0.1 06:27:25 INFO - mozsystemmonitor == 0.0 06:27:25 INFO - moztest == 0.7 06:27:25 INFO - mozversion == 1.4 06:27:25 INFO - psutil == 3.1.1 06:27:25 INFO - requests == 1.2.3 06:27:25 INFO - wsgiref == 0.1.2 06:27:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:25 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:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:25 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:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:25 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:25 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:27:25 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:27:25 INFO - Using env: {'DISPLAY': ':0', 06:27:25 INFO - 'HOME': '/home/cltbld', 06:27:25 INFO - 'LANG': 'en_US.UTF-8', 06:27:25 INFO - 'LANGUAGE': 'en_US:en', 06:27:25 INFO - 'LOGNAME': 'cltbld', 06:27:25 INFO - 'MAIL': '/var/mail/cltbld', 06:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:25 INFO - 'MOZ_NO_REMOTE': '1', 06:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:25 INFO - 'NO_EM_RESTART': '1', 06:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:25 INFO - 'PWD': '/builds/slave/test', 06:27:25 INFO - 'SHELL': '/bin/bash', 06:27:25 INFO - 'SHLVL': '1', 06:27:25 INFO - 'TERM': 'linux', 06:27:25 INFO - 'TMOUT': '86400', 06:27:25 INFO - 'USER': 'cltbld', 06:27:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:25 INFO - '_': '/tools/buildbot/bin/python'} 06:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 INFO - Cleaning up... 06:27:25 INFO - Return code: 0 06:27:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:27:25 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:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:25 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:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:25 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:25 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:27:25 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:27:25 INFO - Using env: {'DISPLAY': ':0', 06:27:25 INFO - 'HOME': '/home/cltbld', 06:27:25 INFO - 'LANG': 'en_US.UTF-8', 06:27:25 INFO - 'LANGUAGE': 'en_US:en', 06:27:25 INFO - 'LOGNAME': 'cltbld', 06:27:25 INFO - 'MAIL': '/var/mail/cltbld', 06:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:25 INFO - 'MOZ_NO_REMOTE': '1', 06:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:25 INFO - 'NO_EM_RESTART': '1', 06:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:25 INFO - 'PWD': '/builds/slave/test', 06:27:25 INFO - 'SHELL': '/bin/bash', 06:27:25 INFO - 'SHLVL': '1', 06:27:25 INFO - 'TERM': 'linux', 06:27:25 INFO - 'TMOUT': '86400', 06:27:25 INFO - 'USER': 'cltbld', 06:27:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:25 INFO - '_': '/tools/buildbot/bin/python'} 06:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:25 INFO - Downloading/unpacking jsonschema 06:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:27:27 INFO - Downloading/unpacking functools32 (from jsonschema) 06:27:27 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:27:27 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:27:27 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:27:27 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:27:27 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:27:27 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:27:28 INFO - Downloading functools32-3.2.3-2.tar.gz 06:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:27:28 INFO - warning: no files found matching '*.txt' 06:27:28 INFO - no previously-included directories found matching 'build' 06:27:28 INFO - no previously-included directories found matching 'dist' 06:27:28 INFO - no previously-included directories found matching '.git*' 06:27:28 INFO - Installing collected packages: jsonschema, functools32 06:27:28 INFO - Running setup.py install for functools32 06:27:28 INFO - warning: no files found matching '*.txt' 06:27:28 INFO - no previously-included directories found matching 'build' 06:27:28 INFO - no previously-included directories found matching 'dist' 06:27:28 INFO - no previously-included directories found matching '.git*' 06:27:28 INFO - Successfully installed jsonschema functools32 06:27:28 INFO - Cleaning up... 06:27:28 INFO - Return code: 0 06:27:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:28 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 0x7f3171f3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c13410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, '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': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', '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:27:28 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:27:28 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:27:28 INFO - Using env: {'DISPLAY': ':0', 06:27:28 INFO - 'HOME': '/home/cltbld', 06:27:28 INFO - 'LANG': 'en_US.UTF-8', 06:27:28 INFO - 'LANGUAGE': 'en_US:en', 06:27:28 INFO - 'LOGNAME': 'cltbld', 06:27:28 INFO - 'MAIL': '/var/mail/cltbld', 06:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:28 INFO - 'MOZ_NO_REMOTE': '1', 06:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:28 INFO - 'NO_EM_RESTART': '1', 06:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:28 INFO - 'PWD': '/builds/slave/test', 06:27:28 INFO - 'SHELL': '/bin/bash', 06:27:28 INFO - 'SHLVL': '1', 06:27:28 INFO - 'TERM': 'linux', 06:27:28 INFO - 'TMOUT': '86400', 06:27:28 INFO - 'USER': 'cltbld', 06:27:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:28 INFO - '_': '/tools/buildbot/bin/python'} 06:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:28 INFO - Downloading/unpacking flake8 06:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:27:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:27:30 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:27:30 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:27:30 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:27:30 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:27:30 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:27:30 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:27:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:27:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:27:30 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:27:30 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:27:30 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:27:30 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:27:30 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:27:30 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:27:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:27:30 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:27:30 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:27:30 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:27:30 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:27:30 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:27:30 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:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:27:31 INFO - no previously-included directories found matching 'docs/_build' 06:27:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:27:31 INFO - Running setup.py install for pep8 06:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:27:31 INFO - no previously-included directories found matching 'docs/_build' 06:27:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:27:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:27:31 INFO - Cleaning up... 06:27:31 INFO - Return code: 0 06:27:31 INFO - Running post-action listener: _resource_record_post_action 06:27:31 INFO - Running post-action listener: _start_resource_monitoring 06:27:31 INFO - Starting resource monitoring. 06:27:31 INFO - ##### 06:27:31 INFO - ##### Running install step. 06:27:31 INFO - ##### 06:27:31 INFO - Running pre-action listener: _resource_record_pre_action 06:27:31 INFO - Running main action method: install 06:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:31 INFO - Reading from file tmpfile_stdout 06:27:31 INFO - Detecting whether we're running mozinstall >=1.0... 06:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:27:31 INFO - Reading from file tmpfile_stdout 06:27:31 INFO - Output received: 06:27:31 INFO - Usage: mozinstall [options] installer 06:27:31 INFO - Options: 06:27:31 INFO - -h, --help show this help message and exit 06:27:31 INFO - -d DEST, --destination=DEST 06:27:31 INFO - Directory to install application into. [default: 06:27:31 INFO - "/builds/slave/test"] 06:27:31 INFO - --app=APP Application being installed. [default: firefox] 06:27:31 INFO - mkdir: /builds/slave/test/build/application 06:27:31 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:27:31 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:27:44 INFO - Reading from file tmpfile_stdout 06:27:44 INFO - Output received: 06:27:44 INFO - /builds/slave/test/build/application/firefox/firefox 06:27:44 INFO - Running post-action listener: _resource_record_post_action 06:27:44 INFO - ##### 06:27:44 INFO - ##### Running run-tests step. 06:27:44 INFO - ##### 06:27:44 INFO - Running pre-action listener: _resource_record_pre_action 06:27:44 INFO - Running main action method: run_tests 06:27:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:27:44 INFO - Python 2.7.3 06:27:44 INFO - Return code: 0 06:27:44 INFO - grabbing minidump binary from tooltool 06:27: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:27:44 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 0x1ca2160>, '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 0x1ca3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca34f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:27:44 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:27:44 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:27:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:27:44 INFO - Return code: 0 06:27:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:27:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:27:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:27:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:27:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:27:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:27:45 INFO - Return code: 0 06:27:45 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', '--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-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:27:45 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 --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-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:27:45 INFO - Using env: {'DISPLAY': ':0', 06:27:45 INFO - 'HOME': '/home/cltbld', 06:27:45 INFO - 'LANG': 'en_US.UTF-8', 06:27:45 INFO - 'LANGUAGE': 'en_US:en', 06:27:45 INFO - 'LOGNAME': 'cltbld', 06:27:45 INFO - 'MAIL': '/var/mail/cltbld', 06:27:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:27:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:45 INFO - 'MOZ_NO_REMOTE': '1', 06:27:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:45 INFO - 'NO_EM_RESTART': '1', 06:27:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:45 INFO - 'PWD': '/builds/slave/test', 06:27:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:27:45 INFO - 'SHELL': '/bin/bash', 06:27:45 INFO - 'SHLVL': '1', 06:27:45 INFO - 'TERM': 'linux', 06:27:45 INFO - 'TMOUT': '86400', 06:27:45 INFO - 'USER': 'cltbld', 06:27:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889', 06:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:45 INFO - '_': '/tools/buildbot/bin/python'} 06:27:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--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-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:27:45 INFO - mozversion application_buildid: 20160602140837 06:27:45 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:27:45 INFO - mozversion application_display_name: Firefox 06:27:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:27:45 INFO - mozversion application_name: Firefox 06:27:45 INFO - mozversion application_remotingname: firefox 06:27:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:27:45 INFO - mozversion application_vendor: Mozilla 06:27:45 INFO - mozversion application_version: 47.0 06:27:45 INFO - mozversion platform_buildid: 20160602140837 06:27:45 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:27:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:27:45 INFO - mozversion platform_version: 47.0 06:27:45 INFO - using testdate: 1465219665 06:27:45 INFO - actual date: 1465219665 06:27:45 INFO - starting webserver on 'localhost:45451' 06:27:45 INFO - SUITE-START | Running 2 tests 06:27:45 INFO - TEST-START | dromaeo_css 06:27:45 INFO - operating with platform_type : linux_ 06:27:45 INFO - Initialising browser for dromaeo_css test... 06:27:45 INFO - TEST-INFO | started process 5311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aRDKg/profile http://localhost:45451/getInfo.html) 06:27:49 INFO - PROCESS | 5311 | __metrics Screen width/height:1600/1200 06:27:49 INFO - PROCESS | 5311 | colorDepth:24 06:27:49 INFO - PROCESS | 5311 | Browser inner width/height: 1024/697 06:27:49 INFO - PROCESS | 5311 | __metrics 06:27:51 INFO - PROCESS | 5311 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:27:52 INFO - TEST-INFO | 5311: exit 0 06:27:52 INFO - Browser initialized. 06:27:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:27:52 INFO - TEST-INFO | started process 5407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aRDKg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:03 INFO - PROCESS | 5407 | RSS: Main: 139190272 06:28:03 INFO - PROCESS | 5407 | 06:28:55 INFO - PROCESS | 5407 | 1465219735323 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:31:02 INFO - PROCESS | 5407 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45451/tests/dromaeo/cssquery-ext.html) 06:31:03 INFO - PROCESS | 5407 | RSS: Main: 255836160 06:31:03 INFO - PROCESS | 5407 | 06:34:06 INFO - PROCESS | 5407 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-ext.html (next: http://localhost:45451/tests/dromaeo/cssquery-jquery.html) 06:34:06 INFO - PROCESS | 5407 | RSS: Main: 227815424 06:34:06 INFO - PROCESS | 5407 | 06:37:08 INFO - PROCESS | 5407 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45451/tests/dromaeo/cssquery-mootools.html) 06:37:09 INFO - PROCESS | 5407 | RSS: Main: 243781632 06:37:09 INFO - PROCESS | 5407 | 06:40:10 INFO - PROCESS | 5407 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45451/tests/dromaeo/cssquery-prototype.html) 06:40:11 INFO - PROCESS | 5407 | RSS: Main: 210305024 06:40:11 INFO - PROCESS | 5407 | 06:43:13 INFO - PROCESS | 5407 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45451/tests/dromaeo/cssquery-yui.html) 06:43:14 INFO - PROCESS | 5407 | RSS: Main: 213536768 06:43:14 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-yui.html (next: http://localhost:45451/tests/dromaeo/cssquery-dojo.html) 06:46:16 INFO - PROCESS | 5407 | RSS: Main: 255623168 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | __start_tp_report 06:46:16 INFO - PROCESS | 5407 | _x_x_mozilla_page_load 06:46:16 INFO - PROCESS | 5407 | _x_x_mozilla_page_load_details 06:46:16 INFO - PROCESS | 5407 | |i|pagename|runs| 06:46:16 INFO - PROCESS | 5407 | |0;dojo.html;3289.35857507786;3316.6683331666836;3328.3676101540705;3345.4312766829635;3356.88250911218;5273.156294992802;5288.814891478799;5291.6824990500545;5292.232626269189;5292.708901010443;5315.415304316522;5318.547923426513;5322.574194064475;5325.121354976434;5326.094563924133;4814.855554333358;4877.536634019772;4901.362822833027;4977.626677999165;4984.975075124619;4796.592289655384;4870.902581948359;4871.342368780222;4874.805007799701;4875.317455556207;4898.436679781835;4964.677295975768;4965.478624744404;4973.602111831045;5004.299398084271;4781.115493633689;4976.104301225778;4979.57673597741;4981.476944920785;4991.401031876162;4814.638902082323;4844.15227335215;4863.148948933923;4879.804807807719;4897.094037603055;5126.333576635051;5194.428612852583;5201.375834899798;5210.921836172461;5229.346331708536;5808;5819.359870414251;5824.796132135355;5831.300243970708;5834.066549352126;5687.175359572881;5803.44867237616;5843.298804143487;5863.882722345572;5864.325602555676;5409.864753381157;5478.506934375925;5482.753276102585;5506.146547285177;5516.338039435253;5900.734466948998;5901.114832775118;5904.380040095814;5906.822795316148;5907.054871220584;5569.053260945649;5707.4577915098;5712.6286791358425;5720.485156335866;5727.198192253088;5721.771129154788;5733.77064917407;5759.625624334489;5764.798232061941;5784.768609255667;5700.087985922232;5708;5709.086546152679;5709.486146246858;5719.3136823581435;5625.128105143709;5651.717027520019;5679.602427830095;5695.658260504383;5705.115707065412;4342.34864770287;4353.673474489426;4363.2364336241035;4367.30123180296;4372.453443319585;3921.686265098785;3954.248692748426;3975.403689446606;3976.681865450757;4001.3197756381487;5475.206095116186;5486.506214440719;5493.121100623881;5494.725263736797;5522.779088836482;5607.52336051432;5810.941890581124;5819;5829.562782791308;5837.737301821428;5361.383440904346;5499;5528.115501519818;5546.833594992157;5552.7778888843995;4998.575121114746;5007.048660754445;5039.244113383022;5048.29323894655;5050.3939527256225;5895.911561326584;5971.671558064349;6043.788467403708;6061.727222275008;6077.6353418795015;5846.795362162389;5896.823095307148;5897.115432685132;5897.705114744332;5900.1149827526215;6056.66688332146;6076.665783381956;6083.726232319645;6086.452219300284;6090.9390906090375;5634.830955071355;5736.053551164011;5768.94231057684;5801.9709901451915;5818;5859.794907178229;5867.442592953663;5875.294964604275;5876.324222714443;5880.558958078247;5689.118186681071;5716.171155182558;5717;5717.17101020358;5717.42825717425;5569.415211402745;5648.350439699487;5697.54419646419;5733.168690539932;5751.166080918327;5575.1915972183;5576.693281869536;5588.636738611977;5596.608237423341;5602;5722.713864306851;5738.885222295614;5751.396103409082;5751.683657398716;5760.6255593386295;5325.2810870531985;5518.310211223597;5539.335279766454;5554.250176226158;5635.211070450222 06:46:16 INFO - PROCESS | 5407 | |1;ext.html;524.9475052494751;533.4398881174768;558.5001423725765;562.7045800954501;567.3135506037694;40428.59571404285;41833;41925.790371048104;41941.370879436836;41943.370849437284;46082.769586152106;46714.29928551066;46726;46753.29870051952;46774.76612616941;8842.469451832878;9044.095590440937;9076.8638470423;9094.86357704635;9103.499307538083;8872.645094196225;9048.049954754755;9052.547372631376;9277.768055798591;9303.209227215695;9220.815583688322;9291.163795258426;9306.58120384581;9314.022027687097;9314.115159059878;9238.307126965505;9330.346875718702;9335.579898904565;9338;9338.439693618404;9160.35877488576;9292.814143717156;9304.581293841793;9307.813843723088;9316.720498385059;44846.327305090446;45030.32454513152;45560.3165952511;45587.77206113981;45591;3524.823758812049;3781.149241420686;3910.335243008695;4171.228322760268;4270.466191726035;33262.168445788804;33542.99371018873;33598;34732.652673473196;36350;3635.1275693833554;3734.831932563014;3750.9812450937843;3757.6618104370737;3838.884833454973;313699;314099;314926;315677;315738;46007.07985840264;46820;47004.29493557599;69749;70296.29703702897;45192;45246.77376613096;45559.31661025087;45575;45616.5438345619;17361.218745156497;17380.0440975745;17382.130893455276;17383.043932583576;17385.130743462778;14197.858021419861;14287.64280892986;14291.785623215661;14299.213543255013;14299.714005719827;15860.52418427449;16027.19864006795;16052.75920861188;16087.597810054842;16098.195090245676;5798.362180160179;5865.4134586541;5922.378150294157;5997.100434934795;6068.238951277158;1003.3879333606494;1073.2755390111643;1090.6782499162766;1165.6736113888126;1212.587720175127;31141.377172456876;31989.680103199134;33902.830485847415;35552.644473555454;35679;1066.9626563070256;1097.4183682648209;1105.209775010871;1116.748731535398;1138.6014894786758;15537.84462155364;15538.145402002998;15569.766453503207;15584.766228506354;15840.287187076608;322777;325482;326709;326958;328364;53844.73077634587;55131.44868551263;55162.448375516535;55317.44682553203;55328;1353.803698463737;1439.820022497188;1501.459474589147;1504.1125735815922;1510.909345439277;28329.150125496268;28559.42881142324;29127;29132.854335728185;31409.371812564077;48690;49578.25632615441;49652.75173624109;49666.255006175656;49761.25358119559;253794;254253;254337;255799;303409;34685.306293874484;34898.65101348954;35251.29497409986;35278.82360588181;35658.64341356553;40312.79843600881;41562.58437415708;52199.21701174409;54562;57486.13770793358;39820.40269396019;39977.80011099926;40360.1927961445;40575.59424405718;40729.796351018056;38963;39444.816219298045;40109.59890401176;40267;40688.59311406966;39492.2101557973;40268.79865600653;40403.59596403998;40612;40730.38904416377;33928.491072633435;35754.10614734548;36104.27791444209;36219;36360;27500.449990999667;27774.583381248893;27775.861120694266;27839;27888.811397828522 06:46:16 INFO - PROCESS | 5407 | |2;jquery.html;362.2555648143066;363.75446573562846;365.78053168099143;370.31861375069866;379.0372453966924;17432.73850892236;18233.635327293447;19720.112594933227;19735.99999999998;19754.91347975861;18317.542061448472;18796.71804922924;18909.054547272615;18924.526886827836;18934.337298194565;5469.398366179727;5719.656820590757;5733.713314334287;5735.913961290584;5738.167965644979;4261.083866968601;4416.8012439440145;5612.270404847364;5885.7939972100985;6151.384861513835;6044.607100538473;6045.546584006195;6092.786752463665;6094.116353128794;6095.3599872013465;5887.646741195521;6038.607490513103;6149.754009839623;6151.784687535915;6160.784372546939;3843.327417701891;5230.607704422184;5401.3248343957;5408;5437.510624043855;20321;20370.388888333226;20498.18007279707;20810.16759329625;20923.05846236923;2240.988795056014;2375.9881200593886;2585.4958283134797;2626.290901456596;2769.210774929156;13444.661080434806;13896.652583685387;13971.09187902783;14096;14216.431342746278;1854.619802940394;1931.169597073272;1941.805819418061;1981.0589969764392;2009.095906841927;65895;66441.66779166121;66543.99999999952;67622.32377676209;68274.31725682729;9613.663521776703;9810.950945245371;9883.11052005323;9932.652357167464;10004.649837255662;14258.643533911736;14342.856571434151;14351.354189061518;14357.856421435861;14364.138151710931;8331.875021874677;8350.874736878952;8364.330853531703;8486.74539763808;8525.872111918326;8651.48091114535;8655;8659.870101948476;8742;8761.56192190388;5849.824505264849;5922.733476993546;5953.523718102541;5995.280566332068;6052.394760523913;1647.7981148072367;1745.8428741413334;1752.8422441980028;1808.6563552924902;1812.0939530234882;996.2279233593878;1021.0810270756231;1022.9335093218917;1088.0262165361958;1115.827046807746;16480.587985300222;16759.497215083567;16773.6645267094;17005.149742512825;17152.22814973329;1030.0317701360698;1051.1800795379615;1062.8990245926625;1066.195022757813;1075.7471994081384;10117.696469105938;10425.218108641882;10460;10495.118549511824;10611.57553697859;403869;404579;404612;408830;429729;67201.6639916807;67408.6629566849;68477;70698.64650676714;71705.64147179335;1049.2655141400896;1055.693848783844;1069.1820757120809;1069.4278560969844;1075.6772968109535;15991.200439977722;16017.439389621308;16090.195490225677;16167.353305867633;16184.271707773414;31829.20426989251;32571.022869313958;32761.017169484952;33997;34625.13437164091;43597.34603980879;44643.10713785771;44896.77551612221;44920.77539612281;44993;8291.170882911661;8309.293710034715;8324.542150181798;8500.489970601784;8611;8915.465072095694;9488.905110948803;12397.93801030989;13150.868491314965;13760.105593136414;11449.65651030437;11555.653330400102;11776.234544754563;11786.233894796811;11817.113716471127;10862.402567858528;11179.552817887194;11189.608363707232;11415.143864210051;11758.941205293919;11300.378479183724;11466.197366184288;11500.309981401142;11517.42412879336;11746.35395053246;8421.5789210538;8444.619992100494;8567.657293708182;8571.357148214034;8722.694705685271;10941.343519388862;11197.776044478902;11255.831162532404;11335.206535542433;11810.822837657613 06:46:16 INFO - PROCESS | 5407 | |3;mootools.html;1414.7594908865492;1551.1778757258653;1577.0852905314919;1774.5281889638113;1873.2413372584108;7977.8803317950205;8158.102608713051;8179.386546009058;8181.713640022593;8182.263596276334;8118.51288922665;8239;8243.58782060896;8300.626471808768;8325.75022749317;2309.6997390339234;2342.121704360865;2342.203650758742;2343.027643527934;2359.8230132740027;2233.966490502644;2268.3648578397992;2271.5797577448143;2284.7486776454575;2285.051703543036;2352.9176478823247;2379.8334116611845;2379.881005949704;2389.438481956739;2391.0555330644384;2269.614165591845;2287.2452090809993;2289.038603786397;2292.64464008079;2319.130326127702;2436.914707985212;2456.3736247257016;2460.3726049857173;2460.458699086198;2460.6555082288496;8396.202360775716;8448.831023379498;8456.661733530651;8457.915420845837;8472.534010629475;4951.752412379366;5100.642954993152;5176.352955880515;5185.196294574347;5189.117849965515;3181.459151944175;3193.7924034937655;3197.7921435106878;3246.9675303247136;3286.9342613147605;1015.2791518022213;1018.1498448795265;1044.4255659387381;1050.3592808386877;1064.6007747094839;12094.939525302405;12140.514379424812;12149.392530373447;12154.878451215463;12155;4436.889077773017;4474.507804141542;4524.298733696282;4549.340345649863;4558.2251017327135;10221.642242521477;10232.693019209435;10246.948765256126;10282.177425805918;10283.331583447052;5051.646384753106;5065.898682026339;5107.795688172506;5107.974460127675;5121.052605268037;4072.450219220427;4564.1556312082375;4633.976830115827;4668.743219122913;4671.15919134559;3863;3948.223299515172;3948.842046318115;3979.8607048753156;4014.0968282136287;1234.8024316109559;1239.5475651387178;1243.4280231093617;1252.0234217310513;1264.8861602455638;1112.944352782374;1123.3540714089268;1126.9887301126885;1320.5642138094406;1405.5221224783418;7814;7891.053073631201;7891.658418068942;7921.683132674629;7934.682612695543;493.80988319497254;497.472678960296;497.62926619667854;500.28209519339134;507.8958813443235;5730.684812335361;5778.508826749773;5782.7686892523825;5787.797427090031;5791.189233507313;9881.50592470388;10346.172306215485;10368.066873981377;10378.688639340831;10447.268691191544;10175.84736228957;10197.031282028343;10227.181825454094;10247.128994035442;10355.119814815826;7855.6464959076975;8017;8017.158198389202;8115.918840811634;8123.6750529978135;7700.075990881131;7707.92292077072;7808.843823123392;7823.100343460347;7875.330596899328;8850;9006.50464224474;9089.909100909172;9240.907590924005;9331.58007889633;9242.12199841014;9290.535473226177;9320.580573874056;9532.428054316762;9815;6513.902291465726;6989.895151572832;7150.284971502808;7279.490435669664;7390.113186417664;7865.370770338473;7874.094479134744;7887.132415434183;7941.245581669732;7982.241687039722;6739.393454589111;6898.206706228848;6947.062146610143;7022.08712867324;7038.964805176146;7136.250693677297;7144.535605185646;7193.928060719535;7277.672504737406;7300.014498042697;7375.741849035258;7389.519681220703;7550.471466997477;7562.168161502341;7566.659500322608;6918.654067296716;6979.825504362431;6986.860262794614;6996.650167491707;7006.474514411338;6926;6942.340477654615;7094.716211351488;7118.644067796693;7135.143782746104 06:46:16 INFO - PROCESS | 5407 | |4;prototype.html;323.12272181028516;323.3339320998741;327.7525468271455;329.36597050677454;332.070203430395;5983.311919129302;5986.730597123129;6014.699265036742;6030.185924900137;6039.18471006414;5858.619189752663;5908.793192238272;5927;5947.762089516425;5998.670073145986;4368.912621747563;4506.616937560311;4594.632429405639;4606.884827879297;4640.67515273931;4591.816327346902;4618.053299073698;4627;4633.1660301145785;4640.373549570799;4571.1771881061395;4573;4575.130725162225;4577.862664120082;4586.4266966629175;4376.2997920332755;4482.910341793146;4562.201614717411;4562.4753153387455;4584.88537786558;4015.31739604268;4021.477207962975;4022.45696830927;4029.730634850013;4037.9596204037875;5677.687727175004;5681.545476361881;5681.829545113653;5691.573132015074;5693.373728889819;5309.283246761676;5315.309009828737;5318.22885681574;5324.307839980816;5326.387465441485;6289.622622642656;6307.590006649553;6308.179936608258;6314.242290925118;6322.399372059647;4342.717723347972;4417.867463976086;4444.644428445717;4458.799354029076;4469.150861336336;6504.577202481823;6525.11910892033;6548.770793022269;6557.180352455943;6563.835904102436;4550.795214215368;4555.293929440942;4560.293154561048;4565.178267911741;4577.427821522309;4619.69971951822;4620.353150558924;4620.607248383858;4624.630029597624;4628.83799067031;5298.549623281987;5300.602454815904;5305.973470132624;5307.336582927134;5315.920261196085;6189.535784816157;6332.68336583169;6344.714487848058;6357.904631430532;6359.7456101755415;1612.8629066529243;1624.350259896051;1635.247786018445;1637.4841924793652;1641.2778377513855;1035.3115178406276;1068.7167900506372;1092.3882625729616;1100.7688385438987;1116.8380584815156;6019;6022.789202377983;6029.638221706711;6093.390660933871;6101.359357267423;6431.453326467209;6483.513736469784;6502.804915852532;6511.934880651228;6523.902141467882;6139.539534534839;6142.723577439026;6143.38566143391;6145.938540614626;6151.569390142647;3503.737219708532;3532.1699400640828;3532.2229109595846;3537.893863184109;3538.929221415557;6693.899591506131;6772.864542709118;6912.654367281616;6915.273896240923;6919.169699636076;6755.695993680296;6762.053312536249;6768.898466523006;6783.59298442095;6804.625745583941;6864.828379290558;6872;6874.175098988154;6888.311168883171;6893.138357705287;6625.370589793962;6630.900536492053;6633.701483433354;6641.070250165078;6644.634545100066;6368.331325210786;6521.9673901630185;6527.836804079936;6558.934410655832;6560.606363618198;6884.586924784328;6903.5167538271835;6903.585784852925;6924.169099708067;6926.168859736864;4498.91002179948;4528.90942181148;4535.523770004102;4536.6143877770755;4540.341650460731;6634.436072933855;6639.402453779183;6642.667866606554;6646.235682896336;6649.63427011519;6336.398042185985;6374.235091789015;6449;6451.806445806634;6461.321561236191;6416.615003099829;6439.613623182437;6447.516436267392;6448.613083215022;6455.61266324022;6301.267151533365;6312.873742525216;6315.526335524946;6316.526260530571;6321.178246828067;6453.806385808433;6461.709223085067;6469.805905822833;6471.158749362553;6477.611343319228;6093.6039157454625;6149.692515374303;6291.905621415774;6325;6327.810165695037 06:46:16 INFO - PROCESS | 5407 | |5;yui.html;657.6415853359919;659.8581305019421;716.0440811516625;746.3059354800034;795.2762985683022;14634.853651463482;14868.553943381703;15910.443134490295;15949.122798246091;16024.75962860558;15013.249337533134;15063.472778452757;15142.772858407132;15146.545603631908;15162.317695703692;758.4387553210639;915.1489115122916;921.6175287255815;928.6285485805664;928.9814203715922;774.6630215856093;778.6106946526737;778.7079845058104;910.9043550427209;932.5849996751448;1005.4319309590095;1006.6879267427121;1007.0936157458273;1009.1926458832941;1012.7468132966758;996.8654231678739;1001.7946321004176;1002.6490728245093;1002.7543251903294;1003.307717674802;592.7984485275027;701.1165930927068;711.7366574367466;711.7508871894847;711.7580022792224;15251.466198683103;15685.215739213108;15699;15731.685366292724;15734.763978540332;13988.160710357412;14294.64263393413;14408.351624176938;14510.347034383372;14568.05307654999;11078.169137314653;11335.022606449065;11335.716607084807;11396.772064558745;11404.03065739413;3855.074782052315;3876.030992251937;3882.9611703882883;3883.7087218458446;3908.9609103908883;47874.76062619699;48602;49867;49940.500594994315;50780.49219507832;10678.57285708563;10754.892451075546;11006;11159.442027898573;11248.212625116163;20170.798292017185;20455.386338409873;20524.692129618066;20537.58924821495;20564.691529627067;8294.3779216559;8365.07984121746;8384.706535271358;8526.147385261424;8624;4484.955150448519;4489.551044895485;4617.815287388534;4765.1660959331975;4998.350214472095;3348.68187522185;3356;3397.38847007541;3401.370746411872;3413.8975830725117;588.4997751910842;591.9052951527735;598.7006496751624;599.7181324777434;600.1477901380051;599.286848650105;651.4009103676298;662.0069895157264;667.4860357524776;677.3463607618671;8143.226393492609;8199.508029518249;8338.583070846555;8340.165163663984;8346.123657016047;636.7580319478568;648.9026646003043;652.3411354531956;664.4617859533793;674.3896773420063;3725.720570957189;3787.0532366908274;3850.3454412749898;3873.573906870242;3912.8239229234755;57388.55668659894;58292;58602;59286;59540.70229648911;49107.263391049164;51271.48728512742;51512.22731659028;51691.22463163055;52790.20814687783;46925.530744692114;47699.5230047702;47729;48084.7595762019;48264;7311.7980181675575;7313.158986716596;7406.7037318506655;7490.101187857492;7525.360344370571;33894.3221135571;34545.30909381848;34774.82612586921;36098.45852312165;37645.435318469696;42059.7897010513;45213.54786452094;45435.545644543134;45548.77225613851;46272.537274626826;10738.785224295627;10828.404437755999;10953.521274628141;11024.944875275572;11144.387058711525;12187.146899716934;12340.382980850742;12396.442160102997;12527.436265368262;12994.545190918272;10420.426876521864;11266.380349080879;11274.492647830702;11561.768764624829;11784.70538236551;11091.33451992883;12221;12431.316277604457;12460.065495087723;12669;11904.821427678418;11934.28394296345;12022.699432514257;12191.146619736533;12413.689657758629;9526.428414295164;9673.70978870635;9683.915332866021;9866.506674666382;10070.748231294276;9866.802663946824;10015.248856335658;10193.84709229377;10228.59085636596;10308.742281442725 06:46:16 INFO - PROCESS | 5407 | __end_tp_report 06:46:16 INFO - PROCESS | 5407 | __start_cc_report 06:46:16 INFO - PROCESS | 5407 | _x_x_mozilla_cycle_collect,890 06:46:16 INFO - PROCESS | 5407 | __end_cc_report 06:46:16 INFO - PROCESS | 5407 | __startTimestamp1465220776731__endTimestamp 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | ------- Summary: start ------- 06:46:16 INFO - PROCESS | 5407 | Number of tests: 6 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | [#0] dojo.html Cycles:165 Average:5377.80 Median:5576.69 stddev:600.31 (10.8%) stddev-sans-first:579.36 06:46:16 INFO - PROCESS | 5407 | Values: 3289.4 3316.7 3328.4 3345.4 3356.9 5273.2 5288.8 5291.7 5292.2 5292.7 5315.4 5318.5 5322.6 5325.1 5326.1 4814.9 4877.5 4901.4 4977.6 4985.0 4796.6 4870.9 4871.3 4874.8 4875.3 4898.4 4964.7 4965.5 4973.6 5004.3 4781.1 4976.1 4979.6 4981.5 4991.4 4814.6 4844.2 4863.1 4879.8 4897.1 5126.3 5194.4 5201.4 5210.9 5229.3 5808.0 5819.4 5824.8 5831.3 5834.1 5687.2 5803.4 5843.3 5863.9 5864.3 5409.9 5478.5 5482.8 5506.1 5516.3 5900.7 5901.1 5904.4 5906.8 5907.1 5569.1 5707.5 5712.6 5720.5 5727.2 5721.8 5733.8 5759.6 5764.8 5784.8 5700.1 5708.0 5709.1 5709.5 5719.3 5625.1 5651.7 5679.6 5695.7 5705.1 4342.3 4353.7 4363.2 4367.3 4372.5 3921.7 3954.2 3975.4 3976.7 4001.3 5475.2 5486.5 5493.1 5494.7 5522.8 5607.5 5810.9 5819.0 5829.6 5837.7 5361.4 5499.0 5528.1 5546.8 5552.8 4998.6 5007.0 5039.2 5048.3 5050.4 5895.9 5971.7 6043.8 6061.7 6077.6 5846.8 5896.8 5897.1 5897.7 5900.1 6056.7 6076.7 6083.7 6086.5 6090.9 5634.8 5736.1 5768.9 5802.0 5818.0 5859.8 5867.4 5875.3 5876.3 5880.6 5689.1 5716.2 5717.0 5717.2 5717.4 5569.4 5648.4 5697.5 5733.2 5751.2 5575.2 5576.7 5588.6 5596.6 5602.0 5722.7 5738.9 5751.4 5751.7 5760.6 5325.3 5518.3 5539.3 5554.3 5635.2 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | [#1] ext.html Cycles:180 Average:48258.32 Median:39656.31 stddev:79077.05 (199.4%) stddev-sans-first:79217.66 06:46:16 INFO - PROCESS | 5407 | Values: 524.9 533.4 558.5 562.7 567.3 40428.6 41833.0 41925.8 41941.4 41943.4 46082.8 46714.3 46726.0 46753.3 46774.8 8842.5 9044.1 9076.9 9094.9 9103.5 8872.6 9048.0 9052.5 9277.8 9303.2 9220.8 9291.2 9306.6 9314.0 9314.1 9238.3 9330.3 9335.6 9338.0 9338.4 9160.4 9292.8 9304.6 9307.8 9316.7 44846.3 45030.3 45560.3 45587.8 45591.0 3524.8 3781.1 3910.3 4171.2 4270.5 33262.2 33543.0 33598.0 34732.7 36350.0 3635.1 3734.8 3751.0 3757.7 3838.9 313699.0 314099.0 314926.0 315677.0 315738.0 46007.1 46820.0 47004.3 69749.0 70296.3 45192.0 45246.8 45559.3 45575.0 45616.5 17361.2 17380.0 17382.1 17383.0 17385.1 14197.9 14287.6 14291.8 14299.2 14299.7 15860.5 16027.2 16052.8 16087.6 16098.2 5798.4 5865.4 5922.4 5997.1 6068.2 1003.4 1073.3 1090.7 1165.7 1212.6 31141.4 31989.7 33902.8 35552.6 35679.0 1067.0 1097.4 1105.2 1116.7 1138.6 15537.8 15538.1 15569.8 15584.8 15840.3 322777.0 325482.0 326709.0 326958.0 328364.0 53844.7 55131.4 55162.4 55317.4 55328.0 1353.8 1439.8 1501.5 1504.1 1510.9 28329.2 28559.4 29127.0 29132.9 31409.4 48690.0 49578.3 49652.8 49666.3 49761.3 253794.0 254253.0 254337.0 255799.0 303409.0 34685.3 34898.7 35251.3 35278.8 35658.6 40312.8 41562.6 52199.2 54562.0 57486.1 39820.4 39977.8 40360.2 40575.6 40729.8 38963.0 39444.8 40109.6 40267.0 40688.6 39492.2 40268.8 40403.6 40612.0 40730.4 33928.5 35754.1 36104.3 36219.0 36360.0 27500.4 27774.6 27775.9 27839.0 27888.8 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | [#2] jquery.html Cycles:180 Average:24977.24 Median:2605.89 stddev:67228.65 (2579.9%) stddev-sans-first:67391.84 06:46:16 INFO - PROCESS | 5407 | Values: 362.3 363.8 365.8 370.3 379.0 17432.7 18233.6 19720.1 19736.0 19754.9 18317.5 18796.7 18909.1 18924.5 18934.3 5469.4 5719.7 5733.7 5735.9 5738.2 4261.1 4416.8 5612.3 5885.8 6151.4 6044.6 6045.5 6092.8 6094.1 6095.4 5887.6 6038.6 6149.8 6151.8 6160.8 3843.3 5230.6 5401.3 5408.0 5437.5 20321.0 20370.4 20498.2 20810.2 20923.1 2241.0 2376.0 2585.5 2626.3 2769.2 13444.7 13896.7 13971.1 14096.0 14216.4 1854.6 1931.2 1941.8 1981.1 2009.1 65895.0 66441.7 66544.0 67622.3 68274.3 9613.7 9811.0 9883.1 9932.7 10004.6 14258.6 14342.9 14351.4 14357.9 14364.1 8331.9 8350.9 8364.3 8486.7 8525.9 8651.5 8655.0 8659.9 8742.0 8761.6 5849.8 5922.7 5953.5 5995.3 6052.4 1647.8 1745.8 1752.8 1808.7 1812.1 996.2 1021.1 1022.9 1088.0 1115.8 16480.6 16759.5 16773.7 17005.1 17152.2 1030.0 1051.2 1062.9 1066.2 1075.7 10117.7 10425.2 10460.0 10495.1 10611.6 403869.0 404579.0 404612.0 408830.0 429729.0 67201.7 67408.7 68477.0 70698.6 71705.6 1049.3 1055.7 1069.2 1069.4 1075.7 15991.2 16017.4 16090.2 16167.4 16184.3 31829.2 32571.0 32761.0 33997.0 34625.1 43597.3 44643.1 44896.8 44920.8 44993.0 8291.2 8309.3 8324.5 8500.5 8611.0 8915.5 9488.9 12397.9 13150.9 13760.1 11449.7 11555.7 11776.2 11786.2 11817.1 10862.4 11179.6 11189.6 11415.1 11758.9 11300.4 11466.2 11500.3 11517.4 11746.4 8421.6 8444.6 8567.7 8571.4 8722.7 10941.3 11197.8 11255.8 11335.2 11810.8 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | [#3] mootools.html Cycles:180 Average:5838.21 Median:2786.90 stddev:3148.74 (113.0%) stddev-sans-first:3140.02 06:46:16 INFO - PROCESS | 5407 | Values: 1414.8 1551.2 1577.1 1774.5 1873.2 7977.9 8158.1 8179.4 8181.7 8182.3 8118.5 8239.0 8243.6 8300.6 8325.8 2309.7 2342.1 2342.2 2343.0 2359.8 2234.0 2268.4 2271.6 2284.7 2285.1 2352.9 2379.8 2379.9 2389.4 2391.1 2269.6 2287.2 2289.0 2292.6 2319.1 2436.9 2456.4 2460.4 2460.5 2460.7 8396.2 8448.8 8456.7 8457.9 8472.5 4951.8 5100.6 5176.4 5185.2 5189.1 3181.5 3193.8 3197.8 3247.0 3286.9 1015.3 1018.1 1044.4 1050.4 1064.6 12094.9 12140.5 12149.4 12154.9 12155.0 4436.9 4474.5 4524.3 4549.3 4558.2 10221.6 10232.7 10246.9 10282.2 10283.3 5051.6 5065.9 5107.8 5108.0 5121.1 4072.5 4564.2 4634.0 4668.7 4671.2 3863.0 3948.2 3948.8 3979.9 4014.1 1234.8 1239.5 1243.4 1252.0 1264.9 1112.9 1123.4 1127.0 1320.6 1405.5 7814.0 7891.1 7891.7 7921.7 7934.7 493.8 497.5 497.6 500.3 507.9 5730.7 5778.5 5782.8 5787.8 5791.2 9881.5 10346.2 10368.1 10378.7 10447.3 10175.8 10197.0 10227.2 10247.1 10355.1 7855.6 8017.0 8017.2 8115.9 8123.7 7700.1 7707.9 7808.8 7823.1 7875.3 8850.0 9006.5 9089.9 9240.9 9331.6 9242.1 9290.5 9320.6 9532.4 9815.0 6513.9 6989.9 7150.3 7279.5 7390.1 7865.4 7874.1 7887.1 7941.2 7982.2 6739.4 6898.2 6947.1 7022.1 7039.0 7136.3 7144.5 7193.9 7277.7 7300.0 7375.7 7389.5 7550.5 7562.2 7566.7 6918.7 6979.8 6986.9 6996.7 7006.5 6926.0 6942.3 7094.7 7118.6 7135.1 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | [#4] prototype.html Cycles:180 Average:5337.67 Median:6029.91 stddev:1612.70 (26.7%) stddev-sans-first:1572.69 06:46:16 INFO - PROCESS | 5407 | Values: 323.1 323.3 327.8 329.4 332.1 5983.3 5986.7 6014.7 6030.2 6039.2 5858.6 5908.8 5927.0 5947.8 5998.7 4368.9 4506.6 4594.6 4606.9 4640.7 4591.8 4618.1 4627.0 4633.2 4640.4 4571.2 4573.0 4575.1 4577.9 4586.4 4376.3 4482.9 4562.2 4562.5 4584.9 4015.3 4021.5 4022.5 4029.7 4038.0 5677.7 5681.5 5681.8 5691.6 5693.4 5309.3 5315.3 5318.2 5324.3 5326.4 6289.6 6307.6 6308.2 6314.2 6322.4 4342.7 4417.9 4444.6 4458.8 4469.2 6504.6 6525.1 6548.8 6557.2 6563.8 4550.8 4555.3 4560.3 4565.2 4577.4 4619.7 4620.4 4620.6 4624.6 4628.8 5298.5 5300.6 5306.0 5307.3 5315.9 6189.5 6332.7 6344.7 6357.9 6359.7 1612.9 1624.4 1635.2 1637.5 1641.3 1035.3 1068.7 1092.4 1100.8 1116.8 6019.0 6022.8 6029.6 6093.4 6101.4 6431.5 6483.5 6502.8 6511.9 6523.9 6139.5 6142.7 6143.4 6145.9 6151.6 3503.7 3532.2 3532.2 3537.9 3538.9 6693.9 6772.9 6912.7 6915.3 6919.2 6755.7 6762.1 6768.9 6783.6 6804.6 6864.8 6872.0 6874.2 6888.3 6893.1 6625.4 6630.9 6633.7 6641.1 6644.6 6368.3 6522.0 6527.8 6558.9 6560.6 6884.6 6903.5 6903.6 6924.2 6926.2 4498.9 4528.9 4535.5 4536.6 4540.3 6634.4 6639.4 6642.7 6646.2 6649.6 6336.4 6374.2 6449.0 6451.8 6461.3 6416.6 6439.6 6447.5 6448.6 6455.6 6301.3 6312.9 6315.5 6316.5 6321.2 6453.8 6461.7 6469.8 6471.2 6477.6 6093.6 6149.7 6291.9 6325.0 6327.8 06:46:16 INFO - PROCESS | 5407 | 06:46:16 INFO - PROCESS | 5407 | [#5] yui.html Cycles:180 Average:14344.59 Median:3883.33 stddev:16202.89 (417.2%) stddev-sans-first:16215.74 06:46:16 INFO - PROCESS | 5407 | Values: 657.6 659.9 716.0 746.3 795.3 14634.9 14868.6 15910.4 15949.1 16024.8 15013.2 15063.5 15142.8 15146.5 15162.3 758.4 915.1 921.6 928.6 929.0 774.7 778.6 778.7 910.9 932.6 1005.4 1006.7 1007.1 1009.2 1012.7 996.9 1001.8 1002.6 1002.8 1003.3 592.8 701.1 711.7 711.8 711.8 15251.5 15685.2 15699.0 15731.7 15734.8 13988.2 14294.6 14408.4 14510.3 14568.1 11078.2 11335.0 11335.7 11396.8 11404.0 3855.1 3876.0 3883.0 3883.7 3909.0 47874.8 48602.0 49867.0 49940.5 50780.5 10678.6 10754.9 11006.0 11159.4 11248.2 20170.8 20455.4 20524.7 20537.6 20564.7 8294.4 8365.1 8384.7 8526.1 8624.0 4485.0 4489.6 4617.8 4765.2 4998.4 3348.7 3356.0 3397.4 3401.4 3413.9 588.5 591.9 598.7 599.7 600.1 599.3 651.4 662.0 667.5 677.3 8143.2 8199.5 8338.6 8340.2 8346.1 636.8 648.9 652.3 664.5 674.4 3725.7 3787.1 3850.3 3873.6 3912.8 57388.6 58292.0 58602.0 59286.0 59540.7 49107.3 51271.5 51512.2 51691.2 52790.2 46925.5 47699.5 47729.0 48084.8 48264.0 7311.8 7313.2 7406.7 7490.1 7525.4 33894.3 34545.3 34774.8 36098.5 37645.4 42059.8 45213.5 45435.5 45548.8 46272.5 10738.8 10828.4 10953.5 11024.9 11144.4 12187.1 12340.4 12396.4 12527.4 12994.5 10420.4 11266.4 11274.5 11561.8 11784.7 11091.3 12221.0 12431.3 12460.1 12669.0 11904.8 11934.3 12022.7 12191.1 12413.7 9526.4 9673.7 9683.9 9866.5 10070.7 9866.8 10015.2 10193.8 10228.6 10308.7 06:46:16 INFO - PROCESS | 5407 | -------- Summary: end -------- 06:46:16 INFO - PROCESS | 5407 | 06:46:17 INFO - TEST-INFO | 5407: exit 0 06:46:17 INFO - TEST-OK | dromaeo_css | took 1111709ms 06:46:17 INFO - TEST-START | kraken 06:46:17 INFO - operating with platform_type : linux_ 06:46:17 INFO - Initialising browser for kraken test... 06:46:17 INFO - TEST-INFO | started process 5598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppbSOZy/profile http://localhost:45451/getInfo.html) 06:46:21 INFO - PROCESS | 5598 | __metrics Screen width/height:1600/1200 06:46:21 INFO - PROCESS | 5598 | colorDepth:24 06:46:21 INFO - PROCESS | 5598 | Browser inner width/height: 1024/697 06:46:21 INFO - PROCESS | 5598 | __metrics 06:46:23 INFO - PROCESS | 5598 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:46:24 INFO - TEST-INFO | 5598: exit 0 06:46:24 INFO - Browser initialized. 06:46:24 INFO - Running cycle 1/1 for kraken test... 06:46:24 INFO - TEST-INFO | started process 5689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppbSOZy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:35 INFO - PROCESS | 5689 | RSS: Main: 139132928 06:46:35 INFO - PROCESS | 5689 | 06:46:38 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-beat-detection) 06:46:38 INFO - PROCESS | 5689 | RSS: Main: 183455744 06:46:38 INFO - PROCESS | 5689 | 06:46:41 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-dft) 06:46:42 INFO - PROCESS | 5689 | RSS: Main: 174804992 06:46:42 INFO - PROCESS | 5689 | 06:46:44 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-fft) 06:46:45 INFO - PROCESS | 5689 | RSS: Main: 175427584 06:46:45 INFO - PROCESS | 5689 | 06:46:47 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-oscillator) 06:46:48 INFO - PROCESS | 5689 | RSS: Main: 175681536 06:46:48 INFO - PROCESS | 5689 | 06:46:50 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:46:50 INFO - PROCESS | 5689 | RSS: Main: 175501312 06:46:50 INFO - PROCESS | 5689 | 06:46:53 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45451/tests/kraken/driver.html?testName=imaging-darkroom) 06:46:54 INFO - PROCESS | 5689 | RSS: Main: 174333952 06:46:54 INFO - PROCESS | 5689 | 06:46:57 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45451/tests/kraken/driver.html?testName=imaging-desaturate) 06:46:58 INFO - PROCESS | 5689 | RSS: Main: 174157824 06:46:58 INFO - PROCESS | 5689 | 06:47:01 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45451/tests/kraken/driver.html?testName=json-parse-financial) 06:47:01 INFO - PROCESS | 5689 | RSS: Main: 175382528 06:47:01 INFO - PROCESS | 5689 | 06:47:03 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:47:03 INFO - PROCESS | 5689 | RSS: Main: 183173120 06:47:03 INFO - PROCESS | 5689 | 06:47:05 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:47:06 INFO - PROCESS | 5689 | RSS: Main: 182558720 06:47:06 INFO - PROCESS | 5689 | 06:47:08 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:47:08 INFO - PROCESS | 5689 | RSS: Main: 184901632 06:47:08 INFO - PROCESS | 5689 | 06:47:11 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:47:11 INFO - PROCESS | 5689 | RSS: Main: 188137472 06:47:11 INFO - PROCESS | 5689 | 06:47:14 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:47:14 INFO - PROCESS | 5689 | RSS: Main: 184754176 06:47:14 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45451/tests/kraken/driver.html?testName=ai-astar) 06:47:16 INFO - PROCESS | 5689 | RSS: Main: 246669312 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | __start_tp_report 06:47:16 INFO - PROCESS | 5689 | _x_x_mozilla_page_load 06:47:16 INFO - PROCESS | 5689 | _x_x_mozilla_page_load_details 06:47:16 INFO - PROCESS | 5689 | |i|pagename|runs| 06:47:16 INFO - PROCESS | 5689 | |0;ai-astar;110;110;110;110;110;111;110;110;110;124 06:47:16 INFO - PROCESS | 5689 | |1;audio-beat-detection;150;128;152;173;126;164;164;130;179;128 06:47:16 INFO - PROCESS | 5689 | |2;audio-dft;161;162;162;160;161;162;161;162;162;161 06:47:16 INFO - PROCESS | 5689 | |3;audio-fft;76;77;76;166;74;77;75;73;161;76 06:47:16 INFO - PROCESS | 5689 | |4;audio-oscillator;94;93;148;93;93;93;141;92;93;135 06:47:16 INFO - PROCESS | 5689 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;118;118;117 06:47:16 INFO - PROCESS | 5689 | |6;imaging-darkroom;147;146;146;147;147;146;145;145;145;146 06:47:16 INFO - PROCESS | 5689 | |7;imaging-desaturate;96;95;96;96;96;95;95;96;96;95 06:47:16 INFO - PROCESS | 5689 | |8;json-parse-financial;55;53;54;54;54;53;55;53;70;52 06:47:16 INFO - PROCESS | 5689 | |9;json-stringify-tinderbox;64;64;66;65;66;66;65;64;65;65 06:47:16 INFO - PROCESS | 5689 | |10;stanford-crypto-aes;78;80;80;80;80;80;80;95;80;80 06:47:16 INFO - PROCESS | 5689 | |11;stanford-crypto-ccm;112;122;111;113;112;113;113;115;116;115 06:47:16 INFO - PROCESS | 5689 | |12;stanford-crypto-pbkdf2;141;137;157;146;147;135;134;145;147;145 06:47:16 INFO - PROCESS | 5689 | |13;stanford-crypto-sha256-iterative;66;72;73;67;67;69;66;67;71;65 06:47:16 INFO - PROCESS | 5689 | __end_tp_report 06:47:16 INFO - PROCESS | 5689 | __start_cc_report 06:47:16 INFO - PROCESS | 5689 | _x_x_mozilla_cycle_collect,1046 06:47:16 INFO - PROCESS | 5689 | __end_cc_report 06:47:16 INFO - PROCESS | 5689 | __startTimestamp1465220836788__endTimestamp 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | ------- Summary: start ------- 06:47:16 INFO - PROCESS | 5689 | Number of tests: 14 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#0] ai-astar Cycles:10 Average:111.50 Median:110.00 stddev:4.40 (4.0%) stddev-sans-first:4.64 06:47:16 INFO - PROCESS | 5689 | Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 124.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:158.00 stddev:20.29 (12.8%) stddev-sans-first:21.52 06:47:16 INFO - PROCESS | 5689 | Values: 150.0 128.0 152.0 173.0 126.0 164.0 164.0 130.0 179.0 128.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 06:47:16 INFO - PROCESS | 5689 | Values: 161.0 162.0 162.0 160.0 161.0 162.0 161.0 162.0 162.0 161.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:37.14 (48.9%) stddev-sans-first:38.88 06:47:16 INFO - PROCESS | 5689 | Values: 76.0 77.0 76.0 166.0 74.0 77.0 75.0 73.0 161.0 76.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:93.00 stddev:23.55 (25.3%) stddev-sans-first:24.47 06:47:16 INFO - PROCESS | 5689 | Values: 94.0 93.0 148.0 93.0 93.0 93.0 141.0 92.0 93.0 135.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 06:47:16 INFO - PROCESS | 5689 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 06:47:16 INFO - PROCESS | 5689 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 145.0 145.0 145.0 146.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:47:16 INFO - PROCESS | 5689 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:5.25 (9.7%) stddev-sans-first:5.57 06:47:16 INFO - PROCESS | 5689 | Values: 55.0 53.0 54.0 54.0 54.0 53.0 55.0 53.0 70.0 52.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 06:47:16 INFO - PROCESS | 5689 | Values: 64.0 64.0 66.0 65.0 66.0 66.0 65.0 64.0 65.0 65.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:4.85 (6.1%) stddev-sans-first:5.00 06:47:16 INFO - PROCESS | 5689 | Values: 78.0 80.0 80.0 80.0 80.0 80.0 80.0 95.0 80.0 80.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:3.24 06:47:16 INFO - PROCESS | 5689 | Values: 112.0 122.0 111.0 113.0 112.0 113.0 113.0 115.0 116.0 115.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:145.50 stddev:6.90 (4.7%) stddev-sans-first:7.26 06:47:16 INFO - PROCESS | 5689 | Values: 141.0 137.0 157.0 146.0 147.0 135.0 134.0 145.0 147.0 145.0 06:47:16 INFO - PROCESS | 5689 | 06:47:16 INFO - PROCESS | 5689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.79 (4.1%) stddev-sans-first:2.83 06:47:16 INFO - PROCESS | 5689 | Values: 66.0 72.0 73.0 67.0 67.0 69.0 66.0 67.0 71.0 65.0 06:47:16 INFO - PROCESS | 5689 | -------- Summary: end -------- 06:47:16 INFO - PROCESS | 5689 | 06:47:17 INFO - TEST-INFO | 5689: exit 0 06:47:17 INFO - TEST-OK | kraken | took 60272ms 06:47:17 INFO - SUITE-END | took 1171s 06:47:17 INFO - Completed test suite (00:19:32) 06:47:17 INFO - javascript benchmark 06:47:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3289.35857507786, 3316.6683331666836, 3328.3676101540705, 3345.4312766829635, 3356.88250911218, 5273.156294992802, 5288.814891478799, 5291.6824990500545, 5292.232626269189, 5292.708901010443, 5315.415304316522, 5318.547923426513, 5322.574194064475, 5325.121354976434, 5326.094563924133, 4814.855554333358, 4877.536634019772, 4901.362822833027, 4977.626677999165, 4984.975075124619, 4796.592289655384, 4870.902581948359, 4871.342368780222, 4874.805007799701, 4875.317455556207, 4898.436679781835, 4964.677295975768, 4965.478624744404, 4973.602111831045, 5004.299398084271, 4781.115493633689, 4976.104301225778, 4979.57673597741, 4981.476944920785, 4991.401031876162, 4814.638902082323, 4844.15227335215, 4863.148948933923, 4879.804807807719, 4897.094037603055, 5126.333576635051, 5194.428612852583, 5201.375834899798, 5210.921836172461, 5229.346331708536, 5808.0, 5819.359870414251, 5824.796132135355, 5831.300243970708, 5834.066549352126, 5687.175359572881, 5803.44867237616, 5843.298804143487, 5863.882722345572, 5864.325602555676, 5409.864753381157, 5478.506934375925, 5482.753276102585, 5506.146547285177, 5516.338039435253, 5900.734466948998, 5901.114832775118, 5904.380040095814, 5906.822795316148, 5907.054871220584, 5569.053260945649, 5707.4577915098, 5712.6286791358425, 5720.485156335866, 5727.198192253088, 5721.771129154788, 5733.77064917407, 5759.625624334489, 5764.798232061941, 5784.768609255667, 5700.087985922232, 5708.0, 5709.086546152679, 5709.486146246858, 5719.3136823581435, 5625.128105143709, 5651.717027520019, 5679.602427830095, 5695.658260504383, 5705.115707065412, 4342.34864770287, 4353.673474489426, 4363.2364336241035, 4367.30123180296, 4372.453443319585, 3921.686265098785, 3954.248692748426, 3975.403689446606, 3976.681865450757, 4001.3197756381487, 5475.206095116186, 5486.506214440719, 5493.121100623881, 5494.725263736797, 5522.779088836482, 5607.52336051432, 5810.941890581124, 5819.0, 5829.562782791308, 5837.737301821428, 5361.383440904346, 5499.0, 5528.115501519818, 5546.833594992157, 5552.7778888843995, 4998.575121114746, 5007.048660754445, 5039.244113383022, 5048.29323894655, 5050.3939527256225, 5895.911561326584, 5971.671558064349, 6043.788467403708, 6061.727222275008, 6077.6353418795015, 5846.795362162389, 5896.823095307148, 5897.115432685132, 5897.705114744332, 5900.1149827526215, 6056.66688332146, 6076.665783381956, 6083.726232319645, 6086.452219300284, 6090.9390906090375, 5634.830955071355, 5736.053551164011, 5768.94231057684, 5801.9709901451915, 5818.0, 5859.794907178229, 5867.442592953663, 5875.294964604275, 5876.324222714443, 5880.558958078247, 5689.118186681071, 5716.171155182558, 5717.0, 5717.17101020358, 5717.42825717425, 5569.415211402745, 5648.350439699487, 5697.54419646419, 5733.168690539932, 5751.166080918327, 5575.1915972183, 5576.693281869536, 5588.636738611977, 5596.608237423341, 5602.0, 5722.713864306851, 5738.885222295614, 5751.396103409082, 5751.683657398716, 5760.6255593386295, 5325.2810870531985, 5518.310211223597, 5539.335279766454, 5554.250176226158, 5635.211070450222], "unit": "score", "name": "dojo.html", "value": 5339.201463158304}, {"lowerIsBetter": false, "replicates": [524.9475052494751, 533.4398881174768, 558.5001423725765, 562.7045800954501, 567.3135506037694, 40428.59571404285, 41833.0, 41925.790371048104, 41941.370879436836, 41943.370849437284, 46082.769586152106, 46714.29928551066, 46726.0, 46753.29870051952, 46774.76612616941, 8842.469451832878, 9044.095590440937, 9076.8638470423, 9094.86357704635, 9103.499307538083, 8872.645094196225, 9048.049954754755, 9052.547372631376, 9277.768055798591, 9303.209227215695, 9220.815583688322, 9291.163795258426, 9306.58120384581, 9314.022027687097, 9314.115159059878, 9238.307126965505, 9330.346875718702, 9335.579898904565, 9338.0, 9338.439693618404, 9160.35877488576, 9292.814143717156, 9304.581293841793, 9307.813843723088, 9316.720498385059, 44846.327305090446, 45030.32454513152, 45560.3165952511, 45587.77206113981, 45591.0, 3524.823758812049, 3781.149241420686, 3910.335243008695, 4171.228322760268, 4270.466191726035, 33262.168445788804, 33542.99371018873, 33598.0, 34732.652673473196, 36350.0, 3635.1275693833554, 3734.831932563014, 3750.9812450937843, 3757.6618104370737, 3838.884833454973, 313699.0, 314099.0, 314926.0, 315677.0, 315738.0, 46007.07985840264, 46820.0, 47004.29493557599, 69749.0, 70296.29703702897, 45192.0, 45246.77376613096, 45559.31661025087, 45575.0, 45616.5438345619, 17361.218745156497, 17380.0440975745, 17382.130893455276, 17383.043932583576, 17385.130743462778, 14197.858021419861, 14287.64280892986, 14291.785623215661, 14299.213543255013, 14299.714005719827, 15860.52418427449, 16027.19864006795, 16052.75920861188, 16087.597810054842, 16098.195090245676, 5798.362180160179, 5865.4134586541, 5922.378150294157, 5997.100434934795, 6068.238951277158, 1003.3879333606494, 1073.2755390111643, 1090.6782499162766, 1165.6736113888126, 1212.587720175127, 31141.377172456876, 31989.680103199134, 33902.830485847415, 35552.644473555454, 35679.0, 1066.9626563070256, 1097.4183682648209, 1105.209775010871, 1116.748731535398, 1138.6014894786758, 15537.84462155364, 15538.145402002998, 15569.766453503207, 15584.766228506354, 15840.287187076608, 322777.0, 325482.0, 326709.0, 326958.0, 328364.0, 53844.73077634587, 55131.44868551263, 55162.448375516535, 55317.44682553203, 55328.0, 1353.803698463737, 1439.820022497188, 1501.459474589147, 1504.1125735815922, 1510.909345439277, 28329.150125496268, 28559.42881142324, 29127.0, 29132.854335728185, 31409.371812564077, 48690.0, 49578.25632615441, 49652.75173624109, 49666.255006175656, 49761.25358119559, 253794.0, 254253.0, 254337.0, 255799.0, 303409.0, 34685.306293874484, 34898.65101348954, 35251.29497409986, 35278.82360588181, 35658.64341356553, 40312.79843600881, 41562.58437415708, 52199.21701174409, 54562.0, 57486.13770793358, 39820.40269396019, 39977.80011099926, 40360.1927961445, 40575.59424405718, 40729.796351018056, 38963.0, 39444.816219298045, 40109.59890401176, 40267.0, 40688.59311406966, 39492.2101557973, 40268.79865600653, 40403.59596403998, 40612.0, 40730.38904416377, 33928.491072633435, 35754.10614734548, 36104.27791444209, 36219.0, 36360.0, 27500.449990999667, 27774.583381248893, 27775.861120694266, 27839.0, 27888.811397828522], "unit": "score", "name": "ext.html", "value": 19375.14919331419}, {"lowerIsBetter": false, "replicates": [362.2555648143066, 363.75446573562846, 365.78053168099143, 370.31861375069866, 379.0372453966924, 17432.73850892236, 18233.635327293447, 19720.112594933227, 19735.99999999998, 19754.91347975861, 18317.542061448472, 18796.71804922924, 18909.054547272615, 18924.526886827836, 18934.337298194565, 5469.398366179727, 5719.656820590757, 5733.713314334287, 5735.913961290584, 5738.167965644979, 4261.083866968601, 4416.8012439440145, 5612.270404847364, 5885.7939972100985, 6151.384861513835, 6044.607100538473, 6045.546584006195, 6092.786752463665, 6094.116353128794, 6095.3599872013465, 5887.646741195521, 6038.607490513103, 6149.754009839623, 6151.784687535915, 6160.784372546939, 3843.327417701891, 5230.607704422184, 5401.3248343957, 5408.0, 5437.510624043855, 20321.0, 20370.388888333226, 20498.18007279707, 20810.16759329625, 20923.05846236923, 2240.988795056014, 2375.9881200593886, 2585.4958283134797, 2626.290901456596, 2769.210774929156, 13444.661080434806, 13896.652583685387, 13971.09187902783, 14096.0, 14216.431342746278, 1854.619802940394, 1931.169597073272, 1941.805819418061, 1981.0589969764392, 2009.095906841927, 65895.0, 66441.66779166121, 66543.99999999952, 67622.32377676209, 68274.31725682729, 9613.663521776703, 9810.950945245371, 9883.11052005323, 9932.652357167464, 10004.649837255662, 14258.643533911736, 14342.856571434151, 14351.354189061518, 14357.856421435861, 14364.138151710931, 8331.875021874677, 8350.874736878952, 8364.330853531703, 8486.74539763808, 8525.872111918326, 8651.48091114535, 8655.0, 8659.870101948476, 8742.0, 8761.56192190388, 5849.824505264849, 5922.733476993546, 5953.523718102541, 5995.280566332068, 6052.394760523913, 1647.7981148072367, 1745.8428741413334, 1752.8422441980028, 1808.6563552924902, 1812.0939530234882, 996.2279233593878, 1021.0810270756231, 1022.9335093218917, 1088.0262165361958, 1115.827046807746, 16480.587985300222, 16759.497215083567, 16773.6645267094, 17005.149742512825, 17152.22814973329, 1030.0317701360698, 1051.1800795379615, 1062.8990245926625, 1066.195022757813, 1075.7471994081384, 10117.696469105938, 10425.218108641882, 10460.0, 10495.118549511824, 10611.57553697859, 403869.0, 404579.0, 404612.0, 408830.0, 429729.0, 67201.6639916807, 67408.6629566849, 68477.0, 70698.64650676714, 71705.64147179335, 1049.2655141400896, 1055.693848783844, 1069.1820757120809, 1069.4278560969844, 1075.6772968109535, 15991.200439977722, 16017.439389621308, 16090.195490225677, 16167.353305867633, 16184.271707773414, 31829.20426989251, 32571.022869313958, 32761.017169484952, 33997.0, 34625.13437164091, 43597.34603980879, 44643.10713785771, 44896.77551612221, 44920.77539612281, 44993.0, 8291.170882911661, 8309.293710034715, 8324.542150181798, 8500.489970601784, 8611.0, 8915.465072095694, 9488.905110948803, 12397.93801030989, 13150.868491314965, 13760.105593136414, 11449.65651030437, 11555.653330400102, 11776.234544754563, 11786.233894796811, 11817.113716471127, 10862.402567858528, 11179.552817887194, 11189.608363707232, 11415.143864210051, 11758.941205293919, 11300.378479183724, 11466.197366184288, 11500.309981401142, 11517.42412879336, 11746.35395053246, 8421.5789210538, 8444.619992100494, 8567.657293708182, 8571.357148214034, 8722.694705685271, 10941.343519388862, 11197.776044478902, 11255.831162532404, 11335.206535542433, 11810.822837657613], "unit": "score", "name": "jquery.html", "value": 8896.18179910734}, {"lowerIsBetter": false, "replicates": [1414.7594908865492, 1551.1778757258653, 1577.0852905314919, 1774.5281889638113, 1873.2413372584108, 7977.8803317950205, 8158.102608713051, 8179.386546009058, 8181.713640022593, 8182.263596276334, 8118.51288922665, 8239.0, 8243.58782060896, 8300.626471808768, 8325.75022749317, 2309.6997390339234, 2342.121704360865, 2342.203650758742, 2343.027643527934, 2359.8230132740027, 2233.966490502644, 2268.3648578397992, 2271.5797577448143, 2284.7486776454575, 2285.051703543036, 2352.9176478823247, 2379.8334116611845, 2379.881005949704, 2389.438481956739, 2391.0555330644384, 2269.614165591845, 2287.2452090809993, 2289.038603786397, 2292.64464008079, 2319.130326127702, 2436.914707985212, 2456.3736247257016, 2460.3726049857173, 2460.458699086198, 2460.6555082288496, 8396.202360775716, 8448.831023379498, 8456.661733530651, 8457.915420845837, 8472.534010629475, 4951.752412379366, 5100.642954993152, 5176.352955880515, 5185.196294574347, 5189.117849965515, 3181.459151944175, 3193.7924034937655, 3197.7921435106878, 3246.9675303247136, 3286.9342613147605, 1015.2791518022213, 1018.1498448795265, 1044.4255659387381, 1050.3592808386877, 1064.6007747094839, 12094.939525302405, 12140.514379424812, 12149.392530373447, 12154.878451215463, 12155.0, 4436.889077773017, 4474.507804141542, 4524.298733696282, 4549.340345649863, 4558.2251017327135, 10221.642242521477, 10232.693019209435, 10246.948765256126, 10282.177425805918, 10283.331583447052, 5051.646384753106, 5065.898682026339, 5107.795688172506, 5107.974460127675, 5121.052605268037, 4072.450219220427, 4564.1556312082375, 4633.976830115827, 4668.743219122913, 4671.15919134559, 3863.0, 3948.223299515172, 3948.842046318115, 3979.8607048753156, 4014.0968282136287, 1234.8024316109559, 1239.5475651387178, 1243.4280231093617, 1252.0234217310513, 1264.8861602455638, 1112.944352782374, 1123.3540714089268, 1126.9887301126885, 1320.5642138094406, 1405.5221224783418, 7814.0, 7891.053073631201, 7891.658418068942, 7921.683132674629, 7934.682612695543, 493.80988319497254, 497.472678960296, 497.62926619667854, 500.28209519339134, 507.8958813443235, 5730.684812335361, 5778.508826749773, 5782.7686892523825, 5787.797427090031, 5791.189233507313, 9881.50592470388, 10346.172306215485, 10368.066873981377, 10378.688639340831, 10447.268691191544, 10175.84736228957, 10197.031282028343, 10227.181825454094, 10247.128994035442, 10355.119814815826, 7855.6464959076975, 8017.0, 8017.158198389202, 8115.918840811634, 8123.6750529978135, 7700.075990881131, 7707.92292077072, 7808.843823123392, 7823.100343460347, 7875.330596899328, 8850.0, 9006.50464224474, 9089.909100909172, 9240.907590924005, 9331.58007889633, 9242.12199841014, 9290.535473226177, 9320.580573874056, 9532.428054316762, 9815.0, 6513.902291465726, 6989.895151572832, 7150.284971502808, 7279.490435669664, 7390.113186417664, 7865.370770338473, 7874.094479134744, 7887.132415434183, 7941.245581669732, 7982.241687039722, 6739.393454589111, 6898.206706228848, 6947.062146610143, 7022.08712867324, 7038.964805176146, 7136.250693677297, 7144.535605185646, 7193.928060719535, 7277.672504737406, 7300.014498042697, 7375.741849035258, 7389.519681220703, 7550.471466997477, 7562.168161502341, 7566.659500322608, 6918.654067296716, 6979.825504362431, 6986.860262794614, 6996.650167491707, 7006.474514411338, 6926.0, 6942.340477654615, 7094.716211351488, 7118.644067796693, 7135.143782746104], "unit": "score", "name": "mootools.html", "value": 4660.905568375653}, {"lowerIsBetter": false, "replicates": [323.12272181028516, 323.3339320998741, 327.7525468271455, 329.36597050677454, 332.070203430395, 5983.311919129302, 5986.730597123129, 6014.699265036742, 6030.185924900137, 6039.18471006414, 5858.619189752663, 5908.793192238272, 5927.0, 5947.762089516425, 5998.670073145986, 4368.912621747563, 4506.616937560311, 4594.632429405639, 4606.884827879297, 4640.67515273931, 4591.816327346902, 4618.053299073698, 4627.0, 4633.1660301145785, 4640.373549570799, 4571.1771881061395, 4573.0, 4575.130725162225, 4577.862664120082, 4586.4266966629175, 4376.2997920332755, 4482.910341793146, 4562.201614717411, 4562.4753153387455, 4584.88537786558, 4015.31739604268, 4021.477207962975, 4022.45696830927, 4029.730634850013, 4037.9596204037875, 5677.687727175004, 5681.545476361881, 5681.829545113653, 5691.573132015074, 5693.373728889819, 5309.283246761676, 5315.309009828737, 5318.22885681574, 5324.307839980816, 5326.387465441485, 6289.622622642656, 6307.590006649553, 6308.179936608258, 6314.242290925118, 6322.399372059647, 4342.717723347972, 4417.867463976086, 4444.644428445717, 4458.799354029076, 4469.150861336336, 6504.577202481823, 6525.11910892033, 6548.770793022269, 6557.180352455943, 6563.835904102436, 4550.795214215368, 4555.293929440942, 4560.293154561048, 4565.178267911741, 4577.427821522309, 4619.69971951822, 4620.353150558924, 4620.607248383858, 4624.630029597624, 4628.83799067031, 5298.549623281987, 5300.602454815904, 5305.973470132624, 5307.336582927134, 5315.920261196085, 6189.535784816157, 6332.68336583169, 6344.714487848058, 6357.904631430532, 6359.7456101755415, 1612.8629066529243, 1624.350259896051, 1635.247786018445, 1637.4841924793652, 1641.2778377513855, 1035.3115178406276, 1068.7167900506372, 1092.3882625729616, 1100.7688385438987, 1116.8380584815156, 6019.0, 6022.789202377983, 6029.638221706711, 6093.390660933871, 6101.359357267423, 6431.453326467209, 6483.513736469784, 6502.804915852532, 6511.934880651228, 6523.902141467882, 6139.539534534839, 6142.723577439026, 6143.38566143391, 6145.938540614626, 6151.569390142647, 3503.737219708532, 3532.1699400640828, 3532.2229109595846, 3537.893863184109, 3538.929221415557, 6693.899591506131, 6772.864542709118, 6912.654367281616, 6915.273896240923, 6919.169699636076, 6755.695993680296, 6762.053312536249, 6768.898466523006, 6783.59298442095, 6804.625745583941, 6864.828379290558, 6872.0, 6874.175098988154, 6888.311168883171, 6893.138357705287, 6625.370589793962, 6630.900536492053, 6633.701483433354, 6641.070250165078, 6644.634545100066, 6368.331325210786, 6521.9673901630185, 6527.836804079936, 6558.934410655832, 6560.606363618198, 6884.586924784328, 6903.5167538271835, 6903.585784852925, 6924.169099708067, 6926.168859736864, 4498.91002179948, 4528.90942181148, 4535.523770004102, 4536.6143877770755, 4540.341650460731, 6634.436072933855, 6639.402453779183, 6642.667866606554, 6646.235682896336, 6649.63427011519, 6336.398042185985, 6374.235091789015, 6449.0, 6451.806445806634, 6461.321561236191, 6416.615003099829, 6439.613623182437, 6447.516436267392, 6448.613083215022, 6455.61266324022, 6301.267151533365, 6312.873742525216, 6315.526335524946, 6316.526260530571, 6321.178246828067, 6453.806385808433, 6461.709223085067, 6469.805905822833, 6471.158749362553, 6477.611343319228, 6093.6039157454625, 6149.692515374303, 6291.905621415774, 6325.0, 6327.810165695037], "unit": "score", "name": "prototype.html", "value": 4810.031372215679}, {"lowerIsBetter": false, "replicates": [657.6415853359919, 659.8581305019421, 716.0440811516625, 746.3059354800034, 795.2762985683022, 14634.853651463482, 14868.553943381703, 15910.443134490295, 15949.122798246091, 16024.75962860558, 15013.249337533134, 15063.472778452757, 15142.772858407132, 15146.545603631908, 15162.317695703692, 758.4387553210639, 915.1489115122916, 921.6175287255815, 928.6285485805664, 928.9814203715922, 774.6630215856093, 778.6106946526737, 778.7079845058104, 910.9043550427209, 932.5849996751448, 1005.4319309590095, 1006.6879267427121, 1007.0936157458273, 1009.1926458832941, 1012.7468132966758, 996.8654231678739, 1001.7946321004176, 1002.6490728245093, 1002.7543251903294, 1003.307717674802, 592.7984485275027, 701.1165930927068, 711.7366574367466, 711.7508871894847, 711.7580022792224, 15251.466198683103, 15685.215739213108, 15699.0, 15731.685366292724, 15734.763978540332, 13988.160710357412, 14294.64263393413, 14408.351624176938, 14510.347034383372, 14568.05307654999, 11078.169137314653, 11335.022606449065, 11335.716607084807, 11396.772064558745, 11404.03065739413, 3855.074782052315, 3876.030992251937, 3882.9611703882883, 3883.7087218458446, 3908.9609103908883, 47874.76062619699, 48602.0, 49867.0, 49940.500594994315, 50780.49219507832, 10678.57285708563, 10754.892451075546, 11006.0, 11159.442027898573, 11248.212625116163, 20170.798292017185, 20455.386338409873, 20524.692129618066, 20537.58924821495, 20564.691529627067, 8294.3779216559, 8365.07984121746, 8384.706535271358, 8526.147385261424, 8624.0, 4484.955150448519, 4489.551044895485, 4617.815287388534, 4765.1660959331975, 4998.350214472095, 3348.68187522185, 3356.0, 3397.38847007541, 3401.370746411872, 3413.8975830725117, 588.4997751910842, 591.9052951527735, 598.7006496751624, 599.7181324777434, 600.1477901380051, 599.286848650105, 651.4009103676298, 662.0069895157264, 667.4860357524776, 677.3463607618671, 8143.226393492609, 8199.508029518249, 8338.583070846555, 8340.165163663984, 8346.123657016047, 636.7580319478568, 648.9026646003043, 652.3411354531956, 664.4617859533793, 674.3896773420063, 3725.720570957189, 3787.0532366908274, 3850.3454412749898, 3873.573906870242, 3912.8239229234755, 57388.55668659894, 58292.0, 58602.0, 59286.0, 59540.70229648911, 49107.263391049164, 51271.48728512742, 51512.22731659028, 51691.22463163055, 52790.20814687783, 46925.530744692114, 47699.5230047702, 47729.0, 48084.7595762019, 48264.0, 7311.7980181675575, 7313.158986716596, 7406.7037318506655, 7490.101187857492, 7525.360344370571, 33894.3221135571, 34545.30909381848, 34774.82612586921, 36098.45852312165, 37645.435318469696, 42059.7897010513, 45213.54786452094, 45435.545644543134, 45548.77225613851, 46272.537274626826, 10738.785224295627, 10828.404437755999, 10953.521274628141, 11024.944875275572, 11144.387058711525, 12187.146899716934, 12340.382980850742, 12396.442160102997, 12527.436265368262, 12994.545190918272, 10420.426876521864, 11266.380349080879, 11274.492647830702, 11561.768764624829, 11784.70538236551, 11091.33451992883, 12221.0, 12431.316277604457, 12460.065495087723, 12669.0, 11904.821427678418, 11934.28394296345, 12022.699432514257, 12191.146619736533, 12413.689657758629, 9526.428414295164, 9673.70978870635, 9683.915332866021, 9866.506674666382, 10070.748231294276, 9866.802663946824, 10015.248856335658, 10193.84709229377, 10228.59085636596, 10308.742281442725], "unit": "score", "name": "yui.html", "value": 6634.915005183817}], "name": "dromaeo_css", "value": 7179.091994477924}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 124.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 152.0, 173.0, 126.0, 164.0, 164.0, 130.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 160.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 76.0, 166.0, 74.0, 77.0, 75.0, 73.0, 161.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 148.0, 93.0, 93.0, 93.0, 141.0, 92.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 54.0, 54.0, 54.0, 53.0, 55.0, 53.0, 70.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 65.0, 66.0, 66.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 80.0, 80.0, 80.0, 80.0, 80.0, 95.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [112.0, 122.0, 111.0, 113.0, 112.0, 113.0, 113.0, 115.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [141.0, 137.0, 157.0, 146.0, 147.0, 135.0, 134.0, 145.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 73.0, 67.0, 67.0, 69.0, 66.0, 67.0, 71.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1509.2}]} 06:47:18 INFO - Return code: 0 06:47:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:47:18 INFO - # TBPL SUCCESS # 06:47:18 INFO - Running post-action listener: _resource_record_post_action 06:47:18 INFO - Running post-run listener: _resource_record_post_run 06:47:19 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 461721600; Read time: 0; Write time: 530460 06:47:19 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 243945472; Read time: 0; Write time: 378292 06:47:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 217776128; Read time: 0; Write time: 152168 06:47:19 INFO - Running post-run listener: _upload_blobber_files 06:47:19 INFO - Blob upload gear active. 06:47:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:47:19 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:47:19 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:47:19 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:47:19 INFO - (blobuploader) - INFO - Open directory for files ... 06:47:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:47:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:20 INFO - (blobuploader) - INFO - Done attempting. 06:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:21 INFO - (blobuploader) - INFO - Done attempting. 06:47:21 INFO - (blobuploader) - INFO - Iteration through files over. 06:47:21 INFO - Return code: 0 06:47:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:47:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:47:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d351c9560321fcded96756b980e39fe47b4c2af0b0237a640a2421faaee6a3c2615036df39e107443262d4998bc681f6b18945d81e9c8973888f1d7969827e99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5871800c6e540c26b8b6c2c314465d252140c3ef26f7db4eac82ea4ee0a6c1320f387a412ec658014477617c659e8c5486cc77a301471ea6e3b3bd6b16479a63"} 06:47:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:47:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:47:21 INFO - Contents: 06:47:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d351c9560321fcded96756b980e39fe47b4c2af0b0237a640a2421faaee6a3c2615036df39e107443262d4998bc681f6b18945d81e9c8973888f1d7969827e99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5871800c6e540c26b8b6c2c314465d252140c3ef26f7db4eac82ea4ee0a6c1320f387a412ec658014477617c659e8c5486cc77a301471ea6e3b3bd6b16479a63"} 06:47:21 INFO - Running post-run listener: copy_logs_to_upload_dir 06:47:21 INFO - Copying logs to upload dir... 06:47:21 INFO - mkdir: /builds/slave/test/build/upload/logs 06:47:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.871621 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-06-06 06:47:20.415901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:47:20.420501) ========= 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=d2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d351c9560321fcded96756b980e39fe47b4c2af0b0237a640a2421faaee6a3c2615036df39e107443262d4998bc681f6b18945d81e9c8973888f1d7969827e99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5871800c6e540c26b8b6c2c314465d252140c3ef26f7db4eac82ea4ee0a6c1320f387a412ec658014477617c659e8c5486cc77a301471ea6e3b3bd6b16479a63"} 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.011408 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d351c9560321fcded96756b980e39fe47b4c2af0b0237a640a2421faaee6a3c2615036df39e107443262d4998bc681f6b18945d81e9c8973888f1d7969827e99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5871800c6e540c26b8b6c2c314465d252140c3ef26f7db4eac82ea4ee0a6c1320f387a412ec658014477617c659e8c5486cc77a301471ea6e3b3bd6b16479a63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:47:20.454095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:47:20.454471) ========= 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=d2a8c569965ab8367867b893000001a1-1465219615.766342-1372536889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003153 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:47:20.546462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:47:20.546777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:47:20.547078) ========= ========= Total master_lag: 0.19 =========