builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1462836628.3 results: success (0) buildid: 20160509134909 builduid: 86d329654490450a809378ee1a4ed0ce revision: beaf4d37d01c85e87cee2682604083a889beeb29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.299535) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.299939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.300219) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.326610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.327049) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 16:30:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-09 16:30:28 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124396 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.596283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.596596) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013989 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:28.672505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 16:30:28.672828) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev beaf4d37d01c85e87cee2682604083a889beeb29 --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 beaf4d37d01c85e87cee2682604083a889beeb29 --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=03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 16:30:28,857 truncating revision to first 12 chars 2016-05-09 16:30:28,858 Setting DEBUG logging. 2016-05-09 16:30:28,858 attempt 1/10 2016-05-09 16:30:28,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/beaf4d37d01c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 16:30:29,892 unpacking tar archive at: mozilla-beta-beaf4d37d01c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 16:30:30.036841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:30.037143) ========= script_repo_revision: beaf4d37d01c85e87cee2682604083a889beeb29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:30.037521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:30.037800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:30:30.045269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-09 16:30:30.045584) ========= /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=03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:30:30 INFO - MultiFileLogger online at 20160509 16:30:30 in /builds/slave/test 16:30:30 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 16:30:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:30 INFO - {'append_to_log': False, 16:30:30 INFO - 'base_work_dir': '/builds/slave/test', 16:30:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:30:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:30 INFO - 'branch': 'Mozilla-Beta', 16:30:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:30 INFO - 'config_files': ('talos/linux_config.py',), 16:30:30 INFO - 'default_actions': ('clobber', 16:30:30 INFO - 'read-buildbot-config', 16:30:30 INFO - 'download-and-extract', 16:30:30 INFO - 'populate-webroot', 16:30:30 INFO - 'create-virtualenv', 16:30:30 INFO - 'install', 16:30:30 INFO - 'run-tests'), 16:30:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:30 INFO - 'download_minidump_stackwalk': True, 16:30:30 INFO - 'download_symbols': 'ondemand', 16:30:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:30 INFO - 'installer_path': 'installer.exe', 16:30:30 INFO - 'log_level': 'info', 16:30:30 INFO - 'log_name': 'talos', 16:30:30 INFO - 'log_to_console': True, 16:30:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:30:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:30:30 INFO - 'opt_config_files': (), 16:30:30 INFO - 'pip_index': False, 16:30:30 INFO - 'sps_profile': False, 16:30:30 INFO - 'sps_profile_interval': 0, 16:30:30 INFO - 'suite': 'dromaeojs', 16:30:30 INFO - 'system_bits': '32', 16:30:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:30 INFO - 'title': 'talos-linux64-ix-047', 16:30:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:30 INFO - 'use_talos_json': True, 16:30:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:30 INFO - 'work_dir': 'build'} 16:30:30 INFO - ##### 16:30:30 INFO - ##### Running clobber step. 16:30:30 INFO - ##### 16:30:30 INFO - Running pre-action listener: _resource_record_pre_action 16:30:30 INFO - Running main action method: clobber 16:30:30 INFO - rmtree: /builds/slave/test/build 16:30:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:30:31 INFO - Running post-action listener: _resource_record_post_action 16:30:31 INFO - ##### 16:30:31 INFO - ##### Running read-buildbot-config step. 16:30:31 INFO - ##### 16:30:31 INFO - Running pre-action listener: _resource_record_pre_action 16:30:31 INFO - Running main action method: read_buildbot_config 16:30:31 INFO - Using buildbot properties: 16:30:31 INFO - { 16:30:31 INFO - "project": "", 16:30:31 INFO - "product": "firefox", 16:30:31 INFO - "script_repo_revision": "production", 16:30:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:30:31 INFO - "repository": "", 16:30:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:30:31 INFO - "buildid": "20160509134909", 16:30:31 INFO - "pgo_build": "True", 16:30:31 INFO - "basedir": "/builds/slave/test", 16:30:31 INFO - "buildnumber": 231, 16:30:31 INFO - "slavename": "talos-linux64-ix-047", 16:30:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:30:31 INFO - "platform": "ubuntu64_hw", 16:30:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:30:31 INFO - "branch": "mozilla-beta", 16:30:31 INFO - "repo_path": "releases/mozilla-beta", 16:30:31 INFO - "revision": "beaf4d37d01c85e87cee2682604083a889beeb29", 16:30:31 INFO - "stage_platform": "linux64-pgo", 16:30:31 INFO - "builduid": "86d329654490450a809378ee1a4ed0ce", 16:30:31 INFO - "slavebuilddir": "test" 16:30:31 INFO - } 16:30:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:30:31 INFO - Running post-action listener: _resource_record_post_action 16:30:31 INFO - ##### 16:30:31 INFO - ##### Running download-and-extract step. 16:30:31 INFO - ##### 16:30:31 INFO - Running pre-action listener: _resource_record_pre_action 16:30:31 INFO - Running main action method: download_and_extract 16:30:31 INFO - mkdir: /builds/slave/test/build/tests 16:30:31 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')]} 16:30:31 INFO - https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:33 INFO - Downloaded 1412 bytes. 16:30:33 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:30:33 INFO - Using the following test package requirements: 16:30:33 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:30:33 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:30:33 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:30:33 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'jsshell-linux-x86_64.zip'], 16:30:33 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:30:33 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:30:33 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:30:33 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:30:33 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:30:33 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:30:33 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:30:33 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:30:33 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:30:33 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')]} 16:30:33 INFO - https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:37 INFO - Downloaded 23364540 bytes. 16:30:37 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'] 16:30:37 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 16:30:38 INFO - Return code: 0 16:30:38 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 16:30: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')]} 16:30:38 INFO - https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:45 INFO - Downloaded 23364540 bytes. 16:30:45 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'] 16:30:45 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 16:30:46 INFO - Return code: 0 16:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:46 INFO - https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:30:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:30:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:30:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:48 INFO - Downloaded 10845194 bytes. 16:30:48 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'] 16:30:48 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 16:30:48 INFO - Return code: 0 16:30:48 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')]} 16:30:48 INFO - https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:30:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:30:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:30:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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 16:30:51 INFO - Downloaded 53798788 bytes. 16:30:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:30:51 INFO - mkdir: /builds/slave/test/properties 16:30:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:30:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:30:51 INFO - Contents: 16:30:51 INFO - build_url:https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:30:52 INFO - Running post-action listener: _resource_record_post_action 16:30:52 INFO - Running post-action listener: set_extra_try_arguments 16:30:52 INFO - ##### 16:30:52 INFO - ##### Running populate-webroot step. 16:30:52 INFO - ##### 16:30:52 INFO - Running pre-action listener: _resource_record_pre_action 16:30:52 INFO - Running main action method: populate_webroot 16:30:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:30:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:30:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:30:52 INFO - '--tppagecycles', 16:30:52 INFO - '7'], 16:30:52 INFO - 'tests': ['tsvgm']}}, 16:30:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:30:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:30:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:30:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:30:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'tests': ['damp', 'tps']}, 16:30:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['damp', 'tps']}, 16:30:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:30:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:30:52 INFO - 'other': {'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other_l64': {'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other_nol64': {'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'svgr': {'tests': ['tsvgx', 16:30:52 INFO - 'tsvgr_opacity', 16:30:52 INFO - 'tart', 16:30:52 INFO - 'tscrollx', 16:30:52 INFO - 'cart']}, 16:30:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['tsvgx', 16:30:52 INFO - 'tsvgr_opacity', 16:30:52 INFO - 'tart', 16:30:52 INFO - 'tscrollx', 16:30:52 INFO - 'cart']}, 16:30:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'tests': ['tp5o']}, 16:30:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--e10s'], 16:30:52 INFO - 'tests': ['tp5o']}, 16:30:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--xperf_path', 16:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:52 INFO - 'tests': ['tp5n']}, 16:30:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--e10s', 16:30:52 INFO - '--xperf_path', 16:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:52 INFO - 'tests': ['tp5n']}}, 16:30:52 INFO - 'talos.zip': {'path': '', 16:30:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:30:52 INFO - Running post-action listener: _resource_record_post_action 16:30:52 INFO - ##### 16:30:52 INFO - ##### Running create-virtualenv step. 16:30:52 INFO - ##### 16:30:52 INFO - Running pre-action listener: _resource_record_pre_action 16:30:52 INFO - Running main action method: create_virtualenv 16:30:52 INFO - Creating virtualenv /builds/slave/test/build/venv 16:30:52 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 16:30:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:30:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:30:52 INFO - Using real prefix '/usr' 16:30:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:30:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:30:54 INFO - Installing pip.................done. 16:30:54 INFO - Return code: 0 16:30:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:30: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')]} 16:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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')]} 16:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:30: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', 'pip>=1.5'] in /builds/slave/test/build 16:30: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 pip>=1.5 16:30:54 INFO - Using env: {'DISPLAY': ':0', 16:30:54 INFO - 'HOME': '/home/cltbld', 16:30:54 INFO - 'LANG': 'en_US.UTF-8', 16:30:54 INFO - 'LANGUAGE': 'en_US:en', 16:30:54 INFO - 'LOGNAME': 'cltbld', 16:30:54 INFO - 'MAIL': '/var/mail/cltbld', 16:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:54 INFO - 'MOZ_NO_REMOTE': '1', 16:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:54 INFO - 'NO_EM_RESTART': '1', 16:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:54 INFO - 'PWD': '/builds/slave/test', 16:30:54 INFO - 'SHELL': '/bin/bash', 16:30:54 INFO - 'SHLVL': '1', 16:30:54 INFO - 'TERM': 'linux', 16:30:54 INFO - 'TMOUT': '86400', 16:30:54 INFO - 'USER': 'cltbld', 16:30:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:54 INFO - '_': '/tools/buildbot/bin/python'} 16:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:54 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 16:30:54 INFO - Cleaning up... 16:30:54 INFO - Return code: 0 16:30:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:30: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')]} 16:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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')]} 16:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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', '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 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:30: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:30: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 psutil>=0.7.1 16:30:54 INFO - Using env: {'DISPLAY': ':0', 16:30:54 INFO - 'HOME': '/home/cltbld', 16:30:54 INFO - 'LANG': 'en_US.UTF-8', 16:30:54 INFO - 'LANGUAGE': 'en_US:en', 16:30:54 INFO - 'LOGNAME': 'cltbld', 16:30:54 INFO - 'MAIL': '/var/mail/cltbld', 16:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:54 INFO - 'MOZ_NO_REMOTE': '1', 16:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:54 INFO - 'NO_EM_RESTART': '1', 16:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:54 INFO - 'PWD': '/builds/slave/test', 16:30:54 INFO - 'SHELL': '/bin/bash', 16:30:54 INFO - 'SHLVL': '1', 16:30:54 INFO - 'TERM': 'linux', 16:30:54 INFO - 'TMOUT': '86400', 16:30:54 INFO - 'USER': 'cltbld', 16:30:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:54 INFO - '_': '/tools/buildbot/bin/python'} 16:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:55 INFO - Downloading/unpacking psutil>=0.7.1 16:30:55 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 16:30:55 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 16:30:55 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 16:30:55 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 16:30:55 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 16:30:55 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 16:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:30:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:57 INFO - Installing collected packages: psutil 16:30:57 INFO - Running setup.py install for psutil 16:30:57 INFO - building 'psutil._psutil_linux' extension 16:30:57 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 16:30:57 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 16:30:57 INFO - building 'psutil._psutil_posix' extension 16:30:57 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 16:30:57 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 16:30:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:57 INFO - Successfully installed psutil 16:30:57 INFO - Cleaning up... 16:30:57 INFO - Return code: 0 16:30:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:30:57 INFO - Using env: {'DISPLAY': ':0', 16:30:57 INFO - 'HOME': '/home/cltbld', 16:30:57 INFO - 'LANG': 'en_US.UTF-8', 16:30:57 INFO - 'LANGUAGE': 'en_US:en', 16:30:57 INFO - 'LOGNAME': 'cltbld', 16:30:57 INFO - 'MAIL': '/var/mail/cltbld', 16:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:57 INFO - 'MOZ_NO_REMOTE': '1', 16:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:57 INFO - 'NO_EM_RESTART': '1', 16:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:57 INFO - 'PWD': '/builds/slave/test', 16:30:57 INFO - 'SHELL': '/bin/bash', 16:30:57 INFO - 'SHLVL': '1', 16:30:57 INFO - 'TERM': 'linux', 16:30:57 INFO - 'TMOUT': '86400', 16:30:57 INFO - 'USER': 'cltbld', 16:30:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:57 INFO - '_': '/tools/buildbot/bin/python'} 16:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:30:59 INFO - Installing collected packages: mozsystemmonitor 16:30:59 INFO - Running setup.py install for mozsystemmonitor 16:30:59 INFO - Successfully installed mozsystemmonitor 16:30:59 INFO - Cleaning up... 16:30:59 INFO - Return code: 0 16:30:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:59 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 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:30:59 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 16:30:59 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 16:30:59 INFO - Using env: {'DISPLAY': ':0', 16:30:59 INFO - 'HOME': '/home/cltbld', 16:30:59 INFO - 'LANG': 'en_US.UTF-8', 16:30:59 INFO - 'LANGUAGE': 'en_US:en', 16:30:59 INFO - 'LOGNAME': 'cltbld', 16:30:59 INFO - 'MAIL': '/var/mail/cltbld', 16:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:59 INFO - 'MOZ_NO_REMOTE': '1', 16:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:59 INFO - 'NO_EM_RESTART': '1', 16:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:59 INFO - 'PWD': '/builds/slave/test', 16:30:59 INFO - 'SHELL': '/bin/bash', 16:30:59 INFO - 'SHLVL': '1', 16:30:59 INFO - 'TERM': 'linux', 16:30:59 INFO - 'TMOUT': '86400', 16:30:59 INFO - 'USER': 'cltbld', 16:30:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:59 INFO - '_': '/tools/buildbot/bin/python'} 16:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:02 INFO - Downloading docopt-0.6.1.tar.gz 16:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:02 INFO - Running setup.py install for blobuploader 16:31:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:02 INFO - Running setup.py install for requests 16:31:03 INFO - Running setup.py install for docopt 16:31:03 INFO - Successfully installed blobuploader requests docopt 16:31:03 INFO - Cleaning up... 16:31:03 INFO - Return code: 0 16:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:03 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 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:31:03 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 16:31:03 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 16:31:03 INFO - Using env: {'DISPLAY': ':0', 16:31:03 INFO - 'HOME': '/home/cltbld', 16:31:03 INFO - 'LANG': 'en_US.UTF-8', 16:31:03 INFO - 'LANGUAGE': 'en_US:en', 16:31:03 INFO - 'LOGNAME': 'cltbld', 16:31:03 INFO - 'MAIL': '/var/mail/cltbld', 16:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:03 INFO - 'MOZ_NO_REMOTE': '1', 16:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:03 INFO - 'NO_EM_RESTART': '1', 16:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:03 INFO - 'PWD': '/builds/slave/test', 16:31:03 INFO - 'SHELL': '/bin/bash', 16:31:03 INFO - 'SHLVL': '1', 16:31:03 INFO - 'TERM': 'linux', 16:31:03 INFO - 'TMOUT': '86400', 16:31:03 INFO - 'USER': 'cltbld', 16:31:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:03 INFO - '_': '/tools/buildbot/bin/python'} 16:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:03 INFO - Running setup.py (path:/tmp/pip-DWUOKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:03 INFO - Running setup.py (path:/tmp/pip-2r8Zok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:03 INFO - Running setup.py (path:/tmp/pip-oO6Ai7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:03 INFO - Running setup.py (path:/tmp/pip-_po2CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:03 INFO - Running setup.py (path:/tmp/pip-ed1Riw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:03 INFO - Running setup.py (path:/tmp/pip-iLvd2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:04 INFO - Running setup.py (path:/tmp/pip-FyyJec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:04 INFO - Running setup.py (path:/tmp/pip-YdBSby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:04 INFO - Running setup.py (path:/tmp/pip-inHnJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:04 INFO - Running setup.py (path:/tmp/pip-cHwXuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:04 INFO - Running setup.py (path:/tmp/pip-eVZTzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:04 INFO - Running setup.py (path:/tmp/pip-0UzmbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:04 INFO - Running setup.py (path:/tmp/pip-R3HI2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:04 INFO - Running setup.py (path:/tmp/pip-B2_gZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:04 INFO - Running setup.py (path:/tmp/pip-vsb2UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:04 INFO - Running setup.py (path:/tmp/pip-EfxGmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:04 INFO - Running setup.py (path:/tmp/pip-6lTOgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:04 INFO - Running setup.py install for manifestparser 16:31:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:04 INFO - Running setup.py install for mozcrash 16:31:05 INFO - Running setup.py install for mozdebug 16:31:05 INFO - Running setup.py install for mozdevice 16:31:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Running setup.py install for mozfile 16:31:05 INFO - Running setup.py install for mozhttpd 16:31:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Running setup.py install for mozinfo 16:31:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Running setup.py install for mozInstall 16:31:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Running setup.py install for mozleak 16:31:05 INFO - Running setup.py install for mozlog 16:31:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Running setup.py install for moznetwork 16:31:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:05 INFO - Running setup.py install for mozprocess 16:31:06 INFO - Running setup.py install for mozprofile 16:31:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:06 INFO - Running setup.py install for mozrunner 16:31:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:06 INFO - Running setup.py install for mozscreenshot 16:31:06 INFO - Running setup.py install for moztest 16:31:06 INFO - Running setup.py install for mozversion 16:31:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:06 INFO - Cleaning up... 16:31:06 INFO - Return code: 0 16:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:06 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 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:31:06 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 16:31:06 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 16:31:06 INFO - Using env: {'DISPLAY': ':0', 16:31:06 INFO - 'HOME': '/home/cltbld', 16:31:06 INFO - 'LANG': 'en_US.UTF-8', 16:31:06 INFO - 'LANGUAGE': 'en_US:en', 16:31:06 INFO - 'LOGNAME': 'cltbld', 16:31:06 INFO - 'MAIL': '/var/mail/cltbld', 16:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:06 INFO - 'MOZ_NO_REMOTE': '1', 16:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:06 INFO - 'NO_EM_RESTART': '1', 16:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:06 INFO - 'PWD': '/builds/slave/test', 16:31:06 INFO - 'SHELL': '/bin/bash', 16:31:06 INFO - 'SHLVL': '1', 16:31:06 INFO - 'TERM': 'linux', 16:31:06 INFO - 'TMOUT': '86400', 16:31:06 INFO - 'USER': 'cltbld', 16:31:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:06 INFO - '_': '/tools/buildbot/bin/python'} 16:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:06 INFO - Running setup.py (path:/tmp/pip-VsrDXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:06 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)) 16:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:06 INFO - Running setup.py (path:/tmp/pip-bWkSdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:06 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)) 16:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:06 INFO - Running setup.py (path:/tmp/pip-f3wgKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:07 INFO - Running setup.py (path:/tmp/pip-X5glxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:07 INFO - Running setup.py (path:/tmp/pip-wWrEkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:07 INFO - Running setup.py (path:/tmp/pip-furSYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:07 INFO - Running setup.py (path:/tmp/pip-MSFi5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:07 INFO - Running setup.py (path:/tmp/pip-agFUQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:07 INFO - Running setup.py (path:/tmp/pip-AUL9ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:07 INFO - Running setup.py (path:/tmp/pip-Dk9pjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:07 INFO - Running setup.py (path:/tmp/pip-mmgf8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:07 INFO - Running setup.py (path:/tmp/pip-1I6WoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:07 INFO - Running setup.py (path:/tmp/pip-K15a7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:07 INFO - Running setup.py (path:/tmp/pip-H1_rY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:07 INFO - Running setup.py (path:/tmp/pip-kA21FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:07 INFO - Running setup.py (path:/tmp/pip-60qEmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:07 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)) 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:07 INFO - Running setup.py (path:/tmp/pip-NAv8MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:08 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)) 16:31:08 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)) 16:31:08 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)) 16:31:08 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)) 16:31:08 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)) 16:31:08 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)) 16:31:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:09 INFO - Downloading blessings-1.6.tar.gz 16:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:10 INFO - Installing collected packages: blessings 16:31:10 INFO - Running setup.py install for blessings 16:31:10 INFO - Successfully installed blessings 16:31:10 INFO - Cleaning up... 16:31:10 INFO - Return code: 0 16:31:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:10 INFO - Reading from file tmpfile_stdout 16:31:10 INFO - Current package versions: 16:31:10 INFO - argparse == 1.2.1 16:31:10 INFO - blessings == 1.6 16:31:10 INFO - blobuploader == 1.2.4 16:31:10 INFO - docopt == 0.6.1 16:31:10 INFO - manifestparser == 1.1 16:31:10 INFO - mozInstall == 1.12 16:31:10 INFO - mozcrash == 0.17 16:31:10 INFO - mozdebug == 0.1 16:31:10 INFO - mozdevice == 0.48 16:31:10 INFO - mozfile == 1.2 16:31:10 INFO - mozhttpd == 0.7 16:31:10 INFO - mozinfo == 0.9 16:31:10 INFO - mozleak == 0.1 16:31:10 INFO - mozlog == 3.1 16:31:10 INFO - moznetwork == 0.27 16:31:10 INFO - mozprocess == 0.22 16:31:10 INFO - mozprofile == 0.28 16:31:10 INFO - mozrunner == 6.11 16:31:10 INFO - mozscreenshot == 0.1 16:31:10 INFO - mozsystemmonitor == 0.0 16:31:10 INFO - moztest == 0.7 16:31:10 INFO - mozversion == 1.4 16:31:10 INFO - psutil == 3.1.1 16:31:10 INFO - requests == 1.2.3 16:31:10 INFO - wsgiref == 0.1.2 16:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:10 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 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:31:10 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 16:31:10 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 16:31:10 INFO - Using env: {'DISPLAY': ':0', 16:31:10 INFO - 'HOME': '/home/cltbld', 16:31:10 INFO - 'LANG': 'en_US.UTF-8', 16:31:10 INFO - 'LANGUAGE': 'en_US:en', 16:31:10 INFO - 'LOGNAME': 'cltbld', 16:31:10 INFO - 'MAIL': '/var/mail/cltbld', 16:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:10 INFO - 'MOZ_NO_REMOTE': '1', 16:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:10 INFO - 'NO_EM_RESTART': '1', 16:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:10 INFO - 'PWD': '/builds/slave/test', 16:31:10 INFO - 'SHELL': '/bin/bash', 16:31:10 INFO - 'SHLVL': '1', 16:31:10 INFO - 'TERM': 'linux', 16:31:10 INFO - 'TMOUT': '86400', 16:31:10 INFO - 'USER': 'cltbld', 16:31:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:10 INFO - '_': '/tools/buildbot/bin/python'} 16:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 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)) 16:31:10 INFO - Cleaning up... 16:31:10 INFO - Return code: 0 16:31:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:31:10 INFO - Using env: {'DISPLAY': ':0', 16:31:10 INFO - 'HOME': '/home/cltbld', 16:31:10 INFO - 'LANG': 'en_US.UTF-8', 16:31:10 INFO - 'LANGUAGE': 'en_US:en', 16:31:10 INFO - 'LOGNAME': 'cltbld', 16:31:10 INFO - 'MAIL': '/var/mail/cltbld', 16:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:10 INFO - 'MOZ_NO_REMOTE': '1', 16:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:10 INFO - 'NO_EM_RESTART': '1', 16:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:10 INFO - 'PWD': '/builds/slave/test', 16:31:10 INFO - 'SHELL': '/bin/bash', 16:31:10 INFO - 'SHLVL': '1', 16:31:10 INFO - 'TERM': 'linux', 16:31:10 INFO - 'TMOUT': '86400', 16:31:10 INFO - 'USER': 'cltbld', 16:31:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:10 INFO - '_': '/tools/buildbot/bin/python'} 16:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:10 INFO - Downloading/unpacking jsonschema 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:12 INFO - Downloading/unpacking functools32 (from jsonschema) 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:12 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:12 INFO - warning: no files found matching '*.txt' 16:31:12 INFO - no previously-included directories found matching 'build' 16:31:12 INFO - no previously-included directories found matching 'dist' 16:31:12 INFO - no previously-included directories found matching '.git*' 16:31:12 INFO - Installing collected packages: jsonschema, functools32 16:31:13 INFO - Running setup.py install for functools32 16:31:13 INFO - warning: no files found matching '*.txt' 16:31:13 INFO - no previously-included directories found matching 'build' 16:31:13 INFO - no previously-included directories found matching 'dist' 16:31:13 INFO - no previously-included directories found matching '.git*' 16:31:13 INFO - Successfully installed jsonschema functools32 16:31:13 INFO - Cleaning up... 16:31:13 INFO - Return code: 0 16:31:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29044eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1721410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', '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 16:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:31:13 INFO - Using env: {'DISPLAY': ':0', 16:31:13 INFO - 'HOME': '/home/cltbld', 16:31:13 INFO - 'LANG': 'en_US.UTF-8', 16:31:13 INFO - 'LANGUAGE': 'en_US:en', 16:31:13 INFO - 'LOGNAME': 'cltbld', 16:31:13 INFO - 'MAIL': '/var/mail/cltbld', 16:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:13 INFO - 'MOZ_NO_REMOTE': '1', 16:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:13 INFO - 'NO_EM_RESTART': '1', 16:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:13 INFO - 'PWD': '/builds/slave/test', 16:31:13 INFO - 'SHELL': '/bin/bash', 16:31:13 INFO - 'SHLVL': '1', 16:31:13 INFO - 'TERM': 'linux', 16:31:13 INFO - 'TMOUT': '86400', 16:31:13 INFO - 'USER': 'cltbld', 16:31:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:13 INFO - '_': '/tools/buildbot/bin/python'} 16:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:13 INFO - Downloading/unpacking flake8 16:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:31:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:31:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:31:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:31:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:31:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:31:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:31:15 INFO - no previously-included directories found matching 'docs/_build' 16:31:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:31:16 INFO - Running setup.py install for pep8 16:31:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:31:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:31:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:31:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:31:16 INFO - no previously-included directories found matching 'docs/_build' 16:31:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:31:16 INFO - Cleaning up... 16:31:16 INFO - Return code: 0 16:31:16 INFO - Running post-action listener: _resource_record_post_action 16:31:16 INFO - Running post-action listener: _start_resource_monitoring 16:31:16 INFO - Starting resource monitoring. 16:31:16 INFO - ##### 16:31:16 INFO - ##### Running install step. 16:31:16 INFO - ##### 16:31:16 INFO - Running pre-action listener: _resource_record_pre_action 16:31:16 INFO - Running main action method: install 16:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:16 INFO - Reading from file tmpfile_stdout 16:31:16 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:16 INFO - Reading from file tmpfile_stdout 16:31:16 INFO - Output received: 16:31:16 INFO - Usage: mozinstall [options] installer 16:31:16 INFO - Options: 16:31:16 INFO - -h, --help show this help message and exit 16:31:16 INFO - -d DEST, --destination=DEST 16:31:16 INFO - Directory to install application into. [default: 16:31:16 INFO - "/builds/slave/test"] 16:31:16 INFO - --app=APP Application being installed. [default: firefox] 16:31:16 INFO - mkdir: /builds/slave/test/build/application 16:31:16 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'] 16:31:16 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 16:31:29 INFO - Reading from file tmpfile_stdout 16:31:29 INFO - Output received: 16:31:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:31:29 INFO - Running post-action listener: _resource_record_post_action 16:31:29 INFO - ##### 16:31:29 INFO - ##### Running run-tests step. 16:31:29 INFO - ##### 16:31:29 INFO - Running pre-action listener: _resource_record_pre_action 16:31:29 INFO - Running main action method: run_tests 16:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:29 INFO - Python 2.7.3 16:31:29 INFO - Return code: 0 16:31:29 INFO - grabbing minidump binary from tooltool 16:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:29 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 0x17b0160>, '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 0x17b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b14f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:29 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 16:31:29 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 16:31:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:29 INFO - Return code: 0 16:31:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:31:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:31:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:31:30 INFO - Return code: 0 16:31:30 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/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:31:30 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/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 16:31:30 INFO - Using env: {'DISPLAY': ':0', 16:31:30 INFO - 'HOME': '/home/cltbld', 16:31:30 INFO - 'LANG': 'en_US.UTF-8', 16:31:30 INFO - 'LANGUAGE': 'en_US:en', 16:31:30 INFO - 'LOGNAME': 'cltbld', 16:31:30 INFO - 'MAIL': '/var/mail/cltbld', 16:31:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:30 INFO - 'MOZ_NO_REMOTE': '1', 16:31:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:30 INFO - 'NO_EM_RESTART': '1', 16:31:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:30 INFO - 'PWD': '/builds/slave/test', 16:31:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:30 INFO - 'SHELL': '/bin/bash', 16:31:30 INFO - 'SHLVL': '1', 16:31:30 INFO - 'TERM': 'linux', 16:31:30 INFO - 'TMOUT': '86400', 16:31:30 INFO - 'USER': 'cltbld', 16:31:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724', 16:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:30 INFO - '_': '/tools/buildbot/bin/python'} 16:31:30 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/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:31:30 INFO - mozversion application_buildid: 20160509134909 16:31:30 INFO - mozversion application_changeset: beaf4d37d01c85e87cee2682604083a889beeb29 16:31:30 INFO - mozversion application_display_name: Firefox 16:31:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:30 INFO - mozversion application_name: Firefox 16:31:30 INFO - mozversion application_remotingname: firefox 16:31:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:31:30 INFO - mozversion application_vendor: Mozilla 16:31:30 INFO - mozversion application_version: 47.0 16:31:30 INFO - mozversion platform_buildid: 20160509134909 16:31:30 INFO - mozversion platform_changeset: beaf4d37d01c85e87cee2682604083a889beeb29 16:31:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:31:30 INFO - mozversion platform_version: 47.0 16:31:30 INFO - using testdate: 1462836690 16:31:30 INFO - actual date: 1462836690 16:31:30 INFO - starting webserver on 'localhost:58935' 16:31:30 INFO - SUITE-START | Running 2 tests 16:31:30 INFO - TEST-START | dromaeo_css 16:31:30 INFO - operating with platform_type : linux_ 16:31:30 INFO - Initialising browser for dromaeo_css test... 16:31:30 INFO - TEST-INFO | started process 4252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaJ9aNH/profile http://localhost:58935/getInfo.html) 16:31:34 INFO - PROCESS | 4252 | __metrics Screen width/height:1600/1200 16:31:34 INFO - PROCESS | 4252 | colorDepth:24 16:31:34 INFO - PROCESS | 4252 | Browser inner width/height: 1024/697 16:31:34 INFO - PROCESS | 4252 | __metrics 16:31:35 INFO - PROCESS | 4252 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:31:36 INFO - TEST-INFO | 4252: exit 0 16:31:36 INFO - Browser initialized. 16:31:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:31:36 INFO - TEST-INFO | started process 4342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaJ9aNH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:48 INFO - PROCESS | 4342 | RSS: Main: 139517952 16:31:48 INFO - PROCESS | 4342 | 16:32:39 INFO - PROCESS | 4342 | 1462836759793 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] 16:34:47 INFO - PROCESS | 4342 | Cycle 1(1): loaded http://localhost:58935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58935/tests/dromaeo/cssquery-ext.html) 16:34:48 INFO - PROCESS | 4342 | RSS: Main: 258863104 16:34:48 INFO - PROCESS | 4342 | 16:37:50 INFO - PROCESS | 4342 | Cycle 1(1): loaded http://localhost:58935/tests/dromaeo/cssquery-ext.html (next: http://localhost:58935/tests/dromaeo/cssquery-jquery.html) 16:37:51 INFO - PROCESS | 4342 | RSS: Main: 221401088 16:37:51 INFO - PROCESS | 4342 | 16:40:52 INFO - PROCESS | 4342 | Cycle 1(1): loaded http://localhost:58935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58935/tests/dromaeo/cssquery-mootools.html) 16:40:53 INFO - PROCESS | 4342 | RSS: Main: 228470784 16:40:53 INFO - PROCESS | 4342 | 16:43:55 INFO - PROCESS | 4342 | Cycle 1(1): loaded http://localhost:58935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58935/tests/dromaeo/cssquery-prototype.html) 16:43:55 INFO - PROCESS | 4342 | RSS: Main: 204754944 16:43:55 INFO - PROCESS | 4342 | 16:46:58 INFO - PROCESS | 4342 | Cycle 1(1): loaded http://localhost:58935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58935/tests/dromaeo/cssquery-yui.html) 16:46:58 INFO - PROCESS | 4342 | RSS: Main: 206508032 16:46:58 INFO - PROCESS | 4342 | 16:50:00 INFO - PROCESS | 4342 | Cycle 1(1): loaded http://localhost:58935/tests/dromaeo/cssquery-yui.html (next: http://localhost:58935/tests/dromaeo/cssquery-dojo.html) 16:50:01 INFO - PROCESS | 4342 | RSS: Main: 251412480 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | __start_tp_report 16:50:01 INFO - PROCESS | 4342 | _x_x_mozilla_page_load 16:50:01 INFO - PROCESS | 4342 | _x_x_mozilla_page_load_details 16:50:01 INFO - PROCESS | 4342 | |i|pagename|runs| 16:50:01 INFO - PROCESS | 4342 | |0;dojo.html;3291.7037466628003;3350.4806754952992;3364.142143753344;3369.2250782320066;3395.6604339566047;5460.1536761801935;5471.3707923588745;5478.698671573062;5484.204790305404;5505.064139096353;5457.481539253775;5458.590605704578;5494.587905907063;5508.063629183039;5510.862228444281;4876.536729010738;4973.353464049677;5036.169032109716;5069.239614057902;5097.108006098936;4975.776090075955;5056.19100943849;5057.317262169597;5065.594752419797;5065.7467126643705;5029.698218106907;5049.3940727112795;5070.264811602316;5093.745312734367;5099.668521546107;4986.750662466862;5018.899622007576;5037.5718063964605;5039.042581909463;5063.949360506384;4855.198892182786;4896.6817156885045;4959.6528243023;4964.528369804862;4987.077390682699;5261.237120617528;5305.814296499642;5320.12217984036;5322.973385133049;5365.248865158881;5760.308762948431;5867.823965281048;5872.236609240814;5926.1110833374905;5937.732802023919;5943.049112142036;5966.761329546813;5978.880422391571;5982.192404025444;6006.069059295816;5571.331440227199;5576.1356989666265;5580.776768929279;5583.162525621149;5583.4974852263085;5897.469227769521;5927.644341339534;5945.970270148621;5972.193753843176;6067.180930574405;5788.102844059177;5843.795467158629;5846.6784326862435;5846.707664616837;5851.473367396955;5919.585629005928;5934.13954976526;5934.287885453773;5941.168236446901;5952.136940143655;5703.058995265817;5827.038538641077;5911.261092363455;5931.347551769302;5956.225690660186;5872.442117998783;5894.705264736746;5898.970505147533;5900;5900.380460051719;4307.698461107692;4465.687401881837;4481.887952801141;4482;4515.774211289422;3973.2450834341385;4024.2957482440456;4033.899152521152;4036.414719865662;4060.9796951015055;5531.557475401958;5559.27729395176;5573.972130139324;5581.218629391808;5589.077802162597;5806.9419305806405;5869.325027621878;5895.941040589625;5941.702914854326;5946.43508866657;5489.286392768994;5514.365847927459;5518.503334699896;5538.944610553843;5568.6101972862325;4984.675996060245;5046.167382381939;5048.671836330626;5049.141645920203;5074.82238121664;5945.7621695132575;5983.790567330123;5992.0712289595185;6068.544859135494;6076.696165191811;5889.381614930542;5934.9406505934385;5936.406359364202;5937.2578427696535;5955.434233747787;6101.938980610137;6138.263408391022;6146.139540464428;6149.292831324455;6151.9384806151365;5695.544356451557;5783.826485205451;5834.18321434991;5846.970765146147;5885;5919.792807251725;5939.524838013035;5952.702364881652;5954.553408494467;5954.791582294599;5764.884702305846;5804.216430781959;5825.417458254141;5825.883482330245;5828.242328497268;5611.775528978958;5618.410066943075;5678.77284908599;5690.687012214368;5712.0860662293835;5690.459406356389;5708;5734.856628584152;5738.22533957927;5742.770289188553;5655.660660360391;5828.154917537018;5832.795852145155;5848.941510584839;5866.2373891393845;5463.918041229305;5495;5629.240052593012;5706.885862282814;5749.8275051748515 16:50:01 INFO - PROCESS | 4342 | |1;ext.html;541.9539339156174;573.2118337286231;575.4676923845448;630.0958125090494;633.4520639646705;38696.419553706684;39434.21131577367;39562.80218598903;39603.60396396032;39676.60323396769;43716.781416092956;44288.77855610725;44481.555184448145;44551.55448445515;44565.331520027146;8664.826703465942;8898.644054237822;8903;8904.287656987426;8905.554722263892;8740.257078148365;8921.973972993092;8930.910690893073;9140.405873618227;9142.954285228598;9156.359054866161;9231.446113233194;9233.907660923373;9235.538223088852;9237.861432078524;9105.817883642323;9171.220446262076;9178.265738740885;9185.770355741093;9187.173154416101;9101.453912765255;9262.259019278441;9263.120003599648;9266.073392660748;9300.255979521622;42991.14017719659;43262.78368608168;43437.78281108606;43489;43496.347554786706;3546.5389499365174;3809.561900381464;3821.6560509554274;3927.8625248116177;4091.243120022805;30557.236069098228;31002.534961975587;31099.37801243985;31106.688933110607;31948.041558753273;4291.678124140702;4341.956580434218;4361.716488428274;4377.627901628365;4380.759058251795;285485;289243;291853.5407322971;291971;292205;47262.29106563405;48442.757786210845;71330;72117;72178.2782172182;51335.74332128315;51702.48297517052;51756.22365664518;51776.22335664968;51991;16402.589935251715;16515.091669958027;16533.50399488017;16565.25456354467;16580.336786528405;14020.859791401956;14043.929780351033;14067.43730250799;14153.716925661634;14168.291585420893;16090;16252.75620865688;16255.59361015984;16274.837251627332;16334.18329083541;6288.182536270256;6356.872862542723;6374.521910856704;6404.455621272151;6408.775692850728;981.6613268422383;984.7193549838262;1060.2419270221828;1063.1547919403938;1083.788661211072;31494.055178344686;32791.83604082012;32794.688212471236;33298.66701333004;33781.66218337785;1005.3465247588979;1087.543231842628;1150.6663067710438;1162.9941850290863;1172.5251273234353;15959.601009974844;16067.357305707641;16086.195690215442;16600.50198494047;16668.166591670368;438075;439192;442416;442459;442725;62089.379106209264;62634.373656263764;62644.686776566734;62741;62750.37249627537;1313.1267706974754;1456.686812335353;1500.8199016118135;1501.4294568064283;1512.8562786535263;28809;28930.27674308159;29061.7093829059;29562.260943476584;29768.722686727717;48476.7576162117;49243.753781230866;49484;49495;49546.752266238436;249855;258259;258732;259016;259220;31129;34981.82509087438;35434.82282588674;35674.28651427009;36284.27431451409;44900.10199796051;44921.775391122836;45497.545024549334;45647;45775.77112114551;37851.810740946115;37946.810265948494;38181;38264.61735382611;38439.423408649454;37788.62211377851;38124.809375952944;38625.42061869018;38836.41745373765;39004;37542;37804.621953781214;38592;38688.22623547457;38814.41778373383;32769.50845737268;33695;34213.82893085518;34426;34492;26168.60747088757;26212.60681089747;26368.60447093257;26537.33656658599;26839.865800670872 16:50:01 INFO - PROCESS | 4342 | |2;jquery.html;344.5985426977571;355.7438644176193;360.0602427663797;365.5503730411594;368.83402468889005;17533.824661753377;17937.730934036;19972.50068748282;19999.60000799985;20025.699614505756;18001.63996720065;18387.26450941964;18568.721469177974;18611.348602798906;18617.534561635934;5309.840704778853;5510.669359838403;5545.556355491572;5556.194351818984;5559.916601250984;4137.2552940470705;5422.783088676449;5733.856653583673;5980.521558275327;6013.729382177812;5903.557233207505;5946.672932988684;5975.462208401243;5978.133170690247;5980.461758441739;5719.742611582468;5898.8230353089475;5906.704664766745;5919.674417907014;5921.259842519685;3758.342290099249;5032.723200223986;5170.922436163461;5217.869553261161;5222.138347172712;22116.778832211632;22144.778552214433;22209.555808883895;22433.32700019002;22527.88736056309;2509.761572650595;2564.0128550508;2904.2739315171207;3138.8901388451523;3162.2094476380903;13270.336483175803;13826.93086534571;13868;13945.09356891809;14083.084599501;1764.303100275384;1795.8832675876026;1840.74229607855;1847.8059803720685;1886.8773529720524;65524;65727;65862;66144;66904.66547667279;9096.81806363869;9321.394109382869;9548.952255238679;9632.855507167398;9780.755481112887;13308.401121949535;13465.394057267447;13480.662983425493;13490.86509134896;13508.729825403438;8087.150849160871;8162.347012239006;8181.79545511367;8226.383021273428;8245.299149572234;8289.253967142986;8300.833983320299;8328.417010809306;8404.579771011426;8432.873506897402;5841.474267315962;5860.941390586125;5888.735006924613;5918.378570250148;5990.610610310316;1650.9504714858574;1651.157909466157;1761.1546457700376;1767.1341042888891;1771.7962434320218;936.6440752514137;938.7981583959481;973.3624475968252;995.2137811129271;1019.6329321444274;15919.283632236577;15975.360985560448;16373.42693005739;16813.32746690143;18093.819061809478;921.7603423109906;952.5189779161618;981.9361741486781;987.0820137272406;988.5452691761726;10223.897761022443;10380.636677716244;10416.739581510372;10433.634822781167;10469.895301047045;441614;443088;447553;505174;516524;82591.17811725143;83930;84096.57951710203;84152.15847841444;84470;1086.4789294986924;1086.7500474890662;1095.457748414524;1127.7969965406141;1146.5184622458587;15736.481294841913;15862.762058569362;15871;15903.920480397524;16111.194440278174;35955;36121.27757444889;36136.8193159043;36238.27523449569;36443.45334819927;46943.29585056295;47313.763431182626;51269;52962.47037529575;53252.73373633107;7702.229777022253;7754.108277548155;7773.650185741542;7864.764057078068;7875.921240787518;12174.817377739164;12700.618981430573;12760.234385936874;13035.869641303465;13355.3990070449;11330.150238731963;11476.827847582459;11619.302841829518;11920.880791191978;11956.641300760992;11053.28153670009;11647.359395233005;11648.708782280512;11851;11988.400579971141;11809.173357865211;12123.45444454984;12160.452779625115;12185.817212741638;12232.204906681038;7824.931035861434;7880;8002.03975522941;8037.477563958324;8070.031596208492;10571.735706607396;11882.881171188177;11995;12007.39963001829;12023.939880300542 16:50:01 INFO - PROCESS | 4342 | |3;mootools.html;1465.1721777195876;1613.4352976458242;1632.5836911587544;1854.5549068223631;1971.9014049297532;6880.311968803117;7767.611619419027;7906.209379062091;7943;7949.562774047417;7876.173001834796;8026.237507436799;8028.438009339348;8041.075276343207;8046.637901294441;2291.301153148289;2310.9306720798404;2315.953680926389;2317.1889838556453;2317.212147869724;2327.93016209514;2330.9883450582806;2377.95244095118;2378.6669866218745;2392.7966122879575;2364.030747393569;2370.8577485350847;2376.025829409942;2403;2406.2300063979533;2311.4105902994797;2318.988405057972;2324.9070037198494;2327.7904988551027;2385.61830107182;2359.8466099703464;2360.881955902198;2365.988170059156;2367.6922000140044;2368.798652114572;8041.597920103972;8042.437029407944;8100.149484304122;8164.7550573482895;8173.79565510867;4986.82546110888;5121.974390128025;5122.103631864409;5123.026624941249;5127.256547800585;3148.7795854290207;3166.255929856482;3228.499582564706;3243.9513407298673;3273.4435146025235;983.6409710455704;985.5762022330395;1003.4180175498267;1016.9338992965434;1019.6838979916249;11211.887881121165;11238.662840114728;11250.3812290324;11266.267692599955;11268.605598804003;4407.493138289138;4441.689081764245;4508.571685689854;4512.864614061584;4551.749653769075;9538.475383853955;9559.90440095604;9594.376365536358;9598.520073996273;9649.372790768577;5033.018561380496;5061;5079.949200508022;5082;5083.262926875583;4070.5929407059057;4160.500739911169;4511.661625378109;4547.045120524661;4621.468531118964;3784.243151369737;3786.583475817658;3797.0886987123445;3855.094052897567;3858.401947698111;1209.25026483579;1249.7875361188437;1259.80473026681;1260.1053252191048;1266.9049821263443;1406.6342750884844;1421.1260075053974;1432.7994080828485;1442.596073099534;1464.6265202373327;7648.005759251262;7657.272559106876;7678.308952194329;7684.423668224906;7687.192844751333;493.5730593037069;496.8459777468996;499.94000719913845;500.73711301566243;502.7109412087991;5810.941890581124;5855.033919403336;5879.412058794172;5915.556333274935;5929.673867937218;9355.672551460802;9922.255830812717;9996.900030999597;10065.245106617032;10070.647527336509;9733.805323893483;9895.505224738734;9912.801743965225;9922.107010368956;9957.900420995842;7273.3453989141235;7375.004374409494;7416.555006699616;7434.851302973911;7462.85074298511;7291.125064992235;7543.622818859145;7639.274268944441;7665.616719164131;7665.846683066419;8680;8732.039475657799;8802.471851688662;8962.507062111647;8970.775730606787;8800.559972001247;8859.468431894107;8866.73399798007;8927.553622318988;9059.547022648972;6328.6202827830475;6491.383318584727;6730.495212859153;6948.513604047668;7071.540349877448;7556.433267505069;7597.050368703912;7651.3496352810635;7658.042744656918;7668.80827979305;6786.083878676315;6936.237013928565;6961.234264231032;6992.615406152507;7095.077639906779;6804.11546498952;6864.347886950732;6892.827679308058;6921;6923.653817309014;7027.613481258375;7066.258042905421;7110.608916509642;7259.346658800733;7274.818129546804;6757.763478278237;6762.526623136333;6767.154105736783;6787.694553744995;6790.32096790317;6634.303398143125;6787.66061696923;6833.45332373399;6834.726610935706;6835.248122706399 16:50:01 INFO - PROCESS | 4342 | |4;prototype.html;332.2408297041261;337.80576168703;339.6111452387017;344.8000159907252;345.3972817433579;6022.638641681497;6070.575059745814;6141.508679305651;6147.538934579902;6178.104174894649;6059.212302400681;6070.514358851292;6077.848053798657;6087.604305720125;6103;4459.063596644701;4539.387182730322;4660.697054691451;4671.439427268732;4681.976590117061;4634.281686338623;4644.930326045112;4668.159731248391;4673.532646735333;4677.50886156952;4457.487388950263;4617.284320930245;4624.97687511562;4625.722456652595;4627.722336659795;4541.818327266906;4649.256119020974;4651.604613607814;4658.813647454114;4661.137689527448;4063.1467391847746;4066.044479547304;4076.673866090706;4077.734947228421;4081.3265811141127;5791.855203619901;5797.217375654275;5809.912851307234;5810.970945145289;5814.127880817869;5431.646942948696;5432.130859062531;5432.266644003088;5434.049041417736;5437.401885792559;6407.807765767035;6411;6411.93588064118;6418.454431373339;6423.357664233539;4257.76582287974;4404.229259879508;4404.889877753082;4411.360352748833;4411.602955733999;6602.1747281589805;6681.866362672719;6688.5652432592215;6693.431058360045;6700.832479187962;4482.125985432875;4487.708298960557;4490.416245888014;4498.3927169832305;4500;4535.818567257339;4536.047430039728;4548.818047278138;4552.226121559343;4552.863414097583;5277.656952298088;5293.629445938825;5297.761600727977;5299.284596579412;5311.389190243094;6241.625502469867;6447.903281450782;6449.935500644933;6453.322401147906;6467.676616169173;1583.2479572203342;1593.7290660587728;1597.6884507521154;1605.0449982260536;1606.1969015492255;974.780674348266;1025.5282570017725;1031.5615863258085;1046.4924511611862;1065.9626913058005;6125.509959203342;6151.3541078187045;6160.229971253593;6172.598781079216;6199.039148931923;6625.105610742585;6699.732010719516;6706.865862682719;6708;6724.899126513106;6200.503959683305;6220.595661282002;6229.501639868799;6229.968850155811;6236.844078898064;3541.38025845476;3585.551806024247;3586.372384832644;3586.8923932282073;3591.425371940477;6675.3324667533825;6818.4886133540185;6832.760853370109;6842.521023528405;6844.623545704934;6737;6754.831129221809;6757.797266082025;6768.458523318122;6772.11962444879;6805.319468053155;6810.046593476917;6812.62530560814;6817.250102488722;6832.111825462757;6608.966955165193;6611.239707433707;6617.139771829631;6618.2719900811835;6621.569597976116;6313.084602732486;6449;6457.870842583216;6483.610983341015;6485.708143133665;6755.3582409671;6795.966020169867;6803.11559497282;6819.045333653392;6820.454363650797;4488.349189367589;4492.865214043584;4494.303382975644;4494.325851122358;4501.122281155274;6604.8348791280605;6612.702428390638;6617.900731488935;6621.966890165519;6625.105610742681;6290.685465726787;6422.42198202164;6424;6428.357164283534;6433.453156481752;6419.069234960811;6428.903566446414;6429.067785171217;6433.356664333716;6440.806775796734;6322.841928951629;6382.5532212744665;6386.489080873426;6390.360963903572;6395.904061439175;6470.547061705635;6472.255690595642;6483.222013358427;6486;6508.153939987771;6073.817785466443;6136.417040381157;6329.461995730415;6334.271558770616;6334.524910631813 16:50:01 INFO - PROCESS | 4342 | |5;yui.html;760.2473551184329;784.9725259615915;790.1308560583359;843.1736897840117;875.1030194051096;13138.737225255501;13302.467901283937;13370.331483425814;13425.462981480741;13428.731425371487;13240.93379533101;13270.203787772716;13282.203067815937;13327.466901323935;13369.264690442022;750.3771869348428;895.9641614335419;896.5472436419599;897.7261935109789;917.4403613795579;915;919.1865199298602;919.8620206968941;920.7007722490184;920.8204400141975;988.4761076629397;992.6823416506721;994.140068840455;994.2493417469836;994.602159136344;798.5687728626564;967.9274054445874;985.0051448037498;989.8861630912465;990.7968866382374;717.3257138290043;721.3579913876654;722.0288711682779;725.6553137259812;727.2654618834962;13349.666258343523;13356.332183390889;13400.329983500786;13404.262765547892;13408.26254555999;13418.329083545783;13733.381997810022;13954.372053257526;14048.719025619532;14227.21750303733;10827.891721082768;11315.603953861575;11585.30488170704;11585.942070289679;12019.759604807943;3905.8632947846972;3948.74333168346;3967.2462232175794;3985.4619626350363;4012.4583181270445;52788.20817687738;53050;53783.19325210125;54035.99999999961;54307.45692543103;11480.138989575815;11558.595449159238;11602.187846850808;11689.123315751183;11702.414879256003;19713.704294435596;20043.799562004195;21302.254421095186;21325.25361612367;21331.68002479964;8432.32541396699;8515.19105684959;8515.829683406297;8581.785455363666;8727.738167854974;4514.593686568224;4558.612517935946;4561.407017087758;4624.44506659203;4704.5765881070865;3382.30662714143;3382.729381649511;3393.270446853938;3422.1615704152146;3430.811305378178;581.880714453536;607.2621764555997;612.6967151260154;616.3651439017818;620.6245221640933;626.6678660310043;719.7193094693074;742.6398196874511;744.6202436757293;774.825664225556;8722.738317850475;9090.545472726337;9102.362834601647;9137.954310228406;9178.908210917938;562.5808772464541;580.4630716587141;649.3409189672486;676.1446769836161;689.2383915773099;4155.376693495939;4229.238737027303;4230.238557059759;4288.442502474721;4352.086061927031;60288.397116029155;61479.692601536706;61593.692031539555;63508.36491635117;63835.6808215956;52944.47055529473;53842.46157538374;54005.72997135068;54179.18731219035;54882.17676734852;45812.5418745815;46358.30462543065;46566.534334657576;46836;47005.764971174925;9657.9034209657;9673.516324183904;9756;9896.158826499828;9931.205503559842;36685.63314366929;36818.447723284706;36877.44683829691;38460.80769596134;38900.41649375205;44121.338179926686;44465.77767111273;47091.76454117707;49822.25266621076;50711.492885072155;11934.404650907667;12146.878531214576;12201;12283.508659653513;12417.75164496687;13035.739285214433;13125.671858203239;13260;13345.799813002619;13697.178169309873;12649;12741.235525868478;12881;13089.0837641368;13109.27898965566;12688.619341419771;12753.61739147827;12931.353432328535;13033;13271.469141234242;11986.160968732454;12157.574484893341;12185.147039707135;12411.836479609465;12471.314077725812;10409.11522520564;10698.518566664363;11047.83428248593;11117.666470005914;11413.714657133305;10842;10930.180236482454;11028.44857757125;11030.172737044913;11045.28205666629 16:50:01 INFO - PROCESS | 4342 | __end_tp_report 16:50:01 INFO - PROCESS | 4342 | __start_cc_report 16:50:01 INFO - PROCESS | 4342 | _x_x_mozilla_cycle_collect,927 16:50:01 INFO - PROCESS | 4342 | __end_cc_report 16:50:01 INFO - PROCESS | 4342 | __startTimestamp1462837801191__endTimestamp 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | ------- Summary: start ------- 16:50:01 INFO - PROCESS | 4342 | Number of tests: 6 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | [#0] dojo.html Cycles:165 Average:5472.35 Median:5690.46 stddev:607.59 (10.7%) stddev-sans-first:584.88 16:50:01 INFO - PROCESS | 4342 | Values: 3291.7 3350.5 3364.1 3369.2 3395.7 5460.2 5471.4 5478.7 5484.2 5505.1 5457.5 5458.6 5494.6 5508.1 5510.9 4876.5 4973.4 5036.2 5069.2 5097.1 4975.8 5056.2 5057.3 5065.6 5065.7 5029.7 5049.4 5070.3 5093.7 5099.7 4986.8 5018.9 5037.6 5039.0 5063.9 4855.2 4896.7 4959.7 4964.5 4987.1 5261.2 5305.8 5320.1 5323.0 5365.2 5760.3 5867.8 5872.2 5926.1 5937.7 5943.0 5966.8 5978.9 5982.2 6006.1 5571.3 5576.1 5580.8 5583.2 5583.5 5897.5 5927.6 5946.0 5972.2 6067.2 5788.1 5843.8 5846.7 5846.7 5851.5 5919.6 5934.1 5934.3 5941.2 5952.1 5703.1 5827.0 5911.3 5931.3 5956.2 5872.4 5894.7 5899.0 5900.0 5900.4 4307.7 4465.7 4481.9 4482.0 4515.8 3973.2 4024.3 4033.9 4036.4 4061.0 5531.6 5559.3 5574.0 5581.2 5589.1 5806.9 5869.3 5895.9 5941.7 5946.4 5489.3 5514.4 5518.5 5538.9 5568.6 4984.7 5046.2 5048.7 5049.1 5074.8 5945.8 5983.8 5992.1 6068.5 6076.7 5889.4 5934.9 5936.4 5937.3 5955.4 6101.9 6138.3 6146.1 6149.3 6151.9 5695.5 5783.8 5834.2 5847.0 5885.0 5919.8 5939.5 5952.7 5954.6 5954.8 5764.9 5804.2 5825.4 5825.9 5828.2 5611.8 5618.4 5678.8 5690.7 5712.1 5690.5 5708.0 5734.9 5738.2 5742.8 5655.7 5828.2 5832.8 5848.9 5866.2 5463.9 5495.0 5629.2 5706.9 5749.8 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | [#1] ext.html Cycles:180 Average:50467.36 Median:38920.21 stddev:89281.99 (229.4%) stddev-sans-first:89453.76 16:50:01 INFO - PROCESS | 4342 | Values: 542.0 573.2 575.5 630.1 633.5 38696.4 39434.2 39562.8 39603.6 39676.6 43716.8 44288.8 44481.6 44551.6 44565.3 8664.8 8898.6 8903.0 8904.3 8905.6 8740.3 8922.0 8930.9 9140.4 9143.0 9156.4 9231.4 9233.9 9235.5 9237.9 9105.8 9171.2 9178.3 9185.8 9187.2 9101.5 9262.3 9263.1 9266.1 9300.3 42991.1 43262.8 43437.8 43489.0 43496.3 3546.5 3809.6 3821.7 3927.9 4091.2 30557.2 31002.5 31099.4 31106.7 31948.0 4291.7 4342.0 4361.7 4377.6 4380.8 285485.0 289243.0 291853.5 291971.0 292205.0 47262.3 48442.8 71330.0 72117.0 72178.3 51335.7 51702.5 51756.2 51776.2 51991.0 16402.6 16515.1 16533.5 16565.3 16580.3 14020.9 14043.9 14067.4 14153.7 14168.3 16090.0 16252.8 16255.6 16274.8 16334.2 6288.2 6356.9 6374.5 6404.5 6408.8 981.7 984.7 1060.2 1063.2 1083.8 31494.1 32791.8 32794.7 33298.7 33781.7 1005.3 1087.5 1150.7 1163.0 1172.5 15959.6 16067.4 16086.2 16600.5 16668.2 438075.0 439192.0 442416.0 442459.0 442725.0 62089.4 62634.4 62644.7 62741.0 62750.4 1313.1 1456.7 1500.8 1501.4 1512.9 28809.0 28930.3 29061.7 29562.3 29768.7 48476.8 49243.8 49484.0 49495.0 49546.8 249855.0 258259.0 258732.0 259016.0 259220.0 31129.0 34981.8 35434.8 35674.3 36284.3 44900.1 44921.8 45497.5 45647.0 45775.8 37851.8 37946.8 38181.0 38264.6 38439.4 37788.6 38124.8 38625.4 38836.4 39004.0 37542.0 37804.6 38592.0 38688.2 38814.4 32769.5 33695.0 34213.8 34426.0 34492.0 26168.6 26212.6 26368.6 26537.3 26839.9 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | [#2] jquery.html Cycles:180 Average:27284.01 Median:36129.05 stddev:77434.97 (214.3%) stddev-sans-first:77625.77 16:50:01 INFO - PROCESS | 4342 | Values: 344.6 355.7 360.1 365.6 368.8 17533.8 17937.7 19972.5 19999.6 20025.7 18001.6 18387.3 18568.7 18611.3 18617.5 5309.8 5510.7 5545.6 5556.2 5559.9 4137.3 5422.8 5733.9 5980.5 6013.7 5903.6 5946.7 5975.5 5978.1 5980.5 5719.7 5898.8 5906.7 5919.7 5921.3 3758.3 5032.7 5170.9 5217.9 5222.1 22116.8 22144.8 22209.6 22433.3 22527.9 2509.8 2564.0 2904.3 3138.9 3162.2 13270.3 13826.9 13868.0 13945.1 14083.1 1764.3 1795.9 1840.7 1847.8 1886.9 65524.0 65727.0 65862.0 66144.0 66904.7 9096.8 9321.4 9549.0 9632.9 9780.8 13308.4 13465.4 13480.7 13490.9 13508.7 8087.2 8162.3 8181.8 8226.4 8245.3 8289.3 8300.8 8328.4 8404.6 8432.9 5841.5 5860.9 5888.7 5918.4 5990.6 1651.0 1651.2 1761.2 1767.1 1771.8 936.6 938.8 973.4 995.2 1019.6 15919.3 15975.4 16373.4 16813.3 18093.8 921.8 952.5 981.9 987.1 988.5 10223.9 10380.6 10416.7 10433.6 10469.9 441614.0 443088.0 447553.0 505174.0 516524.0 82591.2 83930.0 84096.6 84152.2 84470.0 1086.5 1086.8 1095.5 1127.8 1146.5 15736.5 15862.8 15871.0 15903.9 16111.2 35955.0 36121.3 36136.8 36238.3 36443.5 46943.3 47313.8 51269.0 52962.5 53252.7 7702.2 7754.1 7773.7 7864.8 7875.9 12174.8 12700.6 12760.2 13035.9 13355.4 11330.2 11476.8 11619.3 11920.9 11956.6 11053.3 11647.4 11648.7 11851.0 11988.4 11809.2 12123.5 12160.5 12185.8 12232.2 7824.9 7880.0 8002.0 8037.5 8070.0 10571.7 11882.9 11995.0 12007.4 12023.9 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | [#3] mootools.html Cycles:180 Average:5645.03 Median:6410.00 stddev:2950.42 (46.0%) stddev-sans-first:2941.97 16:50:01 INFO - PROCESS | 4342 | Values: 1465.2 1613.4 1632.6 1854.6 1971.9 6880.3 7767.6 7906.2 7943.0 7949.6 7876.2 8026.2 8028.4 8041.1 8046.6 2291.3 2310.9 2316.0 2317.2 2317.2 2327.9 2331.0 2378.0 2378.7 2392.8 2364.0 2370.9 2376.0 2403.0 2406.2 2311.4 2319.0 2324.9 2327.8 2385.6 2359.8 2360.9 2366.0 2367.7 2368.8 8041.6 8042.4 8100.1 8164.8 8173.8 4986.8 5122.0 5122.1 5123.0 5127.3 3148.8 3166.3 3228.5 3244.0 3273.4 983.6 985.6 1003.4 1016.9 1019.7 11211.9 11238.7 11250.4 11266.3 11268.6 4407.5 4441.7 4508.6 4512.9 4551.7 9538.5 9559.9 9594.4 9598.5 9649.4 5033.0 5061.0 5079.9 5082.0 5083.3 4070.6 4160.5 4511.7 4547.0 4621.5 3784.2 3786.6 3797.1 3855.1 3858.4 1209.3 1249.8 1259.8 1260.1 1266.9 1406.6 1421.1 1432.8 1442.6 1464.6 7648.0 7657.3 7678.3 7684.4 7687.2 493.6 496.8 499.9 500.7 502.7 5810.9 5855.0 5879.4 5915.6 5929.7 9355.7 9922.3 9996.9 10065.2 10070.6 9733.8 9895.5 9912.8 9922.1 9957.9 7273.3 7375.0 7416.6 7434.9 7462.9 7291.1 7543.6 7639.3 7665.6 7665.8 8680.0 8732.0 8802.5 8962.5 8970.8 8800.6 8859.5 8866.7 8927.6 9059.5 6328.6 6491.4 6730.5 6948.5 7071.5 7556.4 7597.1 7651.3 7658.0 7668.8 6786.1 6936.2 6961.2 6992.6 7095.1 6804.1 6864.3 6892.8 6921.0 6923.7 7027.6 7066.3 7110.6 7259.3 7274.8 6757.8 6762.5 6767.2 6787.7 6790.3 6634.3 6787.7 6833.5 6834.7 6835.2 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | [#4] prototype.html Cycles:180 Average:5363.67 Median:6149.45 stddev:1625.27 (26.4%) stddev-sans-first:1585.35 16:50:01 INFO - PROCESS | 4342 | Values: 332.2 337.8 339.6 344.8 345.4 6022.6 6070.6 6141.5 6147.5 6178.1 6059.2 6070.5 6077.8 6087.6 6103.0 4459.1 4539.4 4660.7 4671.4 4682.0 4634.3 4644.9 4668.2 4673.5 4677.5 4457.5 4617.3 4625.0 4625.7 4627.7 4541.8 4649.3 4651.6 4658.8 4661.1 4063.1 4066.0 4076.7 4077.7 4081.3 5791.9 5797.2 5809.9 5811.0 5814.1 5431.6 5432.1 5432.3 5434.0 5437.4 6407.8 6411.0 6411.9 6418.5 6423.4 4257.8 4404.2 4404.9 4411.4 4411.6 6602.2 6681.9 6688.6 6693.4 6700.8 4482.1 4487.7 4490.4 4498.4 4500.0 4535.8 4536.0 4548.8 4552.2 4552.9 5277.7 5293.6 5297.8 5299.3 5311.4 6241.6 6447.9 6449.9 6453.3 6467.7 1583.2 1593.7 1597.7 1605.0 1606.2 974.8 1025.5 1031.6 1046.5 1066.0 6125.5 6151.4 6160.2 6172.6 6199.0 6625.1 6699.7 6706.9 6708.0 6724.9 6200.5 6220.6 6229.5 6230.0 6236.8 3541.4 3585.6 3586.4 3586.9 3591.4 6675.3 6818.5 6832.8 6842.5 6844.6 6737.0 6754.8 6757.8 6768.5 6772.1 6805.3 6810.0 6812.6 6817.3 6832.1 6609.0 6611.2 6617.1 6618.3 6621.6 6313.1 6449.0 6457.9 6483.6 6485.7 6755.4 6796.0 6803.1 6819.0 6820.5 4488.3 4492.9 4494.3 4494.3 4501.1 6604.8 6612.7 6617.9 6622.0 6625.1 6290.7 6422.4 6424.0 6428.4 6433.5 6419.1 6428.9 6429.1 6433.4 6440.8 6322.8 6382.6 6386.5 6390.4 6395.9 6470.5 6472.3 6483.2 6486.0 6508.2 6073.8 6136.4 6329.5 6334.3 6334.5 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - PROCESS | 4342 | [#5] yui.html Cycles:180 Average:14861.46 Median:44293.56 stddev:16968.45 (38.3%) stddev-sans-first:16983.01 16:50:01 INFO - PROCESS | 4342 | Values: 760.2 785.0 790.1 843.2 875.1 13138.7 13302.5 13370.3 13425.5 13428.7 13240.9 13270.2 13282.2 13327.5 13369.3 750.4 896.0 896.5 897.7 917.4 915.0 919.2 919.9 920.7 920.8 988.5 992.7 994.1 994.2 994.6 798.6 967.9 985.0 989.9 990.8 717.3 721.4 722.0 725.7 727.3 13349.7 13356.3 13400.3 13404.3 13408.3 13418.3 13733.4 13954.4 14048.7 14227.2 10827.9 11315.6 11585.3 11585.9 12019.8 3905.9 3948.7 3967.2 3985.5 4012.5 52788.2 53050.0 53783.2 54036.0 54307.5 11480.1 11558.6 11602.2 11689.1 11702.4 19713.7 20043.8 21302.3 21325.3 21331.7 8432.3 8515.2 8515.8 8581.8 8727.7 4514.6 4558.6 4561.4 4624.4 4704.6 3382.3 3382.7 3393.3 3422.2 3430.8 581.9 607.3 612.7 616.4 620.6 626.7 719.7 742.6 744.6 774.8 8722.7 9090.5 9102.4 9138.0 9178.9 562.6 580.5 649.3 676.1 689.2 4155.4 4229.2 4230.2 4288.4 4352.1 60288.4 61479.7 61593.7 63508.4 63835.7 52944.5 53842.5 54005.7 54179.2 54882.2 45812.5 46358.3 46566.5 46836.0 47005.8 9657.9 9673.5 9756.0 9896.2 9931.2 36685.6 36818.4 36877.4 38460.8 38900.4 44121.3 44465.8 47091.8 49822.3 50711.5 11934.4 12146.9 12201.0 12283.5 12417.8 13035.7 13125.7 13260.0 13345.8 13697.2 12649.0 12741.2 12881.0 13089.1 13109.3 12688.6 12753.6 12931.4 13033.0 13271.5 11986.2 12157.6 12185.1 12411.8 12471.3 10409.1 10698.5 11047.8 11117.7 11413.7 10842.0 10930.2 11028.4 11030.2 11045.3 16:50:01 INFO - PROCESS | 4342 | -------- Summary: end -------- 16:50:01 INFO - PROCESS | 4342 | 16:50:01 INFO - TEST-INFO | 4342: exit 0 16:50:01 INFO - TEST-OK | dromaeo_css | took 1111351ms 16:50:01 INFO - TEST-START | kraken 16:50:01 INFO - operating with platform_type : linux_ 16:50:01 INFO - Initialising browser for kraken test... 16:50:01 INFO - TEST-INFO | started process 4534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEWesB/profile http://localhost:58935/getInfo.html) 16:50:06 INFO - PROCESS | 4534 | __metrics Screen width/height:1600/1200 16:50:06 INFO - PROCESS | 4534 | colorDepth:24 16:50:06 INFO - PROCESS | 4534 | Browser inner width/height: 1024/697 16:50:06 INFO - PROCESS | 4534 | __metrics 16:50:06 INFO - PROCESS | 4534 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:07 INFO - TEST-INFO | 4534: exit 0 16:50:07 INFO - Browser initialized. 16:50:07 INFO - Running cycle 1/1 for kraken test... 16:50:07 INFO - TEST-INFO | started process 4624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEWesB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:19 INFO - PROCESS | 4624 | RSS: Main: 138817536 16:50:19 INFO - PROCESS | 4624 | 16:50:22 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58935/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:22 INFO - PROCESS | 4624 | RSS: Main: 175370240 16:50:22 INFO - PROCESS | 4624 | 16:50:25 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58935/tests/kraken/driver.html?testName=audio-dft) 16:50:25 INFO - PROCESS | 4624 | RSS: Main: 173338624 16:50:25 INFO - PROCESS | 4624 | 16:50:28 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58935/tests/kraken/driver.html?testName=audio-fft) 16:50:29 INFO - PROCESS | 4624 | RSS: Main: 169750528 16:50:29 INFO - PROCESS | 4624 | 16:50:31 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58935/tests/kraken/driver.html?testName=audio-oscillator) 16:50:32 INFO - PROCESS | 4624 | RSS: Main: 170328064 16:50:32 INFO - PROCESS | 4624 | 16:50:34 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:50:34 INFO - PROCESS | 4624 | RSS: Main: 167727104 16:50:34 INFO - PROCESS | 4624 | 16:50:37 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58935/tests/kraken/driver.html?testName=imaging-darkroom) 16:50:38 INFO - PROCESS | 4624 | RSS: Main: 168058880 16:50:38 INFO - PROCESS | 4624 | 16:50:41 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58935/tests/kraken/driver.html?testName=imaging-desaturate) 16:50:42 INFO - PROCESS | 4624 | RSS: Main: 168529920 16:50:42 INFO - PROCESS | 4624 | 16:50:45 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58935/tests/kraken/driver.html?testName=json-parse-financial) 16:50:45 INFO - PROCESS | 4624 | RSS: Main: 168222720 16:50:45 INFO - PROCESS | 4624 | 16:50:47 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:50:47 INFO - PROCESS | 4624 | RSS: Main: 174051328 16:50:47 INFO - PROCESS | 4624 | 16:50:49 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:50:50 INFO - PROCESS | 4624 | RSS: Main: 171098112 16:50:50 INFO - PROCESS | 4624 | 16:50:52 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:50:52 INFO - PROCESS | 4624 | RSS: Main: 178323456 16:50:52 INFO - PROCESS | 4624 | 16:50:55 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:50:55 INFO - PROCESS | 4624 | RSS: Main: 182284288 16:50:55 INFO - PROCESS | 4624 | 16:50:58 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:50:58 INFO - PROCESS | 4624 | RSS: Main: 180797440 16:50:58 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:58935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58935/tests/kraken/driver.html?testName=ai-astar) 16:51:00 INFO - PROCESS | 4624 | RSS: Main: 243728384 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | __start_tp_report 16:51:00 INFO - PROCESS | 4624 | _x_x_mozilla_page_load 16:51:00 INFO - PROCESS | 4624 | _x_x_mozilla_page_load_details 16:51:00 INFO - PROCESS | 4624 | |i|pagename|runs| 16:51:00 INFO - PROCESS | 4624 | |0;ai-astar;109;112;106;112;110;111;100;111;110;110 16:51:00 INFO - PROCESS | 4624 | |1;audio-beat-detection;153;127;152;185;128;158;159;131;168;128 16:51:00 INFO - PROCESS | 4624 | |2;audio-dft;160;160;163;161;161;160;161;163;161;160 16:51:00 INFO - PROCESS | 4624 | |3;audio-fft;75;77;75;180;77;77;76;83;163;73 16:51:00 INFO - PROCESS | 4624 | |4;audio-oscillator;93;93;140;93;93;93;154;93;93;151 16:51:00 INFO - PROCESS | 4624 | |5;imaging-gaussian-blur;116;117;117;116;116;116;117;117;117;116 16:51:00 INFO - PROCESS | 4624 | |6;imaging-darkroom;145;145;145;145;146;145;145;145;145;145 16:51:00 INFO - PROCESS | 4624 | |7;imaging-desaturate;96;95;95;96;95;95;95;95;95;95 16:51:00 INFO - PROCESS | 4624 | |8;json-parse-financial;54;54;57;55;55;54;56;54;60;53 16:51:00 INFO - PROCESS | 4624 | |9;json-stringify-tinderbox;63;64;64;64;64;75;65;64;64;65 16:51:00 INFO - PROCESS | 4624 | |10;stanford-crypto-aes;81;79;79;79;79;80;79;79;80;81 16:51:00 INFO - PROCESS | 4624 | |11;stanford-crypto-ccm;114;116;112;115;115;117;121;113;113;126 16:51:00 INFO - PROCESS | 4624 | |12;stanford-crypto-pbkdf2;154;141;143;153;142;143;153;151;153;141 16:51:00 INFO - PROCESS | 4624 | |13;stanford-crypto-sha256-iterative;70;71;73;71;70;67;69;72;70;68 16:51:00 INFO - PROCESS | 4624 | __end_tp_report 16:51:00 INFO - PROCESS | 4624 | __start_cc_report 16:51:00 INFO - PROCESS | 4624 | _x_x_mozilla_cycle_collect,1054 16:51:00 INFO - PROCESS | 4624 | __end_cc_report 16:51:00 INFO - PROCESS | 4624 | __startTimestamp1462837860830__endTimestamp 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | ------- Summary: start ------- 16:51:00 INFO - PROCESS | 4624 | Number of tests: 14 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.63 (3.3%) stddev-sans-first:3.86 16:51:00 INFO - PROCESS | 4624 | Values: 109.0 112.0 106.0 112.0 110.0 111.0 100.0 111.0 110.0 110.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:155.50 stddev:19.87 (12.8%) stddev-sans-first:21.02 16:51:00 INFO - PROCESS | 4624 | Values: 153.0 127.0 152.0 185.0 128.0 158.0 159.0 131.0 168.0 128.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 16:51:00 INFO - PROCESS | 4624 | Values: 160.0 160.0 163.0 161.0 161.0 160.0 161.0 163.0 161.0 160.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.50 stddev:40.29 (52.7%) stddev-sans-first:42.03 16:51:00 INFO - PROCESS | 4624 | Values: 75.0 77.0 75.0 180.0 77.0 77.0 76.0 83.0 163.0 73.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.95 (29.0%) stddev-sans-first:27.91 16:51:00 INFO - PROCESS | 4624 | Values: 93.0 93.0 140.0 93.0 93.0 93.0 154.0 93.0 93.0 151.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:51:00 INFO - PROCESS | 4624 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 16:51:00 INFO - PROCESS | 4624 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:51:00 INFO - PROCESS | 4624 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.04 (3.7%) stddev-sans-first:2.12 16:51:00 INFO - PROCESS | 4624 | Values: 54.0 54.0 57.0 55.0 55.0 54.0 56.0 54.0 60.0 53.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:64.00 stddev:3.49 (5.5%) stddev-sans-first:3.61 16:51:00 INFO - PROCESS | 4624 | Values: 63.0 64.0 64.0 64.0 64.0 75.0 65.0 64.0 64.0 65.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:0.84 (1.1%) stddev-sans-first:0.73 16:51:00 INFO - PROCESS | 4624 | Values: 81.0 79.0 79.0 79.0 79.0 80.0 79.0 79.0 80.0 81.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:115.50 stddev:4.29 (3.7%) stddev-sans-first:4.48 16:51:00 INFO - PROCESS | 4624 | Values: 114.0 116.0 112.0 115.0 115.0 117.0 121.0 113.0 113.0 126.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:152.00 stddev:5.78 (3.8%) stddev-sans-first:5.61 16:51:00 INFO - PROCESS | 4624 | Values: 154.0 141.0 143.0 153.0 142.0 143.0 153.0 151.0 153.0 141.0 16:51:00 INFO - PROCESS | 4624 | 16:51:00 INFO - PROCESS | 4624 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.79 (2.5%) stddev-sans-first:1.90 16:51:00 INFO - PROCESS | 4624 | Values: 70.0 71.0 73.0 71.0 70.0 67.0 69.0 72.0 70.0 68.0 16:51:00 INFO - PROCESS | 4624 | -------- Summary: end -------- 16:51:00 INFO - PROCESS | 4624 | 16:51:01 INFO - TEST-INFO | 4624: exit 0 16:51:01 INFO - TEST-OK | kraken | took 59935ms 16:51:01 INFO - SUITE-END | took 1171s 16:51:01 INFO - Completed test suite (00:19:31) 16:51:01 INFO - javascript benchmark 16:51:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3291.7037466628003, 3350.4806754952992, 3364.142143753344, 3369.2250782320066, 3395.6604339566047, 5460.1536761801935, 5471.3707923588745, 5478.698671573062, 5484.204790305404, 5505.064139096353, 5457.481539253775, 5458.590605704578, 5494.587905907063, 5508.063629183039, 5510.862228444281, 4876.536729010738, 4973.353464049677, 5036.169032109716, 5069.239614057902, 5097.108006098936, 4975.776090075955, 5056.19100943849, 5057.317262169597, 5065.594752419797, 5065.7467126643705, 5029.698218106907, 5049.3940727112795, 5070.264811602316, 5093.745312734367, 5099.668521546107, 4986.750662466862, 5018.899622007576, 5037.5718063964605, 5039.042581909463, 5063.949360506384, 4855.198892182786, 4896.6817156885045, 4959.6528243023, 4964.528369804862, 4987.077390682699, 5261.237120617528, 5305.814296499642, 5320.12217984036, 5322.973385133049, 5365.248865158881, 5760.308762948431, 5867.823965281048, 5872.236609240814, 5926.1110833374905, 5937.732802023919, 5943.049112142036, 5966.761329546813, 5978.880422391571, 5982.192404025444, 6006.069059295816, 5571.331440227199, 5576.1356989666265, 5580.776768929279, 5583.162525621149, 5583.4974852263085, 5897.469227769521, 5927.644341339534, 5945.970270148621, 5972.193753843176, 6067.180930574405, 5788.102844059177, 5843.795467158629, 5846.6784326862435, 5846.707664616837, 5851.473367396955, 5919.585629005928, 5934.13954976526, 5934.287885453773, 5941.168236446901, 5952.136940143655, 5703.058995265817, 5827.038538641077, 5911.261092363455, 5931.347551769302, 5956.225690660186, 5872.442117998783, 5894.705264736746, 5898.970505147533, 5900.0, 5900.380460051719, 4307.698461107692, 4465.687401881837, 4481.887952801141, 4482.0, 4515.774211289422, 3973.2450834341385, 4024.2957482440456, 4033.899152521152, 4036.414719865662, 4060.9796951015055, 5531.557475401958, 5559.27729395176, 5573.972130139324, 5581.218629391808, 5589.077802162597, 5806.9419305806405, 5869.325027621878, 5895.941040589625, 5941.702914854326, 5946.43508866657, 5489.286392768994, 5514.365847927459, 5518.503334699896, 5538.944610553843, 5568.6101972862325, 4984.675996060245, 5046.167382381939, 5048.671836330626, 5049.141645920203, 5074.82238121664, 5945.7621695132575, 5983.790567330123, 5992.0712289595185, 6068.544859135494, 6076.696165191811, 5889.381614930542, 5934.9406505934385, 5936.406359364202, 5937.2578427696535, 5955.434233747787, 6101.938980610137, 6138.263408391022, 6146.139540464428, 6149.292831324455, 6151.9384806151365, 5695.544356451557, 5783.826485205451, 5834.18321434991, 5846.970765146147, 5885.0, 5919.792807251725, 5939.524838013035, 5952.702364881652, 5954.553408494467, 5954.791582294599, 5764.884702305846, 5804.216430781959, 5825.417458254141, 5825.883482330245, 5828.242328497268, 5611.775528978958, 5618.410066943075, 5678.77284908599, 5690.687012214368, 5712.0860662293835, 5690.459406356389, 5708.0, 5734.856628584152, 5738.22533957927, 5742.770289188553, 5655.660660360391, 5828.154917537018, 5832.795852145155, 5848.941510584839, 5866.2373891393845, 5463.918041229305, 5495.0, 5629.240052593012, 5706.885862282814, 5749.8275051748515], "unit": "score", "name": "dojo.html", "value": 5433.164484253953}, {"lowerIsBetter": false, "replicates": [541.9539339156174, 573.2118337286231, 575.4676923845448, 630.0958125090494, 633.4520639646705, 38696.419553706684, 39434.21131577367, 39562.80218598903, 39603.60396396032, 39676.60323396769, 43716.781416092956, 44288.77855610725, 44481.555184448145, 44551.55448445515, 44565.331520027146, 8664.826703465942, 8898.644054237822, 8903.0, 8904.287656987426, 8905.554722263892, 8740.257078148365, 8921.973972993092, 8930.910690893073, 9140.405873618227, 9142.954285228598, 9156.359054866161, 9231.446113233194, 9233.907660923373, 9235.538223088852, 9237.861432078524, 9105.817883642323, 9171.220446262076, 9178.265738740885, 9185.770355741093, 9187.173154416101, 9101.453912765255, 9262.259019278441, 9263.120003599648, 9266.073392660748, 9300.255979521622, 42991.14017719659, 43262.78368608168, 43437.78281108606, 43489.0, 43496.347554786706, 3546.5389499365174, 3809.561900381464, 3821.6560509554274, 3927.8625248116177, 4091.243120022805, 30557.236069098228, 31002.534961975587, 31099.37801243985, 31106.688933110607, 31948.041558753273, 4291.678124140702, 4341.956580434218, 4361.716488428274, 4377.627901628365, 4380.759058251795, 285485.0, 289243.0, 291853.5407322971, 291971.0, 292205.0, 47262.29106563405, 48442.757786210845, 71330.0, 72117.0, 72178.2782172182, 51335.74332128315, 51702.48297517052, 51756.22365664518, 51776.22335664968, 51991.0, 16402.589935251715, 16515.091669958027, 16533.50399488017, 16565.25456354467, 16580.336786528405, 14020.859791401956, 14043.929780351033, 14067.43730250799, 14153.716925661634, 14168.291585420893, 16090.0, 16252.75620865688, 16255.59361015984, 16274.837251627332, 16334.18329083541, 6288.182536270256, 6356.872862542723, 6374.521910856704, 6404.455621272151, 6408.775692850728, 981.6613268422383, 984.7193549838262, 1060.2419270221828, 1063.1547919403938, 1083.788661211072, 31494.055178344686, 32791.83604082012, 32794.688212471236, 33298.66701333004, 33781.66218337785, 1005.3465247588979, 1087.543231842628, 1150.6663067710438, 1162.9941850290863, 1172.5251273234353, 15959.601009974844, 16067.357305707641, 16086.195690215442, 16600.50198494047, 16668.166591670368, 438075.0, 439192.0, 442416.0, 442459.0, 442725.0, 62089.379106209264, 62634.373656263764, 62644.686776566734, 62741.0, 62750.37249627537, 1313.1267706974754, 1456.686812335353, 1500.8199016118135, 1501.4294568064283, 1512.8562786535263, 28809.0, 28930.27674308159, 29061.7093829059, 29562.260943476584, 29768.722686727717, 48476.7576162117, 49243.753781230866, 49484.0, 49495.0, 49546.752266238436, 249855.0, 258259.0, 258732.0, 259016.0, 259220.0, 31129.0, 34981.82509087438, 35434.82282588674, 35674.28651427009, 36284.27431451409, 44900.10199796051, 44921.775391122836, 45497.545024549334, 45647.0, 45775.77112114551, 37851.810740946115, 37946.810265948494, 38181.0, 38264.61735382611, 38439.423408649454, 37788.62211377851, 38124.809375952944, 38625.42061869018, 38836.41745373765, 39004.0, 37542.0, 37804.621953781214, 38592.0, 38688.22623547457, 38814.41778373383, 32769.50845737268, 33695.0, 34213.82893085518, 34426.0, 34492.0, 26168.60747088757, 26212.60681089747, 26368.60447093257, 26537.33656658599, 26839.865800670872], "unit": "score", "name": "ext.html", "value": 19417.120967231327}, {"lowerIsBetter": false, "replicates": [344.5985426977571, 355.7438644176193, 360.0602427663797, 365.5503730411594, 368.83402468889005, 17533.824661753377, 17937.730934036, 19972.50068748282, 19999.60000799985, 20025.699614505756, 18001.63996720065, 18387.26450941964, 18568.721469177974, 18611.348602798906, 18617.534561635934, 5309.840704778853, 5510.669359838403, 5545.556355491572, 5556.194351818984, 5559.916601250984, 4137.2552940470705, 5422.783088676449, 5733.856653583673, 5980.521558275327, 6013.729382177812, 5903.557233207505, 5946.672932988684, 5975.462208401243, 5978.133170690247, 5980.461758441739, 5719.742611582468, 5898.8230353089475, 5906.704664766745, 5919.674417907014, 5921.259842519685, 3758.342290099249, 5032.723200223986, 5170.922436163461, 5217.869553261161, 5222.138347172712, 22116.778832211632, 22144.778552214433, 22209.555808883895, 22433.32700019002, 22527.88736056309, 2509.761572650595, 2564.0128550508, 2904.2739315171207, 3138.8901388451523, 3162.2094476380903, 13270.336483175803, 13826.93086534571, 13868.0, 13945.09356891809, 14083.084599501, 1764.303100275384, 1795.8832675876026, 1840.74229607855, 1847.8059803720685, 1886.8773529720524, 65524.0, 65727.0, 65862.0, 66144.0, 66904.66547667279, 9096.81806363869, 9321.394109382869, 9548.952255238679, 9632.855507167398, 9780.755481112887, 13308.401121949535, 13465.394057267447, 13480.662983425493, 13490.86509134896, 13508.729825403438, 8087.150849160871, 8162.347012239006, 8181.79545511367, 8226.383021273428, 8245.299149572234, 8289.253967142986, 8300.833983320299, 8328.417010809306, 8404.579771011426, 8432.873506897402, 5841.474267315962, 5860.941390586125, 5888.735006924613, 5918.378570250148, 5990.610610310316, 1650.9504714858574, 1651.157909466157, 1761.1546457700376, 1767.1341042888891, 1771.7962434320218, 936.6440752514137, 938.7981583959481, 973.3624475968252, 995.2137811129271, 1019.6329321444274, 15919.283632236577, 15975.360985560448, 16373.42693005739, 16813.32746690143, 18093.819061809478, 921.7603423109906, 952.5189779161618, 981.9361741486781, 987.0820137272406, 988.5452691761726, 10223.897761022443, 10380.636677716244, 10416.739581510372, 10433.634822781167, 10469.895301047045, 441614.0, 443088.0, 447553.0, 505174.0, 516524.0, 82591.17811725143, 83930.0, 84096.57951710203, 84152.15847841444, 84470.0, 1086.4789294986924, 1086.7500474890662, 1095.457748414524, 1127.7969965406141, 1146.5184622458587, 15736.481294841913, 15862.762058569362, 15871.0, 15903.920480397524, 16111.194440278174, 35955.0, 36121.27757444889, 36136.8193159043, 36238.27523449569, 36443.45334819927, 46943.29585056295, 47313.763431182626, 51269.0, 52962.47037529575, 53252.73373633107, 7702.229777022253, 7754.108277548155, 7773.650185741542, 7864.764057078068, 7875.921240787518, 12174.817377739164, 12700.618981430573, 12760.234385936874, 13035.869641303465, 13355.3990070449, 11330.150238731963, 11476.827847582459, 11619.302841829518, 11920.880791191978, 11956.641300760992, 11053.28153670009, 11647.359395233005, 11648.708782280512, 11851.0, 11988.400579971141, 11809.173357865211, 12123.45444454984, 12160.452779625115, 12185.817212741638, 12232.204906681038, 7824.931035861434, 7880.0, 8002.03975522941, 8037.477563958324, 8070.031596208492, 10571.735706607396, 11882.881171188177, 11995.0, 12007.39963001829, 12023.939880300542], "unit": "score", "name": "jquery.html", "value": 8959.564236886503}, {"lowerIsBetter": false, "replicates": [1465.1721777195876, 1613.4352976458242, 1632.5836911587544, 1854.5549068223631, 1971.9014049297532, 6880.311968803117, 7767.611619419027, 7906.209379062091, 7943.0, 7949.562774047417, 7876.173001834796, 8026.237507436799, 8028.438009339348, 8041.075276343207, 8046.637901294441, 2291.301153148289, 2310.9306720798404, 2315.953680926389, 2317.1889838556453, 2317.212147869724, 2327.93016209514, 2330.9883450582806, 2377.95244095118, 2378.6669866218745, 2392.7966122879575, 2364.030747393569, 2370.8577485350847, 2376.025829409942, 2403.0, 2406.2300063979533, 2311.4105902994797, 2318.988405057972, 2324.9070037198494, 2327.7904988551027, 2385.61830107182, 2359.8466099703464, 2360.881955902198, 2365.988170059156, 2367.6922000140044, 2368.798652114572, 8041.597920103972, 8042.437029407944, 8100.149484304122, 8164.7550573482895, 8173.79565510867, 4986.82546110888, 5121.974390128025, 5122.103631864409, 5123.026624941249, 5127.256547800585, 3148.7795854290207, 3166.255929856482, 3228.499582564706, 3243.9513407298673, 3273.4435146025235, 983.6409710455704, 985.5762022330395, 1003.4180175498267, 1016.9338992965434, 1019.6838979916249, 11211.887881121165, 11238.662840114728, 11250.3812290324, 11266.267692599955, 11268.605598804003, 4407.493138289138, 4441.689081764245, 4508.571685689854, 4512.864614061584, 4551.749653769075, 9538.475383853955, 9559.90440095604, 9594.376365536358, 9598.520073996273, 9649.372790768577, 5033.018561380496, 5061.0, 5079.949200508022, 5082.0, 5083.262926875583, 4070.5929407059057, 4160.500739911169, 4511.661625378109, 4547.045120524661, 4621.468531118964, 3784.243151369737, 3786.583475817658, 3797.0886987123445, 3855.094052897567, 3858.401947698111, 1209.25026483579, 1249.7875361188437, 1259.80473026681, 1260.1053252191048, 1266.9049821263443, 1406.6342750884844, 1421.1260075053974, 1432.7994080828485, 1442.596073099534, 1464.6265202373327, 7648.005759251262, 7657.272559106876, 7678.308952194329, 7684.423668224906, 7687.192844751333, 493.5730593037069, 496.8459777468996, 499.94000719913845, 500.73711301566243, 502.7109412087991, 5810.941890581124, 5855.033919403336, 5879.412058794172, 5915.556333274935, 5929.673867937218, 9355.672551460802, 9922.255830812717, 9996.900030999597, 10065.245106617032, 10070.647527336509, 9733.805323893483, 9895.505224738734, 9912.801743965225, 9922.107010368956, 9957.900420995842, 7273.3453989141235, 7375.004374409494, 7416.555006699616, 7434.851302973911, 7462.85074298511, 7291.125064992235, 7543.622818859145, 7639.274268944441, 7665.616719164131, 7665.846683066419, 8680.0, 8732.039475657799, 8802.471851688662, 8962.507062111647, 8970.775730606787, 8800.559972001247, 8859.468431894107, 8866.73399798007, 8927.553622318988, 9059.547022648972, 6328.6202827830475, 6491.383318584727, 6730.495212859153, 6948.513604047668, 7071.540349877448, 7556.433267505069, 7597.050368703912, 7651.3496352810635, 7658.042744656918, 7668.80827979305, 6786.083878676315, 6936.237013928565, 6961.234264231032, 6992.615406152507, 7095.077639906779, 6804.11546498952, 6864.347886950732, 6892.827679308058, 6921.0, 6923.653817309014, 7027.613481258375, 7066.258042905421, 7110.608916509642, 7259.346658800733, 7274.818129546804, 6757.763478278237, 6762.526623136333, 6767.154105736783, 6787.694553744995, 6790.32096790317, 6634.303398143125, 6787.66061696923, 6833.45332373399, 6834.726610935706, 6835.248122706399], "unit": "score", "name": "mootools.html", "value": 4570.494987947488}, {"lowerIsBetter": false, "replicates": [332.2408297041261, 337.80576168703, 339.6111452387017, 344.8000159907252, 345.3972817433579, 6022.638641681497, 6070.575059745814, 6141.508679305651, 6147.538934579902, 6178.104174894649, 6059.212302400681, 6070.514358851292, 6077.848053798657, 6087.604305720125, 6103.0, 4459.063596644701, 4539.387182730322, 4660.697054691451, 4671.439427268732, 4681.976590117061, 4634.281686338623, 4644.930326045112, 4668.159731248391, 4673.532646735333, 4677.50886156952, 4457.487388950263, 4617.284320930245, 4624.97687511562, 4625.722456652595, 4627.722336659795, 4541.818327266906, 4649.256119020974, 4651.604613607814, 4658.813647454114, 4661.137689527448, 4063.1467391847746, 4066.044479547304, 4076.673866090706, 4077.734947228421, 4081.3265811141127, 5791.855203619901, 5797.217375654275, 5809.912851307234, 5810.970945145289, 5814.127880817869, 5431.646942948696, 5432.130859062531, 5432.266644003088, 5434.049041417736, 5437.401885792559, 6407.807765767035, 6411.0, 6411.93588064118, 6418.454431373339, 6423.357664233539, 4257.76582287974, 4404.229259879508, 4404.889877753082, 4411.360352748833, 4411.602955733999, 6602.1747281589805, 6681.866362672719, 6688.5652432592215, 6693.431058360045, 6700.832479187962, 4482.125985432875, 4487.708298960557, 4490.416245888014, 4498.3927169832305, 4500.0, 4535.818567257339, 4536.047430039728, 4548.818047278138, 4552.226121559343, 4552.863414097583, 5277.656952298088, 5293.629445938825, 5297.761600727977, 5299.284596579412, 5311.389190243094, 6241.625502469867, 6447.903281450782, 6449.935500644933, 6453.322401147906, 6467.676616169173, 1583.2479572203342, 1593.7290660587728, 1597.6884507521154, 1605.0449982260536, 1606.1969015492255, 974.780674348266, 1025.5282570017725, 1031.5615863258085, 1046.4924511611862, 1065.9626913058005, 6125.509959203342, 6151.3541078187045, 6160.229971253593, 6172.598781079216, 6199.039148931923, 6625.105610742585, 6699.732010719516, 6706.865862682719, 6708.0, 6724.899126513106, 6200.503959683305, 6220.595661282002, 6229.501639868799, 6229.968850155811, 6236.844078898064, 3541.38025845476, 3585.551806024247, 3586.372384832644, 3586.8923932282073, 3591.425371940477, 6675.3324667533825, 6818.4886133540185, 6832.760853370109, 6842.521023528405, 6844.623545704934, 6737.0, 6754.831129221809, 6757.797266082025, 6768.458523318122, 6772.11962444879, 6805.319468053155, 6810.046593476917, 6812.62530560814, 6817.250102488722, 6832.111825462757, 6608.966955165193, 6611.239707433707, 6617.139771829631, 6618.2719900811835, 6621.569597976116, 6313.084602732486, 6449.0, 6457.870842583216, 6483.610983341015, 6485.708143133665, 6755.3582409671, 6795.966020169867, 6803.11559497282, 6819.045333653392, 6820.454363650797, 4488.349189367589, 4492.865214043584, 4494.303382975644, 4494.325851122358, 4501.122281155274, 6604.8348791280605, 6612.702428390638, 6617.900731488935, 6621.966890165519, 6625.105610742681, 6290.685465726787, 6422.42198202164, 6424.0, 6428.357164283534, 6433.453156481752, 6419.069234960811, 6428.903566446414, 6429.067785171217, 6433.356664333716, 6440.806775796734, 6322.841928951629, 6382.5532212744665, 6386.489080873426, 6390.360963903572, 6395.904061439175, 6470.547061705635, 6472.255690595642, 6483.222013358427, 6486.0, 6508.153939987771, 6073.817785466443, 6136.417040381157, 6329.461995730415, 6334.271558770616, 6334.524910631813], "unit": "score", "name": "prototype.html", "value": 4829.396619914613}, {"lowerIsBetter": false, "replicates": [760.2473551184329, 784.9725259615915, 790.1308560583359, 843.1736897840117, 875.1030194051096, 13138.737225255501, 13302.467901283937, 13370.331483425814, 13425.462981480741, 13428.731425371487, 13240.93379533101, 13270.203787772716, 13282.203067815937, 13327.466901323935, 13369.264690442022, 750.3771869348428, 895.9641614335419, 896.5472436419599, 897.7261935109789, 917.4403613795579, 915.0, 919.1865199298602, 919.8620206968941, 920.7007722490184, 920.8204400141975, 988.4761076629397, 992.6823416506721, 994.140068840455, 994.2493417469836, 994.602159136344, 798.5687728626564, 967.9274054445874, 985.0051448037498, 989.8861630912465, 990.7968866382374, 717.3257138290043, 721.3579913876654, 722.0288711682779, 725.6553137259812, 727.2654618834962, 13349.666258343523, 13356.332183390889, 13400.329983500786, 13404.262765547892, 13408.26254555999, 13418.329083545783, 13733.381997810022, 13954.372053257526, 14048.719025619532, 14227.21750303733, 10827.891721082768, 11315.603953861575, 11585.30488170704, 11585.942070289679, 12019.759604807943, 3905.8632947846972, 3948.74333168346, 3967.2462232175794, 3985.4619626350363, 4012.4583181270445, 52788.20817687738, 53050.0, 53783.19325210125, 54035.99999999961, 54307.45692543103, 11480.138989575815, 11558.595449159238, 11602.187846850808, 11689.123315751183, 11702.414879256003, 19713.704294435596, 20043.799562004195, 21302.254421095186, 21325.25361612367, 21331.68002479964, 8432.32541396699, 8515.19105684959, 8515.829683406297, 8581.785455363666, 8727.738167854974, 4514.593686568224, 4558.612517935946, 4561.407017087758, 4624.44506659203, 4704.5765881070865, 3382.30662714143, 3382.729381649511, 3393.270446853938, 3422.1615704152146, 3430.811305378178, 581.880714453536, 607.2621764555997, 612.6967151260154, 616.3651439017818, 620.6245221640933, 626.6678660310043, 719.7193094693074, 742.6398196874511, 744.6202436757293, 774.825664225556, 8722.738317850475, 9090.545472726337, 9102.362834601647, 9137.954310228406, 9178.908210917938, 562.5808772464541, 580.4630716587141, 649.3409189672486, 676.1446769836161, 689.2383915773099, 4155.376693495939, 4229.238737027303, 4230.238557059759, 4288.442502474721, 4352.086061927031, 60288.397116029155, 61479.692601536706, 61593.692031539555, 63508.36491635117, 63835.6808215956, 52944.47055529473, 53842.46157538374, 54005.72997135068, 54179.18731219035, 54882.17676734852, 45812.5418745815, 46358.30462543065, 46566.534334657576, 46836.0, 47005.764971174925, 9657.9034209657, 9673.516324183904, 9756.0, 9896.158826499828, 9931.205503559842, 36685.63314366929, 36818.447723284706, 36877.44683829691, 38460.80769596134, 38900.41649375205, 44121.338179926686, 44465.77767111273, 47091.76454117707, 49822.25266621076, 50711.492885072155, 11934.404650907667, 12146.878531214576, 12201.0, 12283.508659653513, 12417.75164496687, 13035.739285214433, 13125.671858203239, 13260.0, 13345.799813002619, 13697.178169309873, 12649.0, 12741.235525868478, 12881.0, 13089.0837641368, 13109.27898965566, 12688.619341419771, 12753.61739147827, 12931.353432328535, 13033.0, 13271.469141234242, 11986.160968732454, 12157.574484893341, 12185.147039707135, 12411.836479609465, 12471.314077725812, 10409.11522520564, 10698.518566664363, 11047.83428248593, 11117.666470005914, 11413.714657133305, 10842.0, 10930.180236482454, 11028.44857757125, 11030.172737044913, 11045.28205666629], "unit": "score", "name": "yui.html", "value": 6865.173185324177}], "name": "dromaeo_css", "value": 7233.444492403812}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 112.0, 110.0, 111.0, 100.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 152.0, 185.0, 128.0, 158.0, 159.0, 131.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 163.0, 161.0, 161.0, 160.0, 161.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 75.0, 180.0, 77.0, 77.0, 76.0, 83.0, 163.0, 73.0], "unit": "score", "name": "audio-fft", "value": 95.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 93.0, 93.0, 93.0, 154.0, 93.0, 93.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 57.0, 55.0, 55.0, 54.0, 56.0, 54.0, 60.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 75.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [81.0, 79.0, 79.0, 79.0, 79.0, 80.0, 79.0, 79.0, 80.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.6}, {"lowerIsBetter": true, "replicates": [114.0, 116.0, 112.0, 115.0, 115.0, 117.0, 121.0, 113.0, 113.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [154.0, 141.0, 143.0, 153.0, 142.0, 143.0, 153.0, 151.0, 153.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 73.0, 71.0, 70.0, 67.0, 69.0, 72.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1514.7}]} 16:51:02 INFO - Return code: 0 16:51:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:51:02 INFO - # TBPL SUCCESS # 16:51:02 INFO - Running post-action listener: _resource_record_post_action 16:51:02 INFO - Running post-run listener: _resource_record_post_run 16:51:03 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 16384; Write bytes: 459223040; Read time: 36; Write time: 290416 16:51:03 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237301760; Read time: 0; Write time: 191816 16:51:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 221601792; Read time: 36; Write time: 98572 16:51:03 INFO - Running post-run listener: _upload_blobber_files 16:51:03 INFO - Blob upload gear active. 16:51:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:03 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 16:51:03 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'] 16:51:03 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 16:51:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:51:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:04 INFO - (blobuploader) - INFO - Done attempting. 16:51:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:51:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:51:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:05 INFO - (blobuploader) - INFO - Done attempting. 16:51:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:05 INFO - Return code: 0 16:51:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee265584e50558b967b7ae9ae366db41b031baabeda8776ee4fa7d833e939aa14f7bc035286d516a4935b1cdac67e8666a7534e613d45c8dc7070b939cb34b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf76e7f84ec20b6010166eb7acc1c9c5cbca82b14f78c7cdcff3e6152094527516ea1852b28712f9cd01aa1247da3835ce4338f409e8c005a9e8811e324c9fa9"} 16:51:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:05 INFO - Contents: 16:51:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee265584e50558b967b7ae9ae366db41b031baabeda8776ee4fa7d833e939aa14f7bc035286d516a4935b1cdac67e8666a7534e613d45c8dc7070b939cb34b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf76e7f84ec20b6010166eb7acc1c9c5cbca82b14f78c7cdcff3e6152094527516ea1852b28712f9cd01aa1247da3835ce4338f409e8c005a9e8811e324c9fa9"} 16:51:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:05 INFO - Copying logs to upload dir... 16:51:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.028074 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-09 16:51:05.110911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:51:05.115245) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724 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/ee265584e50558b967b7ae9ae366db41b031baabeda8776ee4fa7d833e939aa14f7bc035286d516a4935b1cdac67e8666a7534e613d45c8dc7070b939cb34b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf76e7f84ec20b6010166eb7acc1c9c5cbca82b14f78c7cdcff3e6152094527516ea1852b28712f9cd01aa1247da3835ce4338f409e8c005a9e8811e324c9fa9"} build_url:https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/cJdN0fmaRZeyezAzaBVOKQ/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/ee265584e50558b967b7ae9ae366db41b031baabeda8776ee4fa7d833e939aa14f7bc035286d516a4935b1cdac67e8666a7534e613d45c8dc7070b939cb34b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf76e7f84ec20b6010166eb7acc1c9c5cbca82b14f78c7cdcff3e6152094527516ea1852b28712f9cd01aa1247da3835ce4338f409e8c005a9e8811e324c9fa9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:51:05.139481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:51:05.142836) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462836498.80310-34365724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:51:05.221269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:51:05.221574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:51:05.224889) ========= ========= Total master_lag: 0.35 =========