builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1468759376.74 results: success (0) buildid: 20160717030211 builduid: d2cab318a58a4c29a3aec4d50d71bba0 revision: 711963e8daa312ae06409f8ab5c06612cb0b8f7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.741873) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.742288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.742794) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.770726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.771018) ========= 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=7de08804244eb36560b44971000001c3-1468759346.882662-599020637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 05:42:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.1M=0s 2016-07-17 05:42:56 (44.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.914602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.914929) ========= 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=7de08804244eb36560b44971000001c3-1468759346.882662-599020637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014497 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.975997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:56.976333) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 711963e8daa312ae06409f8ab5c06612cb0b8f7b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 711963e8daa312ae06409f8ab5c06612cb0b8f7b --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=7de08804244eb36560b44971000001c3-1468759346.882662-599020637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 05:42:57,095 truncating revision to first 12 chars 2016-07-17 05:42:57,095 Setting DEBUG logging. 2016-07-17 05:42:57,095 attempt 1/10 2016-07-17 05:42:57,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/711963e8daa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 05:42:57,402 unpacking tar archive at: mozilla-central-711963e8daa3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:57.649415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:57.649723) ========= script_repo_revision: 711963e8daa312ae06409f8ab5c06612cb0b8f7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:57.650118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:57.650435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 05:42:57.661018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-17 05:42:57.661376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7de08804244eb36560b44971000001c3-1468759346.882662-599020637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:57 INFO - MultiFileLogger online at 20160717 05:42:57 in /builds/slave/test 05:42:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:42:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:57 INFO - {'append_to_log': False, 05:42:57 INFO - 'base_work_dir': '/builds/slave/test', 05:42:57 INFO - 'blob_upload_branch': 'Firefox', 05:42:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:57 INFO - 'branch': 'Firefox', 05:42:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:57 INFO - 'config_files': ('talos/linux_config.py',), 05:42:57 INFO - 'default_actions': ('clobber', 05:42:57 INFO - 'read-buildbot-config', 05:42:57 INFO - 'download-and-extract', 05:42:57 INFO - 'populate-webroot', 05:42:57 INFO - 'create-virtualenv', 05:42:57 INFO - 'install', 05:42:57 INFO - 'run-tests'), 05:42:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:57 INFO - 'download_minidump_stackwalk': True, 05:42:57 INFO - 'download_symbols': 'ondemand', 05:42:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:57 INFO - 'installer_path': 'installer.exe', 05:42:57 INFO - 'log_level': 'info', 05:42:57 INFO - 'log_name': 'talos', 05:42:57 INFO - 'log_to_console': True, 05:42:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:57 INFO - 'opt_config_files': (), 05:42:57 INFO - 'pip_index': False, 05:42:57 INFO - 'sps_profile': False, 05:42:57 INFO - 'sps_profile_interval': 0, 05:42:57 INFO - 'suite': 'dromaeojs-e10s', 05:42:57 INFO - 'system_bits': '32', 05:42:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:57 INFO - 'title': 'talos-linux64-ix-003', 05:42:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:57 INFO - 'use_talos_json': True, 05:42:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:57 INFO - 'work_dir': 'build'} 05:42:57 INFO - ##### 05:42:57 INFO - ##### Running clobber step. 05:42:57 INFO - ##### 05:42:57 INFO - Running pre-action listener: _resource_record_pre_action 05:42:57 INFO - Running main action method: clobber 05:42:57 INFO - rmtree: /builds/slave/test/build 05:42:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:58 INFO - Running post-action listener: _resource_record_post_action 05:42:58 INFO - ##### 05:42:58 INFO - ##### Finished clobber step (success) 05:42:58 INFO - ##### 05:42:58 INFO - ##### 05:42:58 INFO - ##### Running read-buildbot-config step. 05:42:58 INFO - ##### 05:42:58 INFO - Running pre-action listener: _resource_record_pre_action 05:42:58 INFO - Running main action method: read_buildbot_config 05:42:58 INFO - Using buildbot properties: 05:42:58 INFO - { 05:42:58 INFO - "project": "", 05:42:58 INFO - "product": "firefox", 05:42:58 INFO - "script_repo_revision": "production", 05:42:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:42:58 INFO - "repository": "", 05:42:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:42:58 INFO - "buildid": "20160717030211", 05:42:58 INFO - "stage_platform": "linux64-pgo", 05:42:58 INFO - "basedir": "/builds/slave/test", 05:42:58 INFO - "nightly_build": "True", 05:42:58 INFO - "buildnumber": 4, 05:42:58 INFO - "slavename": "talos-linux64-ix-003", 05:42:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:42:58 INFO - "platform": "ubuntu64_hw", 05:42:58 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:42:58 INFO - "branch": "mozilla-central", 05:42:58 INFO - "repo_path": "mozilla-central", 05:42:58 INFO - "revision": "711963e8daa312ae06409f8ab5c06612cb0b8f7b", 05:42:58 INFO - "pgo_build": "True", 05:42:58 INFO - "builduid": "d2cab318a58a4c29a3aec4d50d71bba0", 05:42:58 INFO - "slavebuilddir": "test" 05:42:58 INFO - } 05:42:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:42:58 INFO - Running post-action listener: _resource_record_post_action 05:42:58 INFO - ##### 05:42:58 INFO - ##### Finished read-buildbot-config step (success) 05:42:58 INFO - ##### 05:42:58 INFO - ##### 05:42:58 INFO - ##### Running download-and-extract step. 05:42:58 INFO - ##### 05:42:58 INFO - Running pre-action listener: _resource_record_pre_action 05:42:58 INFO - Running main action method: download_and_extract 05:42:58 INFO - mkdir: /builds/slave/test/build/tests 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:43:05 INFO - Downloaded 1361 bytes. 05:43:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:05 INFO - Using the following test package requirements: 05:43:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:43:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'jsshell-linux-x86_64.zip'], 05:43:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43: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')]} 05:43:05 INFO - https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:08 INFO - Downloaded 24334071 bytes. 05:43:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:43:09 INFO - Return code: 0 05:43:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:09 INFO - https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:12 INFO - Downloaded 24334071 bytes. 05:43:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:43:13 INFO - Return code: 0 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 INFO - https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:43:14 INFO - Downloaded 14403317 bytes. 05:43:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:43:14 INFO - Return code: 0 05:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:14 INFO - https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:43:16 INFO - Downloaded 60809702 bytes. 05:43:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:16 INFO - mkdir: /builds/slave/test/properties 05:43:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:16 INFO - Contents: 05:43:16 INFO - build_url:https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:16 INFO - Running post-action listener: _resource_record_post_action 05:43:16 INFO - Running post-action listener: set_extra_try_arguments 05:43:16 INFO - ##### 05:43:16 INFO - ##### Finished download-and-extract step (success) 05:43:16 INFO - ##### 05:43:16 INFO - ##### 05:43:16 INFO - ##### Running populate-webroot step. 05:43:16 INFO - ##### 05:43:16 INFO - Running pre-action listener: _resource_record_pre_action 05:43:16 INFO - Running main action method: populate_webroot 05:43:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:16 INFO - '--tppagecycles', 05:43:16 INFO - '7'], 05:43:16 INFO - 'tests': ['tsvgm']}}, 05:43:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['damp', 'tps']}, 05:43:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'tests': ['damp', 'tps']}, 05:43:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['dromaeo_dom']}, 05:43:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['basic_compositor_video']}, 05:43:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:43:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['a11yr', 05:43:16 INFO - 'ts_paint', 05:43:16 INFO - 'tpaint', 05:43:16 INFO - 'sessionrestore', 05:43:16 INFO - 'sessionrestore_no_auto_restore', 05:43:16 INFO - 'tabpaint']}, 05:43:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:16 INFO - 'ts_paint', 05:43:16 INFO - 'tpaint', 05:43:16 INFO - 'sessionrestore', 05:43:16 INFO - 'sessionrestore_no_auto_restore', 05:43:16 INFO - 'tabpaint']}, 05:43:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:43:16 INFO - 'ts_paint', 05:43:16 INFO - 'tpaint', 05:43:16 INFO - 'sessionrestore', 05:43:16 INFO - 'sessionrestore_no_auto_restore', 05:43:16 INFO - 'tabpaint']}, 05:43:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:43:16 INFO - 'ts_paint', 05:43:16 INFO - 'tpaint', 05:43:16 INFO - 'sessionrestore', 05:43:16 INFO - 'sessionrestore_no_auto_restore', 05:43:16 INFO - 'tabpaint']}, 05:43:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['a11yr', 05:43:16 INFO - 'ts_paint', 05:43:16 INFO - 'tpaint', 05:43:16 INFO - 'sessionrestore', 05:43:16 INFO - 'sessionrestore_no_auto_restore', 05:43:16 INFO - 'tabpaint']}, 05:43:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['a11yr', 05:43:16 INFO - 'ts_paint', 05:43:16 INFO - 'tpaint', 05:43:16 INFO - 'sessionrestore', 05:43:16 INFO - 'sessionrestore_no_auto_restore', 05:43:16 INFO - 'tabpaint']}, 05:43:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['tsvgx', 05:43:16 INFO - 'tsvgr_opacity', 05:43:16 INFO - 'tart', 05:43:16 INFO - 'tscrollx', 05:43:16 INFO - 'cart']}, 05:43:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:16 INFO - 'tsvgr_opacity', 05:43:16 INFO - 'tart', 05:43:16 INFO - 'tscrollx', 05:43:16 INFO - 'cart']}, 05:43:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'talos_options': ['--disable-e10s'], 05:43:16 INFO - 'tests': ['tp5o']}, 05:43:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'tests': ['tp5o']}, 05:43:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'talos_options': ['--disable-e10s', 05:43:16 INFO - '--xperf_path', 05:43:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:16 INFO - 'tests': ['tp5n']}, 05:43:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:16 INFO - 'talos_options': ['--xperf_path', 05:43:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:16 INFO - 'tests': ['tp5n']}}, 05:43:16 INFO - 'talos.zip': {'path': '', 05:43:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:16 INFO - Running post-action listener: _resource_record_post_action 05:43:16 INFO - ##### 05:43:16 INFO - ##### Finished populate-webroot step (success) 05:43:16 INFO - ##### 05:43:16 INFO - ##### 05:43:16 INFO - ##### Running create-virtualenv step. 05:43:16 INFO - ##### 05:43:16 INFO - Running pre-action listener: _resource_record_pre_action 05:43:16 INFO - Running main action method: create_virtualenv 05:43:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:16 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 05:43:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:43:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:17 INFO - Using real prefix '/usr' 05:43:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:19 INFO - Installing pip.................done. 05:43:19 INFO - Return code: 0 05:43:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:19 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')]} 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:19 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')]} 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:19 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 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:19 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 05:43:19 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 05:43:19 INFO - Using env: {'DISPLAY': ':0', 05:43:19 INFO - 'HOME': '/home/cltbld', 05:43:19 INFO - 'LANG': 'en_US.UTF-8', 05:43:19 INFO - 'LANGUAGE': 'en_US:en', 05:43:19 INFO - 'LOGNAME': 'cltbld', 05:43:19 INFO - 'MAIL': '/var/mail/cltbld', 05:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:19 INFO - 'MOZ_NO_REMOTE': '1', 05:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:19 INFO - 'NO_EM_RESTART': '1', 05:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:19 INFO - 'PWD': '/builds/slave/test', 05:43:19 INFO - 'SHELL': '/bin/bash', 05:43:19 INFO - 'SHLVL': '1', 05:43:19 INFO - 'TERM': 'linux', 05:43:19 INFO - 'TMOUT': '86400', 05:43:19 INFO - 'USER': 'cltbld', 05:43:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:19 INFO - '_': '/tools/buildbot/bin/python'} 05:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:19 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 05:43:19 INFO - Cleaning up... 05:43:19 INFO - Return code: 0 05:43:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:43:19 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')]} 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:19 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')]} 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:19 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:19 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>=3.1.1'] in /builds/slave/test/build 05:43:19 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>=3.1.1 05:43:19 INFO - Using env: {'DISPLAY': ':0', 05:43:19 INFO - 'HOME': '/home/cltbld', 05:43:19 INFO - 'LANG': 'en_US.UTF-8', 05:43:19 INFO - 'LANGUAGE': 'en_US:en', 05:43:19 INFO - 'LOGNAME': 'cltbld', 05:43:19 INFO - 'MAIL': '/var/mail/cltbld', 05:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:19 INFO - 'MOZ_NO_REMOTE': '1', 05:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:19 INFO - 'NO_EM_RESTART': '1', 05:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:19 INFO - 'PWD': '/builds/slave/test', 05:43:19 INFO - 'SHELL': '/bin/bash', 05:43:19 INFO - 'SHLVL': '1', 05:43:19 INFO - 'TERM': 'linux', 05:43:19 INFO - 'TMOUT': '86400', 05:43:19 INFO - 'USER': 'cltbld', 05:43:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:19 INFO - '_': '/tools/buildbot/bin/python'} 05:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:20 INFO - Downloading/unpacking psutil>=3.1.1 05:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:22 INFO - Installing collected packages: psutil 05:43:22 INFO - Running setup.py install for psutil 05:43:22 INFO - building 'psutil._psutil_linux' extension 05:43:22 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 05:43:22 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 05:43:22 INFO - building 'psutil._psutil_posix' extension 05:43:22 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 05:43:22 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 05:43:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:22 INFO - Successfully installed psutil 05:43:22 INFO - Cleaning up... 05:43:22 INFO - Return code: 0 05:43:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:43:22 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')]} 05:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:22 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')]} 05:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:22 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:22 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.3'] in /builds/slave/test/build 05:43:22 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.3 05:43:22 INFO - Using env: {'DISPLAY': ':0', 05:43:22 INFO - 'HOME': '/home/cltbld', 05:43:22 INFO - 'LANG': 'en_US.UTF-8', 05:43:22 INFO - 'LANGUAGE': 'en_US:en', 05:43:22 INFO - 'LOGNAME': 'cltbld', 05:43:22 INFO - 'MAIL': '/var/mail/cltbld', 05:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:22 INFO - 'MOZ_NO_REMOTE': '1', 05:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:22 INFO - 'NO_EM_RESTART': '1', 05:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:22 INFO - 'PWD': '/builds/slave/test', 05:43:22 INFO - 'SHELL': '/bin/bash', 05:43:22 INFO - 'SHLVL': '1', 05:43:22 INFO - 'TERM': 'linux', 05:43:22 INFO - 'TMOUT': '86400', 05:43:22 INFO - 'USER': 'cltbld', 05:43:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:22 INFO - '_': '/tools/buildbot/bin/python'} 05:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:43:22 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 05:43:22 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 05:43:22 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 05:43:22 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 05:43:22 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 05:43:22 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 05:43:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:43:24 INFO - Installing collected packages: mozsystemmonitor 05:43:24 INFO - Running setup.py install for mozsystemmonitor 05:43:24 INFO - Successfully installed mozsystemmonitor 05:43:24 INFO - Cleaning up... 05:43:24 INFO - Return code: 0 05:43:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:43:24 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')]} 05:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:24 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')]} 05:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:24 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:24 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==2.5.1'] in /builds/slave/test/build 05:43:24 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==2.5.1 05:43:24 INFO - Using env: {'DISPLAY': ':0', 05:43:24 INFO - 'HOME': '/home/cltbld', 05:43:24 INFO - 'LANG': 'en_US.UTF-8', 05:43:24 INFO - 'LANGUAGE': 'en_US:en', 05:43:24 INFO - 'LOGNAME': 'cltbld', 05:43:24 INFO - 'MAIL': '/var/mail/cltbld', 05:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:24 INFO - 'MOZ_NO_REMOTE': '1', 05:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:24 INFO - 'NO_EM_RESTART': '1', 05:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:24 INFO - 'PWD': '/builds/slave/test', 05:43:24 INFO - 'SHELL': '/bin/bash', 05:43:24 INFO - 'SHLVL': '1', 05:43:24 INFO - 'TERM': 'linux', 05:43:24 INFO - 'TMOUT': '86400', 05:43:24 INFO - 'USER': 'cltbld', 05:43:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:24 INFO - '_': '/tools/buildbot/bin/python'} 05:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:43:26 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 05:43:26 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 05:43:26 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 05:43:26 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 05:43:26 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 05:43:26 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 05:43:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:27 INFO - warning: no files found matching '*.txt' 05:43:27 INFO - no previously-included directories found matching 'build' 05:43:27 INFO - no previously-included directories found matching 'dist' 05:43:27 INFO - no previously-included directories found matching '.git*' 05:43:27 INFO - Installing collected packages: jsonschema, functools32 05:43:27 INFO - Running setup.py install for functools32 05:43:27 INFO - warning: no files found matching '*.txt' 05:43:27 INFO - no previously-included directories found matching 'build' 05:43:27 INFO - no previously-included directories found matching 'dist' 05:43:27 INFO - no previously-included directories found matching '.git*' 05:43:27 INFO - Successfully installed jsonschema functools32 05:43:27 INFO - Cleaning up... 05:43:27 INFO - Return code: 0 05:43:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43:27 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')]} 05:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:27 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')]} 05:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:27 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 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:27 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 05:43:27 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 05:43:27 INFO - Using env: {'DISPLAY': ':0', 05:43:27 INFO - 'HOME': '/home/cltbld', 05:43:27 INFO - 'LANG': 'en_US.UTF-8', 05:43:27 INFO - 'LANGUAGE': 'en_US:en', 05:43:27 INFO - 'LOGNAME': 'cltbld', 05:43:27 INFO - 'MAIL': '/var/mail/cltbld', 05:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:27 INFO - 'MOZ_NO_REMOTE': '1', 05:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:27 INFO - 'NO_EM_RESTART': '1', 05:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:27 INFO - 'PWD': '/builds/slave/test', 05:43:27 INFO - 'SHELL': '/bin/bash', 05:43:27 INFO - 'SHLVL': '1', 05:43:27 INFO - 'TERM': 'linux', 05:43:27 INFO - 'TMOUT': '86400', 05:43:27 INFO - 'USER': 'cltbld', 05:43:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:27 INFO - '_': '/tools/buildbot/bin/python'} 05:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:29 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 05:43:29 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 05:43:29 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 05:43:29 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 05:43:29 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 05:43:29 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 05:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:30 INFO - Downloading docopt-0.6.1.tar.gz 05:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:30 INFO - Running setup.py install for blobuploader 05:43:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:30 INFO - Running setup.py install for requests 05:43:30 INFO - Running setup.py install for docopt 05:43:30 INFO - Successfully installed blobuploader requests docopt 05:43:30 INFO - Cleaning up... 05:43:30 INFO - Return code: 0 05:43:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:30 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')]} 05:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:30 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')]} 05:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:30 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 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:30 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 05:43:30 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 05:43:30 INFO - Using env: {'DISPLAY': ':0', 05:43:30 INFO - 'HOME': '/home/cltbld', 05:43:30 INFO - 'LANG': 'en_US.UTF-8', 05:43:30 INFO - 'LANGUAGE': 'en_US:en', 05:43:30 INFO - 'LOGNAME': 'cltbld', 05:43:30 INFO - 'MAIL': '/var/mail/cltbld', 05:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:30 INFO - 'MOZ_NO_REMOTE': '1', 05:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:30 INFO - 'NO_EM_RESTART': '1', 05:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:30 INFO - 'PWD': '/builds/slave/test', 05:43:30 INFO - 'SHELL': '/bin/bash', 05:43:30 INFO - 'SHLVL': '1', 05:43:30 INFO - 'TERM': 'linux', 05:43:30 INFO - 'TMOUT': '86400', 05:43:30 INFO - 'USER': 'cltbld', 05:43:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:30 INFO - '_': '/tools/buildbot/bin/python'} 05:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:31 INFO - Running setup.py (path:/tmp/pip-jm4hEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:31 INFO - Running setup.py (path:/tmp/pip-rccNub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:31 INFO - Running setup.py (path:/tmp/pip-6Iy5lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:31 INFO - Running setup.py (path:/tmp/pip-3wBj0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:31 INFO - Running setup.py (path:/tmp/pip-OwSrpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:31 INFO - Running setup.py (path:/tmp/pip-poxhMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:31 INFO - Running setup.py (path:/tmp/pip-qFeQvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:31 INFO - Running setup.py (path:/tmp/pip-XqMoW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:31 INFO - Running setup.py (path:/tmp/pip-W1hk8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:31 INFO - Running setup.py (path:/tmp/pip-xumE3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:31 INFO - Running setup.py (path:/tmp/pip-1REEes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:31 INFO - Running setup.py (path:/tmp/pip-5EFnHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:32 INFO - Running setup.py (path:/tmp/pip-jLC5Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:32 INFO - Running setup.py (path:/tmp/pip-6Vm1Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:32 INFO - Running setup.py (path:/tmp/pip-30UhA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:32 INFO - Running setup.py (path:/tmp/pip-1pGPVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:32 INFO - Running setup.py (path:/tmp/pip-rxTMtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:32 INFO - Running setup.py install for manifestparser 05:43:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:32 INFO - Running setup.py install for mozcrash 05:43:32 INFO - Running setup.py install for mozdebug 05:43:32 INFO - Running setup.py install for mozdevice 05:43:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:43:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:32 INFO - Running setup.py install for mozfile 05:43:32 INFO - Running setup.py install for mozhttpd 05:43:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Running setup.py install for mozinfo 05:43:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Running setup.py install for mozInstall 05:43:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Running setup.py install for mozleak 05:43:33 INFO - Running setup.py install for mozlog 05:43:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Running setup.py install for moznetwork 05:43:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Running setup.py install for mozprocess 05:43:33 INFO - Running setup.py install for mozprofile 05:43:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Running setup.py install for mozrunner 05:43:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:33 INFO - Running setup.py install for mozscreenshot 05:43:33 INFO - Running setup.py install for moztest 05:43:34 INFO - Running setup.py install for mozversion 05:43:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:34 INFO - Cleaning up... 05:43:34 INFO - Return code: 0 05:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:34 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')]} 05:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:34 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')]} 05:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:34 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 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:34 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 05:43:34 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 05:43:34 INFO - Using env: {'DISPLAY': ':0', 05:43:34 INFO - 'HOME': '/home/cltbld', 05:43:34 INFO - 'LANG': 'en_US.UTF-8', 05:43:34 INFO - 'LANGUAGE': 'en_US:en', 05:43:34 INFO - 'LOGNAME': 'cltbld', 05:43:34 INFO - 'MAIL': '/var/mail/cltbld', 05:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:34 INFO - 'MOZ_NO_REMOTE': '1', 05:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:34 INFO - 'NO_EM_RESTART': '1', 05:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:34 INFO - 'PWD': '/builds/slave/test', 05:43:34 INFO - 'SHELL': '/bin/bash', 05:43:34 INFO - 'SHLVL': '1', 05:43:34 INFO - 'TERM': 'linux', 05:43:34 INFO - 'TMOUT': '86400', 05:43:34 INFO - 'USER': 'cltbld', 05:43:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:34 INFO - '_': '/tools/buildbot/bin/python'} 05:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:34 INFO - Running setup.py (path:/tmp/pip-UASrb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:34 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)) 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:34 INFO - Running setup.py (path:/tmp/pip-O4Rxv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:34 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)) 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:34 INFO - Running setup.py (path:/tmp/pip-Rj6xrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:34 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)) 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:34 INFO - Running setup.py (path:/tmp/pip-awtM4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:34 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)) 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:34 INFO - Running setup.py (path:/tmp/pip-uD8By3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:34 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)) 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:34 INFO - Running setup.py (path:/tmp/pip-bZ6_WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:34 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)) 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:34 INFO - Running setup.py (path:/tmp/pip-fj2qMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:34 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)) 05:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:34 INFO - Running setup.py (path:/tmp/pip-LNbSD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:35 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:35 INFO - Running setup.py (path:/tmp/pip-imDgGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:35 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:35 INFO - Running setup.py (path:/tmp/pip-dVRSBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:35 INFO - Running setup.py (path:/tmp/pip-Fx5E0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:35 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:35 INFO - Running setup.py (path:/tmp/pip-JXB6P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:35 INFO - Running setup.py (path:/tmp/pip-y4Cfgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:35 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:35 INFO - Running setup.py (path:/tmp/pip-l60jZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:35 INFO - Running setup.py (path:/tmp/pip-al30tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:35 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:35 INFO - Running setup.py (path:/tmp/pip-Rk0otN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:35 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)) 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:35 INFO - Running setup.py (path:/tmp/pip-4Q5g13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:35 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)) 05:43:35 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)) 05:43:35 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)) 05:43:35 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)) 05:43:35 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)) 05:43:35 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)) 05:43:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:35 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 05:43:35 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 05:43:35 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 05:43:35 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 05:43:35 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 05:43:35 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 05:43:37 INFO - Downloading blessings-1.6.tar.gz 05:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:37 INFO - Installing collected packages: blessings 05:43:37 INFO - Running setup.py install for blessings 05:43:37 INFO - Successfully installed blessings 05:43:37 INFO - Cleaning up... 05:43:37 INFO - Return code: 0 05:43:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:38 INFO - Reading from file tmpfile_stdout 05:43:38 INFO - Current package versions: 05:43:38 INFO - argparse == 1.2.1 05:43:38 INFO - blessings == 1.6 05:43:38 INFO - blobuploader == 1.2.4 05:43:38 INFO - docopt == 0.6.1 05:43:38 INFO - functools32 == 3.2.3-2 05:43:38 INFO - jsonschema == 2.5.1 05:43:38 INFO - manifestparser == 1.1 05:43:38 INFO - mozInstall == 1.12 05:43:38 INFO - mozcrash == 0.17 05:43:38 INFO - mozdebug == 0.1 05:43:38 INFO - mozdevice == 0.48 05:43:38 INFO - mozfile == 1.2 05:43:38 INFO - mozhttpd == 0.7 05:43:38 INFO - mozinfo == 0.9 05:43:38 INFO - mozleak == 0.1 05:43:38 INFO - mozlog == 3.2 05:43:38 INFO - moznetwork == 0.27 05:43:38 INFO - mozprocess == 0.23 05:43:38 INFO - mozprofile == 0.28 05:43:38 INFO - mozrunner == 6.12 05:43:38 INFO - mozscreenshot == 0.1 05:43:38 INFO - mozsystemmonitor == 0.3 05:43:38 INFO - moztest == 0.7 05:43:38 INFO - mozversion == 1.4 05:43:38 INFO - psutil == 3.1.1 05:43:38 INFO - requests == 1.2.3 05:43:38 INFO - wsgiref == 0.1.2 05:43:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:38 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 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:38 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 05:43:38 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 05:43:38 INFO - Using env: {'DISPLAY': ':0', 05:43:38 INFO - 'HOME': '/home/cltbld', 05:43:38 INFO - 'LANG': 'en_US.UTF-8', 05:43:38 INFO - 'LANGUAGE': 'en_US:en', 05:43:38 INFO - 'LOGNAME': 'cltbld', 05:43:38 INFO - 'MAIL': '/var/mail/cltbld', 05:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:38 INFO - 'MOZ_NO_REMOTE': '1', 05:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:38 INFO - 'NO_EM_RESTART': '1', 05:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:38 INFO - 'PWD': '/builds/slave/test', 05:43:38 INFO - 'SHELL': '/bin/bash', 05:43:38 INFO - 'SHLVL': '1', 05:43:38 INFO - 'TERM': 'linux', 05:43:38 INFO - 'TMOUT': '86400', 05:43:38 INFO - 'USER': 'cltbld', 05:43:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:38 INFO - '_': '/tools/buildbot/bin/python'} 05:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 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)) 05:43:38 INFO - Cleaning up... 05:43:38 INFO - Return code: 0 05:43:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:38 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 0x24a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, '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': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', '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 05:43:38 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 05:43:38 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 05:43:38 INFO - Using env: {'DISPLAY': ':0', 05:43:38 INFO - 'HOME': '/home/cltbld', 05:43:38 INFO - 'LANG': 'en_US.UTF-8', 05:43:38 INFO - 'LANGUAGE': 'en_US:en', 05:43:38 INFO - 'LOGNAME': 'cltbld', 05:43:38 INFO - 'MAIL': '/var/mail/cltbld', 05:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:38 INFO - 'MOZ_NO_REMOTE': '1', 05:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:38 INFO - 'NO_EM_RESTART': '1', 05:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:38 INFO - 'PWD': '/builds/slave/test', 05:43:38 INFO - 'SHELL': '/bin/bash', 05:43:38 INFO - 'SHLVL': '1', 05:43:38 INFO - 'TERM': 'linux', 05:43:38 INFO - 'TMOUT': '86400', 05:43:38 INFO - 'USER': 'cltbld', 05:43:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:38 INFO - '_': '/tools/buildbot/bin/python'} 05:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:43:38 INFO - Cleaning up... 05:43:38 INFO - Return code: 0 05:43:38 INFO - Running post-action listener: _resource_record_post_action 05:43:38 INFO - Running post-action listener: _start_resource_monitoring 05:43:38 INFO - Starting resource monitoring. 05:43:38 INFO - ##### 05:43:38 INFO - ##### Finished create-virtualenv step (success) 05:43:38 INFO - ##### 05:43:38 INFO - ##### 05:43:38 INFO - ##### Running install step. 05:43:38 INFO - ##### 05:43:38 INFO - Running pre-action listener: _resource_record_pre_action 05:43:38 INFO - Running main action method: install 05:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:38 INFO - Reading from file tmpfile_stdout 05:43:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:38 INFO - Reading from file tmpfile_stdout 05:43:38 INFO - Output received: 05:43:38 INFO - Usage: mozinstall [options] installer 05:43:38 INFO - Options: 05:43:38 INFO - -h, --help show this help message and exit 05:43:38 INFO - -d DEST, --destination=DEST 05:43:38 INFO - Directory to install application into. [default: 05:43:38 INFO - "/builds/slave/test"] 05:43:38 INFO - --app=APP Application being installed. [default: firefox] 05:43:38 INFO - mkdir: /builds/slave/test/build/application 05:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:43:56 INFO - Reading from file tmpfile_stdout 05:43:56 INFO - Output received: 05:43:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:43:56 INFO - Running post-action listener: _resource_record_post_action 05:43:56 INFO - ##### 05:43:56 INFO - ##### Finished install step (success) 05:43:56 INFO - ##### 05:43:56 INFO - ##### 05:43:56 INFO - ##### Running run-tests step. 05:43:56 INFO - ##### 05:43:56 INFO - Running pre-action listener: _resource_record_pre_action 05:43:56 INFO - Running main action method: run_tests 05:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:43:56 INFO - Python 2.7.3 05:43:56 INFO - Return code: 0 05:43:56 INFO - grabbing minidump binary from tooltool 05:43:56 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')]} 05:43:56 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27603b0>, '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 0x27612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2761740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:43:56 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 05:43:56 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 05:43:56 INFO - Calling ['/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'] with output_timeout 600 05:43:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:56 INFO - Return code: 0 05:43:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:43:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:43:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:43:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:43:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 05:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 05:43:56 INFO - Using env: {'DISPLAY': ':0', 05:43:56 INFO - 'HOME': '/home/cltbld', 05:43:56 INFO - 'LANG': 'en_US.UTF-8', 05:43:56 INFO - 'LANGUAGE': 'en_US:en', 05:43:56 INFO - 'LOGNAME': 'cltbld', 05:43:56 INFO - 'MAIL': '/var/mail/cltbld', 05:43:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:43:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:56 INFO - 'MOZ_NO_REMOTE': '1', 05:43:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:56 INFO - 'NO_EM_RESTART': '1', 05:43:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:56 INFO - 'PWD': '/builds/slave/test', 05:43:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:43:56 INFO - 'SHELL': '/bin/bash', 05:43:56 INFO - 'SHLVL': '1', 05:43:56 INFO - 'TERM': 'linux', 05:43:56 INFO - 'TMOUT': '86400', 05:43:56 INFO - 'USER': 'cltbld', 05:43:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468759346.882662-599020637', 05:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:56 INFO - '_': '/tools/buildbot/bin/python'} 05:43:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 05:43:56 INFO - mozversion application_buildid: 20160717030211 05:43:56 INFO - mozversion application_changeset: 711963e8daa312ae06409f8ab5c06612cb0b8f7b 05:43:56 INFO - mozversion application_display_name: Nightly 05:43:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:56 INFO - mozversion application_name: Firefox 05:43:56 INFO - mozversion application_remotingname: firefox 05:43:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:43:56 INFO - mozversion application_vendor: Mozilla 05:43:56 INFO - mozversion application_version: 50.0a1 05:43:56 INFO - mozversion platform_buildid: 20160717030211 05:43:56 INFO - mozversion platform_changeset: 711963e8daa312ae06409f8ab5c06612cb0b8f7b 05:43:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:43:56 INFO - mozversion platform_version: 50.0a1 05:43:56 INFO - using testdate: 1468759436 05:43:56 INFO - actual date: 1468759436 05:43:56 INFO - starting webserver on 'localhost:45006' 05:43:56 INFO - SUITE-START | Running 2 tests 05:43:56 INFO - TEST-START | dromaeo_css 05:43:56 INFO - operating with platform_type : linux_ 05:43:56 INFO - Initialising browser for dromaeo_css test... 05:43:56 INFO - TEST-INFO | started process 14315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqHLxi/profile http://localhost:45006/getInfo.html) 05:43:59 INFO - PROCESS | 14315 | JavaScript error: , line 0: uncaught exception: undefined 05:44:00 INFO - PROCESS | 14315 | __metrics Screen width/height:1600/1200 05:44:00 INFO - PROCESS | 14315 | colorDepth:24 05:44:00 INFO - PROCESS | 14315 | Browser inner width/height: 1024/697 05:44:00 INFO - PROCESS | 14315 | __metrics 05:44:01 ERROR - PROCESS | 14315 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:44:02 INFO - TEST-INFO | 14315: exit 0 05:44:02 INFO - Browser initialized. 05:44:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:02 INFO - TEST-INFO | started process 14435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqHLxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:14 INFO - PROCESS | 14435 | RSS: Main: 168017920 05:44:14 INFO - PROCESS | 14435 | 05:45:03 INFO - PROCESS | 14435 | 1468759503808 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] 05:47:12 INFO - PROCESS | 14435 | Cycle 1(1): loaded http://localhost:45006/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45006/tests/dromaeo/cssquery-ext.html) 05:47:13 INFO - PROCESS | 14435 | RSS: Main: 172691456 05:47:13 INFO - PROCESS | 14435 | 05:50:15 INFO - PROCESS | 14435 | Cycle 1(1): loaded http://localhost:45006/tests/dromaeo/cssquery-ext.html (next: http://localhost:45006/tests/dromaeo/cssquery-jquery.html) 05:50:16 INFO - PROCESS | 14435 | RSS: Main: 168751104 05:50:16 INFO - PROCESS | 14435 | 05:53:18 INFO - PROCESS | 14435 | Cycle 1(1): loaded http://localhost:45006/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45006/tests/dromaeo/cssquery-mootools.html) 05:53:18 INFO - PROCESS | 14435 | RSS: Main: 173039616 05:53:18 INFO - PROCESS | 14435 | 05:56:20 INFO - PROCESS | 14435 | Cycle 1(1): loaded http://localhost:45006/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45006/tests/dromaeo/cssquery-prototype.html) 05:56:21 INFO - PROCESS | 14435 | RSS: Main: 167129088 05:56:21 INFO - PROCESS | 14435 | 05:59:23 INFO - PROCESS | 14435 | Cycle 1(1): loaded http://localhost:45006/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45006/tests/dromaeo/cssquery-yui.html) 05:59:24 INFO - PROCESS | 14435 | RSS: Main: 169222144 05:59:24 INFO - PROCESS | 14435 | 06:02:26 INFO - PROCESS | 14435 | Cycle 1(1): loaded http://localhost:45006/tests/dromaeo/cssquery-yui.html (next: http://localhost:45006/tests/dromaeo/cssquery-dojo.html) 06:02:27 INFO - PROCESS | 14435 | RSS: Main: 172163072 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | __start_tp_report 06:02:27 INFO - PROCESS | 14435 | _x_x_mozilla_page_load 06:02:27 INFO - PROCESS | 14435 | _x_x_mozilla_page_load_details 06:02:27 INFO - PROCESS | 14435 | |i|pagename|runs| 06:02:27 INFO - PROCESS | 14435 | |0;dojo.html;3125.4217969675606;3126.7967582107176;3160.8419579021042;3163.873445062197;3171.1437911763824;5454.890902181954;5455.8363249102495;5457.918131228034;5488.067028605136;5507.228987941687;5361.731913404334;5513.062779327514;5609.859753506164;5622.212890195366;5680.517156041731;5013.699178049311;5017.6236782241385;5045.738565358661;5134.204198349262;5153.716545589991;5069.771860266297;5163.948360516384;5202.271681964528;5202.947970520284;5204.32343795306;4954.232094025432;4985.426675932242;5054;5085;5101.795928162869;4944.53026962438;4979.850604481871;5021.748912554358;5055.823046193365;5087.821926232564;4967.254911763228;4972.776225069881;4990.65065445419;4993.675411098303;5022.045811295842;5402.945970540283;5543.445655434464;5552.222688823568;5574.498295153456;5615.410381909882;5903.3801450847905;5961.940380596226;5967.16459695643;5978.312494063195;5992.4307190817235;6012.038073908154;6015.27816661999;6018.488428483584;6022.096685497167;6031;5439.184122381635;5515.420880807537;5601.859953501154;5606.046972014768;5619.915701264485;6064;6119.265688117454;6148.077788331697;6153.84615384619;6159.96920015406;5799.2750906136735;5834;5836.153757705109;5875.882482350415;5904.852378690567;5802.796902108406;5834.504067154255;5853.414658534112;5898.705064746746;5923.111533269957;5702.515286200636;5894.498967587718;5897.967855625248;5935.643861368331;5953.3451320354725;5903.704814759245;5936.168936348915;5948.67282299469;5953.910691339634;5960.612560183661;4387.714798538085;4456.398386217819;4501.3248012797685;4569.497355290915;4569.520200378979;4020.2160578686876;4024.839006439768;4030.4558884550797;4043.0700938783657;4072.6741860651077;5685.090385538377;5690;5722.77108915647;5723.255976723;5731.140328950691;5812.157237200582;5834;5843.2695913010875;5891.410858914074;5961.7615295387695;5571.192177134293;5649.858753531113;5670.518005969457;5676.460736230051;5680.517156041783;5078.162103252996;5079.568236699922;5085.364329458817;5105.361829771278;5162.380514338229;6039.577229593974;6127.92262824669;6174.228221472316;6185.969070154621;6233.594816336924;5959.404059594006;5963.463288304073;5971.373005834499;5978.358164422217;6024;6113.14415981754;6202.131701561875;6211.3478084802255;6218.22272215973;6224.875502490016;5802.071668533014;5824.097264923944;5830.591858569859;5869.501092407193;5924.674142922181;5901.645901245939;5940.702964851654;5984.820455386345;5993.250843644544;6004.339522652592;5718.342390625131;5857.384974577608;5864.648121112747;5867.237259156454;5870.207521984477;5627.409122042291;5630.549556035589;5644.943550564606;5839;5882.382349853204;5763.625364351304;5827.825165245049;5841.824745257649;5849.385814489588;5853.151293062397;5809.680467574324;5937.643741375531;5957.3744756799915;5957.642541447527;5976.193213916065;5723.542116630576;5759.337676167294;5759.740811663569;5783.595148339576;5811.157382179645 06:02:27 INFO - PROCESS | 14435 | |1;ext.html;571.9828405147845;597.3936454498685;613.1538476901875;626.3110578363801;654.1169421281268;39083.218335633304;43657.34513982293;43749.562504374946;43875.34186987194;43888.34167487482;44280;44756.10487790242;44796;45011;45162;8859.379843410963;9018;9020.323475739313;9021;9029.322800789967;8915.153060459246;8988.325875559327;8988.46069235848;8996.055414181516;8997;9037.096290370977;9080.228180604656;9115.453072815619;9136.177744003038;9149;8959.507227102507;8990.056044115372;9036.728898133066;9040.773980650503;9041.457512549268;8906.064863189402;8957.14907083826;9002.549872506348;9010.909890901072;9019.639214431414;33095;42579.14841703149;43002.78498607518;43058.13883722308;43076;3405.8249903783153;3449.068751437098;3521.7358698097487;3585.0678823506078;3638;28676.13971580856;28808.279793005135;28840;28986.42027159466;29414.558781618292;4164.12553363794;4242.066745316026;4317.287647538153;4329.502107257674;4398.47218333802;261971;262525;262878;262982.6850865753;263025;33927;34043.48934765981;34047;34161.31677366439;34783.82608086994;35297.823510882285;37091.443628345594;37178.8141059293;37351.06622334409;37388.43917341242;14266.500672476413;14290.28548572588;14325.6418589534;14346.713065738626;14363;13426.65733426669;13475.730485390237;13495.527656531975;13511.459541618226;13535.526256580972;8233.50598964064;8355.373346999;8358.582070896431;8369.539675317916;8427.410081294373;3286.7370610351113;3289.5065740138693;3299.9340013199603;3342.398368293682;3346.4143774839304;985.605757696927;1054.478033373485;1103.9779204415868;1134.0304040045808;1194.3132698698282;33732.83133584366;33816.83091584526;34303.65696343005;34362.31275374479;34414.13964650904;1139.4530625299903;1182.763447310524;1186.792311345511;1196.8324434579165;1237.4678888078033;17710.11449427549;17727.11364431773;17843.10784460772;17899.910500447415;17947;555709;558189;560507;561526;562426;61293.38706612966;61806.69096654488;62215.688921555105;62292.37707622866;62301.68849155816;1333.200079952021;1373.6909195430949;1377.3044612470637;1378.3590630356932;1407.619942615488;33102;33658.663413366536;33664;33883.161170870095;33982.150446239044;52856.73571632117;53378.1993270109;53485.46514534805;53564.46435535751;53576;474843;478255;481391;481778;482090;28806.991755288465;28834;29013.419731604827;29134.27164320909;29183.562246566744;49579.25631115464;50883.49116508788;50918.23622645589;51792.22311665252;51916.740416297675;41747.7912610435;41795.164096717286;41853.79073104615;43344;43629.345559817266;41774.58225417828;42276.94307642333;42378.36432453454;43691.34462983121;43712.78143609261;37095.62904370922;42095;42229.36655950102;42962.78518607387;43356.34965475457;35952.8202358997;38363.80818096003;38403.2319353617;38872;39177;28780.568291475225;29743.55384669275;29752.256193595334;30062.69937300599;30193.69806301909 06:02:27 INFO - PROCESS | 14435 | |2;jquery.html;388.79976811941856;391.20975629228974;393.8857731257935;397.7096719394843;418.7445658148531;20070.197192112315;20349.18603255868;20772.376828695127;20791.376258712244;21371.67942480864;20040;20538.794612053876;20832.47918802031;20851.478713032182;20875.791242087573;5593.99999999999;5992.49063829575;5993.790217342394;5998.9700051499685;6000.249968753906;5752.367239603661;5864.179014937912;5899.852503687399;5910.556708246877;5953.285605727318;5855.648661080328;5885;5893.705314734268;5930.970345148268;5943.554233432488;5690.487856092972;5854.619449735775;5867.090600956859;5876.236089308405;6032.5173986081445;5917.082852157922;5928.318243401977;5931.199288096138;5934;5946.405359464062;14044.789328160086;14138.575842724735;23665.171718989754;24200.878995605086;24588.139415120564;2360.7639236076425;2373.181252467913;2544.274881658718;3001.0696684027803;3038.149318190888;9985.75035624108;10556.894431055667;10569.365838049742;10766.838497422545;10841.620543280947;1960.7647082350068;2015.637185306659;2071.4096482502414;2165.307101727448;2228.810551103158;80949.59525202337;84499.5775021127;85030;86105.56947215224;88831.66752498654;11017.504212310465;11202;11219.66341009771;11429.371384573762;11539.307641541534;15201.391944322104;15230.695386092217;15323.387064517518;15342.693146137015;15367.154806485527;8339.708110216114;8601.440906341068;8611.397202195787;8626.654933802578;8763.167499087576;8411.70559030431;8460.703875364332;8485.618147183268;8569.271611912933;8625.439346442461;4641.605463535638;4821.566059054702;4825.276208568673;4855.854324370274;4871.3667223260745;1994.601079784049;2032.8373730101557;2034.979650203479;2036.7861374555755;2096.8741875487212;963.4556475591269;987.2003677021636;1038.4703801061512;1053.4153544782719;1107.1087774341731;20522.897385512977;20977.79022209789;20999.055042523123;21012.26457073995;21257;979.872616559857;1001.4992503748126;1033.6898930321024;1048.2557384257111;1105.9990708408902;11269.830952535718;11643.708907277385;11654.70863228426;11675.416229188506;11768.352740599177;501353;515500;523343;525679;526973;77771.61114194393;87518;100501.49749251206;100711.49644251732;101171.49414253028;1001.5843424978552;1019.0471908765328;1020.5254556631351;1044.070777008463;1045.7124290820086;17921.37275195414;18860.811391885905;19012;19028.904855475634;19147;43925;44184.558154418046;44396.55603443924;44589;44961.77519112384;58802;59729.7013514947;60310.09534856893;60438;60633.39366606454;8822;8854.601542930712;8865.468071915448;8935.240504557185;9092.181703646704;8328.000639923248;10018.499075046073;10310.896891030994;13569.864301357255;13696.86303136956;11233.49449274801;11606.24559403636;11905.702357441134;12071.155019148926;12473;11748;12030.939845300718;12098.334591597546;12272.263664180178;12648;11512;11743.823842642538;11752.941235293769;12263.93868030654;12417.503299867903;8808.647654093764;8917.73246802597;8943.508107054175;9009.864852027356;9010.0989901012;11326.150538709795;11974.521019159136;11999.280043197436;12006.279623222634;12123.272603643809 06:02:27 INFO - PROCESS | 14435 | |3;mootools.html;1506.5405051459306;1507.7286088504068;1678.8992660440374;1808.91859866306;1819.0995457248664;8066.475679080871;8741.606627701753;8859.689910853122;9413.341066125382;9420.387674801133;8841.823163536741;9102.044285350043;9177.449353038823;9177.954110229457;9185.77035574111;2369.893354799038;2420.2860156253946;2421.757824217582;2429.927102186937;2440.9511809763794;2360;2386.522695460906;2387.236084452976;2388.22382725614;2400.4958958618713;2420.1529464687396;2425.818063645225;2431.8662473563945;2439.4145405102827;2450.019992003195;2259.5142044460354;2286.7827556382117;2294.1167650454527;2296.850704704197;2301.827362947786;2283.6346184610547;2298.586254474211;2316.467212541125;2318.802901753353;2322.8722420266877;9146.588403521791;9160.587773550205;9190.35667503275;9194.632214711404;9231.953840230823;5351.09031464652;5443.482869127427;5448.56411487084;5466.180072989044;5468.207109969032;3404.740246108931;3412.181076541637;3456.5160877477174;3473.1490784757643;3481.442969124928;1058.2169194795872;1062.8671416072991;1069.5989004123453;1092.7049696581958;1112.2714621922653;12805;12810.167339122927;12869.163504372185;12872.356382180948;12877.549285774952;4638.281066434708;4694.7887345068875;4859.271109333628;4868.099401610713;4911.45973942866;10734.087602553871;10748.355098694103;10789.56841726338;10830.837537436944;10838.132949364031;5436.266104075979;5485.314335708036;5490.368607610096;5518.558515318765;5526.143447765603;4438.866833994985;4829.323894654751;5030.220315851049;5047.747612619354;5057.898842023139;4122.1244333828035;4135.255653982252;4171.83312667496;4183.946271837013;4205.74765514064;1270.3775150176532;1293.9611811645666;1294.643972907439;1300.596814987357;1329.355262697591;1021.2187676427538;1031.3708637730979;1040.432964034603;1044.587387981743;1049.6378749331468;6225.252969643581;6228.065790131516;6258.718357673915;6285.308616052231;6304.910593809001;448.0501337165231;450.50444511037597;464.5145822615375;467.74975388167167;476.7640018191018;3860.1314704191896;3921.2941670499586;3936.3701807710627;4030.5163380394542;4051.8784436466954;11066.778664426667;11334.14993875446;11345.659630211107;11433.199676022765;11483.13876459269;11350.54597816078;11356.375399353115;11368.317900925806;11370.317780933005;11382.430878456044;8078.757637270891;8467.068622451648;8531.06158322584;8594.183552562621;8598.183172598594;5962.761489540369;6149.907751383822;6156.538259630635;6184.536159788124;6309.526785491014;10499;10545.31455455393;10552.366857988545;10638.8936110641;10644.201684873511;10209.591616335263;10525.263231574023;10586.682399528027;10736.355818650905;10835.620753273597;7261.564306141649;7826.843463130819;8010.91989080125;8039.758807235792;8189.795255118432;8997.820043599222;9007.369484136048;9044.321675874204;9066.909330906607;9087.54562271897;7975.641096150571;8225.588720563828;8296.83406331882;8308.169183081643;8417.5791210438;8027.157148499324;8066.959665201636;8113.71601993951;8213.055498617736;8248.257656810676;7251.311125443074;7274.236205198378;7323.707051718085;7461.253874612712;7463.776086717407;5279.47205279469;5337;5413;5413.8105166320565;5415.972920135532;5248.291480650063;5314.734263286898;5415.1335786274;5417.6478528895495;5590 06:02:27 INFO - PROCESS | 14435 | |4;prototype.html;315.6165259210061;321.27552369406993;327.95900512435946;329.12945259787847;330.42387810145607;5446.972765136169;5546.197485817111;5629.324481062273;5637.321023550454;5658.603897727161;5552.694601796899;5562.666240025601;5565.193047008182;5600.047991841387;5600.411956744534;4319.3952846601505;4324.394584758136;4335.1979883721615;4338.436003319572;4354.191546452536;4244.257254980382;4325.545817689144;4342.565743425664;4365.214261432957;4384.276594361942;4255.148970205955;4293.656507479394;4294.742315461082;4296.871093867173;4298.26929421999;4252.298370768819;4294.119705460389;4299.527052024275;4302.462192225956;4306.590873866978;3645.052286405527;3763.438173158136;3770.981145094257;3771.9434208486896;3776.4901738265257;5459.890802183934;5464.972675136639;5476.726163691839;5482.314710661168;5482.5613950884235;4921.827736029258;4930.03864246472;4939.456659767423;4942.159832828428;4951.331570238008;5692.430756924275;5797.159411885295;5812.854678633025;5858.238429004245;5876.882462350729;4128.483939507561;4129.772862492562;4144.979275103636;4145;4149.688773341982;5793.652380857162;5906.291245050621;6119;6134.4172303631085;6138.0792881067755;4139.668826493873;4143.233501802176;4148.34066373447;4150.979245103756;4162.167566486714;4178.415021896937;4192.3082691355585;4213.873583792491;4228.429162063144;4239.194553034913;4731.621470282369;4874.171390863562;4891.559759621651;4903.239997800275;4931.3835770528685;5792.594518383757;5818.79634212809;5871.500922421556;5874.412558744091;5895.086261629454;1463.5170393770031;1465.2087872548918;1477.541961991786;1480.8519148085106;1482.7553453680023;905.5291248550717;941.4022095969109;948.2414068744977;956.8038552096804;971.9125278724948;5072.82245121419;5090.898182036339;5110.211426000944;5113.386393632788;5175.896482070338;5337.226102215234;5382.407935127133;5387.434319396485;5391.595630327741;5395.62230643859;5068.59451243907;5106.565941894906;5183.974080129575;5362.410134885237;5803.158542011384;3152.243461569207;3201.599800024997;3203.599550056243;3219.6316565460056;3223.3553289342226;6174.38256174379;6272.780452684134;6303.842403939938;6314.305426403092;6322.936770632326;6195.31851496335;6195.783147589813;6219.564630475914;6220.595661282002;6221.471174950089;6276.552144663585;6278.183836101369;6288.968555157195;6292.402221789014;6354.26925903527;5766.855828604318;5952.791652292149;5977.535503801597;6011.879762404815;6060.606060606046;5972.58191926561;5976.731047102978;6002.009668404664;6003.489703375262;6023.879522409615;5983.311919129182;6036.879262414639;6188.226471691039;6203.720832562455;6277.309495955533;4205.558416366238;4230.534641189405;4243.405923170821;4248.405223268683;4258.339957306623;5835.649861008353;5965.433283838029;6036.245469316335;6047.881141988746;6089.817305480843;5795.565332599987;5835.7373918174635;5846.619969701956;5853.385394533512;5875.911861321998;5776.19133321327;5833.649981001154;5886;5912.231409916683;5936.851578710567;5582.883423315435;5639.8590035249445;5771.826845194651;5776.480116789509;5807.535397168301;5862.530997520274;5903.852403689943;5904.557158213065;5918.526517878646;5938.940610593839;5598.244237027949;5759.65442073477;5795.217645617788;5796.188533605383;5819.214406055297 06:02:27 INFO - PROCESS | 14435 | |5;yui.html;612.1002126873498;621.6208113051041;687.6389895304965;847.4491580472693;860.3031544448996;14828.6292842679;15766.60583485412;15792.368305267804;15826.76259856103;15846.20768961553;14618.342174602141;15268.618284542892;15322.463713770021;15469;15479;810.0886502684494;825.4634487583058;829.8962629671291;831.1480732249432;834.5201509132243;818.7011740714626;822.4037572759731;823.5511646152861;823.8064054947083;824.0770337222319;870.4907629037021;873.76845136039;875.0156074416282;878.7319867440428;878.8637761147;867.6355930509138;868.9608967596441;873.462820365477;873.8863947686792;873.9082396348388;623.6850390552742;626.2172284644195;630.1367127035944;632.9208848893888;633.0377825704903;14672.853271467255;14977.850221497754;14980.1011939284;15034.248287585577;15044.548663540112;13197.670058248525;13306.401211945486;13333.466661333536;13354.666133346647;13557.52548660802;12120.151589388746;12137.514499420013;12272.570460033856;12282.201656892274;12668.113232073758;3934.803259836997;3959.5842436544035;3986.40203969404;4145.523264824554;4157.605027522381;77419.22580774233;77546.22453775446;79209.20790792133;79262.6036869812;79299.20700792976;9847.704568862946;10047.849282260771;10134.189264858793;10279.449549491279;10338.276320657633;20520.794792052187;20687.689684654742;20802.375928722162;20847.270345537832;20849.478763031046;8958.148975847284;9110.908890911138;9119.908800912039;9180.081991800767;9384.061593840697;4872.80508779652;4991.825286114969;5082.085224659597;5239.423663397023;5320.76056577455;3610.765300255475;3734.3651579231596;3734.8132593370224;3735.3089678409583;3742.401215805458;639.750497306051;656.6125985668479;662.9469642428594;669.9497537684693;675.9222689390783;659.5053709717712;693.0262980512388;715.2704241673464;743.4869939741561;749.0786332810674;9238.445693258425;9612.66355677548;9822.187128307078;9824.508774561244;9851.359661621971;675.8141511084393;687.2577616174519;697.5465947134403;698.552926127279;707.2927072927073;4711.95288047122;4793.56193142063;4819.7108173509705;4848.3454733610515;4853.053654537402;118673;118732;119826.40086799511;120745;121238.39380803039;104782;107614.85273751819;108590;109004;109844;81917.59041204756;92739.53630231805;94659;94965;95016;8893.911060889566;9109.681161159328;9198.586063627286;9206.263498919936;9308.813823723623;38381.6161838378;47513.52486475091;47835.76082119567;55373;57859;74545;76390;79845;82488.83673286733;85965;13694.863051369359;13701.314934253447;14004.229767362485;14218.715625687222;14380.928095359457;15559.533214003599;15737.921310393374;15917.28372223276;16342;16453.506394808173;14283.428662853785;14329.426822927384;14635.853641463875;15565.247228838864;15807.051576905422;14020.509282175075;14330.785038224643;14612.78080828767;15074;15088.396464141311;14576.416943322572;14927.552173434815;15303.61740956485;15306.23468826532;15363.30865111095;11057.723556911142;11072;11137.777244455228;11139;11215.831762523405;10145.021590994067;10584.259101863103;11171;11489.368084755084;11724.88275117238 06:02:27 INFO - PROCESS | 14435 | __end_tp_report 06:02:27 INFO - PROCESS | 14435 | __start_cc_report 06:02:27 INFO - PROCESS | 14435 | _x_x_mozilla_cycle_collect,368 06:02:27 INFO - PROCESS | 14435 | __end_cc_report 06:02:27 INFO - PROCESS | 14435 | __startTimestamp1468760547214__endTimestamp 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | ------- Summary: start ------- 06:02:27 INFO - PROCESS | 14435 | Number of tests: 6 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | [#0] dojo.html Cycles:165 Average:5523.87 Median:5759.74 stddev:643.42 (11.2%) stddev-sans-first:617.27 06:02:27 INFO - PROCESS | 14435 | Values: 3125.4 3126.8 3160.8 3163.9 3171.1 5454.9 5455.8 5457.9 5488.1 5507.2 5361.7 5513.1 5609.9 5622.2 5680.5 5013.7 5017.6 5045.7 5134.2 5153.7 5069.8 5163.9 5202.3 5202.9 5204.3 4954.2 4985.4 5054.0 5085.0 5101.8 4944.5 4979.9 5021.7 5055.8 5087.8 4967.3 4972.8 4990.7 4993.7 5022.0 5402.9 5543.4 5552.2 5574.5 5615.4 5903.4 5961.9 5967.2 5978.3 5992.4 6012.0 6015.3 6018.5 6022.1 6031.0 5439.2 5515.4 5601.9 5606.0 5619.9 6064.0 6119.3 6148.1 6153.8 6160.0 5799.3 5834.0 5836.2 5875.9 5904.9 5802.8 5834.5 5853.4 5898.7 5923.1 5702.5 5894.5 5898.0 5935.6 5953.3 5903.7 5936.2 5948.7 5953.9 5960.6 4387.7 4456.4 4501.3 4569.5 4569.5 4020.2 4024.8 4030.5 4043.1 4072.7 5685.1 5690.0 5722.8 5723.3 5731.1 5812.2 5834.0 5843.3 5891.4 5961.8 5571.2 5649.9 5670.5 5676.5 5680.5 5078.2 5079.6 5085.4 5105.4 5162.4 6039.6 6127.9 6174.2 6186.0 6233.6 5959.4 5963.5 5971.4 5978.4 6024.0 6113.1 6202.1 6211.3 6218.2 6224.9 5802.1 5824.1 5830.6 5869.5 5924.7 5901.6 5940.7 5984.8 5993.3 6004.3 5718.3 5857.4 5864.6 5867.2 5870.2 5627.4 5630.5 5644.9 5839.0 5882.4 5763.6 5827.8 5841.8 5849.4 5853.2 5809.7 5937.6 5957.4 5957.6 5976.2 5723.5 5759.3 5759.7 5783.6 5811.2 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | [#1] ext.html Cycles:180 Average:58413.05 Median:41824.48 stddev:120493.22 (288.1%) stddev-sans-first:120752.97 06:02:27 INFO - PROCESS | 14435 | Values: 572.0 597.4 613.2 626.3 654.1 39083.2 43657.3 43749.6 43875.3 43888.3 44280.0 44756.1 44796.0 45011.0 45162.0 8859.4 9018.0 9020.3 9021.0 9029.3 8915.2 8988.3 8988.5 8996.1 8997.0 9037.1 9080.2 9115.5 9136.2 9149.0 8959.5 8990.1 9036.7 9040.8 9041.5 8906.1 8957.1 9002.5 9010.9 9019.6 33095.0 42579.1 43002.8 43058.1 43076.0 3405.8 3449.1 3521.7 3585.1 3638.0 28676.1 28808.3 28840.0 28986.4 29414.6 4164.1 4242.1 4317.3 4329.5 4398.5 261971.0 262525.0 262878.0 262982.7 263025.0 33927.0 34043.5 34047.0 34161.3 34783.8 35297.8 37091.4 37178.8 37351.1 37388.4 14266.5 14290.3 14325.6 14346.7 14363.0 13426.7 13475.7 13495.5 13511.5 13535.5 8233.5 8355.4 8358.6 8369.5 8427.4 3286.7 3289.5 3299.9 3342.4 3346.4 985.6 1054.5 1104.0 1134.0 1194.3 33732.8 33816.8 34303.7 34362.3 34414.1 1139.5 1182.8 1186.8 1196.8 1237.5 17710.1 17727.1 17843.1 17899.9 17947.0 555709.0 558189.0 560507.0 561526.0 562426.0 61293.4 61806.7 62215.7 62292.4 62301.7 1333.2 1373.7 1377.3 1378.4 1407.6 33102.0 33658.7 33664.0 33883.2 33982.2 52856.7 53378.2 53485.5 53564.5 53576.0 474843.0 478255.0 481391.0 481778.0 482090.0 28807.0 28834.0 29013.4 29134.3 29183.6 49579.3 50883.5 50918.2 51792.2 51916.7 41747.8 41795.2 41853.8 43344.0 43629.3 41774.6 42276.9 42378.4 43691.3 43712.8 37095.6 42095.0 42229.4 42962.8 43356.3 35952.8 38363.8 38403.2 38872.0 39177.0 28780.6 29743.6 29752.3 30062.7 30193.7 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | [#2] jquery.html Cycles:180 Average:30278.49 Median:13012.97 stddev:85476.01 (656.9%) stddev-sans-first:85686.33 06:02:27 INFO - PROCESS | 14435 | Values: 388.8 391.2 393.9 397.7 418.7 20070.2 20349.2 20772.4 20791.4 21371.7 20040.0 20538.8 20832.5 20851.5 20875.8 5594.0 5992.5 5993.8 5999.0 6000.2 5752.4 5864.2 5899.9 5910.6 5953.3 5855.6 5885.0 5893.7 5931.0 5943.6 5690.5 5854.6 5867.1 5876.2 6032.5 5917.1 5928.3 5931.2 5934.0 5946.4 14044.8 14138.6 23665.2 24200.9 24588.1 2360.8 2373.2 2544.3 3001.1 3038.1 9985.8 10556.9 10569.4 10766.8 10841.6 1960.8 2015.6 2071.4 2165.3 2228.8 80949.6 84499.6 85030.0 86105.6 88831.7 11017.5 11202.0 11219.7 11429.4 11539.3 15201.4 15230.7 15323.4 15342.7 15367.2 8339.7 8601.4 8611.4 8626.7 8763.2 8411.7 8460.7 8485.6 8569.3 8625.4 4641.6 4821.6 4825.3 4855.9 4871.4 1994.6 2032.8 2035.0 2036.8 2096.9 963.5 987.2 1038.5 1053.4 1107.1 20522.9 20977.8 20999.1 21012.3 21257.0 979.9 1001.5 1033.7 1048.3 1106.0 11269.8 11643.7 11654.7 11675.4 11768.4 501353.0 515500.0 523343.0 525679.0 526973.0 77771.6 87518.0 100501.5 100711.5 101171.5 1001.6 1019.0 1020.5 1044.1 1045.7 17921.4 18860.8 19012.0 19028.9 19147.0 43925.0 44184.6 44396.6 44589.0 44961.8 58802.0 59729.7 60310.1 60438.0 60633.4 8822.0 8854.6 8865.5 8935.2 9092.2 8328.0 10018.5 10310.9 13569.9 13696.9 11233.5 11606.2 11905.7 12071.2 12473.0 11748.0 12030.9 12098.3 12272.3 12648.0 11512.0 11743.8 11752.9 12263.9 12417.5 8808.6 8917.7 8943.5 9009.9 9010.1 11326.2 11974.5 11999.3 12006.3 12123.3 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | [#3] mootools.html Cycles:180 Average:6013.56 Median:2443.46 stddev:3476.03 (142.3%) stddev-sans-first:3469.28 06:02:27 INFO - PROCESS | 14435 | Values: 1506.5 1507.7 1678.9 1808.9 1819.1 8066.5 8741.6 8859.7 9413.3 9420.4 8841.8 9102.0 9177.4 9178.0 9185.8 2369.9 2420.3 2421.8 2429.9 2441.0 2360.0 2386.5 2387.2 2388.2 2400.5 2420.2 2425.8 2431.9 2439.4 2450.0 2259.5 2286.8 2294.1 2296.9 2301.8 2283.6 2298.6 2316.5 2318.8 2322.9 9146.6 9160.6 9190.4 9194.6 9232.0 5351.1 5443.5 5448.6 5466.2 5468.2 3404.7 3412.2 3456.5 3473.1 3481.4 1058.2 1062.9 1069.6 1092.7 1112.3 12805.0 12810.2 12869.2 12872.4 12877.5 4638.3 4694.8 4859.3 4868.1 4911.5 10734.1 10748.4 10789.6 10830.8 10838.1 5436.3 5485.3 5490.4 5518.6 5526.1 4438.9 4829.3 5030.2 5047.7 5057.9 4122.1 4135.3 4171.8 4183.9 4205.7 1270.4 1294.0 1294.6 1300.6 1329.4 1021.2 1031.4 1040.4 1044.6 1049.6 6225.3 6228.1 6258.7 6285.3 6304.9 448.1 450.5 464.5 467.7 476.8 3860.1 3921.3 3936.4 4030.5 4051.9 11066.8 11334.1 11345.7 11433.2 11483.1 11350.5 11356.4 11368.3 11370.3 11382.4 8078.8 8467.1 8531.1 8594.2 8598.2 5962.8 6149.9 6156.5 6184.5 6309.5 10499.0 10545.3 10552.4 10638.9 10644.2 10209.6 10525.3 10586.7 10736.4 10835.6 7261.6 7826.8 8010.9 8039.8 8189.8 8997.8 9007.4 9044.3 9066.9 9087.5 7975.6 8225.6 8296.8 8308.2 8417.6 8027.2 8067.0 8113.7 8213.1 8248.3 7251.3 7274.2 7323.7 7461.3 7463.8 5279.5 5337.0 5413.0 5413.8 5416.0 5248.3 5314.7 5415.1 5417.6 5590.0 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | [#4] prototype.html Cycles:180 Average:4875.96 Median:5549.45 stddev:1453.64 (26.2%) stddev-sans-first:1416.85 06:02:27 INFO - PROCESS | 14435 | Values: 315.6 321.3 328.0 329.1 330.4 5447.0 5546.2 5629.3 5637.3 5658.6 5552.7 5562.7 5565.2 5600.0 5600.4 4319.4 4324.4 4335.2 4338.4 4354.2 4244.3 4325.5 4342.6 4365.2 4384.3 4255.1 4293.7 4294.7 4296.9 4298.3 4252.3 4294.1 4299.5 4302.5 4306.6 3645.1 3763.4 3771.0 3771.9 3776.5 5459.9 5465.0 5476.7 5482.3 5482.6 4921.8 4930.0 4939.5 4942.2 4951.3 5692.4 5797.2 5812.9 5858.2 5876.9 4128.5 4129.8 4145.0 4145.0 4149.7 5793.7 5906.3 6119.0 6134.4 6138.1 4139.7 4143.2 4148.3 4151.0 4162.2 4178.4 4192.3 4213.9 4228.4 4239.2 4731.6 4874.2 4891.6 4903.2 4931.4 5792.6 5818.8 5871.5 5874.4 5895.1 1463.5 1465.2 1477.5 1480.9 1482.8 905.5 941.4 948.2 956.8 971.9 5072.8 5090.9 5110.2 5113.4 5175.9 5337.2 5382.4 5387.4 5391.6 5395.6 5068.6 5106.6 5184.0 5362.4 5803.2 3152.2 3201.6 3203.6 3219.6 3223.4 6174.4 6272.8 6303.8 6314.3 6322.9 6195.3 6195.8 6219.6 6220.6 6221.5 6276.6 6278.2 6289.0 6292.4 6354.3 5766.9 5952.8 5977.5 6011.9 6060.6 5972.6 5976.7 6002.0 6003.5 6023.9 5983.3 6036.9 6188.2 6203.7 6277.3 4205.6 4230.5 4243.4 4248.4 4258.3 5835.6 5965.4 6036.2 6047.9 6089.8 5795.6 5835.7 5846.6 5853.4 5875.9 5776.2 5833.6 5886.0 5912.2 5936.9 5582.9 5639.9 5771.8 5776.5 5807.5 5862.5 5903.9 5904.6 5918.5 5938.9 5598.2 5759.7 5795.2 5796.2 5819.2 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - PROCESS | 14435 | [#5] yui.html Cycles:180 Average:21638.58 Median:26112.74 stddev:31689.01 (121.4%) stddev-sans-first:31738.57 06:02:27 INFO - PROCESS | 14435 | Values: 612.1 621.6 687.6 847.4 860.3 14828.6 15766.6 15792.4 15826.8 15846.2 14618.3 15268.6 15322.5 15469.0 15479.0 810.1 825.5 829.9 831.1 834.5 818.7 822.4 823.6 823.8 824.1 870.5 873.8 875.0 878.7 878.9 867.6 869.0 873.5 873.9 873.9 623.7 626.2 630.1 632.9 633.0 14672.9 14977.9 14980.1 15034.2 15044.5 13197.7 13306.4 13333.5 13354.7 13557.5 12120.2 12137.5 12272.6 12282.2 12668.1 3934.8 3959.6 3986.4 4145.5 4157.6 77419.2 77546.2 79209.2 79262.6 79299.2 9847.7 10047.8 10134.2 10279.4 10338.3 20520.8 20687.7 20802.4 20847.3 20849.5 8958.1 9110.9 9119.9 9180.1 9384.1 4872.8 4991.8 5082.1 5239.4 5320.8 3610.8 3734.4 3734.8 3735.3 3742.4 639.8 656.6 662.9 669.9 675.9 659.5 693.0 715.3 743.5 749.1 9238.4 9612.7 9822.2 9824.5 9851.4 675.8 687.3 697.5 698.6 707.3 4712.0 4793.6 4819.7 4848.3 4853.1 118673.0 118732.0 119826.4 120745.0 121238.4 104782.0 107614.9 108590.0 109004.0 109844.0 81917.6 92739.5 94659.0 94965.0 95016.0 8893.9 9109.7 9198.6 9206.3 9308.8 38381.6 47513.5 47835.8 55373.0 57859.0 74545.0 76390.0 79845.0 82488.8 85965.0 13694.9 13701.3 14004.2 14218.7 14380.9 15559.5 15737.9 15917.3 16342.0 16453.5 14283.4 14329.4 14635.9 15565.2 15807.1 14020.5 14330.8 14612.8 15074.0 15088.4 14576.4 14927.6 15303.6 15306.2 15363.3 11057.7 11072.0 11137.8 11139.0 11215.8 10145.0 10584.3 11171.0 11489.4 11724.9 06:02:27 INFO - PROCESS | 14435 | -------- Summary: end -------- 06:02:27 INFO - PROCESS | 14435 | 06:02:27 INFO - TEST-INFO | 14435: exit 0 06:02:28 INFO - TEST-OK | dromaeo_css | took 1111728ms 06:02:28 INFO - TEST-START | kraken 06:02:28 INFO - operating with platform_type : linux_ 06:02:28 INFO - Initialising browser for kraken test... 06:02:28 INFO - TEST-INFO | started process 14674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLaBgK4/profile http://localhost:45006/getInfo.html) 06:02:31 INFO - PROCESS | 14674 | JavaScript error: , line 0: uncaught exception: undefined 06:02:32 INFO - PROCESS | 14674 | __metrics Screen width/height:1600/1200 06:02:32 INFO - PROCESS | 14674 | colorDepth:24 06:02:32 INFO - PROCESS | 14674 | Browser inner width/height: 1024/697 06:02:32 INFO - PROCESS | 14674 | __metrics 06:02:33 ERROR - PROCESS | 14674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:02:34 INFO - TEST-INFO | 14674: exit 0 06:02:34 INFO - Browser initialized. 06:02:34 INFO - Running cycle 1/1 for kraken test... 06:02:34 INFO - TEST-INFO | started process 14795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLaBgK4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:46 INFO - PROCESS | 14795 | RSS: Main: 168652800 06:02:46 INFO - PROCESS | 14795 | 06:02:48 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45006/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:49 INFO - PROCESS | 14795 | RSS: Main: 173989888 06:02:49 INFO - PROCESS | 14795 | 06:02:52 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45006/tests/kraken/driver.html?testName=audio-dft) 06:02:52 INFO - PROCESS | 14795 | RSS: Main: 172830720 06:02:52 INFO - PROCESS | 14795 | 06:02:55 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45006/tests/kraken/driver.html?testName=audio-fft) 06:02:56 INFO - PROCESS | 14795 | RSS: Main: 167313408 06:02:56 INFO - PROCESS | 14795 | 06:02:58 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45006/tests/kraken/driver.html?testName=audio-oscillator) 06:02:58 INFO - PROCESS | 14795 | RSS: Main: 168534016 06:02:58 INFO - PROCESS | 14795 | 06:03:01 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45006/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:01 INFO - PROCESS | 14795 | RSS: Main: 169082880 06:03:01 INFO - PROCESS | 14795 | 06:03:04 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45006/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:05 INFO - PROCESS | 14795 | RSS: Main: 168378368 06:03:05 INFO - PROCESS | 14795 | 06:03:08 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45006/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:09 INFO - PROCESS | 14795 | RSS: Main: 166637568 06:03:09 INFO - PROCESS | 14795 | 06:03:12 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45006/tests/kraken/driver.html?testName=json-parse-financial) 06:03:13 INFO - PROCESS | 14795 | RSS: Main: 168771584 06:03:13 INFO - PROCESS | 14795 | 06:03:14 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45006/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:15 INFO - PROCESS | 14795 | RSS: Main: 169218048 06:03:15 INFO - PROCESS | 14795 | 06:03:16 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:17 INFO - PROCESS | 14795 | RSS: Main: 169185280 06:03:17 INFO - PROCESS | 14795 | 06:03:19 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:20 INFO - PROCESS | 14795 | RSS: Main: 169783296 06:03:20 INFO - PROCESS | 14795 | 06:03:22 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:23 INFO - PROCESS | 14795 | RSS: Main: 169881600 06:03:23 INFO - PROCESS | 14795 | 06:03:26 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:26 INFO - PROCESS | 14795 | RSS: Main: 169549824 06:03:26 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:45006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45006/tests/kraken/driver.html?testName=ai-astar) 06:03:28 INFO - PROCESS | 14795 | RSS: Main: 170573824 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | __start_tp_report 06:03:28 INFO - PROCESS | 14795 | _x_x_mozilla_page_load 06:03:28 INFO - PROCESS | 14795 | _x_x_mozilla_page_load_details 06:03:28 INFO - PROCESS | 14795 | |i|pagename|runs| 06:03:28 INFO - PROCESS | 14795 | |0;ai-astar;103;112;105;111;112;111;113;112;110;111 06:03:28 INFO - PROCESS | 14795 | |1;audio-beat-detection;153;118;149;170;118;147;147;119;170;119 06:03:28 INFO - PROCESS | 14795 | |2;audio-dft;163;163;161;165;161;167;169;163;161;161 06:03:28 INFO - PROCESS | 14795 | |3;audio-fft;75;75;75;141;79;75;75;75;169;76 06:03:28 INFO - PROCESS | 14795 | |4;audio-oscillator;83;83;150;83;84;83;131;83;84;162 06:03:28 INFO - PROCESS | 14795 | |5;imaging-gaussian-blur;117;121;120;120;121;117;117;117;117;117 06:03:28 INFO - PROCESS | 14795 | |6;imaging-darkroom;147;147;147;151;151;150;148;147;148;149 06:03:28 INFO - PROCESS | 14795 | |7;imaging-desaturate;95;97;95;97;96;100;95;96;95;96 06:03:28 INFO - PROCESS | 14795 | |8;json-parse-financial;51;52;52;52;51;53;55;51;52;51 06:03:28 INFO - PROCESS | 14795 | |9;json-stringify-tinderbox;60;61;65;60;65;67;60;60;62;62 06:03:28 INFO - PROCESS | 14795 | |10;stanford-crypto-aes;76;75;74;74;75;75;75;84;82;82 06:03:28 INFO - PROCESS | 14795 | |11;stanford-crypto-ccm;126;122;137;132;125;129;130;129;164;130 06:03:28 INFO - PROCESS | 14795 | |12;stanford-crypto-pbkdf2;160;162;158;160;162;163;159;162;158;161 06:03:28 INFO - PROCESS | 14795 | |13;stanford-crypto-sha256-iterative;64;65;65;67;64;67;63;64;63;65 06:03:28 INFO - PROCESS | 14795 | __end_tp_report 06:03:28 INFO - PROCESS | 14795 | __start_cc_report 06:03:28 INFO - PROCESS | 14795 | _x_x_mozilla_cycle_collect,877 06:03:28 INFO - PROCESS | 14795 | __end_cc_report 06:03:28 INFO - PROCESS | 14795 | __startTimestamp1468760608862__endTimestamp 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | ------- Summary: start ------- 06:03:28 INFO - PROCESS | 14795 | Number of tests: 14 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.30 (3.0%) stddev-sans-first:2.33 06:03:28 INFO - PROCESS | 14795 | Values: 103.0 112.0 105.0 111.0 112.0 111.0 113.0 112.0 110.0 111.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:148.00 stddev:21.05 (14.2%) stddev-sans-first:21.87 06:03:28 INFO - PROCESS | 14795 | Values: 153.0 118.0 149.0 170.0 118.0 147.0 147.0 119.0 170.0 119.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.80 (1.7%) stddev-sans-first:2.96 06:03:28 INFO - PROCESS | 14795 | Values: 163.0 163.0 161.0 165.0 161.0 167.0 169.0 163.0 161.0 161.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#3] audio-fft Cycles:10 Average:91.50 Median:75.00 stddev:34.13 (45.5%) stddev-sans-first:35.68 06:03:28 INFO - PROCESS | 14795 | Values: 75.0 75.0 75.0 141.0 79.0 75.0 75.0 75.0 169.0 76.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:83.00 stddev:31.96 (38.5%) stddev-sans-first:33.11 06:03:28 INFO - PROCESS | 14795 | Values: 83.0 83.0 150.0 83.0 84.0 83.0 131.0 83.0 84.0 162.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:1.84 (1.6%) stddev-sans-first:1.88 06:03:28 INFO - PROCESS | 14795 | Values: 117.0 121.0 120.0 120.0 121.0 117.0 117.0 117.0 117.0 117.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.65 (1.1%) stddev-sans-first:1.66 06:03:28 INFO - PROCESS | 14795 | Values: 147.0 147.0 147.0 151.0 151.0 150.0 148.0 147.0 148.0 149.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.58 06:03:28 INFO - PROCESS | 14795 | Values: 95.0 97.0 95.0 97.0 96.0 100.0 95.0 96.0 95.0 96.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.25 (2.4%) stddev-sans-first:1.27 06:03:28 INFO - PROCESS | 14795 | Values: 51.0 52.0 52.0 52.0 51.0 53.0 55.0 51.0 52.0 51.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:2.57 (4.2%) stddev-sans-first:2.60 06:03:28 INFO - PROCESS | 14795 | Values: 60.0 61.0 65.0 60.0 65.0 67.0 60.0 60.0 62.0 62.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:75.50 stddev:3.85 (5.1%) stddev-sans-first:4.06 06:03:28 INFO - PROCESS | 14795 | Values: 76.0 75.0 74.0 74.0 75.0 75.0 75.0 84.0 82.0 82.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:130.00 stddev:11.82 (9.1%) stddev-sans-first:12.31 06:03:28 INFO - PROCESS | 14795 | Values: 126.0 122.0 137.0 132.0 125.0 129.0 130.0 129.0 164.0 130.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:1.78 (1.1%) stddev-sans-first:1.88 06:03:28 INFO - PROCESS | 14795 | Values: 160.0 162.0 158.0 160.0 162.0 163.0 159.0 162.0 158.0 161.0 06:03:28 INFO - PROCESS | 14795 | 06:03:28 INFO - PROCESS | 14795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.48 06:03:28 INFO - PROCESS | 14795 | Values: 64.0 65.0 65.0 67.0 64.0 67.0 63.0 64.0 63.0 65.0 06:03:28 INFO - PROCESS | 14795 | -------- Summary: end -------- 06:03:28 INFO - PROCESS | 14795 | 06:03:29 INFO - TEST-INFO | 14795: exit 0 06:03:29 INFO - TEST-OK | kraken | took 61851ms 06:03:29 INFO - SUITE-END | took 1173s 06:03:30 INFO - Completed test suite (00:19:33) 06:03:30 INFO - javascript benchmark 06:03:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7354.081303774571, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.4217969675606, 3126.7967582107176, 3160.8419579021042, 3163.873445062197, 3171.1437911763824, 5454.890902181954, 5455.8363249102495, 5457.918131228034, 5488.067028605136, 5507.228987941687, 5361.731913404334, 5513.062779327514, 5609.859753506164, 5622.212890195366, 5680.517156041731, 5013.699178049311, 5017.6236782241385, 5045.738565358661, 5134.204198349262, 5153.716545589991, 5069.771860266297, 5163.948360516384, 5202.271681964528, 5202.947970520284, 5204.32343795306, 4954.232094025432, 4985.426675932242, 5054.0, 5085.0, 5101.795928162869, 4944.53026962438, 4979.850604481871, 5021.748912554358, 5055.823046193365, 5087.821926232564, 4967.254911763228, 4972.776225069881, 4990.65065445419, 4993.675411098303, 5022.045811295842, 5402.945970540283, 5543.445655434464, 5552.222688823568, 5574.498295153456, 5615.410381909882, 5903.3801450847905, 5961.940380596226, 5967.16459695643, 5978.312494063195, 5992.4307190817235, 6012.038073908154, 6015.27816661999, 6018.488428483584, 6022.096685497167, 6031.0, 5439.184122381635, 5515.420880807537, 5601.859953501154, 5606.046972014768, 5619.915701264485, 6064.0, 6119.265688117454, 6148.077788331697, 6153.84615384619, 6159.96920015406, 5799.2750906136735, 5834.0, 5836.153757705109, 5875.882482350415, 5904.852378690567, 5802.796902108406, 5834.504067154255, 5853.414658534112, 5898.705064746746, 5923.111533269957, 5702.515286200636, 5894.498967587718, 5897.967855625248, 5935.643861368331, 5953.3451320354725, 5903.704814759245, 5936.168936348915, 5948.67282299469, 5953.910691339634, 5960.612560183661, 4387.714798538085, 4456.398386217819, 4501.3248012797685, 4569.497355290915, 4569.520200378979, 4020.2160578686876, 4024.839006439768, 4030.4558884550797, 4043.0700938783657, 4072.6741860651077, 5685.090385538377, 5690.0, 5722.77108915647, 5723.255976723, 5731.140328950691, 5812.157237200582, 5834.0, 5843.2695913010875, 5891.410858914074, 5961.7615295387695, 5571.192177134293, 5649.858753531113, 5670.518005969457, 5676.460736230051, 5680.517156041783, 5078.162103252996, 5079.568236699922, 5085.364329458817, 5105.361829771278, 5162.380514338229, 6039.577229593974, 6127.92262824669, 6174.228221472316, 6185.969070154621, 6233.594816336924, 5959.404059594006, 5963.463288304073, 5971.373005834499, 5978.358164422217, 6024.0, 6113.14415981754, 6202.131701561875, 6211.3478084802255, 6218.22272215973, 6224.875502490016, 5802.071668533014, 5824.097264923944, 5830.591858569859, 5869.501092407193, 5924.674142922181, 5901.645901245939, 5940.702964851654, 5984.820455386345, 5993.250843644544, 6004.339522652592, 5718.342390625131, 5857.384974577608, 5864.648121112747, 5867.237259156454, 5870.207521984477, 5627.409122042291, 5630.549556035589, 5644.943550564606, 5839.0, 5882.382349853204, 5763.625364351304, 5827.825165245049, 5841.824745257649, 5849.385814489588, 5853.151293062397, 5809.680467574324, 5937.643741375531, 5957.3744756799915, 5957.642541447527, 5976.193213916065, 5723.542116630576, 5759.337676167294, 5759.740811663569, 5783.595148339576, 5811.157382179645], "value": 5478.935007833747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9828405147845, 597.3936454498685, 613.1538476901875, 626.3110578363801, 654.1169421281268, 39083.218335633304, 43657.34513982293, 43749.562504374946, 43875.34186987194, 43888.34167487482, 44280.0, 44756.10487790242, 44796.0, 45011.0, 45162.0, 8859.379843410963, 9018.0, 9020.323475739313, 9021.0, 9029.322800789967, 8915.153060459246, 8988.325875559327, 8988.46069235848, 8996.055414181516, 8997.0, 9037.096290370977, 9080.228180604656, 9115.453072815619, 9136.177744003038, 9149.0, 8959.507227102507, 8990.056044115372, 9036.728898133066, 9040.773980650503, 9041.457512549268, 8906.064863189402, 8957.14907083826, 9002.549872506348, 9010.909890901072, 9019.639214431414, 33095.0, 42579.14841703149, 43002.78498607518, 43058.13883722308, 43076.0, 3405.8249903783153, 3449.068751437098, 3521.7358698097487, 3585.0678823506078, 3638.0, 28676.13971580856, 28808.279793005135, 28840.0, 28986.42027159466, 29414.558781618292, 4164.12553363794, 4242.066745316026, 4317.287647538153, 4329.502107257674, 4398.47218333802, 261971.0, 262525.0, 262878.0, 262982.6850865753, 263025.0, 33927.0, 34043.48934765981, 34047.0, 34161.31677366439, 34783.82608086994, 35297.823510882285, 37091.443628345594, 37178.8141059293, 37351.06622334409, 37388.43917341242, 14266.500672476413, 14290.28548572588, 14325.6418589534, 14346.713065738626, 14363.0, 13426.65733426669, 13475.730485390237, 13495.527656531975, 13511.459541618226, 13535.526256580972, 8233.50598964064, 8355.373346999, 8358.582070896431, 8369.539675317916, 8427.410081294373, 3286.7370610351113, 3289.5065740138693, 3299.9340013199603, 3342.398368293682, 3346.4143774839304, 985.605757696927, 1054.478033373485, 1103.9779204415868, 1134.0304040045808, 1194.3132698698282, 33732.83133584366, 33816.83091584526, 34303.65696343005, 34362.31275374479, 34414.13964650904, 1139.4530625299903, 1182.763447310524, 1186.792311345511, 1196.8324434579165, 1237.4678888078033, 17710.11449427549, 17727.11364431773, 17843.10784460772, 17899.910500447415, 17947.0, 555709.0, 558189.0, 560507.0, 561526.0, 562426.0, 61293.38706612966, 61806.69096654488, 62215.688921555105, 62292.37707622866, 62301.68849155816, 1333.200079952021, 1373.6909195430949, 1377.3044612470637, 1378.3590630356932, 1407.619942615488, 33102.0, 33658.663413366536, 33664.0, 33883.161170870095, 33982.150446239044, 52856.73571632117, 53378.1993270109, 53485.46514534805, 53564.46435535751, 53576.0, 474843.0, 478255.0, 481391.0, 481778.0, 482090.0, 28806.991755288465, 28834.0, 29013.419731604827, 29134.27164320909, 29183.562246566744, 49579.25631115464, 50883.49116508788, 50918.23622645589, 51792.22311665252, 51916.740416297675, 41747.7912610435, 41795.164096717286, 41853.79073104615, 43344.0, 43629.345559817266, 41774.58225417828, 42276.94307642333, 42378.36432453454, 43691.34462983121, 43712.78143609261, 37095.62904370922, 42095.0, 42229.36655950102, 42962.78518607387, 43356.34965475457, 35952.8202358997, 38363.80818096003, 38403.2319353617, 38872.0, 39177.0, 28780.568291475225, 29743.55384669275, 29752.256193595334, 30062.69937300599, 30193.69806301909], "value": 18910.497341637518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.79976811941856, 391.20975629228974, 393.8857731257935, 397.7096719394843, 418.7445658148531, 20070.197192112315, 20349.18603255868, 20772.376828695127, 20791.376258712244, 21371.67942480864, 20040.0, 20538.794612053876, 20832.47918802031, 20851.478713032182, 20875.791242087573, 5593.99999999999, 5992.49063829575, 5993.790217342394, 5998.9700051499685, 6000.249968753906, 5752.367239603661, 5864.179014937912, 5899.852503687399, 5910.556708246877, 5953.285605727318, 5855.648661080328, 5885.0, 5893.705314734268, 5930.970345148268, 5943.554233432488, 5690.487856092972, 5854.619449735775, 5867.090600956859, 5876.236089308405, 6032.5173986081445, 5917.082852157922, 5928.318243401977, 5931.199288096138, 5934.0, 5946.405359464062, 14044.789328160086, 14138.575842724735, 23665.171718989754, 24200.878995605086, 24588.139415120564, 2360.7639236076425, 2373.181252467913, 2544.274881658718, 3001.0696684027803, 3038.149318190888, 9985.75035624108, 10556.894431055667, 10569.365838049742, 10766.838497422545, 10841.620543280947, 1960.7647082350068, 2015.637185306659, 2071.4096482502414, 2165.307101727448, 2228.810551103158, 80949.59525202337, 84499.5775021127, 85030.0, 86105.56947215224, 88831.66752498654, 11017.504212310465, 11202.0, 11219.66341009771, 11429.371384573762, 11539.307641541534, 15201.391944322104, 15230.695386092217, 15323.387064517518, 15342.693146137015, 15367.154806485527, 8339.708110216114, 8601.440906341068, 8611.397202195787, 8626.654933802578, 8763.167499087576, 8411.70559030431, 8460.703875364332, 8485.618147183268, 8569.271611912933, 8625.439346442461, 4641.605463535638, 4821.566059054702, 4825.276208568673, 4855.854324370274, 4871.3667223260745, 1994.601079784049, 2032.8373730101557, 2034.979650203479, 2036.7861374555755, 2096.8741875487212, 963.4556475591269, 987.2003677021636, 1038.4703801061512, 1053.4153544782719, 1107.1087774341731, 20522.897385512977, 20977.79022209789, 20999.055042523123, 21012.26457073995, 21257.0, 979.872616559857, 1001.4992503748126, 1033.6898930321024, 1048.2557384257111, 1105.9990708408902, 11269.830952535718, 11643.708907277385, 11654.70863228426, 11675.416229188506, 11768.352740599177, 501353.0, 515500.0, 523343.0, 525679.0, 526973.0, 77771.61114194393, 87518.0, 100501.49749251206, 100711.49644251732, 101171.49414253028, 1001.5843424978552, 1019.0471908765328, 1020.5254556631351, 1044.070777008463, 1045.7124290820086, 17921.37275195414, 18860.811391885905, 19012.0, 19028.904855475634, 19147.0, 43925.0, 44184.558154418046, 44396.55603443924, 44589.0, 44961.77519112384, 58802.0, 59729.7013514947, 60310.09534856893, 60438.0, 60633.39366606454, 8822.0, 8854.601542930712, 8865.468071915448, 8935.240504557185, 9092.181703646704, 8328.000639923248, 10018.499075046073, 10310.896891030994, 13569.864301357255, 13696.86303136956, 11233.49449274801, 11606.24559403636, 11905.702357441134, 12071.155019148926, 12473.0, 11748.0, 12030.939845300718, 12098.334591597546, 12272.263664180178, 12648.0, 11512.0, 11743.823842642538, 11752.941235293769, 12263.93868030654, 12417.503299867903, 8808.647654093764, 8917.73246802597, 8943.508107054175, 9009.864852027356, 9010.0989901012, 11326.150538709795, 11974.521019159136, 11999.280043197436, 12006.279623222634, 12123.272603643809], "value": 9531.453794587349, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.5405051459306, 1507.7286088504068, 1678.8992660440374, 1808.91859866306, 1819.0995457248664, 8066.475679080871, 8741.606627701753, 8859.689910853122, 9413.341066125382, 9420.387674801133, 8841.823163536741, 9102.044285350043, 9177.449353038823, 9177.954110229457, 9185.77035574111, 2369.893354799038, 2420.2860156253946, 2421.757824217582, 2429.927102186937, 2440.9511809763794, 2360.0, 2386.522695460906, 2387.236084452976, 2388.22382725614, 2400.4958958618713, 2420.1529464687396, 2425.818063645225, 2431.8662473563945, 2439.4145405102827, 2450.019992003195, 2259.5142044460354, 2286.7827556382117, 2294.1167650454527, 2296.850704704197, 2301.827362947786, 2283.6346184610547, 2298.586254474211, 2316.467212541125, 2318.802901753353, 2322.8722420266877, 9146.588403521791, 9160.587773550205, 9190.35667503275, 9194.632214711404, 9231.953840230823, 5351.09031464652, 5443.482869127427, 5448.56411487084, 5466.180072989044, 5468.207109969032, 3404.740246108931, 3412.181076541637, 3456.5160877477174, 3473.1490784757643, 3481.442969124928, 1058.2169194795872, 1062.8671416072991, 1069.5989004123453, 1092.7049696581958, 1112.2714621922653, 12805.0, 12810.167339122927, 12869.163504372185, 12872.356382180948, 12877.549285774952, 4638.281066434708, 4694.7887345068875, 4859.271109333628, 4868.099401610713, 4911.45973942866, 10734.087602553871, 10748.355098694103, 10789.56841726338, 10830.837537436944, 10838.132949364031, 5436.266104075979, 5485.314335708036, 5490.368607610096, 5518.558515318765, 5526.143447765603, 4438.866833994985, 4829.323894654751, 5030.220315851049, 5047.747612619354, 5057.898842023139, 4122.1244333828035, 4135.255653982252, 4171.83312667496, 4183.946271837013, 4205.74765514064, 1270.3775150176532, 1293.9611811645666, 1294.643972907439, 1300.596814987357, 1329.355262697591, 1021.2187676427538, 1031.3708637730979, 1040.432964034603, 1044.587387981743, 1049.6378749331468, 6225.252969643581, 6228.065790131516, 6258.718357673915, 6285.308616052231, 6304.910593809001, 448.0501337165231, 450.50444511037597, 464.5145822615375, 467.74975388167167, 476.7640018191018, 3860.1314704191896, 3921.2941670499586, 3936.3701807710627, 4030.5163380394542, 4051.8784436466954, 11066.778664426667, 11334.14993875446, 11345.659630211107, 11433.199676022765, 11483.13876459269, 11350.54597816078, 11356.375399353115, 11368.317900925806, 11370.317780933005, 11382.430878456044, 8078.757637270891, 8467.068622451648, 8531.06158322584, 8594.183552562621, 8598.183172598594, 5962.761489540369, 6149.907751383822, 6156.538259630635, 6184.536159788124, 6309.526785491014, 10499.0, 10545.31455455393, 10552.366857988545, 10638.8936110641, 10644.201684873511, 10209.591616335263, 10525.263231574023, 10586.682399528027, 10736.355818650905, 10835.620753273597, 7261.564306141649, 7826.843463130819, 8010.91989080125, 8039.758807235792, 8189.795255118432, 8997.820043599222, 9007.369484136048, 9044.321675874204, 9066.909330906607, 9087.54562271897, 7975.641096150571, 8225.588720563828, 8296.83406331882, 8308.169183081643, 8417.5791210438, 8027.157148499324, 8066.959665201636, 8113.71601993951, 8213.055498617736, 8248.257656810676, 7251.311125443074, 7274.236205198378, 7323.707051718085, 7461.253874612712, 7463.776086717407, 5279.47205279469, 5337.0, 5413.0, 5413.8105166320565, 5415.972920135532, 5248.291480650063, 5314.734263286898, 5415.1335786274, 5417.6478528895495, 5590.0], "value": 4704.100871288308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.6165259210061, 321.27552369406993, 327.95900512435946, 329.12945259787847, 330.42387810145607, 5446.972765136169, 5546.197485817111, 5629.324481062273, 5637.321023550454, 5658.603897727161, 5552.694601796899, 5562.666240025601, 5565.193047008182, 5600.047991841387, 5600.411956744534, 4319.3952846601505, 4324.394584758136, 4335.1979883721615, 4338.436003319572, 4354.191546452536, 4244.257254980382, 4325.545817689144, 4342.565743425664, 4365.214261432957, 4384.276594361942, 4255.148970205955, 4293.656507479394, 4294.742315461082, 4296.871093867173, 4298.26929421999, 4252.298370768819, 4294.119705460389, 4299.527052024275, 4302.462192225956, 4306.590873866978, 3645.052286405527, 3763.438173158136, 3770.981145094257, 3771.9434208486896, 3776.4901738265257, 5459.890802183934, 5464.972675136639, 5476.726163691839, 5482.314710661168, 5482.5613950884235, 4921.827736029258, 4930.03864246472, 4939.456659767423, 4942.159832828428, 4951.331570238008, 5692.430756924275, 5797.159411885295, 5812.854678633025, 5858.238429004245, 5876.882462350729, 4128.483939507561, 4129.772862492562, 4144.979275103636, 4145.0, 4149.688773341982, 5793.652380857162, 5906.291245050621, 6119.0, 6134.4172303631085, 6138.0792881067755, 4139.668826493873, 4143.233501802176, 4148.34066373447, 4150.979245103756, 4162.167566486714, 4178.415021896937, 4192.3082691355585, 4213.873583792491, 4228.429162063144, 4239.194553034913, 4731.621470282369, 4874.171390863562, 4891.559759621651, 4903.239997800275, 4931.3835770528685, 5792.594518383757, 5818.79634212809, 5871.500922421556, 5874.412558744091, 5895.086261629454, 1463.5170393770031, 1465.2087872548918, 1477.541961991786, 1480.8519148085106, 1482.7553453680023, 905.5291248550717, 941.4022095969109, 948.2414068744977, 956.8038552096804, 971.9125278724948, 5072.82245121419, 5090.898182036339, 5110.211426000944, 5113.386393632788, 5175.896482070338, 5337.226102215234, 5382.407935127133, 5387.434319396485, 5391.595630327741, 5395.62230643859, 5068.59451243907, 5106.565941894906, 5183.974080129575, 5362.410134885237, 5803.158542011384, 3152.243461569207, 3201.599800024997, 3203.599550056243, 3219.6316565460056, 3223.3553289342226, 6174.38256174379, 6272.780452684134, 6303.842403939938, 6314.305426403092, 6322.936770632326, 6195.31851496335, 6195.783147589813, 6219.564630475914, 6220.595661282002, 6221.471174950089, 6276.552144663585, 6278.183836101369, 6288.968555157195, 6292.402221789014, 6354.26925903527, 5766.855828604318, 5952.791652292149, 5977.535503801597, 6011.879762404815, 6060.606060606046, 5972.58191926561, 5976.731047102978, 6002.009668404664, 6003.489703375262, 6023.879522409615, 5983.311919129182, 6036.879262414639, 6188.226471691039, 6203.720832562455, 6277.309495955533, 4205.558416366238, 4230.534641189405, 4243.405923170821, 4248.405223268683, 4258.339957306623, 5835.649861008353, 5965.433283838029, 6036.245469316335, 6047.881141988746, 6089.817305480843, 5795.565332599987, 5835.7373918174635, 5846.619969701956, 5853.385394533512, 5875.911861321998, 5776.19133321327, 5833.649981001154, 5886.0, 5912.231409916683, 5936.851578710567, 5582.883423315435, 5639.8590035249445, 5771.826845194651, 5776.480116789509, 5807.535397168301, 5862.530997520274, 5903.852403689943, 5904.557158213065, 5918.526517878646, 5938.940610593839, 5598.244237027949, 5759.65442073477, 5795.217645617788, 5796.188533605383, 5819.214406055297], "value": 4404.175125481598, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.1002126873498, 621.6208113051041, 687.6389895304965, 847.4491580472693, 860.3031544448996, 14828.6292842679, 15766.60583485412, 15792.368305267804, 15826.76259856103, 15846.20768961553, 14618.342174602141, 15268.618284542892, 15322.463713770021, 15469.0, 15479.0, 810.0886502684494, 825.4634487583058, 829.8962629671291, 831.1480732249432, 834.5201509132243, 818.7011740714626, 822.4037572759731, 823.5511646152861, 823.8064054947083, 824.0770337222319, 870.4907629037021, 873.76845136039, 875.0156074416282, 878.7319867440428, 878.8637761147, 867.6355930509138, 868.9608967596441, 873.462820365477, 873.8863947686792, 873.9082396348388, 623.6850390552742, 626.2172284644195, 630.1367127035944, 632.9208848893888, 633.0377825704903, 14672.853271467255, 14977.850221497754, 14980.1011939284, 15034.248287585577, 15044.548663540112, 13197.670058248525, 13306.401211945486, 13333.466661333536, 13354.666133346647, 13557.52548660802, 12120.151589388746, 12137.514499420013, 12272.570460033856, 12282.201656892274, 12668.113232073758, 3934.803259836997, 3959.5842436544035, 3986.40203969404, 4145.523264824554, 4157.605027522381, 77419.22580774233, 77546.22453775446, 79209.20790792133, 79262.6036869812, 79299.20700792976, 9847.704568862946, 10047.849282260771, 10134.189264858793, 10279.449549491279, 10338.276320657633, 20520.794792052187, 20687.689684654742, 20802.375928722162, 20847.270345537832, 20849.478763031046, 8958.148975847284, 9110.908890911138, 9119.908800912039, 9180.081991800767, 9384.061593840697, 4872.80508779652, 4991.825286114969, 5082.085224659597, 5239.423663397023, 5320.76056577455, 3610.765300255475, 3734.3651579231596, 3734.8132593370224, 3735.3089678409583, 3742.401215805458, 639.750497306051, 656.6125985668479, 662.9469642428594, 669.9497537684693, 675.9222689390783, 659.5053709717712, 693.0262980512388, 715.2704241673464, 743.4869939741561, 749.0786332810674, 9238.445693258425, 9612.66355677548, 9822.187128307078, 9824.508774561244, 9851.359661621971, 675.8141511084393, 687.2577616174519, 697.5465947134403, 698.552926127279, 707.2927072927073, 4711.95288047122, 4793.56193142063, 4819.7108173509705, 4848.3454733610515, 4853.053654537402, 118673.0, 118732.0, 119826.40086799511, 120745.0, 121238.39380803039, 104782.0, 107614.85273751819, 108590.0, 109004.0, 109844.0, 81917.59041204756, 92739.53630231805, 94659.0, 94965.0, 95016.0, 8893.911060889566, 9109.681161159328, 9198.586063627286, 9206.263498919936, 9308.813823723623, 38381.6161838378, 47513.52486475091, 47835.76082119567, 55373.0, 57859.0, 74545.0, 76390.0, 79845.0, 82488.83673286733, 85965.0, 13694.863051369359, 13701.314934253447, 14004.229767362485, 14218.715625687222, 14380.928095359457, 15559.533214003599, 15737.921310393374, 15917.28372223276, 16342.0, 16453.506394808173, 14283.428662853785, 14329.426822927384, 14635.853641463875, 15565.247228838864, 15807.051576905422, 14020.509282175075, 14330.785038224643, 14612.78080828767, 15074.0, 15088.396464141311, 14576.416943322572, 14927.552173434815, 15303.61740956485, 15306.23468826532, 15363.30865111095, 11057.723556911142, 11072.0, 11137.777244455228, 11139.0, 11215.831762523405, 10145.021590994067, 10584.259101863103, 11171.0, 11489.368084755084, 11724.88275117238], "value": 7730.908705807949, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 105.0, 111.0, 112.0, 111.0, 113.0, 112.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 149.0, 170.0, 118.0, 147.0, 147.0, 119.0, 170.0, 119.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 165.0, 161.0, 167.0, 169.0, 163.0, 161.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 141.0, 79.0, 75.0, 75.0, 75.0, 169.0, 76.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 150.0, 83.0, 84.0, 83.0, 131.0, 83.0, 84.0, 162.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 120.0, 120.0, 121.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 151.0, 151.0, 150.0, 148.0, 147.0, 148.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 97.0, 96.0, 100.0, 95.0, 96.0, 95.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 52.0, 51.0, 53.0, 55.0, 51.0, 52.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 65.0, 60.0, 65.0, 67.0, 60.0, 60.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 74.0, 75.0, 75.0, 75.0, 84.0, 82.0, 82.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 137.0, 132.0, 125.0, 129.0, 130.0, 129.0, 164.0, 130.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 158.0, 160.0, 162.0, 163.0, 159.0, 162.0, 158.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 67.0, 64.0, 67.0, 63.0, 64.0, 63.0, 65.0], "value": 64.7, "unit": "score"}]}]} 06:03:30 INFO - Return code: 0 06:03:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:03:30 ERROR - # TBPL SUCCESS # 06:03:30 INFO - Running post-action listener: _resource_record_post_action 06:03:30 INFO - ##### 06:03:30 INFO - ##### Finished run-tests step (success) 06:03:30 INFO - ##### 06:03:30 INFO - Running post-run listener: _resource_record_post_run 06:03:30 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559484928; Read time: 12; Write time: 472000 06:03:30 INFO - TinderboxPrint: CPU usage
13.3% 06:03:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:03:30 INFO - TinderboxPrint: I/O write bytes / time
559,484,928 / 472,000 06:03:30 INFO - TinderboxPrint: CPU idle
8,235.2 (86.7%) 06:03:30 INFO - TinderboxPrint: CPU user
1,213.2 (12.8%) 06:03:30 INFO - TinderboxPrint: Swap in / out
0 / 0 06:03:30 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 268451840; Read time: 0; Write time: 271292 06:03:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 291033088; Read time: 0; Write time: 200708 06:03:30 INFO - Running post-run listener: _upload_blobber_files 06:03:30 INFO - Blob upload gear active. 06:03:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:03:30 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:03:30 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:03:31 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:03:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:03:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:32 INFO - (blobuploader) - INFO - Done attempting. 06:03:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:03:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:03:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:33 INFO - (blobuploader) - INFO - Done attempting. 06:03:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:03:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:03:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:36 INFO - (blobuploader) - INFO - Done attempting. 06:03:36 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:36 INFO - Return code: 0 06:03:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89d7bccd28cd54e3a102c01f291c648e438753a9c656d60fa282a80ea2a1ab4a59bfdb3d8cd0df1a6abba530c02c03e3a7f4a590a1b7aed5812164a9f8b4aea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91903bb2dde0d61f0acd479ca525aee6cdacf4154d0dc2dd547aba250a66e9d1aa76064862fe59b602b84112e859aa6895aec08ce5e2029bbd358368e3711e91", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8239a5ea4b0cbf8e9dd94e66571566072a942d9d5041ff5c64b730c61d6a1c7ec566d7044f61bfd39010c71b2132b81a19dcbe4c890fa1c932850048ae307e76"} 06:03:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:36 INFO - Contents: 06:03:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89d7bccd28cd54e3a102c01f291c648e438753a9c656d60fa282a80ea2a1ab4a59bfdb3d8cd0df1a6abba530c02c03e3a7f4a590a1b7aed5812164a9f8b4aea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91903bb2dde0d61f0acd479ca525aee6cdacf4154d0dc2dd547aba250a66e9d1aa76064862fe59b602b84112e859aa6895aec08ce5e2029bbd358368e3711e91", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8239a5ea4b0cbf8e9dd94e66571566072a942d9d5041ff5c64b730c61d6a1c7ec566d7044f61bfd39010c71b2132b81a19dcbe4c890fa1c932850048ae307e76"} 06:03:36 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:36 INFO - Copying logs to upload dir... 06:03:36 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.720916 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-17 06:03:36.416394) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 06:03:36.420886) ========= 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=7de08804244eb36560b44971000001c3-1468759346.882662-599020637 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/Firefox/sha512/89d7bccd28cd54e3a102c01f291c648e438753a9c656d60fa282a80ea2a1ab4a59bfdb3d8cd0df1a6abba530c02c03e3a7f4a590a1b7aed5812164a9f8b4aea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91903bb2dde0d61f0acd479ca525aee6cdacf4154d0dc2dd547aba250a66e9d1aa76064862fe59b602b84112e859aa6895aec08ce5e2029bbd358368e3711e91", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8239a5ea4b0cbf8e9dd94e66571566072a942d9d5041ff5c64b730c61d6a1c7ec566d7044f61bfd39010c71b2132b81a19dcbe4c890fa1c932850048ae307e76"} build_url:https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/BsLHbjxuR_eY2-sldLbfzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89d7bccd28cd54e3a102c01f291c648e438753a9c656d60fa282a80ea2a1ab4a59bfdb3d8cd0df1a6abba530c02c03e3a7f4a590a1b7aed5812164a9f8b4aea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91903bb2dde0d61f0acd479ca525aee6cdacf4154d0dc2dd547aba250a66e9d1aa76064862fe59b602b84112e859aa6895aec08ce5e2029bbd358368e3711e91", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8239a5ea4b0cbf8e9dd94e66571566072a942d9d5041ff5c64b730c61d6a1c7ec566d7044f61bfd39010c71b2132b81a19dcbe4c890fa1c932850048ae307e76"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 06:03:36.453497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 06:03:36.453856) ========= 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=7de08804244eb36560b44971000001c3-1468759346.882662-599020637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 06:03:36.535393) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 06:03:36.535783) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 06:03:36.536109) ========= ========= Total master_lag: 0.22 =========