builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1468318333.16 results: success (0) buildid: 20160712015826 builduid: b2bae7ef5a144dfea66ad3a19b8f5afd revision: 4e2084c39d2be1824042666e2fd05d2b26bab543 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.156559) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.157029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.157364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.172125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.172540) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 03:12:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-07-12 03:12:13 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.283612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.284284) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018714 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.338197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:13.339011) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e2084c39d2be1824042666e2fd05d2b26bab543 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4e2084c39d2be1824042666e2fd05d2b26bab543 --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=5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 03:12:13,943 truncating revision to first 12 chars 2016-07-12 03:12:13,943 Setting DEBUG logging. 2016-07-12 03:12:13,943 attempt 1/10 2016-07-12 03:12:13,943 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e2084c39d2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 03:12:14,255 unpacking tar archive at: mozilla-central-4e2084c39d2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:14.055479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:14.056172) ========= script_repo_revision: 4e2084c39d2be1824042666e2fd05d2b26bab543 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:14.056866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:14.057177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:12:14.068175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-07-12 03:12:14.068539) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:12:14 INFO - MultiFileLogger online at 20160712 03:12:14 in /builds/slave/test 03:12:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:12:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:12:14 INFO - {'append_to_log': False, 03:12:14 INFO - 'base_work_dir': '/builds/slave/test', 03:12:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:12:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:12:14 INFO - 'branch': 'Firefox-Non-PGO', 03:12:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:12:14 INFO - 'config_files': ('talos/linux_config.py',), 03:12:14 INFO - 'default_actions': ('clobber', 03:12:14 INFO - 'read-buildbot-config', 03:12:14 INFO - 'download-and-extract', 03:12:14 INFO - 'populate-webroot', 03:12:14 INFO - 'create-virtualenv', 03:12:14 INFO - 'install', 03:12:14 INFO - 'run-tests'), 03:12:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:12:14 INFO - 'download_minidump_stackwalk': True, 03:12:14 INFO - 'download_symbols': 'ondemand', 03:12:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:12:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:12:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:12:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:12:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:12:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:12:14 INFO - 'installer_path': 'installer.exe', 03:12:14 INFO - 'log_level': 'info', 03:12:14 INFO - 'log_name': 'talos', 03:12:14 INFO - 'log_to_console': True, 03:12:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:12:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:12:14 INFO - 'opt_config_files': (), 03:12:14 INFO - 'pip_index': False, 03:12:14 INFO - 'sps_profile': False, 03:12:14 INFO - 'sps_profile_interval': 0, 03:12:14 INFO - 'suite': 'dromaeojs', 03:12:14 INFO - 'system_bits': '32', 03:12:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:12:14 INFO - 'title': 'talos-linux64-ix-011', 03:12:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:12:14 INFO - 'use_talos_json': True, 03:12:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:12:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:12:14 INFO - 'work_dir': 'build'} 03:12:14 INFO - ##### 03:12:14 INFO - ##### Running clobber step. 03:12:14 INFO - ##### 03:12:14 INFO - Running pre-action listener: _resource_record_pre_action 03:12:14 INFO - Running main action method: clobber 03:12:14 INFO - rmtree: /builds/slave/test/build 03:12:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:12:15 INFO - Running post-action listener: _resource_record_post_action 03:12:15 INFO - ##### 03:12:15 INFO - ##### Finished clobber step (success) 03:12:15 INFO - ##### 03:12:15 INFO - ##### 03:12:15 INFO - ##### Running read-buildbot-config step. 03:12:15 INFO - ##### 03:12:15 INFO - Running pre-action listener: _resource_record_pre_action 03:12:15 INFO - Running main action method: read_buildbot_config 03:12:15 INFO - Using buildbot properties: 03:12:15 INFO - { 03:12:15 INFO - "project": "", 03:12:15 INFO - "product": "firefox", 03:12:15 INFO - "script_repo_revision": "production", 03:12:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:12:15 INFO - "repository": "", 03:12:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:12:15 INFO - "buildid": "20160712015826", 03:12:15 INFO - "pgo_build": "False", 03:12:15 INFO - "basedir": "/builds/slave/test", 03:12:15 INFO - "buildnumber": 553, 03:12:15 INFO - "slavename": "talos-linux64-ix-011", 03:12:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:12:15 INFO - "platform": "ubuntu64_hw", 03:12:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:12:15 INFO - "branch": "mozilla-central", 03:12:15 INFO - "repo_path": "mozilla-central", 03:12:15 INFO - "revision": "4e2084c39d2be1824042666e2fd05d2b26bab543", 03:12:15 INFO - "stage_platform": "linux64", 03:12:15 INFO - "builduid": "b2bae7ef5a144dfea66ad3a19b8f5afd", 03:12:15 INFO - "slavebuilddir": "test" 03:12:15 INFO - } 03:12:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:12:15 INFO - Running post-action listener: _resource_record_post_action 03:12:15 INFO - ##### 03:12:15 INFO - ##### Finished read-buildbot-config step (success) 03:12:15 INFO - ##### 03:12:15 INFO - ##### 03:12:15 INFO - ##### Running download-and-extract step. 03:12:15 INFO - ##### 03:12:15 INFO - Running pre-action listener: _resource_record_pre_action 03:12:15 INFO - Running main action method: download_and_extract 03:12:15 INFO - mkdir: /builds/slave/test/build/tests 03:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:15 INFO - https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:17 INFO - Downloaded 1361 bytes. 03:12:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:17 INFO - Using the following test package requirements: 03:12:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:12:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:12:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:12:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'jsshell-linux-x86_64.zip'], 03:12:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:12:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:12:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:12:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:12:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:12:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:12:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:17 INFO - https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:18 INFO - Downloaded 22700289 bytes. 03:12:18 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'] 03:12:18 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 03:12:20 INFO - Return code: 0 03:12:20 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 03:12:20 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')]} 03:12:20 INFO - https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:21 INFO - Downloaded 22700289 bytes. 03:12:21 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'] 03:12:21 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 03:12:23 INFO - Return code: 0 03:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:23 INFO - https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:24 INFO - Downloaded 14403333 bytes. 03:12:24 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'] 03:12:24 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 03:12:24 INFO - Return code: 0 03:12: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')]} 03:12:24 INFO - https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:12:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:12:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:12:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Op1yVRlYQIqy9MydDgro7Q/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 03:12:26 INFO - Downloaded 56654098 bytes. 03:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:12:26 INFO - mkdir: /builds/slave/test/properties 03:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:12:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:12:26 INFO - Contents: 03:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:12:27 INFO - Running post-action listener: _resource_record_post_action 03:12:27 INFO - Running post-action listener: set_extra_try_arguments 03:12:27 INFO - ##### 03:12:27 INFO - ##### Finished download-and-extract step (success) 03:12:27 INFO - ##### 03:12:27 INFO - ##### 03:12:27 INFO - ##### Running populate-webroot step. 03:12:27 INFO - ##### 03:12:27 INFO - Running pre-action listener: _resource_record_pre_action 03:12:27 INFO - Running main action method: populate_webroot 03:12:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:12:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:12:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:12:27 INFO - '--tppagecycles', 03:12:27 INFO - '7'], 03:12:27 INFO - 'tests': ['tsvgm']}}, 03:12:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:12:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:12:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:12:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:12:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:12:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:12:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['damp', 'tps']}, 03:12:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'tests': ['damp', 'tps']}, 03:12:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['dromaeo_dom']}, 03:12:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:12:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['basic_compositor_video']}, 03:12:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:12:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['a11yr', 03:12:27 INFO - 'ts_paint', 03:12:27 INFO - 'tpaint', 03:12:27 INFO - 'sessionrestore', 03:12:27 INFO - 'sessionrestore_no_auto_restore', 03:12:27 INFO - 'tabpaint']}, 03:12:27 INFO - 'other-e10s': {'tests': ['a11yr', 03:12:27 INFO - 'ts_paint', 03:12:27 INFO - 'tpaint', 03:12:27 INFO - 'sessionrestore', 03:12:27 INFO - 'sessionrestore_no_auto_restore', 03:12:27 INFO - 'tabpaint']}, 03:12:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:12:27 INFO - 'ts_paint', 03:12:27 INFO - 'tpaint', 03:12:27 INFO - 'sessionrestore', 03:12:27 INFO - 'sessionrestore_no_auto_restore', 03:12:27 INFO - 'tabpaint']}, 03:12:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:12:27 INFO - 'ts_paint', 03:12:27 INFO - 'tpaint', 03:12:27 INFO - 'sessionrestore', 03:12:27 INFO - 'sessionrestore_no_auto_restore', 03:12:27 INFO - 'tabpaint']}, 03:12:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['a11yr', 03:12:27 INFO - 'ts_paint', 03:12:27 INFO - 'tpaint', 03:12:27 INFO - 'sessionrestore', 03:12:27 INFO - 'sessionrestore_no_auto_restore', 03:12:27 INFO - 'tabpaint']}, 03:12:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['a11yr', 03:12:27 INFO - 'ts_paint', 03:12:27 INFO - 'tpaint', 03:12:27 INFO - 'sessionrestore', 03:12:27 INFO - 'sessionrestore_no_auto_restore', 03:12:27 INFO - 'tabpaint']}, 03:12:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['tsvgx', 03:12:27 INFO - 'tsvgr_opacity', 03:12:27 INFO - 'tart', 03:12:27 INFO - 'tscrollx', 03:12:27 INFO - 'cart']}, 03:12:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:12:27 INFO - 'tsvgr_opacity', 03:12:27 INFO - 'tart', 03:12:27 INFO - 'tscrollx', 03:12:27 INFO - 'cart']}, 03:12:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'talos_options': ['--disable-e10s'], 03:12:27 INFO - 'tests': ['tp5o']}, 03:12:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'tests': ['tp5o']}, 03:12:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'talos_options': ['--disable-e10s', 03:12:27 INFO - '--xperf_path', 03:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:12:27 INFO - 'tests': ['tp5n']}, 03:12:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:27 INFO - 'talos_options': ['--xperf_path', 03:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:12:27 INFO - 'tests': ['tp5n']}}, 03:12:27 INFO - 'talos.zip': {'path': '', 03:12:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:12:27 INFO - Running post-action listener: _resource_record_post_action 03:12:27 INFO - ##### 03:12:27 INFO - ##### Finished populate-webroot step (success) 03:12:27 INFO - ##### 03:12:27 INFO - ##### 03:12:27 INFO - ##### Running create-virtualenv step. 03:12:27 INFO - ##### 03:12:27 INFO - Running pre-action listener: _resource_record_pre_action 03:12:27 INFO - Running main action method: create_virtualenv 03:12:27 INFO - Creating virtualenv /builds/slave/test/build/venv 03:12:27 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 03:12:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:12:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:12:27 INFO - Using real prefix '/usr' 03:12:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:12:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:12:30 INFO - Installing pip.................done. 03:12:30 INFO - Return code: 0 03:12:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:30 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:30 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 03:12:30 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 03:12:30 INFO - Using env: {'DISPLAY': ':0', 03:12:30 INFO - 'HOME': '/home/cltbld', 03:12:30 INFO - 'LANG': 'en_US.UTF-8', 03:12:30 INFO - 'LANGUAGE': 'en_US:en', 03:12:30 INFO - 'LOGNAME': 'cltbld', 03:12:30 INFO - 'MAIL': '/var/mail/cltbld', 03:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:30 INFO - 'MOZ_NO_REMOTE': '1', 03:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:30 INFO - 'NO_EM_RESTART': '1', 03:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:30 INFO - 'PWD': '/builds/slave/test', 03:12:30 INFO - 'SHELL': '/bin/bash', 03:12:30 INFO - 'SHLVL': '1', 03:12:30 INFO - 'TERM': 'linux', 03:12:30 INFO - 'TMOUT': '86400', 03:12:30 INFO - 'USER': 'cltbld', 03:12:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:30 INFO - '_': '/tools/buildbot/bin/python'} 03:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:30 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 03:12:30 INFO - Cleaning up... 03:12:30 INFO - Return code: 0 03:12:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:30 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:30 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 03:12:30 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 03:12:30 INFO - Using env: {'DISPLAY': ':0', 03:12:30 INFO - 'HOME': '/home/cltbld', 03:12:30 INFO - 'LANG': 'en_US.UTF-8', 03:12:30 INFO - 'LANGUAGE': 'en_US:en', 03:12:30 INFO - 'LOGNAME': 'cltbld', 03:12:30 INFO - 'MAIL': '/var/mail/cltbld', 03:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:30 INFO - 'MOZ_NO_REMOTE': '1', 03:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:30 INFO - 'NO_EM_RESTART': '1', 03:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:30 INFO - 'PWD': '/builds/slave/test', 03:12:30 INFO - 'SHELL': '/bin/bash', 03:12:30 INFO - 'SHLVL': '1', 03:12:30 INFO - 'TERM': 'linux', 03:12:30 INFO - 'TMOUT': '86400', 03:12:30 INFO - 'USER': 'cltbld', 03:12:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:30 INFO - '_': '/tools/buildbot/bin/python'} 03:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:30 INFO - Downloading/unpacking psutil>=3.1.1 03:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:32 INFO - Installing collected packages: psutil 03:12:32 INFO - Running setup.py install for psutil 03:12:32 INFO - building 'psutil._psutil_linux' extension 03:12:32 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 03:12:32 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 03:12:32 INFO - building 'psutil._psutil_posix' extension 03:12:32 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 03:12:32 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 03:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:32 INFO - Successfully installed psutil 03:12:32 INFO - Cleaning up... 03:12:33 INFO - Return code: 0 03:12:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:33 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:33 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 03:12:33 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 03:12:33 INFO - Using env: {'DISPLAY': ':0', 03:12:33 INFO - 'HOME': '/home/cltbld', 03:12:33 INFO - 'LANG': 'en_US.UTF-8', 03:12:33 INFO - 'LANGUAGE': 'en_US:en', 03:12:33 INFO - 'LOGNAME': 'cltbld', 03:12:33 INFO - 'MAIL': '/var/mail/cltbld', 03:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:33 INFO - 'MOZ_NO_REMOTE': '1', 03:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:33 INFO - 'NO_EM_RESTART': '1', 03:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:33 INFO - 'PWD': '/builds/slave/test', 03:12:33 INFO - 'SHELL': '/bin/bash', 03:12:33 INFO - 'SHLVL': '1', 03:12:33 INFO - 'TERM': 'linux', 03:12:33 INFO - 'TMOUT': '86400', 03:12:33 INFO - 'USER': 'cltbld', 03:12:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:33 INFO - '_': '/tools/buildbot/bin/python'} 03:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:12:33 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 03:12:33 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 03:12:33 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 03:12:33 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 03:12:33 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 03:12:33 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 03:12:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:12:35 INFO - Installing collected packages: mozsystemmonitor 03:12:35 INFO - Running setup.py install for mozsystemmonitor 03:12:35 INFO - Successfully installed mozsystemmonitor 03:12:35 INFO - Cleaning up... 03:12:35 INFO - Return code: 0 03:12:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:12:35 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')]} 03:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:35 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')]} 03:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:35 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:35 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 03:12:35 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 03:12:35 INFO - Using env: {'DISPLAY': ':0', 03:12:35 INFO - 'HOME': '/home/cltbld', 03:12:35 INFO - 'LANG': 'en_US.UTF-8', 03:12:35 INFO - 'LANGUAGE': 'en_US:en', 03:12:35 INFO - 'LOGNAME': 'cltbld', 03:12:35 INFO - 'MAIL': '/var/mail/cltbld', 03:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:35 INFO - 'MOZ_NO_REMOTE': '1', 03:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:35 INFO - 'NO_EM_RESTART': '1', 03:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:35 INFO - 'PWD': '/builds/slave/test', 03:12:35 INFO - 'SHELL': '/bin/bash', 03:12:35 INFO - 'SHLVL': '1', 03:12:35 INFO - 'TERM': 'linux', 03:12:35 INFO - 'TMOUT': '86400', 03:12:35 INFO - 'USER': 'cltbld', 03:12:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:35 INFO - '_': '/tools/buildbot/bin/python'} 03:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:12:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:12:37 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 03:12:37 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 03:12:37 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 03:12:37 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 03:12:37 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 03:12:37 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 03:12:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:12:37 INFO - warning: no files found matching '*.txt' 03:12:37 INFO - no previously-included directories found matching 'build' 03:12:37 INFO - no previously-included directories found matching 'dist' 03:12:37 INFO - no previously-included directories found matching '.git*' 03:12:37 INFO - Installing collected packages: jsonschema, functools32 03:12:37 INFO - Running setup.py install for functools32 03:12:37 INFO - warning: no files found matching '*.txt' 03:12:37 INFO - no previously-included directories found matching 'build' 03:12:37 INFO - no previously-included directories found matching 'dist' 03:12:37 INFO - no previously-included directories found matching '.git*' 03:12:37 INFO - Successfully installed jsonschema functools32 03:12:37 INFO - Cleaning up... 03:12:37 INFO - Return code: 0 03:12:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:37 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:37 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 03:12:37 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 03:12:37 INFO - Using env: {'DISPLAY': ':0', 03:12:37 INFO - 'HOME': '/home/cltbld', 03:12:37 INFO - 'LANG': 'en_US.UTF-8', 03:12:37 INFO - 'LANGUAGE': 'en_US:en', 03:12:37 INFO - 'LOGNAME': 'cltbld', 03:12:37 INFO - 'MAIL': '/var/mail/cltbld', 03:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:37 INFO - 'MOZ_NO_REMOTE': '1', 03:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:37 INFO - 'NO_EM_RESTART': '1', 03:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:37 INFO - 'PWD': '/builds/slave/test', 03:12:37 INFO - 'SHELL': '/bin/bash', 03:12:37 INFO - 'SHLVL': '1', 03:12:37 INFO - 'TERM': 'linux', 03:12:37 INFO - 'TMOUT': '86400', 03:12:37 INFO - 'USER': 'cltbld', 03:12:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:37 INFO - '_': '/tools/buildbot/bin/python'} 03:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:12:38 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 03:12:38 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 03:12:38 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 03:12:38 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 03:12:38 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 03:12:38 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 03:12:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:12:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:12:39 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 03:12:39 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 03:12:39 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 03:12:39 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 03:12:39 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 03:12:39 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 03:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:12:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:12:39 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 03:12:39 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 03:12:39 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 03:12:39 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 03:12:39 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 03:12:39 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 03:12:40 INFO - Downloading docopt-0.6.1.tar.gz 03:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:12:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:12:40 INFO - Running setup.py install for blobuploader 03:12:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:12:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:12:40 INFO - Running setup.py install for requests 03:12:41 INFO - Running setup.py install for docopt 03:12:41 INFO - Successfully installed blobuploader requests docopt 03:12:41 INFO - Cleaning up... 03:12:41 INFO - Return code: 0 03:12:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:41 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:41 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 03:12:41 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 03:12:41 INFO - Using env: {'DISPLAY': ':0', 03:12:41 INFO - 'HOME': '/home/cltbld', 03:12:41 INFO - 'LANG': 'en_US.UTF-8', 03:12:41 INFO - 'LANGUAGE': 'en_US:en', 03:12:41 INFO - 'LOGNAME': 'cltbld', 03:12:41 INFO - 'MAIL': '/var/mail/cltbld', 03:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:41 INFO - 'MOZ_NO_REMOTE': '1', 03:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:41 INFO - 'NO_EM_RESTART': '1', 03:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:41 INFO - 'PWD': '/builds/slave/test', 03:12:41 INFO - 'SHELL': '/bin/bash', 03:12:41 INFO - 'SHLVL': '1', 03:12:41 INFO - 'TERM': 'linux', 03:12:41 INFO - 'TMOUT': '86400', 03:12:41 INFO - 'USER': 'cltbld', 03:12:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:41 INFO - '_': '/tools/buildbot/bin/python'} 03:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:41 INFO - Running setup.py (path:/tmp/pip-un3KbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:41 INFO - Running setup.py (path:/tmp/pip-D9XPOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:41 INFO - Running setup.py (path:/tmp/pip-reCZWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:41 INFO - Running setup.py (path:/tmp/pip-sYPwyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:41 INFO - Running setup.py (path:/tmp/pip-0MQx6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:41 INFO - Running setup.py (path:/tmp/pip-aoDD8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:41 INFO - Running setup.py (path:/tmp/pip-KyumMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:41 INFO - Running setup.py (path:/tmp/pip-8yD9L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:41 INFO - Running setup.py (path:/tmp/pip-MhQcjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:42 INFO - Running setup.py (path:/tmp/pip-0YVKcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:42 INFO - Running setup.py (path:/tmp/pip-hk4zDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:42 INFO - Running setup.py (path:/tmp/pip-u5RKGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:42 INFO - Running setup.py (path:/tmp/pip-DBbBa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:42 INFO - Running setup.py (path:/tmp/pip-8DyK6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:42 INFO - Running setup.py (path:/tmp/pip-0vSR4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:42 INFO - Running setup.py (path:/tmp/pip-c8IqEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:42 INFO - Running setup.py (path:/tmp/pip-t_95CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:12:42 INFO - Running setup.py install for manifestparser 03:12:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:12:42 INFO - Running setup.py install for mozcrash 03:12:42 INFO - Running setup.py install for mozdebug 03:12:42 INFO - Running setup.py install for mozdevice 03:12:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Running setup.py install for mozfile 03:12:43 INFO - Running setup.py install for mozhttpd 03:12:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Running setup.py install for mozinfo 03:12:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Running setup.py install for mozInstall 03:12:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Running setup.py install for mozleak 03:12:43 INFO - Running setup.py install for mozlog 03:12:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Running setup.py install for moznetwork 03:12:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Running setup.py install for mozprocess 03:12:43 INFO - Running setup.py install for mozprofile 03:12:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:12:43 INFO - Running setup.py install for mozrunner 03:12:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:12:44 INFO - Running setup.py install for mozscreenshot 03:12:44 INFO - Running setup.py install for moztest 03:12:44 INFO - Running setup.py install for mozversion 03:12:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:12:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:12:44 INFO - Cleaning up... 03:12:44 INFO - Return code: 0 03:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:44 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:44 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 03:12:44 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 03:12:44 INFO - Using env: {'DISPLAY': ':0', 03:12:44 INFO - 'HOME': '/home/cltbld', 03:12:44 INFO - 'LANG': 'en_US.UTF-8', 03:12:44 INFO - 'LANGUAGE': 'en_US:en', 03:12:44 INFO - 'LOGNAME': 'cltbld', 03:12:44 INFO - 'MAIL': '/var/mail/cltbld', 03:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:44 INFO - 'MOZ_NO_REMOTE': '1', 03:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:44 INFO - 'NO_EM_RESTART': '1', 03:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:44 INFO - 'PWD': '/builds/slave/test', 03:12:44 INFO - 'SHELL': '/bin/bash', 03:12:44 INFO - 'SHLVL': '1', 03:12:44 INFO - 'TERM': 'linux', 03:12:44 INFO - 'TMOUT': '86400', 03:12:44 INFO - 'USER': 'cltbld', 03:12:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:44 INFO - '_': '/tools/buildbot/bin/python'} 03:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:44 INFO - Running setup.py (path:/tmp/pip-lQizoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:44 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)) 03:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:44 INFO - Running setup.py (path:/tmp/pip-awhnia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:44 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)) 03:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:44 INFO - Running setup.py (path:/tmp/pip-0Fwaa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:44 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)) 03:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:44 INFO - Running setup.py (path:/tmp/pip-LskrT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:44 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)) 03:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:44 INFO - Running setup.py (path:/tmp/pip-0JMxJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:45 INFO - Running setup.py (path:/tmp/pip-JAiCMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:45 INFO - Running setup.py (path:/tmp/pip-9XImst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:45 INFO - Running setup.py (path:/tmp/pip-mnTyb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:45 INFO - Running setup.py (path:/tmp/pip-AV4a7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:45 INFO - Running setup.py (path:/tmp/pip-fyp8dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:45 INFO - Running setup.py (path:/tmp/pip-VaOXuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:45 INFO - Running setup.py (path:/tmp/pip-A1sGce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:45 INFO - Running setup.py (path:/tmp/pip-NSSnlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:45 INFO - Running setup.py (path:/tmp/pip-FurBdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:45 INFO - Running setup.py (path:/tmp/pip-UMe7DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:45 INFO - Running setup.py (path:/tmp/pip-zGuPYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:45 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)) 03:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:45 INFO - Running setup.py (path:/tmp/pip-FVCjUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:45 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)) 03:12:45 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)) 03:12:45 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)) 03:12:45 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)) 03:12:45 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)) 03:12:45 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)) 03:12:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:45 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 03:12:45 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 03:12:45 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 03:12:45 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 03:12:45 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 03:12:45 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 03:12:47 INFO - Downloading blessings-1.6.tar.gz 03:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:12:47 INFO - Installing collected packages: blessings 03:12:47 INFO - Running setup.py install for blessings 03:12:47 INFO - Successfully installed blessings 03:12:47 INFO - Cleaning up... 03:12:48 INFO - Return code: 0 03:12:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:48 INFO - Reading from file tmpfile_stdout 03:12:48 INFO - Current package versions: 03:12:48 INFO - argparse == 1.2.1 03:12:48 INFO - blessings == 1.6 03:12:48 INFO - blobuploader == 1.2.4 03:12:48 INFO - docopt == 0.6.1 03:12:48 INFO - functools32 == 3.2.3-2 03:12:48 INFO - jsonschema == 2.5.1 03:12:48 INFO - manifestparser == 1.1 03:12:48 INFO - mozInstall == 1.12 03:12:48 INFO - mozcrash == 0.17 03:12:48 INFO - mozdebug == 0.1 03:12:48 INFO - mozdevice == 0.48 03:12:48 INFO - mozfile == 1.2 03:12:48 INFO - mozhttpd == 0.7 03:12:48 INFO - mozinfo == 0.9 03:12:48 INFO - mozleak == 0.1 03:12:48 INFO - mozlog == 3.2 03:12:48 INFO - moznetwork == 0.27 03:12:48 INFO - mozprocess == 0.23 03:12:48 INFO - mozprofile == 0.28 03:12:48 INFO - mozrunner == 6.12 03:12:48 INFO - mozscreenshot == 0.1 03:12:48 INFO - mozsystemmonitor == 0.3 03:12:48 INFO - moztest == 0.7 03:12:48 INFO - mozversion == 1.4 03:12:48 INFO - psutil == 3.1.1 03:12:48 INFO - requests == 1.2.3 03:12:48 INFO - wsgiref == 0.1.2 03:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:48 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 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12:48 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 03:12:48 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 03:12:48 INFO - Using env: {'DISPLAY': ':0', 03:12:48 INFO - 'HOME': '/home/cltbld', 03:12:48 INFO - 'LANG': 'en_US.UTF-8', 03:12:48 INFO - 'LANGUAGE': 'en_US:en', 03:12:48 INFO - 'LOGNAME': 'cltbld', 03:12:48 INFO - 'MAIL': '/var/mail/cltbld', 03:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:48 INFO - 'MOZ_NO_REMOTE': '1', 03:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:48 INFO - 'NO_EM_RESTART': '1', 03:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:48 INFO - 'PWD': '/builds/slave/test', 03:12:48 INFO - 'SHELL': '/bin/bash', 03:12:48 INFO - 'SHLVL': '1', 03:12:48 INFO - 'TERM': 'linux', 03:12:48 INFO - 'TMOUT': '86400', 03:12:48 INFO - 'USER': 'cltbld', 03:12:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:48 INFO - '_': '/tools/buildbot/bin/python'} 03:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 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)) 03:12:48 INFO - Cleaning up... 03:12:48 INFO - Return code: 0 03:12:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', '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 03:12: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', 'jsonschema'] in /builds/slave/test/build 03:12: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 jsonschema 03:12:48 INFO - Using env: {'DISPLAY': ':0', 03:12:48 INFO - 'HOME': '/home/cltbld', 03:12:48 INFO - 'LANG': 'en_US.UTF-8', 03:12:48 INFO - 'LANGUAGE': 'en_US:en', 03:12:48 INFO - 'LOGNAME': 'cltbld', 03:12:48 INFO - 'MAIL': '/var/mail/cltbld', 03:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:48 INFO - 'MOZ_NO_REMOTE': '1', 03:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:48 INFO - 'NO_EM_RESTART': '1', 03:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:48 INFO - 'PWD': '/builds/slave/test', 03:12:48 INFO - 'SHELL': '/bin/bash', 03:12:48 INFO - 'SHLVL': '1', 03:12:48 INFO - 'TERM': 'linux', 03:12:48 INFO - 'TMOUT': '86400', 03:12:48 INFO - 'USER': 'cltbld', 03:12:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:48 INFO - '_': '/tools/buildbot/bin/python'} 03:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:12:48 INFO - Cleaning up... 03:12:48 INFO - Return code: 0 03:12:48 INFO - Running post-action listener: _resource_record_post_action 03:12:48 INFO - Running post-action listener: _start_resource_monitoring 03:12:48 INFO - Starting resource monitoring. 03:12:48 INFO - ##### 03:12:48 INFO - ##### Finished create-virtualenv step (success) 03:12:48 INFO - ##### 03:12:48 INFO - ##### 03:12:48 INFO - ##### Running install step. 03:12:48 INFO - ##### 03:12:48 INFO - Running pre-action listener: _resource_record_pre_action 03:12:48 INFO - Running main action method: install 03:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:48 INFO - Reading from file tmpfile_stdout 03:12:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:12:49 INFO - Reading from file tmpfile_stdout 03:12:49 INFO - Output received: 03:12:49 INFO - Usage: mozinstall [options] installer 03:12:49 INFO - Options: 03:12:49 INFO - -h, --help show this help message and exit 03:12:49 INFO - -d DEST, --destination=DEST 03:12:49 INFO - Directory to install application into. [default: 03:12:49 INFO - "/builds/slave/test"] 03:12:49 INFO - --app=APP Application being installed. [default: firefox] 03:12:49 INFO - mkdir: /builds/slave/test/build/application 03:12:49 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'] 03:12:49 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 03:13:05 INFO - Reading from file tmpfile_stdout 03:13:05 INFO - Output received: 03:13:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:13:05 INFO - Running post-action listener: _resource_record_post_action 03:13:05 INFO - ##### 03:13:05 INFO - ##### Finished install step (success) 03:13:05 INFO - ##### 03:13:05 INFO - ##### 03:13:05 INFO - ##### Running run-tests step. 03:13:05 INFO - ##### 03:13:05 INFO - Running pre-action listener: _resource_record_pre_action 03:13:05 INFO - Running main action method: run_tests 03:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:13:05 INFO - Python 2.7.3 03:13:05 INFO - Return code: 0 03:13:05 INFO - grabbing minidump binary from tooltool 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:05 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 0x10913b0>, '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 0x10922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:13:05 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 03:13:05 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 03:13:05 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 03:13:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:13:05 INFO - Return code: 0 03:13:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:13:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:13:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:13:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:13:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:13:05 INFO - Using env: {'DISPLAY': ':0', 03:13:05 INFO - 'HOME': '/home/cltbld', 03:13:05 INFO - 'LANG': 'en_US.UTF-8', 03:13:05 INFO - 'LANGUAGE': 'en_US:en', 03:13:05 INFO - 'LOGNAME': 'cltbld', 03:13:05 INFO - 'MAIL': '/var/mail/cltbld', 03:13:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:13:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:05 INFO - 'MOZ_NO_REMOTE': '1', 03:13:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:05 INFO - 'NO_EM_RESTART': '1', 03:13:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:05 INFO - 'PWD': '/builds/slave/test', 03:13:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:13:05 INFO - 'SHELL': '/bin/bash', 03:13:05 INFO - 'SHLVL': '1', 03:13:05 INFO - 'TERM': 'linux', 03:13:05 INFO - 'TMOUT': '86400', 03:13:05 INFO - 'USER': 'cltbld', 03:13:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894', 03:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:05 INFO - '_': '/tools/buildbot/bin/python'} 03:13:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:13:05 INFO - mozversion application_buildid: 20160712015826 03:13:05 INFO - mozversion application_changeset: 4e2084c39d2be1824042666e2fd05d2b26bab543 03:13:05 INFO - mozversion application_display_name: Nightly 03:13:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:13:05 INFO - mozversion application_name: Firefox 03:13:05 INFO - mozversion application_remotingname: firefox 03:13:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:13:05 INFO - mozversion application_vendor: Mozilla 03:13:05 INFO - mozversion application_version: 50.0a1 03:13:05 INFO - mozversion platform_buildid: 20160712015826 03:13:05 INFO - mozversion platform_changeset: 4e2084c39d2be1824042666e2fd05d2b26bab543 03:13:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:13:05 INFO - mozversion platform_version: 50.0a1 03:13:05 INFO - using testdate: 1468318385 03:13:05 INFO - actual date: 1468318385 03:13:05 INFO - starting webserver on 'localhost:46436' 03:13:05 INFO - SUITE-START | Running 2 tests 03:13:05 INFO - TEST-START | dromaeo_css 03:13:05 INFO - operating with platform_type : linux_ 03:13:05 INFO - Initialising browser for dromaeo_css test... 03:13:05 INFO - TEST-INFO | started process 8913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprO5DpK/profile http://localhost:46436/getInfo.html) 03:13:10 INFO - PROCESS | 8913 | __metrics Screen width/height:1600/1200 03:13:10 INFO - PROCESS | 8913 | colorDepth:24 03:13:10 INFO - PROCESS | 8913 | Browser inner width/height: 1024/697 03:13:10 INFO - PROCESS | 8913 | __metrics 03:13:11 INFO - PROCESS | 8913 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:13:11 INFO - PROCESS | 8913 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:13:12 INFO - TEST-INFO | 8913: exit 0 03:13:12 INFO - Browser initialized. 03:13:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:13:12 INFO - TEST-INFO | started process 8994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprO5DpK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:24 INFO - PROCESS | 8994 | RSS: Main: 158670848 03:13:24 INFO - PROCESS | 8994 | 03:14:16 INFO - PROCESS | 8994 | 1468318456181 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] 03:16:28 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:46436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46436/tests/dromaeo/cssquery-ext.html) 03:16:30 INFO - PROCESS | 8994 | RSS: Main: 240279552 03:16:30 INFO - PROCESS | 8994 | 03:19:32 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:46436/tests/dromaeo/cssquery-ext.html (next: http://localhost:46436/tests/dromaeo/cssquery-jquery.html) 03:19:33 INFO - PROCESS | 8994 | RSS: Main: 249466880 03:19:33 INFO - PROCESS | 8994 | 03:22:35 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:46436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46436/tests/dromaeo/cssquery-mootools.html) 03:22:36 INFO - PROCESS | 8994 | RSS: Main: 243003392 03:22:36 INFO - PROCESS | 8994 | 03:25:38 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:46436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46436/tests/dromaeo/cssquery-prototype.html) 03:25:39 INFO - PROCESS | 8994 | RSS: Main: 240181248 03:25:39 INFO - PROCESS | 8994 | 03:28:42 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:46436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46436/tests/dromaeo/cssquery-yui.html) 03:28:42 INFO - PROCESS | 8994 | RSS: Main: 221540352 03:28:42 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:46436/tests/dromaeo/cssquery-yui.html (next: http://localhost:46436/tests/dromaeo/cssquery-dojo.html) 03:31:45 INFO - PROCESS | 8994 | RSS: Main: 322072576 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | __start_tp_report 03:31:45 INFO - PROCESS | 8994 | _x_x_mozilla_page_load 03:31:45 INFO - PROCESS | 8994 | _x_x_mozilla_page_load_details 03:31:45 INFO - PROCESS | 8994 | |i|pagename|runs| 03:31:45 INFO - PROCESS | 8994 | |0;dojo.html;2579.264909500793;2608.3609515668663;2610.1777939948915;2612.3991481959147;2648.9602655960166;4617.307403889418;4654.790534425951;4719.740414277213;4736.313234580988;4795.448523419804;4594.127115847995;4644.953550464495;4671.4627817800965;4684.016356565117;4715.834945776898;4251.638610718092;4253.425787518692;4327.156204540116;4349.521552629209;4355.978220108895;4393.692441529094;4442.844500442485;4446.888827779299;4472.262076757331;4481.372607834889;4136;4185.602367775056;4195.832166713328;4294.806733696991;4373.825046998117;4310.31035034393;4350.978245108786;4351.6953813233085;4351.717138385995;4352.89117772055;4320.524742278347;4322.113966636832;4323.2218200723855;4325.048489332374;4326.545712700153;4578.473475550321;4632.374629425019;4638.1883170445035;4640.976795116037;4706.058788242365;5025.472325405816;5033.899322013539;5105.591552675777;5107.846764597031;5110.923336149961;4920.827771027997;5125.615578831603;5128.615353848476;5136.255242989783;5138.023775482684;4708;4738.620910327166;4760.166970780099;4814.927776083362;4816.975915120402;5234.607404444682;5277.9472205278225;5285.788568457296;5287.286216360742;5287.947120528823;4840.177169881129;4902.3872015998;5034.597232221414;5037.370328708911;5039.874003149951;5046.949530504648;5106.234064890222;5135.12702840518;5146.897062058738;5152.201408781645;5050.393952725696;5052.520010598987;5060;5060.746962651926;5105.540501354896;4786.617070634341;4934.432540257844;4994.1509943309;5052.7726252318735;5053.797848086109;4329.956700432956;4343.457067866517;4349.28236840924;4377.037051848588;4393.736375817397;3752.568454627698;3765.9246815063543;3770.6040865709256;3795.411711184771;3811.809409529568;4192.643625291885;4225.598568136023;4230.809613567397;4261.0838669685545;4361.0841723237845;4981.4769449207315;4987.102321582078;5000.3249561309485;5004.599632029429;5024.2463630454995;4281.614654681093;4282.89292767677;4292.678049146327;4323.805428755713;4324.048709283952;4427.158839820424;4464.843730469418;4493.887652808706;4495.415595972568;4499;4696.624270058319;4699.483056863811;4699.530046995274;4700;4748.501407352178;5001.024800164078;5002.174641184164;5004.024215278131;5010.148274793221;5062.797488100582;4633.536646335474;4680.204365257846;4684.92972605418;4696.0607878425135;4752.239641657318;4910.189818679878;4925.753712314298;4926.4088309403105;4931.876703082452;4976.701397916137;4959.975200123977;4963.851084467327;4965.677230979974;4972.254161875748;5019.598432125495;4784.162771514902;4812.759362031815;4878.585320247818;4896.167651499325;4921.13880070979;4863.10032643962;4863.392075990501;4884.853454396374;4898.461169271306;4941.65408421407;4722.716637001791;4826.8793280168275;4837.685550439211;4848.369711937426;4896.338994235733;4856.660033797601;4903.26451032348;4920.630952678492;4930.433000204879;4942.1598328285;4800.639952003684;4827.686200396963;4830.492798256132;4837.661363704507;4867.610591152628 03:31:45 INFO - PROCESS | 8994 | |1;ext.html;566.0433866765167;573.905305624572;597.9402059794024;597.9940200597993;600.3216365506979;26778.19665410036;29364.999999999975;29463.410731785352;29478.410431791406;39449.80275098621;38228.61771382285;41968.790156049254;42007.15985680284;42050.57949420505;42071.78964105183;7824;7983.520988740665;7984.920150798475;7986.081600615946;7988.760337189865;7501.24987501251;7892.526448413085;7995.840083198333;9984.90015099847;10276.02377774114;10242.129418999393;10290.845637315446;10313.89686103137;10315.329503582281;10316.329438586468;10250;10309.072183503446;10338.689839304832;10358.01598848112;10380.169586433067;7421.851562968711;9881.357711748713;10221.284510084297;10233.539490722935;10599.364038157659;38804.22391552181;39041.41437878434;39093.80453097716;39203.215935681124;39298;3108.704673056056;3356.932861342784;3503.2643144939593;3668.2663467306647;3765.491658626105;29502.70497295021;29620.40759184804;29718.851405743048;30065.849670751726;30647.54028689549;3492.441209406483;3495.7028652564563;3513.1217195701074;3526.2594855080465;3597.964020359789;262308;263003.68498157576;263070;263347;263368;31956.520652190236;52471.475285246655;52830.471695282555;52998.73500632472;53005.46994530082;32439.675603244137;34218.144546386044;34404.13989650229;34457.31085378329;34491;12737.617871463872;12908.225506469455;12923.483060677656;12924;12926.095173337964;9642.71071867845;11132.387718675389;11231.775364492665;11240.213185076966;11249.493772780244;7662.4253181011645;7943.364530837519;7947.3642108631175;8066.072401673765;8159.184081591912;3149.637791653989;3209.951850722241;3215.935681286408;3220.259340351732;3225.419424503612;881.8721285413579;954.9856752148723;966.9758256043515;992.4888682328607;1036.036486067964;28338.71661283402;28706.856465717538;28854.567181492293;28926.710732892403;29139.708602914125;960.9231261499064;995.9502024898726;1005.8440941654055;1010.1816729886175;1047.4972013433594;14301;14551.41794328215;14667.633309167357;14867.553973380816;14947.252637368088;407422;411472;412686;412875;412922;48138.5186148134;48400;48420.27369589459;48492.27261591079;48558.75720621374;1078.229066217658;1183.4851839449866;1211.1461419699092;1225.154643296123;1238.4179435665224;27937.580936285565;29042.564361535016;29059.273518162216;29071.273218169714;29714.851425742734;40671.59328406678;41310.38034429426;41312.38031429591;41322.173556529306;41326.586734132274;326429;335244;336937;337158;337935;21843.235486757887;24189.75810241875;24562.140325088538;25074.122405715712;26612.201633951012;40610.59389406068;40843.795781020905;40943.590564093975;41485;41862.16275674409;34560;34945.65054349424;35377.64622353847;35915.46126808048;36088.63911360958;35421.82289088641;35505.64494355127;35585.64414355927;35843.46234806428;36021.27957440889;34581.654183457846;35367.46948795718;35465.290694186486;35492.46761298531;35560.28879422345;30278.84860575683;31840.840795795873;31867.840660796548;32134.678653214105;32287.35425291528;24299.63550546708;24479.38801529976;24628.261152165465;24946.62580061264;25277.494450111262 03:31:45 INFO - PROCESS | 8994 | |2;jquery.html;353.05733691044907;353.8372348719589;360.28483460331245;368.2653107051433;374.3860069486042;13462.259575723343;16568.91715541422;17064.317427302925;18495.167717452714;18507.907460462713;17557.12214389282;17824.554386140353;18266.543336416562;18297.908510457462;18307.72538411925;4388.210122178015;4622.0293738314995;4626.259798432252;4702.24764037754;4707.717536947777;3442.5868895732424;3572.2319701264223;3575.8927232182946;3685.262947410515;4613.146567884952;6002.099685047234;6129.387061293857;6147.200863887689;6151.477124444427;6152.354002829706;5505.3393592768725;5535.308086489189;6025.186599809013;6085.513158947274;6119.296280927706;3408.2842603053386;5083.949160508421;5350.063738845725;5374.381946076212;5383.353997520284;12012.399380030964;12226.327551984637;12309.753804923941;12381.814272785916;12427.75144497105;1921.6541022615922;1969.7439332886634;1988.443235893952;2031.0299009960315;2211.6019116559014;9301.02339254382;9320.114589114024;9368.156865882103;9456.763580910463;9493.952530237373;1560.1185330288351;1625.8536731694205;1635.6646887388056;1647.6787026529832;1684.2589260725242;70500.29499704989;71750.92373614348;71753;72629.27370726278;73044;8877.778055548662;9454.919917618114;9515.762105947406;9779.804403911881;10226.954609078213;13023.47906083765;13859;13876.375563099684;14315.141091534333;14413.927930360282;7209.819754506075;7537.849243015109;7550.131734850453;7646.4265180111715;7660.655270512841;7136.286371362822;7168.741846318393;7227.457940654472;7284.125904891447;7315.853682926312;4343.956560434355;4391.934120988188;4427.247367947392;4451.065276292015;4497.370368148462;1793.9103044847704;1829.7987221405635;1870.747449094382;1881.3726126900133;1930.7200455934092;840.684743221292;860.7805009722606;862.3316929379781;917.2982668258787;917.7613820406742;16770.413035543697;17378.913105434392;17445.21496532659;17558;17929.641407172043;850.5024560632099;856.7429771068654;857.8155696525153;858.3605214115524;860.1828263150032;9465.148136667733;9879.16027137687;9939.105480506789;9944.602215911282;9953.950230248947;380370;392989;397453;398481;400558;48778.75610621924;73206.26793732101;76118.23881761222;77049;90029.54985225032;878.4685265414332;891.9420237684529;905.9456432614064;912.7124955638952;942.5240253671989;14407.42370305218;14528.346224419714;14583.343749531085;15804.490014140469;16983.235754390837;37751.81124094472;39103.80448097855;39177.41233881437;39410.80294598509;40204;53536;54665;54937.450625493235;55414.72292638511;55830.44169558252;7414.184439711736;7696.961515192388;7844.843103137791;7927.643256053376;7941.761747147595;11218.943905280421;11411;11813.586524471602;11901.523939042341;12086.516539338329;9767.365121267096;9835.901640983784;9894.15899648538;10450.111740502143;10652.786944260917;9848.901510984799;9973.700788976343;10777.89222107769;10784.352938823695;10820.945895270474;10103.49482525856;10305.484725763532;10377.481125943823;10554.841677374692;10757.515911783832;6512.08830763684;6570.47436205112;6873.140857392826;7646.197149299466;7708.344790692854;9438.716838494856;9651.758706032406;9864.5560949756;10006.049425304584;10109.551797209204 03:31:45 INFO - PROCESS | 8994 | |3;mootools.html;1195.7190060335824;1323.907326487146;1378.9933348655481;1388.4862600837685;1704.250129942825;6445.065465507504;7190.56856588605;7413.851722965551;7436.3679087277515;7707.421943354243;7398.815029624262;7520.39836813055;7523.736669216579;7524.661390237438;7543.547387156775;2177.3250292409366;2203.4821816873023;2204.5039866030174;2206.2278202629113;2207.0840601150585;2143.2070134050423;2177.140029688272;2195.802377785999;2200.174934399592;2206.0734491513604;2128.372130221588;2140.3578926322043;2140.636091864387;2145.549434618732;2183.235867446389;2157.492989147549;2161.859479133867;2163.2212403534713;2164.5562659654734;2166.956660866782;2080.147139672742;2113.0596884386455;2118.078635793435;2127.723365980399;2130.3182981445943;7292.416606671453;7506.28690274423;7535.73624923125;7584.203658615821;7634.580098094602;4359.455068116486;4467.865964021084;4478.4178056852725;4480.865574032784;4483.193025255453;2774.4451109778124;2859.4138201668607;2864.7421732044218;2883.596296518489;2907.592936988823;895.9776005599847;905.4657751926329;907.0747837206079;908.4231512989234;920.3557509743207;9941.850872236922;10025.548850301753;10034.598616055422;10049.648262310784;10057.145142662883;3833.559140698855;3951.209758048402;4053.756774593475;4056.776877271778;4104.589541045932;8063.637136328879;8084.514929104273;8098.473599216032;8106.351491880635;8107.1892810718455;4403.295472724349;4403.889902752457;4404.185225733186;4411.823527058946;4419.513853476115;3542.433210686278;3929.528456585228;4065.8780236592947;4067.2678917794487;4092.6930480214105;3248.9278538082376;3328.9167770805925;3377;3388.373150967079;3412.675795799395;1002.7443002034435;1028.0285130551556;1036.1296510930854;1037.4501514197486;1038.7662775875367;791.4183075439547;808.1716240853173;814.0556953933409;824.3899514359331;873.5894129759004;5179.507946745053;5191.402988656278;5204.635675502678;5270.367555893317;5309.548688361455;901.9323550733722;914.8810654614857;942.3168203052869;958.4584709639032;977.5503268496429;3387.9153021174666;3475.6097560975813;3517.66582174693;3591.8204089795404;3681.7238707097076;8988.595513201792;9213.355065145375;9225.400348977295;9283.071692830797;9293.070692930653;9211.355205135711;9250.306227033;9253.398529095588;9257.305702072372;9260.49067301305;7101.041359416516;7221.133463984355;7231.168415632164;7235.529690570096;7243.058402407759;4885.828995985124;4903.803847846046;4934.333864928189;4938.2839488273285;5019.924701129413;8333.166683331618;8580.356473264404;8656.870146947675;8660.220580147818;8783.736487905373;8590.312774978112;8727.258183054511;8793.824123517366;8826.91173088261;8845.55772211374;5629.634073785354;5672.914906276326;6122.571420000735;6198.194234749454;6237.906431403442;6969.895451568129;7232.963835181001;7247;7431.702731890664;7434.962825185839;6550.312217217123;6581.3747693969;6622.8344291393105;6634.635095069624;6718.0594716738715;6538.83652908662;6544.509161812978;6556.704948277244;6557.2131344239;6592.8351791205605;6028.246469191351;6030.276366836008;6067.544934130046;6080.69596520181;6084.847878803065;4319.136172765522;4484.529124441887;4517.548245175456;4537.614302784168;4546.658735672918;4502.4371953505815;4627.398438203012;4628.259478483426;4681.250999840146;4696.084263568571 03:31:45 INFO - PROCESS | 8994 | |4;prototype.html;291.6645857264146;295.5861793489116;297.6591802386266;301.2183384118214;308.04352485532416;4803.447603525596;4861.465238823731;4875.975620121894;4880.926786098212;4898.853034408965;4833.178359678855;4836.733979631119;4857.465678775332;4862.683925544837;4887.1447496688115;3634.418493041114;3735.962640373589;3771.66055055045;3859.3439115350457;3885.9702178922607;3823.885283441501;3845.5963573295685;3860.2665493556133;3863.555691095518;3900.0639846436934;3632.909177270563;3824.368979118442;3837.0982819037504;3840.6927445804267;3845.576986531479;3691.187938653505;3790.3177428062936;3801.5248093988253;3808.3624041662074;3841.6350446707797;3366.8148251846137;3383.780054296463;3406.471996840494;3409.7272218222483;3419.128122328815;4772.451168115676;4793.520647935214;4795.112904112715;4798.688085274481;4800.087983283165;4239.0885959518855;4387.3638322443385;4401.5598440156045;4409.5149533551285;4410.7794610269675;5056.595472362203;5060.645754797166;5065.138926382524;5089.949100508985;5091.719955402451;3726.496922915399;3733.506597361077;3747.288015277116;3752.756070855413;3753.436984452354;5159.406668233164;5217.165253559412;5232.659877107976;5330.253764472977;5333.333333333333;3775.4714339992424;3777.301199278142;3780.9243815123546;3781.9432708509394;3813.3326667833016;3861.9227615447535;3870.554886188068;3871.922561548753;3876.8061596920043;3880.359740642819;4354.085642015212;4356.390105385249;4373.650107991353;4374.103308821684;4382.693211475166;4888.535589119028;4993;4997.850064497999;5017.473165317662;5040.143175660147;1284.8072789081525;1311.4098655605017;1314.7107636320186;1319.8218240537597;1324.198859689893;872.9345299102592;882.188386684252;903.3225081189108;927.9489628070521;936.1527817325332;4421.248387774086;4423.137488189772;4426.712263702849;4433.866983990485;4439.822407103744;5163.044836705221;5167.715775632301;5173.249878767633;5191.974040129775;5207.297014903015;4254.191703576311;4394.1870753910625;4412.558744125562;4421.823127074881;4532.388127602798;2754.504189245915;2763.198672385026;2774.6531683539556;2775.736305051017;2781.5827625855877;4853.611711063177;4882.144784981684;4915.721912302755;4915.926261106087;4936.7910857942625;5144.382674079135;5291.444398338196;5319.468053194727;5416.972915135478;5439.728013599304;4950.455449900508;4955.950440495693;4973.428055773632;4993.525615066563;4999.700017998932;5243.8164664236565;5247.527722504993;5259.868503287448;5262.684238945675;5278.656887302313;4901.975490122527;5172.275881376686;5174.689518628894;5192.454792246911;5195.142671530719;4935.383077115361;4958.776855041604;4962.255661650781;4997.900041999067;4999.725015124203;3747.344214762351;3764.5482542095124;3764.7176461766026;3769.6230376962085;3772.75477093988;5077.759413767674;5175.378954525481;5206.427292997843;5246.475352464723;5277.498637629419;5060.266261392151;5064.3909697844665;5074.8581569146645;5087.949120508748;5096.821611243588;5099.643024988215;5101.744912754273;5107.642465027412;5130.12787826078;5134.76893539799;4770.688060783174;4786.186348320724;5018.623603229699;5037.647364684583;5053.772580233972;4945.357103576512;5108.3103780989095;5110.3356563646485;5110.948890511196;5112.616553758408;4980.302757613865;4991.126552853309;4992.925106123338;5010.672171874383;5011 03:31:45 INFO - PROCESS | 8994 | |5;yui.html;664.1731044849163;669.4577392312226;725.538040847692;747.3236720767703;772.0812233442207;14675.119492830425;15450.304736286866;15469.84530154698;15477.148756818398;15482.38070477181;14160.00879938402;14584.781228281585;14691;14750.63123421915;14894.106353618763;767.7965339185121;793.2939683681499;793.8729803231485;794.8012996750813;796.2753893956501;780.8087018680432;786.429838367185;789.0964845252183;789.3527307607764;789.4000559574736;825.859603867344;826.6114925984807;827.1893544326533;828.4739190613943;828.5153185386556;821.8479581277483;822.6421506644629;823.3454403749034;829.5022986208257;829.7759604906702;600.627610881252;601.9789307374265;602.6986506746626;603.0411645483658;603.1796756411277;13110.803337949937;13143.474261029547;13167.802482962763;13176.53882114131;13180.604581862559;13255.867441325656;13372.197668139943;13401.932990335083;13509.932450337783;13516.797248041286;10885.292455990335;10978.396188209645;11003.889961100447;11081.390523521202;11103.38931358775;3299.1257316811066;3343.36476069546;3353.3796247694254;3361.680640339164;3376.7129793967542;42953;44864;61545.38454615486;62613.68693156505;63668.36331636717;10395.428251446243;10518.263721539419;10584.523696433678;10614.89385106139;10649.90476948261;17214.569635759206;17751.911240443715;17760.91119544394;18856.528586785167;18899.52751181204;7110.786676399716;7230.891536626955;7319.194888562254;7338.816529586697;7409.258074832112;3861.420786881934;3927.9018024549046;3985.242803867314;3999.960000400017;4003.939940900889;2831.815931964457;2939.2504911247497;2939.6913324101088;2941.9411611767646;2945.558166275076;515.7756375976462;519.7541354242703;525.1780962793216;525.2620068803337;525.5559052600546;504.71483611759237;507.9695218286915;572.9197912292199;607.4957785038407;656.7569999100364;8522.70170544028;8526.232639062515;8569.228769410784;8574.957125214334;8783.297336213216;568.647438588078;592.5940730599553;637.2225884420999;637.8532937424326;656.9816783984804;4125.876223713293;4222.408862759216;4223.239816832938;4229.090745489734;4236.195122926696;63348.68325658342;88696.556517217;93978;94308.52845735727;94870;45739.54260457419;50373;72369.6381518089;72395.27604723991;85349.57325213334;45162.32256516155;61648;70901.64549177325;73186.63406682933;75860.24139758642;8807.779805504657;9036.864447033167;9042.367034307536;9069.093090690878;9237.353385262966;36951.63048369482;37189;37787.05532361713;42245.788771055944;43261;38305.6169438302;38368;38982.6101738979;45179;60196.69901650639;11198.328100314007;11240.88759112431;11330.886691132982;12004.639860804189;12205.69485762863;12982.805257921327;13122.081454298108;13211.933940330622;13404;13804.861951380759;12699.301538415475;12788.616341509769;12853.614391568268;13120.803187951997;13484.528041518499;12284.262944223376;12588.370581471074;12668.556600518938;12995.740085198055;13136;11152.888471115184;11177;11359.716007099558;11584.42077896085;12265.38673066361;9382.765430864283;9711.951440243036;9865.950670246602;9866.112049915255;9877.209823214269;9084.091590840862;9982.450965196984;10045.196384289386;10137.797244055226;10139.949300253451 03:31:45 INFO - PROCESS | 8994 | __end_tp_report 03:31:45 INFO - PROCESS | 8994 | __start_cc_report 03:31:45 INFO - PROCESS | 8994 | _x_x_mozilla_cycle_collect,970 03:31:45 INFO - PROCESS | 8994 | __end_cc_report 03:31:45 INFO - PROCESS | 8994 | __startTimestamp1468319505954__endTimestamp 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | ------- Summary: start ------- 03:31:45 INFO - PROCESS | 8994 | Number of tests: 6 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | [#0] dojo.html Cycles:165 Average:4649.00 Median:4760.17 stddev:492.58 (10.3%) stddev-sans-first:466.57 03:31:45 INFO - PROCESS | 8994 | Values: 2579.3 2608.4 2610.2 2612.4 2649.0 4617.3 4654.8 4719.7 4736.3 4795.4 4594.1 4645.0 4671.5 4684.0 4715.8 4251.6 4253.4 4327.2 4349.5 4356.0 4393.7 4442.8 4446.9 4472.3 4481.4 4136.0 4185.6 4195.8 4294.8 4373.8 4310.3 4351.0 4351.7 4351.7 4352.9 4320.5 4322.1 4323.2 4325.0 4326.5 4578.5 4632.4 4638.2 4641.0 4706.1 5025.5 5033.9 5105.6 5107.8 5110.9 4920.8 5125.6 5128.6 5136.3 5138.0 4708.0 4738.6 4760.2 4814.9 4817.0 5234.6 5277.9 5285.8 5287.3 5287.9 4840.2 4902.4 5034.6 5037.4 5039.9 5046.9 5106.2 5135.1 5146.9 5152.2 5050.4 5052.5 5060.0 5060.7 5105.5 4786.6 4934.4 4994.2 5052.8 5053.8 4330.0 4343.5 4349.3 4377.0 4393.7 3752.6 3765.9 3770.6 3795.4 3811.8 4192.6 4225.6 4230.8 4261.1 4361.1 4981.5 4987.1 5000.3 5004.6 5024.2 4281.6 4282.9 4292.7 4323.8 4324.0 4427.2 4464.8 4493.9 4495.4 4499.0 4696.6 4699.5 4699.5 4700.0 4748.5 5001.0 5002.2 5004.0 5010.1 5062.8 4633.5 4680.2 4684.9 4696.1 4752.2 4910.2 4925.8 4926.4 4931.9 4976.7 4960.0 4963.9 4965.7 4972.3 5019.6 4784.2 4812.8 4878.6 4896.2 4921.1 4863.1 4863.4 4884.9 4898.5 4941.7 4722.7 4826.9 4837.7 4848.4 4896.3 4856.7 4903.3 4920.6 4930.4 4942.2 4800.6 4827.7 4830.5 4837.7 4867.6 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | [#1] ext.html Cycles:180 Average:47669.70 Median:34311.14 stddev:90296.40 (263.2%) stddev-sans-first:90480.44 03:31:45 INFO - PROCESS | 8994 | Values: 566.0 573.9 597.9 598.0 600.3 26778.2 29365.0 29463.4 29478.4 39449.8 38228.6 41968.8 42007.2 42050.6 42071.8 7824.0 7983.5 7984.9 7986.1 7988.8 7501.2 7892.5 7995.8 9984.9 10276.0 10242.1 10290.8 10313.9 10315.3 10316.3 10250.0 10309.1 10338.7 10358.0 10380.2 7421.9 9881.4 10221.3 10233.5 10599.4 38804.2 39041.4 39093.8 39203.2 39298.0 3108.7 3356.9 3503.3 3668.3 3765.5 29502.7 29620.4 29718.9 30065.8 30647.5 3492.4 3495.7 3513.1 3526.3 3598.0 262308.0 263003.7 263070.0 263347.0 263368.0 31956.5 52471.5 52830.5 52998.7 53005.5 32439.7 34218.1 34404.1 34457.3 34491.0 12737.6 12908.2 12923.5 12924.0 12926.1 9642.7 11132.4 11231.8 11240.2 11249.5 7662.4 7943.4 7947.4 8066.1 8159.2 3149.6 3210.0 3215.9 3220.3 3225.4 881.9 955.0 967.0 992.5 1036.0 28338.7 28706.9 28854.6 28926.7 29139.7 960.9 996.0 1005.8 1010.2 1047.5 14301.0 14551.4 14667.6 14867.6 14947.3 407422.0 411472.0 412686.0 412875.0 412922.0 48138.5 48400.0 48420.3 48492.3 48558.8 1078.2 1183.5 1211.1 1225.2 1238.4 27937.6 29042.6 29059.3 29071.3 29714.9 40671.6 41310.4 41312.4 41322.2 41326.6 326429.0 335244.0 336937.0 337158.0 337935.0 21843.2 24189.8 24562.1 25074.1 26612.2 40610.6 40843.8 40943.6 41485.0 41862.2 34560.0 34945.7 35377.6 35915.5 36088.6 35421.8 35505.6 35585.6 35843.5 36021.3 34581.7 35367.5 35465.3 35492.5 35560.3 30278.8 31840.8 31867.8 32134.7 32287.4 24299.6 24479.4 24628.3 24946.6 25277.5 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | [#2] jquery.html Cycles:180 Average:24326.07 Median:4624.14 stddev:65139.16 (1408.7%) stddev-sans-first:65297.02 03:31:45 INFO - PROCESS | 8994 | Values: 353.1 353.8 360.3 368.3 374.4 13462.3 16568.9 17064.3 18495.2 18507.9 17557.1 17824.6 18266.5 18297.9 18307.7 4388.2 4622.0 4626.3 4702.2 4707.7 3442.6 3572.2 3575.9 3685.3 4613.1 6002.1 6129.4 6147.2 6151.5 6152.4 5505.3 5535.3 6025.2 6085.5 6119.3 3408.3 5083.9 5350.1 5374.4 5383.4 12012.4 12226.3 12309.8 12381.8 12427.8 1921.7 1969.7 1988.4 2031.0 2211.6 9301.0 9320.1 9368.2 9456.8 9494.0 1560.1 1625.9 1635.7 1647.7 1684.3 70500.3 71750.9 71753.0 72629.3 73044.0 8877.8 9454.9 9515.8 9779.8 10227.0 13023.5 13859.0 13876.4 14315.1 14413.9 7209.8 7537.8 7550.1 7646.4 7660.7 7136.3 7168.7 7227.5 7284.1 7315.9 4344.0 4391.9 4427.2 4451.1 4497.4 1793.9 1829.8 1870.7 1881.4 1930.7 840.7 860.8 862.3 917.3 917.8 16770.4 17378.9 17445.2 17558.0 17929.6 850.5 856.7 857.8 858.4 860.2 9465.1 9879.2 9939.1 9944.6 9954.0 380370.0 392989.0 397453.0 398481.0 400558.0 48778.8 73206.3 76118.2 77049.0 90029.5 878.5 891.9 905.9 912.7 942.5 14407.4 14528.3 14583.3 15804.5 16983.2 37751.8 39103.8 39177.4 39410.8 40204.0 53536.0 54665.0 54937.5 55414.7 55830.4 7414.2 7697.0 7844.8 7927.6 7941.8 11218.9 11411.0 11813.6 11901.5 12086.5 9767.4 9835.9 9894.2 10450.1 10652.8 9848.9 9973.7 10777.9 10784.4 10820.9 10103.5 10305.5 10377.5 10554.8 10757.5 6512.1 6570.5 6873.1 7646.2 7708.3 9438.7 9651.8 9864.6 10006.0 10109.6 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | [#3] mootools.html Cycles:180 Average:4932.61 Median:5198.02 stddev:2720.56 (52.3%) stddev-sans-first:2713.70 03:31:45 INFO - PROCESS | 8994 | Values: 1195.7 1323.9 1379.0 1388.5 1704.3 6445.1 7190.6 7413.9 7436.4 7707.4 7398.8 7520.4 7523.7 7524.7 7543.5 2177.3 2203.5 2204.5 2206.2 2207.1 2143.2 2177.1 2195.8 2200.2 2206.1 2128.4 2140.4 2140.6 2145.5 2183.2 2157.5 2161.9 2163.2 2164.6 2167.0 2080.1 2113.1 2118.1 2127.7 2130.3 7292.4 7506.3 7535.7 7584.2 7634.6 4359.5 4467.9 4478.4 4480.9 4483.2 2774.4 2859.4 2864.7 2883.6 2907.6 896.0 905.5 907.1 908.4 920.4 9941.9 10025.5 10034.6 10049.6 10057.1 3833.6 3951.2 4053.8 4056.8 4104.6 8063.6 8084.5 8098.5 8106.4 8107.2 4403.3 4403.9 4404.2 4411.8 4419.5 3542.4 3929.5 4065.9 4067.3 4092.7 3248.9 3328.9 3377.0 3388.4 3412.7 1002.7 1028.0 1036.1 1037.5 1038.8 791.4 808.2 814.1 824.4 873.6 5179.5 5191.4 5204.6 5270.4 5309.5 901.9 914.9 942.3 958.5 977.6 3387.9 3475.6 3517.7 3591.8 3681.7 8988.6 9213.4 9225.4 9283.1 9293.1 9211.4 9250.3 9253.4 9257.3 9260.5 7101.0 7221.1 7231.2 7235.5 7243.1 4885.8 4903.8 4934.3 4938.3 5019.9 8333.2 8580.4 8656.9 8660.2 8783.7 8590.3 8727.3 8793.8 8826.9 8845.6 5629.6 5672.9 6122.6 6198.2 6237.9 6969.9 7233.0 7247.0 7431.7 7435.0 6550.3 6581.4 6622.8 6634.6 6718.1 6538.8 6544.5 6556.7 6557.2 6592.8 6028.2 6030.3 6067.5 6080.7 6084.8 4319.1 4484.5 4517.5 4537.6 4546.7 4502.4 4627.4 4628.3 4681.3 4696.1 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | [#4] prototype.html Cycles:180 Average:4238.69 Median:4855.54 stddev:1213.95 (25.0%) stddev-sans-first:1180.65 03:31:45 INFO - PROCESS | 8994 | Values: 291.7 295.6 297.7 301.2 308.0 4803.4 4861.5 4876.0 4880.9 4898.9 4833.2 4836.7 4857.5 4862.7 4887.1 3634.4 3736.0 3771.7 3859.3 3886.0 3823.9 3845.6 3860.3 3863.6 3900.1 3632.9 3824.4 3837.1 3840.7 3845.6 3691.2 3790.3 3801.5 3808.4 3841.6 3366.8 3383.8 3406.5 3409.7 3419.1 4772.5 4793.5 4795.1 4798.7 4800.1 4239.1 4387.4 4401.6 4409.5 4410.8 5056.6 5060.6 5065.1 5089.9 5091.7 3726.5 3733.5 3747.3 3752.8 3753.4 5159.4 5217.2 5232.7 5330.3 5333.3 3775.5 3777.3 3780.9 3781.9 3813.3 3861.9 3870.6 3871.9 3876.8 3880.4 4354.1 4356.4 4373.7 4374.1 4382.7 4888.5 4993.0 4997.9 5017.5 5040.1 1284.8 1311.4 1314.7 1319.8 1324.2 872.9 882.2 903.3 927.9 936.2 4421.2 4423.1 4426.7 4433.9 4439.8 5163.0 5167.7 5173.2 5192.0 5207.3 4254.2 4394.2 4412.6 4421.8 4532.4 2754.5 2763.2 2774.7 2775.7 2781.6 4853.6 4882.1 4915.7 4915.9 4936.8 5144.4 5291.4 5319.5 5417.0 5439.7 4950.5 4956.0 4973.4 4993.5 4999.7 5243.8 5247.5 5259.9 5262.7 5278.7 4902.0 5172.3 5174.7 5192.5 5195.1 4935.4 4958.8 4962.3 4997.9 4999.7 3747.3 3764.5 3764.7 3769.6 3772.8 5077.8 5175.4 5206.4 5246.5 5277.5 5060.3 5064.4 5074.9 5087.9 5096.8 5099.6 5101.7 5107.6 5130.1 5134.8 4770.7 4786.2 5018.6 5037.6 5053.8 4945.4 5108.3 5110.3 5110.9 5112.6 4980.3 4991.1 4992.9 5010.7 5011.0 03:31:45 INFO - PROCESS | 8994 | 03:31:45 INFO - PROCESS | 8994 | [#5] yui.html Cycles:180 Average:16110.24 Median:43107.00 stddev:21509.51 (49.9%) stddev-sans-first:21538.58 03:31:45 INFO - PROCESS | 8994 | Values: 664.2 669.5 725.5 747.3 772.1 14675.1 15450.3 15469.8 15477.1 15482.4 14160.0 14584.8 14691.0 14750.6 14894.1 767.8 793.3 793.9 794.8 796.3 780.8 786.4 789.1 789.4 789.4 825.9 826.6 827.2 828.5 828.5 821.8 822.6 823.3 829.5 829.8 600.6 602.0 602.7 603.0 603.2 13110.8 13143.5 13167.8 13176.5 13180.6 13255.9 13372.2 13401.9 13509.9 13516.8 10885.3 10978.4 11003.9 11081.4 11103.4 3299.1 3343.4 3353.4 3361.7 3376.7 42953.0 44864.0 61545.4 62613.7 63668.4 10395.4 10518.3 10584.5 10614.9 10649.9 17214.6 17751.9 17760.9 18856.5 18899.5 7110.8 7230.9 7319.2 7338.8 7409.3 3861.4 3927.9 3985.2 4000.0 4003.9 2831.8 2939.3 2939.7 2941.9 2945.6 515.8 519.8 525.2 525.3 525.6 504.7 508.0 572.9 607.5 656.8 8522.7 8526.2 8569.2 8575.0 8783.3 568.6 592.6 637.2 637.9 657.0 4125.9 4222.4 4223.2 4229.1 4236.2 63348.7 88696.6 93978.0 94308.5 94870.0 45739.5 50373.0 72369.6 72395.3 85349.6 45162.3 61648.0 70901.6 73186.6 75860.2 8807.8 9036.9 9042.4 9069.1 9237.4 36951.6 37189.0 37787.1 42245.8 43261.0 38305.6 38368.0 38982.6 45179.0 60196.7 11198.3 11240.9 11330.9 12004.6 12205.7 12982.8 13122.1 13211.9 13404.0 13804.9 12699.3 12788.6 12853.6 13120.8 13484.5 12284.3 12588.4 12668.6 12995.7 13136.0 11152.9 11177.0 11359.7 11584.4 12265.4 9382.8 9712.0 9866.0 9866.1 9877.2 9084.1 9982.5 10045.2 10137.8 10139.9 03:31:45 INFO - PROCESS | 8994 | -------- Summary: end -------- 03:31:45 INFO - PROCESS | 8994 | 03:31:46 INFO - TEST-INFO | 8994: exit 0 03:31:46 INFO - TEST-OK | dromaeo_css | took 1121238ms 03:31:46 INFO - TEST-START | kraken 03:31:46 INFO - operating with platform_type : linux_ 03:31:46 INFO - Initialising browser for kraken test... 03:31:46 INFO - TEST-INFO | started process 9187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNxjEK/profile http://localhost:46436/getInfo.html) 03:31:51 INFO - PROCESS | 9187 | __metrics Screen width/height:1600/1200 03:31:51 INFO - PROCESS | 9187 | colorDepth:24 03:31:51 INFO - PROCESS | 9187 | Browser inner width/height: 1024/697 03:31:51 INFO - PROCESS | 9187 | __metrics 03:31:52 INFO - PROCESS | 9187 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:31:52 INFO - PROCESS | 9187 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:53 INFO - TEST-INFO | 9187: exit 0 03:31:53 INFO - Browser initialized. 03:31:53 INFO - Running cycle 1/1 for kraken test... 03:31:53 INFO - TEST-INFO | started process 9269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNxjEK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:05 INFO - PROCESS | 9269 | RSS: Main: 159416320 03:32:05 INFO - PROCESS | 9269 | 03:32:08 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46436/tests/kraken/driver.html?testName=audio-beat-detection) 03:32:09 INFO - PROCESS | 9269 | RSS: Main: 217640960 03:32:09 INFO - PROCESS | 9269 | 03:32:12 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46436/tests/kraken/driver.html?testName=audio-dft) 03:32:12 INFO - PROCESS | 9269 | RSS: Main: 204673024 03:32:12 INFO - PROCESS | 9269 | 03:32:16 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46436/tests/kraken/driver.html?testName=audio-fft) 03:32:16 INFO - PROCESS | 9269 | RSS: Main: 271683584 03:32:16 INFO - PROCESS | 9269 | 03:32:18 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46436/tests/kraken/driver.html?testName=audio-oscillator) 03:32:19 INFO - PROCESS | 9269 | RSS: Main: 182018048 03:32:19 INFO - PROCESS | 9269 | 03:32:21 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:32:22 INFO - PROCESS | 9269 | RSS: Main: 186925056 03:32:22 INFO - PROCESS | 9269 | 03:32:25 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46436/tests/kraken/driver.html?testName=imaging-darkroom) 03:32:26 INFO - PROCESS | 9269 | RSS: Main: 222343168 03:32:26 INFO - PROCESS | 9269 | 03:32:29 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46436/tests/kraken/driver.html?testName=imaging-desaturate) 03:32:30 INFO - PROCESS | 9269 | RSS: Main: 218202112 03:32:30 INFO - PROCESS | 9269 | 03:32:33 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46436/tests/kraken/driver.html?testName=json-parse-financial) 03:32:33 INFO - PROCESS | 9269 | RSS: Main: 220913664 03:32:33 INFO - PROCESS | 9269 | 03:32:35 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:32:36 INFO - PROCESS | 9269 | RSS: Main: 207953920 03:32:36 INFO - PROCESS | 9269 | 03:32:37 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:32:38 INFO - PROCESS | 9269 | RSS: Main: 212377600 03:32:38 INFO - PROCESS | 9269 | 03:32:40 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:32:41 INFO - PROCESS | 9269 | RSS: Main: 215707648 03:32:41 INFO - PROCESS | 9269 | 03:32:44 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:32:44 INFO - PROCESS | 9269 | RSS: Main: 226357248 03:32:44 INFO - PROCESS | 9269 | 03:32:47 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:32:48 INFO - PROCESS | 9269 | RSS: Main: 226086912 03:32:48 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46436/tests/kraken/driver.html?testName=ai-astar) 03:32:50 INFO - PROCESS | 9269 | RSS: Main: 268697600 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | __start_tp_report 03:32:50 INFO - PROCESS | 9269 | _x_x_mozilla_page_load 03:32:50 INFO - PROCESS | 9269 | _x_x_mozilla_page_load_details 03:32:50 INFO - PROCESS | 9269 | |i|pagename|runs| 03:32:50 INFO - PROCESS | 9269 | |0;ai-astar;105;116;113;115;116;113;113;115;113;114 03:32:50 INFO - PROCESS | 9269 | |1;audio-beat-detection;153;123;128;168;122;124;147;121;155;124 03:32:50 INFO - PROCESS | 9269 | |2;audio-dft;161;162;160;161;163;162;162;162;162;161 03:32:50 INFO - PROCESS | 9269 | |3;audio-fft;76;76;76;128;76;76;76;76;97;75 03:32:50 INFO - PROCESS | 9269 | |4;audio-oscillator;84;86;117;85;85;84;127;84;84;117 03:32:50 INFO - PROCESS | 9269 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 03:32:50 INFO - PROCESS | 9269 | |6;imaging-darkroom;146;147;147;146;146;146;146;146;146;146 03:32:50 INFO - PROCESS | 9269 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;94;95 03:32:50 INFO - PROCESS | 9269 | |8;json-parse-financial;64;65;64;63;64;64;63;64;63;65 03:32:50 INFO - PROCESS | 9269 | |9;json-stringify-tinderbox;65;64;64;64;65;65;64;65;64;65 03:32:50 INFO - PROCESS | 9269 | |10;stanford-crypto-aes;78;79;89;87;85;86;85;84;85;78 03:32:50 INFO - PROCESS | 9269 | |11;stanford-crypto-ccm;130;132;133;138;128;129;135;132;163;132 03:32:50 INFO - PROCESS | 9269 | |12;stanford-crypto-pbkdf2;171;164;164;168;166;164;166;166;165;167 03:32:50 INFO - PROCESS | 9269 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;67;67;66;66;68 03:32:50 INFO - PROCESS | 9269 | __end_tp_report 03:32:50 INFO - PROCESS | 9269 | __start_cc_report 03:32:50 INFO - PROCESS | 9269 | _x_x_mozilla_cycle_collect,1917 03:32:50 INFO - PROCESS | 9269 | __end_cc_report 03:32:50 INFO - PROCESS | 9269 | __startTimestamp1468319570271__endTimestamp 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | ------- Summary: start ------- 03:32:50 INFO - PROCESS | 9269 | Number of tests: 14 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.50 stddev:3.16 (2.8%) stddev-sans-first:1.30 03:32:50 INFO - PROCESS | 9269 | Values: 105.0 116.0 113.0 115.0 116.0 113.0 113.0 115.0 113.0 114.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:137.50 stddev:17.43 (12.7%) stddev-sans-first:17.44 03:32:50 INFO - PROCESS | 9269 | Values: 153.0 123.0 128.0 168.0 122.0 124.0 147.0 121.0 155.0 124.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 03:32:50 INFO - PROCESS | 9269 | Values: 161.0 162.0 160.0 161.0 163.0 162.0 162.0 162.0 162.0 161.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:17.09 (22.5%) stddev-sans-first:17.92 03:32:50 INFO - PROCESS | 9269 | Values: 76.0 76.0 76.0 128.0 76.0 76.0 76.0 76.0 97.0 75.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:17.50 (20.8%) stddev-sans-first:18.08 03:32:50 INFO - PROCESS | 9269 | Values: 84.0 86.0 117.0 85.0 85.0 84.0 127.0 84.0 84.0 117.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:32:50 INFO - PROCESS | 9269 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:32:50 INFO - PROCESS | 9269 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:32:50 INFO - PROCESS | 9269 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 03:32:50 INFO - PROCESS | 9269 | Values: 64.0 65.0 64.0 63.0 64.0 64.0 63.0 64.0 63.0 65.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 03:32:50 INFO - PROCESS | 9269 | Values: 65.0 64.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 65.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:85.00 stddev:3.89 (4.6%) stddev-sans-first:3.56 03:32:50 INFO - PROCESS | 9269 | Values: 78.0 79.0 89.0 87.0 85.0 86.0 85.0 84.0 85.0 78.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:132.50 stddev:10.18 (7.7%) stddev-sans-first:10.63 03:32:50 INFO - PROCESS | 9269 | Values: 130.0 132.0 133.0 138.0 128.0 129.0 135.0 132.0 163.0 132.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.00 stddev:2.18 (1.3%) stddev-sans-first:1.42 03:32:50 INFO - PROCESS | 9269 | Values: 171.0 164.0 164.0 168.0 166.0 164.0 166.0 166.0 165.0 167.0 03:32:50 INFO - PROCESS | 9269 | 03:32:50 INFO - PROCESS | 9269 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:32:50 INFO - PROCESS | 9269 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 67.0 66.0 66.0 68.0 03:32:50 INFO - PROCESS | 9269 | -------- Summary: end -------- 03:32:50 INFO - PROCESS | 9269 | 03:32:51 INFO - TEST-INFO | 9269: exit 0 03:32:51 INFO - TEST-OK | kraken | took 64969ms 03:32:51 INFO - SUITE-END | took 1186s 03:32:51 INFO - Completed test suite (00:19:46) 03:32:51 INFO - javascript benchmark 03:32:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.264909500793, 2608.3609515668663, 2610.1777939948915, 2612.3991481959147, 2648.9602655960166, 4617.307403889418, 4654.790534425951, 4719.740414277213, 4736.313234580988, 4795.448523419804, 4594.127115847995, 4644.953550464495, 4671.4627817800965, 4684.016356565117, 4715.834945776898, 4251.638610718092, 4253.425787518692, 4327.156204540116, 4349.521552629209, 4355.978220108895, 4393.692441529094, 4442.844500442485, 4446.888827779299, 4472.262076757331, 4481.372607834889, 4136.0, 4185.602367775056, 4195.832166713328, 4294.806733696991, 4373.825046998117, 4310.31035034393, 4350.978245108786, 4351.6953813233085, 4351.717138385995, 4352.89117772055, 4320.524742278347, 4322.113966636832, 4323.2218200723855, 4325.048489332374, 4326.545712700153, 4578.473475550321, 4632.374629425019, 4638.1883170445035, 4640.976795116037, 4706.058788242365, 5025.472325405816, 5033.899322013539, 5105.591552675777, 5107.846764597031, 5110.923336149961, 4920.827771027997, 5125.615578831603, 5128.615353848476, 5136.255242989783, 5138.023775482684, 4708.0, 4738.620910327166, 4760.166970780099, 4814.927776083362, 4816.975915120402, 5234.607404444682, 5277.9472205278225, 5285.788568457296, 5287.286216360742, 5287.947120528823, 4840.177169881129, 4902.3872015998, 5034.597232221414, 5037.370328708911, 5039.874003149951, 5046.949530504648, 5106.234064890222, 5135.12702840518, 5146.897062058738, 5152.201408781645, 5050.393952725696, 5052.520010598987, 5060.0, 5060.746962651926, 5105.540501354896, 4786.617070634341, 4934.432540257844, 4994.1509943309, 5052.7726252318735, 5053.797848086109, 4329.956700432956, 4343.457067866517, 4349.28236840924, 4377.037051848588, 4393.736375817397, 3752.568454627698, 3765.9246815063543, 3770.6040865709256, 3795.411711184771, 3811.809409529568, 4192.643625291885, 4225.598568136023, 4230.809613567397, 4261.0838669685545, 4361.0841723237845, 4981.4769449207315, 4987.102321582078, 5000.3249561309485, 5004.599632029429, 5024.2463630454995, 4281.614654681093, 4282.89292767677, 4292.678049146327, 4323.805428755713, 4324.048709283952, 4427.158839820424, 4464.843730469418, 4493.887652808706, 4495.415595972568, 4499.0, 4696.624270058319, 4699.483056863811, 4699.530046995274, 4700.0, 4748.501407352178, 5001.024800164078, 5002.174641184164, 5004.024215278131, 5010.148274793221, 5062.797488100582, 4633.536646335474, 4680.204365257846, 4684.92972605418, 4696.0607878425135, 4752.239641657318, 4910.189818679878, 4925.753712314298, 4926.4088309403105, 4931.876703082452, 4976.701397916137, 4959.975200123977, 4963.851084467327, 4965.677230979974, 4972.254161875748, 5019.598432125495, 4784.162771514902, 4812.759362031815, 4878.585320247818, 4896.167651499325, 4921.13880070979, 4863.10032643962, 4863.392075990501, 4884.853454396374, 4898.461169271306, 4941.65408421407, 4722.716637001791, 4826.8793280168275, 4837.685550439211, 4848.369711937426, 4896.338994235733, 4856.660033797601, 4903.26451032348, 4920.630952678492, 4930.433000204879, 4942.1598328285, 4800.639952003684, 4827.686200396963, 4830.492798256132, 4837.661363704507, 4867.610591152628], "value": 4617.274389868074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.0433866765167, 573.905305624572, 597.9402059794024, 597.9940200597993, 600.3216365506979, 26778.19665410036, 29364.999999999975, 29463.410731785352, 29478.410431791406, 39449.80275098621, 38228.61771382285, 41968.790156049254, 42007.15985680284, 42050.57949420505, 42071.78964105183, 7824.0, 7983.520988740665, 7984.920150798475, 7986.081600615946, 7988.760337189865, 7501.24987501251, 7892.526448413085, 7995.840083198333, 9984.90015099847, 10276.02377774114, 10242.129418999393, 10290.845637315446, 10313.89686103137, 10315.329503582281, 10316.329438586468, 10250.0, 10309.072183503446, 10338.689839304832, 10358.01598848112, 10380.169586433067, 7421.851562968711, 9881.357711748713, 10221.284510084297, 10233.539490722935, 10599.364038157659, 38804.22391552181, 39041.41437878434, 39093.80453097716, 39203.215935681124, 39298.0, 3108.704673056056, 3356.932861342784, 3503.2643144939593, 3668.2663467306647, 3765.491658626105, 29502.70497295021, 29620.40759184804, 29718.851405743048, 30065.849670751726, 30647.54028689549, 3492.441209406483, 3495.7028652564563, 3513.1217195701074, 3526.2594855080465, 3597.964020359789, 262308.0, 263003.68498157576, 263070.0, 263347.0, 263368.0, 31956.520652190236, 52471.475285246655, 52830.471695282555, 52998.73500632472, 53005.46994530082, 32439.675603244137, 34218.144546386044, 34404.13989650229, 34457.31085378329, 34491.0, 12737.617871463872, 12908.225506469455, 12923.483060677656, 12924.0, 12926.095173337964, 9642.71071867845, 11132.387718675389, 11231.775364492665, 11240.213185076966, 11249.493772780244, 7662.4253181011645, 7943.364530837519, 7947.3642108631175, 8066.072401673765, 8159.184081591912, 3149.637791653989, 3209.951850722241, 3215.935681286408, 3220.259340351732, 3225.419424503612, 881.8721285413579, 954.9856752148723, 966.9758256043515, 992.4888682328607, 1036.036486067964, 28338.71661283402, 28706.856465717538, 28854.567181492293, 28926.710732892403, 29139.708602914125, 960.9231261499064, 995.9502024898726, 1005.8440941654055, 1010.1816729886175, 1047.4972013433594, 14301.0, 14551.41794328215, 14667.633309167357, 14867.553973380816, 14947.252637368088, 407422.0, 411472.0, 412686.0, 412875.0, 412922.0, 48138.5186148134, 48400.0, 48420.27369589459, 48492.27261591079, 48558.75720621374, 1078.229066217658, 1183.4851839449866, 1211.1461419699092, 1225.154643296123, 1238.4179435665224, 27937.580936285565, 29042.564361535016, 29059.273518162216, 29071.273218169714, 29714.851425742734, 40671.59328406678, 41310.38034429426, 41312.38031429591, 41322.173556529306, 41326.586734132274, 326429.0, 335244.0, 336937.0, 337158.0, 337935.0, 21843.235486757887, 24189.75810241875, 24562.140325088538, 25074.122405715712, 26612.201633951012, 40610.59389406068, 40843.795781020905, 40943.590564093975, 41485.0, 41862.16275674409, 34560.0, 34945.65054349424, 35377.64622353847, 35915.46126808048, 36088.63911360958, 35421.82289088641, 35505.64494355127, 35585.64414355927, 35843.46234806428, 36021.27957440889, 34581.654183457846, 35367.46948795718, 35465.290694186486, 35492.46761298531, 35560.28879422345, 30278.84860575683, 31840.840795795873, 31867.840660796548, 32134.678653214105, 32287.35425291528, 24299.63550546708, 24479.38801529976, 24628.261152165465, 24946.62580061264, 25277.494450111262], "value": 16909.371209570276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.05733691044907, 353.8372348719589, 360.28483460331245, 368.2653107051433, 374.3860069486042, 13462.259575723343, 16568.91715541422, 17064.317427302925, 18495.167717452714, 18507.907460462713, 17557.12214389282, 17824.554386140353, 18266.543336416562, 18297.908510457462, 18307.72538411925, 4388.210122178015, 4622.0293738314995, 4626.259798432252, 4702.24764037754, 4707.717536947777, 3442.5868895732424, 3572.2319701264223, 3575.8927232182946, 3685.262947410515, 4613.146567884952, 6002.099685047234, 6129.387061293857, 6147.200863887689, 6151.477124444427, 6152.354002829706, 5505.3393592768725, 5535.308086489189, 6025.186599809013, 6085.513158947274, 6119.296280927706, 3408.2842603053386, 5083.949160508421, 5350.063738845725, 5374.381946076212, 5383.353997520284, 12012.399380030964, 12226.327551984637, 12309.753804923941, 12381.814272785916, 12427.75144497105, 1921.6541022615922, 1969.7439332886634, 1988.443235893952, 2031.0299009960315, 2211.6019116559014, 9301.02339254382, 9320.114589114024, 9368.156865882103, 9456.763580910463, 9493.952530237373, 1560.1185330288351, 1625.8536731694205, 1635.6646887388056, 1647.6787026529832, 1684.2589260725242, 70500.29499704989, 71750.92373614348, 71753.0, 72629.27370726278, 73044.0, 8877.778055548662, 9454.919917618114, 9515.762105947406, 9779.804403911881, 10226.954609078213, 13023.47906083765, 13859.0, 13876.375563099684, 14315.141091534333, 14413.927930360282, 7209.819754506075, 7537.849243015109, 7550.131734850453, 7646.4265180111715, 7660.655270512841, 7136.286371362822, 7168.741846318393, 7227.457940654472, 7284.125904891447, 7315.853682926312, 4343.956560434355, 4391.934120988188, 4427.247367947392, 4451.065276292015, 4497.370368148462, 1793.9103044847704, 1829.7987221405635, 1870.747449094382, 1881.3726126900133, 1930.7200455934092, 840.684743221292, 860.7805009722606, 862.3316929379781, 917.2982668258787, 917.7613820406742, 16770.413035543697, 17378.913105434392, 17445.21496532659, 17558.0, 17929.641407172043, 850.5024560632099, 856.7429771068654, 857.8155696525153, 858.3605214115524, 860.1828263150032, 9465.148136667733, 9879.16027137687, 9939.105480506789, 9944.602215911282, 9953.950230248947, 380370.0, 392989.0, 397453.0, 398481.0, 400558.0, 48778.75610621924, 73206.26793732101, 76118.23881761222, 77049.0, 90029.54985225032, 878.4685265414332, 891.9420237684529, 905.9456432614064, 912.7124955638952, 942.5240253671989, 14407.42370305218, 14528.346224419714, 14583.343749531085, 15804.490014140469, 16983.235754390837, 37751.81124094472, 39103.80448097855, 39177.41233881437, 39410.80294598509, 40204.0, 53536.0, 54665.0, 54937.450625493235, 55414.72292638511, 55830.44169558252, 7414.184439711736, 7696.961515192388, 7844.843103137791, 7927.643256053376, 7941.761747147595, 11218.943905280421, 11411.0, 11813.586524471602, 11901.523939042341, 12086.516539338329, 9767.365121267096, 9835.901640983784, 9894.15899648538, 10450.111740502143, 10652.786944260917, 9848.901510984799, 9973.700788976343, 10777.89222107769, 10784.352938823695, 10820.945895270474, 10103.49482525856, 10305.484725763532, 10377.481125943823, 10554.841677374692, 10757.515911783832, 6512.08830763684, 6570.47436205112, 6873.140857392826, 7646.197149299466, 7708.344790692854, 9438.716838494856, 9651.758706032406, 9864.5560949756, 10006.049425304584, 10109.551797209204], "value": 8058.635006626553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1195.7190060335824, 1323.907326487146, 1378.9933348655481, 1388.4862600837685, 1704.250129942825, 6445.065465507504, 7190.56856588605, 7413.851722965551, 7436.3679087277515, 7707.421943354243, 7398.815029624262, 7520.39836813055, 7523.736669216579, 7524.661390237438, 7543.547387156775, 2177.3250292409366, 2203.4821816873023, 2204.5039866030174, 2206.2278202629113, 2207.0840601150585, 2143.2070134050423, 2177.140029688272, 2195.802377785999, 2200.174934399592, 2206.0734491513604, 2128.372130221588, 2140.3578926322043, 2140.636091864387, 2145.549434618732, 2183.235867446389, 2157.492989147549, 2161.859479133867, 2163.2212403534713, 2164.5562659654734, 2166.956660866782, 2080.147139672742, 2113.0596884386455, 2118.078635793435, 2127.723365980399, 2130.3182981445943, 7292.416606671453, 7506.28690274423, 7535.73624923125, 7584.203658615821, 7634.580098094602, 4359.455068116486, 4467.865964021084, 4478.4178056852725, 4480.865574032784, 4483.193025255453, 2774.4451109778124, 2859.4138201668607, 2864.7421732044218, 2883.596296518489, 2907.592936988823, 895.9776005599847, 905.4657751926329, 907.0747837206079, 908.4231512989234, 920.3557509743207, 9941.850872236922, 10025.548850301753, 10034.598616055422, 10049.648262310784, 10057.145142662883, 3833.559140698855, 3951.209758048402, 4053.756774593475, 4056.776877271778, 4104.589541045932, 8063.637136328879, 8084.514929104273, 8098.473599216032, 8106.351491880635, 8107.1892810718455, 4403.295472724349, 4403.889902752457, 4404.185225733186, 4411.823527058946, 4419.513853476115, 3542.433210686278, 3929.528456585228, 4065.8780236592947, 4067.2678917794487, 4092.6930480214105, 3248.9278538082376, 3328.9167770805925, 3377.0, 3388.373150967079, 3412.675795799395, 1002.7443002034435, 1028.0285130551556, 1036.1296510930854, 1037.4501514197486, 1038.7662775875367, 791.4183075439547, 808.1716240853173, 814.0556953933409, 824.3899514359331, 873.5894129759004, 5179.507946745053, 5191.402988656278, 5204.635675502678, 5270.367555893317, 5309.548688361455, 901.9323550733722, 914.8810654614857, 942.3168203052869, 958.4584709639032, 977.5503268496429, 3387.9153021174666, 3475.6097560975813, 3517.66582174693, 3591.8204089795404, 3681.7238707097076, 8988.595513201792, 9213.355065145375, 9225.400348977295, 9283.071692830797, 9293.070692930653, 9211.355205135711, 9250.306227033, 9253.398529095588, 9257.305702072372, 9260.49067301305, 7101.041359416516, 7221.133463984355, 7231.168415632164, 7235.529690570096, 7243.058402407759, 4885.828995985124, 4903.803847846046, 4934.333864928189, 4938.2839488273285, 5019.924701129413, 8333.166683331618, 8580.356473264404, 8656.870146947675, 8660.220580147818, 8783.736487905373, 8590.312774978112, 8727.258183054511, 8793.824123517366, 8826.91173088261, 8845.55772211374, 5629.634073785354, 5672.914906276326, 6122.571420000735, 6198.194234749454, 6237.906431403442, 6969.895451568129, 7232.963835181001, 7247.0, 7431.702731890664, 7434.962825185839, 6550.312217217123, 6581.3747693969, 6622.8344291393105, 6634.635095069624, 6718.0594716738715, 6538.83652908662, 6544.509161812978, 6556.704948277244, 6557.2131344239, 6592.8351791205605, 6028.246469191351, 6030.276366836008, 6067.544934130046, 6080.69596520181, 6084.847878803065, 4319.136172765522, 4484.529124441887, 4517.548245175456, 4537.614302784168, 4546.658735672918, 4502.4371953505815, 4627.398438203012, 4628.259478483426, 4681.250999840146, 4696.084263568571], "value": 3998.4966010172443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.6645857264146, 295.5861793489116, 297.6591802386266, 301.2183384118214, 308.04352485532416, 4803.447603525596, 4861.465238823731, 4875.975620121894, 4880.926786098212, 4898.853034408965, 4833.178359678855, 4836.733979631119, 4857.465678775332, 4862.683925544837, 4887.1447496688115, 3634.418493041114, 3735.962640373589, 3771.66055055045, 3859.3439115350457, 3885.9702178922607, 3823.885283441501, 3845.5963573295685, 3860.2665493556133, 3863.555691095518, 3900.0639846436934, 3632.909177270563, 3824.368979118442, 3837.0982819037504, 3840.6927445804267, 3845.576986531479, 3691.187938653505, 3790.3177428062936, 3801.5248093988253, 3808.3624041662074, 3841.6350446707797, 3366.8148251846137, 3383.780054296463, 3406.471996840494, 3409.7272218222483, 3419.128122328815, 4772.451168115676, 4793.520647935214, 4795.112904112715, 4798.688085274481, 4800.087983283165, 4239.0885959518855, 4387.3638322443385, 4401.5598440156045, 4409.5149533551285, 4410.7794610269675, 5056.595472362203, 5060.645754797166, 5065.138926382524, 5089.949100508985, 5091.719955402451, 3726.496922915399, 3733.506597361077, 3747.288015277116, 3752.756070855413, 3753.436984452354, 5159.406668233164, 5217.165253559412, 5232.659877107976, 5330.253764472977, 5333.333333333333, 3775.4714339992424, 3777.301199278142, 3780.9243815123546, 3781.9432708509394, 3813.3326667833016, 3861.9227615447535, 3870.554886188068, 3871.922561548753, 3876.8061596920043, 3880.359740642819, 4354.085642015212, 4356.390105385249, 4373.650107991353, 4374.103308821684, 4382.693211475166, 4888.535589119028, 4993.0, 4997.850064497999, 5017.473165317662, 5040.143175660147, 1284.8072789081525, 1311.4098655605017, 1314.7107636320186, 1319.8218240537597, 1324.198859689893, 872.9345299102592, 882.188386684252, 903.3225081189108, 927.9489628070521, 936.1527817325332, 4421.248387774086, 4423.137488189772, 4426.712263702849, 4433.866983990485, 4439.822407103744, 5163.044836705221, 5167.715775632301, 5173.249878767633, 5191.974040129775, 5207.297014903015, 4254.191703576311, 4394.1870753910625, 4412.558744125562, 4421.823127074881, 4532.388127602798, 2754.504189245915, 2763.198672385026, 2774.6531683539556, 2775.736305051017, 2781.5827625855877, 4853.611711063177, 4882.144784981684, 4915.721912302755, 4915.926261106087, 4936.7910857942625, 5144.382674079135, 5291.444398338196, 5319.468053194727, 5416.972915135478, 5439.728013599304, 4950.455449900508, 4955.950440495693, 4973.428055773632, 4993.525615066563, 4999.700017998932, 5243.8164664236565, 5247.527722504993, 5259.868503287448, 5262.684238945675, 5278.656887302313, 4901.975490122527, 5172.275881376686, 5174.689518628894, 5192.454792246911, 5195.142671530719, 4935.383077115361, 4958.776855041604, 4962.255661650781, 4997.900041999067, 4999.725015124203, 3747.344214762351, 3764.5482542095124, 3764.7176461766026, 3769.6230376962085, 3772.75477093988, 5077.759413767674, 5175.378954525481, 5206.427292997843, 5246.475352464723, 5277.498637629419, 5060.266261392151, 5064.3909697844665, 5074.8581569146645, 5087.949120508748, 5096.821611243588, 5099.643024988215, 5101.744912754273, 5107.642465027412, 5130.12787826078, 5134.76893539799, 4770.688060783174, 4786.186348320724, 5018.623603229699, 5037.647364684583, 5053.772580233972, 4945.357103576512, 5108.3103780989095, 5110.3356563646485, 5110.948890511196, 5112.616553758408, 4980.302757613865, 4991.126552853309, 4992.925106123338, 5010.672171874383, 5011.0], "value": 3853.6052865872607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.1731044849163, 669.4577392312226, 725.538040847692, 747.3236720767703, 772.0812233442207, 14675.119492830425, 15450.304736286866, 15469.84530154698, 15477.148756818398, 15482.38070477181, 14160.00879938402, 14584.781228281585, 14691.0, 14750.63123421915, 14894.106353618763, 767.7965339185121, 793.2939683681499, 793.8729803231485, 794.8012996750813, 796.2753893956501, 780.8087018680432, 786.429838367185, 789.0964845252183, 789.3527307607764, 789.4000559574736, 825.859603867344, 826.6114925984807, 827.1893544326533, 828.4739190613943, 828.5153185386556, 821.8479581277483, 822.6421506644629, 823.3454403749034, 829.5022986208257, 829.7759604906702, 600.627610881252, 601.9789307374265, 602.6986506746626, 603.0411645483658, 603.1796756411277, 13110.803337949937, 13143.474261029547, 13167.802482962763, 13176.53882114131, 13180.604581862559, 13255.867441325656, 13372.197668139943, 13401.932990335083, 13509.932450337783, 13516.797248041286, 10885.292455990335, 10978.396188209645, 11003.889961100447, 11081.390523521202, 11103.38931358775, 3299.1257316811066, 3343.36476069546, 3353.3796247694254, 3361.680640339164, 3376.7129793967542, 42953.0, 44864.0, 61545.38454615486, 62613.68693156505, 63668.36331636717, 10395.428251446243, 10518.263721539419, 10584.523696433678, 10614.89385106139, 10649.90476948261, 17214.569635759206, 17751.911240443715, 17760.91119544394, 18856.528586785167, 18899.52751181204, 7110.786676399716, 7230.891536626955, 7319.194888562254, 7338.816529586697, 7409.258074832112, 3861.420786881934, 3927.9018024549046, 3985.242803867314, 3999.960000400017, 4003.939940900889, 2831.815931964457, 2939.2504911247497, 2939.6913324101088, 2941.9411611767646, 2945.558166275076, 515.7756375976462, 519.7541354242703, 525.1780962793216, 525.2620068803337, 525.5559052600546, 504.71483611759237, 507.9695218286915, 572.9197912292199, 607.4957785038407, 656.7569999100364, 8522.70170544028, 8526.232639062515, 8569.228769410784, 8574.957125214334, 8783.297336213216, 568.647438588078, 592.5940730599553, 637.2225884420999, 637.8532937424326, 656.9816783984804, 4125.876223713293, 4222.408862759216, 4223.239816832938, 4229.090745489734, 4236.195122926696, 63348.68325658342, 88696.556517217, 93978.0, 94308.52845735727, 94870.0, 45739.54260457419, 50373.0, 72369.6381518089, 72395.27604723991, 85349.57325213334, 45162.32256516155, 61648.0, 70901.64549177325, 73186.63406682933, 75860.24139758642, 8807.779805504657, 9036.864447033167, 9042.367034307536, 9069.093090690878, 9237.353385262966, 36951.63048369482, 37189.0, 37787.05532361713, 42245.788771055944, 43261.0, 38305.6169438302, 38368.0, 38982.6101738979, 45179.0, 60196.69901650639, 11198.328100314007, 11240.88759112431, 11330.886691132982, 12004.639860804189, 12205.69485762863, 12982.805257921327, 13122.081454298108, 13211.933940330622, 13404.0, 13804.861951380759, 12699.301538415475, 12788.616341509769, 12853.614391568268, 13120.803187951997, 13484.528041518499, 12284.262944223376, 12588.370581471074, 12668.556600518938, 12995.740085198055, 13136.0, 11152.888471115184, 11177.0, 11359.716007099558, 11584.42077896085, 12265.38673066361, 9382.765430864283, 9711.951440243036, 9865.950670246602, 9866.112049915255, 9877.209823214269, 9084.091590840862, 9982.450965196984, 10045.196384289386, 10137.797244055226, 10139.949300253451], "value": 6564.346274872214, "unit": "score"}], "name": "dromaeo_css", "value": 6318.7299633175635, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 113.0, 115.0, 116.0, 113.0, 113.0, 115.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 128.0, 168.0, 122.0, 124.0, 147.0, 121.0, 155.0, 124.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 163.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 128.0, 76.0, 76.0, 76.0, 76.0, 97.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 117.0, 85.0, 85.0, 84.0, 127.0, 84.0, 84.0, 117.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 89.0, 87.0, 85.0, 86.0, 85.0, 84.0, 85.0, 78.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 133.0, 138.0, 128.0, 129.0, 135.0, 132.0, 163.0, 132.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 164.0, 168.0, 166.0, 164.0, 166.0, 166.0, 165.0, 167.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1528.1999999999996, "alertThreshold": 2.0}]} 03:32:52 INFO - Return code: 0 03:32:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:32:52 INFO - # TBPL SUCCESS # 03:32:52 INFO - Running post-action listener: _resource_record_post_action 03:32:52 INFO - ##### 03:32:52 INFO - ##### Finished run-tests step (success) 03:32:52 INFO - ##### 03:32:52 INFO - Running post-run listener: _resource_record_post_run 03:32:52 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549335040; Read time: 28; Write time: 1073232 03:32:52 INFO - TinderboxPrint: CPU usage
13.0% 03:32:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 03:32:52 INFO - TinderboxPrint: I/O write bytes / time
549,335,040 / 1,073,232 03:32:52 INFO - TinderboxPrint: CPU idle
8,352.3 (87.0%) 03:32:52 INFO - TinderboxPrint: CPU user
1,201.0 (12.5%) 03:32:52 INFO - TinderboxPrint: Swap in / out
0 / 0 03:32:52 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 253218816; Read time: 0; Write time: 446236 03:32:52 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 296116224; Read time: 0; Write time: 626996 03:32:52 INFO - Running post-run listener: _upload_blobber_files 03:32:52 INFO - Blob upload gear active. 03:32:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:32:52 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 03:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:32:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:32:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:53 INFO - (blobuploader) - INFO - Done attempting. 03:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:32:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:54 INFO - (blobuploader) - INFO - Done attempting. 03:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:58 INFO - (blobuploader) - INFO - Done attempting. 03:32:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:32:58 INFO - Return code: 0 03:32:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:32:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:32:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a10ec68265ad84bbd900d62f222d81a9865f57a17f206c8cf419e0aa155cb1458940a28ac4b0a99e24acc805934be7b0c333e590c4f75c083e65bf138da6db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/535b86d2ab3fb019b85cac2b436f7f9bfc59d3536bd34b11c4830a06195bef0f06b2ed7a3bfa7c32bc7d62bff7595217e0fbf1aef1b75b52eb83f201e8c0c7f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/671d10adcdcdc3f7ad54e68229730f51403a0abd35578d104b734df50851c44e622b599a707c4ae849391cba4917f9a270dffad1126ff44bc9665d8c5c632d5f"} 03:32:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:32:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:32:58 INFO - Contents: 03:32:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a10ec68265ad84bbd900d62f222d81a9865f57a17f206c8cf419e0aa155cb1458940a28ac4b0a99e24acc805934be7b0c333e590c4f75c083e65bf138da6db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/535b86d2ab3fb019b85cac2b436f7f9bfc59d3536bd34b11c4830a06195bef0f06b2ed7a3bfa7c32bc7d62bff7595217e0fbf1aef1b75b52eb83f201e8c0c7f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/671d10adcdcdc3f7ad54e68229730f51403a0abd35578d104b734df50851c44e622b599a707c4ae849391cba4917f9a270dffad1126ff44bc9665d8c5c632d5f"} 03:32:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:32:58 INFO - Copying logs to upload dir... 03:32:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:32:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.557694 ========= master_lag: 72.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-07-12 03:34:09.821589) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 mins, 43 secs) (at 2016-07-12 03:34:09.824753) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a10ec68265ad84bbd900d62f222d81a9865f57a17f206c8cf419e0aa155cb1458940a28ac4b0a99e24acc805934be7b0c333e590c4f75c083e65bf138da6db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/535b86d2ab3fb019b85cac2b436f7f9bfc59d3536bd34b11c4830a06195bef0f06b2ed7a3bfa7c32bc7d62bff7595217e0fbf1aef1b75b52eb83f201e8c0c7f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/671d10adcdcdc3f7ad54e68229730f51403a0abd35578d104b734df50851c44e622b599a707c4ae849391cba4917f9a270dffad1126ff44bc9665d8c5c632d5f"} build_url:https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/Op1yVRlYQIqy9MydDgro7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a10ec68265ad84bbd900d62f222d81a9865f57a17f206c8cf419e0aa155cb1458940a28ac4b0a99e24acc805934be7b0c333e590c4f75c083e65bf138da6db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/535b86d2ab3fb019b85cac2b436f7f9bfc59d3536bd34b11c4830a06195bef0f06b2ed7a3bfa7c32bc7d62bff7595217e0fbf1aef1b75b52eb83f201e8c0c7f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/671d10adcdcdc3f7ad54e68229730f51403a0abd35578d104b734df50851c44e622b599a707c4ae849391cba4917f9a270dffad1126ff44bc9665d8c5c632d5f"}' ========= master_lag: 223.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 mins, 43 secs) (at 2016-07-12 03:37:53.155905) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 mins, 32 secs) (at 2016-07-12 03:37:53.156302) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468318333.8996-1124334894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004750 ========= master_lag: 212.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 mins, 32 secs) (at 2016-07-12 03:41:25.506636) ========= ========= Started reboot skipped (results: 3, elapsed: 11 secs) (at 2016-07-12 03:41:25.506950) ========= ========= Finished reboot skipped (results: 3, elapsed: 11 secs) (at 2016-07-12 03:41:36.706357) ========= ========= Total master_lag: 507.94 =========