builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1469152793.8 results: success (0) buildid: 20160721180915 builduid: a4d1c730b7114f0db9e699c3474a948b revision: 3ab20077e16df40c9e4a61860c69f7b1eec024da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:53.802685) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:53.803054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:53.803323) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:53.832627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:53.832882) ========= 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=0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 18:59:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2016-07-21 18:59:54 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.017856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.018128) ========= 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=0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018333 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.074684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.074982) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3ab20077e16df40c9e4a61860c69f7b1eec024da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 3ab20077e16df40c9e4a61860c69f7b1eec024da --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=0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 18:59:54,409 truncating revision to first 12 chars 2016-07-21 18:59:54,409 Setting DEBUG logging. 2016-07-21 18:59:54,409 attempt 1/10 2016-07-21 18:59:54,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3ab20077e16d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 18:59:54,745 unpacking tar archive at: autoland-3ab20077e16d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.824789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.825061) ========= script_repo_revision: 3ab20077e16df40c9e4a61860c69f7b1eec024da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.825434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.825718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 18:59:54.843736) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-21 18:59:54.843987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:55 INFO - MultiFileLogger online at 20160721 18:59:55 in /builds/slave/test 18:59:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 18:59:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:55 INFO - {'append_to_log': False, 18:59:55 INFO - 'base_work_dir': '/builds/slave/test', 18:59:55 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 18:59:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:55 INFO - 'branch': 'Autoland-Non-PGO', 18:59:55 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:55 INFO - 'config_files': ('talos/linux_config.py',), 18:59:55 INFO - 'default_actions': ('clobber', 18:59:55 INFO - 'read-buildbot-config', 18:59:55 INFO - 'download-and-extract', 18:59:55 INFO - 'populate-webroot', 18:59:55 INFO - 'create-virtualenv', 18:59:55 INFO - 'install', 18:59:55 INFO - 'run-tests'), 18:59:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:55 INFO - 'download_minidump_stackwalk': True, 18:59:55 INFO - 'download_symbols': 'ondemand', 18:59:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:55 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:55 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:55 INFO - 'installer_path': 'installer.exe', 18:59:55 INFO - 'log_level': 'info', 18:59:55 INFO - 'log_name': 'talos', 18:59:55 INFO - 'log_to_console': True, 18:59:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:55 INFO - 'opt_config_files': (), 18:59:55 INFO - 'pip_index': False, 18:59:55 INFO - 'sps_profile': False, 18:59:55 INFO - 'sps_profile_interval': 0, 18:59:55 INFO - 'suite': 'dromaeojs-e10s', 18:59:55 INFO - 'system_bits': '32', 18:59:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:55 INFO - 'title': 'talos-linux64-ix-017', 18:59:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:55 INFO - 'use_talos_json': True, 18:59:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:55 INFO - 'work_dir': 'build'} 18:59:55 INFO - [mozharness: 2016-07-22 01:59:55.273716Z] Running clobber step. 18:59:55 INFO - Running pre-action listener: _resource_record_pre_action 18:59:55 INFO - Running main action method: clobber 18:59:55 INFO - rmtree: /builds/slave/test/build 18:59:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:55 INFO - Running post-action listener: _resource_record_post_action 18:59:55 INFO - [mozharness: 2016-07-22 01:59:55.748897Z] Finished clobber step (success) 18:59:55 INFO - [mozharness: 2016-07-22 01:59:55.748996Z] Running read-buildbot-config step. 18:59:55 INFO - Running pre-action listener: _resource_record_pre_action 18:59:55 INFO - Running main action method: read_buildbot_config 18:59:55 INFO - Using buildbot properties: 18:59:55 INFO - { 18:59:55 INFO - "project": "", 18:59:55 INFO - "product": "firefox", 18:59:55 INFO - "script_repo_revision": "production", 18:59:55 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 18:59:55 INFO - "repository": "", 18:59:55 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 18:59:55 INFO - "buildid": "20160721180915", 18:59:55 INFO - "pgo_build": "False", 18:59:55 INFO - "basedir": "/builds/slave/test", 18:59:55 INFO - "buildnumber": 154, 18:59:55 INFO - "slavename": "talos-linux64-ix-017", 18:59:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:59:55 INFO - "platform": "ubuntu64_hw", 18:59:55 INFO - "scheduler": "tests-autoland-linux64-talos", 18:59:55 INFO - "branch": "autoland", 18:59:55 INFO - "repo_path": "integration/autoland", 18:59:55 INFO - "revision": "3ab20077e16df40c9e4a61860c69f7b1eec024da", 18:59:55 INFO - "stage_platform": "linux64", 18:59:55 INFO - "builduid": "a4d1c730b7114f0db9e699c3474a948b", 18:59:55 INFO - "slavebuilddir": "test" 18:59:55 INFO - } 18:59:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:59:55 INFO - Running post-action listener: _resource_record_post_action 18:59:55 INFO - [mozharness: 2016-07-22 01:59:55.751416Z] Finished read-buildbot-config step (success) 18:59:55 INFO - [mozharness: 2016-07-22 01:59:55.751505Z] Running download-and-extract step. 18:59:55 INFO - Running pre-action listener: _resource_record_pre_action 18:59:55 INFO - Running main action method: download_and_extract 18:59:55 INFO - mkdir: /builds/slave/test/build/tests 18:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:55 INFO - https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:59:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:59:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:59:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 18:59:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:08 INFO - Downloaded 1361 bytes. 19:00:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:00:08 INFO - Using the following test package requirements: 19:00:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:00:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:00:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'jsshell-linux-x86_64.zip'], 19:00:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:00:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:00:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:00:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:00:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:00:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:00:08 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')]} 19:00:08 INFO - https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:09 INFO - Downloaded 22737165 bytes. 19:00:09 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'] 19:00:09 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 19:00:10 INFO - Return code: 0 19:00:10 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 19:00:10 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')]} 19:00:10 INFO - https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:21 INFO - Downloaded 22737165 bytes. 19:00:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:00:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:00:22 INFO - Return code: 0 19:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:22 INFO - https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:23 INFO - Downloaded 14403289 bytes. 19:00:23 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'] 19:00:23 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 19:00:23 INFO - Return code: 0 19:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:23 INFO - https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:00:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:00:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:00:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9tHZZfnT_qmxPhipieTCQ/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 19:00:24 INFO - Downloaded 57158829 bytes. 19:00:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:00:24 INFO - mkdir: /builds/slave/test/properties 19:00:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:24 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:24 INFO - Contents: 19:00:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:00:25 INFO - Running post-action listener: _resource_record_post_action 19:00:25 INFO - Running post-action listener: set_extra_try_arguments 19:00:25 INFO - [mozharness: 2016-07-22 02:00:25.629280Z] Finished download-and-extract step (success) 19:00:25 INFO - [mozharness: 2016-07-22 02:00:25.629547Z] Running populate-webroot step. 19:00:25 INFO - Running pre-action listener: _resource_record_pre_action 19:00:25 INFO - Running main action method: populate_webroot 19:00:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:25 INFO - '--tppagecycles', 19:00:25 INFO - '7'], 19:00:25 INFO - 'tests': ['tsvgm']}}, 19:00:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['damp', 'tps']}, 19:00:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'tests': ['damp', 'tps']}, 19:00:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['dromaeo_dom']}, 19:00:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['basic_compositor_video']}, 19:00:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:00:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['a11yr', 19:00:25 INFO - 'ts_paint', 19:00:25 INFO - 'tpaint', 19:00:25 INFO - 'sessionrestore', 19:00:25 INFO - 'sessionrestore_no_auto_restore', 19:00:25 INFO - 'tabpaint']}, 19:00:25 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:25 INFO - 'ts_paint', 19:00:25 INFO - 'tpaint', 19:00:25 INFO - 'sessionrestore', 19:00:25 INFO - 'sessionrestore_no_auto_restore', 19:00:25 INFO - 'tabpaint']}, 19:00:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:25 INFO - 'ts_paint', 19:00:25 INFO - 'tpaint', 19:00:25 INFO - 'sessionrestore', 19:00:25 INFO - 'sessionrestore_no_auto_restore', 19:00:25 INFO - 'tabpaint']}, 19:00:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:25 INFO - 'ts_paint', 19:00:25 INFO - 'tpaint', 19:00:25 INFO - 'sessionrestore', 19:00:25 INFO - 'sessionrestore_no_auto_restore', 19:00:25 INFO - 'tabpaint']}, 19:00:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['a11yr', 19:00:25 INFO - 'ts_paint', 19:00:25 INFO - 'tpaint', 19:00:25 INFO - 'sessionrestore', 19:00:25 INFO - 'sessionrestore_no_auto_restore', 19:00:25 INFO - 'tabpaint']}, 19:00:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['a11yr', 19:00:25 INFO - 'ts_paint', 19:00:25 INFO - 'tpaint', 19:00:25 INFO - 'sessionrestore', 19:00:25 INFO - 'sessionrestore_no_auto_restore', 19:00:25 INFO - 'tabpaint']}, 19:00:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['tsvgx', 19:00:25 INFO - 'tsvgr_opacity', 19:00:25 INFO - 'tart', 19:00:25 INFO - 'tscrollx', 19:00:25 INFO - 'cart']}, 19:00:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:25 INFO - 'tsvgr_opacity', 19:00:25 INFO - 'tart', 19:00:25 INFO - 'tscrollx', 19:00:25 INFO - 'cart']}, 19:00:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'talos_options': ['--disable-e10s'], 19:00:25 INFO - 'tests': ['tp5o']}, 19:00:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'tests': ['tp5o']}, 19:00:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'talos_options': ['--disable-e10s', 19:00:25 INFO - '--xperf_path', 19:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:25 INFO - 'tests': ['tp5n']}, 19:00:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:25 INFO - 'talos_options': ['--xperf_path', 19:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:25 INFO - 'tests': ['tp5n']}}, 19:00:25 INFO - 'talos.zip': {'path': '', 19:00:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:25 INFO - Running post-action listener: _resource_record_post_action 19:00:25 INFO - [mozharness: 2016-07-22 02:00:25.645366Z] Finished populate-webroot step (success) 19:00:25 INFO - [mozharness: 2016-07-22 02:00:25.645667Z] Running create-virtualenv step. 19:00:25 INFO - Running pre-action listener: _resource_record_pre_action 19:00:25 INFO - Running main action method: create_virtualenv 19:00:25 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:25 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 19:00:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:25 INFO - Using real prefix '/usr' 19:00:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:26 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:28 INFO - Installing pip.................done. 19:00:28 INFO - Return code: 0 19:00:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00: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', 'pip>=1.5'] in /builds/slave/test/build 19:00: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 pip>=1.5 19:00:28 INFO - Using env: {'DISPLAY': ':0', 19:00:28 INFO - 'HOME': '/home/cltbld', 19:00:28 INFO - 'LANG': 'en_US.UTF-8', 19:00:28 INFO - 'LANGUAGE': 'en_US:en', 19:00:28 INFO - 'LOGNAME': 'cltbld', 19:00:28 INFO - 'MAIL': '/var/mail/cltbld', 19:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:28 INFO - 'MOZ_NO_REMOTE': '1', 19:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:28 INFO - 'NO_EM_RESTART': '1', 19:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:28 INFO - 'PWD': '/builds/slave/test', 19:00:28 INFO - 'SHELL': '/bin/bash', 19:00:28 INFO - 'SHLVL': '1', 19:00:28 INFO - 'TERM': 'linux', 19:00:28 INFO - 'TMOUT': '86400', 19:00:28 INFO - 'USER': 'cltbld', 19:00:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:28 INFO - '_': '/tools/buildbot/bin/python'} 19:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:28 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 19:00:28 INFO - Cleaning up... 19:00:28 INFO - Return code: 0 19:00:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', '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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:00: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 psutil>=3.1.1 19:00:28 INFO - Using env: {'DISPLAY': ':0', 19:00:28 INFO - 'HOME': '/home/cltbld', 19:00:28 INFO - 'LANG': 'en_US.UTF-8', 19:00:28 INFO - 'LANGUAGE': 'en_US:en', 19:00:28 INFO - 'LOGNAME': 'cltbld', 19:00:28 INFO - 'MAIL': '/var/mail/cltbld', 19:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:28 INFO - 'MOZ_NO_REMOTE': '1', 19:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:28 INFO - 'NO_EM_RESTART': '1', 19:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:28 INFO - 'PWD': '/builds/slave/test', 19:00:28 INFO - 'SHELL': '/bin/bash', 19:00:28 INFO - 'SHLVL': '1', 19:00:28 INFO - 'TERM': 'linux', 19:00:28 INFO - 'TMOUT': '86400', 19:00:28 INFO - 'USER': 'cltbld', 19:00:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:28 INFO - '_': '/tools/buildbot/bin/python'} 19:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:28 INFO - Downloading/unpacking psutil>=3.1.1 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:30 INFO - Installing collected packages: psutil 19:00:30 INFO - Running setup.py install for psutil 19:00:30 INFO - building 'psutil._psutil_linux' extension 19:00:30 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 19:00:30 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 19:00:30 INFO - building 'psutil._psutil_posix' extension 19:00:30 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 19:00:31 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 19:00:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:31 INFO - Successfully installed psutil 19:00:31 INFO - Cleaning up... 19:00:31 INFO - Return code: 0 19:00:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:00: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 mozsystemmonitor==0.3 19:00:31 INFO - Using env: {'DISPLAY': ':0', 19:00:31 INFO - 'HOME': '/home/cltbld', 19:00:31 INFO - 'LANG': 'en_US.UTF-8', 19:00:31 INFO - 'LANGUAGE': 'en_US:en', 19:00:31 INFO - 'LOGNAME': 'cltbld', 19:00:31 INFO - 'MAIL': '/var/mail/cltbld', 19:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:31 INFO - 'MOZ_NO_REMOTE': '1', 19:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:31 INFO - 'NO_EM_RESTART': '1', 19:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:31 INFO - 'PWD': '/builds/slave/test', 19:00:31 INFO - 'SHELL': '/bin/bash', 19:00:31 INFO - 'SHLVL': '1', 19:00:31 INFO - 'TERM': 'linux', 19:00:31 INFO - 'TMOUT': '86400', 19:00:31 INFO - 'USER': 'cltbld', 19:00:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:31 INFO - '_': '/tools/buildbot/bin/python'} 19:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:33 INFO - Installing collected packages: mozsystemmonitor 19:00:33 INFO - Running setup.py install for mozsystemmonitor 19:00:33 INFO - Successfully installed mozsystemmonitor 19:00:33 INFO - Cleaning up... 19:00:33 INFO - Return code: 0 19:00:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', '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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:00: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 jsonschema==2.5.1 19:00:33 INFO - Using env: {'DISPLAY': ':0', 19:00:33 INFO - 'HOME': '/home/cltbld', 19:00:33 INFO - 'LANG': 'en_US.UTF-8', 19:00:33 INFO - 'LANGUAGE': 'en_US:en', 19:00:33 INFO - 'LOGNAME': 'cltbld', 19:00:33 INFO - 'MAIL': '/var/mail/cltbld', 19:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:33 INFO - 'MOZ_NO_REMOTE': '1', 19:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:33 INFO - 'NO_EM_RESTART': '1', 19:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:33 INFO - 'PWD': '/builds/slave/test', 19:00:33 INFO - 'SHELL': '/bin/bash', 19:00:33 INFO - 'SHLVL': '1', 19:00:33 INFO - 'TERM': 'linux', 19:00:33 INFO - 'TMOUT': '86400', 19:00:33 INFO - 'USER': 'cltbld', 19:00:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:33 INFO - '_': '/tools/buildbot/bin/python'} 19:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:33 INFO - Downloading/unpacking jsonschema==2.5.1 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:35 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:35 INFO - warning: no files found matching '*.txt' 19:00:35 INFO - no previously-included directories found matching 'build' 19:00:35 INFO - no previously-included directories found matching 'dist' 19:00:35 INFO - no previously-included directories found matching '.git*' 19:00:35 INFO - Installing collected packages: jsonschema, functools32 19:00:35 INFO - Running setup.py install for functools32 19:00:36 INFO - warning: no files found matching '*.txt' 19:00:36 INFO - no previously-included directories found matching 'build' 19:00:36 INFO - no previously-included directories found matching 'dist' 19:00:36 INFO - no previously-included directories found matching '.git*' 19:00:36 INFO - Successfully installed jsonschema functools32 19:00:36 INFO - Cleaning up... 19:00:36 INFO - Return code: 0 19:00:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00:36 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 19:00:36 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 19:00:36 INFO - Using env: {'DISPLAY': ':0', 19:00:36 INFO - 'HOME': '/home/cltbld', 19:00:36 INFO - 'LANG': 'en_US.UTF-8', 19:00:36 INFO - 'LANGUAGE': 'en_US:en', 19:00:36 INFO - 'LOGNAME': 'cltbld', 19:00:36 INFO - 'MAIL': '/var/mail/cltbld', 19:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:36 INFO - 'MOZ_NO_REMOTE': '1', 19:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:36 INFO - 'NO_EM_RESTART': '1', 19:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:36 INFO - 'PWD': '/builds/slave/test', 19:00:36 INFO - 'SHELL': '/bin/bash', 19:00:36 INFO - 'SHLVL': '1', 19:00:36 INFO - 'TERM': 'linux', 19:00:36 INFO - 'TMOUT': '86400', 19:00:36 INFO - 'USER': 'cltbld', 19:00:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:36 INFO - '_': '/tools/buildbot/bin/python'} 19:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:36 INFO - Downloading/unpacking blobuploader==1.2.4 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:38 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - Downloading docopt-0.6.1.tar.gz 19:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:39 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:39 INFO - Running setup.py install for blobuploader 19:00:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:39 INFO - Running setup.py install for requests 19:00:39 INFO - Running setup.py install for docopt 19:00:39 INFO - Successfully installed blobuploader requests docopt 19:00:39 INFO - Cleaning up... 19:00:39 INFO - Return code: 0 19:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:39 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00:39 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 19:00:39 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 19:00:39 INFO - Using env: {'DISPLAY': ':0', 19:00:39 INFO - 'HOME': '/home/cltbld', 19:00:39 INFO - 'LANG': 'en_US.UTF-8', 19:00:39 INFO - 'LANGUAGE': 'en_US:en', 19:00:39 INFO - 'LOGNAME': 'cltbld', 19:00:39 INFO - 'MAIL': '/var/mail/cltbld', 19:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:39 INFO - 'MOZ_NO_REMOTE': '1', 19:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:39 INFO - 'NO_EM_RESTART': '1', 19:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:39 INFO - 'PWD': '/builds/slave/test', 19:00:39 INFO - 'SHELL': '/bin/bash', 19:00:39 INFO - 'SHLVL': '1', 19:00:39 INFO - 'TERM': 'linux', 19:00:39 INFO - 'TMOUT': '86400', 19:00:39 INFO - 'USER': 'cltbld', 19:00:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:39 INFO - '_': '/tools/buildbot/bin/python'} 19:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:39 INFO - Running setup.py (path:/tmp/pip-VnKsqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:39 INFO - Running setup.py (path:/tmp/pip-u9DBmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:40 INFO - Running setup.py (path:/tmp/pip-pxkf_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:40 INFO - Running setup.py (path:/tmp/pip-uOs3QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:40 INFO - Running setup.py (path:/tmp/pip-aBcGU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:40 INFO - Running setup.py (path:/tmp/pip-LOfRBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:40 INFO - Running setup.py (path:/tmp/pip-B8NTaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:40 INFO - Running setup.py (path:/tmp/pip-zt1Bbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:40 INFO - Running setup.py (path:/tmp/pip-mye26Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:40 INFO - Running setup.py (path:/tmp/pip-2uBLwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:40 INFO - Running setup.py (path:/tmp/pip-8QsuiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:40 INFO - Running setup.py (path:/tmp/pip-QovpPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:40 INFO - Running setup.py (path:/tmp/pip-tM1SQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:40 INFO - Running setup.py (path:/tmp/pip-AMvPG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:40 INFO - Running setup.py (path:/tmp/pip-R8CZzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:40 INFO - Running setup.py (path:/tmp/pip-scoP0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:41 INFO - Running setup.py (path:/tmp/pip-t0xttv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:41 INFO - Running setup.py install for manifestparser 19:00:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozcrash 19:00:41 INFO - Running setup.py install for mozdebug 19:00:41 INFO - Running setup.py install for mozdevice 19:00:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozfile 19:00:41 INFO - Running setup.py install for mozhttpd 19:00:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozinfo 19:00:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozInstall 19:00:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozleak 19:00:41 INFO - Running setup.py install for mozlog 19:00:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Running setup.py install for moznetwork 19:00:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Running setup.py install for mozprocess 19:00:42 INFO - Running setup.py install for mozprofile 19:00:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Running setup.py install for mozrunner 19:00:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Running setup.py install for mozscreenshot 19:00:42 INFO - Running setup.py install for moztest 19:00:42 INFO - Running setup.py install for mozversion 19:00:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:42 INFO - Cleaning up... 19:00:42 INFO - Return code: 0 19:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:42 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')]} 19:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:42 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')]} 19:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:42 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00:42 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 19:00:42 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 19:00:42 INFO - Using env: {'DISPLAY': ':0', 19:00:42 INFO - 'HOME': '/home/cltbld', 19:00:42 INFO - 'LANG': 'en_US.UTF-8', 19:00:42 INFO - 'LANGUAGE': 'en_US:en', 19:00:42 INFO - 'LOGNAME': 'cltbld', 19:00:42 INFO - 'MAIL': '/var/mail/cltbld', 19:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:42 INFO - 'MOZ_NO_REMOTE': '1', 19:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:42 INFO - 'NO_EM_RESTART': '1', 19:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:42 INFO - 'PWD': '/builds/slave/test', 19:00:42 INFO - 'SHELL': '/bin/bash', 19:00:42 INFO - 'SHLVL': '1', 19:00:42 INFO - 'TERM': 'linux', 19:00:42 INFO - 'TMOUT': '86400', 19:00:42 INFO - 'USER': 'cltbld', 19:00:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:42 INFO - '_': '/tools/buildbot/bin/python'} 19:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:43 INFO - Running setup.py (path:/tmp/pip-aEu2HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:43 INFO - Running setup.py (path:/tmp/pip-1Ae27g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:43 INFO - Running setup.py (path:/tmp/pip-bWAsxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:43 INFO - Running setup.py (path:/tmp/pip-94uaAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:43 INFO - Running setup.py (path:/tmp/pip-ooHS6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:43 INFO - Running setup.py (path:/tmp/pip-xKsybC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:43 INFO - Running setup.py (path:/tmp/pip-sKwdji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:43 INFO - Running setup.py (path:/tmp/pip-m1AwW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:43 INFO - Running setup.py (path:/tmp/pip-94BYWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:43 INFO - Running setup.py (path:/tmp/pip-am8yQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:43 INFO - Running setup.py (path:/tmp/pip-SyeiRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:43 INFO - Running setup.py (path:/tmp/pip-QcmHH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:43 INFO - Running setup.py (path:/tmp/pip-tUXC_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:44 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)) 19:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:44 INFO - Running setup.py (path:/tmp/pip-5XiNYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:44 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)) 19:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:44 INFO - Running setup.py (path:/tmp/pip-32Nuru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:44 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)) 19:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:44 INFO - Running setup.py (path:/tmp/pip-i9TSQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:44 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)) 19:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:44 INFO - Running setup.py (path:/tmp/pip-i9EXLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:44 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 19:00:44 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 19:00:44 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 19:00:44 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 19:00:44 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 19:00:44 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 19:00:46 INFO - Downloading blessings-1.6.tar.gz 19:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:46 INFO - Installing collected packages: blessings 19:00:46 INFO - Running setup.py install for blessings 19:00:46 INFO - Successfully installed blessings 19:00:46 INFO - Cleaning up... 19:00:46 INFO - Return code: 0 19:00:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:46 INFO - Reading from file tmpfile_stdout 19:00:46 INFO - Current package versions: 19:00:46 INFO - argparse == 1.2.1 19:00:46 INFO - blessings == 1.6 19:00:46 INFO - blobuploader == 1.2.4 19:00:46 INFO - docopt == 0.6.1 19:00:46 INFO - functools32 == 3.2.3-2 19:00:46 INFO - jsonschema == 2.5.1 19:00:46 INFO - manifestparser == 1.1 19:00:46 INFO - mozInstall == 1.12 19:00:46 INFO - mozcrash == 0.17 19:00:46 INFO - mozdebug == 0.1 19:00:46 INFO - mozdevice == 0.48 19:00:46 INFO - mozfile == 1.2 19:00:46 INFO - mozhttpd == 0.7 19:00:46 INFO - mozinfo == 0.9 19:00:46 INFO - mozleak == 0.1 19:00:46 INFO - mozlog == 3.3 19:00:46 INFO - moznetwork == 0.27 19:00:46 INFO - mozprocess == 0.23 19:00:46 INFO - mozprofile == 0.28 19:00:46 INFO - mozrunner == 6.12 19:00:46 INFO - mozscreenshot == 0.1 19:00:46 INFO - mozsystemmonitor == 0.3 19:00:46 INFO - moztest == 0.7 19:00:46 INFO - mozversion == 1.4 19:00:46 INFO - psutil == 3.1.1 19:00:46 INFO - requests == 1.2.3 19:00:46 INFO - wsgiref == 0.1.2 19:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:46 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')]} 19:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 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')]} 19:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00:46 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 19:00:46 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 19:00:46 INFO - Using env: {'DISPLAY': ':0', 19:00:46 INFO - 'HOME': '/home/cltbld', 19:00:46 INFO - 'LANG': 'en_US.UTF-8', 19:00:46 INFO - 'LANGUAGE': 'en_US:en', 19:00:46 INFO - 'LOGNAME': 'cltbld', 19:00:46 INFO - 'MAIL': '/var/mail/cltbld', 19:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:46 INFO - 'MOZ_NO_REMOTE': '1', 19:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:46 INFO - 'NO_EM_RESTART': '1', 19:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:46 INFO - 'PWD': '/builds/slave/test', 19:00:46 INFO - 'SHELL': '/bin/bash', 19:00:46 INFO - 'SHLVL': '1', 19:00:46 INFO - 'TERM': 'linux', 19:00:46 INFO - 'TMOUT': '86400', 19:00:46 INFO - 'USER': 'cltbld', 19:00:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:46 INFO - '_': '/tools/buildbot/bin/python'} 19:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 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)) 19:00:46 INFO - Cleaning up... 19:00:46 INFO - Return code: 0 19:00:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:46 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')]} 19:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 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')]} 19:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, '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': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', '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 19:00:46 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 19:00:46 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 19:00:46 INFO - Using env: {'DISPLAY': ':0', 19:00:46 INFO - 'HOME': '/home/cltbld', 19:00:46 INFO - 'LANG': 'en_US.UTF-8', 19:00:46 INFO - 'LANGUAGE': 'en_US:en', 19:00:46 INFO - 'LOGNAME': 'cltbld', 19:00:46 INFO - 'MAIL': '/var/mail/cltbld', 19:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:46 INFO - 'MOZ_NO_REMOTE': '1', 19:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:46 INFO - 'NO_EM_RESTART': '1', 19:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:46 INFO - 'PWD': '/builds/slave/test', 19:00:46 INFO - 'SHELL': '/bin/bash', 19:00:46 INFO - 'SHLVL': '1', 19:00:46 INFO - 'TERM': 'linux', 19:00:46 INFO - 'TMOUT': '86400', 19:00:46 INFO - 'USER': 'cltbld', 19:00:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:46 INFO - '_': '/tools/buildbot/bin/python'} 19:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:47 INFO - Cleaning up... 19:00:47 INFO - Return code: 0 19:00:47 INFO - Running post-action listener: _resource_record_post_action 19:00:47 INFO - Running post-action listener: _start_resource_monitoring 19:00:47 INFO - Starting resource monitoring. 19:00:47 INFO - [mozharness: 2016-07-22 02:00:47.201008Z] Finished create-virtualenv step (success) 19:00:47 INFO - [mozharness: 2016-07-22 02:00:47.201525Z] Running install step. 19:00:47 INFO - Running pre-action listener: _resource_record_pre_action 19:00:47 INFO - Running main action method: install 19:00:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:47 INFO - Reading from file tmpfile_stdout 19:00:47 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:47 INFO - Reading from file tmpfile_stdout 19:00:47 INFO - Output received: 19:00:47 INFO - Usage: mozinstall [options] installer 19:00:47 INFO - Options: 19:00:47 INFO - -h, --help show this help message and exit 19:00:47 INFO - -d DEST, --destination=DEST 19:00:47 INFO - Directory to install application into. [default: 19:00:47 INFO - "/builds/slave/test"] 19:00:47 INFO - --app=APP Application being installed. [default: firefox] 19:00:47 INFO - mkdir: /builds/slave/test/build/application 19:00:47 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'] 19:00:47 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 19:01:03 INFO - Reading from file tmpfile_stdout 19:01:03 INFO - Output received: 19:01:03 INFO - /builds/slave/test/build/application/firefox/firefox 19:01:03 INFO - Running post-action listener: _resource_record_post_action 19:01:03 INFO - [mozharness: 2016-07-22 02:01:03.894403Z] Finished install step (success) 19:01:03 INFO - [mozharness: 2016-07-22 02:01:03.894680Z] Running run-tests step. 19:01:03 INFO - Running pre-action listener: _resource_record_pre_action 19:01:03 INFO - Running main action method: run_tests 19:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:03 INFO - Python 2.7.3 19:01:03 INFO - Return code: 0 19:01:03 INFO - grabbing minidump binary from tooltool 19:01:03 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')]} 19:01:03 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 0x1993570>, '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 0x1994470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:03 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 19:01:03 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 19:01:03 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 19:01:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:03 INFO - Return code: 0 19:01:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:01:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:01:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:01:03 INFO - Using env: {'DISPLAY': ':0', 19:01:03 INFO - 'HOME': '/home/cltbld', 19:01:03 INFO - 'LANG': 'en_US.UTF-8', 19:01:03 INFO - 'LANGUAGE': 'en_US:en', 19:01:03 INFO - 'LOGNAME': 'cltbld', 19:01:03 INFO - 'MAIL': '/var/mail/cltbld', 19:01:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:03 INFO - 'MOZ_NO_REMOTE': '1', 19:01:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:03 INFO - 'NO_EM_RESTART': '1', 19:01:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:03 INFO - 'PWD': '/builds/slave/test', 19:01:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:03 INFO - 'SHELL': '/bin/bash', 19:01:03 INFO - 'SHLVL': '1', 19:01:03 INFO - 'TERM': 'linux', 19:01:03 INFO - 'TMOUT': '86400', 19:01:03 INFO - 'USER': 'cltbld', 19:01:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558', 19:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:03 INFO - '_': '/tools/buildbot/bin/python'} 19:01:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:01:04 INFO - mozversion application_buildid: 20160721180915 19:01:04 INFO - mozversion application_changeset: 3ab20077e16df40c9e4a61860c69f7b1eec024da 19:01:04 INFO - mozversion application_display_name: Nightly 19:01:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:04 INFO - mozversion application_name: Firefox 19:01:04 INFO - mozversion application_remotingname: firefox 19:01:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:01:04 INFO - mozversion application_vendor: Mozilla 19:01:04 INFO - mozversion application_version: 50.0a1 19:01:04 INFO - mozversion platform_buildid: 20160721180915 19:01:04 INFO - mozversion platform_changeset: 3ab20077e16df40c9e4a61860c69f7b1eec024da 19:01:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:01:04 INFO - mozversion platform_version: 50.0a1 19:01:04 INFO - using testdate: 1469152864 19:01:04 INFO - actual date: 1469152864 19:01:04 INFO - starting webserver on 'localhost:55438' 19:01:04 INFO - SUITE-START | Running 2 tests 19:01:04 INFO - TEST-START | dromaeo_css 19:01:04 INFO - operating with platform_type : linux_ 19:01:04 INFO - Initialising browser for dromaeo_css test... 19:01:04 INFO - TEST-INFO | started process 23401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOxIgae/profile http://localhost:55438/getInfo.html) 19:01:07 INFO - PROCESS | 23401 | JavaScript error: , line 0: uncaught exception: undefined 19:01:08 INFO - PROCESS | 23401 | __metrics Screen width/height:1600/1200 19:01:08 INFO - PROCESS | 23401 | colorDepth:24 19:01:08 INFO - PROCESS | 23401 | Browser inner width/height: 1024/697 19:01:08 INFO - PROCESS | 23401 | __metrics 19:01:09 ERROR - PROCESS | 23401 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:01:10 INFO - TEST-INFO | 23401: exit 0 19:01:10 INFO - Browser initialized. 19:01:10 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:10 INFO - TEST-INFO | started process 23520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOxIgae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:21 INFO - PROCESS | 23520 | RSS: Main: 169025536 19:01:21 INFO - PROCESS | 23520 | 19:02:11 INFO - PROCESS | 23520 | 1469152931585 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] 19:04:24 INFO - PROCESS | 23520 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55438/tests/dromaeo/cssquery-ext.html) 19:04:25 INFO - PROCESS | 23520 | RSS: Main: 170663936 19:04:25 INFO - PROCESS | 23520 | 19:07:28 INFO - PROCESS | 23520 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-ext.html (next: http://localhost:55438/tests/dromaeo/cssquery-jquery.html) 19:07:28 INFO - PROCESS | 23520 | RSS: Main: 169947136 19:07:28 INFO - PROCESS | 23520 | 19:10:30 INFO - PROCESS | 23520 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55438/tests/dromaeo/cssquery-mootools.html) 19:10:31 INFO - PROCESS | 23520 | RSS: Main: 173076480 19:10:31 INFO - PROCESS | 23520 | 19:13:33 INFO - PROCESS | 23520 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55438/tests/dromaeo/cssquery-prototype.html) 19:13:34 INFO - PROCESS | 23520 | RSS: Main: 168177664 19:13:34 INFO - PROCESS | 23520 | 19:16:36 INFO - PROCESS | 23520 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55438/tests/dromaeo/cssquery-yui.html) 19:16:37 INFO - PROCESS | 23520 | RSS: Main: 170418176 19:16:37 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-yui.html (next: http://localhost:55438/tests/dromaeo/cssquery-dojo.html) 19:19:40 INFO - PROCESS | 23520 | RSS: Main: 173334528 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | __start_tp_report 19:19:40 INFO - PROCESS | 23520 | _x_x_mozilla_page_load 19:19:40 INFO - PROCESS | 23520 | _x_x_mozilla_page_load_details 19:19:40 INFO - PROCESS | 23520 | |i|pagename|runs| 19:19:40 INFO - PROCESS | 23520 | |0;dojo.html;2650.522905876942;2656.6015097735335;2656.9999999999995;2696.811223214376;2706.134037108126;4766.189747742887;4780.043991201761;4783.712977221369;4798.4001999750035;4850.514948505148;4638.9794245266075;4750.311204875291;4776.355192049073;4827.637927155469;4833.613310935126;4356.564343565642;4385.758783266919;4498.392716983214;4501.414816073922;4509.165804326194;4442.089371678814;4475.39582156408;4493.865184044484;4547.1587756265035;4585.151746926813;4309.82760689572;4379.781010949439;4398.670099742532;4429.579189976979;4434.955650443519;4430.667699922518;4433.933490997638;4439.511653718088;4467.061916997434;4482.125985432842;4384.649228061748;4411.933820992687;4420.977895110536;4425.070735145623;4465.37484752135;4691.976540117277;4735.052989402099;4758.048390321915;4808.471068182497;4819.831305904311;5048;5072.67027643202;5097.286379906816;5110.233464980245;5145.279660847485;5104.566111880495;5119.56483698886;5123.3339665843205;5133.6919784813035;5141;4692.202325604621;4736.194846876039;4778.402699662543;4792.640551958617;4834.250691142878;5237.528622424;5271.499207575274;5283.682979021271;5284.101702710548;5295.046891559557;5019.824306149268;5037.042961837239;5040.949590504048;5061.746912654353;5070.442251352349;4951.702897826142;5000.674956127913;5113.769880355393;5114.5652619527755;5128.153854614022;5040.571551418097;5060.038592667382;5071.442141364447;5100.515451032146;5130.666506677054;4938.703677779273;5074.873128171751;5076.086304465158;5079.847604571869;5115.667481613683;4162.8334866605;4257.595528424795;4283.507396649426;4302.182585308781;4312.649675630236;3775.867844625425;3780.8109594520715;3803.4294855771304;3822.27376798413;3822.9235415292096;4329.848455304049;4368.257396242647;4377.058932329564;4379.4525684289465;4427.335899615084;4954.182559877652;5121.129408000649;5170.586353091744;5188.9740551297755;5204.8178313758835;4374.693771436033;4378.496472905656;4408.735475871458;4410.911781764346;4422.181896349121;4600.2869555218995;4600.332951722048;4611.769411529477;4611.792469338888;4646.581807637329;4624.28323609841;4775.689580177277;4796.760161991956;4816.470188279286;4819.734914579732;5162.612804039787;5168.483151684952;5168.767405466839;5197.8440646780655;5219.347581552306;4810.11012962603;4817.205161148371;4819.6867203631655;4823.1800593898415;4849.4908034655855;4961.404631444249;5041.823536176216;5066.974665126798;5099.337086178922;5124.513171248875;5107.336046314104;5120.18077107661;5126.666766660155;5162.045021671003;5175.171972484384;4958.975205123951;4968.900621987612;4973.751312434291;4981.576565991932;4985.277134815359;4857.247126695368;4928.67963582366;4969.304297398439;4993.300937868774;5002.374703162105;4867.123917694849;4904.92642610354;4912.459629440687;4917.852464426073;4938.8765280868265;5009.949900500948;5019.67372120811;5020.548150666457;5028.270900719448;5072.51811077947;4759.024399998061;4844.95155048445;4869.440014398389;4900.019996000743;4946.134426475424 19:19:40 INFO - PROCESS | 23520 | |1;ext.html;551.9724013799306;559.1696330948541;572.3418069220396;576.4063015094453;604.9987271066386;34601.30797384051;38551.80724096375;38821.22357552847;38841.417378739345;38924.80537597315;39668.40497392534;40336.39495407564;40476.59523404765;40534.7973260134;40569;7516.5865877376855;7682.385409167253;7710.383169346439;7718.266764657348;7737.303642672158;7690.923090769104;7699.6920123195005;7754.612269386508;7758.806029849243;7764.068311802592;7843.098043724987;7849.215078492133;7852.411069169807;7854.450188486809;7879.763607091796;7801.1028731696015;7812.843743125106;7824.1002284737415;7828.921710782934;7852.293293603546;7741;7800.453968222227;7806.0632724073475;7816.53100813953;7820.804479887991;35989.64010359889;36444.27111457756;36496.81751591225;36554.268914621825;36595.0723942084;2642.3394151462135;3021.0936718984217;3111.579936708538;3128.7340576051065;3149.4803357445994;25351.112711055026;26706.332341691417;27276.72723272762;27597.172084837486;27905;3222.2266656002625;3222.822744749038;3245.2211469247445;3312.6521715219797;3366.394049071166;214163;215238;216180;216605;217000.91499542558;31698.683013170034;32003.67996320007;32223.51664725031;32775.67224327774;32825;34014.149646259044;34104.658953410646;34110;34218.48672269918;34240;13480.39338229782;13660.52188173429;13667.589972300846;13686.65783355424;13704.10923289983;11157.888421115686;11195.104391648649;11234.7191320216;11281.21031527785;11307.773844523228;7812.140664526897;7839.568823714636;7877.109493721466;7896.7236146734585;7922.762317130495;3095.4892442747146;3096.5200393938976;3125.9531107033413;3162.256869635634;3163.636181839072;834.4951304460835;899.2042042792045;921.7787730944659;954.9427034377959;1002.8846682631445;27458;27602.861985689942;27884.30289242785;28291.43417131687;28320.291992700346;906.1934877958622;916.4913473022536;930.6370515498961;950.3442624589012;965.034965034965;14198.219097949504;15041.699166016619;15106.622334441507;15277.770833437507;15316.540503784905;384024;384759;389147;389686;389946;48815.26777098346;49158.26262606064;49284.26073608899;49344.50655493471;49595.25607115896;1199.8920097191294;1203.94704219766;1224.179799534314;1233.9136260461862;1247.9188852724544;27134;27763.305917352227;28230.576541351486;28831.135065948056;28873.85563072171;42051.36922946097;42632.78683606562;42740.35889461599;42765;42796;334253;336304;336779;337098;339055;25184.24447266585;25524;25534.872325638255;26352.60471092897;26464.6181843635;40243;40555.18889622132;40903.38644920388;41366.9658258546;41625.37561936634;36184.27631447409;36417.27165456729;36682.26635467329;36809.44785828161;36866.8156659215;35112.82443587766;35376.11559711028;35666.286674266885;35862;35934.10164745902;34885.30229395449;35508.46737298891;35626.643733562334;36135;36321.45517817288;30296.242593935327;31548.211294717814;32042.193670949546;32122;32430.83784581062;24673;24716.25851224466;24841.378965526008;25066.874665626554;25259.242222733348 19:19:40 INFO - PROCESS | 23520 | |2;jquery.html;349.59097855509054;353.6922877096926;358.72736720092723;361.6889475051455;379.45548138421384;15705;16553.503394898158;16993.575160620992;17130.914345428257;17179.484615461526;15705.528834134966;16286.94134881232;16461.670766584662;16778.74831877523;16862.409815656454;4919.040787046527;5173.275741396207;5184.53339199472;5187.507186817265;5197;3758.3422900992355;5112.923306150411;5640.266765320503;5904.645721256738;5915.053591425372;5926.051831706928;5954.70226488676;5960.9403905961035;5966.8806623867495;5972.3131839838325;5937;5980.192673989021;5994.340622531518;6018.939810601882;6019.72911218994;5126.102931986925;5206.088934436459;5206.37523497179;5233.476652334774;5258.447862974409;20594.38216853497;20757.962101894995;21034;21061.684074738892;21193.47016324589;1925.7881633020356;1938.6607343714793;2054.6917962305624;2169.8264138869013;2318.921701408853;8439.662413503453;9148.039455857106;12836.743265134739;13299.468021279234;13492.865071349259;1747.3709464592737;1790.5702631368508;1792.3278770461077;1803.332766876251;1824.2885274742862;70467;72607.63696181591;72924.27075729228;73541.63229183819;76451.6177419115;9420.717378478657;9793.853092203623;9843.360181588174;9909.554070066864;9916.702498925044;12765.93617031909;13448.1258718183;13485.258310792804;13510.256935868425;13534.98487613433;7167.247439018932;7281;7281.890771638429;7384.96307518459;7545.471816972759;7091.609961452066;7195.388391986635;7379.88930166048;7392.96303518479;7470.663820128108;3895.902602434905;4095.795210239476;4181.97909010453;4204.8528301509305;4348.412964249849;1621.7324141516754;1641.8358164183487;1750.6323672028761;1785.446511581414;1797.164318591835;793.6230290611913;849.8172892827948;895.7268033249791;900.4282280751639;911.1981456318398;16773.6645267094;16778;16899.49301520932;16984.21665725081;17630.382936597158;845.9703910363231;867.1631875240423;874.2044739287218;879.9736007919645;903.8599017152352;9177.954110229406;9662.275329350327;9690.612375505041;9788.119069283799;10019.298649094639;435599;438732;443511;445647;446623.90192441415;80303.59848200838;84100.57949710212;84774.15225847786;85297.14702852893;86104.56947715221;934.9813003739887;936.3258453913172;991.5736233419699;993.0913214408735;997.1225321716988;13860.861391385957;15730;16031.438899638457;16119.43581974672;16631.91684041572;36725;37918.620813792615;38114.61885381111;39301.21397571975;39478.40782388324;47293.527064728914;49808.25287620761;53997;54456.45543544514;55493;7130.393916517154;7207.351338379362;7301.671424786004;7325.633718313957;7351.8529629408185;6420.1974753155855;10129.290949633749;10169.9491502542;11088.556457741923;11185.944070279596;7503;8860.689875854572;9439.716808495756;9671.371360861522;10040.096391324816;10364.948175259377;10473.9476302618;10474.371537707762;10474.790504189721;10491.809802370974;9696.5636546357;9888.851667224853;9928.354656947275;10038.598456061676;10347.172226222036;7398.3341499265325;7500.287472690085;7516.0980682316285;7588.392928565812;7640.503367281109;8437.325013998743;9599.32804703664;9714.174295184706;10157.714514234238;10298.279120461495 19:19:40 INFO - PROCESS | 23520 | |3;mootools.html;1356.7015256643535;1389.0554422992363;1469.47099044344;1668.8498035176847;1698.2782317515052;6699.430548403379;7549.886751698729;7589.354904833089;8130.349572034231;8149.225823546761;7735.961320193405;8033.879491807627;8047.959760201205;8050.235227653364;8055.395845311596;2166.1660260799586;2196.901139448729;2200.6148923938326;2202.284257616281;2208.182972300243;2119.247667078188;2174.13034786086;2226.6993955816;2234.1175235781857;2239.552089582082;2200.834937379695;2221.4224301681515;2234.3408694435097;2237;2242.3048854854965;2162.610730068587;2176.771438998906;2187.1142187414043;2189.0696454007143;2198.4503874031493;2127.5532138250987;2140.3257973738223;2153.0203757290396;2192.3094225318973;2194.780521947808;8003.679852805881;8050.315723163538;8066;8068.152843951418;8080.070791858952;4609.0551436955675;4690.976545117287;4725.503822098664;4728.71627702339;4738;2824.6327977363017;2911.30128769096;2913.1988703106817;2960.4375168717875;2965.4662160811044;858.5921687198593;887.6715615222345;897;900.6352427266968;929.256594724218;10975.890241097566;11032.558697652084;11033.724156896062;11037.0618497427;11038.337699738042;3969.920601587952;4172.3532852407925;4194.182134483746;4329.155814616182;4339.674524410681;9365.063493650581;9371.48456834867;9395.671151509801;9405.388649737744;9405.76485587852;4629.976850115795;4636.44362676481;4648;4655.138799322136;4659.673822832437;3643.708503319728;4169.708120431601;4272.380504826782;4273.572642735764;4299.14017196562;3639.890803275906;3674.3018826422895;3762.172322089136;3764.134249122717;3829.8468061277795;1207.3419986107592;1218.3908045977012;1240.9503619855286;1242.8694987026413;1243.5523211643801;807.5275963561265;815.3803109636718;818.6970820796344;821.4044817507379;831.9251267385844;5139.486051394905;5147.819826306136;5276.36683597963;5341.893162136736;5380.112281473513;406.8250652219574;417.1011470281548;423.7118759243744;425.18789112794417;426.34343111608393;3402.3365443738235;3596.9029446019217;3617.7286703497343;3658.506101676293;3662.7802331860175;9367.62529498826;9963.352382095141;9973;9977.650782222732;10002.44986525748;9080.137386948229;9393;9437.867455905198;9780.951095244478;9952.552135153936;7285.927140728631;7295.598742069237;7476.401887848959;7538.170801211862;7570.280823321776;5285.233641122093;5341.599380046434;5474.507294343528;5524.364698059774;5550.750216240198;9045.140711632384;9134.817303654023;9225.538723063954;9308.767280818034;9332.626694932127;8681.479111253346;9048.140426659456;9110.863337050083;9323.627054917999;9323.953380233055;5821.825345239649;6464.0627109069865;6629.370209830058;6650.833729156616;6871.381575658214;7702.845943081219;7860.960695196487;7867.449278550675;7870;7873.291403773688;6460.25707043696;6670.132882725215;6747.089142965637;6753.2909044549615;6955.652217389212;6663.400293973566;6710.496712746466;6779.762708305186;6922.688479018557;6975.651217439209;6398.648074355955;6431.356864313531;6482.546221764431;6498.480121590167;6498.772542960974;4421.933670994873;4500.504944456173;4573.245414506569;4588.403507543998;4619.676622636383;4515.14212299662;4537.886552836206;4558.430196225472;4637.1421287062;4751.358566593465 19:19:40 INFO - PROCESS | 23520 | |4;prototype.html;292.3043157285658;301.21683622581287;305.6195037178713;308.67743208347275;309.65782809994954;4912.557869791718;4942.3080768692325;4991.600671946245;5067.442581316052;5107.719075450854;4967.900641987158;4986.725730084844;4989.57588604969;5001.924971125436;5012.273220383051;3971.424143499191;3983.223271462066;3983.8008099594904;3989.1024519483176;4009.5341365060494;3850.7689538627633;3926.2540117377607;3987.282289187945;3989.381645844884;3991.720579559432;3875.748076375027;3905.258000979819;3911.6870650348046;3912.8239229234755;3928.960710392888;3902.64876161144;3911.256861196392;3913.334733095352;3916.432117342998;3933.8819835404984;3269;3383.6803646577855;3398.83005849709;3469.5489586353865;3479.5998460176897;4883.267509873547;4901.01979604077;4908.852734417973;4943.209086546171;4987.276844857512;4402.493713222988;4454.48773391061;4457.710248833848;4466.731996080213;4470.932936005963;5037.848864534069;5237.481130472159;5250.44870288618;5267.499587539178;5294.97352513235;3588.2105936693883;3596.406592912166;3600.117971097098;3611.7110631149444;3619.2399596084592;5540.445955404468;5549.19536667185;5551.861203469905;5573.21974923507;5573.832785016456;3688.686461650736;3773.4339849022317;3780.432935059763;3805.6384643458828;3814.6566808987322;3759.285735710206;3784.148566572499;3799.677027452642;3804.7907365094634;3831.3869780834934;4369.956300436955;4376.627986621109;4385.342198670225;4385.780710964503;4392.758398288061;5253.3958594761325;5254.1856012317385;5277.393099793496;5279.1817268323475;5294.97352513235;1262.4255963536568;1292.405493473013;1305.6017914536158;1319.089828018664;1330.2284674888542;789.8586542446225;828.7265202483167;829.3199576347458;832.7293629570293;832.8334333133398;4064.886259145228;4073.9796301018305;4086.754794712267;4105.34314509683;4110.856120035784;4750.453697824794;4832.202686556679;4834.540718631724;4844.273358996179;4845.927311090337;4149.585041495826;4150.522689890641;4156.916861662749;4166.708330416903;4183.079722461053;2625.1205846041407;2720.6055122007197;2884.754795842377;2904.3465220325256;2923.8099523530905;5065.848024559269;5077.441481437039;5080.882205914693;5091.541761241506;5103.336566246364;5369.4362091980565;5527.821502636;5547.278853748987;5585.3297604287745;5616.157576363496;5047.889464317917;5063.772130254148;5070.340855688737;5071.18860982241;5087.872803179876;5448.782048718007;5448.972755136199;5466.644668096561;5483.396826349019;5484.588655850747;5135.537801597874;5361.337985224593;5369.973150134224;5409.0527410131535;5419.2954915862265;5137;5152.227165925141;5162.9741851292;5166.199239117943;5179.274901513716;3434.3818112739946;3652.6712595866497;3733.290674771785;3760.8307626156343;3774.113083425338;5276.788928442819;5349.234752531733;5351.705656188947;5365.812196573102;5368.543673787772;5216.713080780593;5217.895642087061;5220.285451565241;5227.085260079395;5229.346331708536;5098.643094983316;5196.4283928767045;5211.843644690665;5220.347456567929;5232.686038837682;5124.769385377742;5137.383513978347;5146.970605878764;5168.793248270177;5206.713630750345;5243.397009343822;5282.177648711188;5284.7886084556185;5304.578546837191;5328.4671532846405;4997.875053123701;5128.3076784633595;5157.690538567698;5158.484151584811;5211.921821172609 19:19:40 INFO - PROCESS | 23520 | |5;yui.html;595.4908553187025;660.280294479018;701.705283780812;735.5366119344816;743.6356185469118;12404.627861164157;12865.292408917507;13157.210567365964;13398.196108233513;13417.664558386045;12125.33310667915;12336.136470447072;12358.320292383938;12362.505499779998;12398.814017789718;632.1339764522611;774.5468900693087;788.3614272439343;789.0255534414993;791.8416316736676;760.9885851712229;781.1992707474827;782.8277778888636;785.2226295967008;787.5078076202374;811.9553424561647;815.8123631564744;817.3910436724649;817.9550124743137;818.8280461103145;812.078291139555;817.15832692327;817.284875733733;817.4727300890921;818.1818181818181;593.5281451246269;594.3937184072265;594.4412252482653;597.041747994467;597.6025942748067;12833.03752218578;12865.228086314852;12868.935655321664;12914.677133071655;12957.416916238792;12851.678708032281;13152.276624785633;13284.269365184911;13367;13753.106048106842;10313.948430257875;10406.895931040668;10517.211209159268;10722.731931701692;10827.512761925733;3312.3540909522653;3344.916377090568;3363.9327213455595;3379.831008449568;3394.253264281854;59952.40047599556;62242;63450;63709.04436433504;64835.67582162106;9320.533973301443;9749.951250243703;9782.608695652236;9795.706128816148;9986.850197247048;19685.901570492057;19741;19797.109130089182;19928.90035549842;20280;6549.148610680581;6591.868162636721;6602.2407423146;6639.70121344531;6905.274946130584;3693.8891833245048;3707.5128809361754;3773.962260377416;3804.334241507725;3892.1826416452295;2855.2576330153893;2951.793374463767;2956.423497418026;2956.645202575705;2969.495185818416;494.60431654676114;506.7111746304571;521.1115048841716;521.3431076843129;531.1899353485887;498.9925151122736;592.238972919796;592.2567178191342;598.2850493660121;618.1191801682585;7014.754483593049;7312.926870731331;7395.408367330709;7559.28186822251;7766.262205090507;470.6423118430018;547.8110052032042;581.8807144535444;587.0929414055295;589.069270552526;3515.5957064937347;3758.342290099222;3773.8867833965023;3859.3824988001784;3902.180542086137;54968.15222934436;55618.72190639021;55779.442205578234;55808.441915581134;56001.15998260029;73414.63292683502;79958.6002069986;79981.20018799853;80476.59761701155;84655;69388;72895;74279.88580171301;74449.6277518609;75280;7121.679524421517;7221.205667376479;7368.778936631909;7422.6374052056535;7422.96288518554;43678.34482482829;44149.77925110354;44205.77897110623;44285.77857110694;44612.869520004315;61107.38892611017;61586.38413615986;61898;63252.367476324645;64906.675466624256;9779.608815647294;9890.604375824887;10054.396736195851;10064.094231519199;10064.798704026025;9824.115829575372;9966.40201587907;10775.892241077489;10998.945005275242;11001.339919604849;9560.904390956279;10131.7467063324;11669.59156429521;12028.083058373992;12058.155929085231;12181.75636487283;12195.451204695633;12535.435905384098;12848.421821018264;13377.799333009818;10782.299150555502;11355.261907975955;12149.81775273354;12211.328376939353;12231.266124032587;9925.3548519346;10470.581176752845;10505.789884202426;10616.256862019585;11191.384473854016;9342.299327550325;9502.287328450255;9589.437258793243;9653.613855445985;9967.700968970943 19:19:40 INFO - PROCESS | 23520 | __end_tp_report 19:19:40 INFO - PROCESS | 23520 | __start_cc_report 19:19:40 INFO - PROCESS | 23520 | _x_x_mozilla_cycle_collect,395 19:19:40 INFO - PROCESS | 23520 | __end_cc_report 19:19:40 INFO - PROCESS | 23520 | __startTimestamp1469153980479__endTimestamp 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | ------- Summary: start ------- 19:19:40 INFO - PROCESS | 23520 | Number of tests: 6 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | [#0] dojo.html Cycles:165 Average:4727.40 Median:4833.61 stddev:492.82 (10.2%) stddev-sans-first:466.63 19:19:40 INFO - PROCESS | 23520 | Values: 2650.5 2656.6 2657.0 2696.8 2706.1 4766.2 4780.0 4783.7 4798.4 4850.5 4639.0 4750.3 4776.4 4827.6 4833.6 4356.6 4385.8 4498.4 4501.4 4509.2 4442.1 4475.4 4493.9 4547.2 4585.2 4309.8 4379.8 4398.7 4429.6 4435.0 4430.7 4433.9 4439.5 4467.1 4482.1 4384.6 4411.9 4421.0 4425.1 4465.4 4692.0 4735.1 4758.0 4808.5 4819.8 5048.0 5072.7 5097.3 5110.2 5145.3 5104.6 5119.6 5123.3 5133.7 5141.0 4692.2 4736.2 4778.4 4792.6 4834.3 5237.5 5271.5 5283.7 5284.1 5295.0 5019.8 5037.0 5040.9 5061.7 5070.4 4951.7 5000.7 5113.8 5114.6 5128.2 5040.6 5060.0 5071.4 5100.5 5130.7 4938.7 5074.9 5076.1 5079.8 5115.7 4162.8 4257.6 4283.5 4302.2 4312.6 3775.9 3780.8 3803.4 3822.3 3822.9 4329.8 4368.3 4377.1 4379.5 4427.3 4954.2 5121.1 5170.6 5189.0 5204.8 4374.7 4378.5 4408.7 4410.9 4422.2 4600.3 4600.3 4611.8 4611.8 4646.6 4624.3 4775.7 4796.8 4816.5 4819.7 5162.6 5168.5 5168.8 5197.8 5219.3 4810.1 4817.2 4819.7 4823.2 4849.5 4961.4 5041.8 5067.0 5099.3 5124.5 5107.3 5120.2 5126.7 5162.0 5175.2 4959.0 4968.9 4973.8 4981.6 4985.3 4857.2 4928.7 4969.3 4993.3 5002.4 4867.1 4904.9 4912.5 4917.9 4938.9 5009.9 5019.7 5020.5 5028.3 5072.5 4759.0 4845.0 4869.4 4900.0 4946.1 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | [#1] ext.html Cycles:180 Average:45193.39 Median:35567.56 stddev:84978.81 (238.9%) stddev-sans-first:85151.10 19:19:40 INFO - PROCESS | 23520 | Values: 552.0 559.2 572.3 576.4 605.0 34601.3 38551.8 38821.2 38841.4 38924.8 39668.4 40336.4 40476.6 40534.8 40569.0 7516.6 7682.4 7710.4 7718.3 7737.3 7690.9 7699.7 7754.6 7758.8 7764.1 7843.1 7849.2 7852.4 7854.5 7879.8 7801.1 7812.8 7824.1 7828.9 7852.3 7741.0 7800.5 7806.1 7816.5 7820.8 35989.6 36444.3 36496.8 36554.3 36595.1 2642.3 3021.1 3111.6 3128.7 3149.5 25351.1 26706.3 27276.7 27597.2 27905.0 3222.2 3222.8 3245.2 3312.7 3366.4 214163.0 215238.0 216180.0 216605.0 217000.9 31698.7 32003.7 32223.5 32775.7 32825.0 34014.1 34104.7 34110.0 34218.5 34240.0 13480.4 13660.5 13667.6 13686.7 13704.1 11157.9 11195.1 11234.7 11281.2 11307.8 7812.1 7839.6 7877.1 7896.7 7922.8 3095.5 3096.5 3126.0 3162.3 3163.6 834.5 899.2 921.8 954.9 1002.9 27458.0 27602.9 27884.3 28291.4 28320.3 906.2 916.5 930.6 950.3 965.0 14198.2 15041.7 15106.6 15277.8 15316.5 384024.0 384759.0 389147.0 389686.0 389946.0 48815.3 49158.3 49284.3 49344.5 49595.3 1199.9 1203.9 1224.2 1233.9 1247.9 27134.0 27763.3 28230.6 28831.1 28873.9 42051.4 42632.8 42740.4 42765.0 42796.0 334253.0 336304.0 336779.0 337098.0 339055.0 25184.2 25524.0 25534.9 26352.6 26464.6 40243.0 40555.2 40903.4 41367.0 41625.4 36184.3 36417.3 36682.3 36809.4 36866.8 35112.8 35376.1 35666.3 35862.0 35934.1 34885.3 35508.5 35626.6 36135.0 36321.5 30296.2 31548.2 32042.2 32122.0 32430.8 24673.0 24716.3 24841.4 25066.9 25259.2 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | [#2] jquery.html Cycles:180 Average:26100.35 Median:5186.02 stddev:72934.28 (1406.4%) stddev-sans-first:73113.25 19:19:40 INFO - PROCESS | 23520 | Values: 349.6 353.7 358.7 361.7 379.5 15705.0 16553.5 16993.6 17130.9 17179.5 15705.5 16286.9 16461.7 16778.7 16862.4 4919.0 5173.3 5184.5 5187.5 5197.0 3758.3 5112.9 5640.3 5904.6 5915.1 5926.1 5954.7 5960.9 5966.9 5972.3 5937.0 5980.2 5994.3 6018.9 6019.7 5126.1 5206.1 5206.4 5233.5 5258.4 20594.4 20758.0 21034.0 21061.7 21193.5 1925.8 1938.7 2054.7 2169.8 2318.9 8439.7 9148.0 12836.7 13299.5 13492.9 1747.4 1790.6 1792.3 1803.3 1824.3 70467.0 72607.6 72924.3 73541.6 76451.6 9420.7 9793.9 9843.4 9909.6 9916.7 12765.9 13448.1 13485.3 13510.3 13535.0 7167.2 7281.0 7281.9 7385.0 7545.5 7091.6 7195.4 7379.9 7393.0 7470.7 3895.9 4095.8 4182.0 4204.9 4348.4 1621.7 1641.8 1750.6 1785.4 1797.2 793.6 849.8 895.7 900.4 911.2 16773.7 16778.0 16899.5 16984.2 17630.4 846.0 867.2 874.2 880.0 903.9 9178.0 9662.3 9690.6 9788.1 10019.3 435599.0 438732.0 443511.0 445647.0 446623.9 80303.6 84100.6 84774.2 85297.1 86104.6 935.0 936.3 991.6 993.1 997.1 13860.9 15730.0 16031.4 16119.4 16631.9 36725.0 37918.6 38114.6 39301.2 39478.4 47293.5 49808.3 53997.0 54456.5 55493.0 7130.4 7207.4 7301.7 7325.6 7351.9 6420.2 10129.3 10169.9 11088.6 11185.9 7503.0 8860.7 9439.7 9671.4 10040.1 10364.9 10473.9 10474.4 10474.8 10491.8 9696.6 9888.9 9928.4 10038.6 10347.2 7398.3 7500.3 7516.1 7588.4 7640.5 8437.3 9599.3 9714.2 10157.7 10298.3 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | [#3] mootools.html Cycles:180 Average:5197.36 Median:4945.42 stddev:2963.91 (59.9%) stddev-sans-first:2958.17 19:19:40 INFO - PROCESS | 23520 | Values: 1356.7 1389.1 1469.5 1668.8 1698.3 6699.4 7549.9 7589.4 8130.3 8149.2 7736.0 8033.9 8048.0 8050.2 8055.4 2166.2 2196.9 2200.6 2202.3 2208.2 2119.2 2174.1 2226.7 2234.1 2239.6 2200.8 2221.4 2234.3 2237.0 2242.3 2162.6 2176.8 2187.1 2189.1 2198.5 2127.6 2140.3 2153.0 2192.3 2194.8 8003.7 8050.3 8066.0 8068.2 8080.1 4609.1 4691.0 4725.5 4728.7 4738.0 2824.6 2911.3 2913.2 2960.4 2965.5 858.6 887.7 897.0 900.6 929.3 10975.9 11032.6 11033.7 11037.1 11038.3 3969.9 4172.4 4194.2 4329.2 4339.7 9365.1 9371.5 9395.7 9405.4 9405.8 4630.0 4636.4 4648.0 4655.1 4659.7 3643.7 4169.7 4272.4 4273.6 4299.1 3639.9 3674.3 3762.2 3764.1 3829.8 1207.3 1218.4 1241.0 1242.9 1243.6 807.5 815.4 818.7 821.4 831.9 5139.5 5147.8 5276.4 5341.9 5380.1 406.8 417.1 423.7 425.2 426.3 3402.3 3596.9 3617.7 3658.5 3662.8 9367.6 9963.4 9973.0 9977.7 10002.4 9080.1 9393.0 9437.9 9781.0 9952.6 7285.9 7295.6 7476.4 7538.2 7570.3 5285.2 5341.6 5474.5 5524.4 5550.8 9045.1 9134.8 9225.5 9308.8 9332.6 8681.5 9048.1 9110.9 9323.6 9324.0 5821.8 6464.1 6629.4 6650.8 6871.4 7702.8 7861.0 7867.4 7870.0 7873.3 6460.3 6670.1 6747.1 6753.3 6955.7 6663.4 6710.5 6779.8 6922.7 6975.7 6398.6 6431.4 6482.5 6498.5 6498.8 4421.9 4500.5 4573.2 4588.4 4619.7 4515.1 4537.9 4558.4 4637.1 4751.4 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | [#4] prototype.html Cycles:180 Average:4308.13 Median:4955.55 stddev:1275.35 (25.7%) stddev-sans-first:1242.80 19:19:40 INFO - PROCESS | 23520 | Values: 292.3 301.2 305.6 308.7 309.7 4912.6 4942.3 4991.6 5067.4 5107.7 4967.9 4986.7 4989.6 5001.9 5012.3 3971.4 3983.2 3983.8 3989.1 4009.5 3850.8 3926.3 3987.3 3989.4 3991.7 3875.7 3905.3 3911.7 3912.8 3929.0 3902.6 3911.3 3913.3 3916.4 3933.9 3269.0 3383.7 3398.8 3469.5 3479.6 4883.3 4901.0 4908.9 4943.2 4987.3 4402.5 4454.5 4457.7 4466.7 4470.9 5037.8 5237.5 5250.4 5267.5 5295.0 3588.2 3596.4 3600.1 3611.7 3619.2 5540.4 5549.2 5551.9 5573.2 5573.8 3688.7 3773.4 3780.4 3805.6 3814.7 3759.3 3784.1 3799.7 3804.8 3831.4 4370.0 4376.6 4385.3 4385.8 4392.8 5253.4 5254.2 5277.4 5279.2 5295.0 1262.4 1292.4 1305.6 1319.1 1330.2 789.9 828.7 829.3 832.7 832.8 4064.9 4074.0 4086.8 4105.3 4110.9 4750.5 4832.2 4834.5 4844.3 4845.9 4149.6 4150.5 4156.9 4166.7 4183.1 2625.1 2720.6 2884.8 2904.3 2923.8 5065.8 5077.4 5080.9 5091.5 5103.3 5369.4 5527.8 5547.3 5585.3 5616.2 5047.9 5063.8 5070.3 5071.2 5087.9 5448.8 5449.0 5466.6 5483.4 5484.6 5135.5 5361.3 5370.0 5409.1 5419.3 5137.0 5152.2 5163.0 5166.2 5179.3 3434.4 3652.7 3733.3 3760.8 3774.1 5276.8 5349.2 5351.7 5365.8 5368.5 5216.7 5217.9 5220.3 5227.1 5229.3 5098.6 5196.4 5211.8 5220.3 5232.7 5124.8 5137.4 5147.0 5168.8 5206.7 5243.4 5282.2 5284.8 5304.6 5328.5 4997.9 5128.3 5157.7 5158.5 5211.9 19:19:40 INFO - PROCESS | 23520 | 19:19:40 INFO - PROCESS | 23520 | [#5] yui.html Cycles:180 Average:16313.45 Median:55904.80 stddev:22031.31 (39.4%) stddev-sans-first:22061.50 19:19:40 INFO - PROCESS | 23520 | Values: 595.5 660.3 701.7 735.5 743.6 12404.6 12865.3 13157.2 13398.2 13417.7 12125.3 12336.1 12358.3 12362.5 12398.8 632.1 774.5 788.4 789.0 791.8 761.0 781.2 782.8 785.2 787.5 812.0 815.8 817.4 818.0 818.8 812.1 817.2 817.3 817.5 818.2 593.5 594.4 594.4 597.0 597.6 12833.0 12865.2 12868.9 12914.7 12957.4 12851.7 13152.3 13284.3 13367.0 13753.1 10313.9 10406.9 10517.2 10722.7 10827.5 3312.4 3344.9 3363.9 3379.8 3394.3 59952.4 62242.0 63450.0 63709.0 64835.7 9320.5 9750.0 9782.6 9795.7 9986.9 19685.9 19741.0 19797.1 19928.9 20280.0 6549.1 6591.9 6602.2 6639.7 6905.3 3693.9 3707.5 3774.0 3804.3 3892.2 2855.3 2951.8 2956.4 2956.6 2969.5 494.6 506.7 521.1 521.3 531.2 499.0 592.2 592.3 598.3 618.1 7014.8 7312.9 7395.4 7559.3 7766.3 470.6 547.8 581.9 587.1 589.1 3515.6 3758.3 3773.9 3859.4 3902.2 54968.2 55618.7 55779.4 55808.4 56001.2 73414.6 79958.6 79981.2 80476.6 84655.0 69388.0 72895.0 74279.9 74449.6 75280.0 7121.7 7221.2 7368.8 7422.6 7423.0 43678.3 44149.8 44205.8 44285.8 44612.9 61107.4 61586.4 61898.0 63252.4 64906.7 9779.6 9890.6 10054.4 10064.1 10064.8 9824.1 9966.4 10775.9 10998.9 11001.3 9560.9 10131.7 11669.6 12028.1 12058.2 12181.8 12195.5 12535.4 12848.4 13377.8 10782.3 11355.3 12149.8 12211.3 12231.3 9925.4 10470.6 10505.8 10616.3 11191.4 9342.3 9502.3 9589.4 9653.6 9967.7 19:19:40 INFO - PROCESS | 23520 | -------- Summary: end -------- 19:19:40 INFO - PROCESS | 23520 | 19:19:41 INFO - TEST-INFO | 23520: exit 0 19:19:41 INFO - TEST-OK | dromaeo_css | took 1117110ms 19:19:41 INFO - TEST-START | kraken 19:19:41 INFO - operating with platform_type : linux_ 19:19:41 INFO - Initialising browser for kraken test... 19:19:41 INFO - TEST-INFO | started process 23765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBqs61X/profile http://localhost:55438/getInfo.html) 19:19:44 INFO - PROCESS | 23765 | JavaScript error: , line 0: uncaught exception: undefined 19:19:45 INFO - PROCESS | 23765 | __metrics Screen width/height:1600/1200 19:19:45 INFO - PROCESS | 23765 | colorDepth:24 19:19:45 INFO - PROCESS | 23765 | Browser inner width/height: 1024/697 19:19:45 INFO - PROCESS | 23765 | __metrics 19:19:46 ERROR - PROCESS | 23765 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:19:47 INFO - TEST-INFO | 23765: exit 0 19:19:47 INFO - Browser initialized. 19:19:47 INFO - Running cycle 1/1 for kraken test... 19:19:47 INFO - TEST-INFO | started process 23886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBqs61X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:59 INFO - PROCESS | 23886 | RSS: Main: 169078784 19:19:59 INFO - PROCESS | 23886 | 19:20:01 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:02 INFO - PROCESS | 23886 | RSS: Main: 174895104 19:20:02 INFO - PROCESS | 23886 | 19:20:05 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-dft) 19:20:06 INFO - PROCESS | 23886 | RSS: Main: 173625344 19:20:06 INFO - PROCESS | 23886 | 19:20:09 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-fft) 19:20:09 INFO - PROCESS | 23886 | RSS: Main: 169668608 19:20:09 INFO - PROCESS | 23886 | 19:20:11 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-oscillator) 19:20:12 INFO - PROCESS | 23886 | RSS: Main: 170405888 19:20:12 INFO - PROCESS | 23886 | 19:20:14 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:15 INFO - PROCESS | 23886 | RSS: Main: 170479616 19:20:15 INFO - PROCESS | 23886 | 19:20:18 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:19 INFO - PROCESS | 23886 | RSS: Main: 170967040 19:20:19 INFO - PROCESS | 23886 | 19:20:22 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:23 INFO - PROCESS | 23886 | RSS: Main: 167755776 19:20:23 INFO - PROCESS | 23886 | 19:20:26 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55438/tests/kraken/driver.html?testName=json-parse-financial) 19:20:27 INFO - PROCESS | 23886 | RSS: Main: 169922560 19:20:27 INFO - PROCESS | 23886 | 19:20:28 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:29 INFO - PROCESS | 23886 | RSS: Main: 170237952 19:20:29 INFO - PROCESS | 23886 | 19:20:31 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:32 INFO - PROCESS | 23886 | RSS: Main: 170807296 19:20:32 INFO - PROCESS | 23886 | 19:20:34 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:35 INFO - PROCESS | 23886 | RSS: Main: 171057152 19:20:35 INFO - PROCESS | 23886 | 19:20:37 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:38 INFO - PROCESS | 23886 | RSS: Main: 171528192 19:20:38 INFO - PROCESS | 23886 | 19:20:41 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:41 INFO - PROCESS | 23886 | RSS: Main: 171069440 19:20:41 INFO - PROCESS | 23886 | 19:20:43 INFO - PROCESS | 23886 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55438/tests/kraken/driver.html?testName=ai-astar) 19:20:43 INFO - PROCESS | 23886 | RSS: Main: 171933696 19:20:43 INFO - PROCESS | 23886 | 19:20:43 INFO - PROCESS | 23886 | __start_tp_report 19:20:43 INFO - PROCESS | 23886 | _x_x_mozilla_page_load 19:20:43 INFO - PROCESS | 23886 | _x_x_mozilla_page_load_details 19:20:43 INFO - PROCESS | 23886 | |i|pagename|runs| 19:20:43 INFO - PROCESS | 23886 | |0;ai-astar;105;114;108;116;113;116;118;113;112;113 19:20:43 INFO - PROCESS | 23886 | |1;audio-beat-detection;145;124;152;191;124;145;152;127;194;123 19:20:43 INFO - PROCESS | 23886 | |2;audio-dft;165;163;167;167;169;165;163;162;163;163 19:20:43 INFO - PROCESS | 23886 | |3;audio-fft;77;79;77;153;78;77;77;78;173;76 19:20:43 INFO - PROCESS | 23886 | |4;audio-oscillator;86;87;151;87;88;85;144;85;86;139 19:20:43 INFO - PROCESS | 23886 | |5;imaging-gaussian-blur;121;118;118;118;119;117;118;118;118;123 19:20:43 INFO - PROCESS | 23886 | |6;imaging-darkroom;149;148;148;148;147;149;148;149;147;148 19:20:44 INFO - PROCESS | 23886 | |7;imaging-desaturate;96;102;96;96;95;96;97;101;96;95 19:20:44 INFO - PROCESS | 23886 | |8;json-parse-financial;63;65;62;62;64;61;64;61;62;68 19:20:44 INFO - PROCESS | 23886 | |9;json-stringify-tinderbox;66;66;65;65;66;66;65;66;66;66 19:20:44 INFO - PROCESS | 23886 | |10;stanford-crypto-aes;84;81;82;80;82;96;80;81;85;80 19:20:44 INFO - PROCESS | 23886 | |11;stanford-crypto-ccm;136;129;136;143;139;135;138;141;171;138 19:20:44 INFO - PROCESS | 23886 | |12;stanford-crypto-pbkdf2;165;168;172;164;170;165;178;181;172;165 19:20:44 INFO - PROCESS | 23886 | |13;stanford-crypto-sha256-iterative;69;67;75;73;69;69;68;67;67;71 19:20:44 INFO - PROCESS | 23886 | __end_tp_report 19:20:44 INFO - PROCESS | 23886 | __start_cc_report 19:20:44 INFO - PROCESS | 23886 | _x_x_mozilla_cycle_collect,1022 19:20:44 INFO - PROCESS | 23886 | __end_cc_report 19:20:44 INFO - PROCESS | 23886 | __startTimestamp1469154043993__endTimestamp 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | ------- Summary: start ------- 19:20:44 INFO - PROCESS | 23886 | Number of tests: 14 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.50 stddev:3.85 (3.4%) stddev-sans-first:2.87 19:20:44 INFO - PROCESS | 23886 | Values: 105.0 114.0 108.0 116.0 113.0 116.0 118.0 113.0 112.0 113.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:148.50 stddev:26.31 (17.7%) stddev-sans-first:27.89 19:20:44 INFO - PROCESS | 23886 | Values: 145.0 124.0 152.0 191.0 124.0 145.0 152.0 127.0 194.0 123.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 19:20:44 INFO - PROCESS | 23886 | Values: 165.0 163.0 167.0 167.0 169.0 165.0 163.0 162.0 163.0 163.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#3] audio-fft Cycles:10 Average:94.50 Median:77.00 stddev:36.42 (47.3%) stddev-sans-first:38.07 19:20:44 INFO - PROCESS | 23886 | Values: 77.0 79.0 77.0 153.0 78.0 77.0 77.0 78.0 173.0 76.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:86.00 stddev:28.36 (33.0%) stddev-sans-first:29.34 19:20:44 INFO - PROCESS | 23886 | Values: 86.0 87.0 151.0 87.0 88.0 85.0 144.0 85.0 86.0 139.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:118.00 stddev:1.81 (1.5%) stddev-sans-first:1.74 19:20:44 INFO - PROCESS | 23886 | Values: 121.0 118.0 118.0 118.0 119.0 117.0 118.0 118.0 118.0 123.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 19:20:44 INFO - PROCESS | 23886 | Values: 149.0 148.0 148.0 148.0 147.0 149.0 148.0 149.0 147.0 148.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.45 (2.6%) stddev-sans-first:2.57 19:20:44 INFO - PROCESS | 23886 | Values: 96.0 102.0 96.0 96.0 95.0 96.0 97.0 101.0 96.0 95.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:2.15 (3.4%) stddev-sans-first:2.28 19:20:44 INFO - PROCESS | 23886 | Values: 63.0 65.0 62.0 62.0 64.0 61.0 64.0 61.0 62.0 68.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 19:20:44 INFO - PROCESS | 23886 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 65.0 66.0 66.0 66.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:4.84 (5.9%) stddev-sans-first:5.12 19:20:44 INFO - PROCESS | 23886 | Values: 84.0 81.0 82.0 80.0 82.0 96.0 80.0 81.0 85.0 80.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:138.50 stddev:11.33 (8.2%) stddev-sans-first:11.89 19:20:44 INFO - PROCESS | 23886 | Values: 136.0 129.0 136.0 143.0 139.0 135.0 138.0 141.0 171.0 138.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.00 stddev:5.85 (3.4%) stddev-sans-first:5.92 19:20:44 INFO - PROCESS | 23886 | Values: 165.0 168.0 172.0 164.0 170.0 165.0 178.0 181.0 172.0 165.0 19:20:44 INFO - PROCESS | 23886 | 19:20:44 INFO - PROCESS | 23886 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:2.72 (3.9%) stddev-sans-first:2.88 19:20:44 INFO - PROCESS | 23886 | Values: 69.0 67.0 75.0 73.0 69.0 69.0 68.0 67.0 67.0 71.0 19:20:44 INFO - PROCESS | 23886 | -------- Summary: end -------- 19:20:44 INFO - PROCESS | 23886 | 19:20:45 INFO - TEST-INFO | 23886: exit 0 19:20:45 INFO - TEST-OK | kraken | took 63880ms 19:20:45 INFO - SUITE-END | took 1180s 19:20:45 INFO - Completed test suite (00:19:41) 19:20:45 INFO - javascript benchmark 19:20:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6316.514481594468, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.522905876942, 2656.6015097735335, 2656.9999999999995, 2696.811223214376, 2706.134037108126, 4766.189747742887, 4780.043991201761, 4783.712977221369, 4798.4001999750035, 4850.514948505148, 4638.9794245266075, 4750.311204875291, 4776.355192049073, 4827.637927155469, 4833.613310935126, 4356.564343565642, 4385.758783266919, 4498.392716983214, 4501.414816073922, 4509.165804326194, 4442.089371678814, 4475.39582156408, 4493.865184044484, 4547.1587756265035, 4585.151746926813, 4309.82760689572, 4379.781010949439, 4398.670099742532, 4429.579189976979, 4434.955650443519, 4430.667699922518, 4433.933490997638, 4439.511653718088, 4467.061916997434, 4482.125985432842, 4384.649228061748, 4411.933820992687, 4420.977895110536, 4425.070735145623, 4465.37484752135, 4691.976540117277, 4735.052989402099, 4758.048390321915, 4808.471068182497, 4819.831305904311, 5048.0, 5072.67027643202, 5097.286379906816, 5110.233464980245, 5145.279660847485, 5104.566111880495, 5119.56483698886, 5123.3339665843205, 5133.6919784813035, 5141.0, 4692.202325604621, 4736.194846876039, 4778.402699662543, 4792.640551958617, 4834.250691142878, 5237.528622424, 5271.499207575274, 5283.682979021271, 5284.101702710548, 5295.046891559557, 5019.824306149268, 5037.042961837239, 5040.949590504048, 5061.746912654353, 5070.442251352349, 4951.702897826142, 5000.674956127913, 5113.769880355393, 5114.5652619527755, 5128.153854614022, 5040.571551418097, 5060.038592667382, 5071.442141364447, 5100.515451032146, 5130.666506677054, 4938.703677779273, 5074.873128171751, 5076.086304465158, 5079.847604571869, 5115.667481613683, 4162.8334866605, 4257.595528424795, 4283.507396649426, 4302.182585308781, 4312.649675630236, 3775.867844625425, 3780.8109594520715, 3803.4294855771304, 3822.27376798413, 3822.9235415292096, 4329.848455304049, 4368.257396242647, 4377.058932329564, 4379.4525684289465, 4427.335899615084, 4954.182559877652, 5121.129408000649, 5170.586353091744, 5188.9740551297755, 5204.8178313758835, 4374.693771436033, 4378.496472905656, 4408.735475871458, 4410.911781764346, 4422.181896349121, 4600.2869555218995, 4600.332951722048, 4611.769411529477, 4611.792469338888, 4646.581807637329, 4624.28323609841, 4775.689580177277, 4796.760161991956, 4816.470188279286, 4819.734914579732, 5162.612804039787, 5168.483151684952, 5168.767405466839, 5197.8440646780655, 5219.347581552306, 4810.11012962603, 4817.205161148371, 4819.6867203631655, 4823.1800593898415, 4849.4908034655855, 4961.404631444249, 5041.823536176216, 5066.974665126798, 5099.337086178922, 5124.513171248875, 5107.336046314104, 5120.18077107661, 5126.666766660155, 5162.045021671003, 5175.171972484384, 4958.975205123951, 4968.900621987612, 4973.751312434291, 4981.576565991932, 4985.277134815359, 4857.247126695368, 4928.67963582366, 4969.304297398439, 4993.300937868774, 5002.374703162105, 4867.123917694849, 4904.92642610354, 4912.459629440687, 4917.852464426073, 4938.8765280868265, 5009.949900500948, 5019.67372120811, 5020.548150666457, 5028.270900719448, 5072.51811077947, 4759.024399998061, 4844.95155048445, 4869.440014398389, 4900.019996000743, 4946.134426475424], "value": 4696.04836396297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.9724013799306, 559.1696330948541, 572.3418069220396, 576.4063015094453, 604.9987271066386, 34601.30797384051, 38551.80724096375, 38821.22357552847, 38841.417378739345, 38924.80537597315, 39668.40497392534, 40336.39495407564, 40476.59523404765, 40534.7973260134, 40569.0, 7516.5865877376855, 7682.385409167253, 7710.383169346439, 7718.266764657348, 7737.303642672158, 7690.923090769104, 7699.6920123195005, 7754.612269386508, 7758.806029849243, 7764.068311802592, 7843.098043724987, 7849.215078492133, 7852.411069169807, 7854.450188486809, 7879.763607091796, 7801.1028731696015, 7812.843743125106, 7824.1002284737415, 7828.921710782934, 7852.293293603546, 7741.0, 7800.453968222227, 7806.0632724073475, 7816.53100813953, 7820.804479887991, 35989.64010359889, 36444.27111457756, 36496.81751591225, 36554.268914621825, 36595.0723942084, 2642.3394151462135, 3021.0936718984217, 3111.579936708538, 3128.7340576051065, 3149.4803357445994, 25351.112711055026, 26706.332341691417, 27276.72723272762, 27597.172084837486, 27905.0, 3222.2266656002625, 3222.822744749038, 3245.2211469247445, 3312.6521715219797, 3366.394049071166, 214163.0, 215238.0, 216180.0, 216605.0, 217000.91499542558, 31698.683013170034, 32003.67996320007, 32223.51664725031, 32775.67224327774, 32825.0, 34014.149646259044, 34104.658953410646, 34110.0, 34218.48672269918, 34240.0, 13480.39338229782, 13660.52188173429, 13667.589972300846, 13686.65783355424, 13704.10923289983, 11157.888421115686, 11195.104391648649, 11234.7191320216, 11281.21031527785, 11307.773844523228, 7812.140664526897, 7839.568823714636, 7877.109493721466, 7896.7236146734585, 7922.762317130495, 3095.4892442747146, 3096.5200393938976, 3125.9531107033413, 3162.256869635634, 3163.636181839072, 834.4951304460835, 899.2042042792045, 921.7787730944659, 954.9427034377959, 1002.8846682631445, 27458.0, 27602.861985689942, 27884.30289242785, 28291.43417131687, 28320.291992700346, 906.1934877958622, 916.4913473022536, 930.6370515498961, 950.3442624589012, 965.034965034965, 14198.219097949504, 15041.699166016619, 15106.622334441507, 15277.770833437507, 15316.540503784905, 384024.0, 384759.0, 389147.0, 389686.0, 389946.0, 48815.26777098346, 49158.26262606064, 49284.26073608899, 49344.50655493471, 49595.25607115896, 1199.8920097191294, 1203.94704219766, 1224.179799534314, 1233.9136260461862, 1247.9188852724544, 27134.0, 27763.305917352227, 28230.576541351486, 28831.135065948056, 28873.85563072171, 42051.36922946097, 42632.78683606562, 42740.35889461599, 42765.0, 42796.0, 334253.0, 336304.0, 336779.0, 337098.0, 339055.0, 25184.24447266585, 25524.0, 25534.872325638255, 26352.60471092897, 26464.6181843635, 40243.0, 40555.18889622132, 40903.38644920388, 41366.9658258546, 41625.37561936634, 36184.27631447409, 36417.27165456729, 36682.26635467329, 36809.44785828161, 36866.8156659215, 35112.82443587766, 35376.11559711028, 35666.286674266885, 35862.0, 35934.10164745902, 34885.30229395449, 35508.46737298891, 35626.643733562334, 36135.0, 36321.45517817288, 30296.242593935327, 31548.211294717814, 32042.193670949546, 32122.0, 32430.83784581062, 24673.0, 24716.25851224466, 24841.378965526008, 25066.874665626554, 25259.242222733348], "value": 16112.07208120961, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.59097855509054, 353.6922877096926, 358.72736720092723, 361.6889475051455, 379.45548138421384, 15705.0, 16553.503394898158, 16993.575160620992, 17130.914345428257, 17179.484615461526, 15705.528834134966, 16286.94134881232, 16461.670766584662, 16778.74831877523, 16862.409815656454, 4919.040787046527, 5173.275741396207, 5184.53339199472, 5187.507186817265, 5197.0, 3758.3422900992355, 5112.923306150411, 5640.266765320503, 5904.645721256738, 5915.053591425372, 5926.051831706928, 5954.70226488676, 5960.9403905961035, 5966.8806623867495, 5972.3131839838325, 5937.0, 5980.192673989021, 5994.340622531518, 6018.939810601882, 6019.72911218994, 5126.102931986925, 5206.088934436459, 5206.37523497179, 5233.476652334774, 5258.447862974409, 20594.38216853497, 20757.962101894995, 21034.0, 21061.684074738892, 21193.47016324589, 1925.7881633020356, 1938.6607343714793, 2054.6917962305624, 2169.8264138869013, 2318.921701408853, 8439.662413503453, 9148.039455857106, 12836.743265134739, 13299.468021279234, 13492.865071349259, 1747.3709464592737, 1790.5702631368508, 1792.3278770461077, 1803.332766876251, 1824.2885274742862, 70467.0, 72607.63696181591, 72924.27075729228, 73541.63229183819, 76451.6177419115, 9420.717378478657, 9793.853092203623, 9843.360181588174, 9909.554070066864, 9916.702498925044, 12765.93617031909, 13448.1258718183, 13485.258310792804, 13510.256935868425, 13534.98487613433, 7167.247439018932, 7281.0, 7281.890771638429, 7384.96307518459, 7545.471816972759, 7091.609961452066, 7195.388391986635, 7379.88930166048, 7392.96303518479, 7470.663820128108, 3895.902602434905, 4095.795210239476, 4181.97909010453, 4204.8528301509305, 4348.412964249849, 1621.7324141516754, 1641.8358164183487, 1750.6323672028761, 1785.446511581414, 1797.164318591835, 793.6230290611913, 849.8172892827948, 895.7268033249791, 900.4282280751639, 911.1981456318398, 16773.6645267094, 16778.0, 16899.49301520932, 16984.21665725081, 17630.382936597158, 845.9703910363231, 867.1631875240423, 874.2044739287218, 879.9736007919645, 903.8599017152352, 9177.954110229406, 9662.275329350327, 9690.612375505041, 9788.119069283799, 10019.298649094639, 435599.0, 438732.0, 443511.0, 445647.0, 446623.90192441415, 80303.59848200838, 84100.57949710212, 84774.15225847786, 85297.14702852893, 86104.56947715221, 934.9813003739887, 936.3258453913172, 991.5736233419699, 993.0913214408735, 997.1225321716988, 13860.861391385957, 15730.0, 16031.438899638457, 16119.43581974672, 16631.91684041572, 36725.0, 37918.620813792615, 38114.61885381111, 39301.21397571975, 39478.40782388324, 47293.527064728914, 49808.25287620761, 53997.0, 54456.45543544514, 55493.0, 7130.393916517154, 7207.351338379362, 7301.671424786004, 7325.633718313957, 7351.8529629408185, 6420.1974753155855, 10129.290949633749, 10169.9491502542, 11088.556457741923, 11185.944070279596, 7503.0, 8860.689875854572, 9439.716808495756, 9671.371360861522, 10040.096391324816, 10364.948175259377, 10473.9476302618, 10474.371537707762, 10474.790504189721, 10491.809802370974, 9696.5636546357, 9888.851667224853, 9928.354656947275, 10038.598456061676, 10347.172226222036, 7398.3341499265325, 7500.287472690085, 7516.0980682316285, 7588.392928565812, 7640.503367281109, 8437.325013998743, 9599.32804703664, 9714.174295184706, 10157.714514234238, 10298.279120461495], "value": 8282.39047505203, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.7015256643535, 1389.0554422992363, 1469.47099044344, 1668.8498035176847, 1698.2782317515052, 6699.430548403379, 7549.886751698729, 7589.354904833089, 8130.349572034231, 8149.225823546761, 7735.961320193405, 8033.879491807627, 8047.959760201205, 8050.235227653364, 8055.395845311596, 2166.1660260799586, 2196.901139448729, 2200.6148923938326, 2202.284257616281, 2208.182972300243, 2119.247667078188, 2174.13034786086, 2226.6993955816, 2234.1175235781857, 2239.552089582082, 2200.834937379695, 2221.4224301681515, 2234.3408694435097, 2237.0, 2242.3048854854965, 2162.610730068587, 2176.771438998906, 2187.1142187414043, 2189.0696454007143, 2198.4503874031493, 2127.5532138250987, 2140.3257973738223, 2153.0203757290396, 2192.3094225318973, 2194.780521947808, 8003.679852805881, 8050.315723163538, 8066.0, 8068.152843951418, 8080.070791858952, 4609.0551436955675, 4690.976545117287, 4725.503822098664, 4728.71627702339, 4738.0, 2824.6327977363017, 2911.30128769096, 2913.1988703106817, 2960.4375168717875, 2965.4662160811044, 858.5921687198593, 887.6715615222345, 897.0, 900.6352427266968, 929.256594724218, 10975.890241097566, 11032.558697652084, 11033.724156896062, 11037.0618497427, 11038.337699738042, 3969.920601587952, 4172.3532852407925, 4194.182134483746, 4329.155814616182, 4339.674524410681, 9365.063493650581, 9371.48456834867, 9395.671151509801, 9405.388649737744, 9405.76485587852, 4629.976850115795, 4636.44362676481, 4648.0, 4655.138799322136, 4659.673822832437, 3643.708503319728, 4169.708120431601, 4272.380504826782, 4273.572642735764, 4299.14017196562, 3639.890803275906, 3674.3018826422895, 3762.172322089136, 3764.134249122717, 3829.8468061277795, 1207.3419986107592, 1218.3908045977012, 1240.9503619855286, 1242.8694987026413, 1243.5523211643801, 807.5275963561265, 815.3803109636718, 818.6970820796344, 821.4044817507379, 831.9251267385844, 5139.486051394905, 5147.819826306136, 5276.36683597963, 5341.893162136736, 5380.112281473513, 406.8250652219574, 417.1011470281548, 423.7118759243744, 425.18789112794417, 426.34343111608393, 3402.3365443738235, 3596.9029446019217, 3617.7286703497343, 3658.506101676293, 3662.7802331860175, 9367.62529498826, 9963.352382095141, 9973.0, 9977.650782222732, 10002.44986525748, 9080.137386948229, 9393.0, 9437.867455905198, 9780.951095244478, 9952.552135153936, 7285.927140728631, 7295.598742069237, 7476.401887848959, 7538.170801211862, 7570.280823321776, 5285.233641122093, 5341.599380046434, 5474.507294343528, 5524.364698059774, 5550.750216240198, 9045.140711632384, 9134.817303654023, 9225.538723063954, 9308.767280818034, 9332.626694932127, 8681.479111253346, 9048.140426659456, 9110.863337050083, 9323.627054917999, 9323.953380233055, 5821.825345239649, 6464.0627109069865, 6629.370209830058, 6650.833729156616, 6871.381575658214, 7702.845943081219, 7860.960695196487, 7867.449278550675, 7870.0, 7873.291403773688, 6460.25707043696, 6670.132882725215, 6747.089142965637, 6753.2909044549615, 6955.652217389212, 6663.400293973566, 6710.496712746466, 6779.762708305186, 6922.688479018557, 6975.651217439209, 6398.648074355955, 6431.356864313531, 6482.546221764431, 6498.480121590167, 6498.772542960974, 4421.933670994873, 4500.504944456173, 4573.245414506569, 4588.403507543998, 4619.676622636383, 4515.14212299662, 4537.886552836206, 4558.430196225472, 4637.1421287062, 4751.358566593465], "value": 4100.2523858845125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.3043157285658, 301.21683622581287, 305.6195037178713, 308.67743208347275, 309.65782809994954, 4912.557869791718, 4942.3080768692325, 4991.600671946245, 5067.442581316052, 5107.719075450854, 4967.900641987158, 4986.725730084844, 4989.57588604969, 5001.924971125436, 5012.273220383051, 3971.424143499191, 3983.223271462066, 3983.8008099594904, 3989.1024519483176, 4009.5341365060494, 3850.7689538627633, 3926.2540117377607, 3987.282289187945, 3989.381645844884, 3991.720579559432, 3875.748076375027, 3905.258000979819, 3911.6870650348046, 3912.8239229234755, 3928.960710392888, 3902.64876161144, 3911.256861196392, 3913.334733095352, 3916.432117342998, 3933.8819835404984, 3269.0, 3383.6803646577855, 3398.83005849709, 3469.5489586353865, 3479.5998460176897, 4883.267509873547, 4901.01979604077, 4908.852734417973, 4943.209086546171, 4987.276844857512, 4402.493713222988, 4454.48773391061, 4457.710248833848, 4466.731996080213, 4470.932936005963, 5037.848864534069, 5237.481130472159, 5250.44870288618, 5267.499587539178, 5294.97352513235, 3588.2105936693883, 3596.406592912166, 3600.117971097098, 3611.7110631149444, 3619.2399596084592, 5540.445955404468, 5549.19536667185, 5551.861203469905, 5573.21974923507, 5573.832785016456, 3688.686461650736, 3773.4339849022317, 3780.432935059763, 3805.6384643458828, 3814.6566808987322, 3759.285735710206, 3784.148566572499, 3799.677027452642, 3804.7907365094634, 3831.3869780834934, 4369.956300436955, 4376.627986621109, 4385.342198670225, 4385.780710964503, 4392.758398288061, 5253.3958594761325, 5254.1856012317385, 5277.393099793496, 5279.1817268323475, 5294.97352513235, 1262.4255963536568, 1292.405493473013, 1305.6017914536158, 1319.089828018664, 1330.2284674888542, 789.8586542446225, 828.7265202483167, 829.3199576347458, 832.7293629570293, 832.8334333133398, 4064.886259145228, 4073.9796301018305, 4086.754794712267, 4105.34314509683, 4110.856120035784, 4750.453697824794, 4832.202686556679, 4834.540718631724, 4844.273358996179, 4845.927311090337, 4149.585041495826, 4150.522689890641, 4156.916861662749, 4166.708330416903, 4183.079722461053, 2625.1205846041407, 2720.6055122007197, 2884.754795842377, 2904.3465220325256, 2923.8099523530905, 5065.848024559269, 5077.441481437039, 5080.882205914693, 5091.541761241506, 5103.336566246364, 5369.4362091980565, 5527.821502636, 5547.278853748987, 5585.3297604287745, 5616.157576363496, 5047.889464317917, 5063.772130254148, 5070.340855688737, 5071.18860982241, 5087.872803179876, 5448.782048718007, 5448.972755136199, 5466.644668096561, 5483.396826349019, 5484.588655850747, 5135.537801597874, 5361.337985224593, 5369.973150134224, 5409.0527410131535, 5419.2954915862265, 5137.0, 5152.227165925141, 5162.9741851292, 5166.199239117943, 5179.274901513716, 3434.3818112739946, 3652.6712595866497, 3733.290674771785, 3760.8307626156343, 3774.113083425338, 5276.788928442819, 5349.234752531733, 5351.705656188947, 5365.812196573102, 5368.543673787772, 5216.713080780593, 5217.895642087061, 5220.285451565241, 5227.085260079395, 5229.346331708536, 5098.643094983316, 5196.4283928767045, 5211.843644690665, 5220.347456567929, 5232.686038837682, 5124.769385377742, 5137.383513978347, 5146.970605878764, 5168.793248270177, 5206.713630750345, 5243.397009343822, 5282.177648711188, 5284.7886084556185, 5304.578546837191, 5328.4671532846405, 4997.875053123701, 5128.3076784633595, 5157.690538567698, 5158.484151584811, 5211.921821172609], "value": 3897.887200439899, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.4908553187025, 660.280294479018, 701.705283780812, 735.5366119344816, 743.6356185469118, 12404.627861164157, 12865.292408917507, 13157.210567365964, 13398.196108233513, 13417.664558386045, 12125.33310667915, 12336.136470447072, 12358.320292383938, 12362.505499779998, 12398.814017789718, 632.1339764522611, 774.5468900693087, 788.3614272439343, 789.0255534414993, 791.8416316736676, 760.9885851712229, 781.1992707474827, 782.8277778888636, 785.2226295967008, 787.5078076202374, 811.9553424561647, 815.8123631564744, 817.3910436724649, 817.9550124743137, 818.8280461103145, 812.078291139555, 817.15832692327, 817.284875733733, 817.4727300890921, 818.1818181818181, 593.5281451246269, 594.3937184072265, 594.4412252482653, 597.041747994467, 597.6025942748067, 12833.03752218578, 12865.228086314852, 12868.935655321664, 12914.677133071655, 12957.416916238792, 12851.678708032281, 13152.276624785633, 13284.269365184911, 13367.0, 13753.106048106842, 10313.948430257875, 10406.895931040668, 10517.211209159268, 10722.731931701692, 10827.512761925733, 3312.3540909522653, 3344.916377090568, 3363.9327213455595, 3379.831008449568, 3394.253264281854, 59952.40047599556, 62242.0, 63450.0, 63709.04436433504, 64835.67582162106, 9320.533973301443, 9749.951250243703, 9782.608695652236, 9795.706128816148, 9986.850197247048, 19685.901570492057, 19741.0, 19797.109130089182, 19928.90035549842, 20280.0, 6549.148610680581, 6591.868162636721, 6602.2407423146, 6639.70121344531, 6905.274946130584, 3693.8891833245048, 3707.5128809361754, 3773.962260377416, 3804.334241507725, 3892.1826416452295, 2855.2576330153893, 2951.793374463767, 2956.423497418026, 2956.645202575705, 2969.495185818416, 494.60431654676114, 506.7111746304571, 521.1115048841716, 521.3431076843129, 531.1899353485887, 498.9925151122736, 592.238972919796, 592.2567178191342, 598.2850493660121, 618.1191801682585, 7014.754483593049, 7312.926870731331, 7395.408367330709, 7559.28186822251, 7766.262205090507, 470.6423118430018, 547.8110052032042, 581.8807144535444, 587.0929414055295, 589.069270552526, 3515.5957064937347, 3758.342290099222, 3773.8867833965023, 3859.3824988001784, 3902.180542086137, 54968.15222934436, 55618.72190639021, 55779.442205578234, 55808.441915581134, 56001.15998260029, 73414.63292683502, 79958.6002069986, 79981.20018799853, 80476.59761701155, 84655.0, 69388.0, 72895.0, 74279.88580171301, 74449.6277518609, 75280.0, 7121.679524421517, 7221.205667376479, 7368.778936631909, 7422.6374052056535, 7422.96288518554, 43678.34482482829, 44149.77925110354, 44205.77897110623, 44285.77857110694, 44612.869520004315, 61107.38892611017, 61586.38413615986, 61898.0, 63252.367476324645, 64906.675466624256, 9779.608815647294, 9890.604375824887, 10054.396736195851, 10064.094231519199, 10064.798704026025, 9824.115829575372, 9966.40201587907, 10775.892241077489, 10998.945005275242, 11001.339919604849, 9560.904390956279, 10131.7467063324, 11669.59156429521, 12028.083058373992, 12058.155929085231, 12181.75636487283, 12195.451204695633, 12535.435905384098, 12848.421821018264, 13377.799333009818, 10782.299150555502, 11355.261907975955, 12149.81775273354, 12211.328376939353, 12231.266124032587, 9925.3548519346, 10470.581176752845, 10505.789884202426, 10616.256862019585, 11191.384473854016, 9342.299327550325, 9502.287328450255, 9589.437258793243, 9653.613855445985, 9967.700968970943], "value": 6340.745272477283, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 108.0, 116.0, 113.0, 116.0, 118.0, 113.0, 112.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 152.0, 191.0, 124.0, 145.0, 152.0, 127.0, 194.0, 123.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 167.0, 167.0, 169.0, 165.0, 163.0, 162.0, 163.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 153.0, 78.0, 77.0, 77.0, 78.0, 173.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 151.0, 87.0, 88.0, 85.0, 144.0, 85.0, 86.0, 139.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 118.0, 118.0, 119.0, 117.0, 118.0, 118.0, 118.0, 123.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 149.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 102.0, 96.0, 96.0, 95.0, 96.0, 97.0, 101.0, 96.0, 95.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 62.0, 64.0, 61.0, 64.0, 61.0, 62.0, 68.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 82.0, 80.0, 82.0, 96.0, 80.0, 81.0, 85.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 136.0, 143.0, 139.0, 135.0, 138.0, 141.0, 171.0, 138.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 172.0, 164.0, 170.0, 165.0, 178.0, 181.0, 172.0, 165.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 75.0, 73.0, 69.0, 69.0, 68.0, 67.0, 67.0, 71.0], "value": 69.5, "unit": "score"}]}]} 19:20:45 INFO - Return code: 0 19:20:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:45 ERROR - # TBPL SUCCESS # 19:20:45 INFO - Running post-action listener: _resource_record_post_action 19:20:45 INFO - [mozharness: 2016-07-22 02:20:45.778927Z] Finished run-tests step (success) 19:20:45 INFO - Running post-run listener: _resource_record_post_run 19:20:45 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 536535040; Read time: 372; Write time: 438160 19:20:45 INFO - TinderboxPrint: CPU usage
13.3% 19:20:45 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 372 19:20:45 INFO - TinderboxPrint: I/O write bytes / time
536,535,040 / 438,160 19:20:45 INFO - TinderboxPrint: CPU idle
8,284.4 (86.7%) 19:20:45 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 19:20:45 INFO - TinderboxPrint: Swap in / out
0 / 0 19:20:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246296576; Read time: 164; Write time: 224828 19:20:45 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289837056; Read time: 192; Write time: 213308 19:20:46 INFO - Running post-run listener: _upload_blobber_files 19:20:46 INFO - Blob upload gear active. 19:20:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:46 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 19:20:46 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:46 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:20:46 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:47 INFO - (blobuploader) - INFO - Done attempting. 19:20:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:48 INFO - (blobuploader) - INFO - Done attempting. 19:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:21:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:01 INFO - (blobuploader) - INFO - Done attempting. 19:21:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:21:01 INFO - Return code: 0 19:21:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:21:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:21:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8da1c8e711d47bdec7bfdec5cbcce5baf7ff56536dde8c1b6e0cbfc26c548fb3600974c08b216d4cb0e95cce6fd5fdc1929d97728e41a919afed5efacbb99ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2edf94b72cfe7306b4aa9aceb9aca3969974adfe750af7a68f3ce727ebd8a9aea47df720c51a1dac55880a314339762558a2e3588b7118575b81796557ffaa2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ea9602630260a9b6287be383dcfc5728916518bf969f35312168f8b923d99b5de7709471cc8f8cdff8f1b3ce38172a492c1a360f3f28b044d0b8ff2814598f1"} 19:21:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:21:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:21:01 INFO - Contents: 19:21:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8da1c8e711d47bdec7bfdec5cbcce5baf7ff56536dde8c1b6e0cbfc26c548fb3600974c08b216d4cb0e95cce6fd5fdc1929d97728e41a919afed5efacbb99ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2edf94b72cfe7306b4aa9aceb9aca3969974adfe750af7a68f3ce727ebd8a9aea47df720c51a1dac55880a314339762558a2e3588b7118575b81796557ffaa2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ea9602630260a9b6287be383dcfc5728916518bf969f35312168f8b923d99b5de7709471cc8f8cdff8f1b3ce38172a492c1a360f3f28b044d0b8ff2814598f1"} 19:21:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:21:01 INFO - Copying logs to upload dir... 19:21:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:21:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.112469 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-21 19:21:00.968071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 19:21:00.971514) ========= 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=0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8da1c8e711d47bdec7bfdec5cbcce5baf7ff56536dde8c1b6e0cbfc26c548fb3600974c08b216d4cb0e95cce6fd5fdc1929d97728e41a919afed5efacbb99ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2edf94b72cfe7306b4aa9aceb9aca3969974adfe750af7a68f3ce727ebd8a9aea47df720c51a1dac55880a314339762558a2e3588b7118575b81796557ffaa2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ea9602630260a9b6287be383dcfc5728916518bf969f35312168f8b923d99b5de7709471cc8f8cdff8f1b3ce38172a492c1a360f3f28b044d0b8ff2814598f1"} build_url:https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/Q9tHZZfnT_qmxPhipieTCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8da1c8e711d47bdec7bfdec5cbcce5baf7ff56536dde8c1b6e0cbfc26c548fb3600974c08b216d4cb0e95cce6fd5fdc1929d97728e41a919afed5efacbb99ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2edf94b72cfe7306b4aa9aceb9aca3969974adfe750af7a68f3ce727ebd8a9aea47df720c51a1dac55880a314339762558a2e3588b7118575b81796557ffaa2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ea9602630260a9b6287be383dcfc5728916518bf969f35312168f8b923d99b5de7709471cc8f8cdff8f1b3ce38172a492c1a360f3f28b044d0b8ff2814598f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 19:21:00.996443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 19:21:00.996746) ========= 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=0333a256a5e4f052382dd180000001b1-1469152547.603044-1794683558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 19:21:01.081315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 19:21:01.081688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 19:21:01.081986) ========= ========= Total master_lag: 0.18 =========