builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1461618989.05 results: success (0) buildid: 20160425095909 builduid: bf4af95f322a4411b3423b15fcf5776e revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.047187) ========= 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:29.047587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.047890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.160714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.161033) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188 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% 39.3M=0s 2016-04-25 14:16:29 (39.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101002 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.279327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.279633) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019195 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.393014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.393362) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 14:16:29,561 truncating revision to first 12 chars 2016-04-25 14:16:29,561 Setting DEBUG logging. 2016-04-25 14:16:29,561 attempt 1/10 2016-04-25 14:16:29,561 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:30,223 unpacking tar archive at: mozilla-beta-dcaf0a6fa115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.953372 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.376103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.376499) ========= script_repo_revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.377025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.377368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.386887) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-25 14:16:30.387293) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188 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-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', 14:16:30 INFO - 'system_bits': '32', 14:16:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:30 INFO - 'title': 'talos-linux64-ix-030', 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-e10s", 14:16:31 INFO - "repository": "", 14:16:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 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": 61, 14:16:31 INFO - "slavename": "talos-linux64-ix-030", 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:37 INFO - Downloaded 1412 bytes. 14:16:37 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:37 INFO - Using the following test package requirements: 14:16:37 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:37 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:37 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 14:16:37 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'jsshell-linux-x86_64.zip'], 14:16:37 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:37 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:37 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 14:16:37 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 14:16:37 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:37 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:37 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:37 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:37 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:37 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:37 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:37 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:37 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:07 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:07 INFO - retry: attempt #1 caught exception: timed out 14:17:07 INFO - retry: Failed, sleeping 30 seconds before retrying 14:17:37 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:38 INFO - Downloaded 23362833 bytes. 14:17:38 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:38 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:40 INFO - Return code: 0 14:17:40 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:17: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:17: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:17: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:17: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:17: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:17: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:17:41 INFO - Downloaded 23362833 bytes. 14:17:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:17:43 INFO - Return code: 0 14:17:43 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:43 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:43 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:43 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:43 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:43 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:44 INFO - Downloaded 10845194 bytes. 14:17:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:17:44 INFO - Return code: 0 14:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:44 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:44 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:44 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:44 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:44 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:45 INFO - Downloaded 53782838 bytes. 14:17:45 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:45 INFO - mkdir: /builds/slave/test/properties 14:17:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:45 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:45 INFO - Contents: 14:17:45 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:46 INFO - Running post-action listener: _resource_record_post_action 14:17:46 INFO - Running post-action listener: set_extra_try_arguments 14:17:46 INFO - ##### 14:17:46 INFO - ##### Running populate-webroot step. 14:17:46 INFO - ##### 14:17:46 INFO - Running pre-action listener: _resource_record_pre_action 14:17:46 INFO - Running main action method: populate_webroot 14:17:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:46 INFO - '--tppagecycles', 14:17:46 INFO - '7'], 14:17:46 INFO - 'tests': ['tsvgm']}}, 14:17:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:17:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:17:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'tests': ['damp', 'tps']}, 14:17:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['damp', 'tps']}, 14:17:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:17:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:46 INFO - 'other': {'tests': ['a11yr', 14:17:46 INFO - 'ts_paint', 14:17:46 INFO - 'tpaint', 14:17:46 INFO - 'sessionrestore', 14:17:46 INFO - 'sessionrestore_no_auto_restore', 14:17:46 INFO - 'tabpaint']}, 14:17:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['a11yr', 14:17:46 INFO - 'ts_paint', 14:17:46 INFO - 'tpaint', 14:17:46 INFO - 'sessionrestore', 14:17:46 INFO - 'sessionrestore_no_auto_restore', 14:17:46 INFO - 'tabpaint']}, 14:17:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['a11yr', 14:17:46 INFO - 'ts_paint', 14:17:46 INFO - 'tpaint', 14:17:46 INFO - 'sessionrestore', 14:17:46 INFO - 'sessionrestore_no_auto_restore', 14:17:46 INFO - 'tabpaint']}, 14:17:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['a11yr', 14:17:46 INFO - 'ts_paint', 14:17:46 INFO - 'tpaint', 14:17:46 INFO - 'sessionrestore', 14:17:46 INFO - 'sessionrestore_no_auto_restore', 14:17:46 INFO - 'tabpaint']}, 14:17:46 INFO - 'other_l64': {'tests': ['a11yr', 14:17:46 INFO - 'ts_paint', 14:17:46 INFO - 'tpaint', 14:17:46 INFO - 'sessionrestore', 14:17:46 INFO - 'sessionrestore_no_auto_restore', 14:17:46 INFO - 'tabpaint']}, 14:17:46 INFO - 'other_nol64': {'tests': ['a11yr', 14:17:46 INFO - 'ts_paint', 14:17:46 INFO - 'tpaint', 14:17:46 INFO - 'sessionrestore', 14:17:46 INFO - 'sessionrestore_no_auto_restore', 14:17:46 INFO - 'tabpaint']}, 14:17:46 INFO - 'svgr': {'tests': ['tsvgx', 14:17:46 INFO - 'tsvgr_opacity', 14:17:46 INFO - 'tart', 14:17:46 INFO - 'tscrollx', 14:17:46 INFO - 'cart']}, 14:17:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['tsvgx', 14:17:46 INFO - 'tsvgr_opacity', 14:17:46 INFO - 'tart', 14:17:46 INFO - 'tscrollx', 14:17:46 INFO - 'cart']}, 14:17:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'tests': ['tp5o']}, 14:17:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'talos_options': ['--e10s'], 14:17:46 INFO - 'tests': ['tp5o']}, 14:17:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'talos_options': ['--xperf_path', 14:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:46 INFO - 'tests': ['tp5n']}, 14:17:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:46 INFO - 'talos_options': ['--e10s', 14:17:46 INFO - '--xperf_path', 14:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:46 INFO - 'tests': ['tp5n']}}, 14:17:46 INFO - 'talos.zip': {'path': '', 14:17:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:46 INFO - Running post-action listener: _resource_record_post_action 14:17:46 INFO - ##### 14:17:46 INFO - ##### Running create-virtualenv step. 14:17:46 INFO - ##### 14:17:46 INFO - Running pre-action listener: _resource_record_pre_action 14:17:46 INFO - Running main action method: create_virtualenv 14:17:46 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:17:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:46 INFO - Using real prefix '/usr' 14:17:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:47 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:49 INFO - Installing pip.................done. 14:17:49 INFO - Return code: 0 14:17:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17: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:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:17:49 INFO - Using env: {'DISPLAY': ':0', 14:17:49 INFO - 'HOME': '/home/cltbld', 14:17:49 INFO - 'LANG': 'en_US.UTF-8', 14:17:49 INFO - 'LANGUAGE': 'en_US:en', 14:17:49 INFO - 'LOGNAME': 'cltbld', 14:17:49 INFO - 'MAIL': '/var/mail/cltbld', 14:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:49 INFO - 'MOZ_NO_REMOTE': '1', 14:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:49 INFO - 'NO_EM_RESTART': '1', 14:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:49 INFO - 'PWD': '/builds/slave/test', 14:17:49 INFO - 'SHELL': '/bin/bash', 14:17:49 INFO - 'SHLVL': '1', 14:17:49 INFO - 'TERM': 'linux', 14:17:49 INFO - 'TMOUT': '86400', 14:17:49 INFO - 'USER': 'cltbld', 14:17:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:49 INFO - '_': '/tools/buildbot/bin/python'} 14:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:17:49 INFO - Cleaning up... 14:17:49 INFO - Return code: 0 14:17:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:17: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:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:17:49 INFO - Using env: {'DISPLAY': ':0', 14:17:49 INFO - 'HOME': '/home/cltbld', 14:17:49 INFO - 'LANG': 'en_US.UTF-8', 14:17:49 INFO - 'LANGUAGE': 'en_US:en', 14:17:49 INFO - 'LOGNAME': 'cltbld', 14:17:49 INFO - 'MAIL': '/var/mail/cltbld', 14:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:49 INFO - 'MOZ_NO_REMOTE': '1', 14:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:49 INFO - 'NO_EM_RESTART': '1', 14:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:49 INFO - 'PWD': '/builds/slave/test', 14:17:49 INFO - 'SHELL': '/bin/bash', 14:17:49 INFO - 'SHLVL': '1', 14:17:49 INFO - 'TERM': 'linux', 14:17:49 INFO - 'TMOUT': '86400', 14:17:49 INFO - 'USER': 'cltbld', 14:17:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:49 INFO - '_': '/tools/buildbot/bin/python'} 14:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:49 INFO - Downloading/unpacking psutil>=0.7.1 14:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:51 INFO - Installing collected packages: psutil 14:17:51 INFO - Running setup.py install for psutil 14:17:51 INFO - building 'psutil._psutil_linux' extension 14:17:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:17:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:17:51 INFO - building 'psutil._psutil_posix' extension 14:17:51 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:17:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:17:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:52 INFO - Successfully installed psutil 14:17:52 INFO - Cleaning up... 14:17:52 INFO - Return code: 0 14:17:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:17:52 INFO - Using env: {'DISPLAY': ':0', 14:17:52 INFO - 'HOME': '/home/cltbld', 14:17:52 INFO - 'LANG': 'en_US.UTF-8', 14:17:52 INFO - 'LANGUAGE': 'en_US:en', 14:17:52 INFO - 'LOGNAME': 'cltbld', 14:17:52 INFO - 'MAIL': '/var/mail/cltbld', 14:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:52 INFO - 'MOZ_NO_REMOTE': '1', 14:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:52 INFO - 'NO_EM_RESTART': '1', 14:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:52 INFO - 'PWD': '/builds/slave/test', 14:17:52 INFO - 'SHELL': '/bin/bash', 14:17:52 INFO - 'SHLVL': '1', 14:17:52 INFO - 'TERM': 'linux', 14:17:52 INFO - 'TMOUT': '86400', 14:17:52 INFO - 'USER': 'cltbld', 14:17:52 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:52 INFO - '_': '/tools/buildbot/bin/python'} 14:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:17:54 INFO - Installing collected packages: mozsystemmonitor 14:17:54 INFO - Running setup.py install for mozsystemmonitor 14:17:54 INFO - Successfully installed mozsystemmonitor 14:17:54 INFO - Cleaning up... 14:17:54 INFO - Return code: 0 14:17:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:17:54 INFO - Using env: {'DISPLAY': ':0', 14:17:54 INFO - 'HOME': '/home/cltbld', 14:17:54 INFO - 'LANG': 'en_US.UTF-8', 14:17:54 INFO - 'LANGUAGE': 'en_US:en', 14:17:54 INFO - 'LOGNAME': 'cltbld', 14:17:54 INFO - 'MAIL': '/var/mail/cltbld', 14:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:54 INFO - 'MOZ_NO_REMOTE': '1', 14:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:54 INFO - 'NO_EM_RESTART': '1', 14:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:54 INFO - 'PWD': '/builds/slave/test', 14:17:54 INFO - 'SHELL': '/bin/bash', 14:17:54 INFO - 'SHLVL': '1', 14:17:54 INFO - 'TERM': 'linux', 14:17:54 INFO - 'TMOUT': '86400', 14:17:54 INFO - 'USER': 'cltbld', 14:17:54 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:54 INFO - '_': '/tools/buildbot/bin/python'} 14:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:17:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:57 INFO - Downloading docopt-0.6.1.tar.gz 14:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:57 INFO - Running setup.py install for blobuploader 14:17:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:17:57 INFO - Running setup.py install for requests 14:17:57 INFO - Running setup.py install for docopt 14:17:57 INFO - Successfully installed blobuploader requests docopt 14:17:57 INFO - Cleaning up... 14:17:57 INFO - Return code: 0 14:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:57 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 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 14:17:57 INFO - 'HOME': '/home/cltbld', 14:17:57 INFO - 'LANG': 'en_US.UTF-8', 14:17:57 INFO - 'LANGUAGE': 'en_US:en', 14:17:57 INFO - 'LOGNAME': 'cltbld', 14:17:57 INFO - 'MAIL': '/var/mail/cltbld', 14:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:57 INFO - 'MOZ_NO_REMOTE': '1', 14:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:57 INFO - 'NO_EM_RESTART': '1', 14:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:57 INFO - 'PWD': '/builds/slave/test', 14:17:57 INFO - 'SHELL': '/bin/bash', 14:17:57 INFO - 'SHLVL': '1', 14:17:57 INFO - 'TERM': 'linux', 14:17:57 INFO - 'TMOUT': '86400', 14:17:57 INFO - 'USER': 'cltbld', 14:17:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:57 INFO - '_': '/tools/buildbot/bin/python'} 14:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:58 INFO - Running setup.py (path:/tmp/pip-0AFht2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:58 INFO - Running setup.py (path:/tmp/pip-4uOASM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:58 INFO - Running setup.py (path:/tmp/pip-pbGkXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:58 INFO - Running setup.py (path:/tmp/pip-RZgm5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:58 INFO - Running setup.py (path:/tmp/pip-SxuK5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:58 INFO - Running setup.py (path:/tmp/pip-tZE2WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:58 INFO - Running setup.py (path:/tmp/pip-SXR61Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:58 INFO - Running setup.py (path:/tmp/pip-Fi4A28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:58 INFO - Running setup.py (path:/tmp/pip-02HZQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:58 INFO - Running setup.py (path:/tmp/pip-H0TZnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:58 INFO - Running setup.py (path:/tmp/pip-1QFMWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:58 INFO - Running setup.py (path:/tmp/pip-osgTTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:59 INFO - Running setup.py (path:/tmp/pip-beUlL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:59 INFO - Running setup.py (path:/tmp/pip-b85o56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:59 INFO - Running setup.py (path:/tmp/pip-oGyTGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:59 INFO - Running setup.py (path:/tmp/pip-IO4T5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:59 INFO - Running setup.py (path:/tmp/pip-GyXXFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:59 INFO - Running setup.py install for manifestparser 14:17:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Running setup.py install for mozcrash 14:17:59 INFO - Running setup.py install for mozdebug 14:17:59 INFO - Running setup.py install for mozdevice 14:17:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Running setup.py install for mozfile 14:17:59 INFO - Running setup.py install for mozhttpd 14:17:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Running setup.py install for mozinfo 14:18:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Running setup.py install for mozInstall 14:18:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Running setup.py install for mozleak 14:18:00 INFO - Running setup.py install for mozlog 14:18:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Running setup.py install for moznetwork 14:18:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Running setup.py install for mozprocess 14:18:00 INFO - Running setup.py install for mozprofile 14:18:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Running setup.py install for mozrunner 14:18:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:00 INFO - Running setup.py install for mozscreenshot 14:18:00 INFO - Running setup.py install for moztest 14:18:01 INFO - Running setup.py install for mozversion 14:18:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:01 INFO - Cleaning up... 14:18:01 INFO - Return code: 0 14:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:01 INFO - Using env: {'DISPLAY': ':0', 14:18:01 INFO - 'HOME': '/home/cltbld', 14:18:01 INFO - 'LANG': 'en_US.UTF-8', 14:18:01 INFO - 'LANGUAGE': 'en_US:en', 14:18:01 INFO - 'LOGNAME': 'cltbld', 14:18:01 INFO - 'MAIL': '/var/mail/cltbld', 14:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:01 INFO - 'MOZ_NO_REMOTE': '1', 14:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:01 INFO - 'NO_EM_RESTART': '1', 14:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:01 INFO - 'PWD': '/builds/slave/test', 14:18:01 INFO - 'SHELL': '/bin/bash', 14:18:01 INFO - 'SHLVL': '1', 14:18:01 INFO - 'TERM': 'linux', 14:18:01 INFO - 'TMOUT': '86400', 14:18:01 INFO - 'USER': 'cltbld', 14:18:01 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:01 INFO - '_': '/tools/buildbot/bin/python'} 14:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:01 INFO - Running setup.py (path:/tmp/pip-Heiik5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:01 INFO - Running setup.py (path:/tmp/pip-v9xmD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:01 INFO - Running setup.py (path:/tmp/pip-vCGjhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:01 INFO - Running setup.py (path:/tmp/pip-y0YHLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:01 INFO - Running setup.py (path:/tmp/pip-XHJz4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:01 INFO - Running setup.py (path:/tmp/pip-HXQuIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:01 INFO - Running setup.py (path:/tmp/pip-x_BVfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:01 INFO - Running setup.py (path:/tmp/pip-BhjyKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:01 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:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:01 INFO - Running setup.py (path:/tmp/pip-BhFHpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:01 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:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:01 INFO - Running setup.py (path:/tmp/pip-IRYpf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:02 INFO - Running setup.py (path:/tmp/pip-boKefi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:02 INFO - Running setup.py (path:/tmp/pip-2xldbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:02 INFO - Running setup.py (path:/tmp/pip-sHMvQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:02 INFO - Running setup.py (path:/tmp/pip-F5tVcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:02 INFO - Running setup.py (path:/tmp/pip-M5mLZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:02 INFO - Running setup.py (path:/tmp/pip-ZKvVz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:02 INFO - Running setup.py (path:/tmp/pip-rGFiOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 14:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:04 INFO - Installing collected packages: blessings 14:18:04 INFO - Running setup.py install for blessings 14:18:04 INFO - Successfully installed blessings 14:18:04 INFO - Cleaning up... 14:18:04 INFO - Return code: 0 14:18:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:04 INFO - Reading from file tmpfile_stdout 14:18:04 INFO - Current package versions: 14:18:04 INFO - argparse == 1.2.1 14:18:04 INFO - blessings == 1.6 14:18:04 INFO - blobuploader == 1.2.4 14:18:04 INFO - docopt == 0.6.1 14:18:04 INFO - manifestparser == 1.1 14:18:04 INFO - mozInstall == 1.12 14:18:04 INFO - mozcrash == 0.17 14:18:04 INFO - mozdebug == 0.1 14:18:04 INFO - mozdevice == 0.48 14:18:04 INFO - mozfile == 1.2 14:18:04 INFO - mozhttpd == 0.7 14:18:04 INFO - mozinfo == 0.9 14:18:04 INFO - mozleak == 0.1 14:18:04 INFO - mozlog == 3.1 14:18:04 INFO - moznetwork == 0.27 14:18:04 INFO - mozprocess == 0.22 14:18:04 INFO - mozprofile == 0.28 14:18:04 INFO - mozrunner == 6.11 14:18:04 INFO - mozscreenshot == 0.1 14:18:04 INFO - mozsystemmonitor == 0.0 14:18:04 INFO - moztest == 0.7 14:18:04 INFO - mozversion == 1.4 14:18:04 INFO - psutil == 3.1.1 14:18:04 INFO - requests == 1.2.3 14:18:04 INFO - wsgiref == 0.1.2 14:18:04 INFO - Installing None 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', '-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 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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', '-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:04 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: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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:04 INFO - '_': '/tools/buildbot/bin/python'} 14:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:05 INFO - Cleaning up... 14:18:05 INFO - Return code: 0 14:18:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:18:05 INFO - Using env: {'DISPLAY': ':0', 14:18:05 INFO - 'HOME': '/home/cltbld', 14:18:05 INFO - 'LANG': 'en_US.UTF-8', 14:18:05 INFO - 'LANGUAGE': 'en_US:en', 14:18:05 INFO - 'LOGNAME': 'cltbld', 14:18:05 INFO - 'MAIL': '/var/mail/cltbld', 14:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:05 INFO - 'MOZ_NO_REMOTE': '1', 14:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:05 INFO - 'NO_EM_RESTART': '1', 14:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:05 INFO - 'PWD': '/builds/slave/test', 14:18:05 INFO - 'SHELL': '/bin/bash', 14:18:05 INFO - 'SHLVL': '1', 14:18:05 INFO - 'TERM': 'linux', 14:18:05 INFO - 'TMOUT': '86400', 14:18:05 INFO - 'USER': 'cltbld', 14:18:05 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:05 INFO - '_': '/tools/buildbot/bin/python'} 14:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:05 INFO - Downloading/unpacking jsonschema 14:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:07 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 14:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:07 INFO - warning: no files found matching '*.txt' 14:18:07 INFO - no previously-included directories found matching 'build' 14:18:07 INFO - no previously-included directories found matching 'dist' 14:18:07 INFO - no previously-included directories found matching '.git*' 14:18:07 INFO - Installing collected packages: jsonschema, functools32 14:18:07 INFO - Running setup.py install for functools32 14:18:07 INFO - warning: no files found matching '*.txt' 14:18:07 INFO - no previously-included directories found matching 'build' 14:18:07 INFO - no previously-included directories found matching 'dist' 14:18:07 INFO - no previously-included directories found matching '.git*' 14:18:07 INFO - Successfully installed jsonschema functools32 14:18:07 INFO - Cleaning up... 14:18:07 INFO - Return code: 0 14:18:07 INFO - Installing flake8 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', '--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 0x7f9534abcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2831410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', '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', '--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:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14: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': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:07 INFO - '_': '/tools/buildbot/bin/python'} 14:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:07 INFO - Downloading/unpacking flake8 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:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:10 INFO - no previously-included directories found matching 'docs/_build' 14:18:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:10 INFO - Running setup.py install for pep8 14:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:10 INFO - no previously-included directories found matching 'docs/_build' 14:18:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:10 INFO - Cleaning up... 14:18:10 INFO - Return code: 0 14:18:10 INFO - Running post-action listener: _resource_record_post_action 14:18:10 INFO - Running post-action listener: _start_resource_monitoring 14:18:10 INFO - Starting resource monitoring. 14:18:10 INFO - ##### 14:18:10 INFO - ##### Running install step. 14:18:10 INFO - ##### 14:18:10 INFO - Running pre-action listener: _resource_record_pre_action 14:18:10 INFO - Running main action method: install 14:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:10 INFO - Reading from file tmpfile_stdout 14:18:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:11 INFO - Reading from file tmpfile_stdout 14:18:11 INFO - Output received: 14:18:11 INFO - Usage: mozinstall [options] installer 14:18:11 INFO - Options: 14:18:11 INFO - -h, --help show this help message and exit 14:18:11 INFO - -d DEST, --destination=DEST 14:18:11 INFO - Directory to install application into. [default: 14:18:11 INFO - "/builds/slave/test"] 14:18:11 INFO - --app=APP Application being installed. [default: firefox] 14:18:11 INFO - mkdir: /builds/slave/test/build/application 14:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:18:23 INFO - Reading from file tmpfile_stdout 14:18:23 INFO - Output received: 14:18:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:23 INFO - Running post-action listener: _resource_record_post_action 14:18:23 INFO - ##### 14:18:23 INFO - ##### Running run-tests step. 14:18:23 INFO - ##### 14:18:23 INFO - Running pre-action listener: _resource_record_pre_action 14:18:23 INFO - Running main action method: run_tests 14:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:23 INFO - Python 2.7.3 14:18:23 INFO - Return code: 0 14:18:23 INFO - grabbing minidump binary from tooltool 14:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0160>, '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 0x28c1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c14f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:18:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:18:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:23 INFO - Return code: 0 14:18:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:18:24 INFO - Return code: 0 14:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:18:24 INFO - Using env: {'DISPLAY': ':0', 14:18:24 INFO - 'HOME': '/home/cltbld', 14:18:24 INFO - 'LANG': 'en_US.UTF-8', 14:18:24 INFO - 'LANGUAGE': 'en_US:en', 14:18:24 INFO - 'LOGNAME': 'cltbld', 14:18:24 INFO - 'MAIL': '/var/mail/cltbld', 14:18:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:24 INFO - 'MOZ_NO_REMOTE': '1', 14:18:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:24 INFO - 'NO_EM_RESTART': '1', 14:18:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:24 INFO - 'PWD': '/builds/slave/test', 14:18:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:24 INFO - 'SHELL': '/bin/bash', 14:18:24 INFO - 'SHLVL': '1', 14:18:24 INFO - 'TERM': 'linux', 14:18:24 INFO - 'TMOUT': '86400', 14:18:24 INFO - 'USER': 'cltbld', 14:18:24 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188', 14:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:24 INFO - '_': '/tools/buildbot/bin/python'} 14:18:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:18:24 INFO - mozversion application_buildid: 20160425095909 14:18:24 INFO - mozversion application_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:18:24 INFO - mozversion application_display_name: Firefox 14:18:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:24 INFO - mozversion application_name: Firefox 14:18:24 INFO - mozversion application_remotingname: firefox 14:18:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:18:24 INFO - mozversion application_vendor: Mozilla 14:18:24 INFO - mozversion application_version: 47.0 14:18:24 INFO - mozversion platform_buildid: 20160425095909 14:18:24 INFO - mozversion platform_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:18:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:18:24 INFO - mozversion platform_version: 47.0 14:18:24 INFO - using testdate: 1461619104 14:18:24 INFO - actual date: 1461619104 14:18:24 INFO - starting webserver on 'localhost:59911' 14:18:24 INFO - SUITE-START | Running 2 tests 14:18:24 INFO - TEST-START | dromaeo_css 14:18:24 INFO - operating with platform_type : linux_ 14:18:24 INFO - Initialising browser for dromaeo_css test... 14:18:24 INFO - TEST-INFO | started process 20960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOJQki/profile http://localhost:59911/getInfo.html) 14:18:28 INFO - PROCESS | 20960 | 14:18:28 INFO - PROCESS | 20960 | (process:21035): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:18:29 INFO - PROCESS | 20960 | __metrics Screen width/height:1600/1200 14:18:29 INFO - PROCESS | 20960 | colorDepth:24 14:18:29 INFO - PROCESS | 20960 | Browser inner width/height: 1024/697 14:18:29 INFO - PROCESS | 20960 | __metrics 14:18:29 ERROR - PROCESS | 20960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:18:30 INFO - TEST-INFO | 20960: exit 0 14:18:30 INFO - Browser initialized. 14:18:30 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:30 INFO - TEST-INFO | started process 21085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOJQki/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:32 INFO - PROCESS | 21085 | 14:18:32 INFO - PROCESS | 21085 | (process:21153): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:18:42 INFO - PROCESS | 21085 | RSS: Main: 150257664 14:18:42 INFO - PROCESS | 21085 | 14:19:31 INFO - PROCESS | 21085 | 1461619171939 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:39 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:59911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59911/tests/dromaeo/cssquery-ext.html) 14:21:40 INFO - PROCESS | 21085 | RSS: Main: 153493504 14:21:40 INFO - PROCESS | 21085 | 14:24:42 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:59911/tests/dromaeo/cssquery-ext.html (next: http://localhost:59911/tests/dromaeo/cssquery-jquery.html) 14:24:42 INFO - PROCESS | 21085 | RSS: Main: 152203264 14:24:42 INFO - PROCESS | 21085 | 14:27:44 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:59911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59911/tests/dromaeo/cssquery-mootools.html) 14:27:45 INFO - PROCESS | 21085 | RSS: Main: 151191552 14:27:45 INFO - PROCESS | 21085 | 14:30:46 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:59911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59911/tests/dromaeo/cssquery-prototype.html) 14:30:47 INFO - PROCESS | 21085 | RSS: Main: 152018944 14:30:47 INFO - PROCESS | 21085 | 14:33:49 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:59911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59911/tests/dromaeo/cssquery-yui.html) 14:33:50 INFO - PROCESS | 21085 | RSS: Main: 151310336 14:33:50 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:59911/tests/dromaeo/cssquery-yui.html (next: http://localhost:59911/tests/dromaeo/cssquery-dojo.html) 14:36:52 INFO - PROCESS | 21085 | RSS: Main: 155394048 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | __start_tp_report 14:36:52 INFO - PROCESS | 21085 | _x_x_mozilla_page_load 14:36:52 INFO - PROCESS | 21085 | _x_x_mozilla_page_load_details 14:36:52 INFO - PROCESS | 21085 | |i|pagename|runs| 14:36:52 INFO - PROCESS | 21085 | |0;dojo.html;3257.1531401835523;3303.587051618548;3309.6359400465954;3368.427367347551;3378.391889459898;5364.946350536494;5367.570594352453;5369.5704343652515;5391.272178255935;5402.513773760361;5367.409584945653;5372.892542149164;5404.297441332631;5427.511523962842;5437.972810135953;4934.506549345073;4954.108260513106;5002.699838009731;5020.899582008357;5021.949780502203;4894.2903279024695;4976.975115124419;4997;5077.720725360104;5090.312807770959;4960.429550601672;4999.850004499871;5006.649534532584;5061.848144555669;5087.033463641915;4975.203967365204;4976.4277108132665;4983.6013118950395;4983.651144419874;5007.774650140753;4909.852704418873;4929.433115191763;4944.703317800908;4960;4965.280034395028;5070.3915530136255;5175.948240517584;5178.0679477694;5214.957008598296;5263.921041184385;5794.101914203306;5803.042497987827;5822.505087067604;5832.6792026438525;5836.912446313267;5778.335491418498;5861.120831875211;5874.706264686749;5878.970605146947;5880.382559831241;5379.38137114233;5449.400565937704;5450.427705090909;5460.5085542301385;5475.06923822951;5969.970150149222;5998.3701711320555;5998.400159983967;6001.4298641628975;6004.129401236796;5634.211210430543;5733.942660573424;5747.885042299215;5773.509251713567;5785.681787501728;5707.6575405475805;5748.051571490741;5752.338481074647;5753.942460575425;5795.739191736382;5678.772849086073;5722.7710891563875;5729.455701708331;5731.226284451629;5732.455416735404;5623.353314368818;5723.055695810228;5733.455321744427;5734.885302293931;5799.4780469757925;4453.910921781611;4463.152001119842;4463.754493502824;4464.419625448736;4484.12559550891;4019.879403617896;4049.372347286175;4053.5135783706146;4067.471228740245;4074.4295798588223;5457.372402173722;5549.250851135045;5575.553955683617;5588.022096133161;5610.410906854803;5656.85857853557;5780.364159942403;5800.738966746507;5833.591648584558;5862.237909071793;5623.887522249532;5637.7181140942785;5645.661260324311;5645.802396916089;5654.067078932012;4927.43334516528;4999.775010124553;5026.52248036436;5032.874178145576;5084.161113416319;5929.970350148222;5941.613795103304;5949.6430214187285;5957.2255606771705;5966.701664916824;5820.476157145878;5828.76684932598;5842.211301474246;5856.590038697421;5862.237909071793;5852.473277405054;5883.146943693226;5928.347881733092;5956.851078723066;5975.910361344497;5803.042497987784;5810.244668193108;5817.76728930838;5824.883502330014;5829.59192856496;5735.369109398046;5844.444777746107;5894.086416605433;5897.941020589739;5905.055191169392;5694.800681976111;5746;5761.56788240892;5765.4811067004175;5802.854928626818;5624.6625202487985;5638.126090455986;5646.71766411686;5675.602707810579;5682.431756824284;5475.425080366664;5564.638298510584;5574.108142697149;5580.079286917613;5593.133064375028;5610.7755689773585;5651.773929042793;5673.234113394639;5677.7161141941915;5684.488396044376;5551.805686800943;5555.8888822222525;5556.472135147154;5559.24950131727;5562.777488900399 14:36:52 INFO - PROCESS | 21085 | |1;ext.html;485.65518481877865;537.2505355029733;539.4605394605395;547.5893080189857;567.0218872445032;39091.80454097729;39641;39645.60354396455;39652.40521392181;39680.404793928115;41926.161476770445;42344.78827605865;42490.78754606222;42676.57323426765;42788.35817462741;8907.46555206688;9113.407628504126;9113.908860911371;9127.497987610679;9137.954310228439;8921.509316987564;8954.238889694383;9007.279417646572;9263.120003599648;9279;9228.261739060892;9240.491772952484;9289.674861379854;9299.721008369726;9349.345545811795;9179.403338782991;9265.814683706321;9291.628334866597;9297.953510232406;9302.674406395778;9085.500297483635;9192.44845309277;9205.953970230174;9213.401128926598;9219.078092190794;43877;44255.336169957474;44372.11255774899;44415.33376999348;44423.555764442586;3607.8376473058775;3694.7967861767593;3816.5229346331707;3827.808609569538;3899.7660140391667;28489.45890020685;28821.135365939055;29505.70494295051;29795.25511862199;29895.10314690541;4179.686523510749;4187.790610469464;4273.7085275022955;4294.763787991659;4403.955960440387;291697;291894.5405272981;294353;295706;295904;69143.3085669147;69692.30307696859;69725.65137174282;69752.65123674349;69758;74721;76640;76667.61666191633;76740.61629691816;76750.23249767543;18201.27194912189;18335.541611459554;18382;18415;18430.539236519195;14048.297585120703;14256.144631322153;14265.714685706227;14269.143851368952;14396.928015359856;21778.237761678265;22039.779602204093;22074;22106;22767;8156.673733050611;8275.255227029596;8352.498850069016;8410.957945210235;8414.49513029208;960.2653969713175;1006.4866917871938;1022.4325499347784;1094.6715985204567;1128.4865386249237;27507.724922750916;27529;27533;27808.86095569509;28171.577426338623;1011.3224139826334;1041.5677493840124;1065.1478816946412;1109.8168802147716;1132.750794825137;14651.194184319966;15220.619484512976;17478.737818932725;18339.30290011808;18841.90579047096;400382;498180;502374;505837;512289;55143;56295.71852140713;56327;56346.43653563494;56381.43618563762;1462.6343414146463;1472.5508719840552;1480.8148981377328;1491.3512622009462;1501.9849801502064;29640.40719185561;32336.83831580921;32372.352552948338;32508.512372314908;33305.500417494244;51183.48816511787;51183.488165119365;51448.48551514437;51640.48359516357;51995.2200716982;312980;318205;320740;321174;321771;35781;36009.459858101625;36208.45687314745;36331.27337453183;36492.81753591215;48110.759446202544;48799.5120048795;48817;48985.75507122442;49158.75420622874;39905.800470997456;39922.401163983144;40027;40984.1803163941;41141.177176455705;39330.803345983084;39704.20591588094;40328.39507407333;40902.386464202464;41264.793676031426;39620.801895990335;40301.79849100736;40416.98957526086;40758.38862417007;40850.79574602108;34942.47586286157;35437.64562354344;36094.63905360913;36210.09474763152;36631;27526.311842204104;28200.576991345555;28261.293467663472;28277;28322.575161373006 14:36:52 INFO - PROCESS | 21085 | |2;jquery.html;376.20432784660443;378.31336124933244;379.11287587046314;387.370522900287;388.52017758068797;16383.18084095795;16948.576285592866;17401.303947842072;17508.474745757616;17520.561985950324;17758.289668413247;18038.458846234633;18241.27034918605;18286.817131828677;18379.632407351844;5521.889562208753;5721.456461636138;5771.365149833515;5804.970975145139;5810.651360918338;5350.8394748157425;5553.861153471155;5567.081431563787;5570.554355651559;5649.23735295736;5520.723963801814;5523.502884740373;5535;5617.915731264035;6404.103425520431;6307.432331090201;6316.873662526769;6322.4942004639515;6368.745250189987;6373.521985851056;5486.341639003305;5649.689267090308;5664.716764161775;5686.601937864351;5719.542436605062;14302.499412520616;14400.423983040666;14420.639484012878;14543.49097781583;19934.30229941945;2215.7784221577876;2247.6179049561615;2259.5254996450767;2298.643710224918;2419.63705444183;10003.59985600575;10329.173666106693;10460.895391046068;10666.626668066658;10844.566217351297;1937.806219378065;1969.1729473621112;2015.7077223802612;2027.523531969986;2048.1193086972594;68356.6582167091;68513;68873.65563172151;70634;71790.2820971794;10213.540390682438;10626.787464250672;10687.091597214168;10705.46472676363;10725.14198864089;14916.955813093196;14918.806495480336;14992.625184370478;15042.473513426978;15072.698546029018;8185;8394.076651568323;8414.200650938152;8515.74452766418;8549;8265.752027439186;8277.04813946392;8332.375071869634;8346.874796878052;8514.659413623509;4558.8632341029825;4736.715797052119;4823.758812059383;4834.95165048345;4892.0705066037335;1922.5482011727233;1947.8118347807826;1960.1767257751778;1963.1165975311167;1980.2969945669367;940.5532372123323;944.4782430909488;967.1585720423136;998.730342807438;1009.0414106598761;17113.743293850603;17952.281908723504;18221.18004689792;18792.812071879107;19292.13185406632;943.2783920300975;990.7671697151163;997.5311603546321;1008.8587597736323;1040.2354269611828;10389.428581427943;10511.1591072714;10528.578856845794;10567;10612.734681633021;428810;436989;437012;437364;451429;70013.64993175103;71313.6434317825;71557;78811.60594196993;83537;1053.7154968158554;1079.983800242997;1091.2906610702948;1097.7584931315098;1107.8615173103362;15815.209239537748;16091.517254482384;16154.353825847305;16351.264193111101;16618.50144495667;33332.1666958328;34344.65655343515;34782.65217347896;35105.29789404249;35423.82288088543;40837.591624083376;41265.79367103145;41289.79355103205;41527.792361038;41918.58081419147;8672.869906951275;8714.172153645393;8742.519161446182;8942.50816205115;9052.049534799015;12252.142350035412;12707.745845083231;12856.871431285568;12954;13220.735585288432;10974.670759877217;11076.833847492455;11095.16786241019;11185.105191584491;11324.37715925599;7130.42956563484;10668.199885008811;11345.319280843176;11416.82874756896;11810;11263.943680281545;11276.210665253682;11559.76880462403;11572.537098516303;11894.286342819458;8611.224989750952;8617.396782225434;8638.481691098303;8710.91289087101;8842.646294148162;10479.128602949093;11260.605878794202;11398.08815294791;11447.427628618369;11461.942690286494 14:36:52 INFO - PROCESS | 21085 | |3;mootools.html;1560.297865960318;1584.809822821261;1683.6380178261672;1784.741212524185;1785.2501949181342;7744.070711514619;7806.219378062191;7929.365650747941;7966.522008679476;8021.9598902005555;8046;8076.838463230732;8129.146439623843;8130.3902207334395;8131.105578386373;2383.1301574925155;2398.3164798032562;2416.5287768885073;2421.055788242587;2422.3701837522194;2405.290439320405;2422.697162854643;2444.0712529238863;2446.6819313489223;2449.632555116738;2359.587072262356;2364.7635236476385;2389.2712722619594;2393.401649587603;2396;2340.9180678676335;2349.048635302705;2365.704286964138;2368.6802281692007;2385.666006759055;2373.8694371809543;2380.345405013618;2386.5465561543424;2387.928362149121;2393.1265088242667;8030.196980301981;8078.676852925876;8082.555459449728;8084;8084.595770211466;4883.975580122112;5036.420811606676;5042.268871013683;5049.848504544832;5064.11378008847;3163.130139211712;3169.9841500792577;3238.5627940228005;3240.141362538929;3259.6903294187014;1013.3565186106802;1031.6286136990677;1035.1563475767225;1062.9627963021335;1068.4550879051662;10626.14990800734;10757.300775449648;10797.784044319149;10855.728606784814;10900.291481053786;4321.854708502186;4448.844290449819;4521.050579378368;4524.819007239739;4540.636749060067;9680.322377433653;9735.269854760922;9770.413775173512;9782.706518804447;9808.509574521246;5089;5103.464136265713;5105.7191854448365;5116.513931176532;5116.846494605168;4096.856610018635;4458.331250312479;4519.5480451954545;4554.111948170075;4618.95381046192;3825.617438256152;3865.130345672201;3905.258000979805;3911.7261791674878;3912.8239229234755;1233.5127624588238;1252.092233130991;1264.607971528829;1271.6121582917115;1274.6176147156002;1044.1907521670767;1052.4790228836775;1054.7679510507676;1257.9119461637597;1423.3737155651688;7178.928210717826;7245.203027666952;7268.200497945222;7290.708371665074;7603.125640551408;501.74411050363847;502.0711683385707;516.8010316028356;521.0256819747021;523.1995047577213;5788.652680839163;5874.882502350015;5890.67601281925;5903.26209223847;5908.113782932509;9073.77315567103;9523.380980236401;9534.856977145348;9546.570404331822;9568.61725530985;9345.859812102824;9393.060693930689;9478.90521094794;9483.525823708787;9529.380590261611;7308.488405811542;7514.135874374408;7514.211007844097;7529.284717951786;7531.171571127172;7206.315400036988;7214.96392518034;7260.782176534713;7277.9272207277245;7289.5261807982315;8370.121137280741;8466.619002145042;8513;8537.445066070686;8559.058503564727;8560.657573696983;8604.569771511524;8761.605727742139;8804.339674524308;8830.072842351718;7070.328318809705;7134.32223938725;7175;7223.458240632079;7270.818229544304;7505.362044226302;7541.509801862861;7565.886511702219;7592;7622.9237707622215;6869.690863911036;7038.120234970629;7049.259827718016;7100.467464940253;7143.571385716874;6845.691943862438;6911.75808846688;6945.826354341182;6966.338197871194;6997.230304666585;7158.391536719437;7167.3549380556;7206.89189662166;7286.271372862671;7307.3058059484265;6638.535302528777;6670.599764014175;6708.798736037927;6710.932890671031;6743.66281685904;6586.571872828251;6696.0960270362875;6742;6769.593824370553;6776.864462710817 14:36:52 INFO - PROCESS | 21085 | |4;prototype.html;358.45514817477437;375.85341716730466;378.1548239684306;380.8457574682253;385.652912378859;6280.842978925529;6308.432241098306;6327.114204011436;6334.809955701337;6481.31946145655;6304.33804450533;6352.047192921064;6361.491080713543;6403.135576697145;6410.775622853201;4738.597219236361;4846.9515304846855;4860.659753817235;4861.829835955742;4864.683795553296;4868.780904859272;4876.487968763282;4876.731779752112;4883.536064073925;4892.730899800509;4792.736399498026;4836.782344794493;4847.466778654345;4848.248521479159;4853.00513394755;4841.927371089437;4842.491538388454;4847.1032858921035;4856.5629093381585;4872.366592343008;4234.237837189305;4240.533541310453;4246.171996460692;4249.043965107826;4253.659707223445;5934.109883517507;6033.607815491979;6036.366181550918;6069.757209711606;6078.908816367758;5676.687782171979;5716.371199168088;5723.8282851514105;5725.885482290372;5730.9426905730825;6717.361850624232;6730.1923769147525;6804.353586409283;6807.047013418125;6823.897641535381;4736.052789442126;4736.100140973204;4738.2892566115015;4742.146413645542;4765.547273009059;6924.896126558106;7013.053237812881;7055.259197784261;7061;7067.257937916496;4687.273472611751;4782.880427989328;4784.425868895755;4844.370231869905;4853.4418541867435;4878.902421951612;4896.4858689837765;4907.7300748458465;4913.287573301851;4922.310876477296;5479.315085614298;5653.547716182696;5656.858578535487;5661.943380566224;5662.745176467069;6765.255821859591;6780.084688566981;6780.118584583973;6788.049673045777;6805.013273075476;1700.7023770840053;1742.3204950069482;1747.3098126240318;1747.7291019891936;1751.553353894774;1145.255583870491;1149.7642983188425;1162.1400163878839;1162.8895254950767;1172.9912275443112;6551.541392102602;6569.507286953498;6587.440067594212;6610.636414997221;6616.305287944697;6949.687264073129;6997.510174287751;7003.6498175092065;7012.614306213105;7027.789166325018;6606.438452731475;6606.7026983785845;6670.132882725312;6680.732770689216;6685.896827023486;3765.1904840459433;3810.2569998850513;3814.504114465102;3823.369144091194;3824.1395685970433;7099.751508697274;7325.901114832818;7336.119665640157;7342.412606991428;7361.705531778669;7264.891026634605;7285.089363829521;7287.234840341794;7292.635368231673;7303.379212766974;7217;7276.854462910818;7281.271872812782;7283.490155689051;7293.8905916411295;6939.930600693929;7064.32888875556;7064.964675176591;7090.964545177241;7104.928950710427;6987.930120698931;6989.126359205099;6996.510244283055;7000.194977577644;7029;7233.602151881487;7278.199398066315;7294.270572942663;7297.051383320135;7359;4848.854534363974;4894.853154405374;4897.314375987294;4906.754662266801;4915.8033678652455;6965.442764578923;7100.573965562083;7116.822079447848;7142.071530700976;7147.749828755968;6854.0404343390965;6859.211190713132;6883.8967415487805;6886.621235832077;6906.482013849082;6837.111175547346;6840;6848.486363522856;6862.176538815374;6879.454601797367;6662.56693314933;6668.499862510234;6705.8323541909895;6717.328267173243;6720.630365329954;6795.116634837439;6884.65576721172;6909.723611055702;6916.962455631696;6921.653917304216;6695.163104611924;6714.0600315954825;6729.226138994079;6754.358335958076;6757.831054223684 14:36:52 INFO - PROCESS | 21085 | |5;yui.html;759.6809340077167;824.9175082491748;880.4981160738378;913.1690161952624;915.6749353979337;14566;14708.411663533472;14817.333220005099;14843.703125937474;14855;14266.429342826275;14342.354594043267;14373.712525749479;14378.49675261366;14401.135931844097;776.0493395590385;914.3919293669735;921.2491819167374;941.5857022909897;943.4292253186826;913.0869130869131;919.7240827751648;920.2867777472479;920.6869664314132;922.4419226368051;974.6686126716914;977.1889331854544;979.2655508368723;980.5391466010964;990.5542505872351;969.9951500242489;970.8009857979098;976.897425770291;977.5991843344194;978.882534095906;729.0667945030369;729.5586170366905;730.6675462664529;732.3335764454374;732.3774791427297;13042;13091.214527128403;13105.934470327587;13165.934170329087;13171.934140329236;14035.859641403558;14224.644383890382;14252.786208206886;14283.428662853474;14336.64158396038;11125.332480051142;11223.831642525369;11255.493502792313;11336.093112550976;11385.259958102697;3869.7097717671004;3903.7072219583647;3928.7053470989504;3949.940750888739;4008.318585840385;48709;48716.75641621805;48787.26819097716;48874.51125488735;48916.26625600619;10709.196810239264;10856.674299771019;11222.158338124511;11283.54865805375;11475.770484590428;19360.225590976203;19510.90244548768;19563.80436195648;19580.314688985818;19643.508912277306;8303.543305118277;8347.582620868932;8358.665653373919;8503.61733721984;8603.31173506118;4750.881227969259;4789.856304310876;4841.394825646794;4923.138450771173;4928.975355123202;3497.492863534824;3557.4663800429626;3562.5012498250267;3603.387424137903;3606.02637287936;613.8219916224334;627.2222444169289;630.1146888621494;636.8153235561728;636.8312397214742;541.339565729809;637.8756142552251;704.2112833626371;706.9363757261871;730.82825535999;8079.353651707849;8294.958525207336;8346.343937390018;8390.496570205807;8426;623.7504998000836;727.9745208917662;729.7591794707733;730.8611363840853;753.2542782645141;3930.4890364252465;3944.447777311179;3970.285348637273;4025.7383270087353;4173.08192197716;55724.72137639286;55845.441545584836;56311;57151.714241428526;57732;49531.50468495269;50624;51270.487295127314;51327.48672513227;51709.482905170466;46580.06839863252;46634.06731865344;46802;46994.76502617465;47540;7942.523448593103;8062.234087761653;8161.306288965505;8163.428560000743;8275.668973241243;36027.45958810672;36037.27925441529;36630.8168459156;36822.63177368192;37268.254634907695;39855.601443985186;40326.59673403228;41044.58955410407;43533.78233108814;43555.12889742251;11692.590759323382;11771.52913883435;11960.940195298968;11965.222260553037;11997.460114294703;11987.160898737005;12122.515099396278;12792.552260670831;13021.414036368196;13744.587662370144;12110.75778484443;12273.324967126893;12323.249464694642;12414.379281036092;12607.054470914902;12263.855391730205;12386.154839350378;12387.673956262426;12422.192557483735;12842.357882106044;10440.53017614194;10508.316959397614;10578.259521833397;10624.096951759188;11088.611898583511;9432.952835236054;9526.095020972996;9549.283803714889;9586.328956972944;9602.711918642452;10195.133413659922;10311.793764124826;10335.276530642783;10342.741431464274;10430.113440357654 14:36:52 INFO - PROCESS | 21085 | __end_tp_report 14:36:52 INFO - PROCESS | 21085 | __start_cc_report 14:36:52 INFO - PROCESS | 21085 | _x_x_mozilla_cycle_collect,338 14:36:52 INFO - PROCESS | 21085 | __end_cc_report 14:36:52 INFO - PROCESS | 21085 | __startTimestamp1461620212816__endTimestamp 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | ------- Summary: start ------- 14:36:52 INFO - PROCESS | 21085 | Number of tests: 6 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | [#0] dojo.html Cycles:165 Average:5404.55 Median:5623.89 stddev:578.01 (10.3%) stddev-sans-first:554.69 14:36:52 INFO - PROCESS | 21085 | Values: 3257.2 3303.6 3309.6 3368.4 3378.4 5364.9 5367.6 5369.6 5391.3 5402.5 5367.4 5372.9 5404.3 5427.5 5438.0 4934.5 4954.1 5002.7 5020.9 5021.9 4894.3 4977.0 4997.0 5077.7 5090.3 4960.4 4999.9 5006.6 5061.8 5087.0 4975.2 4976.4 4983.6 4983.7 5007.8 4909.9 4929.4 4944.7 4960.0 4965.3 5070.4 5175.9 5178.1 5215.0 5263.9 5794.1 5803.0 5822.5 5832.7 5836.9 5778.3 5861.1 5874.7 5879.0 5880.4 5379.4 5449.4 5450.4 5460.5 5475.1 5970.0 5998.4 5998.4 6001.4 6004.1 5634.2 5733.9 5747.9 5773.5 5785.7 5707.7 5748.1 5752.3 5753.9 5795.7 5678.8 5722.8 5729.5 5731.2 5732.5 5623.4 5723.1 5733.5 5734.9 5799.5 4453.9 4463.2 4463.8 4464.4 4484.1 4019.9 4049.4 4053.5 4067.5 4074.4 5457.4 5549.3 5575.6 5588.0 5610.4 5656.9 5780.4 5800.7 5833.6 5862.2 5623.9 5637.7 5645.7 5645.8 5654.1 4927.4 4999.8 5026.5 5032.9 5084.2 5930.0 5941.6 5949.6 5957.2 5966.7 5820.5 5828.8 5842.2 5856.6 5862.2 5852.5 5883.1 5928.3 5956.9 5975.9 5803.0 5810.2 5817.8 5824.9 5829.6 5735.4 5844.4 5894.1 5897.9 5905.1 5694.8 5746.0 5761.6 5765.5 5802.9 5624.7 5638.1 5646.7 5675.6 5682.4 5475.4 5564.6 5574.1 5580.1 5593.1 5610.8 5651.8 5673.2 5677.7 5684.5 5551.8 5555.9 5556.5 5559.2 5562.8 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | [#1] ext.html Cycles:180 Average:54821.24 Median:220341.90 stddev:99261.51 (45.0%) stddev-sans-first:99456.12 14:36:52 INFO - PROCESS | 21085 | Values: 485.7 537.3 539.5 547.6 567.0 39091.8 39641.0 39645.6 39652.4 39680.4 41926.2 42344.8 42490.8 42676.6 42788.4 8907.5 9113.4 9113.9 9127.5 9138.0 8921.5 8954.2 9007.3 9263.1 9279.0 9228.3 9240.5 9289.7 9299.7 9349.3 9179.4 9265.8 9291.6 9298.0 9302.7 9085.5 9192.4 9206.0 9213.4 9219.1 43877.0 44255.3 44372.1 44415.3 44423.6 3607.8 3694.8 3816.5 3827.8 3899.8 28489.5 28821.1 29505.7 29795.3 29895.1 4179.7 4187.8 4273.7 4294.8 4404.0 291697.0 291894.5 294353.0 295706.0 295904.0 69143.3 69692.3 69725.7 69752.7 69758.0 74721.0 76640.0 76667.6 76740.6 76750.2 18201.3 18335.5 18382.0 18415.0 18430.5 14048.3 14256.1 14265.7 14269.1 14396.9 21778.2 22039.8 22074.0 22106.0 22767.0 8156.7 8275.3 8352.5 8411.0 8414.5 960.3 1006.5 1022.4 1094.7 1128.5 27507.7 27529.0 27533.0 27808.9 28171.6 1011.3 1041.6 1065.1 1109.8 1132.8 14651.2 15220.6 17478.7 18339.3 18841.9 400382.0 498180.0 502374.0 505837.0 512289.0 55143.0 56295.7 56327.0 56346.4 56381.4 1462.6 1472.6 1480.8 1491.4 1502.0 29640.4 32336.8 32372.4 32508.5 33305.5 51183.5 51183.5 51448.5 51640.5 51995.2 312980.0 318205.0 320740.0 321174.0 321771.0 35781.0 36009.5 36208.5 36331.3 36492.8 48110.8 48799.5 48817.0 48985.8 49158.8 39905.8 39922.4 40027.0 40984.2 41141.2 39330.8 39704.2 40328.4 40902.4 41264.8 39620.8 40301.8 40417.0 40758.4 40850.8 34942.5 35437.6 36094.6 36210.1 36631.0 27526.3 28200.6 28261.3 28277.0 28322.6 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | [#2] jquery.html Cycles:180 Average:25711.95 Median:2359.14 stddev:71882.41 (3047.0%) stddev-sans-first:72058.89 14:36:52 INFO - PROCESS | 21085 | Values: 376.2 378.3 379.1 387.4 388.5 16383.2 16948.6 17401.3 17508.5 17520.6 17758.3 18038.5 18241.3 18286.8 18379.6 5521.9 5721.5 5771.4 5805.0 5810.7 5350.8 5553.9 5567.1 5570.6 5649.2 5520.7 5523.5 5535.0 5617.9 6404.1 6307.4 6316.9 6322.5 6368.7 6373.5 5486.3 5649.7 5664.7 5686.6 5719.5 14302.5 14400.4 14420.6 14543.5 19934.3 2215.8 2247.6 2259.5 2298.6 2419.6 10003.6 10329.2 10460.9 10666.6 10844.6 1937.8 1969.2 2015.7 2027.5 2048.1 68356.7 68513.0 68873.7 70634.0 71790.3 10213.5 10626.8 10687.1 10705.5 10725.1 14917.0 14918.8 14992.6 15042.5 15072.7 8185.0 8394.1 8414.2 8515.7 8549.0 8265.8 8277.0 8332.4 8346.9 8514.7 4558.9 4736.7 4823.8 4835.0 4892.1 1922.5 1947.8 1960.2 1963.1 1980.3 940.6 944.5 967.2 998.7 1009.0 17113.7 17952.3 18221.2 18792.8 19292.1 943.3 990.8 997.5 1008.9 1040.2 10389.4 10511.2 10528.6 10567.0 10612.7 428810.0 436989.0 437012.0 437364.0 451429.0 70013.6 71313.6 71557.0 78811.6 83537.0 1053.7 1080.0 1091.3 1097.8 1107.9 15815.2 16091.5 16154.4 16351.3 16618.5 33332.2 34344.7 34782.7 35105.3 35423.8 40837.6 41265.8 41289.8 41527.8 41918.6 8672.9 8714.2 8742.5 8942.5 9052.0 12252.1 12707.7 12856.9 12954.0 13220.7 10974.7 11076.8 11095.2 11185.1 11324.4 7130.4 10668.2 11345.3 11416.8 11810.0 11263.9 11276.2 11559.8 11572.5 11894.3 8611.2 8617.4 8638.5 8710.9 8842.6 10479.1 11260.6 11398.1 11447.4 11461.9 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | [#3] mootools.html Cycles:180 Average:5604.08 Median:6612.55 stddev:2884.99 (43.6%) stddev-sans-first:2877.07 14:36:52 INFO - PROCESS | 21085 | Values: 1560.3 1584.8 1683.6 1784.7 1785.3 7744.1 7806.2 7929.4 7966.5 8022.0 8046.0 8076.8 8129.1 8130.4 8131.1 2383.1 2398.3 2416.5 2421.1 2422.4 2405.3 2422.7 2444.1 2446.7 2449.6 2359.6 2364.8 2389.3 2393.4 2396.0 2340.9 2349.0 2365.7 2368.7 2385.7 2373.9 2380.3 2386.5 2387.9 2393.1 8030.2 8078.7 8082.6 8084.0 8084.6 4884.0 5036.4 5042.3 5049.8 5064.1 3163.1 3170.0 3238.6 3240.1 3259.7 1013.4 1031.6 1035.2 1063.0 1068.5 10626.1 10757.3 10797.8 10855.7 10900.3 4321.9 4448.8 4521.1 4524.8 4540.6 9680.3 9735.3 9770.4 9782.7 9808.5 5089.0 5103.5 5105.7 5116.5 5116.8 4096.9 4458.3 4519.5 4554.1 4619.0 3825.6 3865.1 3905.3 3911.7 3912.8 1233.5 1252.1 1264.6 1271.6 1274.6 1044.2 1052.5 1054.8 1257.9 1423.4 7178.9 7245.2 7268.2 7290.7 7603.1 501.7 502.1 516.8 521.0 523.2 5788.7 5874.9 5890.7 5903.3 5908.1 9073.8 9523.4 9534.9 9546.6 9568.6 9345.9 9393.1 9478.9 9483.5 9529.4 7308.5 7514.1 7514.2 7529.3 7531.2 7206.3 7215.0 7260.8 7277.9 7289.5 8370.1 8466.6 8513.0 8537.4 8559.1 8560.7 8604.6 8761.6 8804.3 8830.1 7070.3 7134.3 7175.0 7223.5 7270.8 7505.4 7541.5 7565.9 7592.0 7622.9 6869.7 7038.1 7049.3 7100.5 7143.6 6845.7 6911.8 6945.8 6966.3 6997.2 7158.4 7167.4 7206.9 7286.3 7307.3 6638.5 6670.6 6708.8 6710.9 6743.7 6586.6 6696.1 6742.0 6769.6 6776.9 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | [#4] prototype.html Cycles:180 Average:5702.53 Median:6560.52 stddev:1724.60 (26.3%) stddev-sans-first:1682.15 14:36:52 INFO - PROCESS | 21085 | Values: 358.5 375.9 378.2 380.8 385.7 6280.8 6308.4 6327.1 6334.8 6481.3 6304.3 6352.0 6361.5 6403.1 6410.8 4738.6 4847.0 4860.7 4861.8 4864.7 4868.8 4876.5 4876.7 4883.5 4892.7 4792.7 4836.8 4847.5 4848.2 4853.0 4841.9 4842.5 4847.1 4856.6 4872.4 4234.2 4240.5 4246.2 4249.0 4253.7 5934.1 6033.6 6036.4 6069.8 6078.9 5676.7 5716.4 5723.8 5725.9 5730.9 6717.4 6730.2 6804.4 6807.0 6823.9 4736.1 4736.1 4738.3 4742.1 4765.5 6924.9 7013.1 7055.3 7061.0 7067.3 4687.3 4782.9 4784.4 4844.4 4853.4 4878.9 4896.5 4907.7 4913.3 4922.3 5479.3 5653.5 5656.9 5661.9 5662.7 6765.3 6780.1 6780.1 6788.0 6805.0 1700.7 1742.3 1747.3 1747.7 1751.6 1145.3 1149.8 1162.1 1162.9 1173.0 6551.5 6569.5 6587.4 6610.6 6616.3 6949.7 6997.5 7003.6 7012.6 7027.8 6606.4 6606.7 6670.1 6680.7 6685.9 3765.2 3810.3 3814.5 3823.4 3824.1 7099.8 7325.9 7336.1 7342.4 7361.7 7264.9 7285.1 7287.2 7292.6 7303.4 7217.0 7276.9 7281.3 7283.5 7293.9 6939.9 7064.3 7065.0 7091.0 7104.9 6987.9 6989.1 6996.5 7000.2 7029.0 7233.6 7278.2 7294.3 7297.1 7359.0 4848.9 4894.9 4897.3 4906.8 4915.8 6965.4 7100.6 7116.8 7142.1 7147.7 6854.0 6859.2 6883.9 6886.6 6906.5 6837.1 6840.0 6848.5 6862.2 6879.5 6662.6 6668.5 6705.8 6717.3 6720.6 6795.1 6884.7 6909.7 6917.0 6921.7 6695.2 6714.1 6729.2 6754.4 6757.8 14:36:52 INFO - PROCESS | 21085 | 14:36:52 INFO - PROCESS | 21085 | [#5] yui.html Cycles:180 Average:14117.74 Median:46607.07 stddev:15770.65 (33.8%) stddev-sans-first:15782.98 14:36:52 INFO - PROCESS | 21085 | Values: 759.7 824.9 880.5 913.2 915.7 14566.0 14708.4 14817.3 14843.7 14855.0 14266.4 14342.4 14373.7 14378.5 14401.1 776.0 914.4 921.2 941.6 943.4 913.1 919.7 920.3 920.7 922.4 974.7 977.2 979.3 980.5 990.6 970.0 970.8 976.9 977.6 978.9 729.1 729.6 730.7 732.3 732.4 13042.0 13091.2 13105.9 13165.9 13171.9 14035.9 14224.6 14252.8 14283.4 14336.6 11125.3 11223.8 11255.5 11336.1 11385.3 3869.7 3903.7 3928.7 3949.9 4008.3 48709.0 48716.8 48787.3 48874.5 48916.3 10709.2 10856.7 11222.2 11283.5 11475.8 19360.2 19510.9 19563.8 19580.3 19643.5 8303.5 8347.6 8358.7 8503.6 8603.3 4750.9 4789.9 4841.4 4923.1 4929.0 3497.5 3557.5 3562.5 3603.4 3606.0 613.8 627.2 630.1 636.8 636.8 541.3 637.9 704.2 706.9 730.8 8079.4 8295.0 8346.3 8390.5 8426.0 623.8 728.0 729.8 730.9 753.3 3930.5 3944.4 3970.3 4025.7 4173.1 55724.7 55845.4 56311.0 57151.7 57732.0 49531.5 50624.0 51270.5 51327.5 51709.5 46580.1 46634.1 46802.0 46994.8 47540.0 7942.5 8062.2 8161.3 8163.4 8275.7 36027.5 36037.3 36630.8 36822.6 37268.3 39855.6 40326.6 41044.6 43533.8 43555.1 11692.6 11771.5 11960.9 11965.2 11997.5 11987.2 12122.5 12792.6 13021.4 13744.6 12110.8 12273.3 12323.2 12414.4 12607.1 12263.9 12386.2 12387.7 12422.2 12842.4 10440.5 10508.3 10578.3 10624.1 11088.6 9433.0 9526.1 9549.3 9586.3 9602.7 10195.1 10311.8 10335.3 10342.7 10430.1 14:36:52 INFO - PROCESS | 21085 | -------- Summary: end -------- 14:36:52 INFO - PROCESS | 21085 | 14:36:53 INFO - TEST-INFO | 21085: exit 0 14:36:53 INFO - TEST-OK | dromaeo_css | took 1108543ms 14:36:53 INFO - TEST-START | kraken 14:36:53 INFO - operating with platform_type : linux_ 14:36:53 INFO - Initialising browser for kraken test... 14:36:53 INFO - TEST-INFO | started process 21325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZa8bpE/profile http://localhost:59911/getInfo.html) 14:36:56 INFO - PROCESS | 21325 | 14:36:56 INFO - PROCESS | 21325 | (process:21399): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:36:57 INFO - PROCESS | 21325 | __metrics Screen width/height:1600/1200 14:36:57 INFO - PROCESS | 21325 | colorDepth:24 14:36:57 INFO - PROCESS | 21325 | Browser inner width/height: 1024/697 14:36:57 INFO - PROCESS | 21325 | __metrics 14:36:58 ERROR - PROCESS | 21325 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:36:59 INFO - TEST-INFO | 21325: exit 0 14:36:59 INFO - Browser initialized. 14:36:59 INFO - Running cycle 1/1 for kraken test... 14:36:59 INFO - TEST-INFO | started process 21449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZa8bpE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:00 INFO - PROCESS | 21449 | 14:37:00 INFO - PROCESS | 21449 | (process:21515): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:37:10 INFO - PROCESS | 21449 | RSS: Main: 149790720 14:37:10 INFO - PROCESS | 21449 | 14:37:13 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59911/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:13 INFO - PROCESS | 21449 | RSS: Main: 154787840 14:37:13 INFO - PROCESS | 21449 | 14:37:16 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59911/tests/kraken/driver.html?testName=audio-dft) 14:37:17 INFO - PROCESS | 21449 | RSS: Main: 154066944 14:37:17 INFO - PROCESS | 21449 | 14:37:20 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59911/tests/kraken/driver.html?testName=audio-fft) 14:37:20 INFO - PROCESS | 21449 | RSS: Main: 155058176 14:37:20 INFO - PROCESS | 21449 | 14:37:22 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59911/tests/kraken/driver.html?testName=audio-oscillator) 14:37:23 INFO - PROCESS | 21449 | RSS: Main: 154501120 14:37:23 INFO - PROCESS | 21449 | 14:37:25 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:26 INFO - PROCESS | 21449 | RSS: Main: 154398720 14:37:26 INFO - PROCESS | 21449 | 14:37:29 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59911/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:29 INFO - PROCESS | 21449 | RSS: Main: 155267072 14:37:29 INFO - PROCESS | 21449 | 14:37:33 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59911/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:33 INFO - PROCESS | 21449 | RSS: Main: 155029504 14:37:33 INFO - PROCESS | 21449 | 14:37:36 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59911/tests/kraken/driver.html?testName=json-parse-financial) 14:37:37 INFO - PROCESS | 21449 | RSS: Main: 154697728 14:37:37 INFO - PROCESS | 21449 | 14:37:38 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:37:39 INFO - PROCESS | 21449 | RSS: Main: 154591232 14:37:39 INFO - PROCESS | 21449 | 14:37:41 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:37:41 INFO - PROCESS | 21449 | RSS: Main: 154542080 14:37:41 INFO - PROCESS | 21449 | 14:37:43 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:37:44 INFO - PROCESS | 21449 | RSS: Main: 154923008 14:37:44 INFO - PROCESS | 21449 | 14:37:46 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:47 INFO - PROCESS | 21449 | RSS: Main: 155103232 14:37:47 INFO - PROCESS | 21449 | 14:37:49 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:50 INFO - PROCESS | 21449 | RSS: Main: 154902528 14:37:50 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | Cycle 1(1): loaded http://localhost:59911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59911/tests/kraken/driver.html?testName=ai-astar) 14:37:52 INFO - PROCESS | 21449 | RSS: Main: 157081600 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | __start_tp_report 14:37:52 INFO - PROCESS | 21449 | _x_x_mozilla_page_load 14:37:52 INFO - PROCESS | 21449 | _x_x_mozilla_page_load_details 14:37:52 INFO - PROCESS | 21449 | |i|pagename|runs| 14:37:52 INFO - PROCESS | 21449 | |0;ai-astar;112;107;110;110;110;123;111;110;111;110 14:37:52 INFO - PROCESS | 21449 | |1;audio-beat-detection;155;137;159;165;136;161;166;128;176;129 14:37:52 INFO - PROCESS | 21449 | |2;audio-dft;161;162;161;162;163;161;162;162;164;161 14:37:52 INFO - PROCESS | 21449 | |3;audio-fft;74;74;76;178;76;76;74;73;166;75 14:37:52 INFO - PROCESS | 21449 | |4;audio-oscillator;93;95;137;93;92;93;142;94;94;143 14:37:52 INFO - PROCESS | 21449 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;117;117 14:37:52 INFO - PROCESS | 21449 | |6;imaging-darkroom;147;146;147;147;146;146;146;146;147;147 14:37:52 INFO - PROCESS | 21449 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;95 14:37:52 INFO - PROCESS | 21449 | |8;json-parse-financial;57;56;65;57;59;56;57;62;54;57 14:37:52 INFO - PROCESS | 21449 | |9;json-stringify-tinderbox;86;84;83;85;84;85;84;84;85;85 14:37:52 INFO - PROCESS | 21449 | |10;stanford-crypto-aes;78;85;78;78;78;80;78;78;77;77 14:37:52 INFO - PROCESS | 21449 | |11;stanford-crypto-ccm;114;113;122;115;121;114;119;116;119;117 14:37:52 INFO - PROCESS | 21449 | |12;stanford-crypto-pbkdf2;137;150;144;144;150;143;144;143;141;152 14:37:52 INFO - PROCESS | 21449 | |13;stanford-crypto-sha256-iterative;67;66;69;76;65;66;65;68;65;69 14:37:52 INFO - PROCESS | 21449 | __end_tp_report 14:37:52 INFO - PROCESS | 21449 | __start_cc_report 14:37:52 INFO - PROCESS | 21449 | _x_x_mozilla_cycle_collect,825 14:37:52 INFO - PROCESS | 21449 | __end_cc_report 14:37:52 INFO - PROCESS | 21449 | __startTimestamp1461620272457__endTimestamp 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | ------- Summary: start ------- 14:37:52 INFO - PROCESS | 21449 | Number of tests: 14 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#0] ai-astar Cycles:10 Average:111.40 Median:110.50 stddev:4.27 (3.9%) stddev-sans-first:4.53 14:37:52 INFO - PROCESS | 21449 | Values: 112.0 107.0 110.0 110.0 110.0 123.0 111.0 110.0 111.0 110.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:160.00 stddev:17.19 (10.7%) stddev-sans-first:18.18 14:37:52 INFO - PROCESS | 21449 | Values: 155.0 137.0 159.0 165.0 136.0 161.0 166.0 128.0 176.0 129.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 14:37:52 INFO - PROCESS | 21449 | Values: 161.0 162.0 161.0 162.0 163.0 161.0 162.0 162.0 164.0 161.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#3] audio-fft Cycles:10 Average:94.20 Median:74.50 stddev:41.11 (55.2%) stddev-sans-first:42.95 14:37:52 INFO - PROCESS | 21449 | Values: 74.0 74.0 76.0 178.0 76.0 76.0 74.0 73.0 166.0 75.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:93.00 stddev:22.88 (24.6%) stddev-sans-first:23.65 14:37:52 INFO - PROCESS | 21449 | Values: 93.0 95.0 137.0 93.0 92.0 93.0 142.0 94.0 94.0 143.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:37:52 INFO - PROCESS | 21449 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:37:52 INFO - PROCESS | 21449 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:37:52 INFO - PROCESS | 21449 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:3.23 (5.7%) stddev-sans-first:3.41 14:37:52 INFO - PROCESS | 21449 | Values: 57.0 56.0 65.0 57.0 59.0 56.0 57.0 62.0 54.0 57.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#9] json-stringify-tinderbox Cycles:10 Average:84.50 Median:85.00 stddev:0.85 (1.0%) stddev-sans-first:0.71 14:37:52 INFO - PROCESS | 21449 | Values: 86.0 84.0 83.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:2.36 (3.0%) stddev-sans-first:2.49 14:37:52 INFO - PROCESS | 21449 | Values: 78.0 85.0 78.0 78.0 78.0 80.0 78.0 78.0 77.0 77.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:118.00 stddev:3.13 (2.6%) stddev-sans-first:3.12 14:37:52 INFO - PROCESS | 21449 | Values: 114.0 113.0 122.0 115.0 121.0 114.0 119.0 116.0 119.0 117.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:144.00 stddev:4.59 (3.2%) stddev-sans-first:3.91 14:37:52 INFO - PROCESS | 21449 | Values: 137.0 150.0 144.0 144.0 150.0 143.0 144.0 143.0 141.0 152.0 14:37:52 INFO - PROCESS | 21449 | 14:37:52 INFO - PROCESS | 21449 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:3.34 (4.9%) stddev-sans-first:3.54 14:37:52 INFO - PROCESS | 21449 | Values: 67.0 66.0 69.0 76.0 65.0 66.0 65.0 68.0 65.0 69.0 14:37:52 INFO - PROCESS | 21449 | -------- Summary: end -------- 14:37:52 INFO - PROCESS | 21449 | 14:37:53 INFO - TEST-INFO | 21449: exit 0 14:37:53 INFO - TEST-OK | kraken | took 59912ms 14:37:53 INFO - SUITE-END | took 1168s 14:37:53 INFO - Completed test suite (00:19:28) 14:37:53 INFO - javascript benchmark 14:37:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3257.1531401835523, 3303.587051618548, 3309.6359400465954, 3368.427367347551, 3378.391889459898, 5364.946350536494, 5367.570594352453, 5369.5704343652515, 5391.272178255935, 5402.513773760361, 5367.409584945653, 5372.892542149164, 5404.297441332631, 5427.511523962842, 5437.972810135953, 4934.506549345073, 4954.108260513106, 5002.699838009731, 5020.899582008357, 5021.949780502203, 4894.2903279024695, 4976.975115124419, 4997.0, 5077.720725360104, 5090.312807770959, 4960.429550601672, 4999.850004499871, 5006.649534532584, 5061.848144555669, 5087.033463641915, 4975.203967365204, 4976.4277108132665, 4983.6013118950395, 4983.651144419874, 5007.774650140753, 4909.852704418873, 4929.433115191763, 4944.703317800908, 4960.0, 4965.280034395028, 5070.3915530136255, 5175.948240517584, 5178.0679477694, 5214.957008598296, 5263.921041184385, 5794.101914203306, 5803.042497987827, 5822.505087067604, 5832.6792026438525, 5836.912446313267, 5778.335491418498, 5861.120831875211, 5874.706264686749, 5878.970605146947, 5880.382559831241, 5379.38137114233, 5449.400565937704, 5450.427705090909, 5460.5085542301385, 5475.06923822951, 5969.970150149222, 5998.3701711320555, 5998.400159983967, 6001.4298641628975, 6004.129401236796, 5634.211210430543, 5733.942660573424, 5747.885042299215, 5773.509251713567, 5785.681787501728, 5707.6575405475805, 5748.051571490741, 5752.338481074647, 5753.942460575425, 5795.739191736382, 5678.772849086073, 5722.7710891563875, 5729.455701708331, 5731.226284451629, 5732.455416735404, 5623.353314368818, 5723.055695810228, 5733.455321744427, 5734.885302293931, 5799.4780469757925, 4453.910921781611, 4463.152001119842, 4463.754493502824, 4464.419625448736, 4484.12559550891, 4019.879403617896, 4049.372347286175, 4053.5135783706146, 4067.471228740245, 4074.4295798588223, 5457.372402173722, 5549.250851135045, 5575.553955683617, 5588.022096133161, 5610.410906854803, 5656.85857853557, 5780.364159942403, 5800.738966746507, 5833.591648584558, 5862.237909071793, 5623.887522249532, 5637.7181140942785, 5645.661260324311, 5645.802396916089, 5654.067078932012, 4927.43334516528, 4999.775010124553, 5026.52248036436, 5032.874178145576, 5084.161113416319, 5929.970350148222, 5941.613795103304, 5949.6430214187285, 5957.2255606771705, 5966.701664916824, 5820.476157145878, 5828.76684932598, 5842.211301474246, 5856.590038697421, 5862.237909071793, 5852.473277405054, 5883.146943693226, 5928.347881733092, 5956.851078723066, 5975.910361344497, 5803.042497987784, 5810.244668193108, 5817.76728930838, 5824.883502330014, 5829.59192856496, 5735.369109398046, 5844.444777746107, 5894.086416605433, 5897.941020589739, 5905.055191169392, 5694.800681976111, 5746.0, 5761.56788240892, 5765.4811067004175, 5802.854928626818, 5624.6625202487985, 5638.126090455986, 5646.71766411686, 5675.602707810579, 5682.431756824284, 5475.425080366664, 5564.638298510584, 5574.108142697149, 5580.079286917613, 5593.133064375028, 5610.7755689773585, 5651.773929042793, 5673.234113394639, 5677.7161141941915, 5684.488396044376, 5551.805686800943, 5555.8888822222525, 5556.472135147154, 5559.24950131727, 5562.777488900399], "unit": "score", "name": "dojo.html", "value": 5368.516174976817}, {"lowerIsBetter": false, "replicates": [485.65518481877865, 537.2505355029733, 539.4605394605395, 547.5893080189857, 567.0218872445032, 39091.80454097729, 39641.0, 39645.60354396455, 39652.40521392181, 39680.404793928115, 41926.161476770445, 42344.78827605865, 42490.78754606222, 42676.57323426765, 42788.35817462741, 8907.46555206688, 9113.407628504126, 9113.908860911371, 9127.497987610679, 9137.954310228439, 8921.509316987564, 8954.238889694383, 9007.279417646572, 9263.120003599648, 9279.0, 9228.261739060892, 9240.491772952484, 9289.674861379854, 9299.721008369726, 9349.345545811795, 9179.403338782991, 9265.814683706321, 9291.628334866597, 9297.953510232406, 9302.674406395778, 9085.500297483635, 9192.44845309277, 9205.953970230174, 9213.401128926598, 9219.078092190794, 43877.0, 44255.336169957474, 44372.11255774899, 44415.33376999348, 44423.555764442586, 3607.8376473058775, 3694.7967861767593, 3816.5229346331707, 3827.808609569538, 3899.7660140391667, 28489.45890020685, 28821.135365939055, 29505.70494295051, 29795.25511862199, 29895.10314690541, 4179.686523510749, 4187.790610469464, 4273.7085275022955, 4294.763787991659, 4403.955960440387, 291697.0, 291894.5405272981, 294353.0, 295706.0, 295904.0, 69143.3085669147, 69692.30307696859, 69725.65137174282, 69752.65123674349, 69758.0, 74721.0, 76640.0, 76667.61666191633, 76740.61629691816, 76750.23249767543, 18201.27194912189, 18335.541611459554, 18382.0, 18415.0, 18430.539236519195, 14048.297585120703, 14256.144631322153, 14265.714685706227, 14269.143851368952, 14396.928015359856, 21778.237761678265, 22039.779602204093, 22074.0, 22106.0, 22767.0, 8156.673733050611, 8275.255227029596, 8352.498850069016, 8410.957945210235, 8414.49513029208, 960.2653969713175, 1006.4866917871938, 1022.4325499347784, 1094.6715985204567, 1128.4865386249237, 27507.724922750916, 27529.0, 27533.0, 27808.86095569509, 28171.577426338623, 1011.3224139826334, 1041.5677493840124, 1065.1478816946412, 1109.8168802147716, 1132.750794825137, 14651.194184319966, 15220.619484512976, 17478.737818932725, 18339.30290011808, 18841.90579047096, 400382.0, 498180.0, 502374.0, 505837.0, 512289.0, 55143.0, 56295.71852140713, 56327.0, 56346.43653563494, 56381.43618563762, 1462.6343414146463, 1472.5508719840552, 1480.8148981377328, 1491.3512622009462, 1501.9849801502064, 29640.40719185561, 32336.83831580921, 32372.352552948338, 32508.512372314908, 33305.500417494244, 51183.48816511787, 51183.488165119365, 51448.48551514437, 51640.48359516357, 51995.2200716982, 312980.0, 318205.0, 320740.0, 321174.0, 321771.0, 35781.0, 36009.459858101625, 36208.45687314745, 36331.27337453183, 36492.81753591215, 48110.759446202544, 48799.5120048795, 48817.0, 48985.75507122442, 49158.75420622874, 39905.800470997456, 39922.401163983144, 40027.0, 40984.1803163941, 41141.177176455705, 39330.803345983084, 39704.20591588094, 40328.39507407333, 40902.386464202464, 41264.793676031426, 39620.801895990335, 40301.79849100736, 40416.98957526086, 40758.38862417007, 40850.79574602108, 34942.47586286157, 35437.64562354344, 36094.63905360913, 36210.09474763152, 36631.0, 27526.311842204104, 28200.576991345555, 28261.293467663472, 28277.0, 28322.575161373006], "unit": "score", "name": "ext.html", "value": 20310.73643207025}, {"lowerIsBetter": false, "replicates": [376.20432784660443, 378.31336124933244, 379.11287587046314, 387.370522900287, 388.52017758068797, 16383.18084095795, 16948.576285592866, 17401.303947842072, 17508.474745757616, 17520.561985950324, 17758.289668413247, 18038.458846234633, 18241.27034918605, 18286.817131828677, 18379.632407351844, 5521.889562208753, 5721.456461636138, 5771.365149833515, 5804.970975145139, 5810.651360918338, 5350.8394748157425, 5553.861153471155, 5567.081431563787, 5570.554355651559, 5649.23735295736, 5520.723963801814, 5523.502884740373, 5535.0, 5617.915731264035, 6404.103425520431, 6307.432331090201, 6316.873662526769, 6322.4942004639515, 6368.745250189987, 6373.521985851056, 5486.341639003305, 5649.689267090308, 5664.716764161775, 5686.601937864351, 5719.542436605062, 14302.499412520616, 14400.423983040666, 14420.639484012878, 14543.49097781583, 19934.30229941945, 2215.7784221577876, 2247.6179049561615, 2259.5254996450767, 2298.643710224918, 2419.63705444183, 10003.59985600575, 10329.173666106693, 10460.895391046068, 10666.626668066658, 10844.566217351297, 1937.806219378065, 1969.1729473621112, 2015.7077223802612, 2027.523531969986, 2048.1193086972594, 68356.6582167091, 68513.0, 68873.65563172151, 70634.0, 71790.2820971794, 10213.540390682438, 10626.787464250672, 10687.091597214168, 10705.46472676363, 10725.14198864089, 14916.955813093196, 14918.806495480336, 14992.625184370478, 15042.473513426978, 15072.698546029018, 8185.0, 8394.076651568323, 8414.200650938152, 8515.74452766418, 8549.0, 8265.752027439186, 8277.04813946392, 8332.375071869634, 8346.874796878052, 8514.659413623509, 4558.8632341029825, 4736.715797052119, 4823.758812059383, 4834.95165048345, 4892.0705066037335, 1922.5482011727233, 1947.8118347807826, 1960.1767257751778, 1963.1165975311167, 1980.2969945669367, 940.5532372123323, 944.4782430909488, 967.1585720423136, 998.730342807438, 1009.0414106598761, 17113.743293850603, 17952.281908723504, 18221.18004689792, 18792.812071879107, 19292.13185406632, 943.2783920300975, 990.7671697151163, 997.5311603546321, 1008.8587597736323, 1040.2354269611828, 10389.428581427943, 10511.1591072714, 10528.578856845794, 10567.0, 10612.734681633021, 428810.0, 436989.0, 437012.0, 437364.0, 451429.0, 70013.64993175103, 71313.6434317825, 71557.0, 78811.60594196993, 83537.0, 1053.7154968158554, 1079.983800242997, 1091.2906610702948, 1097.7584931315098, 1107.8615173103362, 15815.209239537748, 16091.517254482384, 16154.353825847305, 16351.264193111101, 16618.50144495667, 33332.1666958328, 34344.65655343515, 34782.65217347896, 35105.29789404249, 35423.82288088543, 40837.591624083376, 41265.79367103145, 41289.79355103205, 41527.792361038, 41918.58081419147, 8672.869906951275, 8714.172153645393, 8742.519161446182, 8942.50816205115, 9052.049534799015, 12252.142350035412, 12707.745845083231, 12856.871431285568, 12954.0, 13220.735585288432, 10974.670759877217, 11076.833847492455, 11095.16786241019, 11185.105191584491, 11324.37715925599, 7130.42956563484, 10668.199885008811, 11345.319280843176, 11416.82874756896, 11810.0, 11263.943680281545, 11276.210665253682, 11559.76880462403, 11572.537098516303, 11894.286342819458, 8611.224989750952, 8617.396782225434, 8638.481691098303, 8710.91289087101, 8842.646294148162, 10479.128602949093, 11260.605878794202, 11398.08815294791, 11447.427628618369, 11461.942690286494], "unit": "score", "name": "jquery.html", "value": 8786.374830275909}, {"lowerIsBetter": false, "replicates": [1560.297865960318, 1584.809822821261, 1683.6380178261672, 1784.741212524185, 1785.2501949181342, 7744.070711514619, 7806.219378062191, 7929.365650747941, 7966.522008679476, 8021.9598902005555, 8046.0, 8076.838463230732, 8129.146439623843, 8130.3902207334395, 8131.105578386373, 2383.1301574925155, 2398.3164798032562, 2416.5287768885073, 2421.055788242587, 2422.3701837522194, 2405.290439320405, 2422.697162854643, 2444.0712529238863, 2446.6819313489223, 2449.632555116738, 2359.587072262356, 2364.7635236476385, 2389.2712722619594, 2393.401649587603, 2396.0, 2340.9180678676335, 2349.048635302705, 2365.704286964138, 2368.6802281692007, 2385.666006759055, 2373.8694371809543, 2380.345405013618, 2386.5465561543424, 2387.928362149121, 2393.1265088242667, 8030.196980301981, 8078.676852925876, 8082.555459449728, 8084.0, 8084.595770211466, 4883.975580122112, 5036.420811606676, 5042.268871013683, 5049.848504544832, 5064.11378008847, 3163.130139211712, 3169.9841500792577, 3238.5627940228005, 3240.141362538929, 3259.6903294187014, 1013.3565186106802, 1031.6286136990677, 1035.1563475767225, 1062.9627963021335, 1068.4550879051662, 10626.14990800734, 10757.300775449648, 10797.784044319149, 10855.728606784814, 10900.291481053786, 4321.854708502186, 4448.844290449819, 4521.050579378368, 4524.819007239739, 4540.636749060067, 9680.322377433653, 9735.269854760922, 9770.413775173512, 9782.706518804447, 9808.509574521246, 5089.0, 5103.464136265713, 5105.7191854448365, 5116.513931176532, 5116.846494605168, 4096.856610018635, 4458.331250312479, 4519.5480451954545, 4554.111948170075, 4618.95381046192, 3825.617438256152, 3865.130345672201, 3905.258000979805, 3911.7261791674878, 3912.8239229234755, 1233.5127624588238, 1252.092233130991, 1264.607971528829, 1271.6121582917115, 1274.6176147156002, 1044.1907521670767, 1052.4790228836775, 1054.7679510507676, 1257.9119461637597, 1423.3737155651688, 7178.928210717826, 7245.203027666952, 7268.200497945222, 7290.708371665074, 7603.125640551408, 501.74411050363847, 502.0711683385707, 516.8010316028356, 521.0256819747021, 523.1995047577213, 5788.652680839163, 5874.882502350015, 5890.67601281925, 5903.26209223847, 5908.113782932509, 9073.77315567103, 9523.380980236401, 9534.856977145348, 9546.570404331822, 9568.61725530985, 9345.859812102824, 9393.060693930689, 9478.90521094794, 9483.525823708787, 9529.380590261611, 7308.488405811542, 7514.135874374408, 7514.211007844097, 7529.284717951786, 7531.171571127172, 7206.315400036988, 7214.96392518034, 7260.782176534713, 7277.9272207277245, 7289.5261807982315, 8370.121137280741, 8466.619002145042, 8513.0, 8537.445066070686, 8559.058503564727, 8560.657573696983, 8604.569771511524, 8761.605727742139, 8804.339674524308, 8830.072842351718, 7070.328318809705, 7134.32223938725, 7175.0, 7223.458240632079, 7270.818229544304, 7505.362044226302, 7541.509801862861, 7565.886511702219, 7592.0, 7622.9237707622215, 6869.690863911036, 7038.120234970629, 7049.259827718016, 7100.467464940253, 7143.571385716874, 6845.691943862438, 6911.75808846688, 6945.826354341182, 6966.338197871194, 6997.230304666585, 7158.391536719437, 7167.3549380556, 7206.89189662166, 7286.271372862671, 7307.3058059484265, 6638.535302528777, 6670.599764014175, 6708.798736037927, 6710.932890671031, 6743.66281685904, 6586.571872828251, 6696.0960270362875, 6742.0, 6769.593824370553, 6776.864462710817], "unit": "score", "name": "mootools.html", "value": 4546.837198437185}, {"lowerIsBetter": false, "replicates": [358.45514817477437, 375.85341716730466, 378.1548239684306, 380.8457574682253, 385.652912378859, 6280.842978925529, 6308.432241098306, 6327.114204011436, 6334.809955701337, 6481.31946145655, 6304.33804450533, 6352.047192921064, 6361.491080713543, 6403.135576697145, 6410.775622853201, 4738.597219236361, 4846.9515304846855, 4860.659753817235, 4861.829835955742, 4864.683795553296, 4868.780904859272, 4876.487968763282, 4876.731779752112, 4883.536064073925, 4892.730899800509, 4792.736399498026, 4836.782344794493, 4847.466778654345, 4848.248521479159, 4853.00513394755, 4841.927371089437, 4842.491538388454, 4847.1032858921035, 4856.5629093381585, 4872.366592343008, 4234.237837189305, 4240.533541310453, 4246.171996460692, 4249.043965107826, 4253.659707223445, 5934.109883517507, 6033.607815491979, 6036.366181550918, 6069.757209711606, 6078.908816367758, 5676.687782171979, 5716.371199168088, 5723.8282851514105, 5725.885482290372, 5730.9426905730825, 6717.361850624232, 6730.1923769147525, 6804.353586409283, 6807.047013418125, 6823.897641535381, 4736.052789442126, 4736.100140973204, 4738.2892566115015, 4742.146413645542, 4765.547273009059, 6924.896126558106, 7013.053237812881, 7055.259197784261, 7061.0, 7067.257937916496, 4687.273472611751, 4782.880427989328, 4784.425868895755, 4844.370231869905, 4853.4418541867435, 4878.902421951612, 4896.4858689837765, 4907.7300748458465, 4913.287573301851, 4922.310876477296, 5479.315085614298, 5653.547716182696, 5656.858578535487, 5661.943380566224, 5662.745176467069, 6765.255821859591, 6780.084688566981, 6780.118584583973, 6788.049673045777, 6805.013273075476, 1700.7023770840053, 1742.3204950069482, 1747.3098126240318, 1747.7291019891936, 1751.553353894774, 1145.255583870491, 1149.7642983188425, 1162.1400163878839, 1162.8895254950767, 1172.9912275443112, 6551.541392102602, 6569.507286953498, 6587.440067594212, 6610.636414997221, 6616.305287944697, 6949.687264073129, 6997.510174287751, 7003.6498175092065, 7012.614306213105, 7027.789166325018, 6606.438452731475, 6606.7026983785845, 6670.132882725312, 6680.732770689216, 6685.896827023486, 3765.1904840459433, 3810.2569998850513, 3814.504114465102, 3823.369144091194, 3824.1395685970433, 7099.751508697274, 7325.901114832818, 7336.119665640157, 7342.412606991428, 7361.705531778669, 7264.891026634605, 7285.089363829521, 7287.234840341794, 7292.635368231673, 7303.379212766974, 7217.0, 7276.854462910818, 7281.271872812782, 7283.490155689051, 7293.8905916411295, 6939.930600693929, 7064.32888875556, 7064.964675176591, 7090.964545177241, 7104.928950710427, 6987.930120698931, 6989.126359205099, 6996.510244283055, 7000.194977577644, 7029.0, 7233.602151881487, 7278.199398066315, 7294.270572942663, 7297.051383320135, 7359.0, 4848.854534363974, 4894.853154405374, 4897.314375987294, 4906.754662266801, 4915.8033678652455, 6965.442764578923, 7100.573965562083, 7116.822079447848, 7142.071530700976, 7147.749828755968, 6854.0404343390965, 6859.211190713132, 6883.8967415487805, 6886.621235832077, 6906.482013849082, 6837.111175547346, 6840.0, 6848.486363522856, 6862.176538815374, 6879.454601797367, 6662.56693314933, 6668.499862510234, 6705.8323541909895, 6717.328267173243, 6720.630365329954, 6795.116634837439, 6884.65576721172, 6909.723611055702, 6916.962455631696, 6921.653917304216, 6695.163104611924, 6714.0600315954825, 6729.226138994079, 6754.358335958076, 6757.831054223684], "unit": "score", "name": "prototype.html", "value": 5147.340651049601}, {"lowerIsBetter": false, "replicates": [759.6809340077167, 824.9175082491748, 880.4981160738378, 913.1690161952624, 915.6749353979337, 14566.0, 14708.411663533472, 14817.333220005099, 14843.703125937474, 14855.0, 14266.429342826275, 14342.354594043267, 14373.712525749479, 14378.49675261366, 14401.135931844097, 776.0493395590385, 914.3919293669735, 921.2491819167374, 941.5857022909897, 943.4292253186826, 913.0869130869131, 919.7240827751648, 920.2867777472479, 920.6869664314132, 922.4419226368051, 974.6686126716914, 977.1889331854544, 979.2655508368723, 980.5391466010964, 990.5542505872351, 969.9951500242489, 970.8009857979098, 976.897425770291, 977.5991843344194, 978.882534095906, 729.0667945030369, 729.5586170366905, 730.6675462664529, 732.3335764454374, 732.3774791427297, 13042.0, 13091.214527128403, 13105.934470327587, 13165.934170329087, 13171.934140329236, 14035.859641403558, 14224.644383890382, 14252.786208206886, 14283.428662853474, 14336.64158396038, 11125.332480051142, 11223.831642525369, 11255.493502792313, 11336.093112550976, 11385.259958102697, 3869.7097717671004, 3903.7072219583647, 3928.7053470989504, 3949.940750888739, 4008.318585840385, 48709.0, 48716.75641621805, 48787.26819097716, 48874.51125488735, 48916.26625600619, 10709.196810239264, 10856.674299771019, 11222.158338124511, 11283.54865805375, 11475.770484590428, 19360.225590976203, 19510.90244548768, 19563.80436195648, 19580.314688985818, 19643.508912277306, 8303.543305118277, 8347.582620868932, 8358.665653373919, 8503.61733721984, 8603.31173506118, 4750.881227969259, 4789.856304310876, 4841.394825646794, 4923.138450771173, 4928.975355123202, 3497.492863534824, 3557.4663800429626, 3562.5012498250267, 3603.387424137903, 3606.02637287936, 613.8219916224334, 627.2222444169289, 630.1146888621494, 636.8153235561728, 636.8312397214742, 541.339565729809, 637.8756142552251, 704.2112833626371, 706.9363757261871, 730.82825535999, 8079.353651707849, 8294.958525207336, 8346.343937390018, 8390.496570205807, 8426.0, 623.7504998000836, 727.9745208917662, 729.7591794707733, 730.8611363840853, 753.2542782645141, 3930.4890364252465, 3944.447777311179, 3970.285348637273, 4025.7383270087353, 4173.08192197716, 55724.72137639286, 55845.441545584836, 56311.0, 57151.714241428526, 57732.0, 49531.50468495269, 50624.0, 51270.487295127314, 51327.48672513227, 51709.482905170466, 46580.06839863252, 46634.06731865344, 46802.0, 46994.76502617465, 47540.0, 7942.523448593103, 8062.234087761653, 8161.306288965505, 8163.428560000743, 8275.668973241243, 36027.45958810672, 36037.27925441529, 36630.8168459156, 36822.63177368192, 37268.254634907695, 39855.601443985186, 40326.59673403228, 41044.58955410407, 43533.78233108814, 43555.12889742251, 11692.590759323382, 11771.52913883435, 11960.940195298968, 11965.222260553037, 11997.460114294703, 11987.160898737005, 12122.515099396278, 12792.552260670831, 13021.414036368196, 13744.587662370144, 12110.75778484443, 12273.324967126893, 12323.249464694642, 12414.379281036092, 12607.054470914902, 12263.855391730205, 12386.154839350378, 12387.673956262426, 12422.192557483735, 12842.357882106044, 10440.53017614194, 10508.316959397614, 10578.259521833397, 10624.096951759188, 11088.611898583511, 9432.952835236054, 9526.095020972996, 9549.283803714889, 9586.328956972944, 9602.711918642452, 10195.133413659922, 10311.793764124826, 10335.276530642783, 10342.741431464274, 10430.113440357654], "unit": "score", "name": "yui.html", "value": 6699.2050508254015}], "name": "dromaeo_css", "value": 7291.060664425956}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 110.0, 110.0, 123.0, 111.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [155.0, 137.0, 159.0, 165.0, 136.0, 161.0, 166.0, 128.0, 176.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 163.0, 161.0, 162.0, 162.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 76.0, 178.0, 76.0, 76.0, 74.0, 73.0, 166.0, 75.0], "unit": "score", "name": "audio-fft", "value": 94.2}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 137.0, 93.0, 92.0, 93.0, 142.0, 94.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 65.0, 57.0, 59.0, 56.0, 57.0, 62.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 83.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 84.5}, {"lowerIsBetter": true, "replicates": [78.0, 85.0, 78.0, 78.0, 78.0, 80.0, 78.0, 78.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 122.0, 115.0, 121.0, 114.0, 119.0, 116.0, 119.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.0}, {"lowerIsBetter": true, "replicates": [137.0, 150.0, 144.0, 144.0, 150.0, 143.0, 144.0, 143.0, 141.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 76.0, 65.0, 66.0, 65.0, 68.0, 65.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1536.5}]} 14:37:53 INFO - Return code: 0 14:37:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:37:53 ERROR - # TBPL SUCCESS # 14:37:53 INFO - Running post-action listener: _resource_record_post_action 14:37:53 INFO - Running post-run listener: _resource_record_post_run 14:37:54 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462716928; Read time: 12; Write time: 478372 14:37:54 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 243957760; Read time: 0; Write time: 362080 14:37:54 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218759168; Read time: 12; Write time: 116292 14:37:54 INFO - Running post-run listener: _upload_blobber_files 14:37:54 INFO - Blob upload gear active. 14:37:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:37:54 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:37:54 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:37:54 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:37:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:56 INFO - (blobuploader) - INFO - Done attempting. 14:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:57 INFO - (blobuploader) - INFO - Done attempting. 14:37:57 INFO - (blobuploader) - INFO - Iteration through files over. 14:37:57 INFO - Return code: 0 14:37:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:37:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:37:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e4c545b0a95367097a597ae68cabe089dde86dcc4761a266b2dd88702f08ae7262465193261deaf89c01faafc9786f8df730a8fb2485c9f31344a0c73397aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acb5e1c4ed740d5f55e49ffdb111a772eaa82ef8bdcef30859f6c1acfe1b56bc6ef3c19977d55c0f5044d0e339ad1cc623915facf45f612512a356dd20bfcce4"} 14:37:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:37:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:37:57 INFO - Contents: 14:37:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e4c545b0a95367097a597ae68cabe089dde86dcc4761a266b2dd88702f08ae7262465193261deaf89c01faafc9786f8df730a8fb2485c9f31344a0c73397aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acb5e1c4ed740d5f55e49ffdb111a772eaa82ef8bdcef30859f6c1acfe1b56bc6ef3c19977d55c0f5044d0e339ad1cc623915facf45f612512a356dd20bfcce4"} 14:37:57 INFO - Running post-run listener: copy_logs_to_upload_dir 14:37:57 INFO - Copying logs to upload dir... 14:37:57 INFO - mkdir: /builds/slave/test/build/upload/logs 14:37:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.670595 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-25 14:37:57.085031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:37:57.088482) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e4c545b0a95367097a597ae68cabe089dde86dcc4761a266b2dd88702f08ae7262465193261deaf89c01faafc9786f8df730a8fb2485c9f31344a0c73397aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acb5e1c4ed740d5f55e49ffdb111a772eaa82ef8bdcef30859f6c1acfe1b56bc6ef3c19977d55c0f5044d0e339ad1cc623915facf45f612512a356dd20bfcce4"} 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.011003 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e4c545b0a95367097a597ae68cabe089dde86dcc4761a266b2dd88702f08ae7262465193261deaf89c01faafc9786f8df730a8fb2485c9f31344a0c73397aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acb5e1c4ed740d5f55e49ffdb111a772eaa82ef8bdcef30859f6c1acfe1b56bc6ef3c19977d55c0f5044d0e339ad1cc623915facf45f612512a356dd20bfcce4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:37:57.113054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:37:57.113413) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461618436.914852-1969008188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:37:57.196031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:37:57.196378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:37:57.196687) ========= ========= Total master_lag: 0.26 =========