builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1461618988.54 results: success (0) buildid: 20160425095909 builduid: bf4af95f322a4411b3423b15fcf5776e revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:28.545054) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:28.545488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:28.545793) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.115054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.115358) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 14:16:29-- 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% 229M=0s 2016-04-25 14:16:29 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.221455 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.423421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.423737) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019253 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.485053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.485406) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --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 dcaf0a6fa115ad73bf7505a8e76464250b971a04 --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=a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 14:16:29,456 truncating revision to first 12 chars 2016-04-25 14:16:29,456 Setting DEBUG logging. 2016-04-25 14:16:29,456 attempt 1/10 2016-04-25 14:16:29,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dcaf0a6fa115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 14:16:29,828 unpacking tar archive at: mozilla-beta-dcaf0a6fa115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.283076) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.283414) ========= script_repo_revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.283854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.284171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.292415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-04-25 14:16:30.292729) ========= /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=a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:30 INFO - MultiFileLogger online at 20160425 14:16:30 in /builds/slave/test 14:16: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 14:16:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:16:30 INFO - {'append_to_log': False, 14:16:30 INFO - 'base_work_dir': '/builds/slave/test', 14:16:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:16:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:16:30 INFO - 'branch': 'Mozilla-Beta', 14:16:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:30 INFO - 'config_files': ('talos/linux_config.py',), 14:16:30 INFO - 'default_actions': ('clobber', 14:16:30 INFO - 'read-buildbot-config', 14:16:30 INFO - 'download-and-extract', 14:16:30 INFO - 'populate-webroot', 14:16:30 INFO - 'create-virtualenv', 14:16:30 INFO - 'install', 14:16:30 INFO - 'run-tests'), 14:16:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:30 INFO - 'download_minidump_stackwalk': True, 14:16:30 INFO - 'download_symbols': 'ondemand', 14:16:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:30 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:30 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:30 INFO - 'installer_path': 'installer.exe', 14:16:30 INFO - 'log_level': 'info', 14:16:30 INFO - 'log_name': 'talos', 14:16:30 INFO - 'log_to_console': True, 14:16:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:30 INFO - 'opt_config_files': (), 14:16:30 INFO - 'pip_index': False, 14:16:30 INFO - 'sps_profile': False, 14:16:30 INFO - 'sps_profile_interval': 0, 14:16:30 INFO - 'suite': 'dromaeojs', 14:16:30 INFO - 'system_bits': '32', 14:16:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:30 INFO - 'title': 'talos-linux64-ix-002', 14:16:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:30 INFO - 'use_talos_json': True, 14:16:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:16:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:30 INFO - 'work_dir': 'build'} 14:16:30 INFO - ##### 14:16:30 INFO - ##### Running clobber step. 14:16:30 INFO - ##### 14:16:30 INFO - Running pre-action listener: _resource_record_pre_action 14:16:30 INFO - Running main action method: clobber 14:16:30 INFO - rmtree: /builds/slave/test/build 14:16:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:16:31 INFO - Running post-action listener: _resource_record_post_action 14:16:31 INFO - ##### 14:16:31 INFO - ##### Running read-buildbot-config step. 14:16:31 INFO - ##### 14:16:31 INFO - Running pre-action listener: _resource_record_pre_action 14:16:31 INFO - Running main action method: read_buildbot_config 14:16:31 INFO - Using buildbot properties: 14:16:31 INFO - { 14:16:31 INFO - "project": "", 14:16:31 INFO - "product": "firefox", 14:16:31 INFO - "script_repo_revision": "production", 14:16:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:16:31 INFO - "repository": "", 14:16:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:16:31 INFO - "buildid": "20160425095909", 14:16:31 INFO - "pgo_build": "True", 14:16:31 INFO - "basedir": "/builds/slave/test", 14:16:31 INFO - "buildnumber": 42, 14:16:31 INFO - "slavename": "talos-linux64-ix-002", 14:16:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:16:31 INFO - "platform": "ubuntu64_hw", 14:16:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:16:31 INFO - "branch": "mozilla-beta", 14:16:31 INFO - "repo_path": "releases/mozilla-beta", 14:16:31 INFO - "revision": "dcaf0a6fa115ad73bf7505a8e76464250b971a04", 14:16:31 INFO - "stage_platform": "linux64-pgo", 14:16:31 INFO - "builduid": "bf4af95f322a4411b3423b15fcf5776e", 14:16:31 INFO - "slavebuilddir": "test" 14:16:31 INFO - } 14:16:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 14:16:31 INFO - Running post-action listener: _resource_record_post_action 14:16:31 INFO - ##### 14:16:31 INFO - ##### Running download-and-extract step. 14:16:31 INFO - ##### 14:16:31 INFO - Running pre-action listener: _resource_record_pre_action 14:16:31 INFO - Running main action method: download_and_extract 14:16:31 INFO - mkdir: /builds/slave/test/build/tests 14:16: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')]} 14:16:31 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:16:40 INFO - Downloaded 1412 bytes. 14:16:40 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:40 INFO - Using the following test package requirements: 14:16:40 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:40 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:40 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 14:16:40 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'jsshell-linux-x86_64.zip'], 14:16:40 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:40 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:40 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 14:16:40 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 14:16:40 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:40 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:40 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:40 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:40 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:40 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:48 INFO - Downloaded 23362833 bytes. 14:16:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:16:49 INFO - Return code: 0 14:16:49 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:49 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:17:19 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip: timed out 14:17:19 INFO - retry: attempt #1 caught exception: timed out 14:17:19 INFO - retry: Failed, sleeping 30 seconds before retrying 14:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/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 #2 14:17:51 INFO - Downloaded 23362833 bytes. 14:17:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:17:52 INFO - Return code: 0 14:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:52 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:17:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:17:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:17:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:17:53 INFO - Downloaded 10845194 bytes. 14:17:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:17:54 INFO - Return code: 0 14:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:54 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:17:55 INFO - Downloaded 53782838 bytes. 14:17:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:17:55 INFO - mkdir: /builds/slave/test/properties 14:17:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:55 INFO - Contents: 14:17:55 INFO - build_url:https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:17:56 INFO - Running post-action listener: _resource_record_post_action 14:17:56 INFO - Running post-action listener: set_extra_try_arguments 14:17:56 INFO - ##### 14:17:56 INFO - ##### Running populate-webroot step. 14:17:56 INFO - ##### 14:17:56 INFO - Running pre-action listener: _resource_record_pre_action 14:17:56 INFO - Running main action method: populate_webroot 14:17:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:56 INFO - '--tppagecycles', 14:17:56 INFO - '7'], 14:17:56 INFO - 'tests': ['tsvgm']}}, 14:17:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:17:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:17:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'tests': ['damp', 'tps']}, 14:17:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['damp', 'tps']}, 14:17:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:17:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:56 INFO - 'other': {'tests': ['a11yr', 14:17:56 INFO - 'ts_paint', 14:17:56 INFO - 'tpaint', 14:17:56 INFO - 'sessionrestore', 14:17:56 INFO - 'sessionrestore_no_auto_restore', 14:17:56 INFO - 'tabpaint']}, 14:17:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['a11yr', 14:17:56 INFO - 'ts_paint', 14:17:56 INFO - 'tpaint', 14:17:56 INFO - 'sessionrestore', 14:17:56 INFO - 'sessionrestore_no_auto_restore', 14:17:56 INFO - 'tabpaint']}, 14:17:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['a11yr', 14:17:56 INFO - 'ts_paint', 14:17:56 INFO - 'tpaint', 14:17:56 INFO - 'sessionrestore', 14:17:56 INFO - 'sessionrestore_no_auto_restore', 14:17:56 INFO - 'tabpaint']}, 14:17:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['a11yr', 14:17:56 INFO - 'ts_paint', 14:17:56 INFO - 'tpaint', 14:17:56 INFO - 'sessionrestore', 14:17:56 INFO - 'sessionrestore_no_auto_restore', 14:17:56 INFO - 'tabpaint']}, 14:17:56 INFO - 'other_l64': {'tests': ['a11yr', 14:17:56 INFO - 'ts_paint', 14:17:56 INFO - 'tpaint', 14:17:56 INFO - 'sessionrestore', 14:17:56 INFO - 'sessionrestore_no_auto_restore', 14:17:56 INFO - 'tabpaint']}, 14:17:56 INFO - 'other_nol64': {'tests': ['a11yr', 14:17:56 INFO - 'ts_paint', 14:17:56 INFO - 'tpaint', 14:17:56 INFO - 'sessionrestore', 14:17:56 INFO - 'sessionrestore_no_auto_restore', 14:17:56 INFO - 'tabpaint']}, 14:17:56 INFO - 'svgr': {'tests': ['tsvgx', 14:17:56 INFO - 'tsvgr_opacity', 14:17:56 INFO - 'tart', 14:17:56 INFO - 'tscrollx', 14:17:56 INFO - 'cart']}, 14:17:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['tsvgx', 14:17:56 INFO - 'tsvgr_opacity', 14:17:56 INFO - 'tart', 14:17:56 INFO - 'tscrollx', 14:17:56 INFO - 'cart']}, 14:17:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'tests': ['tp5o']}, 14:17:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'talos_options': ['--e10s'], 14:17:56 INFO - 'tests': ['tp5o']}, 14:17:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'talos_options': ['--xperf_path', 14:17:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:56 INFO - 'tests': ['tp5n']}, 14:17:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:56 INFO - 'talos_options': ['--e10s', 14:17:56 INFO - '--xperf_path', 14:17:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:56 INFO - 'tests': ['tp5n']}}, 14:17:56 INFO - 'talos.zip': {'path': '', 14:17:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:56 INFO - Running post-action listener: _resource_record_post_action 14:17:56 INFO - ##### 14:17:56 INFO - ##### Running create-virtualenv step. 14:17:56 INFO - ##### 14:17:56 INFO - Running pre-action listener: _resource_record_pre_action 14:17:56 INFO - Running main action method: create_virtualenv 14:17:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:17:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:56 INFO - Using real prefix '/usr' 14:17:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:59 INFO - Installing pip.................done. 14:17:59 INFO - Return code: 0 14:17:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:17: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', 'pip>=1.5'] in /builds/slave/test/build 14:17: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 pip>=1.5 14:17:59 INFO - Using env: {'DISPLAY': ':0', 14:17:59 INFO - 'HOME': '/home/cltbld', 14:17:59 INFO - 'LANG': 'en_US.UTF-8', 14:17:59 INFO - 'LANGUAGE': 'en_US:en', 14:17:59 INFO - 'LOGNAME': 'cltbld', 14:17:59 INFO - 'MAIL': '/var/mail/cltbld', 14:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:59 INFO - 'MOZ_NO_REMOTE': '1', 14:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:59 INFO - 'NO_EM_RESTART': '1', 14:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:59 INFO - 'PWD': '/builds/slave/test', 14:17:59 INFO - 'SHELL': '/bin/bash', 14:17:59 INFO - 'SHLVL': '1', 14:17:59 INFO - 'TERM': 'linux', 14:17:59 INFO - 'TMOUT': '86400', 14:17:59 INFO - 'USER': 'cltbld', 14:17:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:59 INFO - '_': '/tools/buildbot/bin/python'} 14:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:17:59 INFO - Cleaning up... 14:17:59 INFO - Return code: 0 14:17:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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', '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 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:17: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', 'psutil>=0.7.1'] in /builds/slave/test/build 14:17: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 psutil>=0.7.1 14:17:59 INFO - Using env: {'DISPLAY': ':0', 14:17:59 INFO - 'HOME': '/home/cltbld', 14:17:59 INFO - 'LANG': 'en_US.UTF-8', 14:17:59 INFO - 'LANGUAGE': 'en_US:en', 14:17:59 INFO - 'LOGNAME': 'cltbld', 14:17:59 INFO - 'MAIL': '/var/mail/cltbld', 14:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:59 INFO - 'MOZ_NO_REMOTE': '1', 14:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:59 INFO - 'NO_EM_RESTART': '1', 14:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:59 INFO - 'PWD': '/builds/slave/test', 14:17:59 INFO - 'SHELL': '/bin/bash', 14:17:59 INFO - 'SHLVL': '1', 14:17:59 INFO - 'TERM': 'linux', 14:17:59 INFO - 'TMOUT': '86400', 14:17:59 INFO - 'USER': 'cltbld', 14:17:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:59 INFO - '_': '/tools/buildbot/bin/python'} 14:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:59 INFO - Downloading/unpacking psutil>=0.7.1 14:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:01 INFO - Installing collected packages: psutil 14:18:01 INFO - Running setup.py install for psutil 14:18:01 INFO - building 'psutil._psutil_linux' extension 14:18:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:18:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:18:01 INFO - building 'psutil._psutil_posix' extension 14:18:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:18:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:18:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:02 INFO - Successfully installed psutil 14:18:02 INFO - Cleaning up... 14:18:02 INFO - Return code: 0 14:18:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:02 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 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:18:02 INFO - Using env: {'DISPLAY': ':0', 14:18:02 INFO - 'HOME': '/home/cltbld', 14:18:02 INFO - 'LANG': 'en_US.UTF-8', 14:18:02 INFO - 'LANGUAGE': 'en_US:en', 14:18:02 INFO - 'LOGNAME': 'cltbld', 14:18:02 INFO - 'MAIL': '/var/mail/cltbld', 14:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:02 INFO - 'MOZ_NO_REMOTE': '1', 14:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:02 INFO - 'NO_EM_RESTART': '1', 14:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:02 INFO - 'PWD': '/builds/slave/test', 14:18:02 INFO - 'SHELL': '/bin/bash', 14:18:02 INFO - 'SHLVL': '1', 14:18:02 INFO - 'TERM': 'linux', 14:18:02 INFO - 'TMOUT': '86400', 14:18:02 INFO - 'USER': 'cltbld', 14:18:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:02 INFO - '_': '/tools/buildbot/bin/python'} 14:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:18:04 INFO - Installing collected packages: mozsystemmonitor 14:18:04 INFO - Running setup.py install for mozsystemmonitor 14:18:04 INFO - Successfully installed mozsystemmonitor 14:18:04 INFO - Cleaning up... 14:18:04 INFO - Return code: 0 14:18:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 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 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:18:04 INFO - Using env: {'DISPLAY': ':0', 14:18:04 INFO - 'HOME': '/home/cltbld', 14:18:04 INFO - 'LANG': 'en_US.UTF-8', 14:18:04 INFO - 'LANGUAGE': 'en_US:en', 14:18:04 INFO - 'LOGNAME': 'cltbld', 14:18:04 INFO - 'MAIL': '/var/mail/cltbld', 14:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:04 INFO - 'MOZ_NO_REMOTE': '1', 14:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:04 INFO - 'NO_EM_RESTART': '1', 14:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:04 INFO - 'PWD': '/builds/slave/test', 14:18:04 INFO - 'SHELL': '/bin/bash', 14:18:04 INFO - 'SHLVL': '1', 14:18:04 INFO - 'TERM': 'linux', 14:18:04 INFO - 'TMOUT': '86400', 14:18:04 INFO - 'USER': 'cltbld', 14:18:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:04 INFO - '_': '/tools/buildbot/bin/python'} 14:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:04 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:07 INFO - Downloading docopt-0.6.1.tar.gz 14:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:07 INFO - Running setup.py install for blobuploader 14:18:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:07 INFO - Running setup.py install for requests 14:18:07 INFO - Running setup.py install for docopt 14:18:07 INFO - Successfully installed blobuploader requests docopt 14:18:07 INFO - Cleaning up... 14:18:07 INFO - Return code: 0 14:18:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 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 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:07 INFO - Using env: {'DISPLAY': ':0', 14:18:07 INFO - 'HOME': '/home/cltbld', 14:18:07 INFO - 'LANG': 'en_US.UTF-8', 14:18:07 INFO - 'LANGUAGE': 'en_US:en', 14:18:07 INFO - 'LOGNAME': 'cltbld', 14:18:07 INFO - 'MAIL': '/var/mail/cltbld', 14:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:07 INFO - 'MOZ_NO_REMOTE': '1', 14:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:07 INFO - 'NO_EM_RESTART': '1', 14:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:07 INFO - 'PWD': '/builds/slave/test', 14:18:07 INFO - 'SHELL': '/bin/bash', 14:18:07 INFO - 'SHLVL': '1', 14:18:07 INFO - 'TERM': 'linux', 14:18:07 INFO - 'TMOUT': '86400', 14:18:07 INFO - 'USER': 'cltbld', 14:18:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:07 INFO - '_': '/tools/buildbot/bin/python'} 14:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:08 INFO - Running setup.py (path:/tmp/pip-PRWKXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:08 INFO - Running setup.py (path:/tmp/pip-cntc3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:08 INFO - Running setup.py (path:/tmp/pip-H1hTWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:08 INFO - Running setup.py (path:/tmp/pip-3tB1aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:08 INFO - Running setup.py (path:/tmp/pip-9Bm5ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:08 INFO - Running setup.py (path:/tmp/pip-0T5uK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:08 INFO - Running setup.py (path:/tmp/pip-G_Z5jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:08 INFO - Running setup.py (path:/tmp/pip-GIImCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:08 INFO - Running setup.py (path:/tmp/pip-4KemT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:08 INFO - Running setup.py (path:/tmp/pip-rlQNl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:08 INFO - Running setup.py (path:/tmp/pip-1O2tkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:08 INFO - Running setup.py (path:/tmp/pip-iGcFUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:09 INFO - Running setup.py (path:/tmp/pip-Fsd0YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:09 INFO - Running setup.py (path:/tmp/pip-lRmfhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:09 INFO - Running setup.py (path:/tmp/pip-kAOlDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:09 INFO - Running setup.py (path:/tmp/pip-jTfnfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:09 INFO - Running setup.py (path:/tmp/pip-tESLQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:09 INFO - Running setup.py install for manifestparser 14:18:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:09 INFO - Running setup.py install for mozcrash 14:18:09 INFO - Running setup.py install for mozdebug 14:18:09 INFO - Running setup.py install for mozdevice 14:18:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:09 INFO - Running setup.py install for mozfile 14:18:09 INFO - Running setup.py install for mozhttpd 14:18:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Running setup.py install for mozinfo 14:18:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Running setup.py install for mozInstall 14:18:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Running setup.py install for mozleak 14:18:10 INFO - Running setup.py install for mozlog 14:18:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Running setup.py install for moznetwork 14:18:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Running setup.py install for mozprocess 14:18:10 INFO - Running setup.py install for mozprofile 14:18:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Running setup.py install for mozrunner 14:18:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Running setup.py install for mozscreenshot 14:18:10 INFO - Running setup.py install for moztest 14:18:11 INFO - Running setup.py install for mozversion 14:18:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:11 INFO - Cleaning up... 14:18:11 INFO - Return code: 0 14:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:11 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 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:11 INFO - Using env: {'DISPLAY': ':0', 14:18:11 INFO - 'HOME': '/home/cltbld', 14:18:11 INFO - 'LANG': 'en_US.UTF-8', 14:18:11 INFO - 'LANGUAGE': 'en_US:en', 14:18:11 INFO - 'LOGNAME': 'cltbld', 14:18:11 INFO - 'MAIL': '/var/mail/cltbld', 14:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:11 INFO - 'MOZ_NO_REMOTE': '1', 14:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:11 INFO - 'NO_EM_RESTART': '1', 14:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:11 INFO - 'PWD': '/builds/slave/test', 14:18:11 INFO - 'SHELL': '/bin/bash', 14:18:11 INFO - 'SHLVL': '1', 14:18:11 INFO - 'TERM': 'linux', 14:18:11 INFO - 'TMOUT': '86400', 14:18:11 INFO - 'USER': 'cltbld', 14:18:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:11 INFO - '_': '/tools/buildbot/bin/python'} 14:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:11 INFO - Running setup.py (path:/tmp/pip-dyor4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:11 INFO - Running setup.py (path:/tmp/pip-uRe9c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:11 INFO - Running setup.py (path:/tmp/pip-10sl86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:11 INFO - Running setup.py (path:/tmp/pip-mElxcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:11 INFO - Running setup.py (path:/tmp/pip-jxZUrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:11 INFO - Running setup.py (path:/tmp/pip-3FOCgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:11 INFO - Running setup.py (path:/tmp/pip-DdN7D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:11 INFO - Running setup.py (path:/tmp/pip-IUHQ_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:11 INFO - Running setup.py (path:/tmp/pip-RjUaVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:12 INFO - Running setup.py (path:/tmp/pip-NItBna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:12 INFO - Running setup.py (path:/tmp/pip-MDJLP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:12 INFO - Running setup.py (path:/tmp/pip-URvF8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:12 INFO - Running setup.py (path:/tmp/pip-noFbqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:12 INFO - Running setup.py (path:/tmp/pip-O4hVXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:12 INFO - Running setup.py (path:/tmp/pip-YORoSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:12 INFO - Running setup.py (path:/tmp/pip-TCCEG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:12 INFO - Running setup.py (path:/tmp/pip-6RQJnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:14 INFO - Downloading blessings-1.6.tar.gz 14:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:14 INFO - Installing collected packages: blessings 14:18:14 INFO - Running setup.py install for blessings 14:18:14 INFO - Successfully installed blessings 14:18:14 INFO - Cleaning up... 14:18:14 INFO - Return code: 0 14:18:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:14 INFO - Reading from file tmpfile_stdout 14:18:14 INFO - Current package versions: 14:18:14 INFO - argparse == 1.2.1 14:18:14 INFO - blessings == 1.6 14:18:14 INFO - blobuploader == 1.2.4 14:18:14 INFO - docopt == 0.6.1 14:18:14 INFO - manifestparser == 1.1 14:18:14 INFO - mozInstall == 1.12 14:18:14 INFO - mozcrash == 0.17 14:18:14 INFO - mozdebug == 0.1 14:18:14 INFO - mozdevice == 0.48 14:18:14 INFO - mozfile == 1.2 14:18:14 INFO - mozhttpd == 0.7 14:18:14 INFO - mozinfo == 0.9 14:18:14 INFO - mozleak == 0.1 14:18:14 INFO - mozlog == 3.1 14:18:14 INFO - moznetwork == 0.27 14:18:14 INFO - mozprocess == 0.22 14:18:14 INFO - mozprofile == 0.28 14:18:14 INFO - mozrunner == 6.11 14:18:14 INFO - mozscreenshot == 0.1 14:18:14 INFO - mozsystemmonitor == 0.0 14:18:14 INFO - moztest == 0.7 14:18:14 INFO - mozversion == 1.4 14:18:14 INFO - psutil == 3.1.1 14:18:14 INFO - requests == 1.2.3 14:18:14 INFO - wsgiref == 0.1.2 14:18:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:14 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 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:14 INFO - Using env: {'DISPLAY': ':0', 14:18:14 INFO - 'HOME': '/home/cltbld', 14:18:14 INFO - 'LANG': 'en_US.UTF-8', 14:18:14 INFO - 'LANGUAGE': 'en_US:en', 14:18:14 INFO - 'LOGNAME': 'cltbld', 14:18:14 INFO - 'MAIL': '/var/mail/cltbld', 14:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:14 INFO - 'MOZ_NO_REMOTE': '1', 14:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:14 INFO - 'NO_EM_RESTART': '1', 14:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:14 INFO - 'PWD': '/builds/slave/test', 14:18:14 INFO - 'SHELL': '/bin/bash', 14:18:14 INFO - 'SHLVL': '1', 14:18:14 INFO - 'TERM': 'linux', 14:18:14 INFO - 'TMOUT': '86400', 14:18:14 INFO - 'USER': 'cltbld', 14:18:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:14 INFO - '_': '/tools/buildbot/bin/python'} 14:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:15 INFO - Cleaning up... 14:18:15 INFO - Return code: 0 14:18:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:18:15 INFO - Using env: {'DISPLAY': ':0', 14:18:15 INFO - 'HOME': '/home/cltbld', 14:18:15 INFO - 'LANG': 'en_US.UTF-8', 14:18:15 INFO - 'LANGUAGE': 'en_US:en', 14:18:15 INFO - 'LOGNAME': 'cltbld', 14:18:15 INFO - 'MAIL': '/var/mail/cltbld', 14:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:15 INFO - 'MOZ_NO_REMOTE': '1', 14:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:15 INFO - 'NO_EM_RESTART': '1', 14:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:15 INFO - 'PWD': '/builds/slave/test', 14:18:15 INFO - 'SHELL': '/bin/bash', 14:18:15 INFO - 'SHLVL': '1', 14:18:15 INFO - 'TERM': 'linux', 14:18:15 INFO - 'TMOUT': '86400', 14:18:15 INFO - 'USER': 'cltbld', 14:18:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:15 INFO - '_': '/tools/buildbot/bin/python'} 14:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:15 INFO - Downloading/unpacking jsonschema 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:17 INFO - Downloading/unpacking functools32 (from jsonschema) 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:17 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:17 INFO - warning: no files found matching '*.txt' 14:18:17 INFO - no previously-included directories found matching 'build' 14:18:17 INFO - no previously-included directories found matching 'dist' 14:18:17 INFO - no previously-included directories found matching '.git*' 14:18:17 INFO - Installing collected packages: jsonschema, functools32 14:18:17 INFO - Running setup.py install for functools32 14:18:17 INFO - warning: no files found matching '*.txt' 14:18:17 INFO - no previously-included directories found matching 'build' 14:18:17 INFO - no previously-included directories found matching 'dist' 14:18:17 INFO - no previously-included directories found matching '.git*' 14:18:17 INFO - Successfully installed jsonschema functools32 14:18:17 INFO - Cleaning up... 14:18:17 INFO - Return code: 0 14:18:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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 0x7fb2134f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:18:17 INFO - Using env: {'DISPLAY': ':0', 14:18:17 INFO - 'HOME': '/home/cltbld', 14:18:17 INFO - 'LANG': 'en_US.UTF-8', 14:18:17 INFO - 'LANGUAGE': 'en_US:en', 14:18:17 INFO - 'LOGNAME': 'cltbld', 14:18:17 INFO - 'MAIL': '/var/mail/cltbld', 14:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:17 INFO - 'MOZ_NO_REMOTE': '1', 14:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:17 INFO - 'NO_EM_RESTART': '1', 14:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:17 INFO - 'PWD': '/builds/slave/test', 14:18:17 INFO - 'SHELL': '/bin/bash', 14:18:17 INFO - 'SHLVL': '1', 14:18:17 INFO - 'TERM': 'linux', 14:18:17 INFO - 'TMOUT': '86400', 14:18:17 INFO - 'USER': 'cltbld', 14:18:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:17 INFO - '_': '/tools/buildbot/bin/python'} 14:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:17 INFO - Downloading/unpacking flake8 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:20 INFO - no previously-included directories found matching 'docs/_build' 14:18:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:20 INFO - Running setup.py install for pep8 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:20 INFO - no previously-included directories found matching 'docs/_build' 14:18:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:20 INFO - Cleaning up... 14:18:20 INFO - Return code: 0 14:18:20 INFO - Running post-action listener: _resource_record_post_action 14:18:20 INFO - Running post-action listener: _start_resource_monitoring 14:18:20 INFO - Starting resource monitoring. 14:18:20 INFO - ##### 14:18:20 INFO - ##### Running install step. 14:18:20 INFO - ##### 14:18:20 INFO - Running pre-action listener: _resource_record_pre_action 14:18:20 INFO - Running main action method: install 14:18:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:21 INFO - Reading from file tmpfile_stdout 14:18:21 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:21 INFO - Reading from file tmpfile_stdout 14:18:21 INFO - Output received: 14:18:21 INFO - Usage: mozinstall [options] installer 14:18:21 INFO - Options: 14:18:21 INFO - -h, --help show this help message and exit 14:18:21 INFO - -d DEST, --destination=DEST 14:18:21 INFO - Directory to install application into. [default: 14:18:21 INFO - "/builds/slave/test"] 14:18:21 INFO - --app=APP Application being installed. [default: firefox] 14:18:21 INFO - mkdir: /builds/slave/test/build/application 14:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:18:33 INFO - Reading from file tmpfile_stdout 14:18:33 INFO - Output received: 14:18:33 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:33 INFO - Running post-action listener: _resource_record_post_action 14:18:33 INFO - ##### 14:18:33 INFO - ##### Running run-tests step. 14:18:33 INFO - ##### 14:18:33 INFO - Running pre-action listener: _resource_record_pre_action 14:18:33 INFO - Running main action method: run_tests 14:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:33 INFO - Python 2.7.3 14:18:33 INFO - Return code: 0 14:18:33 INFO - grabbing minidump binary from tooltool 14:18: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')]} 14:18:33 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 0x26ac160>, '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 0x26ad060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:18:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:18:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:33 INFO - Return code: 0 14:18:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:18:34 INFO - Return code: 0 14:18:34 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/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:18:34 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/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:18:34 INFO - Using env: {'DISPLAY': ':0', 14:18:34 INFO - 'HOME': '/home/cltbld', 14:18:34 INFO - 'LANG': 'en_US.UTF-8', 14:18:34 INFO - 'LANGUAGE': 'en_US:en', 14:18:34 INFO - 'LOGNAME': 'cltbld', 14:18:34 INFO - 'MAIL': '/var/mail/cltbld', 14:18:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:34 INFO - 'MOZ_NO_REMOTE': '1', 14:18:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:34 INFO - 'NO_EM_RESTART': '1', 14:18:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:34 INFO - 'PWD': '/builds/slave/test', 14:18:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:34 INFO - 'SHELL': '/bin/bash', 14:18:34 INFO - 'SHLVL': '1', 14:18:34 INFO - 'TERM': 'linux', 14:18:34 INFO - 'TMOUT': '86400', 14:18:34 INFO - 'USER': 'cltbld', 14:18:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248', 14:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:34 INFO - '_': '/tools/buildbot/bin/python'} 14:18:34 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/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:18:35 INFO - mozversion application_buildid: 20160425095909 14:18:35 INFO - mozversion application_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:18:35 INFO - mozversion application_display_name: Firefox 14:18:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:35 INFO - mozversion application_name: Firefox 14:18:35 INFO - mozversion application_remotingname: firefox 14:18:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:18:35 INFO - mozversion application_vendor: Mozilla 14:18:35 INFO - mozversion application_version: 47.0 14:18:35 INFO - mozversion platform_buildid: 20160425095909 14:18:35 INFO - mozversion platform_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:18:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:18:35 INFO - mozversion platform_version: 47.0 14:18:35 INFO - using testdate: 1461619115 14:18:35 INFO - actual date: 1461619115 14:18:35 INFO - starting webserver on 'localhost:45362' 14:18:35 INFO - SUITE-START | Running 2 tests 14:18:35 INFO - TEST-START | dromaeo_css 14:18:35 INFO - operating with platform_type : linux_ 14:18:35 INFO - Initialising browser for dromaeo_css test... 14:18:35 INFO - TEST-INFO | started process 16634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQQWW66/profile http://localhost:45362/getInfo.html) 14:18:39 INFO - PROCESS | 16634 | __metrics Screen width/height:1600/1200 14:18:39 INFO - PROCESS | 16634 | colorDepth:24 14:18:39 INFO - PROCESS | 16634 | Browser inner width/height: 1024/697 14:18:39 INFO - PROCESS | 16634 | __metrics 14:18:40 INFO - PROCESS | 16634 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:41 INFO - TEST-INFO | 16634: exit 0 14:18:41 INFO - Browser initialized. 14:18:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:41 INFO - TEST-INFO | started process 16720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQQWW66/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:52 INFO - PROCESS | 16720 | RSS: Main: 139382784 14:18:52 INFO - PROCESS | 16720 | 14:19:44 INFO - PROCESS | 16720 | 1461619184195 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:21:51 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45362/tests/dromaeo/cssquery-ext.html) 14:21:52 INFO - PROCESS | 16720 | RSS: Main: 254988288 14:21:52 INFO - PROCESS | 16720 | 14:24:54 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-ext.html (next: http://localhost:45362/tests/dromaeo/cssquery-jquery.html) 14:24:55 INFO - PROCESS | 16720 | RSS: Main: 222257152 14:24:55 INFO - PROCESS | 16720 | 14:27:57 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45362/tests/dromaeo/cssquery-mootools.html) 14:27:57 INFO - PROCESS | 16720 | RSS: Main: 220028928 14:27:57 INFO - PROCESS | 16720 | 14:30:59 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45362/tests/dromaeo/cssquery-prototype.html) 14:31:00 INFO - PROCESS | 16720 | RSS: Main: 205983744 14:31:00 INFO - PROCESS | 16720 | 14:34:02 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45362/tests/dromaeo/cssquery-yui.html) 14:34:03 INFO - PROCESS | 16720 | RSS: Main: 186421248 14:34:03 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-yui.html (next: http://localhost:45362/tests/dromaeo/cssquery-dojo.html) 14:37:05 INFO - PROCESS | 16720 | RSS: Main: 251658240 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | __start_tp_report 14:37:05 INFO - PROCESS | 16720 | _x_x_mozilla_page_load 14:37:05 INFO - PROCESS | 16720 | _x_x_mozilla_page_load_details 14:37:05 INFO - PROCESS | 16720 | |i|pagename|runs| 14:37:05 INFO - PROCESS | 16720 | |0;dojo.html;3256.478963365861;3329.716974057205;3332.8833490827824;3342.3649506593747;3377.155711072231;5356.6785992840405;5373.220882971967;5373.274607927924;5393.973030134844;5411.296531450906;5352.91970620441;5367.275417818593;5389.299391079154;5389.434109418514;5397.514223719864;4762.595179409755;4904.705717656934;4913.287573301878;4986.10250154972;5018.974905125469;4810.807567697288;4897.314375987365;4897.6081913447015;4903.509649035103;4904.632152588552;4880.707157570557;4897.240927656201;4924.901501969958;4928.630352723542;4929.285253638221;4907.840659971731;4932.654714170009;4959;4962.751862406865;4987.052460032619;4786.688865223784;4829.227323628238;4854.514548545152;4863.416390033219;4889.1443997300685;5099.821506247264;5104.285400043959;5127.512886275797;5134.204198349262;5152.819651312186;5581.05122129239;5639.4642508962;5669.829905102853;5699.430056994309;5702.486776190121;5688.63023903445;5696.601237913348;5719.857003574903;5723.141528770676;5738.885222295572;5345.65253258537;5346.518813306821;5348.973255133738;5349.598780091509;5388.973055134699;5703.17303990919;5798.855028624318;5799.710014499343;5882.911756323659;5900.498457631149;5591.720413979285;5623.606347555632;5631.915521267184;5632;5633.267675202197;5727.2268243787385;5732.914006289909;5733.168690539848;5735.053716136874;5739.024365857814;5609.887802243932;5678.3186017678145;5707.058335374617;5735.655860648374;5749.597528173072;5654.4062873398525;5657.717114144276;5667.09326507765;5667.943320566742;5669.716514174357;4295.4201182839915;4386.056997745436;4388.692791504564;4396.538363471789;4413.8234470621455;3942.3692209246383;3959.544652364957;3976.2842688315804;3989.7007724420782;4011;5445.700486473203;5464.508194262536;5467.480589344006;5469.535089517435;5472.315960504937;5522.061249587579;5652.830415087554;5723.141528770634;5753.683547404933;5753.769849205984;5469;5481.177823326533;5504.614676972574;5508.283923090053;5528.419515950848;4979.103761322925;5002.199648056367;5002.799888004512;5003.799848006039;5031.647784655112;5775.7400916957995;5868.647881127146;5918.8816223675285;5956.1065840123465;5970.194023806817;5752.539796816161;5755.050416681201;5756.42435756421;5772.19189313488;5781;5944.73248703818;5949.434803693643;5953.434423729739;5963.0459126539545;5964.880702385841;5488.862778430571;5504.422035686195;5570.2480165177185;5602.719864006702;5685.914711279417;5700.743466543932;5719.714014299185;5747.827565173052;5760.510356619734;5770.855728606818;5595.328560572594;5606.887862242814;5611.551075913999;5615.18579805934;5618.2415373924;5470.152126420411;5528.391876893619;5586.301712285965;5593.692346920959;5638.295213098363;5482.972585137049;5495.450454954473;5510.118381059011;5510.256115424367;5524.33707955048;5482.424345443671;5568;5604.8038318658655;5621.8594535136945;5652.547796176378;5355.2234925934745;5377.596680248918;5425.321834770653;5533.031719449161;5558.416366281483 14:37:05 INFO - PROCESS | 16720 | |1;ext.html;530.1358785180156;533.2561077297169;536.3054843977047;548.106586264389;558.1098148453216;31752.68247317526;38391.80804095979;38946.22107557847;39007;39058.8047059765;42687.14625707484;42940.785296073554;43093.56906430935;43174;43178;9031.774205644862;9324.813503729922;9332.066793320682;9332.48671323077;9335.486548239844;9036.277097832157;9169.40398874071;9189.310801689866;9192.862107068398;9197.034311397307;9171.449713017208;9252;9265.675701350454;9273.211776998964;9274.39716418434;9112.225460835836;9189.081091890825;9197.310201734897;9204.815903681889;9206.539673016356;8923.776905577348;9059.456432614064;9066.909330906738;9067.501287429188;9072.36493445459;41711.374329385086;42360.78819605882;42414.57585424137;42436;42494.57505424937;3625.764325318872;3656.3601369760186;3751.737378383514;3949.8420063197436;4471.374007638933;32012.839935800173;32301.192470188435;32636.510452343235;32976.34047319064;33510;3525.4888041233876;3587.7488575799703;3652.6164752700847;3684.299983003221;3732.2908647356917;285617;286392;286469;287921;288049.559752202;45309.773451133195;46065.30902036472;61278.38721612727;61768.69115654393;61779.07331390033;44028.77985610116;44166;44258.77870610626;44349.77825110854;44374.11251774946;16913.985160890385;17069.57326066858;17086.231119599648;17090.401835935932;17091.658166836594;14123.717525649636;14200.218987955555;14204.218767967861;14207.147571145764;14211.78682319766;15133.924330378497;15668.608284792743;15717.44988925405;15727.292271847795;15733.292001859943;5936.940630593639;6003.969980150071;6007.8197654070445;6030.819075427657;6036.728347224385;1029.7892663124615;1072.3994563044564;1116.7878103160374;1123.842662027317;1138.9943050284696;29181.56227656587;29915.850420748193;30186.396272074435;30219.395612087636;30505.38989220203;986.9950650246847;1116.3636727065496;1131.8472006279046;1161.1639619473965;1183.2782002978176;14370.784438233435;14589.489367872286;14773.33519991603;14881.181535015461;15004.849951500346;327903;327986;331263;331421;331961;57159.428405716244;57763.422365775805;57900.4209957895;57938.7103064482;57962.4203757957;1272.3002348708173;1436.913785172893;1469.4856800119871;1483.6884254306717;1486.524312220101;29409.264768380104;31929;32229.838850805594;32243.193920151247;32774.50838237381;48973.75513122412;49902;49908.25137622866;49923.75038124786;49941.25088123754;278648;289417;289838;290032;290455;30404.695953040187;34900.301993959474;35486.46770298396;36062.27875442424;36457.270854583294;47383.28925066058;47741.52258477371;47802;48088.27867582059;48714.26928596003;37354.626453735116;39722;40440.79779601201;40650;40846.59153408547;38312;39298;40102.19284650047;40217.59782402139;40698;39903.600963989986;40121.39817902676;40437.19125617413;42229;42681;32938.50592241166;36241;36616.070714342255;36647.63352366442;36743.81628091842;26928.32679183036;27200.727992719818;27360.863195683894;27368.178954631392;27755.902586885397 14:37:05 INFO - PROCESS | 16720 | |2;jquery.html;361.67991327674997;366.90827293176716;366.99266014679705;377.294459360995;377.8469719763495;17269;17432.56418589536;18223.36218232362;18283.451496455127;18312.359067432644;15589.298481568328;16110.355585776584;16125.758113628304;16129.354825806982;16156;5275.657082289658;5539.833804985857;5701.828945131632;5707.372189059221;5713.228714123603;4170;4315.244832154376;4317.546657600954;4318.460192475941;5605.495505404513;5794.5074668653215;6046;6049.183360246355;6055.394460553932;6064.636121832704;5752.769889204426;6020.45815876571;6076.966915624354;6083.8174854754425;6087.208662873798;3763.981180094082;5310.522053015247;5320.255164276966;5343.759530821084;5384.138537833927;18240.726389104173;18647.34734284307;18904;19040.238390464365;19971.101300441514;2142.7750086240876;2364.775346342095;2405.9398515037087;3043.858553042609;3182.7772055956093;13612;13766.174029558159;13933.172964385176;14044.508442204473;14144.929275353557;1806.719958406449;1850.5466160790559;1852.8795628284254;1899.040984302932;1939.7478327817294;66135;66719.66640166816;66776;66989.66505167492;67206.66396667986;9760.658376956915;10087.69736907894;10146.13757830578;10173.745656358651;10176.185905127571;13945.233012184224;14036.649083772783;14136.08115472491;14157.221352825694;14175;8029.638666260033;8202.58987050645;8211.134939866979;8213.507189568645;8345.624446899905;8101.473404228824;8159.83680326402;8195.303399211134;8243.216894395024;8254;5913.201717768132;5973.163757074013;5995.700214989233;6076.422739839708;6104.26748790148;1750.824917508239;1785.2055835153233;1810.3203219677018;1825.5527395788117;1872.569309058924;483.77020915065765;958.3818437108026;1069.262209075751;1160.7620437810228;1178.8644305904932;11019.338839669645;11394.601188958346;11427.657170284905;11583.478743456564;11604;474.95487928646725;528.6484487815636;964.8118616869643;1052.2686732720686;1084.2247792828166;8971.551422428853;9073.183413492818;9204.861927071099;9344.439333640003;9500.049995000583;429906;445438;459869;461349.5460181555;465721;77758.2224177751;82379.35241295141;83649.58175209207;84275.57862210773;84851;1107.6178718342321;1114.8829372915889;1118.6644006797765;1125.6735546691532;1143.5540139345496;14912.254387280376;15051.172185529464;15614.21928903573;15740.842591573937;16048.919755401148;36150.27699446049;36355.818220908724;36803.44794828133;37443.43834842425;37480.437793432575;46534.53465465302;49595.50404495909;50693.49306506888;50781.746091269306;50841.237381438565;8670.349723770869;8693.739187824376;8774.429662071945;8888.911110888808;8910.955445222733;6591.505637077143;8527.957360213159;9243.676471323472;13335.799963000756;13376.264305463294;10985.285956412808;11264.94367528157;11425.257358271685;11662.766744665229;11799.528018879491;11170.441477925908;11332.263402878787;11333.093352531612;11499.770004599693;11707.487404599124;11467.713307167054;11743.530258789895;11818.763624727286;11893.881061189624;11937.761244775229;8242.17578242195;8330.833383332178;8388.622511987098;8565.400421970651;8879;8851.911480885366;10587.682369528926;11022.283551569122;11322.660320190407;11339 14:37:05 INFO - PROCESS | 16720 | |3;mootools.html;1266.7276535544856;1551.7362048451762;1556.727572674782;1741.1207340293158;1848.7689038870149;7110.715571377145;7694.153643099255;7849.5682737449415;7851.450398472095;7863.370930325575;7746.535207887517;7903.92096079039;7919.287264146225;7920.960395198031;7937.325327347183;2338.240071976606;2341.098677009355;2361.3506285771464;2363.6927199464044;2366.733797418373;2287.6797248385237;2319.907203711858;2321.4892723600783;2323.4075310795724;2352.176738141654;2311.3297143828354;2313.8843057847125;2314.525522267931;2371.5968285391523;2383.368407372048;2286.9885650571723;2290.874001929893;2291.9770802291932;2304.711911011132;2365.846219995712;2323.7560056194193;2329.662198981155;2333.474968132157;2333.8132949364012;2334.6031174700342;8032.638531266107;8067.233612806774;8070.192980701941;8071.354291656653;8088.272055515032;4902.632302577285;4984.401871775374;5006.199008158677;5016.54851063406;5018.874528136826;2990.925226869346;3018.864151113183;3073.6772638873044;3081.152683012167;3102.472579661463;1014.9746256343576;1022.3559157730582;1022.4580972084807;1044.112504371286;1046.095127714529;10910.836337454944;10933.945330273376;10936.125109991182;10954.561817527288;10960.28758130727;4201.537830838605;4312.784360781949;4323.48118225815;4349.521552629209;4385.802638881258;9343.90656093444;9367.953160234156;9409.858852117224;9419.670311539201;9426.858597121049;4944.134776414113;4944.975275123673;4947.1837146871085;4953.1332016896895;4956.801727930914;4038.0510580013674;4427.5572442755465;4462.732236065846;4520.954790452053;4541.523140070245;3776;3836.6738827199442;3849.575657006925;3883.475730776309;3901.765894046366;1195.7010747313172;1197.0304053716518;1204.5302332090491;1208.6011616166643;1221.9144659873723;1408.4647833823083;1423.210118384286;1432.219440404961;1437.6765227823655;1467.4717101843328;7652.273034061755;7661.310482056641;7714.421418393643;7716.4212684048925;7728.149903510609;506.8758154252232;522.5375542644787;528.7541293298634;529.7060131626907;535.1143856916731;5684.118961560965;5708.600397972185;5723.055695810144;5750.281214848144;5752.108423194411;9245.399049061789;9569.569369378394;9636.75908102289;9775.755606109904;9814.656487023063;9588.041195880356;9651.855222171673;9669.951650241705;9676.225901927828;9700.563474643657;7370.226126256773;7504.962475187589;7682.347000504908;7690.615469226516;7691.346235570039;7310.59791711461;7350.264973502607;7384.52000619958;7418.96290518544;7420.072490938633;8435.072142064246;8549.786255343666;8612.267957223707;8617.655293788179;8759.562021898751;8716;8786.16531429513;8866.556672166495;8885.777855553662;8911.55442227873;6198.2252218472695;6884.242733299433;7115.217326094022;7349.081364829396;7407.740729074457;7472.140703818913;7481.738139165103;7483.812904677427;7526.962365188139;7529.096508419025;6714.496412768965;6767.661616919233;6771.89842152378;6809.114815074008;7031.7890463286185;6839.829004274734;6865.141857267841;6960.512764106464;6969.477289203229;7012.824679383056;7091.1490621125795;7223.422126229784;7234;7261.128664560287;7287.234840341688;6793.6942837573415;6802.217744959393;6812.591244525344;6831.282715315019;6831.282715315019;6681.866362672817;6716.664166791543;6718.899216511659;6726.932730672631;6728.461723062242 14:37:05 INFO - PROCESS | 16720 | |4;prototype.html;364.95620525536924;365.91218107654163;370.0840419960597;373.20507319409654;379.1563770610392;5891.351951285361;5906.763729450817;5907.852303692404;5965.671888046161;5981.1028345748055;5990.640561566309;6031.884101441236;6032.607880487765;6037.547183961209;6045.425684559971;4499.6625253105985;4578.404807375036;4692.741899195543;4709.3171490134;4717.268823332389;4678.368420263272;4701.835435759749;4704.176769065417;4721.716696998191;4728.621710263171;4697.06058788242;4709.5290470952805;4713.575778179963;4716.410448693913;4718.19790635591;4709.788059537329;4710.222813235812;4712.976435117836;4716.457607375161;4721.055788842245;4212.7472351659;4216.198922204802;4216.64158546524;4225.323948168279;4227.936580951288;5633.267675202238;5747.971260143714;5751.741171647286;5752.338481074688;5761.078227483583;5422.674639521641;5444.863878403072;5456.536194423479;5457.454254574551;5460.972695136499;6287.245530536365;6316.368363163693;6322.272938612073;6326.746930122789;6329.987202047696;4503.076869241798;4597.356370108188;4607.262837945913;4612.561806628365;4625.167469855424;6501.2198536175965;6587.374199451045;6601.768938087144;6614.966925165391;6620.966895165541;4754.5007774183905;4764.618830493552;4766.356541866873;4767.070421267819;4768.403949506312;4830.516948305211;4836.951630483721;4839.612830973514;4839.927401088987;4841.3222148899185;5205.27126202332;5322.813701520428;5453.23654688344;5453.481919217668;5458.590605704509;6330.715117819709;6336.334684858023;6337.271213810379;6348.936510634927;6356.396142366468;1694.4154266777941;1715.1767151767222;1716.5965997990463;1718.8796784224985;1719.2005717341247;1138.886111388871;1152.746395792941;1160.3986498631834;1167.9474423650956;1183.1363104933446;6200.410960958701;6206.875862482815;6222.160008398899;6223.471004964538;6228.314885362606;6559.344065593403;6569.474442044625;6575.704093315812;6577.309382514863;6582.868342633121;6206.844828879314;6214.751409943642;6215.160953271341;6218.284897236786;6223.066540019034;3529.576450825917;3557.7331700122077;3558.395072837624;3560.5549306336707;3561;6681.632510211888;6751.932480675228;6907.827304317432;6911.481638877104;6921.757738479229;6775.254721980578;6787.355201255873;6792.626405547742;6793.048973143764;6807.2512023677355;6901.689423975933;6904.447644188554;6949.82625434358;6952.130983627047;6965.582065076112;6657.06801047844;6664.633445160563;6664.933350666432;6665.366790154928;6667.899981500378;6422.42198202164;6500.349965003462;6522.902156467562;6537.117489139096;6553.475721942328;6813.625250611264;6839.452843772586;6849.1780986281965;6851.862962740817;6853.0126263385055;4589.518100599389;4624.352590637381;4629.421322334708;4636.83771068011;4638.8608341749805;6366.872662546816;6464.482841372773;6616.206055273398;6626.204855417381;6661.700223489857;6402.551821372459;6410.0705397718;6422.133012043314;6430.164078669743;6432.9678351607945;6420.422162005442;6421.5825971311715;6426.164598602339;6428.710708018244;6433.260175079926;6291.591046581958;6301.905471417841;6309.33751956038;6312.337204593635;6323.936760632335;6240.625562466266;6426.871462570816;6429.678516074271;6449.064885591469;6454.419102280817;6290.339514350927;6307.96846015767;6309.842253943688;6318.399752023551;6333.398327159097 14:37:05 INFO - PROCESS | 16720 | |5;yui.html;803.8472690188863;907.1654078248012;910.6994691751722;919.8160367926412;929.0245242495378;14027.298635068257;14069.718605627893;14099.083559568646;14394.280285985698;14770.63073423165;13482.662933426669;13534.39095240714;13568.864311356883;13615.183089014641;13643.72712545751;772.5210369570846;895.6551727584895;902.3097330542124;910.2945217456459;912.4388501071859;915.5742579700438;916.6150216908915;917.0737555069361;919.7194855569048;922.1055576091181;808.3735105293385;963.7494251494592;963.9277054220961;968.428627110005;968.9806203875918;938.8920274168455;953.2469349214113;953.8044700836311;955.5843208204384;955.9044095590455;699.5592776550791;705.4744215559441;705.7988473285141;707.1761397971358;707.8478127202625;14344.641383965485;14392.71214575713;14483.131012139305;14554.908381871295;14557.199354035523;13509.392077356542;13807.17156970585;14024.789628155586;14427.422903083863;14502.927485362612;11607.477663505162;11857.5849845255;12158.696032599168;12257.632271031884;12329.630111096682;3852.8266228019806;3914.217156568669;3935.212957408501;4017.4375587417785;4020.597940205985;49347.75326123346;50155.498445015444;50247.748761255956;50486.49513504855;50628.74685626548;10572.735681608021;10977.231593788358;11018.50416731233;11134.10927125828;11408.315501069963;19720.802791972183;19727.40817775469;19731.60536789256;19751.209951601773;19827.801721982883;8542.871856922151;8668.393212475192;8845.911540884637;8913.732588022369;9049.502277374675;4380.67144964129;4543.227651299287;4682.086993036325;4757.09615173116;4762.047590481918;3513.3851575974613;3523.2601153757487;3536.840842162109;3537.964620353815;3545.6099829018785;628.9654069026247;667.1027468055457;668.1781408867121;675.645286224736;684.8801459744625;610.3591229209312;656.3895577113235;669.3139531979663;726.6475759256862;748.7716246544857;8833.33749968742;9102.635894564144;9367.62529498826;9457.243420526342;9463.952680236554;570.2729020498814;639.0605809460086;654.2378129479199;682.6518475577491;709.8970649255829;4289.699721019561;4293.742375457483;4358.716683415568;4481.148581769518;4491.169133710208;61026.69486652538;61396.69301653552;62186.37813621896;62304.376956230764;62399.440013999105;54512.18231726527;55104.448955510736;55185.448145518836;55427.72286138544;56280.437195628336;50114;50194.24708629373;50359.49640503621;50536.241956370686;51366.22950655743;8330.416870819226;8357.791055223668;8670.812127453097;8817.603207855791;8893.155150260714;37253.81373093117;37528.624713753605;37756;38025.80987095047;39122.804385977885;44681.55318446904;44929.77535112303;48243.75878120587;48593.5140648589;49953.75023124861;11066.778664426827;11155.665330040112;11179.60871369498;11254.099672026383;11440.141989351;12072.698182545506;12230.938845305716;12355.62933112008;12394.504219831106;12538.122331436713;9591.376560523544;12560.74878502443;12744.553940612033;12799;12852.485900564247;11874.940625296818;12568.245905245714;12748.235105893677;12791;13135.014873884305;12631.810522842348;12636;12713.872861271639;12724.681882953;12940.482380705043;10145.543450544596;10305.896941030494;10314.226433017404;10573.207009474167;10670.62652807148;10378.42918639482;10584.523696433525;10592.576296948344;10600.04599586041;10643.946780266358 14:37:05 INFO - PROCESS | 16720 | __end_tp_report 14:37:05 INFO - PROCESS | 16720 | __start_cc_report 14:37:05 INFO - PROCESS | 16720 | _x_x_mozilla_cycle_collect,911 14:37:05 INFO - PROCESS | 16720 | __end_cc_report 14:37:05 INFO - PROCESS | 16720 | __startTimestamp1461620225752__endTimestamp 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | ------- Summary: start ------- 14:37:05 INFO - PROCESS | 16720 | Number of tests: 6 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | [#0] dojo.html Cycles:165 Average:5321.77 Median:5508.28 stddev:563.51 (10.2%) stddev-sans-first:541.45 14:37:05 INFO - PROCESS | 16720 | Values: 3256.5 3329.7 3332.9 3342.4 3377.2 5356.7 5373.2 5373.3 5394.0 5411.3 5352.9 5367.3 5389.3 5389.4 5397.5 4762.6 4904.7 4913.3 4986.1 5019.0 4810.8 4897.3 4897.6 4903.5 4904.6 4880.7 4897.2 4924.9 4928.6 4929.3 4907.8 4932.7 4959.0 4962.8 4987.1 4786.7 4829.2 4854.5 4863.4 4889.1 5099.8 5104.3 5127.5 5134.2 5152.8 5581.1 5639.5 5669.8 5699.4 5702.5 5688.6 5696.6 5719.9 5723.1 5738.9 5345.7 5346.5 5349.0 5349.6 5389.0 5703.2 5798.9 5799.7 5882.9 5900.5 5591.7 5623.6 5631.9 5632.0 5633.3 5727.2 5732.9 5733.2 5735.1 5739.0 5609.9 5678.3 5707.1 5735.7 5749.6 5654.4 5657.7 5667.1 5667.9 5669.7 4295.4 4386.1 4388.7 4396.5 4413.8 3942.4 3959.5 3976.3 3989.7 4011.0 5445.7 5464.5 5467.5 5469.5 5472.3 5522.1 5652.8 5723.1 5753.7 5753.8 5469.0 5481.2 5504.6 5508.3 5528.4 4979.1 5002.2 5002.8 5003.8 5031.6 5775.7 5868.6 5918.9 5956.1 5970.2 5752.5 5755.1 5756.4 5772.2 5781.0 5944.7 5949.4 5953.4 5963.0 5964.9 5488.9 5504.4 5570.2 5602.7 5685.9 5700.7 5719.7 5747.8 5760.5 5770.9 5595.3 5606.9 5611.6 5615.2 5618.2 5470.2 5528.4 5586.3 5593.7 5638.3 5483.0 5495.5 5510.1 5510.3 5524.3 5482.4 5568.0 5604.8 5621.9 5652.5 5355.2 5377.6 5425.3 5533.0 5558.4 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | [#1] ext.html Cycles:180 Average:47786.15 Median:38669.01 stddev:78851.40 (203.9%) stddev-sans-first:78992.77 14:37:05 INFO - PROCESS | 16720 | Values: 530.1 533.3 536.3 548.1 558.1 31752.7 38391.8 38946.2 39007.0 39058.8 42687.1 42940.8 43093.6 43174.0 43178.0 9031.8 9324.8 9332.1 9332.5 9335.5 9036.3 9169.4 9189.3 9192.9 9197.0 9171.4 9252.0 9265.7 9273.2 9274.4 9112.2 9189.1 9197.3 9204.8 9206.5 8923.8 9059.5 9066.9 9067.5 9072.4 41711.4 42360.8 42414.6 42436.0 42494.6 3625.8 3656.4 3751.7 3949.8 4471.4 32012.8 32301.2 32636.5 32976.3 33510.0 3525.5 3587.7 3652.6 3684.3 3732.3 285617.0 286392.0 286469.0 287921.0 288049.6 45309.8 46065.3 61278.4 61768.7 61779.1 44028.8 44166.0 44258.8 44349.8 44374.1 16914.0 17069.6 17086.2 17090.4 17091.7 14123.7 14200.2 14204.2 14207.1 14211.8 15133.9 15668.6 15717.4 15727.3 15733.3 5936.9 6004.0 6007.8 6030.8 6036.7 1029.8 1072.4 1116.8 1123.8 1139.0 29181.6 29915.9 30186.4 30219.4 30505.4 987.0 1116.4 1131.8 1161.2 1183.3 14370.8 14589.5 14773.3 14881.2 15004.8 327903.0 327986.0 331263.0 331421.0 331961.0 57159.4 57763.4 57900.4 57938.7 57962.4 1272.3 1436.9 1469.5 1483.7 1486.5 29409.3 31929.0 32229.8 32243.2 32774.5 48973.8 49902.0 49908.3 49923.8 49941.3 278648.0 289417.0 289838.0 290032.0 290455.0 30404.7 34900.3 35486.5 36062.3 36457.3 47383.3 47741.5 47802.0 48088.3 48714.3 37354.6 39722.0 40440.8 40650.0 40846.6 38312.0 39298.0 40102.2 40217.6 40698.0 39903.6 40121.4 40437.2 42229.0 42681.0 32938.5 36241.0 36616.1 36647.6 36743.8 26928.3 27200.7 27360.9 27368.2 27755.9 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | [#2] jquery.html Cycles:180 Average:26312.77 Median:37123.44 stddev:74383.19 (200.4%) stddev-sans-first:74566.33 14:37:05 INFO - PROCESS | 16720 | Values: 361.7 366.9 367.0 377.3 377.8 17269.0 17432.6 18223.4 18283.5 18312.4 15589.3 16110.4 16125.8 16129.4 16156.0 5275.7 5539.8 5701.8 5707.4 5713.2 4170.0 4315.2 4317.5 4318.5 5605.5 5794.5 6046.0 6049.2 6055.4 6064.6 5752.8 6020.5 6077.0 6083.8 6087.2 3764.0 5310.5 5320.3 5343.8 5384.1 18240.7 18647.3 18904.0 19040.2 19971.1 2142.8 2364.8 2405.9 3043.9 3182.8 13612.0 13766.2 13933.2 14044.5 14144.9 1806.7 1850.5 1852.9 1899.0 1939.7 66135.0 66719.7 66776.0 66989.7 67206.7 9760.7 10087.7 10146.1 10173.7 10176.2 13945.2 14036.6 14136.1 14157.2 14175.0 8029.6 8202.6 8211.1 8213.5 8345.6 8101.5 8159.8 8195.3 8243.2 8254.0 5913.2 5973.2 5995.7 6076.4 6104.3 1750.8 1785.2 1810.3 1825.6 1872.6 483.8 958.4 1069.3 1160.8 1178.9 11019.3 11394.6 11427.7 11583.5 11604.0 475.0 528.6 964.8 1052.3 1084.2 8971.6 9073.2 9204.9 9344.4 9500.0 429906.0 445438.0 459869.0 461349.5 465721.0 77758.2 82379.4 83649.6 84275.6 84851.0 1107.6 1114.9 1118.7 1125.7 1143.6 14912.3 15051.2 15614.2 15740.8 16048.9 36150.3 36355.8 36803.4 37443.4 37480.4 46534.5 49595.5 50693.5 50781.7 50841.2 8670.3 8693.7 8774.4 8888.9 8911.0 6591.5 8528.0 9243.7 13335.8 13376.3 10985.3 11264.9 11425.3 11662.8 11799.5 11170.4 11332.3 11333.1 11499.8 11707.5 11467.7 11743.5 11818.8 11893.9 11937.8 8242.2 8330.8 8388.6 8565.4 8879.0 8851.9 10587.7 11022.3 11322.7 11339.0 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | [#3] mootools.html Cycles:180 Average:5583.67 Median:6440.05 stddev:2908.37 (45.2%) stddev-sans-first:2898.43 14:37:05 INFO - PROCESS | 16720 | Values: 1266.7 1551.7 1556.7 1741.1 1848.8 7110.7 7694.2 7849.6 7851.5 7863.4 7746.5 7903.9 7919.3 7921.0 7937.3 2338.2 2341.1 2361.4 2363.7 2366.7 2287.7 2319.9 2321.5 2323.4 2352.2 2311.3 2313.9 2314.5 2371.6 2383.4 2287.0 2290.9 2292.0 2304.7 2365.8 2323.8 2329.7 2333.5 2333.8 2334.6 8032.6 8067.2 8070.2 8071.4 8088.3 4902.6 4984.4 5006.2 5016.5 5018.9 2990.9 3018.9 3073.7 3081.2 3102.5 1015.0 1022.4 1022.5 1044.1 1046.1 10910.8 10933.9 10936.1 10954.6 10960.3 4201.5 4312.8 4323.5 4349.5 4385.8 9343.9 9368.0 9409.9 9419.7 9426.9 4944.1 4945.0 4947.2 4953.1 4956.8 4038.1 4427.6 4462.7 4521.0 4541.5 3776.0 3836.7 3849.6 3883.5 3901.8 1195.7 1197.0 1204.5 1208.6 1221.9 1408.5 1423.2 1432.2 1437.7 1467.5 7652.3 7661.3 7714.4 7716.4 7728.1 506.9 522.5 528.8 529.7 535.1 5684.1 5708.6 5723.1 5750.3 5752.1 9245.4 9569.6 9636.8 9775.8 9814.7 9588.0 9651.9 9670.0 9676.2 9700.6 7370.2 7505.0 7682.3 7690.6 7691.3 7310.6 7350.3 7384.5 7419.0 7420.1 8435.1 8549.8 8612.3 8617.7 8759.6 8716.0 8786.2 8866.6 8885.8 8911.6 6198.2 6884.2 7115.2 7349.1 7407.7 7472.1 7481.7 7483.8 7527.0 7529.1 6714.5 6767.7 6771.9 6809.1 7031.8 6839.8 6865.1 6960.5 6969.5 7012.8 7091.1 7223.4 7234.0 7261.1 7287.2 6793.7 6802.2 6812.6 6831.3 6831.3 6681.9 6716.7 6718.9 6726.9 6728.5 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | [#4] prototype.html Cycles:180 Average:5398.69 Median:6203.63 stddev:1582.46 (25.5%) stddev-sans-first:1541.14 14:37:05 INFO - PROCESS | 16720 | Values: 365.0 365.9 370.1 373.2 379.2 5891.4 5906.8 5907.9 5965.7 5981.1 5990.6 6031.9 6032.6 6037.5 6045.4 4499.7 4578.4 4692.7 4709.3 4717.3 4678.4 4701.8 4704.2 4721.7 4728.6 4697.1 4709.5 4713.6 4716.4 4718.2 4709.8 4710.2 4713.0 4716.5 4721.1 4212.7 4216.2 4216.6 4225.3 4227.9 5633.3 5748.0 5751.7 5752.3 5761.1 5422.7 5444.9 5456.5 5457.5 5461.0 6287.2 6316.4 6322.3 6326.7 6330.0 4503.1 4597.4 4607.3 4612.6 4625.2 6501.2 6587.4 6601.8 6615.0 6621.0 4754.5 4764.6 4766.4 4767.1 4768.4 4830.5 4837.0 4839.6 4839.9 4841.3 5205.3 5322.8 5453.2 5453.5 5458.6 6330.7 6336.3 6337.3 6348.9 6356.4 1694.4 1715.2 1716.6 1718.9 1719.2 1138.9 1152.7 1160.4 1167.9 1183.1 6200.4 6206.9 6222.2 6223.5 6228.3 6559.3 6569.5 6575.7 6577.3 6582.9 6206.8 6214.8 6215.2 6218.3 6223.1 3529.6 3557.7 3558.4 3560.6 3561.0 6681.6 6751.9 6907.8 6911.5 6921.8 6775.3 6787.4 6792.6 6793.0 6807.3 6901.7 6904.4 6949.8 6952.1 6965.6 6657.1 6664.6 6664.9 6665.4 6667.9 6422.4 6500.3 6522.9 6537.1 6553.5 6813.6 6839.5 6849.2 6851.9 6853.0 4589.5 4624.4 4629.4 4636.8 4638.9 6366.9 6464.5 6616.2 6626.2 6661.7 6402.6 6410.1 6422.1 6430.2 6433.0 6420.4 6421.6 6426.2 6428.7 6433.3 6291.6 6301.9 6309.3 6312.3 6323.9 6240.6 6426.9 6429.7 6449.1 6454.4 6290.3 6308.0 6309.8 6318.4 6333.4 14:37:05 INFO - PROCESS | 16720 | 14:37:05 INFO - PROCESS | 16720 | [#5] yui.html Cycles:180 Average:14851.15 Median:24710.47 stddev:17065.24 (69.1%) stddev-sans-first:17080.51 14:37:05 INFO - PROCESS | 16720 | Values: 803.8 907.2 910.7 919.8 929.0 14027.3 14069.7 14099.1 14394.3 14770.6 13482.7 13534.4 13568.9 13615.2 13643.7 772.5 895.7 902.3 910.3 912.4 915.6 916.6 917.1 919.7 922.1 808.4 963.7 963.9 968.4 969.0 938.9 953.2 953.8 955.6 955.9 699.6 705.5 705.8 707.2 707.8 14344.6 14392.7 14483.1 14554.9 14557.2 13509.4 13807.2 14024.8 14427.4 14502.9 11607.5 11857.6 12158.7 12257.6 12329.6 3852.8 3914.2 3935.2 4017.4 4020.6 49347.8 50155.5 50247.7 50486.5 50628.7 10572.7 10977.2 11018.5 11134.1 11408.3 19720.8 19727.4 19731.6 19751.2 19827.8 8542.9 8668.4 8845.9 8913.7 9049.5 4380.7 4543.2 4682.1 4757.1 4762.0 3513.4 3523.3 3536.8 3538.0 3545.6 629.0 667.1 668.2 675.6 684.9 610.4 656.4 669.3 726.6 748.8 8833.3 9102.6 9367.6 9457.2 9464.0 570.3 639.1 654.2 682.7 709.9 4289.7 4293.7 4358.7 4481.1 4491.2 61026.7 61396.7 62186.4 62304.4 62399.4 54512.2 55104.4 55185.4 55427.7 56280.4 50114.0 50194.2 50359.5 50536.2 51366.2 8330.4 8357.8 8670.8 8817.6 8893.2 37253.8 37528.6 37756.0 38025.8 39122.8 44681.6 44929.8 48243.8 48593.5 49953.8 11066.8 11155.7 11179.6 11254.1 11440.1 12072.7 12230.9 12355.6 12394.5 12538.1 9591.4 12560.7 12744.6 12799.0 12852.5 11874.9 12568.2 12748.2 12791.0 13135.0 12631.8 12636.0 12713.9 12724.7 12940.5 10145.5 10305.9 10314.2 10573.2 10670.6 10378.4 10584.5 10592.6 10600.0 10643.9 14:37:05 INFO - PROCESS | 16720 | -------- Summary: end -------- 14:37:05 INFO - PROCESS | 16720 | 14:37:06 INFO - TEST-INFO | 16720: exit 0 14:37:06 INFO - TEST-OK | dromaeo_css | took 1111395ms 14:37:06 INFO - TEST-START | kraken 14:37:06 INFO - operating with platform_type : linux_ 14:37:06 INFO - Initialising browser for kraken test... 14:37:06 INFO - TEST-INFO | started process 16920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqbiy8/profile http://localhost:45362/getInfo.html) 14:37:10 INFO - PROCESS | 16920 | __metrics Screen width/height:1600/1200 14:37:10 INFO - PROCESS | 16920 | colorDepth:24 14:37:10 INFO - PROCESS | 16920 | Browser inner width/height: 1024/697 14:37:10 INFO - PROCESS | 16920 | __metrics 14:37:11 INFO - PROCESS | 16920 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:12 INFO - TEST-INFO | 16920: exit 0 14:37:12 INFO - Browser initialized. 14:37:12 INFO - Running cycle 1/1 for kraken test... 14:37:12 INFO - TEST-INFO | started process 17011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqbiy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:24 INFO - PROCESS | 17011 | RSS: Main: 139829248 14:37:24 INFO - PROCESS | 17011 | 14:37:26 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:27 INFO - PROCESS | 17011 | RSS: Main: 175235072 14:37:27 INFO - PROCESS | 17011 | 14:37:29 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-dft) 14:37:30 INFO - PROCESS | 17011 | RSS: Main: 173903872 14:37:30 INFO - PROCESS | 17011 | 14:37:33 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-fft) 14:37:33 INFO - PROCESS | 17011 | RSS: Main: 169566208 14:37:33 INFO - PROCESS | 17011 | 14:37:35 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-oscillator) 14:37:36 INFO - PROCESS | 17011 | RSS: Main: 170807296 14:37:36 INFO - PROCESS | 17011 | 14:37:38 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:39 INFO - PROCESS | 17011 | RSS: Main: 168386560 14:37:39 INFO - PROCESS | 17011 | 14:37:42 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45362/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:42 INFO - PROCESS | 17011 | RSS: Main: 168943616 14:37:42 INFO - PROCESS | 17011 | 14:37:46 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45362/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:46 INFO - PROCESS | 17011 | RSS: Main: 167936000 14:37:46 INFO - PROCESS | 17011 | 14:37:49 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45362/tests/kraken/driver.html?testName=json-parse-financial) 14:37:50 INFO - PROCESS | 17011 | RSS: Main: 168943616 14:37:50 INFO - PROCESS | 17011 | 14:37:51 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:37:52 INFO - PROCESS | 17011 | RSS: Main: 174333952 14:37:52 INFO - PROCESS | 17011 | 14:37:54 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:37:54 INFO - PROCESS | 17011 | RSS: Main: 172765184 14:37:54 INFO - PROCESS | 17011 | 14:37:56 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:37:57 INFO - PROCESS | 17011 | RSS: Main: 177291264 14:37:57 INFO - PROCESS | 17011 | 14:37:59 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:00 INFO - PROCESS | 17011 | RSS: Main: 182398976 14:38:00 INFO - PROCESS | 17011 | 14:38:02 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:03 INFO - PROCESS | 17011 | RSS: Main: 181080064 14:38:03 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45362/tests/kraken/driver.html?testName=ai-astar) 14:38:05 INFO - PROCESS | 17011 | RSS: Main: 244412416 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | __start_tp_report 14:38:05 INFO - PROCESS | 17011 | _x_x_mozilla_page_load 14:38:05 INFO - PROCESS | 17011 | _x_x_mozilla_page_load_details 14:38:05 INFO - PROCESS | 17011 | |i|pagename|runs| 14:38:05 INFO - PROCESS | 17011 | |0;ai-astar;110;112;104;110;110;111;99;114;112;112 14:38:05 INFO - PROCESS | 17011 | |1;audio-beat-detection;153;131;153;181;127;163;149;123;172;127 14:38:05 INFO - PROCESS | 17011 | |2;audio-dft;160;160;162;161;161;161;161;165;161;162 14:38:05 INFO - PROCESS | 17011 | |3;audio-fft;73;74;77;160;74;75;75;75;162;74 14:38:05 INFO - PROCESS | 17011 | |4;audio-oscillator;93;93;145;98;93;94;136;93;93;149 14:38:05 INFO - PROCESS | 17011 | |5;imaging-gaussian-blur;116;116;116;117;117;117;117;117;118;117 14:38:05 INFO - PROCESS | 17011 | |6;imaging-darkroom;146;145;145;145;146;145;145;146;145;146 14:38:05 INFO - PROCESS | 17011 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;96;95 14:38:05 INFO - PROCESS | 17011 | |8;json-parse-financial;56;55;55;55;56;55;55;54;53;53 14:38:05 INFO - PROCESS | 17011 | |9;json-stringify-tinderbox;82;82;82;88;82;82;82;82;83;83 14:38:05 INFO - PROCESS | 17011 | |10;stanford-crypto-aes;80;87;80;80;80;79;79;78;78;79 14:38:05 INFO - PROCESS | 17011 | |11;stanford-crypto-ccm;112;110;110;119;126;115;111;112;119;115 14:38:05 INFO - PROCESS | 17011 | |12;stanford-crypto-pbkdf2;150;133;145;146;147;135;154;144;147;145 14:38:05 INFO - PROCESS | 17011 | |13;stanford-crypto-sha256-iterative;67;70;68;67;66;65;67;65;66;66 14:38:05 INFO - PROCESS | 17011 | __end_tp_report 14:38:05 INFO - PROCESS | 17011 | __start_cc_report 14:38:05 INFO - PROCESS | 17011 | _x_x_mozilla_cycle_collect,1066 14:38:05 INFO - PROCESS | 17011 | __end_cc_report 14:38:05 INFO - PROCESS | 17011 | __startTimestamp1461620285302__endTimestamp 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | ------- Summary: start ------- 14:38:05 INFO - PROCESS | 17011 | Number of tests: 14 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#0] ai-astar Cycles:10 Average:109.40 Median:112.00 stddev:4.50 (4.0%) stddev-sans-first:4.77 14:38:05 INFO - PROCESS | 17011 | Values: 110.0 112.0 104.0 110.0 110.0 111.0 99.0 114.0 112.0 112.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:153.00 stddev:20.38 (13.3%) stddev-sans-first:21.53 14:38:05 INFO - PROCESS | 17011 | Values: 153.0 131.0 153.0 181.0 127.0 163.0 149.0 123.0 172.0 127.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 14:38:05 INFO - PROCESS | 17011 | Values: 160.0 160.0 162.0 161.0 161.0 161.0 161.0 165.0 161.0 162.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#3] audio-fft Cycles:10 Average:91.90 Median:74.50 stddev:36.44 (48.9%) stddev-sans-first:38.00 14:38:05 INFO - PROCESS | 17011 | Values: 73.0 74.0 77.0 160.0 74.0 75.0 75.0 75.0 162.0 74.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:24.15 (26.0%) stddev-sans-first:24.94 14:38:05 INFO - PROCESS | 17011 | Values: 93.0 93.0 145.0 98.0 93.0 94.0 136.0 93.0 93.0 149.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 14:38:05 INFO - PROCESS | 17011 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:38:05 INFO - PROCESS | 17011 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:38:05 INFO - PROCESS | 17011 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.01 14:38:05 INFO - PROCESS | 17011 | Values: 56.0 55.0 55.0 55.0 56.0 55.0 55.0 54.0 53.0 53.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#9] json-stringify-tinderbox Cycles:10 Average:82.80 Median:82.00 stddev:1.87 (2.3%) stddev-sans-first:1.96 14:38:05 INFO - PROCESS | 17011 | Values: 82.0 82.0 82.0 88.0 82.0 82.0 82.0 82.0 83.0 83.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:2.58 (3.2%) stddev-sans-first:2.74 14:38:05 INFO - PROCESS | 17011 | Values: 80.0 87.0 80.0 80.0 80.0 79.0 79.0 78.0 78.0 79.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:115.00 stddev:5.13 (4.5%) stddev-sans-first:5.33 14:38:05 INFO - PROCESS | 17011 | Values: 112.0 110.0 110.0 119.0 126.0 115.0 111.0 112.0 119.0 115.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:146.50 stddev:6.31 (4.3%) stddev-sans-first:6.38 14:38:05 INFO - PROCESS | 17011 | Values: 150.0 133.0 145.0 146.0 147.0 135.0 154.0 144.0 147.0 145.0 14:38:05 INFO - PROCESS | 17011 | 14:38:05 INFO - PROCESS | 17011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 14:38:05 INFO - PROCESS | 17011 | Values: 67.0 70.0 68.0 67.0 66.0 65.0 67.0 65.0 66.0 66.0 14:38:05 INFO - PROCESS | 17011 | -------- Summary: end -------- 14:38:05 INFO - PROCESS | 17011 | 14:38:06 INFO - TEST-INFO | 17011: exit 0 14:38:06 INFO - TEST-OK | kraken | took 59926ms 14:38:06 INFO - SUITE-END | took 1171s 14:38:06 INFO - Completed test suite (00:19:31) 14:38:06 INFO - javascript benchmark 14:38:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3256.478963365861, 3329.716974057205, 3332.8833490827824, 3342.3649506593747, 3377.155711072231, 5356.6785992840405, 5373.220882971967, 5373.274607927924, 5393.973030134844, 5411.296531450906, 5352.91970620441, 5367.275417818593, 5389.299391079154, 5389.434109418514, 5397.514223719864, 4762.595179409755, 4904.705717656934, 4913.287573301878, 4986.10250154972, 5018.974905125469, 4810.807567697288, 4897.314375987365, 4897.6081913447015, 4903.509649035103, 4904.632152588552, 4880.707157570557, 4897.240927656201, 4924.901501969958, 4928.630352723542, 4929.285253638221, 4907.840659971731, 4932.654714170009, 4959.0, 4962.751862406865, 4987.052460032619, 4786.688865223784, 4829.227323628238, 4854.514548545152, 4863.416390033219, 4889.1443997300685, 5099.821506247264, 5104.285400043959, 5127.512886275797, 5134.204198349262, 5152.819651312186, 5581.05122129239, 5639.4642508962, 5669.829905102853, 5699.430056994309, 5702.486776190121, 5688.63023903445, 5696.601237913348, 5719.857003574903, 5723.141528770676, 5738.885222295572, 5345.65253258537, 5346.518813306821, 5348.973255133738, 5349.598780091509, 5388.973055134699, 5703.17303990919, 5798.855028624318, 5799.710014499343, 5882.911756323659, 5900.498457631149, 5591.720413979285, 5623.606347555632, 5631.915521267184, 5632.0, 5633.267675202197, 5727.2268243787385, 5732.914006289909, 5733.168690539848, 5735.053716136874, 5739.024365857814, 5609.887802243932, 5678.3186017678145, 5707.058335374617, 5735.655860648374, 5749.597528173072, 5654.4062873398525, 5657.717114144276, 5667.09326507765, 5667.943320566742, 5669.716514174357, 4295.4201182839915, 4386.056997745436, 4388.692791504564, 4396.538363471789, 4413.8234470621455, 3942.3692209246383, 3959.544652364957, 3976.2842688315804, 3989.7007724420782, 4011.0, 5445.700486473203, 5464.508194262536, 5467.480589344006, 5469.535089517435, 5472.315960504937, 5522.061249587579, 5652.830415087554, 5723.141528770634, 5753.683547404933, 5753.769849205984, 5469.0, 5481.177823326533, 5504.614676972574, 5508.283923090053, 5528.419515950848, 4979.103761322925, 5002.199648056367, 5002.799888004512, 5003.799848006039, 5031.647784655112, 5775.7400916957995, 5868.647881127146, 5918.8816223675285, 5956.1065840123465, 5970.194023806817, 5752.539796816161, 5755.050416681201, 5756.42435756421, 5772.19189313488, 5781.0, 5944.73248703818, 5949.434803693643, 5953.434423729739, 5963.0459126539545, 5964.880702385841, 5488.862778430571, 5504.422035686195, 5570.2480165177185, 5602.719864006702, 5685.914711279417, 5700.743466543932, 5719.714014299185, 5747.827565173052, 5760.510356619734, 5770.855728606818, 5595.328560572594, 5606.887862242814, 5611.551075913999, 5615.18579805934, 5618.2415373924, 5470.152126420411, 5528.391876893619, 5586.301712285965, 5593.692346920959, 5638.295213098363, 5482.972585137049, 5495.450454954473, 5510.118381059011, 5510.256115424367, 5524.33707955048, 5482.424345443671, 5568.0, 5604.8038318658655, 5621.8594535136945, 5652.547796176378, 5355.2234925934745, 5377.596680248918, 5425.321834770653, 5533.031719449161, 5558.416366281483], "unit": "score", "name": "dojo.html", "value": 5287.237186209338}, {"lowerIsBetter": false, "replicates": [530.1358785180156, 533.2561077297169, 536.3054843977047, 548.106586264389, 558.1098148453216, 31752.68247317526, 38391.80804095979, 38946.22107557847, 39007.0, 39058.8047059765, 42687.14625707484, 42940.785296073554, 43093.56906430935, 43174.0, 43178.0, 9031.774205644862, 9324.813503729922, 9332.066793320682, 9332.48671323077, 9335.486548239844, 9036.277097832157, 9169.40398874071, 9189.310801689866, 9192.862107068398, 9197.034311397307, 9171.449713017208, 9252.0, 9265.675701350454, 9273.211776998964, 9274.39716418434, 9112.225460835836, 9189.081091890825, 9197.310201734897, 9204.815903681889, 9206.539673016356, 8923.776905577348, 9059.456432614064, 9066.909330906738, 9067.501287429188, 9072.36493445459, 41711.374329385086, 42360.78819605882, 42414.57585424137, 42436.0, 42494.57505424937, 3625.764325318872, 3656.3601369760186, 3751.737378383514, 3949.8420063197436, 4471.374007638933, 32012.839935800173, 32301.192470188435, 32636.510452343235, 32976.34047319064, 33510.0, 3525.4888041233876, 3587.7488575799703, 3652.6164752700847, 3684.299983003221, 3732.2908647356917, 285617.0, 286392.0, 286469.0, 287921.0, 288049.559752202, 45309.773451133195, 46065.30902036472, 61278.38721612727, 61768.69115654393, 61779.07331390033, 44028.77985610116, 44166.0, 44258.77870610626, 44349.77825110854, 44374.11251774946, 16913.985160890385, 17069.57326066858, 17086.231119599648, 17090.401835935932, 17091.658166836594, 14123.717525649636, 14200.218987955555, 14204.218767967861, 14207.147571145764, 14211.78682319766, 15133.924330378497, 15668.608284792743, 15717.44988925405, 15727.292271847795, 15733.292001859943, 5936.940630593639, 6003.969980150071, 6007.8197654070445, 6030.819075427657, 6036.728347224385, 1029.7892663124615, 1072.3994563044564, 1116.7878103160374, 1123.842662027317, 1138.9943050284696, 29181.56227656587, 29915.850420748193, 30186.396272074435, 30219.395612087636, 30505.38989220203, 986.9950650246847, 1116.3636727065496, 1131.8472006279046, 1161.1639619473965, 1183.2782002978176, 14370.784438233435, 14589.489367872286, 14773.33519991603, 14881.181535015461, 15004.849951500346, 327903.0, 327986.0, 331263.0, 331421.0, 331961.0, 57159.428405716244, 57763.422365775805, 57900.4209957895, 57938.7103064482, 57962.4203757957, 1272.3002348708173, 1436.913785172893, 1469.4856800119871, 1483.6884254306717, 1486.524312220101, 29409.264768380104, 31929.0, 32229.838850805594, 32243.193920151247, 32774.50838237381, 48973.75513122412, 49902.0, 49908.25137622866, 49923.75038124786, 49941.25088123754, 278648.0, 289417.0, 289838.0, 290032.0, 290455.0, 30404.695953040187, 34900.301993959474, 35486.46770298396, 36062.27875442424, 36457.270854583294, 47383.28925066058, 47741.52258477371, 47802.0, 48088.27867582059, 48714.26928596003, 37354.626453735116, 39722.0, 40440.79779601201, 40650.0, 40846.59153408547, 38312.0, 39298.0, 40102.19284650047, 40217.59782402139, 40698.0, 39903.600963989986, 40121.39817902676, 40437.19125617413, 42229.0, 42681.0, 32938.50592241166, 36241.0, 36616.070714342255, 36647.63352366442, 36743.81628091842, 26928.32679183036, 27200.727992719818, 27360.863195683894, 27368.178954631392, 27755.902586885397], "unit": "score", "name": "ext.html", "value": 19075.598249912822}, {"lowerIsBetter": false, "replicates": [361.67991327674997, 366.90827293176716, 366.99266014679705, 377.294459360995, 377.8469719763495, 17269.0, 17432.56418589536, 18223.36218232362, 18283.451496455127, 18312.359067432644, 15589.298481568328, 16110.355585776584, 16125.758113628304, 16129.354825806982, 16156.0, 5275.657082289658, 5539.833804985857, 5701.828945131632, 5707.372189059221, 5713.228714123603, 4170.0, 4315.244832154376, 4317.546657600954, 4318.460192475941, 5605.495505404513, 5794.5074668653215, 6046.0, 6049.183360246355, 6055.394460553932, 6064.636121832704, 5752.769889204426, 6020.45815876571, 6076.966915624354, 6083.8174854754425, 6087.208662873798, 3763.981180094082, 5310.522053015247, 5320.255164276966, 5343.759530821084, 5384.138537833927, 18240.726389104173, 18647.34734284307, 18904.0, 19040.238390464365, 19971.101300441514, 2142.7750086240876, 2364.775346342095, 2405.9398515037087, 3043.858553042609, 3182.7772055956093, 13612.0, 13766.174029558159, 13933.172964385176, 14044.508442204473, 14144.929275353557, 1806.719958406449, 1850.5466160790559, 1852.8795628284254, 1899.040984302932, 1939.7478327817294, 66135.0, 66719.66640166816, 66776.0, 66989.66505167492, 67206.66396667986, 9760.658376956915, 10087.69736907894, 10146.13757830578, 10173.745656358651, 10176.185905127571, 13945.233012184224, 14036.649083772783, 14136.08115472491, 14157.221352825694, 14175.0, 8029.638666260033, 8202.58987050645, 8211.134939866979, 8213.507189568645, 8345.624446899905, 8101.473404228824, 8159.83680326402, 8195.303399211134, 8243.216894395024, 8254.0, 5913.201717768132, 5973.163757074013, 5995.700214989233, 6076.422739839708, 6104.26748790148, 1750.824917508239, 1785.2055835153233, 1810.3203219677018, 1825.5527395788117, 1872.569309058924, 483.77020915065765, 958.3818437108026, 1069.262209075751, 1160.7620437810228, 1178.8644305904932, 11019.338839669645, 11394.601188958346, 11427.657170284905, 11583.478743456564, 11604.0, 474.95487928646725, 528.6484487815636, 964.8118616869643, 1052.2686732720686, 1084.2247792828166, 8971.551422428853, 9073.183413492818, 9204.861927071099, 9344.439333640003, 9500.049995000583, 429906.0, 445438.0, 459869.0, 461349.5460181555, 465721.0, 77758.2224177751, 82379.35241295141, 83649.58175209207, 84275.57862210773, 84851.0, 1107.6178718342321, 1114.8829372915889, 1118.6644006797765, 1125.6735546691532, 1143.5540139345496, 14912.254387280376, 15051.172185529464, 15614.21928903573, 15740.842591573937, 16048.919755401148, 36150.27699446049, 36355.818220908724, 36803.44794828133, 37443.43834842425, 37480.437793432575, 46534.53465465302, 49595.50404495909, 50693.49306506888, 50781.746091269306, 50841.237381438565, 8670.349723770869, 8693.739187824376, 8774.429662071945, 8888.911110888808, 8910.955445222733, 6591.505637077143, 8527.957360213159, 9243.676471323472, 13335.799963000756, 13376.264305463294, 10985.285956412808, 11264.94367528157, 11425.257358271685, 11662.766744665229, 11799.528018879491, 11170.441477925908, 11332.263402878787, 11333.093352531612, 11499.770004599693, 11707.487404599124, 11467.713307167054, 11743.530258789895, 11818.763624727286, 11893.881061189624, 11937.761244775229, 8242.17578242195, 8330.833383332178, 8388.622511987098, 8565.400421970651, 8879.0, 8851.911480885366, 10587.682369528926, 11022.283551569122, 11322.660320190407, 11339.0], "unit": "score", "name": "jquery.html", "value": 8651.508943293267}, {"lowerIsBetter": false, "replicates": [1266.7276535544856, 1551.7362048451762, 1556.727572674782, 1741.1207340293158, 1848.7689038870149, 7110.715571377145, 7694.153643099255, 7849.5682737449415, 7851.450398472095, 7863.370930325575, 7746.535207887517, 7903.92096079039, 7919.287264146225, 7920.960395198031, 7937.325327347183, 2338.240071976606, 2341.098677009355, 2361.3506285771464, 2363.6927199464044, 2366.733797418373, 2287.6797248385237, 2319.907203711858, 2321.4892723600783, 2323.4075310795724, 2352.176738141654, 2311.3297143828354, 2313.8843057847125, 2314.525522267931, 2371.5968285391523, 2383.368407372048, 2286.9885650571723, 2290.874001929893, 2291.9770802291932, 2304.711911011132, 2365.846219995712, 2323.7560056194193, 2329.662198981155, 2333.474968132157, 2333.8132949364012, 2334.6031174700342, 8032.638531266107, 8067.233612806774, 8070.192980701941, 8071.354291656653, 8088.272055515032, 4902.632302577285, 4984.401871775374, 5006.199008158677, 5016.54851063406, 5018.874528136826, 2990.925226869346, 3018.864151113183, 3073.6772638873044, 3081.152683012167, 3102.472579661463, 1014.9746256343576, 1022.3559157730582, 1022.4580972084807, 1044.112504371286, 1046.095127714529, 10910.836337454944, 10933.945330273376, 10936.125109991182, 10954.561817527288, 10960.28758130727, 4201.537830838605, 4312.784360781949, 4323.48118225815, 4349.521552629209, 4385.802638881258, 9343.90656093444, 9367.953160234156, 9409.858852117224, 9419.670311539201, 9426.858597121049, 4944.134776414113, 4944.975275123673, 4947.1837146871085, 4953.1332016896895, 4956.801727930914, 4038.0510580013674, 4427.5572442755465, 4462.732236065846, 4520.954790452053, 4541.523140070245, 3776.0, 3836.6738827199442, 3849.575657006925, 3883.475730776309, 3901.765894046366, 1195.7010747313172, 1197.0304053716518, 1204.5302332090491, 1208.6011616166643, 1221.9144659873723, 1408.4647833823083, 1423.210118384286, 1432.219440404961, 1437.6765227823655, 1467.4717101843328, 7652.273034061755, 7661.310482056641, 7714.421418393643, 7716.4212684048925, 7728.149903510609, 506.8758154252232, 522.5375542644787, 528.7541293298634, 529.7060131626907, 535.1143856916731, 5684.118961560965, 5708.600397972185, 5723.055695810144, 5750.281214848144, 5752.108423194411, 9245.399049061789, 9569.569369378394, 9636.75908102289, 9775.755606109904, 9814.656487023063, 9588.041195880356, 9651.855222171673, 9669.951650241705, 9676.225901927828, 9700.563474643657, 7370.226126256773, 7504.962475187589, 7682.347000504908, 7690.615469226516, 7691.346235570039, 7310.59791711461, 7350.264973502607, 7384.52000619958, 7418.96290518544, 7420.072490938633, 8435.072142064246, 8549.786255343666, 8612.267957223707, 8617.655293788179, 8759.562021898751, 8716.0, 8786.16531429513, 8866.556672166495, 8885.777855553662, 8911.55442227873, 6198.2252218472695, 6884.242733299433, 7115.217326094022, 7349.081364829396, 7407.740729074457, 7472.140703818913, 7481.738139165103, 7483.812904677427, 7526.962365188139, 7529.096508419025, 6714.496412768965, 6767.661616919233, 6771.89842152378, 6809.114815074008, 7031.7890463286185, 6839.829004274734, 6865.141857267841, 6960.512764106464, 6969.477289203229, 7012.824679383056, 7091.1490621125795, 7223.422126229784, 7234.0, 7261.128664560287, 7287.234840341688, 6793.6942837573415, 6802.217744959393, 6812.591244525344, 6831.282715315019, 6831.282715315019, 6681.866362672817, 6716.664166791543, 6718.899216511659, 6726.932730672631, 6728.461723062242], "unit": "score", "name": "mootools.html", "value": 4525.761911563203}, {"lowerIsBetter": false, "replicates": [364.95620525536924, 365.91218107654163, 370.0840419960597, 373.20507319409654, 379.1563770610392, 5891.351951285361, 5906.763729450817, 5907.852303692404, 5965.671888046161, 5981.1028345748055, 5990.640561566309, 6031.884101441236, 6032.607880487765, 6037.547183961209, 6045.425684559971, 4499.6625253105985, 4578.404807375036, 4692.741899195543, 4709.3171490134, 4717.268823332389, 4678.368420263272, 4701.835435759749, 4704.176769065417, 4721.716696998191, 4728.621710263171, 4697.06058788242, 4709.5290470952805, 4713.575778179963, 4716.410448693913, 4718.19790635591, 4709.788059537329, 4710.222813235812, 4712.976435117836, 4716.457607375161, 4721.055788842245, 4212.7472351659, 4216.198922204802, 4216.64158546524, 4225.323948168279, 4227.936580951288, 5633.267675202238, 5747.971260143714, 5751.741171647286, 5752.338481074688, 5761.078227483583, 5422.674639521641, 5444.863878403072, 5456.536194423479, 5457.454254574551, 5460.972695136499, 6287.245530536365, 6316.368363163693, 6322.272938612073, 6326.746930122789, 6329.987202047696, 4503.076869241798, 4597.356370108188, 4607.262837945913, 4612.561806628365, 4625.167469855424, 6501.2198536175965, 6587.374199451045, 6601.768938087144, 6614.966925165391, 6620.966895165541, 4754.5007774183905, 4764.618830493552, 4766.356541866873, 4767.070421267819, 4768.403949506312, 4830.516948305211, 4836.951630483721, 4839.612830973514, 4839.927401088987, 4841.3222148899185, 5205.27126202332, 5322.813701520428, 5453.23654688344, 5453.481919217668, 5458.590605704509, 6330.715117819709, 6336.334684858023, 6337.271213810379, 6348.936510634927, 6356.396142366468, 1694.4154266777941, 1715.1767151767222, 1716.5965997990463, 1718.8796784224985, 1719.2005717341247, 1138.886111388871, 1152.746395792941, 1160.3986498631834, 1167.9474423650956, 1183.1363104933446, 6200.410960958701, 6206.875862482815, 6222.160008398899, 6223.471004964538, 6228.314885362606, 6559.344065593403, 6569.474442044625, 6575.704093315812, 6577.309382514863, 6582.868342633121, 6206.844828879314, 6214.751409943642, 6215.160953271341, 6218.284897236786, 6223.066540019034, 3529.576450825917, 3557.7331700122077, 3558.395072837624, 3560.5549306336707, 3561.0, 6681.632510211888, 6751.932480675228, 6907.827304317432, 6911.481638877104, 6921.757738479229, 6775.254721980578, 6787.355201255873, 6792.626405547742, 6793.048973143764, 6807.2512023677355, 6901.689423975933, 6904.447644188554, 6949.82625434358, 6952.130983627047, 6965.582065076112, 6657.06801047844, 6664.633445160563, 6664.933350666432, 6665.366790154928, 6667.899981500378, 6422.42198202164, 6500.349965003462, 6522.902156467562, 6537.117489139096, 6553.475721942328, 6813.625250611264, 6839.452843772586, 6849.1780986281965, 6851.862962740817, 6853.0126263385055, 4589.518100599389, 4624.352590637381, 4629.421322334708, 4636.83771068011, 4638.8608341749805, 6366.872662546816, 6464.482841372773, 6616.206055273398, 6626.204855417381, 6661.700223489857, 6402.551821372459, 6410.0705397718, 6422.133012043314, 6430.164078669743, 6432.9678351607945, 6420.422162005442, 6421.5825971311715, 6426.164598602339, 6428.710708018244, 6433.260175079926, 6291.591046581958, 6301.905471417841, 6309.33751956038, 6312.337204593635, 6323.936760632335, 6240.625562466266, 6426.871462570816, 6429.678516074271, 6449.064885591469, 6454.419102280817, 6290.339514350927, 6307.96846015767, 6309.842253943688, 6318.399752023551, 6333.398327159097], "unit": "score", "name": "prototype.html", "value": 4898.290180240512}, {"lowerIsBetter": false, "replicates": [803.8472690188863, 907.1654078248012, 910.6994691751722, 919.8160367926412, 929.0245242495378, 14027.298635068257, 14069.718605627893, 14099.083559568646, 14394.280285985698, 14770.63073423165, 13482.662933426669, 13534.39095240714, 13568.864311356883, 13615.183089014641, 13643.72712545751, 772.5210369570846, 895.6551727584895, 902.3097330542124, 910.2945217456459, 912.4388501071859, 915.5742579700438, 916.6150216908915, 917.0737555069361, 919.7194855569048, 922.1055576091181, 808.3735105293385, 963.7494251494592, 963.9277054220961, 968.428627110005, 968.9806203875918, 938.8920274168455, 953.2469349214113, 953.8044700836311, 955.5843208204384, 955.9044095590455, 699.5592776550791, 705.4744215559441, 705.7988473285141, 707.1761397971358, 707.8478127202625, 14344.641383965485, 14392.71214575713, 14483.131012139305, 14554.908381871295, 14557.199354035523, 13509.392077356542, 13807.17156970585, 14024.789628155586, 14427.422903083863, 14502.927485362612, 11607.477663505162, 11857.5849845255, 12158.696032599168, 12257.632271031884, 12329.630111096682, 3852.8266228019806, 3914.217156568669, 3935.212957408501, 4017.4375587417785, 4020.597940205985, 49347.75326123346, 50155.498445015444, 50247.748761255956, 50486.49513504855, 50628.74685626548, 10572.735681608021, 10977.231593788358, 11018.50416731233, 11134.10927125828, 11408.315501069963, 19720.802791972183, 19727.40817775469, 19731.60536789256, 19751.209951601773, 19827.801721982883, 8542.871856922151, 8668.393212475192, 8845.911540884637, 8913.732588022369, 9049.502277374675, 4380.67144964129, 4543.227651299287, 4682.086993036325, 4757.09615173116, 4762.047590481918, 3513.3851575974613, 3523.2601153757487, 3536.840842162109, 3537.964620353815, 3545.6099829018785, 628.9654069026247, 667.1027468055457, 668.1781408867121, 675.645286224736, 684.8801459744625, 610.3591229209312, 656.3895577113235, 669.3139531979663, 726.6475759256862, 748.7716246544857, 8833.33749968742, 9102.635894564144, 9367.62529498826, 9457.243420526342, 9463.952680236554, 570.2729020498814, 639.0605809460086, 654.2378129479199, 682.6518475577491, 709.8970649255829, 4289.699721019561, 4293.742375457483, 4358.716683415568, 4481.148581769518, 4491.169133710208, 61026.69486652538, 61396.69301653552, 62186.37813621896, 62304.376956230764, 62399.440013999105, 54512.18231726527, 55104.448955510736, 55185.448145518836, 55427.72286138544, 56280.437195628336, 50114.0, 50194.24708629373, 50359.49640503621, 50536.241956370686, 51366.22950655743, 8330.416870819226, 8357.791055223668, 8670.812127453097, 8817.603207855791, 8893.155150260714, 37253.81373093117, 37528.624713753605, 37756.0, 38025.80987095047, 39122.804385977885, 44681.55318446904, 44929.77535112303, 48243.75878120587, 48593.5140648589, 49953.75023124861, 11066.778664426827, 11155.665330040112, 11179.60871369498, 11254.099672026383, 11440.141989351, 12072.698182545506, 12230.938845305716, 12355.62933112008, 12394.504219831106, 12538.122331436713, 9591.376560523544, 12560.74878502443, 12744.553940612033, 12799.0, 12852.485900564247, 11874.940625296818, 12568.245905245714, 12748.235105893677, 12791.0, 13135.014873884305, 12631.810522842348, 12636.0, 12713.872861271639, 12724.681882953, 12940.482380705043, 10145.543450544596, 10305.896941030494, 10314.226433017404, 10573.207009474167, 10670.62652807148, 10378.42918639482, 10584.523696433525, 10592.576296948344, 10600.04599586041, 10643.946780266358], "unit": "score", "name": "yui.html", "value": 6857.857313375254}], "name": "dromaeo_css", "value": 7141.568543272915}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 110.0, 110.0, 111.0, 99.0, 114.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 153.0, 181.0, 127.0, 163.0, 149.0, 123.0, 172.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 77.0, 160.0, 74.0, 75.0, 75.0, 75.0, 162.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 145.0, 98.0, 93.0, 94.0, 136.0, 93.0, 93.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 54.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 88.0, 82.0, 82.0, 82.0, 82.0, 83.0, 83.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.8}, {"lowerIsBetter": true, "replicates": [80.0, 87.0, 80.0, 80.0, 80.0, 79.0, 79.0, 78.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 110.0, 119.0, 126.0, 115.0, 111.0, 112.0, 119.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [150.0, 133.0, 145.0, 146.0, 147.0, 135.0, 154.0, 144.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 68.0, 67.0, 66.0, 65.0, 67.0, 65.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1520.4}]} 14:38:06 INFO - Return code: 0 14:38:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:38:06 INFO - # TBPL SUCCESS # 14:38:06 INFO - Running post-action listener: _resource_record_post_action 14:38:06 INFO - Running post-run listener: _resource_record_post_run 14:38:07 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 466190336; Read time: 0; Write time: 621756 14:38:07 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 244228096; Read time: 0; Write time: 485364 14:38:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 221962240; Read time: 0; Write time: 136392 14:38:07 INFO - Running post-run listener: _upload_blobber_files 14:38:07 INFO - Blob upload gear active. 14:38:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:38:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:08 INFO - (blobuploader) - INFO - Done attempting. 14:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:09 INFO - (blobuploader) - INFO - Done attempting. 14:38:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:09 INFO - Return code: 0 14:38:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37d87d3ef88a29f5ba2bf0758a97f9a6333595559427105fc1138f8079cb03f7c234b5ccbb4c7a333fefd6f05ef6c5c35b4bf97d1e38fe7a3ee1ff5baedcae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec24ce5186cfe7550b0a45f8c1fc924643f3a1eca695d5ece5d222328bf79647efa13deec409d8dab1a2ad0fb94ff6dab36f7da0a37c68388f58c1885ea66206"} 14:38:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:09 INFO - Contents: 14:38:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37d87d3ef88a29f5ba2bf0758a97f9a6333595559427105fc1138f8079cb03f7c234b5ccbb4c7a333fefd6f05ef6c5c35b4bf97d1e38fe7a3ee1ff5baedcae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec24ce5186cfe7550b0a45f8c1fc924643f3a1eca695d5ece5d222328bf79647efa13deec409d8dab1a2ad0fb94ff6dab36f7da0a37c68388f58c1885ea66206"} 14:38:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:09 INFO - Copying logs to upload dir... 14:38:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1299.405313 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-04-25 14:38:09.716753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:38:09.720459) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248 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/37d87d3ef88a29f5ba2bf0758a97f9a6333595559427105fc1138f8079cb03f7c234b5ccbb4c7a333fefd6f05ef6c5c35b4bf97d1e38fe7a3ee1ff5baedcae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec24ce5186cfe7550b0a45f8c1fc924643f3a1eca695d5ece5d222328bf79647efa13deec409d8dab1a2ad0fb94ff6dab36f7da0a37c68388f58c1885ea66206"} build_url:https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/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/37d87d3ef88a29f5ba2bf0758a97f9a6333595559427105fc1138f8079cb03f7c234b5ccbb4c7a333fefd6f05ef6c5c35b4bf97d1e38fe7a3ee1ff5baedcae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec24ce5186cfe7550b0a45f8c1fc924643f3a1eca695d5ece5d222328bf79647efa13deec409d8dab1a2ad0fb94ff6dab36f7da0a37c68388f58c1885ea66206"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:38:09.745927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:38:09.746303) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461618797.188883-1443903248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:38:09.829102) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:38:09.829450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:38:09.829768) ========= ========= Total master_lag: 0.26 =========