builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1467783153.75 results: success (0) buildid: 20160705193127 builduid: 816eb11402f5447d822073fc1bc20dc2 revision: 5fbfd52e02678da4a00b2535f568086ad3e33258 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.754231) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.754733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.755018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.770235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.770546) ========= 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=d2a8c569965ab8367867b893000001a1-1467783153.5472-528770780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 22:32:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.7M=0s 2016-07-05 22:32:33 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.889312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.889648) ========= 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=d2a8c569965ab8367867b893000001a1-1467783153.5472-528770780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014196 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:33.939520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 22:32:33.939874) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5fbfd52e02678da4a00b2535f568086ad3e33258 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5fbfd52e02678da4a00b2535f568086ad3e33258 --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=d2a8c569965ab8367867b893000001a1-1467783153.5472-528770780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 22:32:34,012 truncating revision to first 12 chars 2016-07-05 22:32:34,013 Setting DEBUG logging. 2016-07-05 22:32:34,013 attempt 1/10 2016-07-05 22:32:34,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5fbfd52e0267?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 22:32:35,443 unpacking tar archive at: mozilla-inbound-5fbfd52e0267/testing/mozharness/ program finished with exit code 0 elapsedTime=1.821466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 22:32:35.776584) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:35.776920) ========= script_repo_revision: 5fbfd52e02678da4a00b2535f568086ad3e33258 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:35.777301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:35.777581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:32:35.788002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-05 22:32:35.788279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=d2a8c569965ab8367867b893000001a1-1467783153.5472-528770780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:32:35 INFO - MultiFileLogger online at 20160705 22:32:35 in /builds/slave/test 22:32:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:32:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:32:35 INFO - {'append_to_log': False, 22:32:35 INFO - 'base_work_dir': '/builds/slave/test', 22:32:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:32:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:32:35 INFO - 'branch': 'Mozilla-Inbound', 22:32:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:32:35 INFO - 'config_files': ('talos/linux_config.py',), 22:32:35 INFO - 'default_actions': ('clobber', 22:32:35 INFO - 'read-buildbot-config', 22:32:35 INFO - 'download-and-extract', 22:32:35 INFO - 'populate-webroot', 22:32:35 INFO - 'create-virtualenv', 22:32:35 INFO - 'install', 22:32:35 INFO - 'run-tests'), 22:32:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:32:35 INFO - 'download_minidump_stackwalk': True, 22:32:35 INFO - 'download_symbols': 'ondemand', 22:32:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:32:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:32:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:32:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:32:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:32:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:32:35 INFO - 'installer_path': 'installer.exe', 22:32:35 INFO - 'log_level': 'info', 22:32:35 INFO - 'log_name': 'talos', 22:32:35 INFO - 'log_to_console': True, 22:32:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:32:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:32:35 INFO - 'opt_config_files': (), 22:32:35 INFO - 'pip_index': False, 22:32:35 INFO - 'sps_profile': False, 22:32:35 INFO - 'sps_profile_interval': 0, 22:32:35 INFO - 'suite': 'dromaeojs-e10s', 22:32:35 INFO - 'system_bits': '32', 22:32:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:32:35 INFO - 'title': 'talos-linux64-ix-043', 22:32:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:32:35 INFO - 'use_talos_json': True, 22:32:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:32:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:32:35 INFO - 'work_dir': 'build'} 22:32:35 INFO - ##### 22:32:35 INFO - ##### Running clobber step. 22:32:35 INFO - ##### 22:32:35 INFO - Running pre-action listener: _resource_record_pre_action 22:32:35 INFO - Running main action method: clobber 22:32:35 INFO - rmtree: /builds/slave/test/build 22:32:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:32:36 INFO - Running post-action listener: _resource_record_post_action 22:32:36 INFO - ##### 22:32:36 INFO - ##### Finished clobber step (success) 22:32:36 INFO - ##### 22:32:36 INFO - ##### 22:32:36 INFO - ##### Running read-buildbot-config step. 22:32:36 INFO - ##### 22:32:36 INFO - Running pre-action listener: _resource_record_pre_action 22:32:36 INFO - Running main action method: read_buildbot_config 22:32:36 INFO - Using buildbot properties: 22:32:36 INFO - { 22:32:36 INFO - "project": "", 22:32:36 INFO - "product": "firefox", 22:32:36 INFO - "script_repo_revision": "production", 22:32:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:32:36 INFO - "repository": "", 22:32:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:32:36 INFO - "buildid": "20160705193127", 22:32:36 INFO - "pgo_build": "True", 22:32:36 INFO - "basedir": "/builds/slave/test", 22:32:36 INFO - "buildnumber": 799, 22:32:36 INFO - "slavename": "talos-linux64-ix-043", 22:32:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:32:36 INFO - "platform": "ubuntu64_hw", 22:32:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:32:36 INFO - "branch": "mozilla-inbound", 22:32:36 INFO - "repo_path": "integration/mozilla-inbound", 22:32:36 INFO - "revision": "5fbfd52e02678da4a00b2535f568086ad3e33258", 22:32:36 INFO - "stage_platform": "linux64-pgo", 22:32:36 INFO - "builduid": "816eb11402f5447d822073fc1bc20dc2", 22:32:36 INFO - "slavebuilddir": "test" 22:32:36 INFO - } 22:32:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:32:36 INFO - Running post-action listener: _resource_record_post_action 22:32:36 INFO - ##### 22:32:36 INFO - ##### Finished read-buildbot-config step (success) 22:32:36 INFO - ##### 22:32:36 INFO - ##### 22:32:36 INFO - ##### Running download-and-extract step. 22:32:36 INFO - ##### 22:32:36 INFO - Running pre-action listener: _resource_record_pre_action 22:32:36 INFO - Running main action method: download_and_extract 22:32:36 INFO - mkdir: /builds/slave/test/build/tests 22:32:36 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')]} 22:32:36 INFO - https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:32:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:32:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:32:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:37 INFO - Downloaded 1361 bytes. 22:32:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:32:37 INFO - Using the following test package requirements: 22:32:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:32:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:32:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:32:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'jsshell-linux-x86_64.zip'], 22:32:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:32:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:32:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:32:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:32:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:32:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:32:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:37 INFO - https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:38 INFO - Downloaded 24300750 bytes. 22:32:38 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'] 22:32:38 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 22:32:39 INFO - Return code: 0 22:32:39 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 22:32:39 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')]} 22:32:39 INFO - https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:40 INFO - Downloaded 24300750 bytes. 22:32:40 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'] 22:32:40 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 22:32:41 INFO - Return code: 0 22:32:41 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')]} 22:32:41 INFO - https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:42 INFO - Downloaded 14403333 bytes. 22:32:42 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'] 22:32:42 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 22:32:43 INFO - Return code: 0 22:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:43 INFO - https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:32:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:32:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:32:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkOQot9fRwS4wvommiS4bg/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 22:32:44 INFO - Downloaded 60395644 bytes. 22:32:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:32:44 INFO - mkdir: /builds/slave/test/properties 22:32:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:32:44 INFO - Writing to file /builds/slave/test/properties/build_url 22:32:44 INFO - Contents: 22:32:44 INFO - build_url:https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:32:45 INFO - Running post-action listener: _resource_record_post_action 22:32:45 INFO - Running post-action listener: set_extra_try_arguments 22:32:45 INFO - ##### 22:32:45 INFO - ##### Finished download-and-extract step (success) 22:32:45 INFO - ##### 22:32:45 INFO - ##### 22:32:45 INFO - ##### Running populate-webroot step. 22:32:45 INFO - ##### 22:32:45 INFO - Running pre-action listener: _resource_record_pre_action 22:32:45 INFO - Running main action method: populate_webroot 22:32:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:32:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:32:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:32:45 INFO - '--tppagecycles', 22:32:45 INFO - '7'], 22:32:45 INFO - 'tests': ['tsvgm']}}, 22:32:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:32:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:32:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:32:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:32:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:32:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:32:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['damp', 'tps']}, 22:32:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'tests': ['damp', 'tps']}, 22:32:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['dromaeo_dom']}, 22:32:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:32:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['basic_compositor_video']}, 22:32:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:32:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['a11yr', 22:32:45 INFO - 'ts_paint', 22:32:45 INFO - 'tpaint', 22:32:45 INFO - 'sessionrestore', 22:32:45 INFO - 'sessionrestore_no_auto_restore', 22:32:45 INFO - 'tabpaint']}, 22:32:45 INFO - 'other-e10s': {'tests': ['a11yr', 22:32:45 INFO - 'ts_paint', 22:32:45 INFO - 'tpaint', 22:32:45 INFO - 'sessionrestore', 22:32:45 INFO - 'sessionrestore_no_auto_restore', 22:32:45 INFO - 'tabpaint']}, 22:32:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:32:45 INFO - 'ts_paint', 22:32:45 INFO - 'tpaint', 22:32:45 INFO - 'sessionrestore', 22:32:45 INFO - 'sessionrestore_no_auto_restore', 22:32:45 INFO - 'tabpaint']}, 22:32:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:32:45 INFO - 'ts_paint', 22:32:45 INFO - 'tpaint', 22:32:45 INFO - 'sessionrestore', 22:32:45 INFO - 'sessionrestore_no_auto_restore', 22:32:45 INFO - 'tabpaint']}, 22:32:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['a11yr', 22:32:45 INFO - 'ts_paint', 22:32:45 INFO - 'tpaint', 22:32:45 INFO - 'sessionrestore', 22:32:45 INFO - 'sessionrestore_no_auto_restore', 22:32:45 INFO - 'tabpaint']}, 22:32:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['a11yr', 22:32:45 INFO - 'ts_paint', 22:32:45 INFO - 'tpaint', 22:32:45 INFO - 'sessionrestore', 22:32:45 INFO - 'sessionrestore_no_auto_restore', 22:32:45 INFO - 'tabpaint']}, 22:32:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['tsvgx', 22:32:45 INFO - 'tsvgr_opacity', 22:32:45 INFO - 'tart', 22:32:45 INFO - 'tscrollx', 22:32:45 INFO - 'cart']}, 22:32:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:32:45 INFO - 'tsvgr_opacity', 22:32:45 INFO - 'tart', 22:32:45 INFO - 'tscrollx', 22:32:45 INFO - 'cart']}, 22:32:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'talos_options': ['--disable-e10s'], 22:32:45 INFO - 'tests': ['tp5o']}, 22:32:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'tests': ['tp5o']}, 22:32:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'talos_options': ['--disable-e10s', 22:32:45 INFO - '--xperf_path', 22:32:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:32:45 INFO - 'tests': ['tp5n']}, 22:32:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:45 INFO - 'talos_options': ['--xperf_path', 22:32:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:32:45 INFO - 'tests': ['tp5n']}}, 22:32:45 INFO - 'talos.zip': {'path': '', 22:32:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:32:45 INFO - Running post-action listener: _resource_record_post_action 22:32:45 INFO - ##### 22:32:45 INFO - ##### Finished populate-webroot step (success) 22:32:45 INFO - ##### 22:32:45 INFO - ##### 22:32:45 INFO - ##### Running create-virtualenv step. 22:32:45 INFO - ##### 22:32:45 INFO - Running pre-action listener: _resource_record_pre_action 22:32:45 INFO - Running main action method: create_virtualenv 22:32:45 INFO - Creating virtualenv /builds/slave/test/build/venv 22:32:45 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 22:32:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:32:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:32:45 INFO - Using real prefix '/usr' 22:32:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:32:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:32:47 INFO - Installing pip.................done. 22:32:47 INFO - Return code: 0 22:32:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:32:47 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')]} 22:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:47 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')]} 22:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:47 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:32:47 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 22:32:47 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 22:32:47 INFO - Using env: {'DISPLAY': ':0', 22:32:47 INFO - 'HOME': '/home/cltbld', 22:32:47 INFO - 'LANG': 'en_US.UTF-8', 22:32:47 INFO - 'LANGUAGE': 'en_US:en', 22:32:47 INFO - 'LOGNAME': 'cltbld', 22:32:47 INFO - 'MAIL': '/var/mail/cltbld', 22:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:47 INFO - 'MOZ_NO_REMOTE': '1', 22:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:47 INFO - 'NO_EM_RESTART': '1', 22:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:47 INFO - 'PWD': '/builds/slave/test', 22:32:47 INFO - 'SHELL': '/bin/bash', 22:32:47 INFO - 'SHLVL': '1', 22:32:47 INFO - 'TERM': 'linux', 22:32:47 INFO - 'TMOUT': '86400', 22:32:47 INFO - 'USER': 'cltbld', 22:32:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:47 INFO - '_': '/tools/buildbot/bin/python'} 22:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:48 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 22:32:48 INFO - Cleaning up... 22:32:48 INFO - Return code: 0 22:32:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:48 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:32:48 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 22:32:48 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 22:32:48 INFO - Using env: {'DISPLAY': ':0', 22:32:48 INFO - 'HOME': '/home/cltbld', 22:32:48 INFO - 'LANG': 'en_US.UTF-8', 22:32:48 INFO - 'LANGUAGE': 'en_US:en', 22:32:48 INFO - 'LOGNAME': 'cltbld', 22:32:48 INFO - 'MAIL': '/var/mail/cltbld', 22:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:48 INFO - 'MOZ_NO_REMOTE': '1', 22:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:48 INFO - 'NO_EM_RESTART': '1', 22:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:48 INFO - 'PWD': '/builds/slave/test', 22:32:48 INFO - 'SHELL': '/bin/bash', 22:32:48 INFO - 'SHLVL': '1', 22:32:48 INFO - 'TERM': 'linux', 22:32:48 INFO - 'TMOUT': '86400', 22:32:48 INFO - 'USER': 'cltbld', 22:32:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:48 INFO - '_': '/tools/buildbot/bin/python'} 22:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:48 INFO - Downloading/unpacking psutil>=3.1.1 22:32:48 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 22:32:48 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 22:32:48 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 22:32:48 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 22:32:48 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 22:32:48 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 22:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:32:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:32:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:32:50 INFO - Installing collected packages: psutil 22:32:50 INFO - Running setup.py install for psutil 22:32:50 INFO - building 'psutil._psutil_linux' extension 22:32:50 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 22:32:50 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 22:32:50 INFO - building 'psutil._psutil_posix' extension 22:32:50 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 22:32:50 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 22:32:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:32:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:32:50 INFO - Successfully installed psutil 22:32:50 INFO - Cleaning up... 22:32:50 INFO - Return code: 0 22:32:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:32:50 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')]} 22:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:50 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')]} 22:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:50 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:32:50 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 22:32:50 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 22:32:50 INFO - Using env: {'DISPLAY': ':0', 22:32:50 INFO - 'HOME': '/home/cltbld', 22:32:50 INFO - 'LANG': 'en_US.UTF-8', 22:32:50 INFO - 'LANGUAGE': 'en_US:en', 22:32:50 INFO - 'LOGNAME': 'cltbld', 22:32:50 INFO - 'MAIL': '/var/mail/cltbld', 22:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:50 INFO - 'MOZ_NO_REMOTE': '1', 22:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:50 INFO - 'NO_EM_RESTART': '1', 22:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:50 INFO - 'PWD': '/builds/slave/test', 22:32:50 INFO - 'SHELL': '/bin/bash', 22:32:50 INFO - 'SHLVL': '1', 22:32:50 INFO - 'TERM': 'linux', 22:32:50 INFO - 'TMOUT': '86400', 22:32:50 INFO - 'USER': 'cltbld', 22:32:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:50 INFO - '_': '/tools/buildbot/bin/python'} 22:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:32:51 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 22:32:51 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 22:32:51 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 22:32:51 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 22:32:51 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 22:32:51 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 22:32:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:32:53 INFO - Installing collected packages: mozsystemmonitor 22:32:53 INFO - Running setup.py install for mozsystemmonitor 22:32:53 INFO - Successfully installed mozsystemmonitor 22:32:53 INFO - Cleaning up... 22:32:53 INFO - Return code: 0 22:32:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:32:53 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')]} 22:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:53 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')]} 22:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:53 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:32:53 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 22:32:53 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 22:32:53 INFO - Using env: {'DISPLAY': ':0', 22:32:53 INFO - 'HOME': '/home/cltbld', 22:32:53 INFO - 'LANG': 'en_US.UTF-8', 22:32:53 INFO - 'LANGUAGE': 'en_US:en', 22:32:53 INFO - 'LOGNAME': 'cltbld', 22:32:53 INFO - 'MAIL': '/var/mail/cltbld', 22:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:53 INFO - 'MOZ_NO_REMOTE': '1', 22:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:53 INFO - 'NO_EM_RESTART': '1', 22:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:53 INFO - 'PWD': '/builds/slave/test', 22:32:53 INFO - 'SHELL': '/bin/bash', 22:32:53 INFO - 'SHLVL': '1', 22:32:53 INFO - 'TERM': 'linux', 22:32:53 INFO - 'TMOUT': '86400', 22:32:53 INFO - 'USER': 'cltbld', 22:32:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:53 INFO - '_': '/tools/buildbot/bin/python'} 22:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:53 INFO - Downloading/unpacking jsonschema==2.5.1 22:32:53 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 22:32:53 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 22:32:53 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 22:32:53 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 22:32:53 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 22:32:53 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 22:32:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:32:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:55 INFO - Downloading functools32-3.2.3-2.tar.gz 22:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:32:55 INFO - warning: no files found matching '*.txt' 22:32:55 INFO - no previously-included directories found matching 'build' 22:32:55 INFO - no previously-included directories found matching 'dist' 22:32:55 INFO - no previously-included directories found matching '.git*' 22:32:55 INFO - Installing collected packages: jsonschema, functools32 22:32:55 INFO - Running setup.py install for functools32 22:32:55 INFO - warning: no files found matching '*.txt' 22:32:55 INFO - no previously-included directories found matching 'build' 22:32:55 INFO - no previously-included directories found matching 'dist' 22:32:55 INFO - no previously-included directories found matching '.git*' 22:32:55 INFO - Successfully installed jsonschema functools32 22:32:55 INFO - Cleaning up... 22:32:55 INFO - Return code: 0 22:32:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:32:55 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')]} 22:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:55 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')]} 22:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:55 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:32:55 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 22:32:55 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 22:32:55 INFO - Using env: {'DISPLAY': ':0', 22:32:55 INFO - 'HOME': '/home/cltbld', 22:32:55 INFO - 'LANG': 'en_US.UTF-8', 22:32:55 INFO - 'LANGUAGE': 'en_US:en', 22:32:55 INFO - 'LOGNAME': 'cltbld', 22:32:55 INFO - 'MAIL': '/var/mail/cltbld', 22:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:55 INFO - 'MOZ_NO_REMOTE': '1', 22:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:55 INFO - 'NO_EM_RESTART': '1', 22:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:55 INFO - 'PWD': '/builds/slave/test', 22:32:55 INFO - 'SHELL': '/bin/bash', 22:32:55 INFO - 'SHLVL': '1', 22:32:55 INFO - 'TERM': 'linux', 22:32:55 INFO - 'TMOUT': '86400', 22:32:55 INFO - 'USER': 'cltbld', 22:32:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:55 INFO - '_': '/tools/buildbot/bin/python'} 22:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:57 INFO - Downloading blobuploader-1.2.4.tar.gz 22:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:32:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:32:58 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 22:32:58 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 22:32:58 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 22:32:58 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 22:32:58 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 22:32:58 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 22:32:58 INFO - Downloading docopt-0.6.1.tar.gz 22:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:32:58 INFO - Installing collected packages: blobuploader, requests, docopt 22:32:58 INFO - Running setup.py install for blobuploader 22:32:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:32:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:32:58 INFO - Running setup.py install for requests 22:32:59 INFO - Running setup.py install for docopt 22:32:59 INFO - Successfully installed blobuploader requests docopt 22:32:59 INFO - Cleaning up... 22:32:59 INFO - Return code: 0 22:32:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:59 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:32:59 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 22:32:59 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 22:32:59 INFO - Using env: {'DISPLAY': ':0', 22:32:59 INFO - 'HOME': '/home/cltbld', 22:32:59 INFO - 'LANG': 'en_US.UTF-8', 22:32:59 INFO - 'LANGUAGE': 'en_US:en', 22:32:59 INFO - 'LOGNAME': 'cltbld', 22:32:59 INFO - 'MAIL': '/var/mail/cltbld', 22:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:59 INFO - 'MOZ_NO_REMOTE': '1', 22:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:59 INFO - 'NO_EM_RESTART': '1', 22:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:59 INFO - 'PWD': '/builds/slave/test', 22:32:59 INFO - 'SHELL': '/bin/bash', 22:32:59 INFO - 'SHLVL': '1', 22:32:59 INFO - 'TERM': 'linux', 22:32:59 INFO - 'TMOUT': '86400', 22:32:59 INFO - 'USER': 'cltbld', 22:32:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:59 INFO - '_': '/tools/buildbot/bin/python'} 22:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:32:59 INFO - Running setup.py (path:/tmp/pip-X7DRCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:32:59 INFO - Running setup.py (path:/tmp/pip-ymbvGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:32:59 INFO - Running setup.py (path:/tmp/pip-dlbwIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:32:59 INFO - Running setup.py (path:/tmp/pip-cELjpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:32:59 INFO - Running setup.py (path:/tmp/pip-St8FOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:32:59 INFO - Running setup.py (path:/tmp/pip-fnI63d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:32:59 INFO - Running setup.py (path:/tmp/pip-ZrTjK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:32:59 INFO - Running setup.py (path:/tmp/pip-rLhUSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:00 INFO - Running setup.py (path:/tmp/pip-DIt8zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:00 INFO - Running setup.py (path:/tmp/pip-LgE8L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:00 INFO - Running setup.py (path:/tmp/pip-1ButAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:00 INFO - Running setup.py (path:/tmp/pip-PGYcEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:00 INFO - Running setup.py (path:/tmp/pip-i8p9Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:00 INFO - Running setup.py (path:/tmp/pip-LuAVqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:00 INFO - Running setup.py (path:/tmp/pip-uOMuZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:00 INFO - Running setup.py (path:/tmp/pip-WcKcXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:00 INFO - Running setup.py (path:/tmp/pip-BJt5TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:33:00 INFO - Running setup.py install for manifestparser 22:33:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:33:00 INFO - Running setup.py install for mozcrash 22:33:00 INFO - Running setup.py install for mozdebug 22:33:01 INFO - Running setup.py install for mozdevice 22:33:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Running setup.py install for mozfile 22:33:01 INFO - Running setup.py install for mozhttpd 22:33:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Running setup.py install for mozinfo 22:33:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Running setup.py install for mozInstall 22:33:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Running setup.py install for mozleak 22:33:01 INFO - Running setup.py install for mozlog 22:33:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Running setup.py install for moznetwork 22:33:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:33:01 INFO - Running setup.py install for mozprocess 22:33:01 INFO - Running setup.py install for mozprofile 22:33:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:33:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:33:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:33:02 INFO - Running setup.py install for mozrunner 22:33:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:33:02 INFO - Running setup.py install for mozscreenshot 22:33:02 INFO - Running setup.py install for moztest 22:33:02 INFO - Running setup.py install for mozversion 22:33:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:33:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:33:02 INFO - Cleaning up... 22:33:02 INFO - Return code: 0 22:33:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:02 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:33:02 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 22:33:02 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 22:33:02 INFO - Using env: {'DISPLAY': ':0', 22:33:02 INFO - 'HOME': '/home/cltbld', 22:33:02 INFO - 'LANG': 'en_US.UTF-8', 22:33:02 INFO - 'LANGUAGE': 'en_US:en', 22:33:02 INFO - 'LOGNAME': 'cltbld', 22:33:02 INFO - 'MAIL': '/var/mail/cltbld', 22:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:02 INFO - 'MOZ_NO_REMOTE': '1', 22:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:02 INFO - 'NO_EM_RESTART': '1', 22:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:02 INFO - 'PWD': '/builds/slave/test', 22:33:02 INFO - 'SHELL': '/bin/bash', 22:33:02 INFO - 'SHLVL': '1', 22:33:02 INFO - 'TERM': 'linux', 22:33:02 INFO - 'TMOUT': '86400', 22:33:02 INFO - 'USER': 'cltbld', 22:33:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:02 INFO - '_': '/tools/buildbot/bin/python'} 22:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:02 INFO - Running setup.py (path:/tmp/pip-7kxQq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:02 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)) 22:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:02 INFO - Running setup.py (path:/tmp/pip-lydBo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:02 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)) 22:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:02 INFO - Running setup.py (path:/tmp/pip-acduMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:02 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)) 22:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:02 INFO - Running setup.py (path:/tmp/pip-Bo8zVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:03 INFO - Running setup.py (path:/tmp/pip-obCtyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:03 INFO - Running setup.py (path:/tmp/pip-CrCkie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:03 INFO - Running setup.py (path:/tmp/pip-0YUVHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:03 INFO - Running setup.py (path:/tmp/pip-JwQmfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:03 INFO - Running setup.py (path:/tmp/pip-Qz_qkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:03 INFO - Running setup.py (path:/tmp/pip-tVcf7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:03 INFO - Running setup.py (path:/tmp/pip-Pi6Zdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:03 INFO - Running setup.py (path:/tmp/pip-YcZPMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:03 INFO - Running setup.py (path:/tmp/pip-JRqaLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:03 INFO - Running setup.py (path:/tmp/pip-vj9oqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:03 INFO - Running setup.py (path:/tmp/pip-cC41kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:03 INFO - Running setup.py (path:/tmp/pip-QYN4wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:03 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)) 22:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:03 INFO - Running setup.py (path:/tmp/pip-yENJ0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:03 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)) 22:33:03 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)) 22:33:03 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)) 22:33:03 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)) 22:33:03 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)) 22:33:03 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)) 22:33:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:33:03 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 22:33:03 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 22:33:03 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 22:33:03 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 22:33:03 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 22:33:03 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 22:33:05 INFO - Downloading blessings-1.6.tar.gz 22:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:33:05 INFO - Installing collected packages: blessings 22:33:05 INFO - Running setup.py install for blessings 22:33:06 INFO - Successfully installed blessings 22:33:06 INFO - Cleaning up... 22:33:06 INFO - Return code: 0 22:33:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:06 INFO - Reading from file tmpfile_stdout 22:33:06 INFO - Current package versions: 22:33:06 INFO - argparse == 1.2.1 22:33:06 INFO - blessings == 1.6 22:33:06 INFO - blobuploader == 1.2.4 22:33:06 INFO - docopt == 0.6.1 22:33:06 INFO - functools32 == 3.2.3-2 22:33:06 INFO - jsonschema == 2.5.1 22:33:06 INFO - manifestparser == 1.1 22:33:06 INFO - mozInstall == 1.12 22:33:06 INFO - mozcrash == 0.17 22:33:06 INFO - mozdebug == 0.1 22:33:06 INFO - mozdevice == 0.48 22:33:06 INFO - mozfile == 1.2 22:33:06 INFO - mozhttpd == 0.7 22:33:06 INFO - mozinfo == 0.9 22:33:06 INFO - mozleak == 0.1 22:33:06 INFO - mozlog == 3.2 22:33:06 INFO - moznetwork == 0.27 22:33:06 INFO - mozprocess == 0.22 22:33:06 INFO - mozprofile == 0.28 22:33:06 INFO - mozrunner == 6.11 22:33:06 INFO - mozscreenshot == 0.1 22:33:06 INFO - mozsystemmonitor == 0.3 22:33:06 INFO - moztest == 0.7 22:33:06 INFO - mozversion == 1.4 22:33:06 INFO - psutil == 3.1.1 22:33:06 INFO - requests == 1.2.3 22:33:06 INFO - wsgiref == 0.1.2 22:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:06 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:33:06 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 22:33:06 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 22:33:06 INFO - Using env: {'DISPLAY': ':0', 22:33:06 INFO - 'HOME': '/home/cltbld', 22:33:06 INFO - 'LANG': 'en_US.UTF-8', 22:33:06 INFO - 'LANGUAGE': 'en_US:en', 22:33:06 INFO - 'LOGNAME': 'cltbld', 22:33:06 INFO - 'MAIL': '/var/mail/cltbld', 22:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:06 INFO - 'MOZ_NO_REMOTE': '1', 22:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:06 INFO - 'NO_EM_RESTART': '1', 22:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:06 INFO - 'PWD': '/builds/slave/test', 22:33:06 INFO - 'SHELL': '/bin/bash', 22:33:06 INFO - 'SHLVL': '1', 22:33:06 INFO - 'TERM': 'linux', 22:33:06 INFO - 'TMOUT': '86400', 22:33:06 INFO - 'USER': 'cltbld', 22:33:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:06 INFO - '_': '/tools/buildbot/bin/python'} 22:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 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)) 22:33:06 INFO - Cleaning up... 22:33:06 INFO - Return code: 0 22:33:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:06 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 0x191b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, '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': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', '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 22:33:06 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 22:33:06 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 22:33:06 INFO - Using env: {'DISPLAY': ':0', 22:33:06 INFO - 'HOME': '/home/cltbld', 22:33:06 INFO - 'LANG': 'en_US.UTF-8', 22:33:06 INFO - 'LANGUAGE': 'en_US:en', 22:33:06 INFO - 'LOGNAME': 'cltbld', 22:33:06 INFO - 'MAIL': '/var/mail/cltbld', 22:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:06 INFO - 'MOZ_NO_REMOTE': '1', 22:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:06 INFO - 'NO_EM_RESTART': '1', 22:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:06 INFO - 'PWD': '/builds/slave/test', 22:33:06 INFO - 'SHELL': '/bin/bash', 22:33:06 INFO - 'SHLVL': '1', 22:33:06 INFO - 'TERM': 'linux', 22:33:06 INFO - 'TMOUT': '86400', 22:33:06 INFO - 'USER': 'cltbld', 22:33:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:06 INFO - '_': '/tools/buildbot/bin/python'} 22:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:33:06 INFO - Cleaning up... 22:33:06 INFO - Return code: 0 22:33:06 INFO - Running post-action listener: _resource_record_post_action 22:33:06 INFO - Running post-action listener: _start_resource_monitoring 22:33:06 INFO - Starting resource monitoring. 22:33:06 INFO - ##### 22:33:06 INFO - ##### Finished create-virtualenv step (success) 22:33:06 INFO - ##### 22:33:06 INFO - ##### 22:33:06 INFO - ##### Running install step. 22:33:06 INFO - ##### 22:33:06 INFO - Running pre-action listener: _resource_record_pre_action 22:33:06 INFO - Running main action method: install 22:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:06 INFO - Reading from file tmpfile_stdout 22:33:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:33:07 INFO - Reading from file tmpfile_stdout 22:33:07 INFO - Output received: 22:33:07 INFO - Usage: mozinstall [options] installer 22:33:07 INFO - Options: 22:33:07 INFO - -h, --help show this help message and exit 22:33:07 INFO - -d DEST, --destination=DEST 22:33:07 INFO - Directory to install application into. [default: 22:33:07 INFO - "/builds/slave/test"] 22:33:07 INFO - --app=APP Application being installed. [default: firefox] 22:33:07 INFO - mkdir: /builds/slave/test/build/application 22:33:07 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'] 22:33:07 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 22:33:24 INFO - Reading from file tmpfile_stdout 22:33:24 INFO - Output received: 22:33:24 INFO - /builds/slave/test/build/application/firefox/firefox 22:33:24 INFO - Running post-action listener: _resource_record_post_action 22:33:24 INFO - ##### 22:33:24 INFO - ##### Finished install step (success) 22:33:24 INFO - ##### 22:33:24 INFO - ##### 22:33:24 INFO - ##### Running run-tests step. 22:33:24 INFO - ##### 22:33:24 INFO - Running pre-action listener: _resource_record_pre_action 22:33:24 INFO - Running main action method: run_tests 22:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:33:24 INFO - Python 2.7.3 22:33:24 INFO - Return code: 0 22:33:24 INFO - grabbing minidump binary from tooltool 22:33: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')]} 22:33:24 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 0x1bd9570>, '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 0x1bda470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bda900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:33:24 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 22:33:24 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 22:33:24 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 22:33:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:33:24 INFO - Return code: 0 22:33:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:33:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:33:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:33:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:33:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 22:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 22:33:24 INFO - Using env: {'DISPLAY': ':0', 22:33:24 INFO - 'HOME': '/home/cltbld', 22:33:24 INFO - 'LANG': 'en_US.UTF-8', 22:33:24 INFO - 'LANGUAGE': 'en_US:en', 22:33:24 INFO - 'LOGNAME': 'cltbld', 22:33:24 INFO - 'MAIL': '/var/mail/cltbld', 22:33:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:33:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:24 INFO - 'MOZ_NO_REMOTE': '1', 22:33:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:24 INFO - 'NO_EM_RESTART': '1', 22:33:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:24 INFO - 'PWD': '/builds/slave/test', 22:33:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:33:24 INFO - 'SHELL': '/bin/bash', 22:33:24 INFO - 'SHLVL': '1', 22:33:24 INFO - 'TERM': 'linux', 22:33:24 INFO - 'TMOUT': '86400', 22:33:24 INFO - 'USER': 'cltbld', 22:33:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467783153.5472-528770780', 22:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:24 INFO - '_': '/tools/buildbot/bin/python'} 22:33:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 22:33:24 INFO - mozversion application_buildid: 20160705193127 22:33:24 INFO - mozversion application_changeset: 5fbfd52e02678da4a00b2535f568086ad3e33258 22:33:24 INFO - mozversion application_display_name: Nightly 22:33:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:33:24 INFO - mozversion application_name: Firefox 22:33:24 INFO - mozversion application_remotingname: firefox 22:33:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:33:24 INFO - mozversion application_vendor: Mozilla 22:33:24 INFO - mozversion application_version: 50.0a1 22:33:24 INFO - mozversion platform_buildid: 20160705193127 22:33:24 INFO - mozversion platform_changeset: 5fbfd52e02678da4a00b2535f568086ad3e33258 22:33:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:33:24 INFO - mozversion platform_version: 50.0a1 22:33:24 INFO - using testdate: 1467783204 22:33:24 INFO - actual date: 1467783204 22:33:24 INFO - starting webserver on 'localhost:43724' 22:33:24 INFO - SUITE-START | Running 2 tests 22:33:24 INFO - TEST-START | dromaeo_css 22:33:24 INFO - operating with platform_type : linux_ 22:33:24 INFO - Initialising browser for dromaeo_css test... 22:33:24 INFO - TEST-INFO | started process 6512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpocHrlz/profile http://localhost:43724/getInfo.html) 22:33:29 INFO - PROCESS | 6512 | __metrics Screen width/height:1600/1200 22:33:29 INFO - PROCESS | 6512 | colorDepth:24 22:33:29 INFO - PROCESS | 6512 | Browser inner width/height: 1024/697 22:33:29 INFO - PROCESS | 6512 | __metrics 22:33:29 ERROR - PROCESS | 6512 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 22:33:30 INFO - TEST-INFO | 6512: exit 0 22:33:30 INFO - Browser initialized. 22:33:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:33:30 INFO - TEST-INFO | started process 6631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpocHrlz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:33:42 INFO - PROCESS | 6631 | RSS: Main: 168685568 22:33:42 INFO - PROCESS | 6631 | 22:34:32 INFO - PROCESS | 6631 | 1467783272238 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] 22:36:39 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:43724/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43724/tests/dromaeo/cssquery-ext.html) 22:36:40 INFO - PROCESS | 6631 | RSS: Main: 171675648 22:36:40 INFO - PROCESS | 6631 | 22:39:43 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:43724/tests/dromaeo/cssquery-ext.html (next: http://localhost:43724/tests/dromaeo/cssquery-jquery.html) 22:39:43 INFO - PROCESS | 6631 | RSS: Main: 168427520 22:39:43 INFO - PROCESS | 6631 | 22:42:45 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:43724/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43724/tests/dromaeo/cssquery-mootools.html) 22:42:46 INFO - PROCESS | 6631 | RSS: Main: 171638784 22:42:46 INFO - PROCESS | 6631 | 22:45:47 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:43724/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43724/tests/dromaeo/cssquery-prototype.html) 22:45:48 INFO - PROCESS | 6631 | RSS: Main: 166993920 22:45:48 INFO - PROCESS | 6631 | 22:48:51 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:43724/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43724/tests/dromaeo/cssquery-yui.html) 22:48:51 INFO - PROCESS | 6631 | RSS: Main: 169259008 22:48:51 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:43724/tests/dromaeo/cssquery-yui.html (next: http://localhost:43724/tests/dromaeo/cssquery-dojo.html) 22:51:54 INFO - PROCESS | 6631 | RSS: Main: 170483712 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | __start_tp_report 22:51:54 INFO - PROCESS | 6631 | _x_x_mozilla_page_load 22:51:54 INFO - PROCESS | 6631 | _x_x_mozilla_page_load_details 22:51:54 INFO - PROCESS | 6631 | |i|pagename|runs| 22:51:54 INFO - PROCESS | 6631 | |0;dojo.html;3036.1498780341512;3038.4834578121718;3054.068509104722;3101.7828751987354;3108.803110802342;5281.075811732951;5283.2867562879;5295.708736019522;5320.9467905320935;5363.785448582062;5247.658902171356;5257.631965762398;5333.493318134771;5351.866203344918;5366.892662146754;4845.491223421534;4876.707397556158;4963.950360496385;5000.07498612756;5019.247112933052;407.129994519404;4757;4899.142650036247;4943.1596628573225;5056.873578160557;4926.852194434173;4961.8511444656715;4978.278149668296;5004.924926126111;5008.198688209887;4947.282644016634;5002.224655178453;5004.599632029429;5006.8497945061345;5034.4713805050305;4847.733374664392;4858.319835223072;4904.828331008433;4926.3842019747535;4933.605311575066;5371.274877891513;5380.596455265871;5382.946170538284;5414.512693857571;5449.972750136264;5621.634593751393;5767.625104368202;5775.566832487538;5784.334801497839;5832.24180856486;5757.136429535562;5783.306003279633;5784.595078344518;5800.158976948361;5808.332041815161;5353.2237825515085;5363.410024897258;5385.78456861725;5406.08096623575;5416.404195538487;5675.943240567624;5842.415758424124;5912.201852749824;5913.379095194942;5932.7330270137945;5628.155776633538;5688.744006519633;5699.971500142473;5730.484256416942;5767.8175973925245;5787.247657804459;5803.506701930299;5811.041178205549;5814.883702325929;5818.854528636733;5455.536279416294;5761.769529218868;5772.422757724194;5800.796972105956;5801.767929282866;5719.513841323451;5734.254546908958;5744;5784.132380143013;5807.390224026501;4385.101054283864;4412.823487060482;4425.269830477935;4432.423784907941;4438.911221775546;3826.8086595670106;3829.3872980323013;3864.7874366909527;3874.2832575973534;3987.8404863805704;5393.514583687487;5439.700816455133;5470.234167216593;5480.26016487777;5489.204065410573;5684.857878552986;5752.9712351437975;5772.509336706427;5774.68239246837;5776.220210271559;5392.056390131711;5473.75368108436;5494.313210848644;5498;5619.100943849046;4988.376452943382;5009.0482808266315;5024.2463630454995;5033.245013247969;5040.747962601855;6036.728347224385;6043.033114701714;6049.727762250709;6050.092486127116;6052.939470605325;5647.435256474319;5659.037963546207;5664.320281566238;5745.368009519033;5756.625819321731;5877.617954832922;5956.612820166675;5971.7611295547695;5974.462298393166;5993.880122397615;5523.502884740393;5654.264945557051;5659.207710920392;5673.404292549223;5679.0345641240265;5719.113537401709;5764.942350576608;5776.162456443876;5803.332616749128;5816.098504731774;5627.099664053731;5627.21219029328;5633.802816901552;5640.097584386643;5659.292588426447;5490.615656903979;5565.499105080562;5601.383847776823;5617.382087970402;5630.23991761107;5526.502614764529;5544.695041772741;5568.805091821767;5579.69311687861;5585.69278689676;5633.1831884375715;5634.802781902614;5654.83035508919;5655.660660360391;5658.151277308437;5385.111456609616;5479.6164268500825;5498.3127109111365;5554.2779438672715;5561.582881284001 22:51:54 INFO - PROCESS | 6631 | |1;ext.html;553.5260674972783;583.011795007462;587.9088741245107;611.6910959965217;627.2441707742171;39673.40489892651;42639.57360426395;42944.57055429445;43005.78497107514;43079.78460107703;43068.353974690326;43291;43468.130637387236;43564.346534802;43610;8862.556872156398;9014.954925225366;9046.276297896153;9048.592813323383;9056.184943355096;8809.955950220272;8981.820363592724;9021.503817290046;9028.68399606014;9029.277657787394;9025.909740902605;9046.185843274105;9055.773605659846;9135.086491350845;9136;8988.640454381817;9007.144321289466;9010.45937243761;9033.367664263504;9055.275577953747;8901.287896968228;8954.507502087383;8959.283257339397;8972.192502674725;8977.32670049749;33016.50475242873;40812.38781418281;41226.58773412288;41525.37711934323;41587.79206103981;3347.645443096989;3506.8947931562093;3597.7661452005536;3945.270125026879;4192.308269135589;31548.211294717585;32016;32133.35733285321;33705.32589348224;34848.65151348505;4542.750148741818;4575.748333841638;4632.953670463286;4695.835645752382;4824.879378015543;368557;368856;371189;372415;374579;32715.672843271263;33065.834670826975;33110.17224569357;33138.50292245618;61550.69224653938;37978.810105949844;37996.62003379986;38126.80936595299;38129;38156;13178.60464186076;13204.075714699879;13211.73576528464;13233.272170030741;13302.135361201492;11704.70738231551;11864.050875929905;11869.76260474803;11916.285022898654;11949.522019119311;8457.873131903027;8507.27688146502;8576.957115214384;8583.18459746323;8600.13998600135;3380.4760262159402;3383.289509203046;3390.304987477561;3414.5390372299917;3424.7260219182403;950.4819873169139;1034.234666346913;1073.7154654016692;1085.5603480590373;1160.2110564815837;32079;32232;33131.834340828624;33199.83400083033;33350.16624584405;1057.5188289328337;1073.061071562383;1079.0881704959454;1110.1507346879644;1174.1546086817477;17036;17125.57186070358;17131.486055418358;17283.308667653404;17372.218250178772;563680;564526;568934;569435;571974;57921.13118303229;58222.708886456145;58718.70640646855;58718.70640646855;58772.41227587755;1331.766940785378;1344.5159742492694;1381.5579014715195;1383.9377228024764;1385.4735200623697;30864.382712346076;31191.84404077965;31587.526187107673;32170.51744223885;32321.51517727189;52098;52351;52490.475095248556;52535.47464525306;52553;473590;480907;481717;482812;483166;29092.127236182947;29205;29344.853275733483;29547.704522954496;29659.703402965693;49316;49463.752681236365;49987.25019124789;50445.24332135094;50502.494975049776;41546.58453415548;42220;42328.1534369317;42828.35757463578;43485.782571086944;40888.911108888875;41078.79460602797;41687.1662566753;42029.78985105055;42788.358174628025;35833.46249806203;40486.392704110054;40542.78371648855;41589.58410415857;42333.153336933705;35205.647943520235;36978.26043479169;37326;37717;37735.81132094322;27812.860935695193;28714.425711485237;28729;29010.854945725136;29071.418571628026 22:51:54 INFO - PROCESS | 6631 | |2;jquery.html;386.61531775882963;388.0763782198369;395.778364116095;398.7189031732629;409.55563213912905;18569.907150464263;20477.078531466082;20501.897490512525;20613.896930515326;20674.793252067473;17922.10389480524;18278.177482013307;18396.816031839677;19897.701534476957;20030.49923751907;5684.914726279109;5830.679312637803;5888.735006924699;5914.083317085859;5930.140129681194;5713.685747283918;5736.196932429463;5806.216160818278;5854;5883.735231914574;5708.08670612702;5755.9927012772805;5791.623544469617;5860.413958604148;5866.090755932837;5719.227904232958;5731.885362292752;5766.82699519013;5785.768569257246;5812.186293918855;5131.640785145041;5134.64057515974;5162.638615296931;5167.6641018333685;5214.139666954948;23835;24499.02003919841;24685.876570617213;24811.503769924682;25081.122160724288;2470.308313672175;2509.1970569417795;2510.2218312323057;2556.5014822109697;2744.2316151477617;14557.417703291856;14874.776878346725;15032.098074115478;15230.695386092328;15394.615134621725;1875.3904980881132;1956;1988.0258673250003;1988.8408927285782;1989.4529004523727;59544;69224.3077569223;80711.59644201859;81637.18362816355;82652.58673706593;10854.837177442345;11054.392008439452;11061.557537698402;11261.605843795593;11308.208425410307;15224.238788060553;15399.46101886451;15502.224888755518;15508.767368489256;15534.922325388527;7733.690652373954;7776.688932442752;7913.881291780628;7922.841543169219;7967.641456134372;7230.674619642129;7275;7320.1215854097845;7330.96334518324;7515.473916825769;4757.548032936866;4818.6626936114835;4840.709557426566;4842.612590992712;4912.8280510182685;1910.1881700277327;1986.1459572384013;2005.1578337098454;2022.48426651203;2032.3699653107583;879.2658130461136;959.6545243712258;977.8093271811929;1027.1269420992096;1073.0717928991521;19484;20481.078351474218;21569.89215053946;21582.244621438174;21637.242696505546;942.4910548303839;957.7174733453647;963.4219468319093;999.6351331763854;1061.1245722278995;10023;11354.602588909349;11487.540498380138;11509.424528773528;11601.477933493014;471821;472916;474442;525318;542443;83243.58378208191;92525;101058;102442.48778756207;104453;1013.437542164106;1043.582566973217;1044.895510448949;1051.579368252705;1059.592057058038;17045.659086818443;18623;19034.143463543896;19200.327988520334;19434.514137146685;31118.22204444907;32750.836245818617;44727.32909006302;44838.32860639151;47863.282050769965;65666;65867.67066164638;66544.66727666331;67155;67790.66104669445;8647.0920553341;8885.4668719877;8952.507612081137;8976;9005.549722513979;10173.389596624227;13890.722185556031;13973.510927117502;14204.78692819588;14299.21354325522;12322.938385308016;12427.31649759272;12443.626691198917;12482;12543.24740515572;12056.698582535506;12213.328266945047;12269.69325766863;12320.630381088582;12439.564615238423;12165.270083795001;12646;12735.681607959876;12810.615681529569;12882.227066376048;8921.687740929035;8943.195112439911;9031.819363612822;9075.954620226856;9175.495347755937;11994.940025299818;12247.510099595916;12300.569480068154;12406.751864962831;12478 22:51:54 INFO - PROCESS | 6631 | |3;mootools.html;1453.970920581588;1464.9121052736834;1594.5057032319983;1730;1777.0581591756356;7228.277172282769;7841.059072911258;7920.564368959705;8323.583820808966;8347.91652083479;7978.521288722666;8124.959375203131;8141.267285944264;8199.672013119469;8202.466839655433;2094.1518684932626;2113.619548481273;2120.809127178554;2123.6495978163584;2131.3499382688274;2194.8792816395094;2254.785795349439;2260.7174103237094;2263.909443622253;2266.093562574975;2233.2853486884205;2236.519148383097;2237;2257.1084421653436;2257.503349263168;2206.768289329629;2208.447888028001;2214.8671079735186;2218.6450167973207;2220.2340192633596;2162.4918144236094;2184.4648061225103;2186.584548935697;2190.9452263693533;2193.670949357593;8080.8383832323025;8146.877796833052;8164.306033987118;8220.958895205546;8251.216134467277;4737.218358970766;4896.167651499253;4904.264360345941;4907.460179380265;4925.729084900329;3096.922576935572;3111.533270009494;3155.8895438659765;3163.066895265879;3222.0494953988627;1053.4732633683159;1061.8194906865851;1087.2986923434419;1096.1285777806663;1097.8023955687972;10951.288166269247;10973.23187376884;10982.121430285639;10983.560657573687;11016.228863979524;4094.1402305516176;4259.595338442843;4345.782710864444;4350.086481838849;4355.891102722458;9382.10869967352;9383.483908385104;9445.338826282232;9447.338686291894;9447.480388578695;4739.052189562101;4767.165745994437;4769.809207631656;4771.904561908812;4794.328793968847;3837.654611085016;4395.692301538926;4397.120575884772;4553.840615578439;4579.473360563511;3685.723570732152;3687.4284485904727;3791.696664266852;3799.297130030953;3877.0695033191832;1170.6780635325354;1172.1209093180114;1178.4225729392535;1179;1190.571394298052;927.9536023198813;992.2409356842022;1019.7195771162841;1026.045777426985;1032.7882784029407;5654.37801841797;5745.913811292834;5811.82564523065;5888.5289176865745;6009.399060093956;927.5176908007799;952.4047470331043;984.0749695286407;993.8360170571775;1020.9897901020895;4134.669226461876;4226.091390351089;4238.237117318912;4240.809163587646;4249.660027197817;9485.098915603006;9721.173700235558;9724.319297649237;9769.951150244204;9770.169535589412;9635.807283854283;9654.517274136406;9697.515124243759;9717.6598819041;9730.075642813921;7271.854562908712;7623.199564045695;7643.350315223157;7765.961170194113;7827.217278272241;5662.178984047372;5956.42154828962;5979.431953964367;6037;6059.182010428712;8919.866202007104;9126.863097053681;9169.587368568296;9211.815763684823;9230.446173229628;9024.684136055206;9313.301502387212;9394.342396032212;9495.907970583472;9499;6612.173478315211;7099.148102227559;7306.123265208209;7325.194228634952;7456.9254307458405;7883.054033516015;7928.167542407964;7954.960225198837;7956.443048986515;8027.719029833927;7150.141982962078;7311.305425984523;7337.74317898871;7408.148062972827;7455.888161677471;7070.36366726997;7281.672324745505;7300.014498042697;7315.707371705073;7415.851682966202;6456.709448074754;6475.899097153401;6487.837804054936;6503.707333169924;6517.902231466626;4998.6750861193905;5003.599712023102;5078.796848126033;5144.845654630367;5213.661112027706;5027.798888044584;5042.218456139304;5153.871153221199;5281.366236051698;5414.458554144554 22:51:54 INFO - PROCESS | 6631 | |4;prototype.html;322.9951550726738;328.64013904774276;338.4669146094901;339.32643702251033;342.88170581149495;5427.697352635369;5464.590155738326;5553;5603.439656034395;5625.4655807698255;5499.670019798815;5523.6409633373805;5531.889362212763;5550.91673624896;5599.8600034999145;4344.413504176927;4345.826166953318;4352.151330490556;4352.477702675684;4358.65130789536;4139.296319625671;4354.7806614148085;4355.996241728809;4357.3899654048455;4365.973996110912;4296.419983302246;4298.183345164409;4305.160493703729;4306.44016277885;4324.481062272532;4298.226319262531;4301.483821941356;4331.090471001109;4341.565843415665;4342.609165175118;3694.630536946284;3710.628937106295;3784.6404591563755;3811.3711237645757;3814;5350.678959262456;5407.161889907032;5416.702081385522;5448.482394172547;5452.563794896399;4872.829450969199;4912.459629440758;4922.458529561745;4937.358143441365;4971.1549036663855;5492.697901615409;5877.206577112078;5884;5885.823425297248;5906.675132867691;4117.5706333263515;4136.110736191703;4166.312558427856;4169.999200191932;4173.979130104361;6050.939490605082;6120.693965301717;6141.385861413867;6152.092851216137;6166.4758495527485;4165.375193720966;4249.957500425018;4264.957350426456;4269.679774016961;4283.957160428418;4299.07569872479;4321.762303073361;4322.610965013164;4330.2502910651965;4339.2209194230845;4876.171050921352;4936.580390666762;4949.678270912379;4949.90100197994;4954.430240522314;5747.936631723144;5894.469497745224;5916.940830591725;5940.930632486107;5950.345461999176;1470.815993125523;1472.8953285036223;1484.1095342794238;1486.6952274783644;1496.8278647955624;892.2727976698969;930.8650245714333;937.3485427627869;953.423178976723;954.3033585482636;4985.700857948535;5010.974945125251;5051.413496417511;5051.898962020739;5056.873578160502;5225.798066444663;5275.417374787548;5292.708901010481;5302.655327403706;5324.547413469899;5008.69947803133;5017.799288028438;5055.51972562606;5315.415304316522;5753.568482363756;3219.5492631031675;3229.1927018245437;3239.5140728890383;3248.7888287261253;3252.2032102134654;6135.478484328882;6256.781012664626;6275.435210831047;6279.309275979638;6290.528210384239;6176.320604733476;6176.722047507873;6226.283977342664;6258.812235632939;6281.466075383643;6124.356942520971;6229.563930524911;6268.968655156695;6291.591046581958;6305.747770089145;5831.970840145772;6081;6090.147379366804;6101;6118.60229085108;5949.286085669747;5983.700814959322;5995.790147344822;6004.969975150097;6015.639061656315;5859.94140058611;6246.875062498815;6262.812115636538;6264.5301602379095;6276;4355.1507456045765;4362.1493808707;4374.21264172452;4381.583749543788;4391.429114215131;6050.641893748835;6053.788117415869;6063.6664983426335;6068.817935461767;6087.330393656605;5702.971485142548;5867;5943.762249510144;5948.702564871653;5960.731767070405;5909.8227053188475;5921.111833225051;5923.881522369442;5939.287285525765;5949.19685842423;5618.66105531892;5722.341930677859;5851.834821116215;5854.507100689297;5869.534795385863;5921.911171332519;5929.377415371497;5934.546036221153;5943.91084133747;5947.583669143119;5762.855928601818;5768;5780.427709669157;5809.398173132685;5811.041178205549 22:51:54 INFO - PROCESS | 6631 | |5;yui.html;755.693943952699;763.110975713294;823.7734622978676;832.8334333133373;859.1236938322909;15313.234338283082;16281.267342969566;16723.49829505115;16724.91637541812;16799.748003779954;13703;15041.924790376033;15234.6953060939;15277.08337499748;15318.310676019579;799.5882120707826;820.306840719591;820.7496713502379;822.5434883639577;822.576373167819;795.399473397584;799.7360870912585;804.6017221475378;804.9718259860906;808.6441965535146;853.4879072556479;856.2422256303186;856.7087190355278;857.7941294089436;861.2033868671485;853.7908212487918;854.8974123105268;855.0423525651248;855.4525103933488;857.7469646454342;614.7387360371824;617.4874853871321;618.8452886778306;619.7180282971237;621.4034526854225;14052.578422647337;14228.217448040354;14231.288435578283;14252.429902803875;14368.568942931728;13518.459261629523;13519.121257118355;13522.32388380577;13675.521356752466;13798.93100534501;11220;11395.601153959655;11463.36951467669;11574.826377604259;11713.180077394585;3892.377219644843;3923.4899463069905;3938.0548668319684;3953.5453422856162;4037.777922214277;74155;75660.62169689171;76409.61795191043;77025.22974770237;77065.22934770693;10096.44469554167;10265.692029239135;10374.17006639467;10587.364758114538;10812.513436895359;20356.28752993668;20484.18063277482;20505;20542.17831286732;21038.579228415652;8097.392695547857;8339.708110216114;8418.621162047722;8476.660933562713;9126.45241285525;4807.831725889577;4814.085323788469;4820.68665536739;4866.6106711463;4894.216925291937;3333.5333053372547;3480.0603836964383;3482.303539292101;3485.1635607454537;3493.2314890724;601.5338112962489;604.5798170271707;624.2789578037374;632.1750116098535;638.1990601794718;663.694700437804;702.9841878485539;711.3988679565758;713.707379974208;732.373820383575;9050.456972581535;9077.228435583049;9183.95408022969;9270.3313403588;9543.33196676226;620.9379062093844;661.5501459007825;674.9898751518731;675.598019178588;680.2755065854849;4326.069894972533;4540.364348991144;4589.35748995141;4605.355250264898;4618.538146185355;116902.41548792202;117168.798184128;117323;121131;122141;76256.61871690606;86554;89452.55273723589;104789.47605261925;107773.46113269383;88617;88912.5554372237;89746.55126724455;91620.54189729142;92232;9934.254930880068;10111.090001899864;10446.895531044593;10660.46697665129;10708.143348531943;48614.27078593895;50932;51695.22457163221;52246;52437.21344179917;70851.64574177096;78091;79149;79560;79561.20438795538;12409.44157512896;12774;12871.485140594272;12917.03122265815;13413.128146670435;15500.92249538745;15592.92203538975;15687.843121568638;16041.358345666044;17083.06043167638;13632.386542605409;14333.78499322532;15044.774328385301;15298;15467.381304747683;13352.532661356807;13819.516316928859;13957.953059021986;14028.018038737191;14409.711805764036;13962.092463989808;14025.789613155606;14091.295435227992;14206.218657973497;14714.926425367805;11075.224734268846;11138.665840024812;11409.201355905006;11713.158902487921;11861.169718119994;12043.458044388199;12114.212576182872;12187.817182742443;12187.87812121903;12292.078094142797 22:51:54 INFO - PROCESS | 6631 | __end_tp_report 22:51:54 INFO - PROCESS | 6631 | __start_cc_report 22:51:54 INFO - PROCESS | 6631 | _x_x_mozilla_cycle_collect,371 22:51:54 INFO - PROCESS | 6631 | __end_cc_report 22:51:54 INFO - PROCESS | 6631 | __startTimestamp1467784314262__endTimestamp 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | ------- Summary: start ------- 22:51:54 INFO - PROCESS | 6631 | Number of tests: 6 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | [#0] dojo.html Cycles:165 Average:5325.16 Median:5554.28 stddev:721.38 (13.0%) stddev-sans-first:700.88 22:51:54 INFO - PROCESS | 6631 | Values: 3036.1 3038.5 3054.1 3101.8 3108.8 5281.1 5283.3 5295.7 5320.9 5363.8 5247.7 5257.6 5333.5 5351.9 5366.9 4845.5 4876.7 4964.0 5000.1 5019.2 407.1 4757.0 4899.1 4943.2 5056.9 4926.9 4961.9 4978.3 5004.9 5008.2 4947.3 5002.2 5004.6 5006.8 5034.5 4847.7 4858.3 4904.8 4926.4 4933.6 5371.3 5380.6 5382.9 5414.5 5450.0 5621.6 5767.6 5775.6 5784.3 5832.2 5757.1 5783.3 5784.6 5800.2 5808.3 5353.2 5363.4 5385.8 5406.1 5416.4 5675.9 5842.4 5912.2 5913.4 5932.7 5628.2 5688.7 5700.0 5730.5 5767.8 5787.2 5803.5 5811.0 5814.9 5818.9 5455.5 5761.8 5772.4 5800.8 5801.8 5719.5 5734.3 5744.0 5784.1 5807.4 4385.1 4412.8 4425.3 4432.4 4438.9 3826.8 3829.4 3864.8 3874.3 3987.8 5393.5 5439.7 5470.2 5480.3 5489.2 5684.9 5753.0 5772.5 5774.7 5776.2 5392.1 5473.8 5494.3 5498.0 5619.1 4988.4 5009.0 5024.2 5033.2 5040.7 6036.7 6043.0 6049.7 6050.1 6052.9 5647.4 5659.0 5664.3 5745.4 5756.6 5877.6 5956.6 5971.8 5974.5 5993.9 5523.5 5654.3 5659.2 5673.4 5679.0 5719.1 5764.9 5776.2 5803.3 5816.1 5627.1 5627.2 5633.8 5640.1 5659.3 5490.6 5565.5 5601.4 5617.4 5630.2 5526.5 5544.7 5568.8 5579.7 5585.7 5633.2 5634.8 5654.8 5655.7 5658.2 5385.1 5479.6 5498.3 5554.3 5561.6 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | [#1] ext.html Cycles:180 Average:61404.58 Median:41375.98 stddev:127791.81 (308.9%) stddev-sans-first:128068.63 22:51:54 INFO - PROCESS | 6631 | Values: 553.5 583.0 587.9 611.7 627.2 39673.4 42639.6 42944.6 43005.8 43079.8 43068.4 43291.0 43468.1 43564.3 43610.0 8862.6 9015.0 9046.3 9048.6 9056.2 8810.0 8981.8 9021.5 9028.7 9029.3 9025.9 9046.2 9055.8 9135.1 9136.0 8988.6 9007.1 9010.5 9033.4 9055.3 8901.3 8954.5 8959.3 8972.2 8977.3 33016.5 40812.4 41226.6 41525.4 41587.8 3347.6 3506.9 3597.8 3945.3 4192.3 31548.2 32016.0 32133.4 33705.3 34848.7 4542.8 4575.7 4633.0 4695.8 4824.9 368557.0 368856.0 371189.0 372415.0 374579.0 32715.7 33065.8 33110.2 33138.5 61550.7 37978.8 37996.6 38126.8 38129.0 38156.0 13178.6 13204.1 13211.7 13233.3 13302.1 11704.7 11864.1 11869.8 11916.3 11949.5 8457.9 8507.3 8577.0 8583.2 8600.1 3380.5 3383.3 3390.3 3414.5 3424.7 950.5 1034.2 1073.7 1085.6 1160.2 32079.0 32232.0 33131.8 33199.8 33350.2 1057.5 1073.1 1079.1 1110.2 1174.2 17036.0 17125.6 17131.5 17283.3 17372.2 563680.0 564526.0 568934.0 569435.0 571974.0 57921.1 58222.7 58718.7 58718.7 58772.4 1331.8 1344.5 1381.6 1383.9 1385.5 30864.4 31191.8 31587.5 32170.5 32321.5 52098.0 52351.0 52490.5 52535.5 52553.0 473590.0 480907.0 481717.0 482812.0 483166.0 29092.1 29205.0 29344.9 29547.7 29659.7 49316.0 49463.8 49987.3 50445.2 50502.5 41546.6 42220.0 42328.2 42828.4 43485.8 40888.9 41078.8 41687.2 42029.8 42788.4 35833.5 40486.4 40542.8 41589.6 42333.2 35205.6 36978.3 37326.0 37717.0 37735.8 27812.9 28714.4 28729.0 29010.9 29071.4 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | [#2] jquery.html Cycles:180 Average:29749.05 Median:24946.31 stddev:82183.06 (329.4%) stddev-sans-first:82384.03 22:51:54 INFO - PROCESS | 6631 | Values: 386.6 388.1 395.8 398.7 409.6 18569.9 20477.1 20501.9 20613.9 20674.8 17922.1 18278.2 18396.8 19897.7 20030.5 5684.9 5830.7 5888.7 5914.1 5930.1 5713.7 5736.2 5806.2 5854.0 5883.7 5708.1 5756.0 5791.6 5860.4 5866.1 5719.2 5731.9 5766.8 5785.8 5812.2 5131.6 5134.6 5162.6 5167.7 5214.1 23835.0 24499.0 24685.9 24811.5 25081.1 2470.3 2509.2 2510.2 2556.5 2744.2 14557.4 14874.8 15032.1 15230.7 15394.6 1875.4 1956.0 1988.0 1988.8 1989.5 59544.0 69224.3 80711.6 81637.2 82652.6 10854.8 11054.4 11061.6 11261.6 11308.2 15224.2 15399.5 15502.2 15508.8 15534.9 7733.7 7776.7 7913.9 7922.8 7967.6 7230.7 7275.0 7320.1 7331.0 7515.5 4757.5 4818.7 4840.7 4842.6 4912.8 1910.2 1986.1 2005.2 2022.5 2032.4 879.3 959.7 977.8 1027.1 1073.1 19484.0 20481.1 21569.9 21582.2 21637.2 942.5 957.7 963.4 999.6 1061.1 10023.0 11354.6 11487.5 11509.4 11601.5 471821.0 472916.0 474442.0 525318.0 542443.0 83243.6 92525.0 101058.0 102442.5 104453.0 1013.4 1043.6 1044.9 1051.6 1059.6 17045.7 18623.0 19034.1 19200.3 19434.5 31118.2 32750.8 44727.3 44838.3 47863.3 65666.0 65867.7 66544.7 67155.0 67790.7 8647.1 8885.5 8952.5 8976.0 9005.5 10173.4 13890.7 13973.5 14204.8 14299.2 12322.9 12427.3 12443.6 12482.0 12543.2 12056.7 12213.3 12269.7 12320.6 12439.6 12165.3 12646.0 12735.7 12810.6 12882.2 8921.7 8943.2 9031.8 9076.0 9175.5 11994.9 12247.5 12300.6 12406.8 12478.0 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | [#3] mootools.html Cycles:180 Average:5406.06 Median:5183.77 stddev:2954.56 (57.0%) stddev-sans-first:2947.92 22:51:54 INFO - PROCESS | 6631 | Values: 1454.0 1464.9 1594.5 1730.0 1777.1 7228.3 7841.1 7920.6 8323.6 8347.9 7978.5 8125.0 8141.3 8199.7 8202.5 2094.2 2113.6 2120.8 2123.6 2131.3 2194.9 2254.8 2260.7 2263.9 2266.1 2233.3 2236.5 2237.0 2257.1 2257.5 2206.8 2208.4 2214.9 2218.6 2220.2 2162.5 2184.5 2186.6 2190.9 2193.7 8080.8 8146.9 8164.3 8221.0 8251.2 4737.2 4896.2 4904.3 4907.5 4925.7 3096.9 3111.5 3155.9 3163.1 3222.0 1053.5 1061.8 1087.3 1096.1 1097.8 10951.3 10973.2 10982.1 10983.6 11016.2 4094.1 4259.6 4345.8 4350.1 4355.9 9382.1 9383.5 9445.3 9447.3 9447.5 4739.1 4767.2 4769.8 4771.9 4794.3 3837.7 4395.7 4397.1 4553.8 4579.5 3685.7 3687.4 3791.7 3799.3 3877.1 1170.7 1172.1 1178.4 1179.0 1190.6 928.0 992.2 1019.7 1026.0 1032.8 5654.4 5745.9 5811.8 5888.5 6009.4 927.5 952.4 984.1 993.8 1021.0 4134.7 4226.1 4238.2 4240.8 4249.7 9485.1 9721.2 9724.3 9770.0 9770.2 9635.8 9654.5 9697.5 9717.7 9730.1 7271.9 7623.2 7643.4 7766.0 7827.2 5662.2 5956.4 5979.4 6037.0 6059.2 8919.9 9126.9 9169.6 9211.8 9230.4 9024.7 9313.3 9394.3 9495.9 9499.0 6612.2 7099.1 7306.1 7325.2 7456.9 7883.1 7928.2 7955.0 7956.4 8027.7 7150.1 7311.3 7337.7 7408.1 7455.9 7070.4 7281.7 7300.0 7315.7 7415.9 6456.7 6475.9 6487.8 6503.7 6517.9 4998.7 5003.6 5078.8 5144.8 5213.7 5027.8 5042.2 5153.9 5281.4 5414.5 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | [#4] prototype.html Cycles:180 Average:4893.76 Median:5478.64 stddev:1453.65 (26.5%) stddev-sans-first:1416.67 22:51:54 INFO - PROCESS | 6631 | Values: 323.0 328.6 338.5 339.3 342.9 5427.7 5464.6 5553.0 5603.4 5625.5 5499.7 5523.6 5531.9 5550.9 5599.9 4344.4 4345.8 4352.2 4352.5 4358.7 4139.3 4354.8 4356.0 4357.4 4366.0 4296.4 4298.2 4305.2 4306.4 4324.5 4298.2 4301.5 4331.1 4341.6 4342.6 3694.6 3710.6 3784.6 3811.4 3814.0 5350.7 5407.2 5416.7 5448.5 5452.6 4872.8 4912.5 4922.5 4937.4 4971.2 5492.7 5877.2 5884.0 5885.8 5906.7 4117.6 4136.1 4166.3 4170.0 4174.0 6050.9 6120.7 6141.4 6152.1 6166.5 4165.4 4250.0 4265.0 4269.7 4284.0 4299.1 4321.8 4322.6 4330.3 4339.2 4876.2 4936.6 4949.7 4949.9 4954.4 5747.9 5894.5 5916.9 5940.9 5950.3 1470.8 1472.9 1484.1 1486.7 1496.8 892.3 930.9 937.3 953.4 954.3 4985.7 5011.0 5051.4 5051.9 5056.9 5225.8 5275.4 5292.7 5302.7 5324.5 5008.7 5017.8 5055.5 5315.4 5753.6 3219.5 3229.2 3239.5 3248.8 3252.2 6135.5 6256.8 6275.4 6279.3 6290.5 6176.3 6176.7 6226.3 6258.8 6281.5 6124.4 6229.6 6269.0 6291.6 6305.7 5832.0 6081.0 6090.1 6101.0 6118.6 5949.3 5983.7 5995.8 6005.0 6015.6 5859.9 6246.9 6262.8 6264.5 6276.0 4355.2 4362.1 4374.2 4381.6 4391.4 6050.6 6053.8 6063.7 6068.8 6087.3 5703.0 5867.0 5943.8 5948.7 5960.7 5909.8 5921.1 5923.9 5939.3 5949.2 5618.7 5722.3 5851.8 5854.5 5869.5 5921.9 5929.4 5934.5 5943.9 5947.6 5762.9 5768.0 5780.4 5809.4 5811.0 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - PROCESS | 6631 | [#5] yui.html Cycles:180 Average:20982.34 Median:4181.92 stddev:30287.45 (724.2%) stddev-sans-first:30334.33 22:51:54 INFO - PROCESS | 6631 | Values: 755.7 763.1 823.8 832.8 859.1 15313.2 16281.3 16723.5 16724.9 16799.7 13703.0 15041.9 15234.7 15277.1 15318.3 799.6 820.3 820.7 822.5 822.6 795.4 799.7 804.6 805.0 808.6 853.5 856.2 856.7 857.8 861.2 853.8 854.9 855.0 855.5 857.7 614.7 617.5 618.8 619.7 621.4 14052.6 14228.2 14231.3 14252.4 14368.6 13518.5 13519.1 13522.3 13675.5 13798.9 11220.0 11395.6 11463.4 11574.8 11713.2 3892.4 3923.5 3938.1 3953.5 4037.8 74155.0 75660.6 76409.6 77025.2 77065.2 10096.4 10265.7 10374.2 10587.4 10812.5 20356.3 20484.2 20505.0 20542.2 21038.6 8097.4 8339.7 8418.6 8476.7 9126.5 4807.8 4814.1 4820.7 4866.6 4894.2 3333.5 3480.1 3482.3 3485.2 3493.2 601.5 604.6 624.3 632.2 638.2 663.7 703.0 711.4 713.7 732.4 9050.5 9077.2 9184.0 9270.3 9543.3 620.9 661.6 675.0 675.6 680.3 4326.1 4540.4 4589.4 4605.4 4618.5 116902.4 117168.8 117323.0 121131.0 122141.0 76256.6 86554.0 89452.6 104789.5 107773.5 88617.0 88912.6 89746.6 91620.5 92232.0 9934.3 10111.1 10446.9 10660.5 10708.1 48614.3 50932.0 51695.2 52246.0 52437.2 70851.6 78091.0 79149.0 79560.0 79561.2 12409.4 12774.0 12871.5 12917.0 13413.1 15500.9 15592.9 15687.8 16041.4 17083.1 13632.4 14333.8 15044.8 15298.0 15467.4 13352.5 13819.5 13958.0 14028.0 14409.7 13962.1 14025.8 14091.3 14206.2 14714.9 11075.2 11138.7 11409.2 11713.2 11861.2 12043.5 12114.2 12187.8 12187.9 12292.1 22:51:54 INFO - PROCESS | 6631 | -------- Summary: end -------- 22:51:54 INFO - PROCESS | 6631 | 22:51:54 INFO - TEST-INFO | 6631: exit 0 22:51:54 INFO - TEST-OK | dromaeo_css | took 1110571ms 22:51:54 INFO - TEST-START | kraken 22:51:54 INFO - operating with platform_type : linux_ 22:51:54 INFO - Initialising browser for kraken test... 22:51:55 INFO - TEST-INFO | started process 6877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYXk8us/profile http://localhost:43724/getInfo.html) 22:51:59 INFO - PROCESS | 6877 | __metrics Screen width/height:1600/1200 22:51:59 INFO - PROCESS | 6877 | colorDepth:24 22:51:59 INFO - PROCESS | 6877 | Browser inner width/height: 1024/697 22:51:59 INFO - PROCESS | 6877 | __metrics 22:52:00 ERROR - PROCESS | 6877 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 22:52:01 INFO - TEST-INFO | 6877: exit 0 22:52:01 INFO - Browser initialized. 22:52:01 INFO - Running cycle 1/1 for kraken test... 22:52:01 INFO - TEST-INFO | started process 6998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYXk8us/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:13 INFO - PROCESS | 6998 | RSS: Main: 168095744 22:52:13 INFO - PROCESS | 6998 | 22:52:15 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43724/tests/kraken/driver.html?testName=audio-beat-detection) 22:52:16 INFO - PROCESS | 6998 | RSS: Main: 173625344 22:52:16 INFO - PROCESS | 6998 | 22:52:19 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43724/tests/kraken/driver.html?testName=audio-dft) 22:52:19 INFO - PROCESS | 6998 | RSS: Main: 173486080 22:52:19 INFO - PROCESS | 6998 | 22:52:22 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43724/tests/kraken/driver.html?testName=audio-fft) 22:52:23 INFO - PROCESS | 6998 | RSS: Main: 167321600 22:52:23 INFO - PROCESS | 6998 | 22:52:25 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43724/tests/kraken/driver.html?testName=audio-oscillator) 22:52:25 INFO - PROCESS | 6998 | RSS: Main: 168873984 22:52:25 INFO - PROCESS | 6998 | 22:52:28 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43724/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:52:28 INFO - PROCESS | 6998 | RSS: Main: 168886272 22:52:28 INFO - PROCESS | 6998 | 22:52:31 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43724/tests/kraken/driver.html?testName=imaging-darkroom) 22:52:32 INFO - PROCESS | 6998 | RSS: Main: 168620032 22:52:32 INFO - PROCESS | 6998 | 22:52:35 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43724/tests/kraken/driver.html?testName=imaging-desaturate) 22:52:36 INFO - PROCESS | 6998 | RSS: Main: 167006208 22:52:36 INFO - PROCESS | 6998 | 22:52:39 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43724/tests/kraken/driver.html?testName=json-parse-financial) 22:52:40 INFO - PROCESS | 6998 | RSS: Main: 168349696 22:52:40 INFO - PROCESS | 6998 | 22:52:41 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43724/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:52:42 INFO - PROCESS | 6998 | RSS: Main: 168357888 22:52:42 INFO - PROCESS | 6998 | 22:52:43 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:52:44 INFO - PROCESS | 6998 | RSS: Main: 168878080 22:52:44 INFO - PROCESS | 6998 | 22:52:46 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:52:47 INFO - PROCESS | 6998 | RSS: Main: 169168896 22:52:47 INFO - PROCESS | 6998 | 22:52:49 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:52:50 INFO - PROCESS | 6998 | RSS: Main: 169693184 22:52:50 INFO - PROCESS | 6998 | 22:52:53 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:52:53 INFO - PROCESS | 6998 | RSS: Main: 169295872 22:52:53 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | Cycle 1(1): loaded http://localhost:43724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43724/tests/kraken/driver.html?testName=ai-astar) 22:52:55 INFO - PROCESS | 6998 | RSS: Main: 170201088 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | __start_tp_report 22:52:55 INFO - PROCESS | 6998 | _x_x_mozilla_page_load 22:52:55 INFO - PROCESS | 6998 | _x_x_mozilla_page_load_details 22:52:55 INFO - PROCESS | 6998 | |i|pagename|runs| 22:52:55 INFO - PROCESS | 6998 | |0;ai-astar;102;113;106;112;111;112;112;111;112;111 22:52:55 INFO - PROCESS | 6998 | |1;audio-beat-detection;146;117;144;163;120;148;148;119;171;120 22:52:55 INFO - PROCESS | 6998 | |2;audio-dft;165;165;163;159;163;164;170;169;160;161 22:52:55 INFO - PROCESS | 6998 | |3;audio-fft;81;75;75;168;77;76;74;75;164;76 22:52:55 INFO - PROCESS | 6998 | |4;audio-oscillator;84;83;156;86;84;83;144;84;85;150 22:52:55 INFO - PROCESS | 6998 | |5;imaging-gaussian-blur;118;120;120;117;118;117;117;118;118;119 22:52:55 INFO - PROCESS | 6998 | |6;imaging-darkroom;147;148;146;147;147;147;147;146;147;147 22:52:55 INFO - PROCESS | 6998 | |7;imaging-desaturate;95;95;95;96;96;103;96;96;95;95 22:52:55 INFO - PROCESS | 6998 | |8;json-parse-financial;55;54;55;55;55;55;55;54;54;54 22:52:55 INFO - PROCESS | 6998 | |9;json-stringify-tinderbox;62;62;61;62;62;63;62;62;63;62 22:52:55 INFO - PROCESS | 6998 | |10;stanford-crypto-aes;76;79;77;82;77;75;77;76;82;76 22:52:55 INFO - PROCESS | 6998 | |11;stanford-crypto-ccm;129;131;124;139;123;133;131;124;174;123 22:52:55 INFO - PROCESS | 6998 | |12;stanford-crypto-pbkdf2;173;162;164;158;156;159;161;161;163;167 22:52:55 INFO - PROCESS | 6998 | |13;stanford-crypto-sha256-iterative;66;64;65;64;63;64;71;62;63;61 22:52:55 INFO - PROCESS | 6998 | __end_tp_report 22:52:55 INFO - PROCESS | 6998 | __start_cc_report 22:52:55 INFO - PROCESS | 6998 | _x_x_mozilla_cycle_collect,925 22:52:55 INFO - PROCESS | 6998 | __end_cc_report 22:52:55 INFO - PROCESS | 6998 | __startTimestamp1467784375890__endTimestamp 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | ------- Summary: start ------- 22:52:55 INFO - PROCESS | 6998 | Number of tests: 14 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.46 (3.1%) stddev-sans-first:2.03 22:52:55 INFO - PROCESS | 6998 | Values: 102.0 113.0 106.0 112.0 111.0 112.0 112.0 111.0 112.0 111.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:147.00 stddev:19.55 (13.3%) stddev-sans-first:20.59 22:52:55 INFO - PROCESS | 6998 | Values: 146.0 117.0 144.0 163.0 120.0 148.0 148.0 119.0 171.0 120.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:3.57 (2.2%) stddev-sans-first:3.77 22:52:55 INFO - PROCESS | 6998 | Values: 165.0 165.0 163.0 159.0 163.0 164.0 170.0 169.0 160.0 161.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:37.95 (50.3%) stddev-sans-first:39.96 22:52:55 INFO - PROCESS | 6998 | Values: 81.0 75.0 75.0 168.0 77.0 76.0 74.0 75.0 164.0 76.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:84.00 stddev:31.95 (38.0%) stddev-sans-first:33.07 22:52:55 INFO - PROCESS | 6998 | Values: 84.0 83.0 156.0 86.0 84.0 83.0 144.0 84.0 85.0 150.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 22:52:55 INFO - PROCESS | 6998 | Values: 118.0 120.0 120.0 117.0 118.0 117.0 117.0 118.0 118.0 119.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:52:55 INFO - PROCESS | 6998 | Values: 147.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.50 stddev:2.44 (2.6%) stddev-sans-first:2.55 22:52:55 INFO - PROCESS | 6998 | Values: 95.0 95.0 95.0 96.0 96.0 103.0 96.0 96.0 95.0 95.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 22:52:55 INFO - PROCESS | 6998 | Values: 55.0 54.0 55.0 55.0 55.0 55.0 55.0 54.0 54.0 54.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:52:55 INFO - PROCESS | 6998 | Values: 62.0 62.0 61.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.00 stddev:2.50 (3.2%) stddev-sans-first:2.57 22:52:55 INFO - PROCESS | 6998 | Values: 76.0 79.0 77.0 82.0 77.0 75.0 77.0 76.0 82.0 76.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:131.00 stddev:15.29 (11.7%) stddev-sans-first:16.14 22:52:55 INFO - PROCESS | 6998 | Values: 129.0 131.0 124.0 139.0 123.0 133.0 131.0 124.0 174.0 123.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:162.50 stddev:4.86 (3.0%) stddev-sans-first:3.31 22:52:55 INFO - PROCESS | 6998 | Values: 173.0 162.0 164.0 158.0 156.0 159.0 161.0 161.0 163.0 167.0 22:52:55 INFO - PROCESS | 6998 | 22:52:55 INFO - PROCESS | 6998 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:2.75 (4.3%) stddev-sans-first:2.85 22:52:55 INFO - PROCESS | 6998 | Values: 66.0 64.0 65.0 64.0 63.0 64.0 71.0 62.0 63.0 61.0 22:52:55 INFO - PROCESS | 6998 | -------- Summary: end -------- 22:52:55 INFO - PROCESS | 6998 | 22:52:56 INFO - TEST-INFO | 6998: exit 0 22:52:56 INFO - TEST-OK | kraken | took 61880ms 22:52:56 INFO - SUITE-END | took 1172s 22:52:57 INFO - Completed test suite (00:19:32) 22:52:57 INFO - javascript benchmark 22:52:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.178422640195, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.1498780341512, 3038.4834578121718, 3054.068509104722, 3101.7828751987354, 3108.803110802342, 5281.075811732951, 5283.2867562879, 5295.708736019522, 5320.9467905320935, 5363.785448582062, 5247.658902171356, 5257.631965762398, 5333.493318134771, 5351.866203344918, 5366.892662146754, 4845.491223421534, 4876.707397556158, 4963.950360496385, 5000.07498612756, 5019.247112933052, 407.129994519404, 4757.0, 4899.142650036247, 4943.1596628573225, 5056.873578160557, 4926.852194434173, 4961.8511444656715, 4978.278149668296, 5004.924926126111, 5008.198688209887, 4947.282644016634, 5002.224655178453, 5004.599632029429, 5006.8497945061345, 5034.4713805050305, 4847.733374664392, 4858.319835223072, 4904.828331008433, 4926.3842019747535, 4933.605311575066, 5371.274877891513, 5380.596455265871, 5382.946170538284, 5414.512693857571, 5449.972750136264, 5621.634593751393, 5767.625104368202, 5775.566832487538, 5784.334801497839, 5832.24180856486, 5757.136429535562, 5783.306003279633, 5784.595078344518, 5800.158976948361, 5808.332041815161, 5353.2237825515085, 5363.410024897258, 5385.78456861725, 5406.08096623575, 5416.404195538487, 5675.943240567624, 5842.415758424124, 5912.201852749824, 5913.379095194942, 5932.7330270137945, 5628.155776633538, 5688.744006519633, 5699.971500142473, 5730.484256416942, 5767.8175973925245, 5787.247657804459, 5803.506701930299, 5811.041178205549, 5814.883702325929, 5818.854528636733, 5455.536279416294, 5761.769529218868, 5772.422757724194, 5800.796972105956, 5801.767929282866, 5719.513841323451, 5734.254546908958, 5744.0, 5784.132380143013, 5807.390224026501, 4385.101054283864, 4412.823487060482, 4425.269830477935, 4432.423784907941, 4438.911221775546, 3826.8086595670106, 3829.3872980323013, 3864.7874366909527, 3874.2832575973534, 3987.8404863805704, 5393.514583687487, 5439.700816455133, 5470.234167216593, 5480.26016487777, 5489.204065410573, 5684.857878552986, 5752.9712351437975, 5772.509336706427, 5774.68239246837, 5776.220210271559, 5392.056390131711, 5473.75368108436, 5494.313210848644, 5498.0, 5619.100943849046, 4988.376452943382, 5009.0482808266315, 5024.2463630454995, 5033.245013247969, 5040.747962601855, 6036.728347224385, 6043.033114701714, 6049.727762250709, 6050.092486127116, 6052.939470605325, 5647.435256474319, 5659.037963546207, 5664.320281566238, 5745.368009519033, 5756.625819321731, 5877.617954832922, 5956.612820166675, 5971.7611295547695, 5974.462298393166, 5993.880122397615, 5523.502884740393, 5654.264945557051, 5659.207710920392, 5673.404292549223, 5679.0345641240265, 5719.113537401709, 5764.942350576608, 5776.162456443876, 5803.332616749128, 5816.098504731774, 5627.099664053731, 5627.21219029328, 5633.802816901552, 5640.097584386643, 5659.292588426447, 5490.615656903979, 5565.499105080562, 5601.383847776823, 5617.382087970402, 5630.23991761107, 5526.502614764529, 5544.695041772741, 5568.805091821767, 5579.69311687861, 5585.69278689676, 5633.1831884375715, 5634.802781902614, 5654.83035508919, 5655.660660360391, 5658.151277308437, 5385.111456609616, 5479.6164268500825, 5498.3127109111365, 5554.2779438672715, 5561.582881284001], "value": 5278.0048042283615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5260674972783, 583.011795007462, 587.9088741245107, 611.6910959965217, 627.2441707742171, 39673.40489892651, 42639.57360426395, 42944.57055429445, 43005.78497107514, 43079.78460107703, 43068.353974690326, 43291.0, 43468.130637387236, 43564.346534802, 43610.0, 8862.556872156398, 9014.954925225366, 9046.276297896153, 9048.592813323383, 9056.184943355096, 8809.955950220272, 8981.820363592724, 9021.503817290046, 9028.68399606014, 9029.277657787394, 9025.909740902605, 9046.185843274105, 9055.773605659846, 9135.086491350845, 9136.0, 8988.640454381817, 9007.144321289466, 9010.45937243761, 9033.367664263504, 9055.275577953747, 8901.287896968228, 8954.507502087383, 8959.283257339397, 8972.192502674725, 8977.32670049749, 33016.50475242873, 40812.38781418281, 41226.58773412288, 41525.37711934323, 41587.79206103981, 3347.645443096989, 3506.8947931562093, 3597.7661452005536, 3945.270125026879, 4192.308269135589, 31548.211294717585, 32016.0, 32133.35733285321, 33705.32589348224, 34848.65151348505, 4542.750148741818, 4575.748333841638, 4632.953670463286, 4695.835645752382, 4824.879378015543, 368557.0, 368856.0, 371189.0, 372415.0, 374579.0, 32715.672843271263, 33065.834670826975, 33110.17224569357, 33138.50292245618, 61550.69224653938, 37978.810105949844, 37996.62003379986, 38126.80936595299, 38129.0, 38156.0, 13178.60464186076, 13204.075714699879, 13211.73576528464, 13233.272170030741, 13302.135361201492, 11704.70738231551, 11864.050875929905, 11869.76260474803, 11916.285022898654, 11949.522019119311, 8457.873131903027, 8507.27688146502, 8576.957115214384, 8583.18459746323, 8600.13998600135, 3380.4760262159402, 3383.289509203046, 3390.304987477561, 3414.5390372299917, 3424.7260219182403, 950.4819873169139, 1034.234666346913, 1073.7154654016692, 1085.5603480590373, 1160.2110564815837, 32079.0, 32232.0, 33131.834340828624, 33199.83400083033, 33350.16624584405, 1057.5188289328337, 1073.061071562383, 1079.0881704959454, 1110.1507346879644, 1174.1546086817477, 17036.0, 17125.57186070358, 17131.486055418358, 17283.308667653404, 17372.218250178772, 563680.0, 564526.0, 568934.0, 569435.0, 571974.0, 57921.13118303229, 58222.708886456145, 58718.70640646855, 58718.70640646855, 58772.41227587755, 1331.766940785378, 1344.5159742492694, 1381.5579014715195, 1383.9377228024764, 1385.4735200623697, 30864.382712346076, 31191.84404077965, 31587.526187107673, 32170.51744223885, 32321.51517727189, 52098.0, 52351.0, 52490.475095248556, 52535.47464525306, 52553.0, 473590.0, 480907.0, 481717.0, 482812.0, 483166.0, 29092.127236182947, 29205.0, 29344.853275733483, 29547.704522954496, 29659.703402965693, 49316.0, 49463.752681236365, 49987.25019124789, 50445.24332135094, 50502.494975049776, 41546.58453415548, 42220.0, 42328.1534369317, 42828.35757463578, 43485.782571086944, 40888.911108888875, 41078.79460602797, 41687.1662566753, 42029.78985105055, 42788.358174628025, 35833.46249806203, 40486.392704110054, 40542.78371648855, 41589.58410415857, 42333.153336933705, 35205.647943520235, 36978.26043479169, 37326.0, 37717.0, 37735.81132094322, 27812.860935695193, 28714.425711485237, 28729.0, 29010.854945725136, 29071.418571628026], "value": 18932.450541611393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.61531775882963, 388.0763782198369, 395.778364116095, 398.7189031732629, 409.55563213912905, 18569.907150464263, 20477.078531466082, 20501.897490512525, 20613.896930515326, 20674.793252067473, 17922.10389480524, 18278.177482013307, 18396.816031839677, 19897.701534476957, 20030.49923751907, 5684.914726279109, 5830.679312637803, 5888.735006924699, 5914.083317085859, 5930.140129681194, 5713.685747283918, 5736.196932429463, 5806.216160818278, 5854.0, 5883.735231914574, 5708.08670612702, 5755.9927012772805, 5791.623544469617, 5860.413958604148, 5866.090755932837, 5719.227904232958, 5731.885362292752, 5766.82699519013, 5785.768569257246, 5812.186293918855, 5131.640785145041, 5134.64057515974, 5162.638615296931, 5167.6641018333685, 5214.139666954948, 23835.0, 24499.02003919841, 24685.876570617213, 24811.503769924682, 25081.122160724288, 2470.308313672175, 2509.1970569417795, 2510.2218312323057, 2556.5014822109697, 2744.2316151477617, 14557.417703291856, 14874.776878346725, 15032.098074115478, 15230.695386092328, 15394.615134621725, 1875.3904980881132, 1956.0, 1988.0258673250003, 1988.8408927285782, 1989.4529004523727, 59544.0, 69224.3077569223, 80711.59644201859, 81637.18362816355, 82652.58673706593, 10854.837177442345, 11054.392008439452, 11061.557537698402, 11261.605843795593, 11308.208425410307, 15224.238788060553, 15399.46101886451, 15502.224888755518, 15508.767368489256, 15534.922325388527, 7733.690652373954, 7776.688932442752, 7913.881291780628, 7922.841543169219, 7967.641456134372, 7230.674619642129, 7275.0, 7320.1215854097845, 7330.96334518324, 7515.473916825769, 4757.548032936866, 4818.6626936114835, 4840.709557426566, 4842.612590992712, 4912.8280510182685, 1910.1881700277327, 1986.1459572384013, 2005.1578337098454, 2022.48426651203, 2032.3699653107583, 879.2658130461136, 959.6545243712258, 977.8093271811929, 1027.1269420992096, 1073.0717928991521, 19484.0, 20481.078351474218, 21569.89215053946, 21582.244621438174, 21637.242696505546, 942.4910548303839, 957.7174733453647, 963.4219468319093, 999.6351331763854, 1061.1245722278995, 10023.0, 11354.602588909349, 11487.540498380138, 11509.424528773528, 11601.477933493014, 471821.0, 472916.0, 474442.0, 525318.0, 542443.0, 83243.58378208191, 92525.0, 101058.0, 102442.48778756207, 104453.0, 1013.437542164106, 1043.582566973217, 1044.895510448949, 1051.579368252705, 1059.592057058038, 17045.659086818443, 18623.0, 19034.143463543896, 19200.327988520334, 19434.514137146685, 31118.22204444907, 32750.836245818617, 44727.32909006302, 44838.32860639151, 47863.282050769965, 65666.0, 65867.67066164638, 66544.66727666331, 67155.0, 67790.66104669445, 8647.0920553341, 8885.4668719877, 8952.507612081137, 8976.0, 9005.549722513979, 10173.389596624227, 13890.722185556031, 13973.510927117502, 14204.78692819588, 14299.21354325522, 12322.938385308016, 12427.31649759272, 12443.626691198917, 12482.0, 12543.24740515572, 12056.698582535506, 12213.328266945047, 12269.69325766863, 12320.630381088582, 12439.564615238423, 12165.270083795001, 12646.0, 12735.681607959876, 12810.615681529569, 12882.227066376048, 8921.687740929035, 8943.195112439911, 9031.819363612822, 9075.954620226856, 9175.495347755937, 11994.940025299818, 12247.510099595916, 12300.569480068154, 12406.751864962831, 12478.0], "value": 9518.04379008592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.970920581588, 1464.9121052736834, 1594.5057032319983, 1730.0, 1777.0581591756356, 7228.277172282769, 7841.059072911258, 7920.564368959705, 8323.583820808966, 8347.91652083479, 7978.521288722666, 8124.959375203131, 8141.267285944264, 8199.672013119469, 8202.466839655433, 2094.1518684932626, 2113.619548481273, 2120.809127178554, 2123.6495978163584, 2131.3499382688274, 2194.8792816395094, 2254.785795349439, 2260.7174103237094, 2263.909443622253, 2266.093562574975, 2233.2853486884205, 2236.519148383097, 2237.0, 2257.1084421653436, 2257.503349263168, 2206.768289329629, 2208.447888028001, 2214.8671079735186, 2218.6450167973207, 2220.2340192633596, 2162.4918144236094, 2184.4648061225103, 2186.584548935697, 2190.9452263693533, 2193.670949357593, 8080.8383832323025, 8146.877796833052, 8164.306033987118, 8220.958895205546, 8251.216134467277, 4737.218358970766, 4896.167651499253, 4904.264360345941, 4907.460179380265, 4925.729084900329, 3096.922576935572, 3111.533270009494, 3155.8895438659765, 3163.066895265879, 3222.0494953988627, 1053.4732633683159, 1061.8194906865851, 1087.2986923434419, 1096.1285777806663, 1097.8023955687972, 10951.288166269247, 10973.23187376884, 10982.121430285639, 10983.560657573687, 11016.228863979524, 4094.1402305516176, 4259.595338442843, 4345.782710864444, 4350.086481838849, 4355.891102722458, 9382.10869967352, 9383.483908385104, 9445.338826282232, 9447.338686291894, 9447.480388578695, 4739.052189562101, 4767.165745994437, 4769.809207631656, 4771.904561908812, 4794.328793968847, 3837.654611085016, 4395.692301538926, 4397.120575884772, 4553.840615578439, 4579.473360563511, 3685.723570732152, 3687.4284485904727, 3791.696664266852, 3799.297130030953, 3877.0695033191832, 1170.6780635325354, 1172.1209093180114, 1178.4225729392535, 1179.0, 1190.571394298052, 927.9536023198813, 992.2409356842022, 1019.7195771162841, 1026.045777426985, 1032.7882784029407, 5654.37801841797, 5745.913811292834, 5811.82564523065, 5888.5289176865745, 6009.399060093956, 927.5176908007799, 952.4047470331043, 984.0749695286407, 993.8360170571775, 1020.9897901020895, 4134.669226461876, 4226.091390351089, 4238.237117318912, 4240.809163587646, 4249.660027197817, 9485.098915603006, 9721.173700235558, 9724.319297649237, 9769.951150244204, 9770.169535589412, 9635.807283854283, 9654.517274136406, 9697.515124243759, 9717.6598819041, 9730.075642813921, 7271.854562908712, 7623.199564045695, 7643.350315223157, 7765.961170194113, 7827.217278272241, 5662.178984047372, 5956.42154828962, 5979.431953964367, 6037.0, 6059.182010428712, 8919.866202007104, 9126.863097053681, 9169.587368568296, 9211.815763684823, 9230.446173229628, 9024.684136055206, 9313.301502387212, 9394.342396032212, 9495.907970583472, 9499.0, 6612.173478315211, 7099.148102227559, 7306.123265208209, 7325.194228634952, 7456.9254307458405, 7883.054033516015, 7928.167542407964, 7954.960225198837, 7956.443048986515, 8027.719029833927, 7150.141982962078, 7311.305425984523, 7337.74317898871, 7408.148062972827, 7455.888161677471, 7070.36366726997, 7281.672324745505, 7300.014498042697, 7315.707371705073, 7415.851682966202, 6456.709448074754, 6475.899097153401, 6487.837804054936, 6503.707333169924, 6517.902231466626, 4998.6750861193905, 5003.599712023102, 5078.796848126033, 5144.845654630367, 5213.661112027706, 5027.798888044584, 5042.218456139304, 5153.871153221199, 5281.366236051698, 5414.458554144554], "value": 4389.331391633214, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.9951550726738, 328.64013904774276, 338.4669146094901, 339.32643702251033, 342.88170581149495, 5427.697352635369, 5464.590155738326, 5553.0, 5603.439656034395, 5625.4655807698255, 5499.670019798815, 5523.6409633373805, 5531.889362212763, 5550.91673624896, 5599.8600034999145, 4344.413504176927, 4345.826166953318, 4352.151330490556, 4352.477702675684, 4358.65130789536, 4139.296319625671, 4354.7806614148085, 4355.996241728809, 4357.3899654048455, 4365.973996110912, 4296.419983302246, 4298.183345164409, 4305.160493703729, 4306.44016277885, 4324.481062272532, 4298.226319262531, 4301.483821941356, 4331.090471001109, 4341.565843415665, 4342.609165175118, 3694.630536946284, 3710.628937106295, 3784.6404591563755, 3811.3711237645757, 3814.0, 5350.678959262456, 5407.161889907032, 5416.702081385522, 5448.482394172547, 5452.563794896399, 4872.829450969199, 4912.459629440758, 4922.458529561745, 4937.358143441365, 4971.1549036663855, 5492.697901615409, 5877.206577112078, 5884.0, 5885.823425297248, 5906.675132867691, 4117.5706333263515, 4136.110736191703, 4166.312558427856, 4169.999200191932, 4173.979130104361, 6050.939490605082, 6120.693965301717, 6141.385861413867, 6152.092851216137, 6166.4758495527485, 4165.375193720966, 4249.957500425018, 4264.957350426456, 4269.679774016961, 4283.957160428418, 4299.07569872479, 4321.762303073361, 4322.610965013164, 4330.2502910651965, 4339.2209194230845, 4876.171050921352, 4936.580390666762, 4949.678270912379, 4949.90100197994, 4954.430240522314, 5747.936631723144, 5894.469497745224, 5916.940830591725, 5940.930632486107, 5950.345461999176, 1470.815993125523, 1472.8953285036223, 1484.1095342794238, 1486.6952274783644, 1496.8278647955624, 892.2727976698969, 930.8650245714333, 937.3485427627869, 953.423178976723, 954.3033585482636, 4985.700857948535, 5010.974945125251, 5051.413496417511, 5051.898962020739, 5056.873578160502, 5225.798066444663, 5275.417374787548, 5292.708901010481, 5302.655327403706, 5324.547413469899, 5008.69947803133, 5017.799288028438, 5055.51972562606, 5315.415304316522, 5753.568482363756, 3219.5492631031675, 3229.1927018245437, 3239.5140728890383, 3248.7888287261253, 3252.2032102134654, 6135.478484328882, 6256.781012664626, 6275.435210831047, 6279.309275979638, 6290.528210384239, 6176.320604733476, 6176.722047507873, 6226.283977342664, 6258.812235632939, 6281.466075383643, 6124.356942520971, 6229.563930524911, 6268.968655156695, 6291.591046581958, 6305.747770089145, 5831.970840145772, 6081.0, 6090.147379366804, 6101.0, 6118.60229085108, 5949.286085669747, 5983.700814959322, 5995.790147344822, 6004.969975150097, 6015.639061656315, 5859.94140058611, 6246.875062498815, 6262.812115636538, 6264.5301602379095, 6276.0, 4355.1507456045765, 4362.1493808707, 4374.21264172452, 4381.583749543788, 4391.429114215131, 6050.641893748835, 6053.788117415869, 6063.6664983426335, 6068.817935461767, 6087.330393656605, 5702.971485142548, 5867.0, 5943.762249510144, 5948.702564871653, 5960.731767070405, 5909.8227053188475, 5921.111833225051, 5923.881522369442, 5939.287285525765, 5949.19685842423, 5618.66105531892, 5722.341930677859, 5851.834821116215, 5854.507100689297, 5869.534795385863, 5921.911171332519, 5929.377415371497, 5934.546036221153, 5943.91084133747, 5947.583669143119, 5762.855928601818, 5768.0, 5780.427709669157, 5809.398173132685, 5811.041178205549], "value": 4423.592513794303, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.693943952699, 763.110975713294, 823.7734622978676, 832.8334333133373, 859.1236938322909, 15313.234338283082, 16281.267342969566, 16723.49829505115, 16724.91637541812, 16799.748003779954, 13703.0, 15041.924790376033, 15234.6953060939, 15277.08337499748, 15318.310676019579, 799.5882120707826, 820.306840719591, 820.7496713502379, 822.5434883639577, 822.576373167819, 795.399473397584, 799.7360870912585, 804.6017221475378, 804.9718259860906, 808.6441965535146, 853.4879072556479, 856.2422256303186, 856.7087190355278, 857.7941294089436, 861.2033868671485, 853.7908212487918, 854.8974123105268, 855.0423525651248, 855.4525103933488, 857.7469646454342, 614.7387360371824, 617.4874853871321, 618.8452886778306, 619.7180282971237, 621.4034526854225, 14052.578422647337, 14228.217448040354, 14231.288435578283, 14252.429902803875, 14368.568942931728, 13518.459261629523, 13519.121257118355, 13522.32388380577, 13675.521356752466, 13798.93100534501, 11220.0, 11395.601153959655, 11463.36951467669, 11574.826377604259, 11713.180077394585, 3892.377219644843, 3923.4899463069905, 3938.0548668319684, 3953.5453422856162, 4037.777922214277, 74155.0, 75660.62169689171, 76409.61795191043, 77025.22974770237, 77065.22934770693, 10096.44469554167, 10265.692029239135, 10374.17006639467, 10587.364758114538, 10812.513436895359, 20356.28752993668, 20484.18063277482, 20505.0, 20542.17831286732, 21038.579228415652, 8097.392695547857, 8339.708110216114, 8418.621162047722, 8476.660933562713, 9126.45241285525, 4807.831725889577, 4814.085323788469, 4820.68665536739, 4866.6106711463, 4894.216925291937, 3333.5333053372547, 3480.0603836964383, 3482.303539292101, 3485.1635607454537, 3493.2314890724, 601.5338112962489, 604.5798170271707, 624.2789578037374, 632.1750116098535, 638.1990601794718, 663.694700437804, 702.9841878485539, 711.3988679565758, 713.707379974208, 732.373820383575, 9050.456972581535, 9077.228435583049, 9183.95408022969, 9270.3313403588, 9543.33196676226, 620.9379062093844, 661.5501459007825, 674.9898751518731, 675.598019178588, 680.2755065854849, 4326.069894972533, 4540.364348991144, 4589.35748995141, 4605.355250264898, 4618.538146185355, 116902.41548792202, 117168.798184128, 117323.0, 121131.0, 122141.0, 76256.61871690606, 86554.0, 89452.55273723589, 104789.47605261925, 107773.46113269383, 88617.0, 88912.5554372237, 89746.55126724455, 91620.54189729142, 92232.0, 9934.254930880068, 10111.090001899864, 10446.895531044593, 10660.46697665129, 10708.143348531943, 48614.27078593895, 50932.0, 51695.22457163221, 52246.0, 52437.21344179917, 70851.64574177096, 78091.0, 79149.0, 79560.0, 79561.20438795538, 12409.44157512896, 12774.0, 12871.485140594272, 12917.03122265815, 13413.128146670435, 15500.92249538745, 15592.92203538975, 15687.843121568638, 16041.358345666044, 17083.06043167638, 13632.386542605409, 14333.78499322532, 15044.774328385301, 15298.0, 15467.381304747683, 13352.532661356807, 13819.516316928859, 13957.953059021986, 14028.018038737191, 14409.711805764036, 13962.092463989808, 14025.789613155606, 14091.295435227992, 14206.218657973497, 14714.926425367805, 11075.224734268846, 11138.665840024812, 11409.201355905006, 11713.158902487921, 11861.169718119994, 12043.458044388199, 12114.212576182872, 12187.817182742443, 12187.87812121903, 12292.078094142797], "value": 7594.719360092218, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 106.0, 112.0, 111.0, 112.0, 112.0, 111.0, 112.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 144.0, 163.0, 120.0, 148.0, 148.0, 119.0, 171.0, 120.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 159.0, 163.0, 164.0, 170.0, 169.0, 160.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 75.0, 168.0, 77.0, 76.0, 74.0, 75.0, 164.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 156.0, 86.0, 84.0, 83.0, 144.0, 84.0, 85.0, 150.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 120.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 103.0, 96.0, 96.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 77.0, 82.0, 77.0, 75.0, 77.0, 76.0, 82.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 124.0, 139.0, 123.0, 133.0, 131.0, 124.0, 174.0, 123.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 162.0, 164.0, 158.0, 156.0, 159.0, 161.0, 161.0, 163.0, 167.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 63.0, 64.0, 71.0, 62.0, 63.0, 61.0], "value": 64.3, "unit": "score"}]}]} 22:52:57 INFO - Return code: 0 22:52:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:52:57 ERROR - # TBPL SUCCESS # 22:52:57 INFO - Running post-action listener: _resource_record_post_action 22:52:57 INFO - ##### 22:52:57 INFO - ##### Finished run-tests step (success) 22:52:57 INFO - ##### 22:52:57 INFO - Running post-run listener: _resource_record_post_run 22:52:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 196608; Write bytes: 298352640; Read time: 44; Write time: 153592 22:52:57 INFO - TinderboxPrint: CPU usage
13.2% 22:52:57 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 44 22:52:57 INFO - TinderboxPrint: I/O write bytes / time
298,352,640 / 153,592 22:52:57 INFO - TinderboxPrint: CPU idle
8,235.9 (86.7%) 22:52:57 INFO - TinderboxPrint: CPU user
1,203.8 (12.7%) 22:52:57 INFO - TinderboxPrint: Swap in / out
0 / 0 22:52:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5206016; Read time: 0; Write time: 996 22:52:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 192512; Write bytes: 293146624; Read time: 32; Write time: 152596 22:52:57 INFO - Running post-run listener: _upload_blobber_files 22:52:57 INFO - Blob upload gear active. 22:52:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:52:57 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 22:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:52:58 INFO - (blobuploader) - INFO - Open directory for files ... 22:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:52:59 INFO - (blobuploader) - INFO - Done attempting. 22:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:02 INFO - (blobuploader) - INFO - Done attempting. 22:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:03 INFO - (blobuploader) - INFO - Done attempting. 22:53:03 INFO - (blobuploader) - INFO - Iteration through files over. 22:53:03 INFO - Return code: 0 22:53:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:53:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:53:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4221a109301776852af4c6ce9d12168d785b8d3d90e75859457cc469808770256281f5b586fbde4594caff28fd3e04b24411c4a00bc3ced081f1e75a094caf3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd84e3154ac42bc3d53ab9e97f9d81f19f6c1ef0e1ab8318e5ab8caefdf437f821ce4942f2c4f3b7dff2d57c1545068deac460f1c94814d8aee53ebeaf0c12ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbd7a71315ee65d256c6b8974dd97b16cbdd116c2852fa4f06fcce2907d3d7408d19b0be3d4964dbcde25bbd4ed135e05618ff2d308a8638c264a688ab47d02"} 22:53:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:53:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:53:03 INFO - Contents: 22:53:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4221a109301776852af4c6ce9d12168d785b8d3d90e75859457cc469808770256281f5b586fbde4594caff28fd3e04b24411c4a00bc3ced081f1e75a094caf3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd84e3154ac42bc3d53ab9e97f9d81f19f6c1ef0e1ab8318e5ab8caefdf437f821ce4942f2c4f3b7dff2d57c1545068deac460f1c94814d8aee53ebeaf0c12ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbd7a71315ee65d256c6b8974dd97b16cbdd116c2852fa4f06fcce2907d3d7408d19b0be3d4964dbcde25bbd4ed135e05618ff2d308a8638c264a688ab47d02"} 22:53:03 INFO - Running post-run listener: copy_logs_to_upload_dir 22:53:03 INFO - Copying logs to upload dir... 22:53:03 INFO - mkdir: /builds/slave/test/build/upload/logs 22:53:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.513013 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-05 22:53:03.315401) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:53:03.318973) ========= 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=d2a8c569965ab8367867b893000001a1-1467783153.5472-528770780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4221a109301776852af4c6ce9d12168d785b8d3d90e75859457cc469808770256281f5b586fbde4594caff28fd3e04b24411c4a00bc3ced081f1e75a094caf3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd84e3154ac42bc3d53ab9e97f9d81f19f6c1ef0e1ab8318e5ab8caefdf437f821ce4942f2c4f3b7dff2d57c1545068deac460f1c94814d8aee53ebeaf0c12ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbd7a71315ee65d256c6b8974dd97b16cbdd116c2852fa4f06fcce2907d3d7408d19b0be3d4964dbcde25bbd4ed135e05618ff2d308a8638c264a688ab47d02"} build_url:https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/HkOQot9fRwS4wvommiS4bg/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/Mozilla-Inbound/sha512/4221a109301776852af4c6ce9d12168d785b8d3d90e75859457cc469808770256281f5b586fbde4594caff28fd3e04b24411c4a00bc3ced081f1e75a094caf3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd84e3154ac42bc3d53ab9e97f9d81f19f6c1ef0e1ab8318e5ab8caefdf437f821ce4942f2c4f3b7dff2d57c1545068deac460f1c94814d8aee53ebeaf0c12ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbd7a71315ee65d256c6b8974dd97b16cbdd116c2852fa4f06fcce2907d3d7408d19b0be3d4964dbcde25bbd4ed135e05618ff2d308a8638c264a688ab47d02"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:53:03.345440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:53:03.345839) ========= 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=d2a8c569965ab8367867b893000001a1-1467783153.5472-528770780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:53:03.430850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:53:03.431261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:53:03.431643) ========= ========= Total master_lag: 0.18 =========