builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1463173295.24 results: success (0) buildid: 20160513112242 builduid: 91d8d7ac8fee4455be522e629bf592d5 revision: fc1c6d02f8725d48b9a44532a6f633cd4b91d060 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.239330) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.240152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.240462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.308598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.309297) ========= 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=af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 14:01:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-05-13 14:01:36 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.445647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.448135) ========= 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=af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015144 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.500779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:35.501198) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc1c6d02f8725d48b9a44532a6f633cd4b91d060 --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 fc1c6d02f8725d48b9a44532a6f633cd4b91d060 --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=af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 14:01:36,258 truncating revision to first 12 chars 2016-05-13 14:01:36,258 Setting DEBUG logging. 2016-05-13 14:01:36,258 attempt 1/10 2016-05-13 14:01:36,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fc1c6d02f872?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 14:01:36,507 unpacking tar archive at: mozilla-beta-fc1c6d02f872/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:36.045295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:36.046066) ========= script_repo_revision: fc1c6d02f8725d48b9a44532a6f633cd4b91d060 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:36.048222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:36.048951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:01:36.059788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-05-13 14:01:36.060192) ========= /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=af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:36 INFO - MultiFileLogger online at 20160513 14:01:36 in /builds/slave/test 14:01:36 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 14:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:36 INFO - {'append_to_log': False, 14:01:36 INFO - 'base_work_dir': '/builds/slave/test', 14:01:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:36 INFO - 'branch': 'Mozilla-Beta', 14:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:36 INFO - 'config_files': ('talos/linux_config.py',), 14:01:36 INFO - 'default_actions': ('clobber', 14:01:36 INFO - 'read-buildbot-config', 14:01:36 INFO - 'download-and-extract', 14:01:36 INFO - 'populate-webroot', 14:01:36 INFO - 'create-virtualenv', 14:01:36 INFO - 'install', 14:01:36 INFO - 'run-tests'), 14:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:36 INFO - 'download_minidump_stackwalk': True, 14:01:36 INFO - 'download_symbols': 'ondemand', 14:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:36 INFO - 'installer_path': 'installer.exe', 14:01:36 INFO - 'log_level': 'info', 14:01:36 INFO - 'log_name': 'talos', 14:01:36 INFO - 'log_to_console': True, 14:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:36 INFO - 'opt_config_files': (), 14:01:36 INFO - 'pip_index': False, 14:01:36 INFO - 'sps_profile': False, 14:01:36 INFO - 'sps_profile_interval': 0, 14:01:36 INFO - 'suite': 'dromaeojs', 14:01:36 INFO - 'system_bits': '32', 14:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:36 INFO - 'title': 'talos-linux64-ix-020', 14:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:36 INFO - 'use_talos_json': True, 14:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:36 INFO - 'work_dir': 'build'} 14:01:36 INFO - ##### 14:01:36 INFO - ##### Running clobber step. 14:01:36 INFO - ##### 14:01:36 INFO - Running pre-action listener: _resource_record_pre_action 14:01:36 INFO - Running main action method: clobber 14:01:36 INFO - rmtree: /builds/slave/test/build 14:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:37 INFO - Running post-action listener: _resource_record_post_action 14:01:37 INFO - ##### 14:01:37 INFO - ##### Running read-buildbot-config step. 14:01:37 INFO - ##### 14:01:37 INFO - Running pre-action listener: _resource_record_pre_action 14:01:37 INFO - Running main action method: read_buildbot_config 14:01:37 INFO - Using buildbot properties: 14:01:37 INFO - { 14:01:37 INFO - "project": "", 14:01:37 INFO - "product": "firefox", 14:01:37 INFO - "script_repo_revision": "production", 14:01:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:01:37 INFO - "repository": "", 14:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:01:37 INFO - "buildid": "20160513112242", 14:01:37 INFO - "pgo_build": "True", 14:01:37 INFO - "basedir": "/builds/slave/test", 14:01:37 INFO - "buildnumber": 238, 14:01:37 INFO - "slavename": "talos-linux64-ix-020", 14:01:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:01:37 INFO - "platform": "ubuntu64_hw", 14:01:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:01:37 INFO - "branch": "mozilla-beta", 14:01:37 INFO - "repo_path": "releases/mozilla-beta", 14:01:37 INFO - "revision": "fc1c6d02f8725d48b9a44532a6f633cd4b91d060", 14:01:37 INFO - "stage_platform": "linux64-pgo", 14:01:37 INFO - "builduid": "91d8d7ac8fee4455be522e629bf592d5", 14:01:37 INFO - "slavebuilddir": "test" 14:01:37 INFO - } 14:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 14:01:37 INFO - Running post-action listener: _resource_record_post_action 14:01:37 INFO - ##### 14:01:37 INFO - ##### Running download-and-extract step. 14:01:37 INFO - ##### 14:01:37 INFO - Running pre-action listener: _resource_record_pre_action 14:01:37 INFO - Running main action method: download_and_extract 14:01:37 INFO - mkdir: /builds/slave/test/build/tests 14:01:37 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')]} 14:01:37 INFO - https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:38 INFO - Downloaded 1412 bytes. 14:01:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:01:38 INFO - Using the following test package requirements: 14:01:38 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:01:38 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:01:38 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 14:01:38 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'jsshell-linux-x86_64.zip'], 14:01:38 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:01:38 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:01:38 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 14:01:38 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 14:01:38 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:01:38 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:01:38 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:38 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:01:38 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:38 INFO - https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:39 INFO - Downloaded 23365078 bytes. 14:01:39 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'] 14:01:39 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 14:01:40 INFO - Return code: 0 14:01:40 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 14:01:40 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')]} 14:01:40 INFO - https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:41 INFO - Downloaded 23365078 bytes. 14:01:41 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'] 14:01:41 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 14:01:42 INFO - Return code: 0 14:01:42 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')]} 14:01:42 INFO - https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:44 INFO - Downloaded 10845194 bytes. 14:01:44 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'] 14:01:44 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 14:01:44 INFO - Return code: 0 14:01: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')]} 14:01:44 INFO - https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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 14:01:45 INFO - Downloaded 53797694 bytes. 14:01:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:45 INFO - mkdir: /builds/slave/test/properties 14:01:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:45 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:45 INFO - Contents: 14:01:45 INFO - build_url:https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:46 INFO - Running post-action listener: _resource_record_post_action 14:01:46 INFO - Running post-action listener: set_extra_try_arguments 14:01:46 INFO - ##### 14:01:46 INFO - ##### Running populate-webroot step. 14:01:46 INFO - ##### 14:01:46 INFO - Running pre-action listener: _resource_record_pre_action 14:01:46 INFO - Running main action method: populate_webroot 14:01:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:46 INFO - '--tppagecycles', 14:01:46 INFO - '7'], 14:01:46 INFO - 'tests': ['tsvgm']}}, 14:01:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:01:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:01:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'tests': ['damp', 'tps']}, 14:01:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['damp', 'tps']}, 14:01:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:01:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:46 INFO - 'other': {'tests': ['a11yr', 14:01:46 INFO - 'ts_paint', 14:01:46 INFO - 'tpaint', 14:01:46 INFO - 'sessionrestore', 14:01:46 INFO - 'sessionrestore_no_auto_restore', 14:01:46 INFO - 'tabpaint']}, 14:01:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['a11yr', 14:01:46 INFO - 'ts_paint', 14:01:46 INFO - 'tpaint', 14:01:46 INFO - 'sessionrestore', 14:01:46 INFO - 'sessionrestore_no_auto_restore', 14:01:46 INFO - 'tabpaint']}, 14:01:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['a11yr', 14:01:46 INFO - 'ts_paint', 14:01:46 INFO - 'tpaint', 14:01:46 INFO - 'sessionrestore', 14:01:46 INFO - 'sessionrestore_no_auto_restore', 14:01:46 INFO - 'tabpaint']}, 14:01:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['a11yr', 14:01:46 INFO - 'ts_paint', 14:01:46 INFO - 'tpaint', 14:01:46 INFO - 'sessionrestore', 14:01:46 INFO - 'sessionrestore_no_auto_restore', 14:01:46 INFO - 'tabpaint']}, 14:01:46 INFO - 'other_l64': {'tests': ['a11yr', 14:01:46 INFO - 'ts_paint', 14:01:46 INFO - 'tpaint', 14:01:46 INFO - 'sessionrestore', 14:01:46 INFO - 'sessionrestore_no_auto_restore', 14:01:46 INFO - 'tabpaint']}, 14:01:46 INFO - 'other_nol64': {'tests': ['a11yr', 14:01:46 INFO - 'ts_paint', 14:01:46 INFO - 'tpaint', 14:01:46 INFO - 'sessionrestore', 14:01:46 INFO - 'sessionrestore_no_auto_restore', 14:01:46 INFO - 'tabpaint']}, 14:01:46 INFO - 'svgr': {'tests': ['tsvgx', 14:01:46 INFO - 'tsvgr_opacity', 14:01:46 INFO - 'tart', 14:01:46 INFO - 'tscrollx', 14:01:46 INFO - 'cart']}, 14:01:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['tsvgx', 14:01:46 INFO - 'tsvgr_opacity', 14:01:46 INFO - 'tart', 14:01:46 INFO - 'tscrollx', 14:01:46 INFO - 'cart']}, 14:01:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'tests': ['tp5o']}, 14:01:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'talos_options': ['--e10s'], 14:01:46 INFO - 'tests': ['tp5o']}, 14:01:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'talos_options': ['--xperf_path', 14:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:46 INFO - 'tests': ['tp5n']}, 14:01:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:46 INFO - 'talos_options': ['--e10s', 14:01:46 INFO - '--xperf_path', 14:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:46 INFO - 'tests': ['tp5n']}}, 14:01:46 INFO - 'talos.zip': {'path': '', 14:01:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:46 INFO - Running post-action listener: _resource_record_post_action 14:01:46 INFO - ##### 14:01:46 INFO - ##### Running create-virtualenv step. 14:01:46 INFO - ##### 14:01:46 INFO - Running pre-action listener: _resource_record_pre_action 14:01:46 INFO - Running main action method: create_virtualenv 14:01:46 INFO - Creating virtualenv /builds/slave/test/build/venv 14:01:46 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 14:01:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:01:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:46 INFO - Using real prefix '/usr' 14:01:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:01:47 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:49 INFO - Installing pip.................done. 14:01:49 INFO - Return code: 0 14:01:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:01:49 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')]} 14:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:49 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')]} 14:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:49 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:01:49 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 14:01:49 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 14:01:49 INFO - Using env: {'DISPLAY': ':0', 14:01:49 INFO - 'HOME': '/home/cltbld', 14:01:49 INFO - 'LANG': 'en_US.UTF-8', 14:01:49 INFO - 'LANGUAGE': 'en_US:en', 14:01:49 INFO - 'LOGNAME': 'cltbld', 14:01:49 INFO - 'MAIL': '/var/mail/cltbld', 14:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:49 INFO - 'MOZ_NO_REMOTE': '1', 14:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:49 INFO - 'NO_EM_RESTART': '1', 14:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:49 INFO - 'PWD': '/builds/slave/test', 14:01:49 INFO - 'SHELL': '/bin/bash', 14:01:49 INFO - 'SHLVL': '1', 14:01:49 INFO - 'TERM': 'linux', 14:01:49 INFO - 'TMOUT': '86400', 14:01:49 INFO - 'USER': 'cltbld', 14:01:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:49 INFO - '_': '/tools/buildbot/bin/python'} 14:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:49 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 14:01:49 INFO - Cleaning up... 14:01:49 INFO - Return code: 0 14:01:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:01:49 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')]} 14:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:49 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')]} 14:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:49 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:01:49 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 14:01:49 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 14:01:49 INFO - Using env: {'DISPLAY': ':0', 14:01:49 INFO - 'HOME': '/home/cltbld', 14:01:49 INFO - 'LANG': 'en_US.UTF-8', 14:01:49 INFO - 'LANGUAGE': 'en_US:en', 14:01:49 INFO - 'LOGNAME': 'cltbld', 14:01:49 INFO - 'MAIL': '/var/mail/cltbld', 14:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:49 INFO - 'MOZ_NO_REMOTE': '1', 14:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:49 INFO - 'NO_EM_RESTART': '1', 14:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:49 INFO - 'PWD': '/builds/slave/test', 14:01:49 INFO - 'SHELL': '/bin/bash', 14:01:49 INFO - 'SHLVL': '1', 14:01:49 INFO - 'TERM': 'linux', 14:01:49 INFO - 'TMOUT': '86400', 14:01:49 INFO - 'USER': 'cltbld', 14:01:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:49 INFO - '_': '/tools/buildbot/bin/python'} 14:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:49 INFO - Downloading/unpacking psutil>=0.7.1 14:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:51 INFO - Installing collected packages: psutil 14:01:51 INFO - Running setup.py install for psutil 14:01:51 INFO - building 'psutil._psutil_linux' extension 14:01:51 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 14:01:51 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 14:01:52 INFO - building 'psutil._psutil_posix' extension 14:01:52 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 14:01:52 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 14:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:52 INFO - Successfully installed psutil 14:01:52 INFO - Cleaning up... 14:01:52 INFO - Return code: 0 14:01:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:52 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:01:52 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 14:01:52 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 14:01:52 INFO - Using env: {'DISPLAY': ':0', 14:01:52 INFO - 'HOME': '/home/cltbld', 14:01:52 INFO - 'LANG': 'en_US.UTF-8', 14:01:52 INFO - 'LANGUAGE': 'en_US:en', 14:01:52 INFO - 'LOGNAME': 'cltbld', 14:01:52 INFO - 'MAIL': '/var/mail/cltbld', 14:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:52 INFO - 'MOZ_NO_REMOTE': '1', 14:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:52 INFO - 'NO_EM_RESTART': '1', 14:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:52 INFO - 'PWD': '/builds/slave/test', 14:01:52 INFO - 'SHELL': '/bin/bash', 14:01:52 INFO - 'SHLVL': '1', 14:01:52 INFO - 'TERM': 'linux', 14:01:52 INFO - 'TMOUT': '86400', 14:01:52 INFO - 'USER': 'cltbld', 14:01:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:52 INFO - '_': '/tools/buildbot/bin/python'} 14:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:54 INFO - Installing collected packages: mozsystemmonitor 14:01:54 INFO - Running setup.py install for mozsystemmonitor 14:01:54 INFO - Successfully installed mozsystemmonitor 14:01:54 INFO - Cleaning up... 14:01:54 INFO - Return code: 0 14:01:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:01:54 INFO - Using env: {'DISPLAY': ':0', 14:01:54 INFO - 'HOME': '/home/cltbld', 14:01:54 INFO - 'LANG': 'en_US.UTF-8', 14:01:54 INFO - 'LANGUAGE': 'en_US:en', 14:01:54 INFO - 'LOGNAME': 'cltbld', 14:01:54 INFO - 'MAIL': '/var/mail/cltbld', 14:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:54 INFO - 'MOZ_NO_REMOTE': '1', 14:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:54 INFO - 'NO_EM_RESTART': '1', 14:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:54 INFO - 'PWD': '/builds/slave/test', 14:01:54 INFO - 'SHELL': '/bin/bash', 14:01:54 INFO - 'SHLVL': '1', 14:01:54 INFO - 'TERM': 'linux', 14:01:54 INFO - 'TMOUT': '86400', 14:01:54 INFO - 'USER': 'cltbld', 14:01:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:54 INFO - '_': '/tools/buildbot/bin/python'} 14:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:01:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:57 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 14:01:57 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 14:01:57 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 14:01:57 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 14:01:57 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 14:01:57 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 14:01:57 INFO - Downloading docopt-0.6.1.tar.gz 14:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:57 INFO - Running setup.py install for blobuploader 14:01:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:01:57 INFO - Running setup.py install for requests 14:01:57 INFO - Running setup.py install for docopt 14:01:57 INFO - Successfully installed blobuploader requests docopt 14:01:57 INFO - Cleaning up... 14:01:58 INFO - Return code: 0 14:01:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:58 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:01:58 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 14:01:58 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 14:01:58 INFO - Using env: {'DISPLAY': ':0', 14:01:58 INFO - 'HOME': '/home/cltbld', 14:01:58 INFO - 'LANG': 'en_US.UTF-8', 14:01:58 INFO - 'LANGUAGE': 'en_US:en', 14:01:58 INFO - 'LOGNAME': 'cltbld', 14:01:58 INFO - 'MAIL': '/var/mail/cltbld', 14:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:58 INFO - 'MOZ_NO_REMOTE': '1', 14:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:58 INFO - 'NO_EM_RESTART': '1', 14:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:58 INFO - 'PWD': '/builds/slave/test', 14:01:58 INFO - 'SHELL': '/bin/bash', 14:01:58 INFO - 'SHLVL': '1', 14:01:58 INFO - 'TERM': 'linux', 14:01:58 INFO - 'TMOUT': '86400', 14:01:58 INFO - 'USER': 'cltbld', 14:01:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:58 INFO - '_': '/tools/buildbot/bin/python'} 14:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:58 INFO - Running setup.py (path:/tmp/pip-akgIGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:58 INFO - Running setup.py (path:/tmp/pip-bIvG0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:58 INFO - Running setup.py (path:/tmp/pip-x5vdpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:58 INFO - Running setup.py (path:/tmp/pip-x0QUPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:58 INFO - Running setup.py (path:/tmp/pip-Qj2niS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:58 INFO - Running setup.py (path:/tmp/pip-JQKZRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:58 INFO - Running setup.py (path:/tmp/pip-mrDXA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:58 INFO - Running setup.py (path:/tmp/pip-AMV7h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:58 INFO - Running setup.py (path:/tmp/pip-M317AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:58 INFO - Running setup.py (path:/tmp/pip-2uogrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:58 INFO - Running setup.py (path:/tmp/pip-G6vj6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:59 INFO - Running setup.py (path:/tmp/pip-X5QYWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:59 INFO - Running setup.py (path:/tmp/pip-2usMAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:59 INFO - Running setup.py (path:/tmp/pip-1ywT0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:59 INFO - Running setup.py (path:/tmp/pip-xnUwe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:59 INFO - Running setup.py (path:/tmp/pip-3jFfpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:59 INFO - Running setup.py (path:/tmp/pip-AlhCsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:59 INFO - Running setup.py install for manifestparser 14:01:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Running setup.py install for mozcrash 14:01:59 INFO - Running setup.py install for mozdebug 14:01:59 INFO - Running setup.py install for mozdevice 14:01:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Running setup.py install for mozfile 14:01:59 INFO - Running setup.py install for mozhttpd 14:02:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for mozinfo 14:02:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for mozInstall 14:02:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for mozleak 14:02:00 INFO - Running setup.py install for mozlog 14:02:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for moznetwork 14:02:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for mozprocess 14:02:00 INFO - Running setup.py install for mozprofile 14:02:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for mozrunner 14:02:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for mozscreenshot 14:02:01 INFO - Running setup.py install for moztest 14:02:01 INFO - Running setup.py install for mozversion 14:02:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:01 INFO - Cleaning up... 14:02:01 INFO - Return code: 0 14:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:02:01 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 14:02:01 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 14:02:01 INFO - Using env: {'DISPLAY': ':0', 14:02:01 INFO - 'HOME': '/home/cltbld', 14:02:01 INFO - 'LANG': 'en_US.UTF-8', 14:02:01 INFO - 'LANGUAGE': 'en_US:en', 14:02:01 INFO - 'LOGNAME': 'cltbld', 14:02:01 INFO - 'MAIL': '/var/mail/cltbld', 14:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:01 INFO - 'MOZ_NO_REMOTE': '1', 14:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:01 INFO - 'NO_EM_RESTART': '1', 14:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:01 INFO - 'PWD': '/builds/slave/test', 14:02:01 INFO - 'SHELL': '/bin/bash', 14:02:01 INFO - 'SHLVL': '1', 14:02:01 INFO - 'TERM': 'linux', 14:02:01 INFO - 'TMOUT': '86400', 14:02:01 INFO - 'USER': 'cltbld', 14:02:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:01 INFO - '_': '/tools/buildbot/bin/python'} 14:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:01 INFO - Running setup.py (path:/tmp/pip-i8NOAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:01 INFO - Running setup.py (path:/tmp/pip-NaFnS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:01 INFO - Running setup.py (path:/tmp/pip-AxCPxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:01 INFO - Running setup.py (path:/tmp/pip-ZTeZss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:01 INFO - Running setup.py (path:/tmp/pip-ohNmMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:01 INFO - Running setup.py (path:/tmp/pip-hEkZD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:01 INFO - Running setup.py (path:/tmp/pip-eeVIBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:01 INFO - Running setup.py (path:/tmp/pip-OCaNoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:02 INFO - Running setup.py (path:/tmp/pip-_hBsfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:02 INFO - Running setup.py (path:/tmp/pip-5E6I0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:02 INFO - Running setup.py (path:/tmp/pip-LFdT7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:02 INFO - Running setup.py (path:/tmp/pip-jhviRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:02 INFO - Running setup.py (path:/tmp/pip-NWejow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:02 INFO - Running setup.py (path:/tmp/pip-K4SOsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:02 INFO - Running setup.py (path:/tmp/pip-9Atqan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:02 INFO - Running setup.py (path:/tmp/pip-nVk_4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:02 INFO - Running setup.py (path:/tmp/pip-EfqUsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:02 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)) 14:02:02 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)) 14:02:02 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)) 14:02:02 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)) 14:02:02 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)) 14:02:02 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)) 14:02:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:04 INFO - Downloading blessings-1.6.tar.gz 14:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:04 INFO - Installing collected packages: blessings 14:02:04 INFO - Running setup.py install for blessings 14:02:04 INFO - Successfully installed blessings 14:02:04 INFO - Cleaning up... 14:02:04 INFO - Return code: 0 14:02:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:05 INFO - Reading from file tmpfile_stdout 14:02:05 INFO - Current package versions: 14:02:05 INFO - argparse == 1.2.1 14:02:05 INFO - blessings == 1.6 14:02:05 INFO - blobuploader == 1.2.4 14:02:05 INFO - docopt == 0.6.1 14:02:05 INFO - manifestparser == 1.1 14:02:05 INFO - mozInstall == 1.12 14:02:05 INFO - mozcrash == 0.17 14:02:05 INFO - mozdebug == 0.1 14:02:05 INFO - mozdevice == 0.48 14:02:05 INFO - mozfile == 1.2 14:02:05 INFO - mozhttpd == 0.7 14:02:05 INFO - mozinfo == 0.9 14:02:05 INFO - mozleak == 0.1 14:02:05 INFO - mozlog == 3.1 14:02:05 INFO - moznetwork == 0.27 14:02:05 INFO - mozprocess == 0.22 14:02:05 INFO - mozprofile == 0.28 14:02:05 INFO - mozrunner == 6.11 14:02:05 INFO - mozscreenshot == 0.1 14:02:05 INFO - mozsystemmonitor == 0.0 14:02:05 INFO - moztest == 0.7 14:02:05 INFO - mozversion == 1.4 14:02:05 INFO - psutil == 3.1.1 14:02:05 INFO - requests == 1.2.3 14:02:05 INFO - wsgiref == 0.1.2 14:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:05 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:02:05 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 14:02:05 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 14:02:05 INFO - Using env: {'DISPLAY': ':0', 14:02:05 INFO - 'HOME': '/home/cltbld', 14:02:05 INFO - 'LANG': 'en_US.UTF-8', 14:02:05 INFO - 'LANGUAGE': 'en_US:en', 14:02:05 INFO - 'LOGNAME': 'cltbld', 14:02:05 INFO - 'MAIL': '/var/mail/cltbld', 14:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:05 INFO - 'MOZ_NO_REMOTE': '1', 14:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:05 INFO - 'NO_EM_RESTART': '1', 14:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:05 INFO - 'PWD': '/builds/slave/test', 14:02:05 INFO - 'SHELL': '/bin/bash', 14:02:05 INFO - 'SHLVL': '1', 14:02:05 INFO - 'TERM': 'linux', 14:02:05 INFO - 'TMOUT': '86400', 14:02:05 INFO - 'USER': 'cltbld', 14:02:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:05 INFO - '_': '/tools/buildbot/bin/python'} 14:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 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)) 14:02:05 INFO - Cleaning up... 14:02:05 INFO - Return code: 0 14:02:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:05 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:02:05 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 14:02:05 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 14:02:05 INFO - Using env: {'DISPLAY': ':0', 14:02:05 INFO - 'HOME': '/home/cltbld', 14:02:05 INFO - 'LANG': 'en_US.UTF-8', 14:02:05 INFO - 'LANGUAGE': 'en_US:en', 14:02:05 INFO - 'LOGNAME': 'cltbld', 14:02:05 INFO - 'MAIL': '/var/mail/cltbld', 14:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:05 INFO - 'MOZ_NO_REMOTE': '1', 14:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:05 INFO - 'NO_EM_RESTART': '1', 14:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:05 INFO - 'PWD': '/builds/slave/test', 14:02:05 INFO - 'SHELL': '/bin/bash', 14:02:05 INFO - 'SHLVL': '1', 14:02:05 INFO - 'TERM': 'linux', 14:02:05 INFO - 'TMOUT': '86400', 14:02:05 INFO - 'USER': 'cltbld', 14:02:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:05 INFO - '_': '/tools/buildbot/bin/python'} 14:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:05 INFO - Downloading/unpacking jsonschema 14:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:07 INFO - Downloading/unpacking functools32 (from jsonschema) 14:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:07 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:07 INFO - warning: no files found matching '*.txt' 14:02:07 INFO - no previously-included directories found matching 'build' 14:02:07 INFO - no previously-included directories found matching 'dist' 14:02:07 INFO - no previously-included directories found matching '.git*' 14:02:07 INFO - Installing collected packages: jsonschema, functools32 14:02:07 INFO - Running setup.py install for functools32 14:02:07 INFO - warning: no files found matching '*.txt' 14:02:07 INFO - no previously-included directories found matching 'build' 14:02:07 INFO - no previously-included directories found matching 'dist' 14:02:07 INFO - no previously-included directories found matching '.git*' 14:02:07 INFO - Successfully installed jsonschema functools32 14:02:07 INFO - Cleaning up... 14:02:07 INFO - Return code: 0 14:02:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:02:07 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')]} 14:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:07 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')]} 14:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:07 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 0x7fc63f531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', '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 14:02:07 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 14:02:07 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 14:02:07 INFO - Using env: {'DISPLAY': ':0', 14:02:07 INFO - 'HOME': '/home/cltbld', 14:02:07 INFO - 'LANG': 'en_US.UTF-8', 14:02:07 INFO - 'LANGUAGE': 'en_US:en', 14:02:07 INFO - 'LOGNAME': 'cltbld', 14:02:07 INFO - 'MAIL': '/var/mail/cltbld', 14:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:07 INFO - 'MOZ_NO_REMOTE': '1', 14:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:07 INFO - 'NO_EM_RESTART': '1', 14:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:07 INFO - 'PWD': '/builds/slave/test', 14:02:07 INFO - 'SHELL': '/bin/bash', 14:02:07 INFO - 'SHLVL': '1', 14:02:07 INFO - 'TERM': 'linux', 14:02:07 INFO - 'TMOUT': '86400', 14:02:07 INFO - 'USER': 'cltbld', 14:02:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:07 INFO - '_': '/tools/buildbot/bin/python'} 14:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:08 INFO - Downloading/unpacking flake8 14:02:08 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 14:02:08 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 14:02:08 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 14:02:08 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 14:02:08 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 14:02:08 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 14:02:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:10 INFO - no previously-included directories found matching 'docs/_build' 14:02:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:10 INFO - Running setup.py install for pep8 14:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:10 INFO - no previously-included directories found matching 'docs/_build' 14:02:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:02:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:10 INFO - Cleaning up... 14:02:10 INFO - Return code: 0 14:02:10 INFO - Running post-action listener: _resource_record_post_action 14:02:10 INFO - Running post-action listener: _start_resource_monitoring 14:02:10 INFO - Starting resource monitoring. 14:02:10 INFO - ##### 14:02:10 INFO - ##### Running install step. 14:02:10 INFO - ##### 14:02:10 INFO - Running pre-action listener: _resource_record_pre_action 14:02:10 INFO - Running main action method: install 14:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:11 INFO - Reading from file tmpfile_stdout 14:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:11 INFO - Reading from file tmpfile_stdout 14:02:11 INFO - Output received: 14:02:11 INFO - Usage: mozinstall [options] installer 14:02:11 INFO - Options: 14:02:11 INFO - -h, --help show this help message and exit 14:02:11 INFO - -d DEST, --destination=DEST 14:02:11 INFO - Directory to install application into. [default: 14:02:11 INFO - "/builds/slave/test"] 14:02:11 INFO - --app=APP Application being installed. [default: firefox] 14:02:11 INFO - mkdir: /builds/slave/test/build/application 14:02:11 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'] 14:02:11 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 14:02:23 INFO - Reading from file tmpfile_stdout 14:02:23 INFO - Output received: 14:02:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:02:23 INFO - Running post-action listener: _resource_record_post_action 14:02:23 INFO - ##### 14:02:23 INFO - ##### Running run-tests step. 14:02:23 INFO - ##### 14:02:23 INFO - Running pre-action listener: _resource_record_pre_action 14:02:23 INFO - Running main action method: run_tests 14:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:02:23 INFO - Python 2.7.3 14:02:23 INFO - Return code: 0 14:02:23 INFO - grabbing minidump binary from tooltool 14:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:23 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 0xf33160>, '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 0xf34060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf344f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:02:23 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 14:02:23 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 14:02:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:02:24 INFO - Return code: 0 14:02:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:02:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:02:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:02:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:02:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:02:25 INFO - Return code: 0 14:02:25 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/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 14:02:25 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/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 14:02:25 INFO - Using env: {'DISPLAY': ':0', 14:02:25 INFO - 'HOME': '/home/cltbld', 14:02:25 INFO - 'LANG': 'en_US.UTF-8', 14:02:25 INFO - 'LANGUAGE': 'en_US:en', 14:02:25 INFO - 'LOGNAME': 'cltbld', 14:02:25 INFO - 'MAIL': '/var/mail/cltbld', 14:02:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:02:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:25 INFO - 'MOZ_NO_REMOTE': '1', 14:02:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:25 INFO - 'NO_EM_RESTART': '1', 14:02:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:25 INFO - 'PWD': '/builds/slave/test', 14:02:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:02:25 INFO - 'SHELL': '/bin/bash', 14:02:25 INFO - 'SHLVL': '1', 14:02:25 INFO - 'TERM': 'linux', 14:02:25 INFO - 'TMOUT': '86400', 14:02:25 INFO - 'USER': 'cltbld', 14:02:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602', 14:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:25 INFO - '_': '/tools/buildbot/bin/python'} 14:02:25 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/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 14:02:25 INFO - mozversion application_buildid: 20160513112242 14:02:25 INFO - mozversion application_changeset: fc1c6d02f8725d48b9a44532a6f633cd4b91d060 14:02:25 INFO - mozversion application_display_name: Firefox 14:02:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:02:25 INFO - mozversion application_name: Firefox 14:02:25 INFO - mozversion application_remotingname: firefox 14:02:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:02:25 INFO - mozversion application_vendor: Mozilla 14:02:25 INFO - mozversion application_version: 47.0 14:02:25 INFO - mozversion platform_buildid: 20160513112242 14:02:25 INFO - mozversion platform_changeset: fc1c6d02f8725d48b9a44532a6f633cd4b91d060 14:02:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:02:25 INFO - mozversion platform_version: 47.0 14:02:25 INFO - using testdate: 1463173345 14:02:25 INFO - actual date: 1463173345 14:02:25 INFO - starting webserver on 'localhost:55738' 14:02:25 INFO - SUITE-START | Running 2 tests 14:02:25 INFO - TEST-START | dromaeo_css 14:02:25 INFO - operating with platform_type : linux_ 14:02:25 INFO - Initialising browser for dromaeo_css test... 14:02:25 INFO - TEST-INFO | started process 9026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpncYYvW/profile http://localhost:55738/getInfo.html) 14:02:29 INFO - PROCESS | 9026 | __metrics Screen width/height:1600/1200 14:02:29 INFO - PROCESS | 9026 | colorDepth:24 14:02:29 INFO - PROCESS | 9026 | Browser inner width/height: 1024/697 14:02:29 INFO - PROCESS | 9026 | __metrics 14:02:31 INFO - PROCESS | 9026 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:31 INFO - TEST-INFO | 9026: exit 0 14:02:31 INFO - Browser initialized. 14:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:02:31 INFO - TEST-INFO | started process 9118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpncYYvW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:43 INFO - PROCESS | 9118 | RSS: Main: 139063296 14:02:43 INFO - PROCESS | 9118 | 14:03:34 INFO - PROCESS | 9118 | 1463173414463 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] 14:05:42 INFO - PROCESS | 9118 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55738/tests/dromaeo/cssquery-ext.html) 14:05:43 INFO - PROCESS | 9118 | RSS: Main: 249577472 14:05:43 INFO - PROCESS | 9118 | 14:08:45 INFO - PROCESS | 9118 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-ext.html (next: http://localhost:55738/tests/dromaeo/cssquery-jquery.html) 14:08:45 INFO - PROCESS | 9118 | RSS: Main: 227459072 14:08:45 INFO - PROCESS | 9118 | 14:11:47 INFO - PROCESS | 9118 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55738/tests/dromaeo/cssquery-mootools.html) 14:11:48 INFO - PROCESS | 9118 | RSS: Main: 215539712 14:11:48 INFO - PROCESS | 9118 | 14:14:50 INFO - PROCESS | 9118 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55738/tests/dromaeo/cssquery-prototype.html) 14:14:50 INFO - PROCESS | 9118 | RSS: Main: 191344640 14:14:50 INFO - PROCESS | 9118 | 14:17:53 INFO - PROCESS | 9118 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55738/tests/dromaeo/cssquery-yui.html) 14:17:53 INFO - PROCESS | 9118 | RSS: Main: 207011840 14:17:53 INFO - PROCESS | 9118 | 14:20:55 INFO - PROCESS | 9118 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-yui.html (next: http://localhost:55738/tests/dromaeo/cssquery-dojo.html) 14:20:56 INFO - PROCESS | 9118 | RSS: Main: 254930944 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | __start_tp_report 14:20:56 INFO - PROCESS | 9118 | _x_x_mozilla_page_load 14:20:56 INFO - PROCESS | 9118 | _x_x_mozilla_page_load_details 14:20:56 INFO - PROCESS | 9118 | |i|pagename|runs| 14:20:56 INFO - PROCESS | 9118 | |0;dojo.html;3306.9338613227737;3376.4260075787115;3390.64398238185;3391.9660803391957;3407.8296085195743;5416.2958815353995;5428.484293992069;5428.728563571821;5436.374816896058;5456.372517160517;5402;5415.431379705134;5441.782328706857;5445.237666726662;5448.891022179554;4797.184478638623;4924.236743304785;4987.650864439491;5005.174146265862;5037.773300201499;4901.583365413926;4917.459079501252;4989.825356112537;5005.874853128665;5021.748912554376;4956.083124621939;5025.874353141164;5043.873903152414;5062.0888240116765;5070.08738427083;4914.975425122851;4969.627277954168;4970.676906001135;4986.4265609455015;5006.424261209971;4811.687240329403;4898.975505122487;4939.234418665113;4960.082384758831;4982.60139188864;5160.845174644729;5176.741162941876;5176.948230517722;5183.3261675981885;5193.714345710984;5759.107338362561;5759.913601295942;5761.971190144064;5762.279715035621;5802.419758024206;5590.636608620427;5750.1949727038245;5795.043817770105;5874.588778785486;5877.9118313225335;5446.564274858002;5453.945460545344;5459.836204913859;5461.317335333044;5464;5751.597388182787;5885.323187833454;5942.435468630473;5948.375420580776;5948.821535353946;5714.857128571819;5796.101604251347;5804.593678442553;5834.562407819346;5838.299404071538;5653.604247702704;5658.717064146858;5658.91511627326;5678.119891416837;5678.858028549319;5646.745896434671;5653.971730141323;5660.85847853807;5687.175359572839;5745.425457454221;5716.885662286731;5720.227769251098;5722.170285308607;5723.5707321950185;5760.683162426107;4355.499117601453;4390.056137930296;4391;4394.868153955386;4416.24923762961;3915.4909861717792;3942.56631770505;3995.7402768819934;4012.017055821284;4023.376376661622;5494.230807686927;5507.366652834895;5512.944870551323;5523.143912693539;5530.917036244459;5777.566682498829;5817.738201780845;5819.156222347736;5819.592628516048;5824.504917082011;5347.786088556414;5475.178723191553;5497.752601132958;5567.832965011056;5581.888362232733;5007.749612519359;5050.116229659795;5055.87360315995;5058.64589478733;5075.593952483792;6079.483243924227;6090.786822461193;6101.701685707434;6117.522930757332;6122.916604401382;5717.971410143005;5730.770769169187;5798.420157984337;5833.125031245348;5842.795502157404;6090.23872015998;6094.695265236809;6117.082437634391;6122.112293717297;6126.938730612636;5562.3881373048125;5761.193432919478;5774.307083150049;5775.509081727932;5781.277340332458;5833.358330583717;5896.174535564938;5909.704514774158;5915.852103697442;5947.613405128653;5570.61005729595;5588.469095435927;5600.579956503197;5606.383297837153;5606.439356064361;5571.0807716726285;5588.720563971867;5596.832095037155;5602.1036634138345;5603.187537807076;5594.049011668108;5626.578006649435;5627.43725627434;5628.634138780966;5664.915026274527;5738.225339579103;5740.799072032459;5751.798687045934;5753.05074662676;5757.5393968481585;5349.411564727955;5464.836054918359;5542.8337149885565;5651.660900345993;5666.46168613981 14:20:56 INFO - PROCESS | 9118 | |1;ext.html;530.5437323901447;546.8031508656885;551.5890661457215;568.9402612725663;576.9134629805528;30875.845620771892;31243.68756312436;31415.68584314156;31442.842785786095;39399.40900886489;43562.346564801555;44098.77950610242;44185;44222.33666495005;44268;8831.690890818807;8951.373403861733;9040.502772347518;9057.728268151966;9063.728088157333;8966.86549701755;9119.179273865351;9132.543372831366;9136.177744003038;9137.817243655123;9106.908930910673;9126.361154719172;9199.908000919972;9202.585883635218;9211.493367864765;9083.45499270046;9162.496062716547;9170.816583668322;9172.770680733001;9174.724758257264;9036.638534458614;9196.90803091974;9201.263898888074;9202.861957070649;9203.447793132433;44132.779336103435;44542.33186502205;44642.10715785698;44645.77677111626;44764.77617611924;3617.6563226493704;3625.6736893679695;3639.6906262967677;3819.7135214858995;4290.227759003378;32030.59770517197;32164.517532237034;32868.50697239544;33020;33452;4134.565870583606;4169.061961058768;4192.11965487248;4201.138766552849;4209.621134097915;300139;300682;301214;301585.49207254045;302706;45854.770726146155;64686.6765666178;64778.67610662011;65184.348156518776;65278.347216527225;44830.55169448329;44959.77520112378;45046.77476612596;45090.32364514535;45108;16486.6702665946;16914.238859251116;16960.15199240033;17005.65988680244;17037.57406064858;13331.066825322134;13352.399142038632;13380.866191338157;13401.195928244337;13406;15482.612934676723;15576.844231557767;15582.688346233012;15604.531864044096;15688.450904218298;5897.2333596633025;5905.291365036223;5962.672053037038;5973.581849270597;6028.306744724413;1030.6804890483975;1034.8913364096811;1080.556971641639;1100.3452945497415;1168.696139003865;29111.258258362814;29119;29894;30218.395632087235;30242;1172.402074941786;1191.845060142176;1206.342543313896;1214.338185688784;1261.0668105601972;15375.92312038455;15561;15574;15772.369105235892;15872.44446444369;323534;326453;327126;327740;329016;57270.42729572734;57655;57791.42208577944;57850;57857.4214257852;1372.4373007067054;1389.7498450278845;1473.1823837770141;1480.5484327280283;1585.4530187085436;29497.85251073731;31868.362632747678;32857;33107.668923310455;33280.1679958003;50426;51093.74453127711;51110.23334650058;51262.74368628133;51317;309872;320755;321095;321672;321992;45959.3106103402;46748;47294;47967.520324797704;48204.51795482141;50488;51081.48918510916;51101;51504.74247628738;51871.48128518817;41735;42478.78760606177;43189.56810431981;43222.13555728805;44077.11845763131;42339;42629.36055959101;43176;43465.78267108644;43680.781596091816;41631;41735.7913210432;41954.37068443915;42259.154816902876;42527.574724252365;36831.63168368282;37800;37867.431988520744;38293.617063829006;38449;28352.85823570869;28478.288042799097;28505.28736781597;28588.42823143567;28695.42609147847 14:20:56 INFO - PROCESS | 9118 | |2;jquery.html;378.4588039104081;385.87575397437087;386.3605732512691;390.0716295217382;391.1668146847215;17391.13044347784;18191.45425637231;18762.62474750504;18766;18803.341883034114;17074;17603.55991100223;17834.55413614657;17843.464696059138;17854.107294635247;5138.563222126115;5311.575073994071;5373.946260537384;5375.381831089416;5377.569794416438;3927.5483319418345;5546.972265138689;5747.482726554609;5789.913151302734;5799.159121927339;5768.192453056576;5774.566907481934;5777.480026797587;5797.275340582427;5802.361740208574;5329.520343169114;5508.476694713996;5522.254495643077;5532.502074813266;5544.085225937735;5139.61452891031;5327.227552004976;5329.25390445338;5341.1988201769655;5342.225377320306;13503.392347344394;13663.931680341633;13719.657008574766;13733.107348022346;13861.376238069312;2279.6352583586545;2286.702728645282;2539.911103111382;2779.8610069496444;3034.8786048558254;9809.264305177068;9900.257480688977;9998.200143988464;10346.37921724699;10392;1840.8895466271933;1867.2717640120363;1895.1471837672964;1912.4358314297315;1921.3179321341001;64879.67560162216;67604.32395676078;67903;68353.65823170853;68359.31640683579;9513.619455221851;9836.11474967242;9858.556364963593;9864.852027219598;9908.752281192883;13340.533081342106;13379.264140472173;13429.39567719455;13462.865371346357;13467.797983030263;7352.448566357544;7749.263819937097;7850.371970242367;7857.449978501564;7871.803204919808;7914.24814642608;7936.166702496154;8054;8079.272865442138;8126.9593652032545;4195.1819395217635;4252.213340532012;4296.892577685583;4479.283314669638;4639.118567472169;1720.3720641965592;1775.2721384232402;1808.1230603157458;1838.4590062545492;1890.5368184794538;466.53346653346654;503.60970248057316;511.75435790820615;511.9078565858107;1040.3601784902382;11057.06014988735;11070.5571777128;11394.658160255205;11669.124815638861;11886.643400697993;489.82611173033774;500.31207090250905;504.8409750928519;505.4238168487927;514.385309555078;6291.622502649856;6317;6354.555181137276;6405;6419.2296924369375;459852;468547;477381;477567;483733;82032;84933;85115;85535.57232213924;85964.57017714996;1019.3578045831078;1036.9637062702768;1063.941483218415;1072.0458791675414;1072.0887245840972;16192.190390480193;16220.756688649915;16312.102834344225;16396;16652.084135372672;34501.30997380088;35147.29705405929;35176.472352914214;36161.81919090388;37209;49417.258741118196;51768.74115629549;52308.738456307474;52482.21276680777;53923.460765393414;7762.223777622193;7869.291763741291;7938.801529961797;7946.245106714853;8033.799155021171;11741.76516469683;12441.688957776129;12493.875061249635;13046.282454465096;13161.144525605805;10361.948190259;11343.376114313793;11531.538738450703;11580.42097895085;11819.527218911491;10836.620718275139;10941.28881622692;11072.335659860435;11838.763224735285;12050.758984820079;11812.232204906653;11860.762784744084;11868.940655297014;12362.44369003379;12584.182028168507;8599.39804213699;8735.43219690718;8953.597088130919;8959.507227102571;9070.274378049608;10891.618793342195;11050.944745276222;11202.775944481227;11250.493727782106;11286.266392684778 14:20:56 INFO - PROCESS | 9118 | |3;mootools.html;1457.0601961734674;1588.1265304082754;1614.7254966655667;1843.8248366405196;1945.7956914523975;8278.793030174249;8530.658773649055;8544.401891867572;8549.40154189207;8550.144985501454;8398.706045288416;8572.828543429143;8582.699605513808;8598.44110132841;8598.61306241219;2461.59383701689;2489.0541594194183;2492.7756501914823;2493.127405408102;2493.8004959603277;2447.339218411028;2538.5684433646234;2547.0575886921865;2558.9104381346656;2560.4623029163804;2522.117258959368;2528.1783420388356;2543.6566063581363;2546.172493939468;2547.3631592101974;2459.1270099114827;2466.2971053249826;2481.8759062046825;2495.1142344467635;2501.399664080626;2488.415222422729;2510.3598582361565;2532.3162746058647;2543.9364015899564;2544.2494464133124;7996.08045074818;8016.31861291785;8018.799530011738;8041.477303975223;8050.959745201237;5399.217113518518;5487.588430867661;5524.475174858382;5533.806316778893;5542.63972841768;3304.6695330467;3343.3480471308103;3380.1042723678247;3388.610309814378;3400.472926696366;1088.1023155896416;1139.8689150747605;1147.0651419093494;1154.8960593546537;1164.3130552973787;11919.165658403916;12037.699057523545;12051.638450846402;12093.879061209363;12170.087243456775;4719.976400117977;4720.551547602972;4735.21868891629;4746.454157771831;4773.880652983703;10169.135623472088;10180.592776289013;10205.183585313158;10206.387616743019;10268.07587317145;5347.759350829222;5348.5988550858065;5354;5360.3299587551555;5364.436734142937;4090.202410529918;4651.62786977041;4809;4820.6143508519235;4896.46138924718;4015.4339807475108;4057.107436363995;4090.0592863641527;4118.75287482752;4121.319982202903;1300.8699130087105;1304.373900527733;1309.1228876652665;1314.8159257703928;1344.6705557138368;1369.3632460905726;1374.8006539051783;1390.3604342002793;1397.8602139786144;1416.1432333438327;7599.734009309758;7620.885686714703;7634.732784352521;7687.807804804925;7905.367570594339;556.785637529554;558.154396089924;559.9552035837205;562.9521490673256;566.4052744618134;6015.699215039318;6017.69911504423;6062.514998800086;6073.210482637317;6184.845378865564;10333.74165645865;10873.130149588014;10983.340999540053;11049.723756906142;11069.391183484986;10472.319299245677;10617.946910265553;10772.515236814363;10791.514381852678;10838.78322433547;8253.13342099083;8347.332213423033;8414.410991230556;8433.95783021081;8446.324294056461;7650.2349765023055;7832.138464768985;8053.476524025919;8053.919460805317;8055.516668999879;9410.811783764424;9415.657441608404;9535.952320238355;9590.280728945496;9593.616255349987;9777.608895644094;9783.657571985232;9862.723442957984;10131.746706332106;10136.847947280648;6652.634105124264;7122.60825654594;7365.2634736525915;7377.557346559223;7517.43619228571;8451.535165565707;8487.957560212159;8495.32037437016;8514.233718965323;8534.103919088655;7105;7349.816254593464;7504;7593.5823529706395;7619.1999840016;7322.267773222635;7380.667869945758;7382.926170738224;7468.887966680612;7469.365103966224;7580.393568514395;7586.544807311579;7623.809404764926;7623.923760762322;7625.618719063914;6788.830279243059;6804.149481314836;7032.12098487689;7069.045678833291;7084.539504932163;7181.461390395846;7233.312835280851;7240.456965727697;7293.635318233961;7296.124465064227 14:20:56 INFO - PROCESS | 9118 | |4;prototype.html;358.0993800591512;362.84760400631734;364.96897763690083;366.4375184092419;370.44433349975054;5950.226470558827;5969.343372229062;5979.312379076402;6061.787837425691;6076.787312444066;5918.792842250522;5931.5254779617635;5938.9703051484685;5951.196588460556;5953.196318497002;4469.374287599739;4571.9314210286875;4684.391029166212;4687.2969054641735;4708.293755936603;4679.040796636698;4696.553827386393;4696.765161741916;4699.530046995307;4710.387649605546;4654.418197725285;4660.6970546914345;4661.44062712475;4666.113438446701;4681.344611754357;4427.490838553559;4539.659525535598;4624.884377890546;4639.164950308943;4649.372334734801;4119.855805046839;4121.9587804122175;4130.0294430808735;4134.255833949888;4138;5596.468335508121;5610.607257491977;5612.466815652507;5613.943860561383;5622.887542249173;5413.323334583177;5427.1316589345515;5433.646812957145;5434.510894019518;5434.64674796137;6312.431881130675;6316.715747791314;6319.8104056878365;6322.652254126021;6334.239891213084;4326.762028088454;4442.4669039715445;4463.196624607569;4472.329150627399;4591.79336929839;6502.992036234391;6573.408393244583;6581.2760596334365;6596.340365963413;6602.405783479558;4541.887237626803;4549.772511374418;4552.658550608651;4559.338895860082;4573.5426457354;4614.123316569841;4620.953790462119;4629.537046295343;4639;4644.419447569054;5329.760160792774;5335.3864305604575;5337.466253374709;5349.304590403222;5352.946470535323;6252.717283901772;6292.685365731695;6362.904556431565;6367.808965731036;6385.042243663488;1614.9838501615068;1625.0249850090088;1630.79615048119;1632.7877375941052;1638.7951506061743;1010.9898901010896;1060.7931453366673;1069.8662667166604;1077.8221593437152;1100.1144079016308;6043.516518678495;6057.757689692363;6147.877042459215;6150.354212807591;6157.168782214344;6503.6097834130105;6516.380943810425;6517.087607734921;6518.837029074216;6527.477801775846;6129.662868542184;6135.723892424851;6139.693015349215;6144.41628045335;6144.631322120687;3475.669811367916;3501.492283618861;3504.2465869838106;3513.631068737797;3519.9296014080087;6620.271770105284;6748.797536073926;6754.020667003257;6764.72941082361;6782.626955517395;6646.302138275508;6649.368310010541;6650.068990341356;6710.194776626836;6769.255381907986;6802.489813263926;6824.6928888200155;6835.726570937107;6850.6574671267235;6859.17689877208;6572.539922205399;6572.539922205399;6584.637844918576;6586;6589.374009469093;6239.937600624117;6424.93575064262;6431.585051288709;6439.871202576016;6485.54601177913;6811.89782153278;6827.624480653413;6859.416949559144;6860.3139686031;6866.34769696878;4707.882302942454;4758.04839032188;4761.523847615211;4764.523547645346;4768.237082066853;6535.085088087577;6544.247411547733;6544.770933017321;6548.1814773153355;6556.639384833689;6211.565190436626;6349;6350.841228969312;6367.458766004941;6369.808905732835;6378.2983871774995;6382.489400847828;6435.806925792233;6452.290248072614;6452.483801295791;6313.747450101944;6319.905201422074;6321.241451025906;6335.3981371769605;6397.808065758035;6405.071264666504;6443.226812782309;6468;6470.6441145737435;6473.676316184266;6018.578699490994;6123.407913942318;6143.938560614337;6300.936990630218;6312.621242725451 14:20:56 INFO - PROCESS | 9118 | |5;yui.html;762.0436352377768;846.4032856835928;891.1445012787724;900.7252787899696;919.4191259057519;14856.777148342784;15012.774808377882;15101.169435681033;15148.394064237431;15152.62118447038;13955.092918960261;14071.859281407209;15674.294656740445;15815.446459373925;15840.603984900383;690.6167077272112;905.8958219804724;910.8178364327127;922.2667978956746;922.3589605224372;923.6813299411692;924.6393906376519;924.8843894513186;924.9213816825544;925.1118925831211;970.2335155227362;972.9902700972971;973.026973026973;974.2692980264801;974.4786539201493;725.9491835571512;933.0902370189011;955.9474228917406;960.8030353777493;964.9807003859919;706.1949377709416;706.6043015911106;707.4941416886951;707.9327463890974;708.2987842036398;15250.161241131733;15365.846341536666;15381.230938453144;15383.615409614737;15486.767698484531;13343.86656133436;13646.181229126185;13689.383977721027;13949;14044.648883777885;11501.539938402453;11509.827352589718;11512.827307590393;11531.769364612745;11597.362145082017;3831.8275677594575;3846.7114966377635;3850.0374906273432;3871.128995975911;3898.8635397761227;53890.73054634741;54068.72965635186;54441.45558544403;54839.177412338846;54993.1751023735;10379.377237365783;10851.457427128613;10854.72863178411;11004.174686898514;11204.327740335606;19838.107285171915;19868.304609338604;19905.900470497556;19911.203551857765;19938.20247190096;8041.718539851077;8118.918810811934;8190.672373105128;8412.074671786098;8443.493390396596;4558.703684260512;4679.906401871944;4683.555062269079;4710.105080034782;4803.927941080887;3515.3848076586496;3531.947020794639;3532.982335088308;3569.6787289144104;3571.482135090397;574.7097715653651;587.5769445998874;593.2673148661399;599.7600959616101;608.4159207161175;682.2427105912433;691.401937324211;693.920199177091;698.4831224893644;704.3660705365212;8098.3116435103675;8109.837803243902;8379.664813407517;8719.869201961976;9069.501177435304;596.4512648363516;718.795143384133;719.2986837833071;719.6078137415121;729.8138974561452;4076.144009757925;4159.604837540429;4201.432806571135;4263.722858014219;4337.219300525936;54403;54943.17585236225;55010.17484737732;58773;60262;47339.97610203172;47527.67306288596;47830.28254576184;47878.5212147881;53187.734061329444;46021.53978460172;46753.5324646756;51693;51718.482815172116;53712.99999999922;8644.438111522732;8894.221155768742;8921.107889211287;8996.955015224881;9075.636974521209;34769.30461390808;37049;37992;38409.50338228118;40494.79752601218;48989.755051224514;49251.75374123106;49595.75202123966;49735.75132124316;50784;11632.825507617561;11633;11922.225055371373;11983.64049078529;12062.638120856389;12354.876451235372;12589;12650.30423326726;12838.935805320914;12965.611031669065;11285.830712539482;11298.322100673986;11375.829362559403;11464.656060318204;11835.408229588314;11437.08503319749;11459.25514841566;11607.30356178632;11886.940565297118;12054.879451205727;10646.520906559379;10773.946130269613;10918.836217456903;11099.72250693739;11167.106631469625;9641.37331073478;10144.239182061227;10207.183425326104;10394.168466522811;10578.259521833397;9324.533773311172;9587;9707.174890134134;9717.6598819041;9731.951340243253 14:20:56 INFO - PROCESS | 9118 | __end_tp_report 14:20:56 INFO - PROCESS | 9118 | __start_cc_report 14:20:56 INFO - PROCESS | 9118 | _x_x_mozilla_cycle_collect,827 14:20:56 INFO - PROCESS | 9118 | __end_cc_report 14:20:56 INFO - PROCESS | 9118 | __startTimestamp1463174456110__endTimestamp 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | ------- Summary: start ------- 14:20:56 INFO - PROCESS | 9118 | Number of tests: 6 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | [#0] dojo.html Cycles:165 Average:5393.59 Median:5588.72 stddev:585.41 (10.5%) stddev-sans-first:563.86 14:20:56 INFO - PROCESS | 9118 | Values: 3306.9 3376.4 3390.6 3392.0 3407.8 5416.3 5428.5 5428.7 5436.4 5456.4 5402.0 5415.4 5441.8 5445.2 5448.9 4797.2 4924.2 4987.7 5005.2 5037.8 4901.6 4917.5 4989.8 5005.9 5021.7 4956.1 5025.9 5043.9 5062.1 5070.1 4915.0 4969.6 4970.7 4986.4 5006.4 4811.7 4899.0 4939.2 4960.1 4982.6 5160.8 5176.7 5176.9 5183.3 5193.7 5759.1 5759.9 5762.0 5762.3 5802.4 5590.6 5750.2 5795.0 5874.6 5877.9 5446.6 5453.9 5459.8 5461.3 5464.0 5751.6 5885.3 5942.4 5948.4 5948.8 5714.9 5796.1 5804.6 5834.6 5838.3 5653.6 5658.7 5658.9 5678.1 5678.9 5646.7 5654.0 5660.9 5687.2 5745.4 5716.9 5720.2 5722.2 5723.6 5760.7 4355.5 4390.1 4391.0 4394.9 4416.2 3915.5 3942.6 3995.7 4012.0 4023.4 5494.2 5507.4 5512.9 5523.1 5530.9 5777.6 5817.7 5819.2 5819.6 5824.5 5347.8 5475.2 5497.8 5567.8 5581.9 5007.7 5050.1 5055.9 5058.6 5075.6 6079.5 6090.8 6101.7 6117.5 6122.9 5718.0 5730.8 5798.4 5833.1 5842.8 6090.2 6094.7 6117.1 6122.1 6126.9 5562.4 5761.2 5774.3 5775.5 5781.3 5833.4 5896.2 5909.7 5915.9 5947.6 5570.6 5588.5 5600.6 5606.4 5606.4 5571.1 5588.7 5596.8 5602.1 5603.2 5594.0 5626.6 5627.4 5628.6 5664.9 5738.2 5740.8 5751.8 5753.1 5757.5 5349.4 5464.8 5542.8 5651.7 5666.5 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | [#1] ext.html Cycles:180 Average:49893.62 Median:23077.75 stddev:82476.90 (357.4%) stddev-sans-first:82624.99 14:20:56 INFO - PROCESS | 9118 | Values: 530.5 546.8 551.6 568.9 576.9 30875.8 31243.7 31415.7 31442.8 39399.4 43562.3 44098.8 44185.0 44222.3 44268.0 8831.7 8951.4 9040.5 9057.7 9063.7 8966.9 9119.2 9132.5 9136.2 9137.8 9106.9 9126.4 9199.9 9202.6 9211.5 9083.5 9162.5 9170.8 9172.8 9174.7 9036.6 9196.9 9201.3 9202.9 9203.4 44132.8 44542.3 44642.1 44645.8 44764.8 3617.7 3625.7 3639.7 3819.7 4290.2 32030.6 32164.5 32868.5 33020.0 33452.0 4134.6 4169.1 4192.1 4201.1 4209.6 300139.0 300682.0 301214.0 301585.5 302706.0 45854.8 64686.7 64778.7 65184.3 65278.3 44830.6 44959.8 45046.8 45090.3 45108.0 16486.7 16914.2 16960.2 17005.7 17037.6 13331.1 13352.4 13380.9 13401.2 13406.0 15482.6 15576.8 15582.7 15604.5 15688.5 5897.2 5905.3 5962.7 5973.6 6028.3 1030.7 1034.9 1080.6 1100.3 1168.7 29111.3 29119.0 29894.0 30218.4 30242.0 1172.4 1191.8 1206.3 1214.3 1261.1 15375.9 15561.0 15574.0 15772.4 15872.4 323534.0 326453.0 327126.0 327740.0 329016.0 57270.4 57655.0 57791.4 57850.0 57857.4 1372.4 1389.7 1473.2 1480.5 1585.5 29497.9 31868.4 32857.0 33107.7 33280.2 50426.0 51093.7 51110.2 51262.7 51317.0 309872.0 320755.0 321095.0 321672.0 321992.0 45959.3 46748.0 47294.0 47967.5 48204.5 50488.0 51081.5 51101.0 51504.7 51871.5 41735.0 42478.8 43189.6 43222.1 44077.1 42339.0 42629.4 43176.0 43465.8 43680.8 41631.0 41735.8 41954.4 42259.2 42527.6 36831.6 37800.0 37867.4 38293.6 38449.0 28352.9 28478.3 28505.3 28588.4 28695.4 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | [#2] jquery.html Cycles:180 Average:26716.25 Median:4274.55 stddev:77852.99 (1821.3%) stddev-sans-first:78046.27 14:20:56 INFO - PROCESS | 9118 | Values: 378.5 385.9 386.4 390.1 391.2 17391.1 18191.5 18762.6 18766.0 18803.3 17074.0 17603.6 17834.6 17843.5 17854.1 5138.6 5311.6 5373.9 5375.4 5377.6 3927.5 5547.0 5747.5 5789.9 5799.2 5768.2 5774.6 5777.5 5797.3 5802.4 5329.5 5508.5 5522.3 5532.5 5544.1 5139.6 5327.2 5329.3 5341.2 5342.2 13503.4 13663.9 13719.7 13733.1 13861.4 2279.6 2286.7 2539.9 2779.9 3034.9 9809.3 9900.3 9998.2 10346.4 10392.0 1840.9 1867.3 1895.1 1912.4 1921.3 64879.7 67604.3 67903.0 68353.7 68359.3 9513.6 9836.1 9858.6 9864.9 9908.8 13340.5 13379.3 13429.4 13462.9 13467.8 7352.4 7749.3 7850.4 7857.4 7871.8 7914.2 7936.2 8054.0 8079.3 8127.0 4195.2 4252.2 4296.9 4479.3 4639.1 1720.4 1775.3 1808.1 1838.5 1890.5 466.5 503.6 511.8 511.9 1040.4 11057.1 11070.6 11394.7 11669.1 11886.6 489.8 500.3 504.8 505.4 514.4 6291.6 6317.0 6354.6 6405.0 6419.2 459852.0 468547.0 477381.0 477567.0 483733.0 82032.0 84933.0 85115.0 85535.6 85964.6 1019.4 1037.0 1063.9 1072.0 1072.1 16192.2 16220.8 16312.1 16396.0 16652.1 34501.3 35147.3 35176.5 36161.8 37209.0 49417.3 51768.7 52308.7 52482.2 53923.5 7762.2 7869.3 7938.8 7946.2 8033.8 11741.8 12441.7 12493.9 13046.3 13161.1 10361.9 11343.4 11531.5 11580.4 11819.5 10836.6 10941.3 11072.3 11838.8 12050.8 11812.2 11860.8 11868.9 12362.4 12584.2 8599.4 8735.4 8953.6 8959.5 9070.3 10891.6 11050.9 11202.8 11250.5 11286.3 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | [#3] mootools.html Cycles:180 Average:6030.57 Median:5362.38 stddev:3191.77 (59.5%) stddev-sans-first:3182.21 14:20:56 INFO - PROCESS | 9118 | Values: 1457.1 1588.1 1614.7 1843.8 1945.8 8278.8 8530.7 8544.4 8549.4 8550.1 8398.7 8572.8 8582.7 8598.4 8598.6 2461.6 2489.1 2492.8 2493.1 2493.8 2447.3 2538.6 2547.1 2558.9 2560.5 2522.1 2528.2 2543.7 2546.2 2547.4 2459.1 2466.3 2481.9 2495.1 2501.4 2488.4 2510.4 2532.3 2543.9 2544.2 7996.1 8016.3 8018.8 8041.5 8051.0 5399.2 5487.6 5524.5 5533.8 5542.6 3304.7 3343.3 3380.1 3388.6 3400.5 1088.1 1139.9 1147.1 1154.9 1164.3 11919.2 12037.7 12051.6 12093.9 12170.1 4720.0 4720.6 4735.2 4746.5 4773.9 10169.1 10180.6 10205.2 10206.4 10268.1 5347.8 5348.6 5354.0 5360.3 5364.4 4090.2 4651.6 4809.0 4820.6 4896.5 4015.4 4057.1 4090.1 4118.8 4121.3 1300.9 1304.4 1309.1 1314.8 1344.7 1369.4 1374.8 1390.4 1397.9 1416.1 7599.7 7620.9 7634.7 7687.8 7905.4 556.8 558.2 560.0 563.0 566.4 6015.7 6017.7 6062.5 6073.2 6184.8 10333.7 10873.1 10983.3 11049.7 11069.4 10472.3 10617.9 10772.5 10791.5 10838.8 8253.1 8347.3 8414.4 8434.0 8446.3 7650.2 7832.1 8053.5 8053.9 8055.5 9410.8 9415.7 9536.0 9590.3 9593.6 9777.6 9783.7 9862.7 10131.7 10136.8 6652.6 7122.6 7365.3 7377.6 7517.4 8451.5 8488.0 8495.3 8514.2 8534.1 7105.0 7349.8 7504.0 7593.6 7619.2 7322.3 7380.7 7382.9 7468.9 7469.4 7580.4 7586.5 7623.8 7623.9 7625.6 6788.8 6804.1 7032.1 7069.0 7084.5 7181.5 7233.3 7240.5 7293.6 7296.1 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | [#4] prototype.html Cycles:180 Average:5342.09 Median:6059.77 stddev:1588.72 (26.2%) stddev-sans-first:1548.51 14:20:56 INFO - PROCESS | 9118 | Values: 358.1 362.8 365.0 366.4 370.4 5950.2 5969.3 5979.3 6061.8 6076.8 5918.8 5931.5 5939.0 5951.2 5953.2 4469.4 4571.9 4684.4 4687.3 4708.3 4679.0 4696.6 4696.8 4699.5 4710.4 4654.4 4660.7 4661.4 4666.1 4681.3 4427.5 4539.7 4624.9 4639.2 4649.4 4119.9 4122.0 4130.0 4134.3 4138.0 5596.5 5610.6 5612.5 5613.9 5622.9 5413.3 5427.1 5433.6 5434.5 5434.6 6312.4 6316.7 6319.8 6322.7 6334.2 4326.8 4442.5 4463.2 4472.3 4591.8 6503.0 6573.4 6581.3 6596.3 6602.4 4541.9 4549.8 4552.7 4559.3 4573.5 4614.1 4621.0 4629.5 4639.0 4644.4 5329.8 5335.4 5337.5 5349.3 5352.9 6252.7 6292.7 6362.9 6367.8 6385.0 1615.0 1625.0 1630.8 1632.8 1638.8 1011.0 1060.8 1069.9 1077.8 1100.1 6043.5 6057.8 6147.9 6150.4 6157.2 6503.6 6516.4 6517.1 6518.8 6527.5 6129.7 6135.7 6139.7 6144.4 6144.6 3475.7 3501.5 3504.2 3513.6 3519.9 6620.3 6748.8 6754.0 6764.7 6782.6 6646.3 6649.4 6650.1 6710.2 6769.3 6802.5 6824.7 6835.7 6850.7 6859.2 6572.5 6572.5 6584.6 6586.0 6589.4 6239.9 6424.9 6431.6 6439.9 6485.5 6811.9 6827.6 6859.4 6860.3 6866.3 4707.9 4758.0 4761.5 4764.5 4768.2 6535.1 6544.2 6544.8 6548.2 6556.6 6211.6 6349.0 6350.8 6367.5 6369.8 6378.3 6382.5 6435.8 6452.3 6452.5 6313.7 6319.9 6321.2 6335.4 6397.8 6405.1 6443.2 6468.0 6470.6 6473.7 6018.6 6123.4 6143.9 6300.9 6312.6 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - PROCESS | 9118 | [#5] yui.html Cycles:180 Average:14620.46 Median:47433.82 stddev:16692.66 (35.2%) stddev-sans-first:16707.05 14:20:56 INFO - PROCESS | 9118 | Values: 762.0 846.4 891.1 900.7 919.4 14856.8 15012.8 15101.2 15148.4 15152.6 13955.1 14071.9 15674.3 15815.4 15840.6 690.6 905.9 910.8 922.3 922.4 923.7 924.6 924.9 924.9 925.1 970.2 973.0 973.0 974.3 974.5 725.9 933.1 955.9 960.8 965.0 706.2 706.6 707.5 707.9 708.3 15250.2 15365.8 15381.2 15383.6 15486.8 13343.9 13646.2 13689.4 13949.0 14044.6 11501.5 11509.8 11512.8 11531.8 11597.4 3831.8 3846.7 3850.0 3871.1 3898.9 53890.7 54068.7 54441.5 54839.2 54993.2 10379.4 10851.5 10854.7 11004.2 11204.3 19838.1 19868.3 19905.9 19911.2 19938.2 8041.7 8118.9 8190.7 8412.1 8443.5 4558.7 4679.9 4683.6 4710.1 4803.9 3515.4 3531.9 3533.0 3569.7 3571.5 574.7 587.6 593.3 599.8 608.4 682.2 691.4 693.9 698.5 704.4 8098.3 8109.8 8379.7 8719.9 9069.5 596.5 718.8 719.3 719.6 729.8 4076.1 4159.6 4201.4 4263.7 4337.2 54403.0 54943.2 55010.2 58773.0 60262.0 47340.0 47527.7 47830.3 47878.5 53187.7 46021.5 46753.5 51693.0 51718.5 53713.0 8644.4 8894.2 8921.1 8997.0 9075.6 34769.3 37049.0 37992.0 38409.5 40494.8 48989.8 49251.8 49595.8 49735.8 50784.0 11632.8 11633.0 11922.2 11983.6 12062.6 12354.9 12589.0 12650.3 12838.9 12965.6 11285.8 11298.3 11375.8 11464.7 11835.4 11437.1 11459.3 11607.3 11886.9 12054.9 10646.5 10773.9 10918.8 11099.7 11167.1 9641.4 10144.2 10207.2 10394.2 10578.3 9324.5 9587.0 9707.2 9717.7 9732.0 14:20:56 INFO - PROCESS | 9118 | -------- Summary: end -------- 14:20:56 INFO - PROCESS | 9118 | 14:20:56 INFO - TEST-INFO | 9118: exit 0 14:20:56 INFO - TEST-OK | dromaeo_css | took 1111560ms 14:20:56 INFO - TEST-START | kraken 14:20:56 INFO - operating with platform_type : linux_ 14:20:56 INFO - Initialising browser for kraken test... 14:20:56 INFO - TEST-INFO | started process 9311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKU7xQF/profile http://localhost:55738/getInfo.html) 14:21:01 INFO - PROCESS | 9311 | __metrics Screen width/height:1600/1200 14:21:01 INFO - PROCESS | 9311 | colorDepth:24 14:21:01 INFO - PROCESS | 9311 | Browser inner width/height: 1024/697 14:21:01 INFO - PROCESS | 9311 | __metrics 14:21:02 INFO - PROCESS | 9311 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:02 INFO - TEST-INFO | 9311: exit 0 14:21:02 INFO - Browser initialized. 14:21:02 INFO - Running cycle 1/1 for kraken test... 14:21:02 INFO - TEST-INFO | started process 9400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKU7xQF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:14 INFO - PROCESS | 9400 | RSS: Main: 139628544 14:21:14 INFO - PROCESS | 9400 | 14:21:17 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:17 INFO - PROCESS | 9400 | RSS: Main: 173813760 14:21:17 INFO - PROCESS | 9400 | 14:21:20 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-dft) 14:21:21 INFO - PROCESS | 9400 | RSS: Main: 172425216 14:21:21 INFO - PROCESS | 9400 | 14:21:23 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-fft) 14:21:24 INFO - PROCESS | 9400 | RSS: Main: 168861696 14:21:24 INFO - PROCESS | 9400 | 14:21:26 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-oscillator) 14:21:27 INFO - PROCESS | 9400 | RSS: Main: 169963520 14:21:27 INFO - PROCESS | 9400 | 14:21:29 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55738/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:21:29 INFO - PROCESS | 9400 | RSS: Main: 167550976 14:21:29 INFO - PROCESS | 9400 | 14:21:32 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55738/tests/kraken/driver.html?testName=imaging-darkroom) 14:21:33 INFO - PROCESS | 9400 | RSS: Main: 167329792 14:21:33 INFO - PROCESS | 9400 | 14:21:36 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55738/tests/kraken/driver.html?testName=imaging-desaturate) 14:21:37 INFO - PROCESS | 9400 | RSS: Main: 167215104 14:21:37 INFO - PROCESS | 9400 | 14:21:40 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55738/tests/kraken/driver.html?testName=json-parse-financial) 14:21:40 INFO - PROCESS | 9400 | RSS: Main: 167075840 14:21:40 INFO - PROCESS | 9400 | 14:21:42 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55738/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:42 INFO - PROCESS | 9400 | RSS: Main: 172253184 14:21:42 INFO - PROCESS | 9400 | 14:21:44 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:45 INFO - PROCESS | 9400 | RSS: Main: 170250240 14:21:45 INFO - PROCESS | 9400 | 14:21:47 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:47 INFO - PROCESS | 9400 | RSS: Main: 176783360 14:21:47 INFO - PROCESS | 9400 | 14:21:50 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:50 INFO - PROCESS | 9400 | RSS: Main: 181243904 14:21:50 INFO - PROCESS | 9400 | 14:21:53 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:53 INFO - PROCESS | 9400 | RSS: Main: 179146752 14:21:53 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55738/tests/kraken/driver.html?testName=ai-astar) 14:21:55 INFO - PROCESS | 9400 | RSS: Main: 241868800 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | __start_tp_report 14:21:55 INFO - PROCESS | 9400 | _x_x_mozilla_page_load 14:21:55 INFO - PROCESS | 9400 | _x_x_mozilla_page_load_details 14:21:55 INFO - PROCESS | 9400 | |i|pagename|runs| 14:21:55 INFO - PROCESS | 9400 | |0;ai-astar;111;110;104;108;109;111;99;109;108;108 14:21:55 INFO - PROCESS | 9400 | |1;audio-beat-detection;154;132;157;165;128;154;161;128;168;128 14:21:55 INFO - PROCESS | 9400 | |2;audio-dft;162;161;165;160;159;160;159;164;162;161 14:21:55 INFO - PROCESS | 9400 | |3;audio-fft;77;75;75;165;75;74;76;74;163;76 14:21:55 INFO - PROCESS | 9400 | |4;audio-oscillator;93;93;155;93;93;93;140;93;93;147 14:21:55 INFO - PROCESS | 9400 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;117;117 14:21:55 INFO - PROCESS | 9400 | |6;imaging-darkroom;149;146;148;146;148;146;146;147;146;146 14:21:55 INFO - PROCESS | 9400 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;96 14:21:55 INFO - PROCESS | 9400 | |8;json-parse-financial;57;56;56;57;58;65;57;57;62;54 14:21:55 INFO - PROCESS | 9400 | |9;json-stringify-tinderbox;65;65;65;66;65;65;66;65;65;65 14:21:55 INFO - PROCESS | 9400 | |10;stanford-crypto-aes;79;78;78;78;77;78;85;79;78;78 14:21:55 INFO - PROCESS | 9400 | |11;stanford-crypto-ccm;115;111;116;123;122;132;119;115;115;112 14:21:55 INFO - PROCESS | 9400 | |12;stanford-crypto-pbkdf2;151;139;158;147;137;139;151;150;148;148 14:21:55 INFO - PROCESS | 9400 | |13;stanford-crypto-sha256-iterative;73;68;68;69;69;67;68;76;67;67 14:21:55 INFO - PROCESS | 9400 | __end_tp_report 14:21:55 INFO - PROCESS | 9400 | __start_cc_report 14:21:55 INFO - PROCESS | 9400 | _x_x_mozilla_cycle_collect,1069 14:21:55 INFO - PROCESS | 9400 | __end_cc_report 14:21:55 INFO - PROCESS | 9400 | __startTimestamp1463174515841__endTimestamp 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | ------- Summary: start ------- 14:21:55 INFO - PROCESS | 9400 | Number of tests: 14 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:3.65 (3.3%) stddev-sans-first:3.67 14:21:55 INFO - PROCESS | 9400 | Values: 111.0 110.0 104.0 108.0 109.0 111.0 99.0 109.0 108.0 108.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:155.50 stddev:16.55 (10.6%) stddev-sans-first:17.38 14:21:55 INFO - PROCESS | 9400 | Values: 154.0 132.0 157.0 165.0 128.0 154.0 161.0 128.0 168.0 128.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:2.00 (1.2%) stddev-sans-first:2.11 14:21:55 INFO - PROCESS | 9400 | Values: 162.0 161.0 165.0 160.0 159.0 160.0 159.0 164.0 162.0 161.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:37.43 (49.9%) stddev-sans-first:39.25 14:21:55 INFO - PROCESS | 9400 | Values: 77.0 75.0 75.0 165.0 75.0 74.0 76.0 74.0 163.0 76.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:93.00 stddev:26.48 (28.5%) stddev-sans-first:27.42 14:21:55 INFO - PROCESS | 9400 | Values: 93.0 93.0 155.0 93.0 93.0 93.0 140.0 93.0 93.0 147.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:21:55 INFO - PROCESS | 9400 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.14 (0.8%) stddev-sans-first:0.88 14:21:55 INFO - PROCESS | 9400 | Values: 149.0 146.0 148.0 146.0 148.0 146.0 146.0 147.0 146.0 146.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:21:55 INFO - PROCESS | 9400 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.00 stddev:3.21 (5.6%) stddev-sans-first:3.39 14:21:55 INFO - PROCESS | 9400 | Values: 57.0 56.0 56.0 57.0 58.0 65.0 57.0 57.0 62.0 54.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 14:21:55 INFO - PROCESS | 9400 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.25 (2.9%) stddev-sans-first:2.39 14:21:55 INFO - PROCESS | 9400 | Values: 79.0 78.0 78.0 78.0 77.0 78.0 85.0 79.0 78.0 78.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:117.50 stddev:6.27 (5.3%) stddev-sans-first:6.56 14:21:55 INFO - PROCESS | 9400 | Values: 115.0 111.0 116.0 123.0 122.0 132.0 119.0 115.0 115.0 112.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:149.00 stddev:6.60 (4.4%) stddev-sans-first:6.82 14:21:55 INFO - PROCESS | 9400 | Values: 151.0 139.0 158.0 147.0 137.0 139.0 151.0 150.0 148.0 148.0 14:21:55 INFO - PROCESS | 9400 | 14:21:55 INFO - PROCESS | 9400 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.50 stddev:2.97 (4.3%) stddev-sans-first:2.82 14:21:55 INFO - PROCESS | 9400 | Values: 73.0 68.0 68.0 69.0 69.0 67.0 68.0 76.0 67.0 67.0 14:21:55 INFO - PROCESS | 9400 | -------- Summary: end -------- 14:21:55 INFO - PROCESS | 9400 | 14:21:56 INFO - TEST-INFO | 9400: exit 0 14:21:56 INFO - TEST-OK | kraken | took 60009ms 14:21:56 INFO - SUITE-END | took 1171s 14:21:56 INFO - Completed test suite (00:19:31) 14:21:56 INFO - javascript benchmark 14:21:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3306.9338613227737, 3376.4260075787115, 3390.64398238185, 3391.9660803391957, 3407.8296085195743, 5416.2958815353995, 5428.484293992069, 5428.728563571821, 5436.374816896058, 5456.372517160517, 5402.0, 5415.431379705134, 5441.782328706857, 5445.237666726662, 5448.891022179554, 4797.184478638623, 4924.236743304785, 4987.650864439491, 5005.174146265862, 5037.773300201499, 4901.583365413926, 4917.459079501252, 4989.825356112537, 5005.874853128665, 5021.748912554376, 4956.083124621939, 5025.874353141164, 5043.873903152414, 5062.0888240116765, 5070.08738427083, 4914.975425122851, 4969.627277954168, 4970.676906001135, 4986.4265609455015, 5006.424261209971, 4811.687240329403, 4898.975505122487, 4939.234418665113, 4960.082384758831, 4982.60139188864, 5160.845174644729, 5176.741162941876, 5176.948230517722, 5183.3261675981885, 5193.714345710984, 5759.107338362561, 5759.913601295942, 5761.971190144064, 5762.279715035621, 5802.419758024206, 5590.636608620427, 5750.1949727038245, 5795.043817770105, 5874.588778785486, 5877.9118313225335, 5446.564274858002, 5453.945460545344, 5459.836204913859, 5461.317335333044, 5464.0, 5751.597388182787, 5885.323187833454, 5942.435468630473, 5948.375420580776, 5948.821535353946, 5714.857128571819, 5796.101604251347, 5804.593678442553, 5834.562407819346, 5838.299404071538, 5653.604247702704, 5658.717064146858, 5658.91511627326, 5678.119891416837, 5678.858028549319, 5646.745896434671, 5653.971730141323, 5660.85847853807, 5687.175359572839, 5745.425457454221, 5716.885662286731, 5720.227769251098, 5722.170285308607, 5723.5707321950185, 5760.683162426107, 4355.499117601453, 4390.056137930296, 4391.0, 4394.868153955386, 4416.24923762961, 3915.4909861717792, 3942.56631770505, 3995.7402768819934, 4012.017055821284, 4023.376376661622, 5494.230807686927, 5507.366652834895, 5512.944870551323, 5523.143912693539, 5530.917036244459, 5777.566682498829, 5817.738201780845, 5819.156222347736, 5819.592628516048, 5824.504917082011, 5347.786088556414, 5475.178723191553, 5497.752601132958, 5567.832965011056, 5581.888362232733, 5007.749612519359, 5050.116229659795, 5055.87360315995, 5058.64589478733, 5075.593952483792, 6079.483243924227, 6090.786822461193, 6101.701685707434, 6117.522930757332, 6122.916604401382, 5717.971410143005, 5730.770769169187, 5798.420157984337, 5833.125031245348, 5842.795502157404, 6090.23872015998, 6094.695265236809, 6117.082437634391, 6122.112293717297, 6126.938730612636, 5562.3881373048125, 5761.193432919478, 5774.307083150049, 5775.509081727932, 5781.277340332458, 5833.358330583717, 5896.174535564938, 5909.704514774158, 5915.852103697442, 5947.613405128653, 5570.61005729595, 5588.469095435927, 5600.579956503197, 5606.383297837153, 5606.439356064361, 5571.0807716726285, 5588.720563971867, 5596.832095037155, 5602.1036634138345, 5603.187537807076, 5594.049011668108, 5626.578006649435, 5627.43725627434, 5628.634138780966, 5664.915026274527, 5738.225339579103, 5740.799072032459, 5751.798687045934, 5753.05074662676, 5757.5393968481585, 5349.411564727955, 5464.836054918359, 5542.8337149885565, 5651.660900345993, 5666.46168613981], "unit": "score", "name": "dojo.html", "value": 5357.018291522703}, {"lowerIsBetter": false, "replicates": [530.5437323901447, 546.8031508656885, 551.5890661457215, 568.9402612725663, 576.9134629805528, 30875.845620771892, 31243.68756312436, 31415.68584314156, 31442.842785786095, 39399.40900886489, 43562.346564801555, 44098.77950610242, 44185.0, 44222.33666495005, 44268.0, 8831.690890818807, 8951.373403861733, 9040.502772347518, 9057.728268151966, 9063.728088157333, 8966.86549701755, 9119.179273865351, 9132.543372831366, 9136.177744003038, 9137.817243655123, 9106.908930910673, 9126.361154719172, 9199.908000919972, 9202.585883635218, 9211.493367864765, 9083.45499270046, 9162.496062716547, 9170.816583668322, 9172.770680733001, 9174.724758257264, 9036.638534458614, 9196.90803091974, 9201.263898888074, 9202.861957070649, 9203.447793132433, 44132.779336103435, 44542.33186502205, 44642.10715785698, 44645.77677111626, 44764.77617611924, 3617.6563226493704, 3625.6736893679695, 3639.6906262967677, 3819.7135214858995, 4290.227759003378, 32030.59770517197, 32164.517532237034, 32868.50697239544, 33020.0, 33452.0, 4134.565870583606, 4169.061961058768, 4192.11965487248, 4201.138766552849, 4209.621134097915, 300139.0, 300682.0, 301214.0, 301585.49207254045, 302706.0, 45854.770726146155, 64686.6765666178, 64778.67610662011, 65184.348156518776, 65278.347216527225, 44830.55169448329, 44959.77520112378, 45046.77476612596, 45090.32364514535, 45108.0, 16486.6702665946, 16914.238859251116, 16960.15199240033, 17005.65988680244, 17037.57406064858, 13331.066825322134, 13352.399142038632, 13380.866191338157, 13401.195928244337, 13406.0, 15482.612934676723, 15576.844231557767, 15582.688346233012, 15604.531864044096, 15688.450904218298, 5897.2333596633025, 5905.291365036223, 5962.672053037038, 5973.581849270597, 6028.306744724413, 1030.6804890483975, 1034.8913364096811, 1080.556971641639, 1100.3452945497415, 1168.696139003865, 29111.258258362814, 29119.0, 29894.0, 30218.395632087235, 30242.0, 1172.402074941786, 1191.845060142176, 1206.342543313896, 1214.338185688784, 1261.0668105601972, 15375.92312038455, 15561.0, 15574.0, 15772.369105235892, 15872.44446444369, 323534.0, 326453.0, 327126.0, 327740.0, 329016.0, 57270.42729572734, 57655.0, 57791.42208577944, 57850.0, 57857.4214257852, 1372.4373007067054, 1389.7498450278845, 1473.1823837770141, 1480.5484327280283, 1585.4530187085436, 29497.85251073731, 31868.362632747678, 32857.0, 33107.668923310455, 33280.1679958003, 50426.0, 51093.74453127711, 51110.23334650058, 51262.74368628133, 51317.0, 309872.0, 320755.0, 321095.0, 321672.0, 321992.0, 45959.3106103402, 46748.0, 47294.0, 47967.520324797704, 48204.51795482141, 50488.0, 51081.48918510916, 51101.0, 51504.74247628738, 51871.48128518817, 41735.0, 42478.78760606177, 43189.56810431981, 43222.13555728805, 44077.11845763131, 42339.0, 42629.36055959101, 43176.0, 43465.78267108644, 43680.781596091816, 41631.0, 41735.7913210432, 41954.37068443915, 42259.154816902876, 42527.574724252365, 36831.63168368282, 37800.0, 37867.431988520744, 38293.617063829006, 38449.0, 28352.85823570869, 28478.288042799097, 28505.28736781597, 28588.42823143567, 28695.42609147847], "unit": "score", "name": "ext.html", "value": 19648.687849971404}, {"lowerIsBetter": false, "replicates": [378.4588039104081, 385.87575397437087, 386.3605732512691, 390.0716295217382, 391.1668146847215, 17391.13044347784, 18191.45425637231, 18762.62474750504, 18766.0, 18803.341883034114, 17074.0, 17603.55991100223, 17834.55413614657, 17843.464696059138, 17854.107294635247, 5138.563222126115, 5311.575073994071, 5373.946260537384, 5375.381831089416, 5377.569794416438, 3927.5483319418345, 5546.972265138689, 5747.482726554609, 5789.913151302734, 5799.159121927339, 5768.192453056576, 5774.566907481934, 5777.480026797587, 5797.275340582427, 5802.361740208574, 5329.520343169114, 5508.476694713996, 5522.254495643077, 5532.502074813266, 5544.085225937735, 5139.61452891031, 5327.227552004976, 5329.25390445338, 5341.1988201769655, 5342.225377320306, 13503.392347344394, 13663.931680341633, 13719.657008574766, 13733.107348022346, 13861.376238069312, 2279.6352583586545, 2286.702728645282, 2539.911103111382, 2779.8610069496444, 3034.8786048558254, 9809.264305177068, 9900.257480688977, 9998.200143988464, 10346.37921724699, 10392.0, 1840.8895466271933, 1867.2717640120363, 1895.1471837672964, 1912.4358314297315, 1921.3179321341001, 64879.67560162216, 67604.32395676078, 67903.0, 68353.65823170853, 68359.31640683579, 9513.619455221851, 9836.11474967242, 9858.556364963593, 9864.852027219598, 9908.752281192883, 13340.533081342106, 13379.264140472173, 13429.39567719455, 13462.865371346357, 13467.797983030263, 7352.448566357544, 7749.263819937097, 7850.371970242367, 7857.449978501564, 7871.803204919808, 7914.24814642608, 7936.166702496154, 8054.0, 8079.272865442138, 8126.9593652032545, 4195.1819395217635, 4252.213340532012, 4296.892577685583, 4479.283314669638, 4639.118567472169, 1720.3720641965592, 1775.2721384232402, 1808.1230603157458, 1838.4590062545492, 1890.5368184794538, 466.53346653346654, 503.60970248057316, 511.75435790820615, 511.9078565858107, 1040.3601784902382, 11057.06014988735, 11070.5571777128, 11394.658160255205, 11669.124815638861, 11886.643400697993, 489.82611173033774, 500.31207090250905, 504.8409750928519, 505.4238168487927, 514.385309555078, 6291.622502649856, 6317.0, 6354.555181137276, 6405.0, 6419.2296924369375, 459852.0, 468547.0, 477381.0, 477567.0, 483733.0, 82032.0, 84933.0, 85115.0, 85535.57232213924, 85964.57017714996, 1019.3578045831078, 1036.9637062702768, 1063.941483218415, 1072.0458791675414, 1072.0887245840972, 16192.190390480193, 16220.756688649915, 16312.102834344225, 16396.0, 16652.084135372672, 34501.30997380088, 35147.29705405929, 35176.472352914214, 36161.81919090388, 37209.0, 49417.258741118196, 51768.74115629549, 52308.738456307474, 52482.21276680777, 53923.460765393414, 7762.223777622193, 7869.291763741291, 7938.801529961797, 7946.245106714853, 8033.799155021171, 11741.76516469683, 12441.688957776129, 12493.875061249635, 13046.282454465096, 13161.144525605805, 10361.948190259, 11343.376114313793, 11531.538738450703, 11580.42097895085, 11819.527218911491, 10836.620718275139, 10941.28881622692, 11072.335659860435, 11838.763224735285, 12050.758984820079, 11812.232204906653, 11860.762784744084, 11868.940655297014, 12362.44369003379, 12584.182028168507, 8599.39804213699, 8735.43219690718, 8953.597088130919, 8959.507227102571, 9070.274378049608, 10891.618793342195, 11050.944745276222, 11202.775944481227, 11250.493727782106, 11286.266392684778], "unit": "score", "name": "jquery.html", "value": 8193.172977182256}, {"lowerIsBetter": false, "replicates": [1457.0601961734674, 1588.1265304082754, 1614.7254966655667, 1843.8248366405196, 1945.7956914523975, 8278.793030174249, 8530.658773649055, 8544.401891867572, 8549.40154189207, 8550.144985501454, 8398.706045288416, 8572.828543429143, 8582.699605513808, 8598.44110132841, 8598.61306241219, 2461.59383701689, 2489.0541594194183, 2492.7756501914823, 2493.127405408102, 2493.8004959603277, 2447.339218411028, 2538.5684433646234, 2547.0575886921865, 2558.9104381346656, 2560.4623029163804, 2522.117258959368, 2528.1783420388356, 2543.6566063581363, 2546.172493939468, 2547.3631592101974, 2459.1270099114827, 2466.2971053249826, 2481.8759062046825, 2495.1142344467635, 2501.399664080626, 2488.415222422729, 2510.3598582361565, 2532.3162746058647, 2543.9364015899564, 2544.2494464133124, 7996.08045074818, 8016.31861291785, 8018.799530011738, 8041.477303975223, 8050.959745201237, 5399.217113518518, 5487.588430867661, 5524.475174858382, 5533.806316778893, 5542.63972841768, 3304.6695330467, 3343.3480471308103, 3380.1042723678247, 3388.610309814378, 3400.472926696366, 1088.1023155896416, 1139.8689150747605, 1147.0651419093494, 1154.8960593546537, 1164.3130552973787, 11919.165658403916, 12037.699057523545, 12051.638450846402, 12093.879061209363, 12170.087243456775, 4719.976400117977, 4720.551547602972, 4735.21868891629, 4746.454157771831, 4773.880652983703, 10169.135623472088, 10180.592776289013, 10205.183585313158, 10206.387616743019, 10268.07587317145, 5347.759350829222, 5348.5988550858065, 5354.0, 5360.3299587551555, 5364.436734142937, 4090.202410529918, 4651.62786977041, 4809.0, 4820.6143508519235, 4896.46138924718, 4015.4339807475108, 4057.107436363995, 4090.0592863641527, 4118.75287482752, 4121.319982202903, 1300.8699130087105, 1304.373900527733, 1309.1228876652665, 1314.8159257703928, 1344.6705557138368, 1369.3632460905726, 1374.8006539051783, 1390.3604342002793, 1397.8602139786144, 1416.1432333438327, 7599.734009309758, 7620.885686714703, 7634.732784352521, 7687.807804804925, 7905.367570594339, 556.785637529554, 558.154396089924, 559.9552035837205, 562.9521490673256, 566.4052744618134, 6015.699215039318, 6017.69911504423, 6062.514998800086, 6073.210482637317, 6184.845378865564, 10333.74165645865, 10873.130149588014, 10983.340999540053, 11049.723756906142, 11069.391183484986, 10472.319299245677, 10617.946910265553, 10772.515236814363, 10791.514381852678, 10838.78322433547, 8253.13342099083, 8347.332213423033, 8414.410991230556, 8433.95783021081, 8446.324294056461, 7650.2349765023055, 7832.138464768985, 8053.476524025919, 8053.919460805317, 8055.516668999879, 9410.811783764424, 9415.657441608404, 9535.952320238355, 9590.280728945496, 9593.616255349987, 9777.608895644094, 9783.657571985232, 9862.723442957984, 10131.746706332106, 10136.847947280648, 6652.634105124264, 7122.60825654594, 7365.2634736525915, 7377.557346559223, 7517.43619228571, 8451.535165565707, 8487.957560212159, 8495.32037437016, 8514.233718965323, 8534.103919088655, 7105.0, 7349.816254593464, 7504.0, 7593.5823529706395, 7619.1999840016, 7322.267773222635, 7380.667869945758, 7382.926170738224, 7468.887966680612, 7469.365103966224, 7580.393568514395, 7586.544807311579, 7623.809404764926, 7623.923760762322, 7625.618719063914, 6788.830279243059, 6804.149481314836, 7032.12098487689, 7069.045678833291, 7084.539504932163, 7181.461390395846, 7233.312835280851, 7240.456965727697, 7293.635318233961, 7296.124465064227], "unit": "score", "name": "mootools.html", "value": 4868.198765836272}, {"lowerIsBetter": false, "replicates": [358.0993800591512, 362.84760400631734, 364.96897763690083, 366.4375184092419, 370.44433349975054, 5950.226470558827, 5969.343372229062, 5979.312379076402, 6061.787837425691, 6076.787312444066, 5918.792842250522, 5931.5254779617635, 5938.9703051484685, 5951.196588460556, 5953.196318497002, 4469.374287599739, 4571.9314210286875, 4684.391029166212, 4687.2969054641735, 4708.293755936603, 4679.040796636698, 4696.553827386393, 4696.765161741916, 4699.530046995307, 4710.387649605546, 4654.418197725285, 4660.6970546914345, 4661.44062712475, 4666.113438446701, 4681.344611754357, 4427.490838553559, 4539.659525535598, 4624.884377890546, 4639.164950308943, 4649.372334734801, 4119.855805046839, 4121.9587804122175, 4130.0294430808735, 4134.255833949888, 4138.0, 5596.468335508121, 5610.607257491977, 5612.466815652507, 5613.943860561383, 5622.887542249173, 5413.323334583177, 5427.1316589345515, 5433.646812957145, 5434.510894019518, 5434.64674796137, 6312.431881130675, 6316.715747791314, 6319.8104056878365, 6322.652254126021, 6334.239891213084, 4326.762028088454, 4442.4669039715445, 4463.196624607569, 4472.329150627399, 4591.79336929839, 6502.992036234391, 6573.408393244583, 6581.2760596334365, 6596.340365963413, 6602.405783479558, 4541.887237626803, 4549.772511374418, 4552.658550608651, 4559.338895860082, 4573.5426457354, 4614.123316569841, 4620.953790462119, 4629.537046295343, 4639.0, 4644.419447569054, 5329.760160792774, 5335.3864305604575, 5337.466253374709, 5349.304590403222, 5352.946470535323, 6252.717283901772, 6292.685365731695, 6362.904556431565, 6367.808965731036, 6385.042243663488, 1614.9838501615068, 1625.0249850090088, 1630.79615048119, 1632.7877375941052, 1638.7951506061743, 1010.9898901010896, 1060.7931453366673, 1069.8662667166604, 1077.8221593437152, 1100.1144079016308, 6043.516518678495, 6057.757689692363, 6147.877042459215, 6150.354212807591, 6157.168782214344, 6503.6097834130105, 6516.380943810425, 6517.087607734921, 6518.837029074216, 6527.477801775846, 6129.662868542184, 6135.723892424851, 6139.693015349215, 6144.41628045335, 6144.631322120687, 3475.669811367916, 3501.492283618861, 3504.2465869838106, 3513.631068737797, 3519.9296014080087, 6620.271770105284, 6748.797536073926, 6754.020667003257, 6764.72941082361, 6782.626955517395, 6646.302138275508, 6649.368310010541, 6650.068990341356, 6710.194776626836, 6769.255381907986, 6802.489813263926, 6824.6928888200155, 6835.726570937107, 6850.6574671267235, 6859.17689877208, 6572.539922205399, 6572.539922205399, 6584.637844918576, 6586.0, 6589.374009469093, 6239.937600624117, 6424.93575064262, 6431.585051288709, 6439.871202576016, 6485.54601177913, 6811.89782153278, 6827.624480653413, 6859.416949559144, 6860.3139686031, 6866.34769696878, 4707.882302942454, 4758.04839032188, 4761.523847615211, 4764.523547645346, 4768.237082066853, 6535.085088087577, 6544.247411547733, 6544.770933017321, 6548.1814773153355, 6556.639384833689, 6211.565190436626, 6349.0, 6350.841228969312, 6367.458766004941, 6369.808905732835, 6378.2983871774995, 6382.489400847828, 6435.806925792233, 6452.290248072614, 6452.483801295791, 6313.747450101944, 6319.905201422074, 6321.241451025906, 6335.3981371769605, 6397.808065758035, 6405.071264666504, 6443.226812782309, 6468.0, 6470.6441145737435, 6473.676316184266, 6018.578699490994, 6123.407913942318, 6143.938560614337, 6300.936990630218, 6312.621242725451], "unit": "score", "name": "prototype.html", "value": 4831.224713058747}, {"lowerIsBetter": false, "replicates": [762.0436352377768, 846.4032856835928, 891.1445012787724, 900.7252787899696, 919.4191259057519, 14856.777148342784, 15012.774808377882, 15101.169435681033, 15148.394064237431, 15152.62118447038, 13955.092918960261, 14071.859281407209, 15674.294656740445, 15815.446459373925, 15840.603984900383, 690.6167077272112, 905.8958219804724, 910.8178364327127, 922.2667978956746, 922.3589605224372, 923.6813299411692, 924.6393906376519, 924.8843894513186, 924.9213816825544, 925.1118925831211, 970.2335155227362, 972.9902700972971, 973.026973026973, 974.2692980264801, 974.4786539201493, 725.9491835571512, 933.0902370189011, 955.9474228917406, 960.8030353777493, 964.9807003859919, 706.1949377709416, 706.6043015911106, 707.4941416886951, 707.9327463890974, 708.2987842036398, 15250.161241131733, 15365.846341536666, 15381.230938453144, 15383.615409614737, 15486.767698484531, 13343.86656133436, 13646.181229126185, 13689.383977721027, 13949.0, 14044.648883777885, 11501.539938402453, 11509.827352589718, 11512.827307590393, 11531.769364612745, 11597.362145082017, 3831.8275677594575, 3846.7114966377635, 3850.0374906273432, 3871.128995975911, 3898.8635397761227, 53890.73054634741, 54068.72965635186, 54441.45558544403, 54839.177412338846, 54993.1751023735, 10379.377237365783, 10851.457427128613, 10854.72863178411, 11004.174686898514, 11204.327740335606, 19838.107285171915, 19868.304609338604, 19905.900470497556, 19911.203551857765, 19938.20247190096, 8041.718539851077, 8118.918810811934, 8190.672373105128, 8412.074671786098, 8443.493390396596, 4558.703684260512, 4679.906401871944, 4683.555062269079, 4710.105080034782, 4803.927941080887, 3515.3848076586496, 3531.947020794639, 3532.982335088308, 3569.6787289144104, 3571.482135090397, 574.7097715653651, 587.5769445998874, 593.2673148661399, 599.7600959616101, 608.4159207161175, 682.2427105912433, 691.401937324211, 693.920199177091, 698.4831224893644, 704.3660705365212, 8098.3116435103675, 8109.837803243902, 8379.664813407517, 8719.869201961976, 9069.501177435304, 596.4512648363516, 718.795143384133, 719.2986837833071, 719.6078137415121, 729.8138974561452, 4076.144009757925, 4159.604837540429, 4201.432806571135, 4263.722858014219, 4337.219300525936, 54403.0, 54943.17585236225, 55010.17484737732, 58773.0, 60262.0, 47339.97610203172, 47527.67306288596, 47830.28254576184, 47878.5212147881, 53187.734061329444, 46021.53978460172, 46753.5324646756, 51693.0, 51718.482815172116, 53712.99999999922, 8644.438111522732, 8894.221155768742, 8921.107889211287, 8996.955015224881, 9075.636974521209, 34769.30461390808, 37049.0, 37992.0, 38409.50338228118, 40494.79752601218, 48989.755051224514, 49251.75374123106, 49595.75202123966, 49735.75132124316, 50784.0, 11632.825507617561, 11633.0, 11922.225055371373, 11983.64049078529, 12062.638120856389, 12354.876451235372, 12589.0, 12650.30423326726, 12838.935805320914, 12965.611031669065, 11285.830712539482, 11298.322100673986, 11375.829362559403, 11464.656060318204, 11835.408229588314, 11437.08503319749, 11459.25514841566, 11607.30356178632, 11886.940565297118, 12054.879451205727, 10646.520906559379, 10773.946130269613, 10918.836217456903, 11099.72250693739, 11167.106631469625, 9641.37331073478, 10144.239182061227, 10207.183425326104, 10394.168466522811, 10578.259521833397, 9324.533773311172, 9587.0, 9707.174890134134, 9717.6598819041, 9731.951340243253], "unit": "score", "name": "yui.html", "value": 6762.0610925662295}], "name": "dromaeo_css", "value": 7181.387273115686}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 104.0, 108.0, 109.0, 111.0, 99.0, 109.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 157.0, 165.0, 128.0, 154.0, 161.0, 128.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 165.0, 160.0, 159.0, 160.0, 159.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 75.0, 165.0, 75.0, 74.0, 76.0, 74.0, 163.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 155.0, 93.0, 93.0, 93.0, 140.0, 93.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 148.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 57.0, 58.0, 65.0, 57.0, 57.0, 62.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 78.0, 78.0, 77.0, 78.0, 85.0, 79.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [115.0, 111.0, 116.0, 123.0, 122.0, 132.0, 119.0, 115.0, 115.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.0}, {"lowerIsBetter": true, "replicates": [151.0, 139.0, 158.0, 147.0, 137.0, 139.0, 151.0, 150.0, 148.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 68.0, 69.0, 69.0, 67.0, 68.0, 76.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1513.6}]} 14:21:57 INFO - Return code: 0 14:21:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:57 INFO - # TBPL SUCCESS # 14:21:57 INFO - Running post-action listener: _resource_record_post_action 14:21:57 INFO - Running post-run listener: _resource_record_post_run 14:21:58 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 458932224; Read time: 16; Write time: 630404 14:21:58 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 237547520; Read time: 0; Write time: 444972 14:21:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221069312; Read time: 16; Write time: 185376 14:21:58 INFO - Running post-run listener: _upload_blobber_files 14:21:58 INFO - Blob upload gear active. 14:21:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:21:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:21:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:21:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:21:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:59 INFO - (blobuploader) - INFO - Done attempting. 14:21:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:21:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:22:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:00 INFO - (blobuploader) - INFO - Done attempting. 14:22:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:00 INFO - Return code: 0 14:22:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:22:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fac0594548594dc76f3c974c899df7dd9f24205e246d72bc5cd7997f066701ae02b3d3b263db82d5135dee38ccbeae41e90cee6294e7748c5bfcab384de92aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15106b858839949d7e08ce6b0e09a876b2de4a9bec988b646919763d635f3bf5223df7b147e7a21d579c8ba42aff714f03ac346b4ecf452475258134b7d6f017"} 14:22:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:22:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:22:00 INFO - Contents: 14:22:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fac0594548594dc76f3c974c899df7dd9f24205e246d72bc5cd7997f066701ae02b3d3b263db82d5135dee38ccbeae41e90cee6294e7748c5bfcab384de92aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15106b858839949d7e08ce6b0e09a876b2de4a9bec988b646919763d635f3bf5223df7b147e7a21d579c8ba42aff714f03ac346b4ecf452475258134b7d6f017"} 14:22:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:22:00 INFO - Copying logs to upload dir... 14:22:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:22:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.661865 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-05-13 14:21:59.735039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:21:59.738181) ========= 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=af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602 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/2fac0594548594dc76f3c974c899df7dd9f24205e246d72bc5cd7997f066701ae02b3d3b263db82d5135dee38ccbeae41e90cee6294e7748c5bfcab384de92aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15106b858839949d7e08ce6b0e09a876b2de4a9bec988b646919763d635f3bf5223df7b147e7a21d579c8ba42aff714f03ac346b4ecf452475258134b7d6f017"} build_url:https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/RDhBy2o7S1uu6fs1ozq-Kw/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/2fac0594548594dc76f3c974c899df7dd9f24205e246d72bc5cd7997f066701ae02b3d3b263db82d5135dee38ccbeae41e90cee6294e7748c5bfcab384de92aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15106b858839949d7e08ce6b0e09a876b2de4a9bec988b646919763d635f3bf5223df7b147e7a21d579c8ba42aff714f03ac346b4ecf452475258134b7d6f017"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:21:59.763097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:21:59.763639) ========= 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=af724c981e2a0f424dbabf99000001e7-1463173294.160009-179935602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:21:59.846592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:21:59.846916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:21:59.847214) ========= ========= Total master_lag: 0.18 =========