builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1468873623.07 results: success (0) buildid: 20160718103058 builduid: 12b402f7e7764cf88f4e5ee8ceae5a34 revision: 4a992c10189fd39b2c9daeb49749127a5a2a0d7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.068988) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.069555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.069858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.085077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.085438) ========= 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=df17445c3590ff7897617a0e00000225-1468872994.394424-426034555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 13:27:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.4M=0s 2016-07-18 13:27:03 (89.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.223887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.224215) ========= 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=df17445c3590ff7897617a0e00000225-1468872994.394424-426034555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020636 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.274988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.275559) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a992c10189fd39b2c9daeb49749127a5a2a0d7d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a992c10189fd39b2c9daeb49749127a5a2a0d7d --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=df17445c3590ff7897617a0e00000225-1468872994.394424-426034555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 13:27:03,676 truncating revision to first 12 chars 2016-07-18 13:27:03,676 Setting DEBUG logging. 2016-07-18 13:27:03,676 attempt 1/10 2016-07-18 13:27:03,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4a992c10189f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 13:27:03,999 unpacking tar archive at: mozilla-inbound-4a992c10189f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.986703) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.987062) ========= script_repo_revision: 4a992c10189fd39b2c9daeb49749127a5a2a0d7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.987488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:03.987751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 13:27:04.003008) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-18 13:27:04.003439) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468872994.394424-426034555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:27:04 INFO - MultiFileLogger online at 20160718 13:27:04 in /builds/slave/test 13:27:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:27:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:27:04 INFO - {'append_to_log': False, 13:27:04 INFO - 'base_work_dir': '/builds/slave/test', 13:27:04 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:27:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:27:04 INFO - 'branch': 'Mozilla-Inbound', 13:27:04 INFO - 'buildbot_json_path': 'buildprops.json', 13:27:04 INFO - 'config_files': ('talos/linux_config.py',), 13:27:04 INFO - 'default_actions': ('clobber', 13:27:04 INFO - 'read-buildbot-config', 13:27:04 INFO - 'download-and-extract', 13:27:04 INFO - 'populate-webroot', 13:27:04 INFO - 'create-virtualenv', 13:27:04 INFO - 'install', 13:27:04 INFO - 'run-tests'), 13:27:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:27:04 INFO - 'download_minidump_stackwalk': True, 13:27:04 INFO - 'download_symbols': 'ondemand', 13:27:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:27:04 INFO - 'tooltool.py': '/tools/tooltool.py', 13:27:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:27:04 INFO - '/tools/misc-python/virtualenv.py')}, 13:27:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:27:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:27:04 INFO - 'installer_path': 'installer.exe', 13:27:04 INFO - 'log_level': 'info', 13:27:04 INFO - 'log_name': 'talos', 13:27:04 INFO - 'log_to_console': True, 13:27:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:27:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:27:04 INFO - 'opt_config_files': (), 13:27:04 INFO - 'pip_index': False, 13:27:04 INFO - 'sps_profile': False, 13:27:04 INFO - 'sps_profile_interval': 0, 13:27:04 INFO - 'suite': 'dromaeojs', 13:27:04 INFO - 'system_bits': '32', 13:27:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:27:04 INFO - 'title': 'talos-linux64-ix-021', 13:27:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:27:04 INFO - 'use_talos_json': True, 13:27:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:27:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:27:04 INFO - 'work_dir': 'build'} 13:27:04 INFO - ##### 13:27:04 INFO - ##### Running clobber step. 13:27:04 INFO - ##### 13:27:04 INFO - Running pre-action listener: _resource_record_pre_action 13:27:04 INFO - Running main action method: clobber 13:27:04 INFO - rmtree: /builds/slave/test/build 13:27:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:27:04 INFO - Running post-action listener: _resource_record_post_action 13:27:04 INFO - ##### 13:27:04 INFO - ##### Finished clobber step (success) 13:27:04 INFO - ##### 13:27:04 INFO - ##### 13:27:04 INFO - ##### Running read-buildbot-config step. 13:27:04 INFO - ##### 13:27:04 INFO - Running pre-action listener: _resource_record_pre_action 13:27:04 INFO - Running main action method: read_buildbot_config 13:27:04 INFO - Using buildbot properties: 13:27:04 INFO - { 13:27:04 INFO - "project": "", 13:27:04 INFO - "product": "firefox", 13:27:04 INFO - "script_repo_revision": "production", 13:27:04 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:27:04 INFO - "repository": "", 13:27:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:27:04 INFO - "buildid": "20160718103058", 13:27:04 INFO - "pgo_build": "True", 13:27:04 INFO - "basedir": "/builds/slave/test", 13:27:04 INFO - "buildnumber": 1259, 13:27:04 INFO - "slavename": "talos-linux64-ix-021", 13:27:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:27:04 INFO - "platform": "ubuntu64_hw", 13:27:04 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:27:04 INFO - "branch": "mozilla-inbound", 13:27:04 INFO - "repo_path": "integration/mozilla-inbound", 13:27:04 INFO - "revision": "4a992c10189fd39b2c9daeb49749127a5a2a0d7d", 13:27:04 INFO - "stage_platform": "linux64-pgo", 13:27:04 INFO - "builduid": "12b402f7e7764cf88f4e5ee8ceae5a34", 13:27:04 INFO - "slavebuilddir": "test" 13:27:04 INFO - } 13:27:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:27:04 INFO - Running post-action listener: _resource_record_post_action 13:27:04 INFO - ##### 13:27:04 INFO - ##### Finished read-buildbot-config step (success) 13:27:04 INFO - ##### 13:27:04 INFO - ##### 13:27:04 INFO - ##### Running download-and-extract step. 13:27:04 INFO - ##### 13:27:04 INFO - Running pre-action listener: _resource_record_pre_action 13:27:04 INFO - Running main action method: download_and_extract 13:27:04 INFO - mkdir: /builds/slave/test/build/tests 13:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:04 INFO - https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:27:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:27:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:27:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:09 INFO - Downloaded 1361 bytes. 13:27:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:27:09 INFO - Using the following test package requirements: 13:27:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:27:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:27:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:27:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'jsshell-linux-x86_64.zip'], 13:27:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:27:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:27:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:27:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:27:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:27:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:27:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:09 INFO - https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:27:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:27:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:27:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:14 INFO - Downloaded 24335358 bytes. 13:27:14 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'] 13:27:14 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 13:27:15 INFO - Return code: 0 13:27:15 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 13:27: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')]} 13:27:15 INFO - https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:27:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:27:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:27:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:17 INFO - Downloaded 24335358 bytes. 13:27:17 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'] 13:27:17 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 13:27:18 INFO - Return code: 0 13:27:18 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')]} 13:27:18 INFO - https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:20 INFO - Downloaded 14403317 bytes. 13:27:20 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'] 13:27:20 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 13:27:20 INFO - Return code: 0 13:27: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')]} 13:27:20 INFO - https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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 13:27:22 INFO - Downloaded 60852130 bytes. 13:27:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:27:22 INFO - mkdir: /builds/slave/test/properties 13:27:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:27:22 INFO - Writing to file /builds/slave/test/properties/build_url 13:27:22 INFO - Contents: 13:27:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:27:23 INFO - Running post-action listener: _resource_record_post_action 13:27:23 INFO - Running post-action listener: set_extra_try_arguments 13:27:23 INFO - ##### 13:27:23 INFO - ##### Finished download-and-extract step (success) 13:27:23 INFO - ##### 13:27:23 INFO - ##### 13:27:23 INFO - ##### Running populate-webroot step. 13:27:23 INFO - ##### 13:27:23 INFO - Running pre-action listener: _resource_record_pre_action 13:27:23 INFO - Running main action method: populate_webroot 13:27:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:27:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:27:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:27:23 INFO - '--tppagecycles', 13:27:23 INFO - '7'], 13:27:23 INFO - 'tests': ['tsvgm']}}, 13:27:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:27:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:27:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:27:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:27:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['damp', 'tps']}, 13:27:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'tests': ['damp', 'tps']}, 13:27:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['dromaeo_dom']}, 13:27:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:27:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['basic_compositor_video']}, 13:27:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:27:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['a11yr', 13:27:23 INFO - 'ts_paint', 13:27:23 INFO - 'tpaint', 13:27:23 INFO - 'sessionrestore', 13:27:23 INFO - 'sessionrestore_no_auto_restore', 13:27:23 INFO - 'tabpaint']}, 13:27:23 INFO - 'other-e10s': {'tests': ['a11yr', 13:27:23 INFO - 'ts_paint', 13:27:23 INFO - 'tpaint', 13:27:23 INFO - 'sessionrestore', 13:27:23 INFO - 'sessionrestore_no_auto_restore', 13:27:23 INFO - 'tabpaint']}, 13:27:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:27:23 INFO - 'ts_paint', 13:27:23 INFO - 'tpaint', 13:27:23 INFO - 'sessionrestore', 13:27:23 INFO - 'sessionrestore_no_auto_restore', 13:27:23 INFO - 'tabpaint']}, 13:27:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:27:23 INFO - 'ts_paint', 13:27:23 INFO - 'tpaint', 13:27:23 INFO - 'sessionrestore', 13:27:23 INFO - 'sessionrestore_no_auto_restore', 13:27:23 INFO - 'tabpaint']}, 13:27:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['a11yr', 13:27:23 INFO - 'ts_paint', 13:27:23 INFO - 'tpaint', 13:27:23 INFO - 'sessionrestore', 13:27:23 INFO - 'sessionrestore_no_auto_restore', 13:27:23 INFO - 'tabpaint']}, 13:27:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['a11yr', 13:27:23 INFO - 'ts_paint', 13:27:23 INFO - 'tpaint', 13:27:23 INFO - 'sessionrestore', 13:27:23 INFO - 'sessionrestore_no_auto_restore', 13:27:23 INFO - 'tabpaint']}, 13:27:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['tsvgx', 13:27:23 INFO - 'tsvgr_opacity', 13:27:23 INFO - 'tart', 13:27:23 INFO - 'tscrollx', 13:27:23 INFO - 'cart']}, 13:27:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:27:23 INFO - 'tsvgr_opacity', 13:27:23 INFO - 'tart', 13:27:23 INFO - 'tscrollx', 13:27:23 INFO - 'cart']}, 13:27:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'talos_options': ['--disable-e10s'], 13:27:23 INFO - 'tests': ['tp5o']}, 13:27:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'tests': ['tp5o']}, 13:27:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'talos_options': ['--disable-e10s', 13:27:23 INFO - '--xperf_path', 13:27:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:23 INFO - 'tests': ['tp5n']}, 13:27:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:23 INFO - 'talos_options': ['--xperf_path', 13:27:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:23 INFO - 'tests': ['tp5n']}}, 13:27:23 INFO - 'talos.zip': {'path': '', 13:27:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:27:23 INFO - Running post-action listener: _resource_record_post_action 13:27:23 INFO - ##### 13:27:23 INFO - ##### Finished populate-webroot step (success) 13:27:23 INFO - ##### 13:27:23 INFO - ##### 13:27:23 INFO - ##### Running create-virtualenv step. 13:27:23 INFO - ##### 13:27:23 INFO - Running pre-action listener: _resource_record_pre_action 13:27:23 INFO - Running main action method: create_virtualenv 13:27:23 INFO - Creating virtualenv /builds/slave/test/build/venv 13:27:23 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 13:27:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:27:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:27:23 INFO - Using real prefix '/usr' 13:27:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:27:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:27:25 INFO - Installing pip.................done. 13:27:25 INFO - Return code: 0 13:27:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:27:25 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')]} 13:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:25 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')]} 13:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:25 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:25 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 13:27:25 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 13:27:25 INFO - Using env: {'DISPLAY': ':0', 13:27:25 INFO - 'HOME': '/home/cltbld', 13:27:25 INFO - 'LANG': 'en_US.UTF-8', 13:27:25 INFO - 'LANGUAGE': 'en_US:en', 13:27:25 INFO - 'LOGNAME': 'cltbld', 13:27:25 INFO - 'MAIL': '/var/mail/cltbld', 13:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:25 INFO - 'MOZ_NO_REMOTE': '1', 13:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:25 INFO - 'NO_EM_RESTART': '1', 13:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:25 INFO - 'PWD': '/builds/slave/test', 13:27:25 INFO - 'SHELL': '/bin/bash', 13:27:25 INFO - 'SHLVL': '1', 13:27:25 INFO - 'TERM': 'linux', 13:27:25 INFO - 'TMOUT': '86400', 13:27:25 INFO - 'USER': 'cltbld', 13:27:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:25 INFO - '_': '/tools/buildbot/bin/python'} 13:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:26 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 13:27:26 INFO - Cleaning up... 13:27:26 INFO - Return code: 0 13:27:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:27:26 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')]} 13:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:26 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')]} 13:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:26 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:26 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 13:27:26 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 13:27:26 INFO - Using env: {'DISPLAY': ':0', 13:27:26 INFO - 'HOME': '/home/cltbld', 13:27:26 INFO - 'LANG': 'en_US.UTF-8', 13:27:26 INFO - 'LANGUAGE': 'en_US:en', 13:27:26 INFO - 'LOGNAME': 'cltbld', 13:27:26 INFO - 'MAIL': '/var/mail/cltbld', 13:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:26 INFO - 'MOZ_NO_REMOTE': '1', 13:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:26 INFO - 'NO_EM_RESTART': '1', 13:27:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:26 INFO - 'PWD': '/builds/slave/test', 13:27:26 INFO - 'SHELL': '/bin/bash', 13:27:26 INFO - 'SHLVL': '1', 13:27:26 INFO - 'TERM': 'linux', 13:27:26 INFO - 'TMOUT': '86400', 13:27:26 INFO - 'USER': 'cltbld', 13:27:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:26 INFO - '_': '/tools/buildbot/bin/python'} 13:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:26 INFO - Downloading/unpacking psutil>=3.1.1 13:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:27:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:28 INFO - Installing collected packages: psutil 13:27:28 INFO - Running setup.py install for psutil 13:27:28 INFO - building 'psutil._psutil_linux' extension 13:27:28 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 13:27:28 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 13:27:28 INFO - building 'psutil._psutil_posix' extension 13:27:28 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 13:27:28 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 13:27:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:28 INFO - Successfully installed psutil 13:27:28 INFO - Cleaning up... 13:27:28 INFO - Return code: 0 13:27:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:27:28 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')]} 13:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:28 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')]} 13:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:28 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:28 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 13:27:28 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 13:27:28 INFO - Using env: {'DISPLAY': ':0', 13:27:28 INFO - 'HOME': '/home/cltbld', 13:27:28 INFO - 'LANG': 'en_US.UTF-8', 13:27:28 INFO - 'LANGUAGE': 'en_US:en', 13:27:28 INFO - 'LOGNAME': 'cltbld', 13:27:28 INFO - 'MAIL': '/var/mail/cltbld', 13:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:28 INFO - 'MOZ_NO_REMOTE': '1', 13:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:28 INFO - 'NO_EM_RESTART': '1', 13:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:28 INFO - 'PWD': '/builds/slave/test', 13:27:28 INFO - 'SHELL': '/bin/bash', 13:27:28 INFO - 'SHLVL': '1', 13:27:28 INFO - 'TERM': 'linux', 13:27:28 INFO - 'TMOUT': '86400', 13:27:28 INFO - 'USER': 'cltbld', 13:27:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:28 INFO - '_': '/tools/buildbot/bin/python'} 13:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:27:28 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 13:27:28 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 13:27:28 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 13:27:28 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 13:27:28 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 13:27:28 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 13:27:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:27:30 INFO - Installing collected packages: mozsystemmonitor 13:27:30 INFO - Running setup.py install for mozsystemmonitor 13:27:31 INFO - Successfully installed mozsystemmonitor 13:27:31 INFO - Cleaning up... 13:27:31 INFO - Return code: 0 13:27:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:31 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:31 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 13:27:31 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 13:27:31 INFO - Using env: {'DISPLAY': ':0', 13:27:31 INFO - 'HOME': '/home/cltbld', 13:27:31 INFO - 'LANG': 'en_US.UTF-8', 13:27:31 INFO - 'LANGUAGE': 'en_US:en', 13:27:31 INFO - 'LOGNAME': 'cltbld', 13:27:31 INFO - 'MAIL': '/var/mail/cltbld', 13:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:31 INFO - 'MOZ_NO_REMOTE': '1', 13:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:31 INFO - 'NO_EM_RESTART': '1', 13:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:31 INFO - 'PWD': '/builds/slave/test', 13:27:31 INFO - 'SHELL': '/bin/bash', 13:27:31 INFO - 'SHLVL': '1', 13:27:31 INFO - 'TERM': 'linux', 13:27:31 INFO - 'TMOUT': '86400', 13:27:31 INFO - 'USER': 'cltbld', 13:27:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:31 INFO - '_': '/tools/buildbot/bin/python'} 13:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:27:31 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 13:27:31 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 13:27:31 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 13:27:31 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 13:27:31 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 13:27:31 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 13:27:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:27:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27:33 INFO - Downloading functools32-3.2.3-2.tar.gz 13:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:27:33 INFO - warning: no files found matching '*.txt' 13:27:33 INFO - no previously-included directories found matching 'build' 13:27:33 INFO - no previously-included directories found matching 'dist' 13:27:33 INFO - no previously-included directories found matching '.git*' 13:27:33 INFO - Installing collected packages: jsonschema, functools32 13:27:33 INFO - Running setup.py install for functools32 13:27:33 INFO - warning: no files found matching '*.txt' 13:27:33 INFO - no previously-included directories found matching 'build' 13:27:33 INFO - no previously-included directories found matching 'dist' 13:27:33 INFO - no previously-included directories found matching '.git*' 13:27:33 INFO - Successfully installed jsonschema functools32 13:27:33 INFO - Cleaning up... 13:27:33 INFO - Return code: 0 13:27:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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')]} 13:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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', '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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:27: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 blobuploader==1.2.4 13:27:33 INFO - Using env: {'DISPLAY': ':0', 13:27:33 INFO - 'HOME': '/home/cltbld', 13:27:33 INFO - 'LANG': 'en_US.UTF-8', 13:27:33 INFO - 'LANGUAGE': 'en_US:en', 13:27:33 INFO - 'LOGNAME': 'cltbld', 13:27:33 INFO - 'MAIL': '/var/mail/cltbld', 13:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:33 INFO - 'MOZ_NO_REMOTE': '1', 13:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:33 INFO - 'NO_EM_RESTART': '1', 13:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:33 INFO - 'PWD': '/builds/slave/test', 13:27:33 INFO - 'SHELL': '/bin/bash', 13:27:33 INFO - 'SHLVL': '1', 13:27:33 INFO - 'TERM': 'linux', 13:27:33 INFO - 'TMOUT': '86400', 13:27:33 INFO - 'USER': 'cltbld', 13:27:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:33 INFO - '_': '/tools/buildbot/bin/python'} 13:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27:35 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:27:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27:36 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 13:27:36 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 13:27:36 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 13:27:36 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 13:27:36 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 13:27:36 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 13:27:36 INFO - Downloading docopt-0.6.1.tar.gz 13:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:36 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:36 INFO - Running setup.py install for blobuploader 13:27:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:27:36 INFO - Running setup.py install for requests 13:27:37 INFO - Running setup.py install for docopt 13:27:37 INFO - Successfully installed blobuploader requests docopt 13:27:37 INFO - Cleaning up... 13:27:37 INFO - Return code: 0 13:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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')]} 13:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:37 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:37 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 13:27:37 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 13:27:37 INFO - Using env: {'DISPLAY': ':0', 13:27:37 INFO - 'HOME': '/home/cltbld', 13:27:37 INFO - 'LANG': 'en_US.UTF-8', 13:27:37 INFO - 'LANGUAGE': 'en_US:en', 13:27:37 INFO - 'LOGNAME': 'cltbld', 13:27:37 INFO - 'MAIL': '/var/mail/cltbld', 13:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:37 INFO - 'MOZ_NO_REMOTE': '1', 13:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:37 INFO - 'NO_EM_RESTART': '1', 13:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:37 INFO - 'PWD': '/builds/slave/test', 13:27:37 INFO - 'SHELL': '/bin/bash', 13:27:37 INFO - 'SHLVL': '1', 13:27:37 INFO - 'TERM': 'linux', 13:27:37 INFO - 'TMOUT': '86400', 13:27:37 INFO - 'USER': 'cltbld', 13:27:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:37 INFO - '_': '/tools/buildbot/bin/python'} 13:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:37 INFO - Running setup.py (path:/tmp/pip-Fglbb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:37 INFO - Running setup.py (path:/tmp/pip-Ro8k8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:37 INFO - Running setup.py (path:/tmp/pip-QXboaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:37 INFO - Running setup.py (path:/tmp/pip-1Uzyyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:37 INFO - Running setup.py (path:/tmp/pip-SCQ4Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:37 INFO - Running setup.py (path:/tmp/pip-INseQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:37 INFO - Running setup.py (path:/tmp/pip-Gyvr1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:37 INFO - Running setup.py (path:/tmp/pip-2SqGZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:37 INFO - Running setup.py (path:/tmp/pip-z5c29f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:38 INFO - Running setup.py (path:/tmp/pip-Wm8zhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:38 INFO - Running setup.py (path:/tmp/pip-nimSNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:38 INFO - Running setup.py (path:/tmp/pip-RHRwVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:38 INFO - Running setup.py (path:/tmp/pip-MolgAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:38 INFO - Running setup.py (path:/tmp/pip-jeN52D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:38 INFO - Running setup.py (path:/tmp/pip-CVcvRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:38 INFO - Running setup.py (path:/tmp/pip-KGEmJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:38 INFO - Running setup.py (path:/tmp/pip-k3kqws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:38 INFO - Running setup.py install for manifestparser 13:27:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:27:38 INFO - Running setup.py install for mozcrash 13:27:38 INFO - Running setup.py install for mozdebug 13:27:38 INFO - Running setup.py install for mozdevice 13:27:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Running setup.py install for mozfile 13:27:39 INFO - Running setup.py install for mozhttpd 13:27:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Running setup.py install for mozinfo 13:27:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Running setup.py install for mozInstall 13:27:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Running setup.py install for mozleak 13:27:39 INFO - Running setup.py install for mozlog 13:27:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Running setup.py install for moznetwork 13:27:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Running setup.py install for mozprocess 13:27:39 INFO - Running setup.py install for mozprofile 13:27:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:27:39 INFO - Running setup.py install for mozrunner 13:27:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:27:40 INFO - Running setup.py install for mozscreenshot 13:27:40 INFO - Running setup.py install for moztest 13:27:40 INFO - Running setup.py install for mozversion 13:27:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:27:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:27:40 INFO - Cleaning up... 13:27:40 INFO - Return code: 0 13:27:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:40 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:40 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 13:27:40 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 13:27:40 INFO - Using env: {'DISPLAY': ':0', 13:27:40 INFO - 'HOME': '/home/cltbld', 13:27:40 INFO - 'LANG': 'en_US.UTF-8', 13:27:40 INFO - 'LANGUAGE': 'en_US:en', 13:27:40 INFO - 'LOGNAME': 'cltbld', 13:27:40 INFO - 'MAIL': '/var/mail/cltbld', 13:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:40 INFO - 'MOZ_NO_REMOTE': '1', 13:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:40 INFO - 'NO_EM_RESTART': '1', 13:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:40 INFO - 'PWD': '/builds/slave/test', 13:27:40 INFO - 'SHELL': '/bin/bash', 13:27:40 INFO - 'SHLVL': '1', 13:27:40 INFO - 'TERM': 'linux', 13:27:40 INFO - 'TMOUT': '86400', 13:27:40 INFO - 'USER': 'cltbld', 13:27:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:40 INFO - '_': '/tools/buildbot/bin/python'} 13:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:40 INFO - Running setup.py (path:/tmp/pip-Vt3oqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:40 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)) 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:40 INFO - Running setup.py (path:/tmp/pip-ov4omZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:40 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)) 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:40 INFO - Running setup.py (path:/tmp/pip-Vr1s5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:40 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)) 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:40 INFO - Running setup.py (path:/tmp/pip-uswvDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:40 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)) 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:40 INFO - Running setup.py (path:/tmp/pip-KMkIRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:40 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)) 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:40 INFO - Running setup.py (path:/tmp/pip-lZkqF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:41 INFO - Running setup.py (path:/tmp/pip-v3_aTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:41 INFO - Running setup.py (path:/tmp/pip-4yaSwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:41 INFO - Running setup.py (path:/tmp/pip-imYwHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:41 INFO - Running setup.py (path:/tmp/pip-Ig90fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:41 INFO - Running setup.py (path:/tmp/pip-X2TpxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:41 INFO - Running setup.py (path:/tmp/pip-GdClJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:41 INFO - Running setup.py (path:/tmp/pip-Dd5s99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:41 INFO - Running setup.py (path:/tmp/pip-7aKW3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:41 INFO - Running setup.py (path:/tmp/pip-nEFyPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:41 INFO - Running setup.py (path:/tmp/pip-BWK2Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:41 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)) 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:41 INFO - Running setup.py (path:/tmp/pip-ElhCVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:41 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)) 13:27:41 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)) 13:27:41 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)) 13:27:41 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)) 13:27:41 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)) 13:27:41 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)) 13:27:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:41 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 13:27:41 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 13:27:41 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 13:27:41 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 13:27:41 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 13:27:41 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 13:27:43 INFO - Downloading blessings-1.6.tar.gz 13:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:27:43 INFO - Installing collected packages: blessings 13:27:43 INFO - Running setup.py install for blessings 13:27:43 INFO - Successfully installed blessings 13:27:43 INFO - Cleaning up... 13:27:44 INFO - Return code: 0 13:27:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:44 INFO - Reading from file tmpfile_stdout 13:27:44 INFO - Current package versions: 13:27:44 INFO - argparse == 1.2.1 13:27:44 INFO - blessings == 1.6 13:27:44 INFO - blobuploader == 1.2.4 13:27:44 INFO - docopt == 0.6.1 13:27:44 INFO - functools32 == 3.2.3-2 13:27:44 INFO - jsonschema == 2.5.1 13:27:44 INFO - manifestparser == 1.1 13:27:44 INFO - mozInstall == 1.12 13:27:44 INFO - mozcrash == 0.17 13:27:44 INFO - mozdebug == 0.1 13:27:44 INFO - mozdevice == 0.48 13:27:44 INFO - mozfile == 1.2 13:27:44 INFO - mozhttpd == 0.7 13:27:44 INFO - mozinfo == 0.9 13:27:44 INFO - mozleak == 0.1 13:27:44 INFO - mozlog == 3.2 13:27:44 INFO - moznetwork == 0.27 13:27:44 INFO - mozprocess == 0.23 13:27:44 INFO - mozprofile == 0.28 13:27:44 INFO - mozrunner == 6.12 13:27:44 INFO - mozscreenshot == 0.1 13:27:44 INFO - mozsystemmonitor == 0.3 13:27:44 INFO - moztest == 0.7 13:27:44 INFO - mozversion == 1.4 13:27:44 INFO - psutil == 3.1.1 13:27:44 INFO - requests == 1.2.3 13:27:44 INFO - wsgiref == 0.1.2 13:27:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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')]} 13:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:44 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:44 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 13:27:44 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 13:27:44 INFO - Using env: {'DISPLAY': ':0', 13:27:44 INFO - 'HOME': '/home/cltbld', 13:27:44 INFO - 'LANG': 'en_US.UTF-8', 13:27:44 INFO - 'LANGUAGE': 'en_US:en', 13:27:44 INFO - 'LOGNAME': 'cltbld', 13:27:44 INFO - 'MAIL': '/var/mail/cltbld', 13:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:44 INFO - 'MOZ_NO_REMOTE': '1', 13:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:44 INFO - 'NO_EM_RESTART': '1', 13:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:44 INFO - 'PWD': '/builds/slave/test', 13:27:44 INFO - 'SHELL': '/bin/bash', 13:27:44 INFO - 'SHLVL': '1', 13:27:44 INFO - 'TERM': 'linux', 13:27:44 INFO - 'TMOUT': '86400', 13:27:44 INFO - 'USER': 'cltbld', 13:27:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:44 INFO - '_': '/tools/buildbot/bin/python'} 13:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 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)) 13:27:44 INFO - Cleaning up... 13:27:44 INFO - Return code: 0 13:27:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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')]} 13:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:44 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 0x17bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, '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': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', '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 13:27:44 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 13:27:44 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 13:27:44 INFO - Using env: {'DISPLAY': ':0', 13:27:44 INFO - 'HOME': '/home/cltbld', 13:27:44 INFO - 'LANG': 'en_US.UTF-8', 13:27:44 INFO - 'LANGUAGE': 'en_US:en', 13:27:44 INFO - 'LOGNAME': 'cltbld', 13:27:44 INFO - 'MAIL': '/var/mail/cltbld', 13:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:44 INFO - 'MOZ_NO_REMOTE': '1', 13:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:44 INFO - 'NO_EM_RESTART': '1', 13:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:44 INFO - 'PWD': '/builds/slave/test', 13:27:44 INFO - 'SHELL': '/bin/bash', 13:27:44 INFO - 'SHLVL': '1', 13:27:44 INFO - 'TERM': 'linux', 13:27:44 INFO - 'TMOUT': '86400', 13:27:44 INFO - 'USER': 'cltbld', 13:27:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:44 INFO - '_': '/tools/buildbot/bin/python'} 13:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:27:44 INFO - Cleaning up... 13:27:44 INFO - Return code: 0 13:27:44 INFO - Running post-action listener: _resource_record_post_action 13:27:44 INFO - Running post-action listener: _start_resource_monitoring 13:27:44 INFO - Starting resource monitoring. 13:27:44 INFO - ##### 13:27:44 INFO - ##### Finished create-virtualenv step (success) 13:27:44 INFO - ##### 13:27:44 INFO - ##### 13:27:44 INFO - ##### Running install step. 13:27:44 INFO - ##### 13:27:44 INFO - Running pre-action listener: _resource_record_pre_action 13:27:44 INFO - Running main action method: install 13:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:44 INFO - Reading from file tmpfile_stdout 13:27:44 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:44 INFO - Reading from file tmpfile_stdout 13:27:44 INFO - Output received: 13:27:44 INFO - Usage: mozinstall [options] installer 13:27:44 INFO - Options: 13:27:44 INFO - -h, --help show this help message and exit 13:27:44 INFO - -d DEST, --destination=DEST 13:27:44 INFO - Directory to install application into. [default: 13:27:44 INFO - "/builds/slave/test"] 13:27:44 INFO - --app=APP Application being installed. [default: firefox] 13:27:44 INFO - mkdir: /builds/slave/test/build/application 13:27:44 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'] 13:27:44 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 13:28:02 INFO - Reading from file tmpfile_stdout 13:28:02 INFO - Output received: 13:28:02 INFO - /builds/slave/test/build/application/firefox/firefox 13:28:02 INFO - Running post-action listener: _resource_record_post_action 13:28:02 INFO - ##### 13:28:02 INFO - ##### Finished install step (success) 13:28:02 INFO - ##### 13:28:02 INFO - ##### 13:28:02 INFO - ##### Running run-tests step. 13:28:02 INFO - ##### 13:28:02 INFO - Running pre-action listener: _resource_record_pre_action 13:28:02 INFO - Running main action method: run_tests 13:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:28:02 INFO - Python 2.7.3 13:28:02 INFO - Return code: 0 13:28:02 INFO - grabbing minidump binary from tooltool 13:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:02 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 0x1a7b3b0>, '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 0x1a7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:28:02 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 13:28:02 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 13:28:02 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 13:28:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:28:02 INFO - Return code: 0 13:28:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:28:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:28:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:28:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:28:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 13:28:02 INFO - Using env: {'DISPLAY': ':0', 13:28:02 INFO - 'HOME': '/home/cltbld', 13:28:02 INFO - 'LANG': 'en_US.UTF-8', 13:28:02 INFO - 'LANGUAGE': 'en_US:en', 13:28:02 INFO - 'LOGNAME': 'cltbld', 13:28:02 INFO - 'MAIL': '/var/mail/cltbld', 13:28:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:28:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:02 INFO - 'MOZ_NO_REMOTE': '1', 13:28:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:02 INFO - 'NO_EM_RESTART': '1', 13:28:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:02 INFO - 'PWD': '/builds/slave/test', 13:28:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:28:02 INFO - 'SHELL': '/bin/bash', 13:28:02 INFO - 'SHLVL': '1', 13:28:02 INFO - 'TERM': 'linux', 13:28:02 INFO - 'TMOUT': '86400', 13:28:02 INFO - 'USER': 'cltbld', 13:28:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468872994.394424-426034555', 13:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:02 INFO - '_': '/tools/buildbot/bin/python'} 13:28:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:28:02 INFO - mozversion application_buildid: 20160718103058 13:28:02 INFO - mozversion application_changeset: 4a992c10189fd39b2c9daeb49749127a5a2a0d7d 13:28:02 INFO - mozversion application_display_name: Nightly 13:28:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:28:02 INFO - mozversion application_name: Firefox 13:28:02 INFO - mozversion application_remotingname: firefox 13:28:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:28:02 INFO - mozversion application_vendor: Mozilla 13:28:02 INFO - mozversion application_version: 50.0a1 13:28:02 INFO - mozversion platform_buildid: 20160718103058 13:28:02 INFO - mozversion platform_changeset: 4a992c10189fd39b2c9daeb49749127a5a2a0d7d 13:28:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:28:02 INFO - mozversion platform_version: 50.0a1 13:28:02 INFO - using testdate: 1468873682 13:28:02 INFO - actual date: 1468873682 13:28:02 INFO - starting webserver on 'localhost:43735' 13:28:02 INFO - SUITE-START | Running 2 tests 13:28:02 INFO - TEST-START | dromaeo_css 13:28:02 INFO - operating with platform_type : linux_ 13:28:02 INFO - Initialising browser for dromaeo_css test... 13:28:02 INFO - TEST-INFO | started process 23374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHPFix/profile http://localhost:43735/getInfo.html) 13:28:07 INFO - PROCESS | 23374 | __metrics Screen width/height:1600/1200 13:28:07 INFO - PROCESS | 23374 | colorDepth:24 13:28:07 INFO - PROCESS | 23374 | Browser inner width/height: 1024/697 13:28:07 INFO - PROCESS | 23374 | __metrics 13:28:08 INFO - PROCESS | 23374 | 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" 13:28:08 INFO - PROCESS | 23374 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:09 INFO - TEST-INFO | 23374: exit 0 13:28:09 INFO - Browser initialized. 13:28:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:28:09 INFO - TEST-INFO | started process 23459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHPFix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:21 INFO - PROCESS | 23459 | RSS: Main: 157814784 13:28:21 INFO - PROCESS | 23459 | 13:29:12 INFO - PROCESS | 23459 | 1468873752853 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] 13:31:21 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43735/tests/dromaeo/cssquery-ext.html) 13:31:22 INFO - PROCESS | 23459 | RSS: Main: 255205376 13:31:22 INFO - PROCESS | 23459 | 13:34:24 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-ext.html (next: http://localhost:43735/tests/dromaeo/cssquery-jquery.html) 13:34:25 INFO - PROCESS | 23459 | RSS: Main: 246431744 13:34:25 INFO - PROCESS | 23459 | 13:37:27 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43735/tests/dromaeo/cssquery-mootools.html) 13:37:27 INFO - PROCESS | 23459 | RSS: Main: 243003392 13:37:27 INFO - PROCESS | 23459 | 13:40:29 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43735/tests/dromaeo/cssquery-prototype.html) 13:40:30 INFO - PROCESS | 23459 | RSS: Main: 245981184 13:40:30 INFO - PROCESS | 23459 | 13:43:33 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43735/tests/dromaeo/cssquery-yui.html) 13:43:33 INFO - PROCESS | 23459 | RSS: Main: 220430336 13:43:33 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-yui.html (next: http://localhost:43735/tests/dromaeo/cssquery-dojo.html) 13:46:36 INFO - PROCESS | 23459 | RSS: Main: 300531712 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | __start_tp_report 13:46:36 INFO - PROCESS | 23459 | _x_x_mozilla_page_load 13:46:36 INFO - PROCESS | 23459 | _x_x_mozilla_page_load_details 13:46:36 INFO - PROCESS | 23459 | |i|pagename|runs| 13:46:36 INFO - PROCESS | 23459 | |0;dojo.html;3035.5598438226457;3061.4489391909447;3085.0898984799483;3088.135322109809;3104.7671424643145;5235.895282094356;5319.468053194679;5357.91963120553;5438.428964958682;5460.6177567570285;5346.304980352558;5374.301340825697;5376.758045887935;5381.973090134544;5430.59270554708;4820.66255362124;4850.2724591311235;4899.191633380488;4911.508849115078;5037;4975.079610272093;4984.87537811554;5012.498750124976;5028.6731362461505;5045.0666626674;4817.22924332107;4828.975855120737;4866.124097662419;4880.341153944243;4891.804327826882;4864.318995340655;4890.657653964188;4902.7058376497525;4969.577585905203;5001.199808030734;4920.384951881015;4924.482929292409;4956.727379994099;4961.305417241589;5003.649744517885;5211.1922651989;5291.682499050031;5412.621116521845;5436.483534064258;5461.754221060062;5859.501942334907;5861.531077513789;5885.793997210077;5890.705464726747;5899.911501327483;5586.469285417919;5841.0362290222065;5898.528117750569;5900;5909.143174239711;5348.732563371816;5393.19102134679;5416.512513873731;5476.616636835383;5480.04099282624;5972.223610930551;5975.820725378246;5976.073708575178;5976.372480889531;5978.192943952511;5504.2294078829;5601;5747.511461525817;5772.538196944234;5775.740091695884;5811.244538210006;5824.068149096124;5826.388229235869;5828.446297601721;5829.912551311733;5694.829155125353;5743.798967036134;5754.74103665336;5759.596828221985;5763.394843541451;5566;5681.687507187145;5751.827445176651;5758.539316854725;5768.538516918637;4406.581374769392;4412.691111622155;4413.205622987893;4445.222086134913;4449.17690227309;3911.041794760302;3922.8626998054933;3937.7046721496004;3965.306071437487;3968.6626636735623;5293.126634105406;5337.172738225581;5430.619856609999;5445.83662490126;5468.671879687232;5837.67892765902;5852.765889364463;5860.970695146497;5866.325372582208;5890.293164820163;5504.697241651747;5523.558115350762;5526.723663816873;5534.335879694382;5539.9169012464845;4907.386576677915;4958.157113290749;5000;5008.69947803133;5039.092963266574;5983.940160598426;5989.670568118708;5994.28068631767;5998.340182579913;5998.4601385875485;5772.740226689725;5783.94216057834;5785.82642520725;5788.652680839163;5791.218185544897;5739.196512488172;5776.249087618751;5919.91120133207;5977.671228082497;6021.969890150521;5691.459311365414;5729.828105156852;5746.9712651436475;5755.3381361144;5756.539476841926;5611.354694210218;5809.215755873072;5825.388334225015;5826.329972053268;5827.76688932438;5567.109262517978;5589.077802162597;5628.802991895264;5636.2954630671165;5653.265075540154;5596.272484576979;5632.493075623213;5647.265855438766;5649.830505084854;5658.575606829422;5412.918806217831;5506.5870059746485;5584.636998595079;5607;5614.2701448811395;5636.802711905064;5683.090705487268;5688.232088668143;5744.167095771173;5752.9712351437975;5553.583481238842;5601.215829783915;5601.24383208278;5602.159676048625;5602.215689803512 13:46:36 INFO - PROCESS | 23459 | |1;ext.html;593.2436143916506;605.751641826851;618.6782872906086;621.3320680268712;627.259833396592;32053.19867003323;35260;43631.34552981704;44858.551414485846;44947;46464.76767616165;46841;46878.765606171924;46950;46999.53000469994;8900.777480562972;9035.367524273304;9043.050479699636;9049.321300902426;9050.909490905105;8086.959565202165;10774.892251077466;11078.501467433944;11097.611583594577;11101.888981110167;10966.561337546489;11050.447477626127;11053.723656908602;11056.11551075916;11064.114870810356;8134.267915887539;10726.839097413545;10779.353238805697;10799.028087472087;10801.675949721483;10351.844722329171;10692.144628429785;10696.518656660392;11008.39453830039;11024;43965;44329.11341773147;44349.669509914755;44388.3341749874;44417.33373999393;3393.5266090125633;3458.2219000724886;3522.2955408918065;3541.769784963969;4063.7155399122075;33357;33565.83217083923;33902.83048584766;34120.658793411996;35116;4366.694331396803;4431.180231657121;4465.307877279027;4538.931916021263;4669.136209801164;362514;363405;365985;366940;369132;34794;59245.70377148173;59335.40664593299;59747.701261493414;59807.102893456635;35420.468692969625;37344.626553734655;37360.62639373626;37369.25261494809;37401.25197496089;14431.2062836545;14587.41650333996;14597.635059123395;14599.635009124857;14600.926995364955;11334.886651133547;11444.828327575093;11851.940740296415;12017.399130043463;12031.09766767496;8266.462679925906;8366.288865446384;8411.957940210259;8484.448510846774;8502.06477287498;3221;3222.4844024955896;3238.5793392019723;3264.97571505668;3280.048785852076;1025.1286406554368;1073.5115522437272;1092.5520536579963;1107.8227483602584;1214.550616271985;33940.15149621279;34494.65505344915;34512.30975380478;34564.30871382609;34604.48093278603;1144.799660059503;1147.3689470791032;1171.016346269138;1199.0287866827898;1222.1200735470447;17368.826311736975;17738.931790529685;17947.8719894425;18211;18703.90648046751;580174;582218;586233;590285;591327;59611.70194149001;60088.69955650194;60243;60295.69852150799;60339.39660603426;1244.147758785235;1344.6033420141082;1368.7262547490343;1369.9726005479833;1384.9030567860354;33596.496052558745;34295.828520857234;34818.129546761535;34818.30363392769;34869.12827179341;50563.74718126386;51403.48596513987;51424.48575514197;51424.48575514347;51446.742766285926;459594;460256;461178;463226;463388;24097;24695.38261543476;25492;27865.86067069652;28237.294067648472;48001.51998479971;48771.3912900021;49016.50983490262;49047.754761225966;49273.753631231615;40694.18611627692;41896.581034189265;42678.359824602034;42733;42826.57173428226;41339.379909301984;41537.37693934533;41759.7912010438;41792.58207417887;42633.57366426296;41025.79487102546;41944;42087;42230;42326.576734232265;35506.46740298846;37076;37767.62232377641;37835.81082094572;37841.243175135794;28401.28996775097;28738.568921465776;28809.711902880703;28964.27589310284;29303.41393172082 13:46:36 INFO - PROCESS | 23459 | |2;jquery.html;378.1453914154011;379.96200379962005;380.8686003328851;390.20398387289913;396.922600092982;15669.451569195053;15722.449714259974;18575.761664193153;20627.896860515713;20855.895720521396;18640.440786776384;18946.336878209266;19329.516762080955;20124;20137.899310503428;5077.162268225738;5174.741262936857;5203.375594928614;5225.399079105894;5230.581553475713;3824.9043773905596;5178.300929374543;5477.589180811435;5735.1970724098655;5753.769849206048;5762.423757624246;5789.594728368995;5800.564957628174;5807.303123625171;5811.738471768759;5904;6277.843053923642;6285.120083188357;6288.276848162452;6296.811095667137;5348.438413966555;5503.752331145108;5588;5593.300837395325;5598.804041858515;12937.35313234344;12966.092373533857;12988.675283117998;13092.083554151213;15738.842611573853;2326.5579539887367;2335.7664233576675;2383.511380167062;2574.6266791315343;2604.3358943469293;9907.157891579225;9940.105390514816;9992.600295988152;10411.375317480975;10476.68569942903;1894.9621007579908;2000.8799472031724;2020.3635854705722;2034.471037530238;2035.2469586253033;84097.15902840954;87503.56248218782;87799.56100219522;87952.56023719904;90329.54835225847;10908.290961087503;10996.560137594566;11149.944250278697;11266.267692600119;11356.148288878367;15488.845111548966;15525.534233973;15625.06249625026;15639.530814075595;15659.217039147998;7899.763007109796;8099.433039687283;8134.389920755967;8182.918170818216;8219.342452603778;7702.499337543042;7732.845343093107;7784.3772498200005;7879.566623835744;7890.684372625145;4721.763911804396;4793.808247670124;4802.975985120052;4823.469418363977;4922.138625740481;1925.2395303854898;1977.3474753331654;1984.8312893404222;2020.3938818354434;2021.848361372903;887.8712586674895;932.5150921520772;1004.3170643962176;1023.82083135451;1132.2074547816562;19923.501912452306;20494.077766500246;20579.79420205809;20630.58738825245;20701.89649051745;995.3331268050424;1011.6155860772859;1026.8767747870304;1064.5316060933164;1069.534752382716;10300.587976480856;11402.543898243977;11439.771204575862;11514.30914145154;11520.769584608428;510842;515289;525914;538636;538790;97240.51379743198;97980;98270;98348.50825745969;98839;976.770458942148;993.2600212841479;1000.694788089625;1020.7295066807302;1024.9180065594735;17887.552811179823;17946.820531794514;18463.261469541067;18479.907600461913;19747.308844190386;44696.55303446924;44791.328130077425;45269.32096018628;45302.773486132355;45665;56440.717796410754;61143;61273.38726612677;62744.686276568325;62877.37122628715;8455.830883382421;8796.824063518821;8800.207981281716;8903.465792052497;8938.821223575362;9499.810003800023;12640.936795315965;13522.797158042835;13593.59219223425;14156.858431415554;11873.287602743863;12171.714154869382;12318.076144289393;12443.502259909865;12474.43865026058;12079.39603019863;12151.878481215075;12208.741382844202;12303.446344914679;12384.256944583354;12264.448099835707;12271.570495032987;12363.62909112728;12374.195677280948;12601;8439.95780021096;8552.914470855212;8584.656613735631;8681.175288347597;8748.300135988979;10911.618093366695;11805.884967019785;11964.461599227881;12091.637250882488;12190.756184876076 13:46:36 INFO - PROCESS | 23459 | |3;mootools.html;1328.8139660447532;1498.7152441036205;1520.049968769519;1612.9193540322988;1759.8856074355167;8538.743837684871;8932.24075953544;8960.14878586534;9055.04921983192;9066.09339066093;8840;9027.548622568862;9050.456972581633;9051.547422628875;9057.13957174069;1992.2329902987383;2015.707722380254;2020.8080232377974;2355.0108954239217;2386.9283921482383;2027.7465316835396;2312.375658572193;2397.436602398435;2405.855648661086;2417.419819243378;2288.668143119247;2306.9307920762403;2327.93016209514;2328.1734984080663;2328.778766017234;1961.5096225943514;2283.7259528856475;2290.4159439342943;2292.5529521743265;2292.6790249365104;2237.9888100559556;2308.1575225042907;2308.90764369425;2318.04959966413;2318.9652155217686;9009.59456824438;9053.547322633907;9058.501782401965;9060.864087038699;9071.727848164566;5283.841484755425;5356.517913387814;5408.161734931092;5411.702356370398;5412.9458705412835;3281.8523166457567;3369;3431.8284085795613;3438.9312213755584;3444.8277586120844;1088.7441451258949;1135.1486385211092;1136.4539457998894;1148.6439203846835;1158.7972104881612;12716.618501444971;12753.107282490322;12763.298018608974;12764.936175319157;12774.23354598727;4634.86445820776;4682.1103990241745;4826.758662066883;4895.412550493964;4895.510448955076;10043.397396156108;10076.244281678903;10136.797264054678;10141.645042423479;10145.03622155894;5373.247745315659;5379.220013098079;5385.542228910586;5386.703731294817;5387.299651045339;4952.579030782352;5000.924986125211;5009.499050095034;5009.7244651544515;5046.4953504649975;3771.528558930134;3785.6403641653997;3859.6333348331864;3890.6498415142205;3907.651860108258;1116.5868628607468;1127.22784892349;1136.9033632141195;1137.75538259273;1160.8897154770284;989.1147423056468;1013.381837079381;1013.8124446977333;1022.4683164754287;1026.58423338548;6349.269833969152;6403.743850246031;6417.229932408048;6475.32009139043;6507.934920650828;436.50456731609853;440.9338599210144;442.9844955426609;444.06967403290054;458.830232813861;4331.220380331571;4439.156560253541;4563.840265590688;4590.104929538707;4596.954030459719;11009.229353945148;11376.658700239006;11528.481218345194;11528.711782205344;11546.711332216762;11426;11426.25729327591;11447.37039462821;11449.313041217554;11450;7855.450118491765;8204.548749818818;8217.219364160395;8357.498550087013;8385.161483851689;6168.475679567287;6407.871842563216;6533.934660653333;6548.672566371758;6597.736090556324;10536.209784266364;10659.94670026645;10726.302790318916;10758.085562727256;10788;9440.527973601154;10290.588376464857;10386.844197336895;10968.506417211403;10989.395583242678;7552.622368881424;7720.613969301625;7721.227877212458;7732.652030658522;7760.223977602421;8838.381313308008;8896.377253592445;8911.287097032351;8913.153250441457;8923.107689231025;7865.4887432319;8031.799205019687;8116.959415203122;8125.3905957052275;8251.257386835214;7872.448928575174;7966.283034526688;7971.402144839044;8149.592520373839;8176.877346839683;7251.1298644163035;7294.1247050354295;7298.2701729826595;7305.488615796843;7307.634618269171;5440.428754980829;5504.559635229252;5508.118701007819;5577;5645.181448689999;5413.53984911287;5546.889062218814;5602.019646561754;5688.40271771458;5750.367459579359 13:46:36 INFO - PROCESS | 23459 | |4;prototype.html;300.56568258865946;306.21608681774643;315.0265679051731;322.5468217154897;324.79700187382883;5307.708076055825;5348.598855085869;5386.622936394454;5398.866238090006;5400;5021.774020169092;5144.996725638502;5177.145770947789;5179.4561571035065;5295.841124766253;4000.3399439092586;4008.118213992917;4128.2156390285745;4154.8130334134885;4191.538930717634;4130.513015314499;4134.4831896013;4144.191882582898;4151.501819781615;4158.563350848162;3928.3125453045745;4049.6152865477734;4151.3150330195485;4169.4162817205615;4197.265478541259;3900.395438707005;3993.4409182714444;4047.3726572381033;4062.7968601569805;4067.7559346439307;3538.9469157962653;3564.2336897567147;3567.928641427183;3570.321638888603;3571.1250743567994;5155.123628983082;5207.401148867891;5225.712585807779;5227.738613069369;5267.55225805807;4507.954920450787;4595.954040459586;4630.536946305376;4631;4634.844797169332;5465.426130256305;5472.589555783332;5487.780488780484;5488.7530061147345;5549.223108764776;3859.556151042638;3888.0474283800368;3890.9416358754356;3891.540672247907;3896.59085795993;5513.979913715935;5755.251817263771;5757.193992841006;5787.363390027093;5792.855178620568;3928.607139286106;3950.585188555218;3951.7233793634746;3976.071605271441;4002.2595819773437;4040.717149799486;4051.4125451809323;4051.554329023805;4055.614716601918;4060.26915155269;4517.570830771071;4657.976710116428;4666.673332866667;4677.95322046782;4750.097481478508;5608.607397482218;5627.662340259598;5637.295338082739;5682.460166284279;5684.261046063985;1396.6382776792545;1408.7323408552343;1414.6816966182528;1417.9578010162522;1419.0988722161296;847.9109693482219;887.5828360670474;902.3412908576645;906.6128822900972;912.1471424218377;4779.665423420397;4822.445418776885;4829.541193586604;4850.248211527219;4865.659403841697;5076.959223359203;5083.771230294646;5089.277236678433;5092.821751238763;5116.206987916805;4818.927716084191;4832.734199618984;5092.770825312869;5192.870178245574;5312.73436328182;3021.6676165621766;3037.179961410407;3058.235441139715;3067.8312692801665;3068.094912000965;5888.823335299948;5904.9704751475965;5920.6974465617495;5923.4076592340425;5931.258592675916;5595.608307418523;5827.825165245049;5836.795712150054;5867.266591676041;5878.353381128072;5884.823455296348;5908.261467316585;5910.674912879833;5914.172015917689;5922.911156332659;5479.3424789023975;5708.6574805510145;5723.427657234243;5769.798057067983;5777.162311464898;5726.2269593606;5749.712514374348;5760.452756988079;5775.653460792366;5780.653160810365;5963.254593175853;5977.970110149421;5992.310884248367;6049.0926361046195;6085.269767627913;3852.191039881544;4017.5580686125086;4049.3318602431445;4076.2255171517318;4082.571330010306;5705.744736158039;5776.480116789341;5783.971080144573;5790.594658373873;5820.73806678692;5687.492814404103;5699.401562836008;5712.457316554921;5712.971435142964;5717.799877004285;5517.200005999188;5616.354119276336;5638.238837757014;5639.633423827602;5646.689432081275;5290.81482148123;5508.11870100798;5515.586331025109;5528.143137813645;5587.7485513152815;5447.972760136174;5704.401037890962;5706.885862282648;5713.542916566582;5737.762272713729;5471.835844924659;5549.611527193219;5564.527015203753;5577.6653400796085;5589.329280486368 13:46:36 INFO - PROCESS | 23459 | |5;yui.html;714.8999140120387;766.8044648614602;773.3040263762613;795.2167115391342;872.2716531696032;16057.277422515986;16382.853200275986;16475.83524164758;16863.40978065768;16883.66232675349;14905.403783848633;15016.549503514885;15025;15035.54893353201;15043.849561504381;672.5124284893462;798.4730078148394;823.1069289820551;828.2173346187855;840.848647243496;829.9626516806728;834.4909605140859;837.3761547646981;837.7738010737097;838.3502785341378;703.7501686901153;878.4377998081233;889.4529864133576;890.2077151335317;890.4657205676607;848.4909054567241;867.1242045533993;868.7958329792525;872.1060912564609;874.6501399440211;633.4773811605398;638.6934271549682;638.827516570528;638.9488840892717;639.0924886660906;15385.923070384688;15492.922535387252;15521.223938803014;15531.5340539784;15538.06771593708;14556.272186390745;14601.196934168616;14624.853751462455;14764.704705905822;14786.55640330781;12899;12996.545120920722;13134.86865131346;13366;13732.65668358289;4505.977470112662;4561.384213131218;4563.087382523476;4602.861914142581;4619.976900115478;73404.63297683478;73456.26543734547;74128;74193;74295;11684.766304673858;11704.70738231534;11727.472263748152;11730.811261896699;12243.816342754866;22085.227017054327;22094.22670206535;22102;22102.668459973112;22886.198983035512;8252.33981281496;8549.786255343666;8664.436811607226;8735.65057397697;9069.77325566866;4808.110499557593;4844.15227335222;4853.39332583427;4920.852374428773;4988.950110498921;3444.190615205425;3547.3260080585123;3583.068402215443;3586.7847929124337;3594.856205751793;528.3052785586941;627.2128478759128;632.8512799492115;652.9869402611921;674.9190097188368;571.3115695586891;666.643345809999;689.6207086102623;711.5730561663064;736.3814395907464;10032;10141.391516509033;10218.131458825934;10274.383536987805;10566.207534434949;709.868674295257;731.670748163318;734.6877577029741;742.2540346951388;752.9171791102974;5038.697678139323;5164.225366195101;5192.299039629677;5199.1161502544655;5206.3752349717515;69873.65063174651;78314.60842695864;91051;119966;120911.39544302222;67495;104780;104843.47578262212;104928;107000.46499767451;69137;74134.6293268541;95623.52188239014;95647;96828.51585742168;9575.808483830146;9757.365771224848;9816.331223692132;9831.606735730777;9846.015398460097;38695;44772.55227447814;52879.206811897086;53288.73355633197;54947;66042.33957660555;67306.66346668235;67690.3230967684;68821;79458;13045.934770326088;13127.803082953955;13243.867561324263;13311.866881331063;13519.053666243663;14031.579052628438;14694.191819449605;14755.778663320274;15116.244187790786;15174.696506069597;14731.926340368229;14967.401303948156;15062;15764;15815.446459373867;14008.299585020912;14038.78941815853;14157.938154638648;14911.627209319853;14962.40150393972;14255.429782808571;14498.202598857164;14810.333534991167;14817.925910370379;15642.765358519404;10969.945150274516;11028.558857645605;11137.443127843737;11194.720131996439;11313.321200727984;11179.496922638664;11948.402579871146;12061.653971059934;12227.816582751087;12783.977281817619 13:46:36 INFO - PROCESS | 23459 | __end_tp_report 13:46:36 INFO - PROCESS | 23459 | __start_cc_report 13:46:36 INFO - PROCESS | 23459 | _x_x_mozilla_cycle_collect,868 13:46:36 INFO - PROCESS | 23459 | __end_cc_report 13:46:36 INFO - PROCESS | 23459 | __startTimestamp1468874796968__endTimestamp 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | ------- Summary: start ------- 13:46:36 INFO - PROCESS | 23459 | Number of tests: 6 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | [#0] dojo.html Cycles:165 Average:5372.46 Median:5586.47 stddev:618.40 (11.1%) stddev-sans-first:592.50 13:46:36 INFO - PROCESS | 23459 | Values: 3035.6 3061.4 3085.1 3088.1 3104.8 5235.9 5319.5 5357.9 5438.4 5460.6 5346.3 5374.3 5376.8 5382.0 5430.6 4820.7 4850.3 4899.2 4911.5 5037.0 4975.1 4984.9 5012.5 5028.7 5045.1 4817.2 4829.0 4866.1 4880.3 4891.8 4864.3 4890.7 4902.7 4969.6 5001.2 4920.4 4924.5 4956.7 4961.3 5003.6 5211.2 5291.7 5412.6 5436.5 5461.8 5859.5 5861.5 5885.8 5890.7 5899.9 5586.5 5841.0 5898.5 5900.0 5909.1 5348.7 5393.2 5416.5 5476.6 5480.0 5972.2 5975.8 5976.1 5976.4 5978.2 5504.2 5601.0 5747.5 5772.5 5775.7 5811.2 5824.1 5826.4 5828.4 5829.9 5694.8 5743.8 5754.7 5759.6 5763.4 5566.0 5681.7 5751.8 5758.5 5768.5 4406.6 4412.7 4413.2 4445.2 4449.2 3911.0 3922.9 3937.7 3965.3 3968.7 5293.1 5337.2 5430.6 5445.8 5468.7 5837.7 5852.8 5861.0 5866.3 5890.3 5504.7 5523.6 5526.7 5534.3 5539.9 4907.4 4958.2 5000.0 5008.7 5039.1 5983.9 5989.7 5994.3 5998.3 5998.5 5772.7 5783.9 5785.8 5788.7 5791.2 5739.2 5776.2 5919.9 5977.7 6022.0 5691.5 5729.8 5747.0 5755.3 5756.5 5611.4 5809.2 5825.4 5826.3 5827.8 5567.1 5589.1 5628.8 5636.3 5653.3 5596.3 5632.5 5647.3 5649.8 5658.6 5412.9 5506.6 5584.6 5607.0 5614.3 5636.8 5683.1 5688.2 5744.2 5753.0 5553.6 5601.2 5601.2 5602.2 5602.2 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | [#1] ext.html Cycles:180 Average:62135.87 Median:368036.00 stddev:127619.62 (34.7%) stddev-sans-first:127893.97 13:46:36 INFO - PROCESS | 23459 | Values: 593.2 605.8 618.7 621.3 627.3 32053.2 35260.0 43631.3 44858.6 44947.0 46464.8 46841.0 46878.8 46950.0 46999.5 8900.8 9035.4 9043.1 9049.3 9050.9 8087.0 10774.9 11078.5 11097.6 11101.9 10966.6 11050.4 11053.7 11056.1 11064.1 8134.3 10726.8 10779.4 10799.0 10801.7 10351.8 10692.1 10696.5 11008.4 11024.0 43965.0 44329.1 44349.7 44388.3 44417.3 3393.5 3458.2 3522.3 3541.8 4063.7 33357.0 33565.8 33902.8 34120.7 35116.0 4366.7 4431.2 4465.3 4538.9 4669.1 362514.0 363405.0 365985.0 366940.0 369132.0 34794.0 59245.7 59335.4 59747.7 59807.1 35420.5 37344.6 37360.6 37369.3 37401.3 14431.2 14587.4 14597.6 14599.6 14600.9 11334.9 11444.8 11851.9 12017.4 12031.1 8266.5 8366.3 8412.0 8484.4 8502.1 3221.0 3222.5 3238.6 3265.0 3280.0 1025.1 1073.5 1092.6 1107.8 1214.6 33940.2 34494.7 34512.3 34564.3 34604.5 1144.8 1147.4 1171.0 1199.0 1222.1 17368.8 17738.9 17947.9 18211.0 18703.9 580174.0 582218.0 586233.0 590285.0 591327.0 59611.7 60088.7 60243.0 60295.7 60339.4 1244.1 1344.6 1368.7 1370.0 1384.9 33596.5 34295.8 34818.1 34818.3 34869.1 50563.7 51403.5 51424.5 51424.5 51446.7 459594.0 460256.0 461178.0 463226.0 463388.0 24097.0 24695.4 25492.0 27865.9 28237.3 48001.5 48771.4 49016.5 49047.8 49273.8 40694.2 41896.6 42678.4 42733.0 42826.6 41339.4 41537.4 41759.8 41792.6 42633.6 41025.8 41944.0 42087.0 42230.0 42326.6 35506.5 37076.0 37767.6 37835.8 37841.2 28401.3 28738.6 28809.7 28964.3 29303.4 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | [#2] jquery.html Cycles:180 Average:30364.93 Median:1491.24 stddev:86851.54 (5824.1%) stddev-sans-first:87066.00 13:46:36 INFO - PROCESS | 23459 | Values: 378.1 380.0 380.9 390.2 396.9 15669.5 15722.4 18575.8 20627.9 20855.9 18640.4 18946.3 19329.5 20124.0 20137.9 5077.2 5174.7 5203.4 5225.4 5230.6 3824.9 5178.3 5477.6 5735.2 5753.8 5762.4 5789.6 5800.6 5807.3 5811.7 5904.0 6277.8 6285.1 6288.3 6296.8 5348.4 5503.8 5588.0 5593.3 5598.8 12937.4 12966.1 12988.7 13092.1 15738.8 2326.6 2335.8 2383.5 2574.6 2604.3 9907.2 9940.1 9992.6 10411.4 10476.7 1895.0 2000.9 2020.4 2034.5 2035.2 84097.2 87503.6 87799.6 87952.6 90329.5 10908.3 10996.6 11149.9 11266.3 11356.1 15488.8 15525.5 15625.1 15639.5 15659.2 7899.8 8099.4 8134.4 8182.9 8219.3 7702.5 7732.8 7784.4 7879.6 7890.7 4721.8 4793.8 4803.0 4823.5 4922.1 1925.2 1977.3 1984.8 2020.4 2021.8 887.9 932.5 1004.3 1023.8 1132.2 19923.5 20494.1 20579.8 20630.6 20701.9 995.3 1011.6 1026.9 1064.5 1069.5 10300.6 11402.5 11439.8 11514.3 11520.8 510842.0 515289.0 525914.0 538636.0 538790.0 97240.5 97980.0 98270.0 98348.5 98839.0 976.8 993.3 1000.7 1020.7 1024.9 17887.6 17946.8 18463.3 18479.9 19747.3 44696.6 44791.3 45269.3 45302.8 45665.0 56440.7 61143.0 61273.4 62744.7 62877.4 8455.8 8796.8 8800.2 8903.5 8938.8 9499.8 12640.9 13522.8 13593.6 14156.9 11873.3 12171.7 12318.1 12443.5 12474.4 12079.4 12151.9 12208.7 12303.4 12384.3 12264.4 12271.6 12363.6 12374.2 12601.0 8440.0 8552.9 8584.7 8681.2 8748.3 10911.6 11805.9 11964.5 12091.6 12190.8 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | [#3] mootools.html Cycles:180 Average:5968.14 Median:2524.47 stddev:3453.41 (136.8%) stddev-sans-first:3445.49 13:46:36 INFO - PROCESS | 23459 | Values: 1328.8 1498.7 1520.0 1612.9 1759.9 8538.7 8932.2 8960.1 9055.0 9066.1 8840.0 9027.5 9050.5 9051.5 9057.1 1992.2 2015.7 2020.8 2355.0 2386.9 2027.7 2312.4 2397.4 2405.9 2417.4 2288.7 2306.9 2327.9 2328.2 2328.8 1961.5 2283.7 2290.4 2292.6 2292.7 2238.0 2308.2 2308.9 2318.0 2319.0 9009.6 9053.5 9058.5 9060.9 9071.7 5283.8 5356.5 5408.2 5411.7 5412.9 3281.9 3369.0 3431.8 3438.9 3444.8 1088.7 1135.1 1136.5 1148.6 1158.8 12716.6 12753.1 12763.3 12764.9 12774.2 4634.9 4682.1 4826.8 4895.4 4895.5 10043.4 10076.2 10136.8 10141.6 10145.0 5373.2 5379.2 5385.5 5386.7 5387.3 4952.6 5000.9 5009.5 5009.7 5046.5 3771.5 3785.6 3859.6 3890.6 3907.7 1116.6 1127.2 1136.9 1137.8 1160.9 989.1 1013.4 1013.8 1022.5 1026.6 6349.3 6403.7 6417.2 6475.3 6507.9 436.5 440.9 443.0 444.1 458.8 4331.2 4439.2 4563.8 4590.1 4597.0 11009.2 11376.7 11528.5 11528.7 11546.7 11426.0 11426.3 11447.4 11449.3 11450.0 7855.5 8204.5 8217.2 8357.5 8385.2 6168.5 6407.9 6533.9 6548.7 6597.7 10536.2 10659.9 10726.3 10758.1 10788.0 9440.5 10290.6 10386.8 10968.5 10989.4 7552.6 7720.6 7721.2 7732.7 7760.2 8838.4 8896.4 8911.3 8913.2 8923.1 7865.5 8031.8 8117.0 8125.4 8251.3 7872.4 7966.3 7971.4 8149.6 8176.9 7251.1 7294.1 7298.3 7305.5 7307.6 5440.4 5504.6 5508.1 5577.0 5645.2 5413.5 5546.9 5602.0 5688.4 5750.4 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | [#4] prototype.html Cycles:180 Average:4644.83 Median:5226.73 stddev:1390.96 (26.6%) stddev-sans-first:1356.10 13:46:36 INFO - PROCESS | 23459 | Values: 300.6 306.2 315.0 322.5 324.8 5307.7 5348.6 5386.6 5398.9 5400.0 5021.8 5145.0 5177.1 5179.5 5295.8 4000.3 4008.1 4128.2 4154.8 4191.5 4130.5 4134.5 4144.2 4151.5 4158.6 3928.3 4049.6 4151.3 4169.4 4197.3 3900.4 3993.4 4047.4 4062.8 4067.8 3538.9 3564.2 3567.9 3570.3 3571.1 5155.1 5207.4 5225.7 5227.7 5267.6 4508.0 4596.0 4630.5 4631.0 4634.8 5465.4 5472.6 5487.8 5488.8 5549.2 3859.6 3888.0 3890.9 3891.5 3896.6 5514.0 5755.3 5757.2 5787.4 5792.9 3928.6 3950.6 3951.7 3976.1 4002.3 4040.7 4051.4 4051.6 4055.6 4060.3 4517.6 4658.0 4666.7 4678.0 4750.1 5608.6 5627.7 5637.3 5682.5 5684.3 1396.6 1408.7 1414.7 1418.0 1419.1 847.9 887.6 902.3 906.6 912.1 4779.7 4822.4 4829.5 4850.2 4865.7 5077.0 5083.8 5089.3 5092.8 5116.2 4818.9 4832.7 5092.8 5192.9 5312.7 3021.7 3037.2 3058.2 3067.8 3068.1 5888.8 5905.0 5920.7 5923.4 5931.3 5595.6 5827.8 5836.8 5867.3 5878.4 5884.8 5908.3 5910.7 5914.2 5922.9 5479.3 5708.7 5723.4 5769.8 5777.2 5726.2 5749.7 5760.5 5775.7 5780.7 5963.3 5978.0 5992.3 6049.1 6085.3 3852.2 4017.6 4049.3 4076.2 4082.6 5705.7 5776.5 5784.0 5790.6 5820.7 5687.5 5699.4 5712.5 5713.0 5717.8 5517.2 5616.4 5638.2 5639.6 5646.7 5290.8 5508.1 5515.6 5528.1 5587.7 5448.0 5704.4 5706.9 5713.5 5737.8 5471.8 5549.6 5564.5 5577.7 5589.3 13:46:36 INFO - PROCESS | 23459 | 13:46:36 INFO - PROCESS | 23459 | [#5] yui.html Cycles:180 Average:20307.57 Median:4582.97 stddev:28191.03 (615.1%) stddev-sans-first:28231.73 13:46:36 INFO - PROCESS | 23459 | Values: 714.9 766.8 773.3 795.2 872.3 16057.3 16382.9 16475.8 16863.4 16883.7 14905.4 15016.5 15025.0 15035.5 15043.8 672.5 798.5 823.1 828.2 840.8 830.0 834.5 837.4 837.8 838.4 703.8 878.4 889.5 890.2 890.5 848.5 867.1 868.8 872.1 874.7 633.5 638.7 638.8 638.9 639.1 15385.9 15492.9 15521.2 15531.5 15538.1 14556.3 14601.2 14624.9 14764.7 14786.6 12899.0 12996.5 13134.9 13366.0 13732.7 4506.0 4561.4 4563.1 4602.9 4620.0 73404.6 73456.3 74128.0 74193.0 74295.0 11684.8 11704.7 11727.5 11730.8 12243.8 22085.2 22094.2 22102.0 22102.7 22886.2 8252.3 8549.8 8664.4 8735.7 9069.8 4808.1 4844.2 4853.4 4920.9 4989.0 3444.2 3547.3 3583.1 3586.8 3594.9 528.3 627.2 632.9 653.0 674.9 571.3 666.6 689.6 711.6 736.4 10032.0 10141.4 10218.1 10274.4 10566.2 709.9 731.7 734.7 742.3 752.9 5038.7 5164.2 5192.3 5199.1 5206.4 69873.7 78314.6 91051.0 119966.0 120911.4 67495.0 104780.0 104843.5 104928.0 107000.5 69137.0 74134.6 95623.5 95647.0 96828.5 9575.8 9757.4 9816.3 9831.6 9846.0 38695.0 44772.6 52879.2 53288.7 54947.0 66042.3 67306.7 67690.3 68821.0 79458.0 13045.9 13127.8 13243.9 13311.9 13519.1 14031.6 14694.2 14755.8 15116.2 15174.7 14731.9 14967.4 15062.0 15764.0 15815.4 14008.3 14038.8 14157.9 14911.6 14962.4 14255.4 14498.2 14810.3 14817.9 15642.8 10969.9 11028.6 11137.4 11194.7 11313.3 11179.5 11948.4 12061.7 12227.8 12784.0 13:46:36 INFO - PROCESS | 23459 | -------- Summary: end -------- 13:46:36 INFO - PROCESS | 23459 | 13:46:37 INFO - TEST-INFO | 23459: exit 0 13:46:37 INFO - TEST-OK | dromaeo_css | took 1114820ms 13:46:37 INFO - TEST-START | kraken 13:46:37 INFO - operating with platform_type : linux_ 13:46:37 INFO - Initialising browser for kraken test... 13:46:37 INFO - TEST-INFO | started process 23651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdswK2f/profile http://localhost:43735/getInfo.html) 13:46:42 INFO - PROCESS | 23651 | __metrics Screen width/height:1600/1200 13:46:42 INFO - PROCESS | 23651 | colorDepth:24 13:46:42 INFO - PROCESS | 23651 | Browser inner width/height: 1024/697 13:46:42 INFO - PROCESS | 23651 | __metrics 13:46:43 INFO - PROCESS | 23651 | 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" 13:46:43 INFO - PROCESS | 23651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:44 INFO - TEST-INFO | 23651: exit 0 13:46:44 INFO - Browser initialized. 13:46:44 INFO - Running cycle 1/1 for kraken test... 13:46:44 INFO - TEST-INFO | started process 23733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdswK2f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:56 INFO - PROCESS | 23733 | RSS: Main: 157683712 13:46:56 INFO - PROCESS | 23733 | 13:46:58 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-beat-detection) 13:46:59 INFO - PROCESS | 23733 | RSS: Main: 217354240 13:46:59 INFO - PROCESS | 23733 | 13:47:02 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-dft) 13:47:02 INFO - PROCESS | 23733 | RSS: Main: 206147584 13:47:02 INFO - PROCESS | 23733 | 13:47:05 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-fft) 13:47:06 INFO - PROCESS | 23733 | RSS: Main: 270245888 13:47:06 INFO - PROCESS | 23733 | 13:47:08 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-oscillator) 13:47:09 INFO - PROCESS | 23733 | RSS: Main: 180793344 13:47:09 INFO - PROCESS | 23733 | 13:47:11 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:11 INFO - PROCESS | 23733 | RSS: Main: 184356864 13:47:11 INFO - PROCESS | 23733 | 13:47:14 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43735/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:15 INFO - PROCESS | 23733 | RSS: Main: 219717632 13:47:15 INFO - PROCESS | 23733 | 13:47:18 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43735/tests/kraken/driver.html?testName=imaging-desaturate) 13:47:19 INFO - PROCESS | 23733 | RSS: Main: 221585408 13:47:19 INFO - PROCESS | 23733 | 13:47:22 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43735/tests/kraken/driver.html?testName=json-parse-financial) 13:47:22 INFO - PROCESS | 23733 | RSS: Main: 221921280 13:47:22 INFO - PROCESS | 23733 | 13:47:24 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:47:24 INFO - PROCESS | 23733 | RSS: Main: 210157568 13:47:24 INFO - PROCESS | 23733 | 13:47:26 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:27 INFO - PROCESS | 23733 | RSS: Main: 214183936 13:47:27 INFO - PROCESS | 23733 | 13:47:29 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:30 INFO - PROCESS | 23733 | RSS: Main: 214859776 13:47:30 INFO - PROCESS | 23733 | 13:47:32 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:33 INFO - PROCESS | 23733 | RSS: Main: 225792000 13:47:33 INFO - PROCESS | 23733 | 13:47:35 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:36 INFO - PROCESS | 23733 | RSS: Main: 226250752 13:47:36 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43735/tests/kraken/driver.html?testName=ai-astar) 13:47:38 INFO - PROCESS | 23733 | RSS: Main: 267968512 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | __start_tp_report 13:47:38 INFO - PROCESS | 23733 | _x_x_mozilla_page_load 13:47:38 INFO - PROCESS | 23733 | _x_x_mozilla_page_load_details 13:47:38 INFO - PROCESS | 23733 | |i|pagename|runs| 13:47:38 INFO - PROCESS | 23733 | |0;ai-astar;100;110;110;109;110;109;109;110;112;109 13:47:38 INFO - PROCESS | 23733 | |1;audio-beat-detection;146;117;120;180;129;121;152;125;155;117 13:47:38 INFO - PROCESS | 23733 | |2;audio-dft;162;162;161;160;162;160;169;162;163;168 13:47:38 INFO - PROCESS | 23733 | |3;audio-fft;74;74;76;122;76;77;74;74;117;75 13:47:38 INFO - PROCESS | 23733 | |4;audio-oscillator;84;84;108;83;83;83;124;83;83;131 13:47:38 INFO - PROCESS | 23733 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;118;117 13:47:38 INFO - PROCESS | 23733 | |6;imaging-darkroom;146;146;145;145;146;145;145;146;145;145 13:47:38 INFO - PROCESS | 23733 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 13:47:38 INFO - PROCESS | 23733 | |8;json-parse-financial;52;51;52;52;55;53;51;50;51;51 13:47:38 INFO - PROCESS | 23733 | |9;json-stringify-tinderbox;63;63;61;63;62;62;63;63;62;63 13:47:38 INFO - PROCESS | 23733 | |10;stanford-crypto-aes;84;75;75;75;76;77;76;74;75;79 13:47:38 INFO - PROCESS | 23733 | |11;stanford-crypto-ccm;118;118;118;127;123;123;120;129;167;118 13:47:38 INFO - PROCESS | 23733 | |12;stanford-crypto-pbkdf2;165;157;154;156;156;161;158;162;158;159 13:47:38 INFO - PROCESS | 23733 | |13;stanford-crypto-sha256-iterative;63;64;64;61;62;62;63;62;62;66 13:47:38 INFO - PROCESS | 23733 | __end_tp_report 13:47:38 INFO - PROCESS | 23733 | __start_cc_report 13:47:38 INFO - PROCESS | 23733 | _x_x_mozilla_cycle_collect,1682 13:47:38 INFO - PROCESS | 23733 | __end_cc_report 13:47:38 INFO - PROCESS | 23733 | __startTimestamp1468874858287__endTimestamp 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | ------- Summary: start ------- 13:47:38 INFO - PROCESS | 23733 | Number of tests: 14 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.22 (2.9%) stddev-sans-first:0.97 13:47:38 INFO - PROCESS | 23733 | Values: 100.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 112.0 109.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:137.50 stddev:21.15 (15.4%) stddev-sans-first:22.13 13:47:38 INFO - PROCESS | 23733 | Values: 146.0 117.0 120.0 180.0 129.0 121.0 152.0 125.0 155.0 117.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:3.11 (1.9%) stddev-sans-first:3.28 13:47:38 INFO - PROCESS | 23733 | Values: 162.0 162.0 161.0 160.0 162.0 160.0 169.0 162.0 163.0 168.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#3] audio-fft Cycles:10 Average:83.90 Median:74.50 stddev:18.83 (25.3%) stddev-sans-first:19.63 13:47:38 INFO - PROCESS | 23733 | Values: 74.0 74.0 76.0 122.0 76.0 77.0 74.0 74.0 117.0 75.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.00 stddev:19.05 (23.0%) stddev-sans-first:19.82 13:47:38 INFO - PROCESS | 23733 | Values: 84.0 84.0 108.0 83.0 83.0 83.0 124.0 83.0 83.0 131.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 13:47:38 INFO - PROCESS | 23733 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:47:38 INFO - PROCESS | 23733 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:47:38 INFO - PROCESS | 23733 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.40 (2.7%) stddev-sans-first:1.48 13:47:38 INFO - PROCESS | 23733 | Values: 52.0 51.0 52.0 52.0 55.0 53.0 51.0 50.0 51.0 51.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 13:47:38 INFO - PROCESS | 23733 | Values: 63.0 63.0 61.0 63.0 62.0 62.0 63.0 63.0 62.0 63.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.95 (3.9%) stddev-sans-first:1.48 13:47:38 INFO - PROCESS | 23733 | Values: 84.0 75.0 75.0 75.0 76.0 77.0 76.0 74.0 75.0 79.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:123.00 stddev:14.91 (12.1%) stddev-sans-first:15.52 13:47:38 INFO - PROCESS | 23733 | Values: 118.0 118.0 118.0 127.0 123.0 123.0 120.0 129.0 167.0 118.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.50 stddev:3.27 (2.1%) stddev-sans-first:2.52 13:47:38 INFO - PROCESS | 23733 | Values: 165.0 157.0 154.0 156.0 156.0 161.0 158.0 162.0 158.0 159.0 13:47:38 INFO - PROCESS | 23733 | 13:47:38 INFO - PROCESS | 23733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.54 13:47:38 INFO - PROCESS | 23733 | Values: 63.0 64.0 64.0 61.0 62.0 62.0 63.0 62.0 62.0 66.0 13:47:38 INFO - PROCESS | 23733 | -------- Summary: end -------- 13:47:38 INFO - PROCESS | 23733 | 13:47:39 INFO - TEST-INFO | 23733: exit 0 13:47:39 INFO - TEST-OK | kraken | took 61534ms 13:47:39 INFO - SUITE-END | took 1176s 13:47:39 INFO - Completed test suite (00:19:36) 13:47:39 INFO - javascript benchmark 13:47:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.5598438226457, 3061.4489391909447, 3085.0898984799483, 3088.135322109809, 3104.7671424643145, 5235.895282094356, 5319.468053194679, 5357.91963120553, 5438.428964958682, 5460.6177567570285, 5346.304980352558, 5374.301340825697, 5376.758045887935, 5381.973090134544, 5430.59270554708, 4820.66255362124, 4850.2724591311235, 4899.191633380488, 4911.508849115078, 5037.0, 4975.079610272093, 4984.87537811554, 5012.498750124976, 5028.6731362461505, 5045.0666626674, 4817.22924332107, 4828.975855120737, 4866.124097662419, 4880.341153944243, 4891.804327826882, 4864.318995340655, 4890.657653964188, 4902.7058376497525, 4969.577585905203, 5001.199808030734, 4920.384951881015, 4924.482929292409, 4956.727379994099, 4961.305417241589, 5003.649744517885, 5211.1922651989, 5291.682499050031, 5412.621116521845, 5436.483534064258, 5461.754221060062, 5859.501942334907, 5861.531077513789, 5885.793997210077, 5890.705464726747, 5899.911501327483, 5586.469285417919, 5841.0362290222065, 5898.528117750569, 5900.0, 5909.143174239711, 5348.732563371816, 5393.19102134679, 5416.512513873731, 5476.616636835383, 5480.04099282624, 5972.223610930551, 5975.820725378246, 5976.073708575178, 5976.372480889531, 5978.192943952511, 5504.2294078829, 5601.0, 5747.511461525817, 5772.538196944234, 5775.740091695884, 5811.244538210006, 5824.068149096124, 5826.388229235869, 5828.446297601721, 5829.912551311733, 5694.829155125353, 5743.798967036134, 5754.74103665336, 5759.596828221985, 5763.394843541451, 5566.0, 5681.687507187145, 5751.827445176651, 5758.539316854725, 5768.538516918637, 4406.581374769392, 4412.691111622155, 4413.205622987893, 4445.222086134913, 4449.17690227309, 3911.041794760302, 3922.8626998054933, 3937.7046721496004, 3965.306071437487, 3968.6626636735623, 5293.126634105406, 5337.172738225581, 5430.619856609999, 5445.83662490126, 5468.671879687232, 5837.67892765902, 5852.765889364463, 5860.970695146497, 5866.325372582208, 5890.293164820163, 5504.697241651747, 5523.558115350762, 5526.723663816873, 5534.335879694382, 5539.9169012464845, 4907.386576677915, 4958.157113290749, 5000.0, 5008.69947803133, 5039.092963266574, 5983.940160598426, 5989.670568118708, 5994.28068631767, 5998.340182579913, 5998.4601385875485, 5772.740226689725, 5783.94216057834, 5785.82642520725, 5788.652680839163, 5791.218185544897, 5739.196512488172, 5776.249087618751, 5919.91120133207, 5977.671228082497, 6021.969890150521, 5691.459311365414, 5729.828105156852, 5746.9712651436475, 5755.3381361144, 5756.539476841926, 5611.354694210218, 5809.215755873072, 5825.388334225015, 5826.329972053268, 5827.76688932438, 5567.109262517978, 5589.077802162597, 5628.802991895264, 5636.2954630671165, 5653.265075540154, 5596.272484576979, 5632.493075623213, 5647.265855438766, 5649.830505084854, 5658.575606829422, 5412.918806217831, 5506.5870059746485, 5584.636998595079, 5607.0, 5614.2701448811395, 5636.802711905064, 5683.090705487268, 5688.232088668143, 5744.167095771173, 5752.9712351437975, 5553.583481238842, 5601.215829783915, 5601.24383208278, 5602.159676048625, 5602.215689803512], "value": 5329.864193397752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2436143916506, 605.751641826851, 618.6782872906086, 621.3320680268712, 627.259833396592, 32053.19867003323, 35260.0, 43631.34552981704, 44858.551414485846, 44947.0, 46464.76767616165, 46841.0, 46878.765606171924, 46950.0, 46999.53000469994, 8900.777480562972, 9035.367524273304, 9043.050479699636, 9049.321300902426, 9050.909490905105, 8086.959565202165, 10774.892251077466, 11078.501467433944, 11097.611583594577, 11101.888981110167, 10966.561337546489, 11050.447477626127, 11053.723656908602, 11056.11551075916, 11064.114870810356, 8134.267915887539, 10726.839097413545, 10779.353238805697, 10799.028087472087, 10801.675949721483, 10351.844722329171, 10692.144628429785, 10696.518656660392, 11008.39453830039, 11024.0, 43965.0, 44329.11341773147, 44349.669509914755, 44388.3341749874, 44417.33373999393, 3393.5266090125633, 3458.2219000724886, 3522.2955408918065, 3541.769784963969, 4063.7155399122075, 33357.0, 33565.83217083923, 33902.83048584766, 34120.658793411996, 35116.0, 4366.694331396803, 4431.180231657121, 4465.307877279027, 4538.931916021263, 4669.136209801164, 362514.0, 363405.0, 365985.0, 366940.0, 369132.0, 34794.0, 59245.70377148173, 59335.40664593299, 59747.701261493414, 59807.102893456635, 35420.468692969625, 37344.626553734655, 37360.62639373626, 37369.25261494809, 37401.25197496089, 14431.2062836545, 14587.41650333996, 14597.635059123395, 14599.635009124857, 14600.926995364955, 11334.886651133547, 11444.828327575093, 11851.940740296415, 12017.399130043463, 12031.09766767496, 8266.462679925906, 8366.288865446384, 8411.957940210259, 8484.448510846774, 8502.06477287498, 3221.0, 3222.4844024955896, 3238.5793392019723, 3264.97571505668, 3280.048785852076, 1025.1286406554368, 1073.5115522437272, 1092.5520536579963, 1107.8227483602584, 1214.550616271985, 33940.15149621279, 34494.65505344915, 34512.30975380478, 34564.30871382609, 34604.48093278603, 1144.799660059503, 1147.3689470791032, 1171.016346269138, 1199.0287866827898, 1222.1200735470447, 17368.826311736975, 17738.931790529685, 17947.8719894425, 18211.0, 18703.90648046751, 580174.0, 582218.0, 586233.0, 590285.0, 591327.0, 59611.70194149001, 60088.69955650194, 60243.0, 60295.69852150799, 60339.39660603426, 1244.147758785235, 1344.6033420141082, 1368.7262547490343, 1369.9726005479833, 1384.9030567860354, 33596.496052558745, 34295.828520857234, 34818.129546761535, 34818.30363392769, 34869.12827179341, 50563.74718126386, 51403.48596513987, 51424.48575514197, 51424.48575514347, 51446.742766285926, 459594.0, 460256.0, 461178.0, 463226.0, 463388.0, 24097.0, 24695.38261543476, 25492.0, 27865.86067069652, 28237.294067648472, 48001.51998479971, 48771.3912900021, 49016.50983490262, 49047.754761225966, 49273.753631231615, 40694.18611627692, 41896.581034189265, 42678.359824602034, 42733.0, 42826.57173428226, 41339.379909301984, 41537.37693934533, 41759.7912010438, 41792.58207417887, 42633.57366426296, 41025.79487102546, 41944.0, 42087.0, 42230.0, 42326.576734232265, 35506.46740298846, 37076.0, 37767.62232377641, 37835.81082094572, 37841.243175135794, 28401.28996775097, 28738.568921465776, 28809.711902880703, 28964.27589310284, 29303.41393172082], "value": 19624.675048529007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1453914154011, 379.96200379962005, 380.8686003328851, 390.20398387289913, 396.922600092982, 15669.451569195053, 15722.449714259974, 18575.761664193153, 20627.896860515713, 20855.895720521396, 18640.440786776384, 18946.336878209266, 19329.516762080955, 20124.0, 20137.899310503428, 5077.162268225738, 5174.741262936857, 5203.375594928614, 5225.399079105894, 5230.581553475713, 3824.9043773905596, 5178.300929374543, 5477.589180811435, 5735.1970724098655, 5753.769849206048, 5762.423757624246, 5789.594728368995, 5800.564957628174, 5807.303123625171, 5811.738471768759, 5904.0, 6277.843053923642, 6285.120083188357, 6288.276848162452, 6296.811095667137, 5348.438413966555, 5503.752331145108, 5588.0, 5593.300837395325, 5598.804041858515, 12937.35313234344, 12966.092373533857, 12988.675283117998, 13092.083554151213, 15738.842611573853, 2326.5579539887367, 2335.7664233576675, 2383.511380167062, 2574.6266791315343, 2604.3358943469293, 9907.157891579225, 9940.105390514816, 9992.600295988152, 10411.375317480975, 10476.68569942903, 1894.9621007579908, 2000.8799472031724, 2020.3635854705722, 2034.471037530238, 2035.2469586253033, 84097.15902840954, 87503.56248218782, 87799.56100219522, 87952.56023719904, 90329.54835225847, 10908.290961087503, 10996.560137594566, 11149.944250278697, 11266.267692600119, 11356.148288878367, 15488.845111548966, 15525.534233973, 15625.06249625026, 15639.530814075595, 15659.217039147998, 7899.763007109796, 8099.433039687283, 8134.389920755967, 8182.918170818216, 8219.342452603778, 7702.499337543042, 7732.845343093107, 7784.3772498200005, 7879.566623835744, 7890.684372625145, 4721.763911804396, 4793.808247670124, 4802.975985120052, 4823.469418363977, 4922.138625740481, 1925.2395303854898, 1977.3474753331654, 1984.8312893404222, 2020.3938818354434, 2021.848361372903, 887.8712586674895, 932.5150921520772, 1004.3170643962176, 1023.82083135451, 1132.2074547816562, 19923.501912452306, 20494.077766500246, 20579.79420205809, 20630.58738825245, 20701.89649051745, 995.3331268050424, 1011.6155860772859, 1026.8767747870304, 1064.5316060933164, 1069.534752382716, 10300.587976480856, 11402.543898243977, 11439.771204575862, 11514.30914145154, 11520.769584608428, 510842.0, 515289.0, 525914.0, 538636.0, 538790.0, 97240.51379743198, 97980.0, 98270.0, 98348.50825745969, 98839.0, 976.770458942148, 993.2600212841479, 1000.694788089625, 1020.7295066807302, 1024.9180065594735, 17887.552811179823, 17946.820531794514, 18463.261469541067, 18479.907600461913, 19747.308844190386, 44696.55303446924, 44791.328130077425, 45269.32096018628, 45302.773486132355, 45665.0, 56440.717796410754, 61143.0, 61273.38726612677, 62744.686276568325, 62877.37122628715, 8455.830883382421, 8796.824063518821, 8800.207981281716, 8903.465792052497, 8938.821223575362, 9499.810003800023, 12640.936795315965, 13522.797158042835, 13593.59219223425, 14156.858431415554, 11873.287602743863, 12171.714154869382, 12318.076144289393, 12443.502259909865, 12474.43865026058, 12079.39603019863, 12151.878481215075, 12208.741382844202, 12303.446344914679, 12384.256944583354, 12264.448099835707, 12271.570495032987, 12363.62909112728, 12374.195677280948, 12601.0, 8439.95780021096, 8552.914470855212, 8584.656613735631, 8681.175288347597, 8748.300135988979, 10911.618093366695, 11805.884967019785, 11964.461599227881, 12091.637250882488, 12190.756184876076], "value": 9245.319663308912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.8139660447532, 1498.7152441036205, 1520.049968769519, 1612.9193540322988, 1759.8856074355167, 8538.743837684871, 8932.24075953544, 8960.14878586534, 9055.04921983192, 9066.09339066093, 8840.0, 9027.548622568862, 9050.456972581633, 9051.547422628875, 9057.13957174069, 1992.2329902987383, 2015.707722380254, 2020.8080232377974, 2355.0108954239217, 2386.9283921482383, 2027.7465316835396, 2312.375658572193, 2397.436602398435, 2405.855648661086, 2417.419819243378, 2288.668143119247, 2306.9307920762403, 2327.93016209514, 2328.1734984080663, 2328.778766017234, 1961.5096225943514, 2283.7259528856475, 2290.4159439342943, 2292.5529521743265, 2292.6790249365104, 2237.9888100559556, 2308.1575225042907, 2308.90764369425, 2318.04959966413, 2318.9652155217686, 9009.59456824438, 9053.547322633907, 9058.501782401965, 9060.864087038699, 9071.727848164566, 5283.841484755425, 5356.517913387814, 5408.161734931092, 5411.702356370398, 5412.9458705412835, 3281.8523166457567, 3369.0, 3431.8284085795613, 3438.9312213755584, 3444.8277586120844, 1088.7441451258949, 1135.1486385211092, 1136.4539457998894, 1148.6439203846835, 1158.7972104881612, 12716.618501444971, 12753.107282490322, 12763.298018608974, 12764.936175319157, 12774.23354598727, 4634.86445820776, 4682.1103990241745, 4826.758662066883, 4895.412550493964, 4895.510448955076, 10043.397396156108, 10076.244281678903, 10136.797264054678, 10141.645042423479, 10145.03622155894, 5373.247745315659, 5379.220013098079, 5385.542228910586, 5386.703731294817, 5387.299651045339, 4952.579030782352, 5000.924986125211, 5009.499050095034, 5009.7244651544515, 5046.4953504649975, 3771.528558930134, 3785.6403641653997, 3859.6333348331864, 3890.6498415142205, 3907.651860108258, 1116.5868628607468, 1127.22784892349, 1136.9033632141195, 1137.75538259273, 1160.8897154770284, 989.1147423056468, 1013.381837079381, 1013.8124446977333, 1022.4683164754287, 1026.58423338548, 6349.269833969152, 6403.743850246031, 6417.229932408048, 6475.32009139043, 6507.934920650828, 436.50456731609853, 440.9338599210144, 442.9844955426609, 444.06967403290054, 458.830232813861, 4331.220380331571, 4439.156560253541, 4563.840265590688, 4590.104929538707, 4596.954030459719, 11009.229353945148, 11376.658700239006, 11528.481218345194, 11528.711782205344, 11546.711332216762, 11426.0, 11426.25729327591, 11447.37039462821, 11449.313041217554, 11450.0, 7855.450118491765, 8204.548749818818, 8217.219364160395, 8357.498550087013, 8385.161483851689, 6168.475679567287, 6407.871842563216, 6533.934660653333, 6548.672566371758, 6597.736090556324, 10536.209784266364, 10659.94670026645, 10726.302790318916, 10758.085562727256, 10788.0, 9440.527973601154, 10290.588376464857, 10386.844197336895, 10968.506417211403, 10989.395583242678, 7552.622368881424, 7720.613969301625, 7721.227877212458, 7732.652030658522, 7760.223977602421, 8838.381313308008, 8896.377253592445, 8911.287097032351, 8913.153250441457, 8923.107689231025, 7865.4887432319, 8031.799205019687, 8116.959415203122, 8125.3905957052275, 8251.257386835214, 7872.448928575174, 7966.283034526688, 7971.402144839044, 8149.592520373839, 8176.877346839683, 7251.1298644163035, 7294.1247050354295, 7298.2701729826595, 7305.488615796843, 7307.634618269171, 5440.428754980829, 5504.559635229252, 5508.118701007819, 5577.0, 5645.181448689999, 5413.53984911287, 5546.889062218814, 5602.019646561754, 5688.40271771458, 5750.367459579359], "value": 4641.909741810686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.56568258865946, 306.21608681774643, 315.0265679051731, 322.5468217154897, 324.79700187382883, 5307.708076055825, 5348.598855085869, 5386.622936394454, 5398.866238090006, 5400.0, 5021.774020169092, 5144.996725638502, 5177.145770947789, 5179.4561571035065, 5295.841124766253, 4000.3399439092586, 4008.118213992917, 4128.2156390285745, 4154.8130334134885, 4191.538930717634, 4130.513015314499, 4134.4831896013, 4144.191882582898, 4151.501819781615, 4158.563350848162, 3928.3125453045745, 4049.6152865477734, 4151.3150330195485, 4169.4162817205615, 4197.265478541259, 3900.395438707005, 3993.4409182714444, 4047.3726572381033, 4062.7968601569805, 4067.7559346439307, 3538.9469157962653, 3564.2336897567147, 3567.928641427183, 3570.321638888603, 3571.1250743567994, 5155.123628983082, 5207.401148867891, 5225.712585807779, 5227.738613069369, 5267.55225805807, 4507.954920450787, 4595.954040459586, 4630.536946305376, 4631.0, 4634.844797169332, 5465.426130256305, 5472.589555783332, 5487.780488780484, 5488.7530061147345, 5549.223108764776, 3859.556151042638, 3888.0474283800368, 3890.9416358754356, 3891.540672247907, 3896.59085795993, 5513.979913715935, 5755.251817263771, 5757.193992841006, 5787.363390027093, 5792.855178620568, 3928.607139286106, 3950.585188555218, 3951.7233793634746, 3976.071605271441, 4002.2595819773437, 4040.717149799486, 4051.4125451809323, 4051.554329023805, 4055.614716601918, 4060.26915155269, 4517.570830771071, 4657.976710116428, 4666.673332866667, 4677.95322046782, 4750.097481478508, 5608.607397482218, 5627.662340259598, 5637.295338082739, 5682.460166284279, 5684.261046063985, 1396.6382776792545, 1408.7323408552343, 1414.6816966182528, 1417.9578010162522, 1419.0988722161296, 847.9109693482219, 887.5828360670474, 902.3412908576645, 906.6128822900972, 912.1471424218377, 4779.665423420397, 4822.445418776885, 4829.541193586604, 4850.248211527219, 4865.659403841697, 5076.959223359203, 5083.771230294646, 5089.277236678433, 5092.821751238763, 5116.206987916805, 4818.927716084191, 4832.734199618984, 5092.770825312869, 5192.870178245574, 5312.73436328182, 3021.6676165621766, 3037.179961410407, 3058.235441139715, 3067.8312692801665, 3068.094912000965, 5888.823335299948, 5904.9704751475965, 5920.6974465617495, 5923.4076592340425, 5931.258592675916, 5595.608307418523, 5827.825165245049, 5836.795712150054, 5867.266591676041, 5878.353381128072, 5884.823455296348, 5908.261467316585, 5910.674912879833, 5914.172015917689, 5922.911156332659, 5479.3424789023975, 5708.6574805510145, 5723.427657234243, 5769.798057067983, 5777.162311464898, 5726.2269593606, 5749.712514374348, 5760.452756988079, 5775.653460792366, 5780.653160810365, 5963.254593175853, 5977.970110149421, 5992.310884248367, 6049.0926361046195, 6085.269767627913, 3852.191039881544, 4017.5580686125086, 4049.3318602431445, 4076.2255171517318, 4082.571330010306, 5705.744736158039, 5776.480116789341, 5783.971080144573, 5790.594658373873, 5820.73806678692, 5687.492814404103, 5699.401562836008, 5712.457316554921, 5712.971435142964, 5717.799877004285, 5517.200005999188, 5616.354119276336, 5638.238837757014, 5639.633423827602, 5646.689432081275, 5290.81482148123, 5508.11870100798, 5515.586331025109, 5528.143137813645, 5587.7485513152815, 5447.972760136174, 5704.401037890962, 5706.885862282648, 5713.542916566582, 5737.762272713729, 5471.835844924659, 5549.611527193219, 5564.527015203753, 5577.6653400796085, 5589.329280486368], "value": 4194.903209245677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8999140120387, 766.8044648614602, 773.3040263762613, 795.2167115391342, 872.2716531696032, 16057.277422515986, 16382.853200275986, 16475.83524164758, 16863.40978065768, 16883.66232675349, 14905.403783848633, 15016.549503514885, 15025.0, 15035.54893353201, 15043.849561504381, 672.5124284893462, 798.4730078148394, 823.1069289820551, 828.2173346187855, 840.848647243496, 829.9626516806728, 834.4909605140859, 837.3761547646981, 837.7738010737097, 838.3502785341378, 703.7501686901153, 878.4377998081233, 889.4529864133576, 890.2077151335317, 890.4657205676607, 848.4909054567241, 867.1242045533993, 868.7958329792525, 872.1060912564609, 874.6501399440211, 633.4773811605398, 638.6934271549682, 638.827516570528, 638.9488840892717, 639.0924886660906, 15385.923070384688, 15492.922535387252, 15521.223938803014, 15531.5340539784, 15538.06771593708, 14556.272186390745, 14601.196934168616, 14624.853751462455, 14764.704705905822, 14786.55640330781, 12899.0, 12996.545120920722, 13134.86865131346, 13366.0, 13732.65668358289, 4505.977470112662, 4561.384213131218, 4563.087382523476, 4602.861914142581, 4619.976900115478, 73404.63297683478, 73456.26543734547, 74128.0, 74193.0, 74295.0, 11684.766304673858, 11704.70738231534, 11727.472263748152, 11730.811261896699, 12243.816342754866, 22085.227017054327, 22094.22670206535, 22102.0, 22102.668459973112, 22886.198983035512, 8252.33981281496, 8549.786255343666, 8664.436811607226, 8735.65057397697, 9069.77325566866, 4808.110499557593, 4844.15227335222, 4853.39332583427, 4920.852374428773, 4988.950110498921, 3444.190615205425, 3547.3260080585123, 3583.068402215443, 3586.7847929124337, 3594.856205751793, 528.3052785586941, 627.2128478759128, 632.8512799492115, 652.9869402611921, 674.9190097188368, 571.3115695586891, 666.643345809999, 689.6207086102623, 711.5730561663064, 736.3814395907464, 10032.0, 10141.391516509033, 10218.131458825934, 10274.383536987805, 10566.207534434949, 709.868674295257, 731.670748163318, 734.6877577029741, 742.2540346951388, 752.9171791102974, 5038.697678139323, 5164.225366195101, 5192.299039629677, 5199.1161502544655, 5206.3752349717515, 69873.65063174651, 78314.60842695864, 91051.0, 119966.0, 120911.39544302222, 67495.0, 104780.0, 104843.47578262212, 104928.0, 107000.46499767451, 69137.0, 74134.6293268541, 95623.52188239014, 95647.0, 96828.51585742168, 9575.808483830146, 9757.365771224848, 9816.331223692132, 9831.606735730777, 9846.015398460097, 38695.0, 44772.55227447814, 52879.206811897086, 53288.73355633197, 54947.0, 66042.33957660555, 67306.66346668235, 67690.3230967684, 68821.0, 79458.0, 13045.934770326088, 13127.803082953955, 13243.867561324263, 13311.866881331063, 13519.053666243663, 14031.579052628438, 14694.191819449605, 14755.778663320274, 15116.244187790786, 15174.696506069597, 14731.926340368229, 14967.401303948156, 15062.0, 15764.0, 15815.446459373867, 14008.299585020912, 14038.78941815853, 14157.938154638648, 14911.627209319853, 14962.40150393972, 14255.429782808571, 14498.202598857164, 14810.333534991167, 14817.925910370379, 15642.765358519404, 10969.945150274516, 11028.558857645605, 11137.443127843737, 11194.720131996439, 11313.321200727984, 11179.496922638664, 11948.402579871146, 12061.653971059934, 12227.816582751087, 12783.977281817619], "value": 7725.638455818773, "unit": "score"}], "name": "dromaeo_css", "value": 7252.254286359118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 112.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 120.0, 180.0, 129.0, 121.0, 152.0, 125.0, 155.0, 117.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 162.0, 160.0, 169.0, 162.0, 163.0, 168.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 122.0, 76.0, 77.0, 74.0, 74.0, 117.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 83.0, 83.0, 83.0, 124.0, 83.0, 83.0, 131.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 55.0, 53.0, 51.0, 50.0, 51.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 75.0, 75.0, 76.0, 77.0, 76.0, 74.0, 75.0, 79.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 127.0, 123.0, 123.0, 120.0, 129.0, 167.0, 118.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 157.0, 154.0, 156.0, 156.0, 161.0, 158.0, 162.0, 158.0, 159.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 66.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1482.2999999999997, "alertThreshold": 2.0}]} 13:47:39 INFO - Return code: 0 13:47:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:47:39 INFO - # TBPL SUCCESS # 13:47:39 INFO - Running post-action listener: _resource_record_post_action 13:47:39 INFO - ##### 13:47:39 INFO - ##### Finished run-tests step (success) 13:47:39 INFO - ##### 13:47:39 INFO - Running post-run listener: _resource_record_post_run 13:47:39 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554971136; Read time: 324; Write time: 1089468 13:47:39 INFO - TinderboxPrint: CPU usage
13.1% 13:47:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 324 13:47:39 INFO - TinderboxPrint: I/O write bytes / time
554,971,136 / 1,089,468 13:47:39 INFO - TinderboxPrint: CPU idle
8,283.9 (86.9%) 13:47:39 INFO - TinderboxPrint: CPU user
1,195.5 (12.5%) 13:47:39 INFO - TinderboxPrint: Swap in / out
0 / 0 13:47:39 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 257736704; Read time: 0; Write time: 707456 13:47:39 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 297234432; Read time: 324; Write time: 382012 13:47:40 INFO - Running post-run listener: _upload_blobber_files 13:47:40 INFO - Blob upload gear active. 13:47:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:47:40 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 13:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:47:40 INFO - (blobuploader) - INFO - Open directory for files ... 13:47:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:47:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:44 INFO - (blobuploader) - INFO - Done attempting. 13:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:45 INFO - (blobuploader) - INFO - Done attempting. 13:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:46 INFO - (blobuploader) - INFO - Done attempting. 13:47:46 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:46 INFO - Return code: 0 13:47:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/563ff25dbc73272ecedfb3a9aa1069d2f11b43b325b76edeba25f4bd73d1578e69449f33fee7c04ba526b05ff5b6b40e9b0cdf70428c29963c62896e18caa74f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6a1a266b8aea94d3c1ce1c23d434ed9d8f2ba70472df822c301f082870dacdcc202e09359600eac8abece3f67bf8ca2ef43699bc959c7302513d19e12cb4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb112d4fe0593730b11032b09ade43f12ec28e7172ce2bd2f01329ac32960d2462ec3753c7b497f0f85b2aa244d06dabac3d2e5ac084966b39e343a6899ac43b"} 13:47:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:46 INFO - Contents: 13:47:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/563ff25dbc73272ecedfb3a9aa1069d2f11b43b325b76edeba25f4bd73d1578e69449f33fee7c04ba526b05ff5b6b40e9b0cdf70428c29963c62896e18caa74f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6a1a266b8aea94d3c1ce1c23d434ed9d8f2ba70472df822c301f082870dacdcc202e09359600eac8abece3f67bf8ca2ef43699bc959c7302513d19e12cb4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb112d4fe0593730b11032b09ade43f12ec28e7172ce2bd2f01329ac32960d2462ec3753c7b497f0f85b2aa244d06dabac3d2e5ac084966b39e343a6899ac43b"} 13:47:46 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:46 INFO - Copying logs to upload dir... 13:47:46 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.813616 ========= master_lag: 0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-18 13:47:46.202639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 13:47:46.210769) ========= 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=df17445c3590ff7897617a0e00000225-1468872994.394424-426034555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/563ff25dbc73272ecedfb3a9aa1069d2f11b43b325b76edeba25f4bd73d1578e69449f33fee7c04ba526b05ff5b6b40e9b0cdf70428c29963c62896e18caa74f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6a1a266b8aea94d3c1ce1c23d434ed9d8f2ba70472df822c301f082870dacdcc202e09359600eac8abece3f67bf8ca2ef43699bc959c7302513d19e12cb4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb112d4fe0593730b11032b09ade43f12ec28e7172ce2bd2f01329ac32960d2462ec3753c7b497f0f85b2aa244d06dabac3d2e5ac084966b39e343a6899ac43b"} build_url:https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/Yk7ZDdy-RHOC4FhtTxnQ7g/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/Mozilla-Inbound/sha512/563ff25dbc73272ecedfb3a9aa1069d2f11b43b325b76edeba25f4bd73d1578e69449f33fee7c04ba526b05ff5b6b40e9b0cdf70428c29963c62896e18caa74f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6a1a266b8aea94d3c1ce1c23d434ed9d8f2ba70472df822c301f082870dacdcc202e09359600eac8abece3f67bf8ca2ef43699bc959c7302513d19e12cb4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb112d4fe0593730b11032b09ade43f12ec28e7172ce2bd2f01329ac32960d2462ec3753c7b497f0f85b2aa244d06dabac3d2e5ac084966b39e343a6899ac43b"}' ========= master_lag: 0.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 13:47:46.520920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:47:46.521264) ========= 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=df17445c3590ff7897617a0e00000225-1468872994.394424-426034555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 13:47:46.541109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 13:47:46.541436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 13:47:46.541749) ========= ========= Total master_lag: 0.76 =========