builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1468667641.35 results: success (0) buildid: 20160716013008 builduid: 27285102431645c8a69fac299db6c72f revision: 8027432e7f0a0cf52eaec04d72f67c25dd11446a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.347669) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.348095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.348358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.362931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.363200) ========= 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=32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 04:14:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-07-16 04:14:02 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.474768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.475473) ========= 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=32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015757 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.526737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:01.527053) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8027432e7f0a0cf52eaec04d72f67c25dd11446a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8027432e7f0a0cf52eaec04d72f67c25dd11446a --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=32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 04:14:02,182 truncating revision to first 12 chars 2016-07-16 04:14:02,182 Setting DEBUG logging. 2016-07-16 04:14:02,182 attempt 1/10 2016-07-16 04:14:02,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8027432e7f0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 04:14:02,506 unpacking tar archive at: mozilla-inbound-8027432e7f0a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:02.209349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:02.213007) ========= script_repo_revision: 8027432e7f0a0cf52eaec04d72f67c25dd11446a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:02.213433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:02.213728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 04:14:02.224562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-16 04:14:02.224942) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:02 INFO - MultiFileLogger online at 20160716 04:14:02 in /builds/slave/test 04:14:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:02 INFO - {'append_to_log': False, 04:14:02 INFO - 'base_work_dir': '/builds/slave/test', 04:14:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:02 INFO - 'branch': 'Mozilla-Inbound', 04:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:02 INFO - 'config_files': ('talos/linux_config.py',), 04:14:02 INFO - 'default_actions': ('clobber', 04:14:02 INFO - 'read-buildbot-config', 04:14:02 INFO - 'download-and-extract', 04:14:02 INFO - 'populate-webroot', 04:14:02 INFO - 'create-virtualenv', 04:14:02 INFO - 'install', 04:14:02 INFO - 'run-tests'), 04:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:02 INFO - 'download_minidump_stackwalk': True, 04:14:02 INFO - 'download_symbols': 'ondemand', 04:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:02 INFO - 'installer_path': 'installer.exe', 04:14:02 INFO - 'log_level': 'info', 04:14:02 INFO - 'log_name': 'talos', 04:14:02 INFO - 'log_to_console': True, 04:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:02 INFO - 'opt_config_files': (), 04:14:02 INFO - 'pip_index': False, 04:14:02 INFO - 'sps_profile': False, 04:14:02 INFO - 'sps_profile_interval': 0, 04:14:02 INFO - 'suite': 'dromaeojs-e10s', 04:14:02 INFO - 'system_bits': '32', 04:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:02 INFO - 'title': 'talos-linux64-ix-008', 04:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:02 INFO - 'use_talos_json': True, 04:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:02 INFO - 'work_dir': 'build'} 04:14:02 INFO - ##### 04:14:02 INFO - ##### Running clobber step. 04:14:02 INFO - ##### 04:14:02 INFO - Running pre-action listener: _resource_record_pre_action 04:14:02 INFO - Running main action method: clobber 04:14:02 INFO - rmtree: /builds/slave/test/build 04:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:03 INFO - Running post-action listener: _resource_record_post_action 04:14:03 INFO - ##### 04:14:03 INFO - ##### Finished clobber step (success) 04:14:03 INFO - ##### 04:14:03 INFO - ##### 04:14:03 INFO - ##### Running read-buildbot-config step. 04:14:03 INFO - ##### 04:14:03 INFO - Running pre-action listener: _resource_record_pre_action 04:14:03 INFO - Running main action method: read_buildbot_config 04:14:03 INFO - Using buildbot properties: 04:14:03 INFO - { 04:14:03 INFO - "project": "", 04:14:03 INFO - "product": "firefox", 04:14:03 INFO - "script_repo_revision": "production", 04:14:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:14:03 INFO - "repository": "", 04:14:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:14:03 INFO - "buildid": "20160716013008", 04:14:03 INFO - "pgo_build": "True", 04:14:03 INFO - "basedir": "/builds/slave/test", 04:14:03 INFO - "buildnumber": 1041, 04:14:03 INFO - "slavename": "talos-linux64-ix-008", 04:14:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:14:03 INFO - "platform": "ubuntu64_hw", 04:14:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:14:03 INFO - "branch": "mozilla-inbound", 04:14:03 INFO - "repo_path": "integration/mozilla-inbound", 04:14:03 INFO - "revision": "8027432e7f0a0cf52eaec04d72f67c25dd11446a", 04:14:03 INFO - "stage_platform": "linux64-pgo", 04:14:03 INFO - "builduid": "27285102431645c8a69fac299db6c72f", 04:14:03 INFO - "slavebuilddir": "test" 04:14:03 INFO - } 04:14:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:14:03 INFO - Running post-action listener: _resource_record_post_action 04:14:03 INFO - ##### 04:14:03 INFO - ##### Finished read-buildbot-config step (success) 04:14:03 INFO - ##### 04:14:03 INFO - ##### 04:14:03 INFO - ##### Running download-and-extract step. 04:14:03 INFO - ##### 04:14:03 INFO - Running pre-action listener: _resource_record_pre_action 04:14:03 INFO - Running main action method: download_and_extract 04:14:03 INFO - mkdir: /builds/slave/test/build/tests 04:14: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')]} 04:14:03 INFO - https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:14:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:15 INFO - Downloaded 1361 bytes. 04:14:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:15 INFO - Using the following test package requirements: 04:14:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:14:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:14:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'jsshell-linux-x86_64.zip'], 04:14:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:14:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:14:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:14:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:14:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:14:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:15 INFO - https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:26 INFO - Downloaded 24333595 bytes. 04:14:26 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'] 04:14:26 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 04:14:27 INFO - Return code: 0 04:14:27 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 04:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:27 INFO - https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:29 INFO - Downloaded 24333595 bytes. 04:14:29 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'] 04:14:29 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 04:14:30 INFO - Return code: 0 04:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:30 INFO - https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:31 INFO - Downloaded 14403317 bytes. 04:14:31 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'] 04:14:31 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 04:14:31 INFO - Return code: 0 04:14: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')]} 04:14:31 INFO - https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S8S5EdfJS9CVdie44df4Lw/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 04:14:32 INFO - Downloaded 60833174 bytes. 04:14:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:32 INFO - mkdir: /builds/slave/test/properties 04:14:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:32 INFO - Contents: 04:14:32 INFO - build_url:https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:33 INFO - Running post-action listener: _resource_record_post_action 04:14:33 INFO - Running post-action listener: set_extra_try_arguments 04:14:33 INFO - ##### 04:14:33 INFO - ##### Finished download-and-extract step (success) 04:14:33 INFO - ##### 04:14:33 INFO - ##### 04:14:33 INFO - ##### Running populate-webroot step. 04:14:33 INFO - ##### 04:14:33 INFO - Running pre-action listener: _resource_record_pre_action 04:14:33 INFO - Running main action method: populate_webroot 04:14:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:33 INFO - '--tppagecycles', 04:14:33 INFO - '7'], 04:14:33 INFO - 'tests': ['tsvgm']}}, 04:14:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['damp', 'tps']}, 04:14:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'tests': ['damp', 'tps']}, 04:14:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['dromaeo_dom']}, 04:14:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['basic_compositor_video']}, 04:14:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:14:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tsvgx', 04:14:33 INFO - 'tsvgr_opacity', 04:14:33 INFO - 'tart', 04:14:33 INFO - 'tscrollx', 04:14:33 INFO - 'cart']}, 04:14:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:33 INFO - 'tsvgr_opacity', 04:14:33 INFO - 'tart', 04:14:33 INFO - 'tscrollx', 04:14:33 INFO - 'cart']}, 04:14:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tp5o']}, 04:14:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'tests': ['tp5o']}, 04:14:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s', 04:14:33 INFO - '--xperf_path', 04:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:33 INFO - 'tests': ['tp5n']}, 04:14:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--xperf_path', 04:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:33 INFO - 'tests': ['tp5n']}}, 04:14:33 INFO - 'talos.zip': {'path': '', 04:14:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:33 INFO - Running post-action listener: _resource_record_post_action 04:14:33 INFO - ##### 04:14:33 INFO - ##### Finished populate-webroot step (success) 04:14:33 INFO - ##### 04:14:33 INFO - ##### 04:14:33 INFO - ##### Running create-virtualenv step. 04:14:33 INFO - ##### 04:14:33 INFO - Running pre-action listener: _resource_record_pre_action 04:14:33 INFO - Running main action method: create_virtualenv 04:14:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:33 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 04:14:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:33 INFO - Using real prefix '/usr' 04:14:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:36 INFO - Installing pip.................done. 04:14:36 INFO - Return code: 0 04:14:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14: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', 'pip>=1.5'] in /builds/slave/test/build 04:14: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 pip>=1.5 04:14:36 INFO - Using env: {'DISPLAY': ':0', 04:14:36 INFO - 'HOME': '/home/cltbld', 04:14:36 INFO - 'LANG': 'en_US.UTF-8', 04:14:36 INFO - 'LANGUAGE': 'en_US:en', 04:14:36 INFO - 'LOGNAME': 'cltbld', 04:14:36 INFO - 'MAIL': '/var/mail/cltbld', 04:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:36 INFO - 'MOZ_NO_REMOTE': '1', 04:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:36 INFO - 'NO_EM_RESTART': '1', 04:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:36 INFO - 'PWD': '/builds/slave/test', 04:14:36 INFO - 'SHELL': '/bin/bash', 04:14:36 INFO - 'SHLVL': '1', 04:14:36 INFO - 'TERM': 'linux', 04:14:36 INFO - 'TMOUT': '86400', 04:14:36 INFO - 'USER': 'cltbld', 04:14:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:36 INFO - '_': '/tools/buildbot/bin/python'} 04:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:36 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 04:14:36 INFO - Cleaning up... 04:14:36 INFO - Return code: 0 04:14:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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', '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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:14: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 psutil>=3.1.1 04:14:36 INFO - Using env: {'DISPLAY': ':0', 04:14:36 INFO - 'HOME': '/home/cltbld', 04:14:36 INFO - 'LANG': 'en_US.UTF-8', 04:14:36 INFO - 'LANGUAGE': 'en_US:en', 04:14:36 INFO - 'LOGNAME': 'cltbld', 04:14:36 INFO - 'MAIL': '/var/mail/cltbld', 04:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:36 INFO - 'MOZ_NO_REMOTE': '1', 04:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:36 INFO - 'NO_EM_RESTART': '1', 04:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:36 INFO - 'PWD': '/builds/slave/test', 04:14:36 INFO - 'SHELL': '/bin/bash', 04:14:36 INFO - 'SHLVL': '1', 04:14:36 INFO - 'TERM': 'linux', 04:14:36 INFO - 'TMOUT': '86400', 04:14:36 INFO - 'USER': 'cltbld', 04:14:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:36 INFO - '_': '/tools/buildbot/bin/python'} 04:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:36 INFO - Downloading/unpacking psutil>=3.1.1 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:38 INFO - Installing collected packages: psutil 04:14:38 INFO - Running setup.py install for psutil 04:14:38 INFO - building 'psutil._psutil_linux' extension 04:14:38 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 04:14:39 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 04:14:39 INFO - building 'psutil._psutil_posix' extension 04:14:39 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 04:14:39 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 04:14:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:39 INFO - Successfully installed psutil 04:14:39 INFO - Cleaning up... 04:14:39 INFO - Return code: 0 04:14:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:39 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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14:39 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 04:14:39 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 04:14:39 INFO - Using env: {'DISPLAY': ':0', 04:14:39 INFO - 'HOME': '/home/cltbld', 04:14:39 INFO - 'LANG': 'en_US.UTF-8', 04:14:39 INFO - 'LANGUAGE': 'en_US:en', 04:14:39 INFO - 'LOGNAME': 'cltbld', 04:14:39 INFO - 'MAIL': '/var/mail/cltbld', 04:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:39 INFO - 'MOZ_NO_REMOTE': '1', 04:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:39 INFO - 'NO_EM_RESTART': '1', 04:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:39 INFO - 'PWD': '/builds/slave/test', 04:14:39 INFO - 'SHELL': '/bin/bash', 04:14:39 INFO - 'SHLVL': '1', 04:14:39 INFO - 'TERM': 'linux', 04:14:39 INFO - 'TMOUT': '86400', 04:14:39 INFO - 'USER': 'cltbld', 04:14:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:39 INFO - '_': '/tools/buildbot/bin/python'} 04:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:41 INFO - Installing collected packages: mozsystemmonitor 04:14:41 INFO - Running setup.py install for mozsystemmonitor 04:14:41 INFO - Successfully installed mozsystemmonitor 04:14:41 INFO - Cleaning up... 04:14:41 INFO - Return code: 0 04:14:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14:41 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 04:14:41 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 04:14:41 INFO - Using env: {'DISPLAY': ':0', 04:14:41 INFO - 'HOME': '/home/cltbld', 04:14:41 INFO - 'LANG': 'en_US.UTF-8', 04:14:41 INFO - 'LANGUAGE': 'en_US:en', 04:14:41 INFO - 'LOGNAME': 'cltbld', 04:14:41 INFO - 'MAIL': '/var/mail/cltbld', 04:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:41 INFO - 'MOZ_NO_REMOTE': '1', 04:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:41 INFO - 'NO_EM_RESTART': '1', 04:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:41 INFO - 'PWD': '/builds/slave/test', 04:14:41 INFO - 'SHELL': '/bin/bash', 04:14:41 INFO - 'SHLVL': '1', 04:14:41 INFO - 'TERM': 'linux', 04:14:41 INFO - 'TMOUT': '86400', 04:14:41 INFO - 'USER': 'cltbld', 04:14:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:41 INFO - '_': '/tools/buildbot/bin/python'} 04:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:41 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:43 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 04:14:43 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 04:14:43 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 04:14:43 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 04:14:43 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 04:14:43 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 04:14:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:44 INFO - warning: no files found matching '*.txt' 04:14:44 INFO - no previously-included directories found matching 'build' 04:14:44 INFO - no previously-included directories found matching 'dist' 04:14:44 INFO - no previously-included directories found matching '.git*' 04:14:44 INFO - Installing collected packages: jsonschema, functools32 04:14:44 INFO - Running setup.py install for functools32 04:14:44 INFO - warning: no files found matching '*.txt' 04:14:44 INFO - no previously-included directories found matching 'build' 04:14:44 INFO - no previously-included directories found matching 'dist' 04:14:44 INFO - no previously-included directories found matching '.git*' 04:14:44 INFO - Successfully installed jsonschema functools32 04:14:44 INFO - Cleaning up... 04:14:44 INFO - Return code: 0 04:14:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:44 INFO - Using env: {'DISPLAY': ':0', 04:14:44 INFO - 'HOME': '/home/cltbld', 04:14:44 INFO - 'LANG': 'en_US.UTF-8', 04:14:44 INFO - 'LANGUAGE': 'en_US:en', 04:14:44 INFO - 'LOGNAME': 'cltbld', 04:14:44 INFO - 'MAIL': '/var/mail/cltbld', 04:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:44 INFO - 'MOZ_NO_REMOTE': '1', 04:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:44 INFO - 'NO_EM_RESTART': '1', 04:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:44 INFO - 'PWD': '/builds/slave/test', 04:14:44 INFO - 'SHELL': '/bin/bash', 04:14:44 INFO - 'SHLVL': '1', 04:14:44 INFO - 'TERM': 'linux', 04:14:44 INFO - 'TMOUT': '86400', 04:14:44 INFO - 'USER': 'cltbld', 04:14:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:44 INFO - '_': '/tools/buildbot/bin/python'} 04:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:46 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 04:14:46 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 04:14:46 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 04:14:46 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 04:14:46 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 04:14:46 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 04:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:46 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 04:14:46 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 04:14:46 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 04:14:46 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 04:14:46 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 04:14:46 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 04:14:47 INFO - Downloading docopt-0.6.1.tar.gz 04:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:47 INFO - Running setup.py install for blobuploader 04:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:47 INFO - Running setup.py install for requests 04:14:47 INFO - Running setup.py install for docopt 04:14:47 INFO - Successfully installed blobuploader requests docopt 04:14:47 INFO - Cleaning up... 04:14:47 INFO - Return code: 0 04:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:47 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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14:47 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 04:14:47 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 04:14:47 INFO - Using env: {'DISPLAY': ':0', 04:14:47 INFO - 'HOME': '/home/cltbld', 04:14:47 INFO - 'LANG': 'en_US.UTF-8', 04:14:47 INFO - 'LANGUAGE': 'en_US:en', 04:14:47 INFO - 'LOGNAME': 'cltbld', 04:14:47 INFO - 'MAIL': '/var/mail/cltbld', 04:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:47 INFO - 'MOZ_NO_REMOTE': '1', 04:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:47 INFO - 'NO_EM_RESTART': '1', 04:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:47 INFO - 'PWD': '/builds/slave/test', 04:14:47 INFO - 'SHELL': '/bin/bash', 04:14:47 INFO - 'SHLVL': '1', 04:14:47 INFO - 'TERM': 'linux', 04:14:47 INFO - 'TMOUT': '86400', 04:14:47 INFO - 'USER': 'cltbld', 04:14:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:47 INFO - '_': '/tools/buildbot/bin/python'} 04:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:47 INFO - Running setup.py (path:/tmp/pip-Za35L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:47 INFO - Running setup.py (path:/tmp/pip-HfNvpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:48 INFO - Running setup.py (path:/tmp/pip-RqU75i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:48 INFO - Running setup.py (path:/tmp/pip-NN0v5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:48 INFO - Running setup.py (path:/tmp/pip-ZgeFWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:48 INFO - Running setup.py (path:/tmp/pip-sBG1Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:48 INFO - Running setup.py (path:/tmp/pip-vSdXZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:48 INFO - Running setup.py (path:/tmp/pip-gps7Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:48 INFO - Running setup.py (path:/tmp/pip-yD1018-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:48 INFO - Running setup.py (path:/tmp/pip-RUkPME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:48 INFO - Running setup.py (path:/tmp/pip-xVflCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:48 INFO - Running setup.py (path:/tmp/pip-YDhnH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:48 INFO - Running setup.py (path:/tmp/pip-GNxVme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:48 INFO - Running setup.py (path:/tmp/pip-q1VhKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:48 INFO - Running setup.py (path:/tmp/pip-qwuK62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:49 INFO - Running setup.py (path:/tmp/pip-M7qk8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:49 INFO - Running setup.py (path:/tmp/pip-BZ48X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:49 INFO - Running setup.py install for manifestparser 04:14:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Running setup.py install for mozcrash 04:14:49 INFO - Running setup.py install for mozdebug 04:14:49 INFO - Running setup.py install for mozdevice 04:14:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Running setup.py install for mozfile 04:14:49 INFO - Running setup.py install for mozhttpd 04:14:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Running setup.py install for mozinfo 04:14:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Running setup.py install for mozInstall 04:14:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Running setup.py install for mozleak 04:14:50 INFO - Running setup.py install for mozlog 04:14:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for moznetwork 04:14:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozprocess 04:14:50 INFO - Running setup.py install for mozprofile 04:14:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozrunner 04:14:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozscreenshot 04:14:50 INFO - Running setup.py install for moztest 04:14:50 INFO - Running setup.py install for mozversion 04:14:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:50 INFO - Cleaning up... 04:14:50 INFO - Return code: 0 04:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:50 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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14:50 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 04:14:50 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 04:14:50 INFO - Using env: {'DISPLAY': ':0', 04:14:50 INFO - 'HOME': '/home/cltbld', 04:14:50 INFO - 'LANG': 'en_US.UTF-8', 04:14:50 INFO - 'LANGUAGE': 'en_US:en', 04:14:50 INFO - 'LOGNAME': 'cltbld', 04:14:50 INFO - 'MAIL': '/var/mail/cltbld', 04:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:50 INFO - 'MOZ_NO_REMOTE': '1', 04:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:50 INFO - 'NO_EM_RESTART': '1', 04:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:50 INFO - 'PWD': '/builds/slave/test', 04:14:50 INFO - 'SHELL': '/bin/bash', 04:14:50 INFO - 'SHLVL': '1', 04:14:50 INFO - 'TERM': 'linux', 04:14:50 INFO - 'TMOUT': '86400', 04:14:50 INFO - 'USER': 'cltbld', 04:14:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:50 INFO - '_': '/tools/buildbot/bin/python'} 04:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:51 INFO - Running setup.py (path:/tmp/pip-zwxJST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:51 INFO - Running setup.py (path:/tmp/pip-WS9JTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:51 INFO - Running setup.py (path:/tmp/pip-eY3h6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:51 INFO - Running setup.py (path:/tmp/pip-OomKm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:51 INFO - Running setup.py (path:/tmp/pip-GNfjMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:51 INFO - Running setup.py (path:/tmp/pip-s1e9bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:51 INFO - Running setup.py (path:/tmp/pip-SpDF_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:51 INFO - Running setup.py (path:/tmp/pip-h9R3G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:51 INFO - Running setup.py (path:/tmp/pip-n7ZjM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:51 INFO - Running setup.py (path:/tmp/pip-NK6ata-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:51 INFO - Running setup.py (path:/tmp/pip-u54qGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:51 INFO - Running setup.py (path:/tmp/pip-4a1gZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:52 INFO - Running setup.py (path:/tmp/pip-Tdwnw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:52 INFO - Running setup.py (path:/tmp/pip-VNTTpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:52 INFO - Running setup.py (path:/tmp/pip-oNyp4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:52 INFO - Running setup.py (path:/tmp/pip-KW6Zxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:52 INFO - Running setup.py (path:/tmp/pip-flC6zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:52 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 04:14:52 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 04:14:52 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 04:14:52 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 04:14:52 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 04:14:52 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 04:14:54 INFO - Downloading blessings-1.6.tar.gz 04:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:54 INFO - Installing collected packages: blessings 04:14:54 INFO - Running setup.py install for blessings 04:14:54 INFO - Successfully installed blessings 04:14:54 INFO - Cleaning up... 04:14:54 INFO - Return code: 0 04:14:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:54 INFO - Reading from file tmpfile_stdout 04:14:54 INFO - Current package versions: 04:14:54 INFO - argparse == 1.2.1 04:14:54 INFO - blessings == 1.6 04:14:54 INFO - blobuploader == 1.2.4 04:14:54 INFO - docopt == 0.6.1 04:14:54 INFO - functools32 == 3.2.3-2 04:14:54 INFO - jsonschema == 2.5.1 04:14:54 INFO - manifestparser == 1.1 04:14:54 INFO - mozInstall == 1.12 04:14:54 INFO - mozcrash == 0.17 04:14:54 INFO - mozdebug == 0.1 04:14:54 INFO - mozdevice == 0.48 04:14:54 INFO - mozfile == 1.2 04:14:54 INFO - mozhttpd == 0.7 04:14:54 INFO - mozinfo == 0.9 04:14:54 INFO - mozleak == 0.1 04:14:54 INFO - mozlog == 3.2 04:14:54 INFO - moznetwork == 0.27 04:14:54 INFO - mozprocess == 0.23 04:14:54 INFO - mozprofile == 0.28 04:14:54 INFO - mozrunner == 6.12 04:14:54 INFO - mozscreenshot == 0.1 04:14:54 INFO - mozsystemmonitor == 0.3 04:14:54 INFO - moztest == 0.7 04:14:54 INFO - mozversion == 1.4 04:14:54 INFO - psutil == 3.1.1 04:14:54 INFO - requests == 1.2.3 04:14:54 INFO - wsgiref == 0.1.2 04:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:54 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')]} 04:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:54 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')]} 04:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:54 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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14:54 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 04:14:54 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 04:14:54 INFO - Using env: {'DISPLAY': ':0', 04:14:54 INFO - 'HOME': '/home/cltbld', 04:14:54 INFO - 'LANG': 'en_US.UTF-8', 04:14:54 INFO - 'LANGUAGE': 'en_US:en', 04:14:54 INFO - 'LOGNAME': 'cltbld', 04:14:54 INFO - 'MAIL': '/var/mail/cltbld', 04:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:54 INFO - 'MOZ_NO_REMOTE': '1', 04:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:54 INFO - 'NO_EM_RESTART': '1', 04:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:54 INFO - 'PWD': '/builds/slave/test', 04:14:54 INFO - 'SHELL': '/bin/bash', 04:14:54 INFO - 'SHLVL': '1', 04:14:54 INFO - 'TERM': 'linux', 04:14:54 INFO - 'TMOUT': '86400', 04:14:54 INFO - 'USER': 'cltbld', 04:14:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:54 INFO - '_': '/tools/buildbot/bin/python'} 04:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 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)) 04:14:54 INFO - Cleaning up... 04:14:54 INFO - Return code: 0 04:14:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:54 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')]} 04:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:54 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')]} 04:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:54 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 0x1aea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d19400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, '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': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', '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 04:14:54 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 04:14:54 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 04:14:54 INFO - Using env: {'DISPLAY': ':0', 04:14:54 INFO - 'HOME': '/home/cltbld', 04:14:54 INFO - 'LANG': 'en_US.UTF-8', 04:14:54 INFO - 'LANGUAGE': 'en_US:en', 04:14:54 INFO - 'LOGNAME': 'cltbld', 04:14:54 INFO - 'MAIL': '/var/mail/cltbld', 04:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:54 INFO - 'MOZ_NO_REMOTE': '1', 04:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:54 INFO - 'NO_EM_RESTART': '1', 04:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:54 INFO - 'PWD': '/builds/slave/test', 04:14:54 INFO - 'SHELL': '/bin/bash', 04:14:54 INFO - 'SHLVL': '1', 04:14:54 INFO - 'TERM': 'linux', 04:14:54 INFO - 'TMOUT': '86400', 04:14:54 INFO - 'USER': 'cltbld', 04:14:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:54 INFO - '_': '/tools/buildbot/bin/python'} 04:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:55 INFO - Cleaning up... 04:14:55 INFO - Return code: 0 04:14:55 INFO - Running post-action listener: _resource_record_post_action 04:14:55 INFO - Running post-action listener: _start_resource_monitoring 04:14:55 INFO - Starting resource monitoring. 04:14:55 INFO - ##### 04:14:55 INFO - ##### Finished create-virtualenv step (success) 04:14:55 INFO - ##### 04:14:55 INFO - ##### 04:14:55 INFO - ##### Running install step. 04:14:55 INFO - ##### 04:14:55 INFO - Running pre-action listener: _resource_record_pre_action 04:14:55 INFO - Running main action method: install 04:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:55 INFO - Reading from file tmpfile_stdout 04:14:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:55 INFO - Reading from file tmpfile_stdout 04:14:55 INFO - Output received: 04:14:55 INFO - Usage: mozinstall [options] installer 04:14:55 INFO - Options: 04:14:55 INFO - -h, --help show this help message and exit 04:14:55 INFO - -d DEST, --destination=DEST 04:14:55 INFO - Directory to install application into. [default: 04:14:55 INFO - "/builds/slave/test"] 04:14:55 INFO - --app=APP Application being installed. [default: firefox] 04:14:55 INFO - mkdir: /builds/slave/test/build/application 04:14:55 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'] 04:14:55 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 04:15:12 INFO - Reading from file tmpfile_stdout 04:15:12 INFO - Output received: 04:15:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:15:12 INFO - Running post-action listener: _resource_record_post_action 04:15:12 INFO - ##### 04:15:12 INFO - ##### Finished install step (success) 04:15:12 INFO - ##### 04:15:12 INFO - ##### 04:15:12 INFO - ##### Running run-tests step. 04:15:12 INFO - ##### 04:15:12 INFO - Running pre-action listener: _resource_record_pre_action 04:15:12 INFO - Running main action method: run_tests 04:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:12 INFO - Python 2.7.3 04:15:12 INFO - Return code: 0 04:15:12 INFO - grabbing minidump binary from tooltool 04:15:12 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')]} 04:15:12 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 0x1da8570>, '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 0x1da9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da9900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:12 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 04:15:12 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 04:15:12 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 04:15:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:12 INFO - Return code: 0 04:15:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:15:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:15:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 04:15:12 INFO - Using env: {'DISPLAY': ':0', 04:15:12 INFO - 'HOME': '/home/cltbld', 04:15:12 INFO - 'LANG': 'en_US.UTF-8', 04:15:12 INFO - 'LANGUAGE': 'en_US:en', 04:15:12 INFO - 'LOGNAME': 'cltbld', 04:15:12 INFO - 'MAIL': '/var/mail/cltbld', 04:15:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:12 INFO - 'MOZ_NO_REMOTE': '1', 04:15:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:12 INFO - 'NO_EM_RESTART': '1', 04:15:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:12 INFO - 'PWD': '/builds/slave/test', 04:15:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:12 INFO - 'SHELL': '/bin/bash', 04:15:12 INFO - 'SHLVL': '1', 04:15:12 INFO - 'TERM': 'linux', 04:15:12 INFO - 'TMOUT': '86400', 04:15:12 INFO - 'USER': 'cltbld', 04:15:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010', 04:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:12 INFO - '_': '/tools/buildbot/bin/python'} 04:15:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:15:13 INFO - mozversion application_buildid: 20160716013008 04:15:13 INFO - mozversion application_changeset: 8027432e7f0a0cf52eaec04d72f67c25dd11446a 04:15:13 INFO - mozversion application_display_name: Nightly 04:15:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:13 INFO - mozversion application_name: Firefox 04:15:13 INFO - mozversion application_remotingname: firefox 04:15:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:15:13 INFO - mozversion application_vendor: Mozilla 04:15:13 INFO - mozversion application_version: 50.0a1 04:15:13 INFO - mozversion platform_buildid: 20160716013008 04:15:13 INFO - mozversion platform_changeset: 8027432e7f0a0cf52eaec04d72f67c25dd11446a 04:15:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:15:13 INFO - mozversion platform_version: 50.0a1 04:15:13 INFO - using testdate: 1468667713 04:15:13 INFO - actual date: 1468667713 04:15:13 INFO - starting webserver on 'localhost:49719' 04:15:13 INFO - SUITE-START | Running 2 tests 04:15:13 INFO - TEST-START | dromaeo_css 04:15:13 INFO - operating with platform_type : linux_ 04:15:13 INFO - Initialising browser for dromaeo_css test... 04:15:13 INFO - TEST-INFO | started process 388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmUo6SQ/profile http://localhost:49719/getInfo.html) 04:15:17 INFO - PROCESS | 388 | __metrics Screen width/height:1600/1200 04:15:17 INFO - PROCESS | 388 | colorDepth:24 04:15:17 INFO - PROCESS | 388 | Browser inner width/height: 1024/697 04:15:17 INFO - PROCESS | 388 | __metrics 04:15:18 ERROR - PROCESS | 388 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:15:18 INFO - TEST-INFO | 388: exit 0 04:15:18 INFO - Browser initialized. 04:15:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:18 INFO - TEST-INFO | started process 510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmUo6SQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:30 INFO - PROCESS | 510 | RSS: Main: 168001536 04:15:30 INFO - PROCESS | 510 | 04:16:20 INFO - PROCESS | 510 | 1468667780306 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] 04:18:28 INFO - PROCESS | 510 | Cycle 1(1): loaded http://localhost:49719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49719/tests/dromaeo/cssquery-ext.html) 04:18:29 INFO - PROCESS | 510 | RSS: Main: 172314624 04:18:29 INFO - PROCESS | 510 | 04:21:31 INFO - PROCESS | 510 | Cycle 1(1): loaded http://localhost:49719/tests/dromaeo/cssquery-ext.html (next: http://localhost:49719/tests/dromaeo/cssquery-jquery.html) 04:21:31 INFO - PROCESS | 510 | RSS: Main: 168239104 04:21:31 INFO - PROCESS | 510 | 04:24:33 INFO - PROCESS | 510 | Cycle 1(1): loaded http://localhost:49719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49719/tests/dromaeo/cssquery-mootools.html) 04:24:34 INFO - PROCESS | 510 | RSS: Main: 172466176 04:24:34 INFO - PROCESS | 510 | 04:27:36 INFO - PROCESS | 510 | Cycle 1(1): loaded http://localhost:49719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49719/tests/dromaeo/cssquery-prototype.html) 04:27:36 INFO - PROCESS | 510 | RSS: Main: 166834176 04:27:36 INFO - PROCESS | 510 | 04:30:39 INFO - PROCESS | 510 | Cycle 1(1): loaded http://localhost:49719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49719/tests/dromaeo/cssquery-yui.html) 04:30:39 INFO - PROCESS | 510 | RSS: Main: 168947712 04:30:39 INFO - PROCESS | 510 | 04:33:42 INFO - PROCESS | 510 | Cycle 1(1): loaded http://localhost:49719/tests/dromaeo/cssquery-yui.html (next: http://localhost:49719/tests/dromaeo/cssquery-dojo.html) 04:33:43 INFO - PROCESS | 510 | RSS: Main: 169521152 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | __start_tp_report 04:33:43 INFO - PROCESS | 510 | _x_x_mozilla_page_load 04:33:43 INFO - PROCESS | 510 | _x_x_mozilla_page_load_details 04:33:43 INFO - PROCESS | 510 | |i|pagename|runs| 04:33:43 INFO - PROCESS | 510 | |0;dojo.html;3104.674009229031;3114.828684422357;3133.279345750476;3141.7486601071914;3154.984225078875;5433.7283135843245;5476.069068258395;5482.287302650655;5528.364238112618;5602.719864006794;5426.430224826396;5504.559635229182;5553.444655534445;5566.805161819337;5594.636348637346;4970.6520543561965;5036.521530454601;5129.871753206163;5172.250023746555;5223.869403264911;536.5627863478778;5079.746012699368;5103.081445339837;5122.078025955327;5158.974205128988;4989.875253118665;5015.3730783652045;5029.547340739333;5032.270320803481;5062.139436295838;5002.24966255061;5024.497550244982;5035.496450354972;5035.496450354972;5045.899082018339;5025.648204625678;5081.974590127063;5085.364329458817;5101.795928162869;5105.591552675777;5525.944740552623;5579.46995035471;5585.218069470277;5600.383957764642;5619.719014049281;5689.146628005791;5814.186013958049;5855.560832937546;5975.820725378246;6023.879522409527;5930.911036334458;5956.047032474783;5959.851003724942;5964.1650168976375;5997.190379298782;5517.668939863621;5527.640703354309;5550.91673624896;5559.138333558305;5563.471470210324;5989.760409583655;6029.276486821609;6057.909131363033;6089.908651370233;6092.268927728701;5832.591718579659;5852.122181672698;5853.94146058534;5858.2677165354335;5861.618994765412;5903.409659034062;5906.084556893688;5925.170476133345;5925.229720136354;5948.851278718067;5771.68255745938;5804.303483581913;5811.738471768781;5860.736266868002;5884.735186916599;5783.971080144656;5802.47777700009;5826.388229235869;5844.503217226584;5893.14549390336;4500.189965806121;4501.932471012938;4504.81980720774;4520.95479045212;4541.591256786905;3932.036651020518;3949.30887094763;3952.505936757905;3983.780892050907;3987.4816273884207;5590;5644.181593668977;5662.66024038559;5662.801801936913;5710.114932185518;5799.5650326225705;5962.1056841473255;5978.940210597925;6008.789692360747;6012.098185272244;5595.496405323541;5638.323401191801;5641.2384328116;5651.576131790132;5682.829515114553;5155.072087024371;5155.304033955443;5159.638825282269;5161.225816127611;5200.037992971313;5969.761209551656;5986.132010858401;6174.753009879554;6181.598196117238;6195.19462469876;5907.261592300876;5980.671063091398;5984.1921340618455;5985.970070149621;6032.33644299118;6090.23872015998;6126.23422072241;6131.816045518642;6132.233470816148;6138.723757430837;5621.437856214346;5819.5053420459735;5854.0340843760305;5879.176915231957;5921.526277897844;6082.2093127893095;6085.66528840918;6086.573939824347;6088.6042407243385;6138.386161383826;5855.414458554111;5901.498372638202;5932.228810254639;5942.494887934574;5945.672987985529;5762.855928601651;5765.423457654369;5798.768049277982;5809.419058094157;5922.052471604523;5625;5636;5677.744501497526;5697.401772813961;5713.143028545752;5827.096799996008;5843.065109582446;5853.385394533512;5888.087346461305;5892.086726557391;5614.550835933034;5661.122526008476;5707.514861236841;5753.338366087786;5755.36690964002 04:33:43 INFO - PROCESS | 510 | |1;ext.html;593.0718425663836;594.6729298885612;596.2427716799667;628.1519948070106;654.8330175805166;42289.57710422895;43684.34473482901;43909.12181756367;44320;47426.28860567086;45052;45730;45739.542604573944;45741.31388029174;45746.31380529295;9048.230900373475;9193.310501712398;9209.263258939269;9211.953940230323;9215.216706579915;9130.132637399436;9152.588133533975;9217.493037882914;9226.630934762601;9261.629534818632;9204.263658907304;9245.214156796646;9252.074792520727;9295.024022477644;9315.580798864068;9144.268458523335;9176.908230917672;9183.770405739877;9214.861777073349;9240.306976976754;9059.547022648841;9063.456192628397;9131;9135.269178465707;9141.360104792668;42724.1455170898;42809.57190428087;42828.57171428277;43147.35278970818;43250;3549.378858699743;3648.416253399443;3664.963350366489;3781.716371272166;4008.6592639625665;33029.66970330314;33749.83125084383;34164;34956.6504334956;35657;4369.519352871182;4372.23485889968;4464.241079016575;4490.259107247301;4559.886002849922;384153;385221.0738946315;386021;386685;387702.0614896936;57964.130538041965;58609.41390586125;58620.70689646524;58636.706816465645;58941;37392.81303593465;38421.807890960925;59341;59952.70023649854;60217;15739.13434761099;15802.209889505479;15850.128242946748;15934.442294519868;15963.60090997711;12963.22220666763;13074.607761767162;13092.279924604049;13118.540851070358;13123.934380328228;19646.508837279183;19719.605607887763;19913;19925.202991880164;20011;7322.450816188701;7395.149557800814;7486.363659089038;7540.245975402526;7662.770116896502;962.7448726087592;1058.4654749351528;1074.363280296203;1109.4230999880017;1155.3530023186875;33290.334193316;33546.49680254798;33950.320993580484;34439.31121377558;35948.46077308842;1119.5409881948362;1124.409684915426;1127.8363298202107;1166.8191430328313;1171.83008463774;16813.57966050834;17088.743668844978;17219.827801722073;17406.65186696259;17481.213345399487;586450;594273;598430;598715.0256994836;600836;57597.712011439675;57906.710466447395;57950.42049579535;58155;58184;1332.6068809701162;1366.917984920888;1392.8258967629047;1394.1913690059741;1400.033976556173;30964.53553196749;31792.841035794674;31990.84004579962;32130.67869321277;32205.677943220267;50894.745526272134;51192.23211651903;51554.22668659898;51683.224751628004;51734.741326294636;510717;518327;518537;519625;520784;27556.862215688794;27702.722972770014;27745.722542775122;27757.861210693816;27887.44225115527;47478;48146.75926620485;48269;48798.72182210067;49377.50622493729;40025.59974400219;40664.39003414892;41174.79412602918;41469.79265103655;41633.79183104065;40800.59199408087;40859.79570102131;40923;41196.588034120476;41825.58174418217;39486;39764.403533947596;40593.39109913295;40722;41002;35717;36363.818180909984;36660.81669591742;37119.25761484701;37258.813705931294;27500.862495687394;27590.448191036467;27752;27962.720372796826;28052 04:33:43 INFO - PROCESS | 510 | |2;jquery.html;393.3136676499509;396.5499158455153;398.856411691791;401.4800832921367;420.6004295918878;18841.340553080645;20280.492987675334;20344.1862325507;20497.385078447634;20853.895730521363;19536.70694939577;19960.301389451335;20193.49516262094;20265.290714824983;20269.797302026975;5699.629524080932;6013.398660133996;6015.157877897076;6020.698965051752;6037.456628903398;5602.915956260639;5756.510696590794;5829.533637309005;5837.416258374171;5840.649561026352;5777.884442311151;5807.303123625171;5809.506191973687;5826.475617194452;5854.619449735754;5776.104703770922;5796.07262837946;5868.530517558585;5902.144189092557;5931.169636250886;5258.6318957672975;5258.710770907599;5276.366835979668;5303.867403314909;5304.840854774363;23258.534829303488;24226.63660045101;24554.140605078916;24650.506989860103;24960.50078998428;2547.9490410191693;2734.740199681027;3150.070729134911;3195.344954284366;3245.837708114585;14608.342624581814;14948.40206391743;14956.24739567828;15101.47144849936;15455.613609659737;1937.2832052140657;1953.9120739566754;1978.1889425335544;2128.5742851429777;2200.6919031335624;84213.04918785814;86966;88794.11205887923;89830.550847246;89966.10033899643;10155.441450720133;11292.717682058013;11357.659270221906;11442.199046066695;11707.414629268502;15754.76367854483;15795.289211985488;15808.762868556982;15892.52322430329;15895.046297221972;8002.479838810459;8018.158093400109;8124.309433698084;8270.090290068089;8277.296429803535;7735.1491335953;7791.922080779233;7839;7857.214278572212;7869.921300787033;4677.976610116928;4839.854804355875;4863.756812159378;4889.828855990095;4922.237053256751;1842.97235541467;1993.1130646862007;2003.1486618187212;2022.737044184276;2095.5226565271446;998.2513115163628;999.8700168977987;1012.3166862367872;1052.736815796051;1063.9838953799103;20123.59752804965;20752.896235519027;20755.481112972295;20829.1668333268;20847.47881302949;1007.4861820471613;1034.374203606822;1066.9786604267872;1070.7804899995483;1095.2552264460244;10960.56157753681;11494.367809770376;11500.827487587692;11530.711732206593;11685.474153663106;484896;485059;485484;493853;500985;95682;95820.52089739506;95988;96005;96034.51982740182;832.1304237072274;834.678648720235;844.2359664503634;852.5012867472598;939.7979434421495;17748.3788067417;17877.553061173574;18327.17527711283;18528.629427411644;18724.81275187285;36676;40265.79867100763;43057.354139688556;43951.78024109859;44111.55888441203;56244.43755562392;57732;58706.706466467396;65999.67000164969;66461.33538664551;8195.95902020486;8276.220612568086;8564.229219370287;8763.167499087576;8811;9836.06557377048;13543.661408464866;13677.521286755315;13712.451501939811;13788.655283617989;12194.51221951112;12195.841395067455;12211.328376938998;12249;12339.69150771238;12033.398330083286;12038.157328986887;12182.573609923611;12313.322767247888;12319.076069294659;11956.163068585116;12122.09084318662;12145.817812732992;12347.938260308641;12481.375931203585;8288.917110829056;8628.568571571523;8648.82702345937;8739;8796.164364385373;8949.552522373726;11982.64052078439;12075;12270.447829847857;12307.015438764698 04:33:43 INFO - PROCESS | 510 | |3;mootools.html;1494.3947701181019;1499.3178103962698;1673.155056696368;1780.23449916536;1809.8280663336986;8125.91874081259;8260.793480162984;8884.911150888489;9455.621775129004;9468.479233642156;8637.265832404237;8876.068012858654;8929.464232146076;8970.102989701027;8972.955135224314;2344.296710986706;2357.4205282460707;2376.6316220985773;2378.8691621960784;2387.880605969703;2237.5748607764554;2292.4841910570153;2400.4238982644215;2401.5317013182434;2411.7829395354415;2402.3633737059695;2402.5675378431874;2407.109369533275;2411.807055435561;2424.806015518754;2361.055577768906;2364.6925899633025;2376.394019525019;2380.238323736414;2382.4401265702545;2294.8278879084137;2305.5965206089036;2311.6763653088583;2316.5598536278053;2323.268170526279;8817.867731984026;8883.555822208864;8885.733427997171;8948.463092214422;8955.149260820212;5410.1343784994215;5477.534409575191;5503.284573005523;5540.50135487804;5551.555875529948;3572.374834403969;3669.743117981742;3719.1817800083936;3742.8128593570486;3752.3245815753153;1201.3572738584903;1233.9444724987306;1237.4307818403545;1251.1804767877054;1281.9038572107129;12860.678483037906;12941.741165176643;12980.415881285271;12980.740385192337;12990.61028169147;4771.928421073687;4831.685940413862;4846.442659094178;4880.829170978998;5005.499450055038;9995.250356223312;10055.547500362502;10072.345297555781;10075.193984481224;10079.848802267972;5318.494742999409;5327.174287985368;5339.46605339463;5344.251804747339;5345.33183352081;4426.579474949875;4824.782884770194;4866.635002374836;4970.378702662168;4984.327115839315;3936.7637941723588;4008.9799551002056;4010.8796736097966;4066.694997875112;4138.441310423054;1218.585680868509;1250.143651598658;1260.9558665446666;1264.8166015927823;1266.6516707905216;1002.6364144763262;1036.5698235232444;1041.7499800047933;1045.7960697664034;1058.7035630023606;6273.937260627426;6335.11308416822;6435.839104022437;6551.541392102602;6575.375339342755;437.7001753798658;451.31400271587006;460.2980454806447;463.04612498253704;466.78994452495834;4335.479742430928;4406.581374769392;4419.624331931757;4434.911301773946;4462.196804575207;11264.774704505864;11493.42532873353;11557.422128893522;11571.884281157249;11673;10856.891431085745;11378.772424551462;11387.772244555063;11407.25852819564;11424.657260282205;8319.292860106958;8727.345449091217;8776.122387761172;8784.165504277084;8795.252403545643;6254.687265636791;6381.8085457436355;6579.078928949855;6611.603303801788;6625.403713665601;10508.684739457829;10645.254832161674;10648.574057037631;10673.626423075155;10743.409112498888;10897.727556811144;10914.945425272823;10916;11050.281731687415;11053.72365690832;7325.926740732524;7729.304362607392;7963.6814527418255;8206.917930820855;8314.251717345467;9071.682491112779;9095.772605684911;9102.772430689285;9154.038825923182;9163.633454661738;7831.686732530863;7990.84018319642;8090.15053419406;8135.674573017013;8145;7862.60686965638;7882.487638303492;7894.36845052383;7990;8150.673973041012;7024.4029257513685;7132.215456299907;7195.532290401107;7251.673674684546;7268.164161121539;5291.947080529146;5403.270558474713;5428.891422171456;5498.257735205856;5619.690916999441;5465.72671366438;5535.225068490495;5561.6663000220115;5567.05360088794;5658.801941932013 04:33:43 INFO - PROCESS | 510 | |4;prototype.html;328.7813603953371;333.386568713567;339.8029143097003;342.86285485805683;345.81498898089495;5441.455854414557;5541.251930989315;5585.329760428749;5669.262995810544;5760.337561180466;5598.44015598441;5599.8600034999145;5611.3546942101675;5614.326280846294;5620.751699320274;4358.782060896959;4364.476262848462;4366.781660916958;4382.9123417531555;4383.715058521202;4148.751074935513;4366.737995720267;4366.768591242474;4383.627391671712;4393.275109606911;4316.525182229952;4317.395564620955;4324;4334.13317336534;4334.479862416514;4344.500382456011;4350.216960947028;4365.43249377582;4389.604935555783;4396.648268138541;3791.431285307226;3840.2703486337505;3868.825902834379;3879;3881.86413475527;5403.729813509348;5457.263269458652;5493.835184944458;5522.834314970557;5534;4986.127427700174;4986.775595098229;4992.350994370745;5023.422306434771;5036.11867923112;5723.885522289531;5829.650220986712;5853.151293062482;5879.176915231871;5896.734646940855;4184.351425529047;4189.120284740208;4191.601797829201;4221.2190744712325;4233.354153653966;6120.785772497986;6142.692865356759;6157.7536898524;6186.566940314135;6188.133661287423;4169.395437661522;4252.020156841695;4285.357196420499;4312.159128969821;4330.978345108254;4330.891727706832;4365.75988320639;4367.192069467159;4367.253098760521;4368.868933931987;4996.126452580283;5000.099982003274;5010.974945125251;5026.371703537058;5041.319421878;5748.885022299614;5902.58681892272;5912.290525137011;5941.910871336933;5959.433853783884;1475.7196132734962;1502.8797696184279;1506.802092336595;1513.2887542854842;1520.5402813299136;929.7443203119196;955.991429042353;959.2421986630624;970.7865168539325;971.0095702383529;4987.800487980513;5019.723915184627;5027.4218464877;5034.471380505068;5057.367829021372;5324.866878327995;5333.866653333697;5417.753916599126;5439.918401223985;5442.755076021588;4989.825356112518;5034.597232221414;5034.89930201394;5243.973780131075;5715.971420142872;3220.2610590281456;3224.661410551905;3224.8548815303366;3255.6256030556315;3285.91785205367;6132.294786099566;6272.776808522385;6308.653024083627;6312.495000399957;6327.114204011442;6200.3799620037635;6208.255009398811;6215.502759779207;6249.843828866484;6270.6864656766975;6273.9372606273355;6290.276618188876;6294.433500984934;6322.146510221061;6337.873242535124;5810.477057064884;5977.864205800884;6045.758169673164;6069.180660610761;6120.234970628671;5988.341282459013;5988.640681559121;6006.489448396936;6061.696915154136;6066.605670631395;6040.244969378828;6265.404786545271;6278.277998030285;6314.400131987454;6388.169537960035;4206.284931561703;4237.703360764717;4254;4276.358546218092;4280.422143010654;6201.689915504297;6207.906881396873;6213.751449941951;6225.501959843292;6227.221597300338;5696.515796157373;5934.970325148347;5949.286085669747;5983.401659834156;6085.148079268817;5893.2044174035955;5902.586818922634;5949.613275137102;5978.163057172086;6020.187274717857;5664.745086471036;5830.883382332245;5883.676397798162;5907.2911250650195;5976.342602313655;5964.373740757158;5968.253968253968;5991.741734235685;6009.36901625323;6020.337762846171;5861.824145275648;5880.441358070976;5898;5919.852003699942;5981.282246130492 04:33:43 INFO - PROCESS | 510 | |5;yui.html;785.3952456608412;810.2221867007672;827.4869580859867;840.0759164918586;850.7515963986831;15584.220788960549;16716.91641541792;16727.080010599413;17019.659606807858;17613.11934403278;15768.44810431635;15938.043717376966;15947.122908240042;15957.680846383066;15998.520044398687;670.9261981182066;815.4536460571402;840.4369072721291;841.6338892581716;844.1136806353335;795.9283664470197;820.3888103363003;822.8107535266893;823.6952327638782;828.031203491913;868.431177578687;868.7741187291318;873.3406278259905;874.5845723281423;878.9296856251517;871.2420194430854;875.5315905990328;876.0494863073573;876.6931573949099;878.2008372381134;628.7547856336032;630.8864404407204;631.9336469670665;632.9556931014831;634.2262439823409;15363.615909602238;15426.537203883901;15474.690506189812;15547.533573992798;15593.844061559466;15034.248287585686;15044.849551504454;15110.471133510384;15146.848531514654;15178.544643660707;12626.873731262662;12670.936645316715;12814.615561533168;12837.29394883281;12851.485940562367;3923.548791888912;4091.079507110906;4095.1604920991126;4124.154548317588;4125.752454852688;77310.45379092387;78280.60859695722;78437.21562784356;78462.21537784606;78601.60699196525;11716.648500544998;11780.410979450993;12014.279143251433;12017;12114.81827772584;21223.893880530497;21281.89359053195;21298;21341.573168536543;21472.677909831364;8853.114688531095;8934.821303574023;9058.909410905939;9108.316876234308;9320.487373194539;4744.288356746447;4774.259989701602;4928.8767780805765;4930.580900623487;4934.679245849008;3471.253680458663;3522.9119272018406;3526.3123690880034;3532.8233588320995;3534.0988048047584;632.5666918161074;633.6736580660963;649.4901502320656;662.1656712542232;663.5554178700282;650;724.4892350892608;730.8574827908614;743.8252010777463;757.8332766791297;9616;9658.951705241428;9664.323497355117;10054.64808731691;10160.441175735257;622.7851391270004;677.4580335731494;682.276786606199;704.1655638068904;715.7280233511233;4986.376702912136;5002.849914502571;5044.596432285409;5067.239914012854;5075.111855425286;87772.56113719518;108202.45898770614;126004;128776.35611822069;129797;105849.47075264728;106002;106194.46902765437;107175.46412267888;107369;80031.59984200042;81308.18691813125;95572.52213739026;95626.52186739161;97431.4897359544;9932.324840764159;10455.372677639367;10646.73383165427;10804.567817287221;10817.45912704346;50773.49226507688;53230.73384633052;53817;54566.72716636391;54823.45176548343;72950.63524682343;74528.62735686287;80672;81156.59421702854;83291.58354208432;12679.175853569488;12878.227306361649;12959.870401295866;13008.869911300766;13285.601431957057;15290.847091528942;15319.540413787605;16299.103549304902;16497.752533711762;16598.75101873449;14552.563423097325;14766.557003289918;14908.85091149118;15085.47200847965;15543.689126217638;14197.025651262684;14892.925535372688;15019.924900375428;15367.846321536641;15536.456224032105;14622.634434139232;14678.268834440494;14739.92630036843;14890.553283401516;15180;11326.377064111248;11469.598564050551;11574.768504630028;11791.233569817934;11909.880901191224;10905.83641245366;11277.661670149908;11406.714832129263;11687.76624467523;12044.156909016285 04:33:43 INFO - PROCESS | 510 | __end_tp_report 04:33:43 INFO - PROCESS | 510 | __start_cc_report 04:33:43 INFO - PROCESS | 510 | _x_x_mozilla_cycle_collect,378 04:33:43 INFO - PROCESS | 510 | __end_cc_report 04:33:43 INFO - PROCESS | 510 | __startTimestamp1468668823012__endTimestamp 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | ------- Summary: start ------- 04:33:43 INFO - PROCESS | 510 | Number of tests: 6 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | [#0] dojo.html Cycles:165 Average:5485.17 Median:5707.51 stddev:746.99 (13.1%) stddev-sans-first:725.57 04:33:43 INFO - PROCESS | 510 | Values: 3104.7 3114.8 3133.3 3141.7 3155.0 5433.7 5476.1 5482.3 5528.4 5602.7 5426.4 5504.6 5553.4 5566.8 5594.6 4970.7 5036.5 5129.9 5172.3 5223.9 536.6 5079.7 5103.1 5122.1 5159.0 4989.9 5015.4 5029.5 5032.3 5062.1 5002.2 5024.5 5035.5 5035.5 5045.9 5025.6 5082.0 5085.4 5101.8 5105.6 5525.9 5579.5 5585.2 5600.4 5619.7 5689.1 5814.2 5855.6 5975.8 6023.9 5930.9 5956.0 5959.9 5964.2 5997.2 5517.7 5527.6 5550.9 5559.1 5563.5 5989.8 6029.3 6057.9 6089.9 6092.3 5832.6 5852.1 5853.9 5858.3 5861.6 5903.4 5906.1 5925.2 5925.2 5948.9 5771.7 5804.3 5811.7 5860.7 5884.7 5784.0 5802.5 5826.4 5844.5 5893.1 4500.2 4501.9 4504.8 4521.0 4541.6 3932.0 3949.3 3952.5 3983.8 3987.5 5590.0 5644.2 5662.7 5662.8 5710.1 5799.6 5962.1 5978.9 6008.8 6012.1 5595.5 5638.3 5641.2 5651.6 5682.8 5155.1 5155.3 5159.6 5161.2 5200.0 5969.8 5986.1 6174.8 6181.6 6195.2 5907.3 5980.7 5984.2 5986.0 6032.3 6090.2 6126.2 6131.8 6132.2 6138.7 5621.4 5819.5 5854.0 5879.2 5921.5 6082.2 6085.7 6086.6 6088.6 6138.4 5855.4 5901.5 5932.2 5942.5 5945.7 5762.9 5765.4 5798.8 5809.4 5922.1 5625.0 5636.0 5677.7 5697.4 5713.1 5827.1 5843.1 5853.4 5888.1 5892.1 5614.6 5661.1 5707.5 5753.3 5755.4 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | [#1] ext.html Cycles:180 Average:65174.33 Median:42057.58 stddev:134969.78 (320.9%) stddev-sans-first:135261.31 04:33:43 INFO - PROCESS | 510 | Values: 593.1 594.7 596.2 628.2 654.8 42289.6 43684.3 43909.1 44320.0 47426.3 45052.0 45730.0 45739.5 45741.3 45746.3 9048.2 9193.3 9209.3 9212.0 9215.2 9130.1 9152.6 9217.5 9226.6 9261.6 9204.3 9245.2 9252.1 9295.0 9315.6 9144.3 9176.9 9183.8 9214.9 9240.3 9059.5 9063.5 9131.0 9135.3 9141.4 42724.1 42809.6 42828.6 43147.4 43250.0 3549.4 3648.4 3665.0 3781.7 4008.7 33029.7 33749.8 34164.0 34956.7 35657.0 4369.5 4372.2 4464.2 4490.3 4559.9 384153.0 385221.1 386021.0 386685.0 387702.1 57964.1 58609.4 58620.7 58636.7 58941.0 37392.8 38421.8 59341.0 59952.7 60217.0 15739.1 15802.2 15850.1 15934.4 15963.6 12963.2 13074.6 13092.3 13118.5 13123.9 19646.5 19719.6 19913.0 19925.2 20011.0 7322.5 7395.1 7486.4 7540.2 7662.8 962.7 1058.5 1074.4 1109.4 1155.4 33290.3 33546.5 33950.3 34439.3 35948.5 1119.5 1124.4 1127.8 1166.8 1171.8 16813.6 17088.7 17219.8 17406.7 17481.2 586450.0 594273.0 598430.0 598715.0 600836.0 57597.7 57906.7 57950.4 58155.0 58184.0 1332.6 1366.9 1392.8 1394.2 1400.0 30964.5 31792.8 31990.8 32130.7 32205.7 50894.7 51192.2 51554.2 51683.2 51734.7 510717.0 518327.0 518537.0 519625.0 520784.0 27556.9 27702.7 27745.7 27757.9 27887.4 47478.0 48146.8 48269.0 48798.7 49377.5 40025.6 40664.4 41174.8 41469.8 41633.8 40800.6 40859.8 40923.0 41196.6 41825.6 39486.0 39764.4 40593.4 40722.0 41002.0 35717.0 36363.8 36660.8 37119.3 37258.8 27500.9 27590.4 27752.0 27962.7 28052.0 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | [#2] jquery.html Cycles:180 Average:29763.62 Median:19960.92 stddev:80994.57 (405.8%) stddev-sans-first:81191.76 04:33:43 INFO - PROCESS | 510 | Values: 393.3 396.5 398.9 401.5 420.6 18841.3 20280.5 20344.2 20497.4 20853.9 19536.7 19960.3 20193.5 20265.3 20269.8 5699.6 6013.4 6015.2 6020.7 6037.5 5602.9 5756.5 5829.5 5837.4 5840.6 5777.9 5807.3 5809.5 5826.5 5854.6 5776.1 5796.1 5868.5 5902.1 5931.2 5258.6 5258.7 5276.4 5303.9 5304.8 23258.5 24226.6 24554.1 24650.5 24960.5 2547.9 2734.7 3150.1 3195.3 3245.8 14608.3 14948.4 14956.2 15101.5 15455.6 1937.3 1953.9 1978.2 2128.6 2200.7 84213.0 86966.0 88794.1 89830.6 89966.1 10155.4 11292.7 11357.7 11442.2 11707.4 15754.8 15795.3 15808.8 15892.5 15895.0 8002.5 8018.2 8124.3 8270.1 8277.3 7735.1 7791.9 7839.0 7857.2 7869.9 4678.0 4839.9 4863.8 4889.8 4922.2 1843.0 1993.1 2003.1 2022.7 2095.5 998.3 999.9 1012.3 1052.7 1064.0 20123.6 20752.9 20755.5 20829.2 20847.5 1007.5 1034.4 1067.0 1070.8 1095.3 10960.6 11494.4 11500.8 11530.7 11685.5 484896.0 485059.0 485484.0 493853.0 500985.0 95682.0 95820.5 95988.0 96005.0 96034.5 832.1 834.7 844.2 852.5 939.8 17748.4 17877.6 18327.2 18528.6 18724.8 36676.0 40265.8 43057.4 43951.8 44111.6 56244.4 57732.0 58706.7 65999.7 66461.3 8196.0 8276.2 8564.2 8763.2 8811.0 9836.1 13543.7 13677.5 13712.5 13788.7 12194.5 12195.8 12211.3 12249.0 12339.7 12033.4 12038.2 12182.6 12313.3 12319.1 11956.2 12122.1 12145.8 12347.9 12481.4 8288.9 8628.6 8648.8 8739.0 8796.2 8949.6 11982.6 12075.0 12270.4 12307.0 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | [#3] mootools.html Cycles:180 Average:6026.06 Median:2456.76 stddev:3451.27 (140.5%) stddev-sans-first:3444.15 04:33:43 INFO - PROCESS | 510 | Values: 1494.4 1499.3 1673.2 1780.2 1809.8 8125.9 8260.8 8884.9 9455.6 9468.5 8637.3 8876.1 8929.5 8970.1 8973.0 2344.3 2357.4 2376.6 2378.9 2387.9 2237.6 2292.5 2400.4 2401.5 2411.8 2402.4 2402.6 2407.1 2411.8 2424.8 2361.1 2364.7 2376.4 2380.2 2382.4 2294.8 2305.6 2311.7 2316.6 2323.3 8817.9 8883.6 8885.7 8948.5 8955.1 5410.1 5477.5 5503.3 5540.5 5551.6 3572.4 3669.7 3719.2 3742.8 3752.3 1201.4 1233.9 1237.4 1251.2 1281.9 12860.7 12941.7 12980.4 12980.7 12990.6 4771.9 4831.7 4846.4 4880.8 5005.5 9995.3 10055.5 10072.3 10075.2 10079.8 5318.5 5327.2 5339.5 5344.3 5345.3 4426.6 4824.8 4866.6 4970.4 4984.3 3936.8 4009.0 4010.9 4066.7 4138.4 1218.6 1250.1 1261.0 1264.8 1266.7 1002.6 1036.6 1041.7 1045.8 1058.7 6273.9 6335.1 6435.8 6551.5 6575.4 437.7 451.3 460.3 463.0 466.8 4335.5 4406.6 4419.6 4434.9 4462.2 11264.8 11493.4 11557.4 11571.9 11673.0 10856.9 11378.8 11387.8 11407.3 11424.7 8319.3 8727.3 8776.1 8784.2 8795.3 6254.7 6381.8 6579.1 6611.6 6625.4 10508.7 10645.3 10648.6 10673.6 10743.4 10897.7 10914.9 10916.0 11050.3 11053.7 7325.9 7729.3 7963.7 8206.9 8314.3 9071.7 9095.8 9102.8 9154.0 9163.6 7831.7 7990.8 8090.2 8135.7 8145.0 7862.6 7882.5 7894.4 7990.0 8150.7 7024.4 7132.2 7195.5 7251.7 7268.2 5291.9 5403.3 5428.9 5498.3 5619.7 5465.7 5535.2 5561.7 5567.1 5658.8 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | [#4] prototype.html Cycles:180 Average:4931.39 Median:5563.29 stddev:1464.53 (26.3%) stddev-sans-first:1427.31 04:33:43 INFO - PROCESS | 510 | Values: 328.8 333.4 339.8 342.9 345.8 5441.5 5541.3 5585.3 5669.3 5760.3 5598.4 5599.9 5611.4 5614.3 5620.8 4358.8 4364.5 4366.8 4382.9 4383.7 4148.8 4366.7 4366.8 4383.6 4393.3 4316.5 4317.4 4324.0 4334.1 4334.5 4344.5 4350.2 4365.4 4389.6 4396.6 3791.4 3840.3 3868.8 3879.0 3881.9 5403.7 5457.3 5493.8 5522.8 5534.0 4986.1 4986.8 4992.4 5023.4 5036.1 5723.9 5829.7 5853.2 5879.2 5896.7 4184.4 4189.1 4191.6 4221.2 4233.4 6120.8 6142.7 6157.8 6186.6 6188.1 4169.4 4252.0 4285.4 4312.2 4331.0 4330.9 4365.8 4367.2 4367.3 4368.9 4996.1 5000.1 5011.0 5026.4 5041.3 5748.9 5902.6 5912.3 5941.9 5959.4 1475.7 1502.9 1506.8 1513.3 1520.5 929.7 956.0 959.2 970.8 971.0 4987.8 5019.7 5027.4 5034.5 5057.4 5324.9 5333.9 5417.8 5439.9 5442.8 4989.8 5034.6 5034.9 5244.0 5716.0 3220.3 3224.7 3224.9 3255.6 3285.9 6132.3 6272.8 6308.7 6312.5 6327.1 6200.4 6208.3 6215.5 6249.8 6270.7 6273.9 6290.3 6294.4 6322.1 6337.9 5810.5 5977.9 6045.8 6069.2 6120.2 5988.3 5988.6 6006.5 6061.7 6066.6 6040.2 6265.4 6278.3 6314.4 6388.2 4206.3 4237.7 4254.0 4276.4 4280.4 6201.7 6207.9 6213.8 6225.5 6227.2 5696.5 5935.0 5949.3 5983.4 6085.1 5893.2 5902.6 5949.6 5978.2 6020.2 5664.7 5830.9 5883.7 5907.3 5976.3 5964.4 5968.3 5991.7 6009.4 6020.3 5861.8 5880.4 5898.0 5919.9 5981.3 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - PROCESS | 510 | [#5] yui.html Cycles:180 Average:21740.87 Median:4007.31 stddev:31216.00 (779.0%) stddev-sans-first:31263.91 04:33:43 INFO - PROCESS | 510 | Values: 785.4 810.2 827.5 840.1 850.8 15584.2 16716.9 16727.1 17019.7 17613.1 15768.4 15938.0 15947.1 15957.7 15998.5 670.9 815.5 840.4 841.6 844.1 795.9 820.4 822.8 823.7 828.0 868.4 868.8 873.3 874.6 878.9 871.2 875.5 876.0 876.7 878.2 628.8 630.9 631.9 633.0 634.2 15363.6 15426.5 15474.7 15547.5 15593.8 15034.2 15044.8 15110.5 15146.8 15178.5 12626.9 12670.9 12814.6 12837.3 12851.5 3923.5 4091.1 4095.2 4124.2 4125.8 77310.5 78280.6 78437.2 78462.2 78601.6 11716.6 11780.4 12014.3 12017.0 12114.8 21223.9 21281.9 21298.0 21341.6 21472.7 8853.1 8934.8 9058.9 9108.3 9320.5 4744.3 4774.3 4928.9 4930.6 4934.7 3471.3 3522.9 3526.3 3532.8 3534.1 632.6 633.7 649.5 662.2 663.6 650.0 724.5 730.9 743.8 757.8 9616.0 9659.0 9664.3 10054.6 10160.4 622.8 677.5 682.3 704.2 715.7 4986.4 5002.8 5044.6 5067.2 5075.1 87772.6 108202.5 126004.0 128776.4 129797.0 105849.5 106002.0 106194.5 107175.5 107369.0 80031.6 81308.2 95572.5 95626.5 97431.5 9932.3 10455.4 10646.7 10804.6 10817.5 50773.5 53230.7 53817.0 54566.7 54823.5 72950.6 74528.6 80672.0 81156.6 83291.6 12679.2 12878.2 12959.9 13008.9 13285.6 15290.8 15319.5 16299.1 16497.8 16598.8 14552.6 14766.6 14908.9 15085.5 15543.7 14197.0 14892.9 15019.9 15367.8 15536.5 14622.6 14678.3 14739.9 14890.6 15180.0 11326.4 11469.6 11574.8 11791.2 11909.9 10905.8 11277.7 11406.7 11687.8 12044.2 04:33:43 INFO - PROCESS | 510 | -------- Summary: end -------- 04:33:43 INFO - PROCESS | 510 | 04:33:43 INFO - TEST-INFO | 510: exit 0 04:33:43 INFO - TEST-OK | dromaeo_css | took 1110701ms 04:33:43 INFO - TEST-START | kraken 04:33:43 INFO - operating with platform_type : linux_ 04:33:43 INFO - Initialising browser for kraken test... 04:33:43 INFO - TEST-INFO | started process 763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfi0LuD/profile http://localhost:49719/getInfo.html) 04:33:48 INFO - PROCESS | 763 | __metrics Screen width/height:1600/1200 04:33:48 INFO - PROCESS | 763 | colorDepth:24 04:33:48 INFO - PROCESS | 763 | Browser inner width/height: 1024/697 04:33:48 INFO - PROCESS | 763 | __metrics 04:33:48 ERROR - PROCESS | 763 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:33:49 INFO - TEST-INFO | 763: exit 0 04:33:49 INFO - Browser initialized. 04:33:49 INFO - Running cycle 1/1 for kraken test... 04:33:49 INFO - TEST-INFO | started process 891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfi0LuD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:01 INFO - PROCESS | 891 | RSS: Main: 168263680 04:34:01 INFO - PROCESS | 891 | 04:34:03 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49719/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:04 INFO - PROCESS | 891 | RSS: Main: 173674496 04:34:04 INFO - PROCESS | 891 | 04:34:07 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49719/tests/kraken/driver.html?testName=audio-dft) 04:34:07 INFO - PROCESS | 891 | RSS: Main: 172802048 04:34:07 INFO - PROCESS | 891 | 04:34:10 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49719/tests/kraken/driver.html?testName=audio-fft) 04:34:11 INFO - PROCESS | 891 | RSS: Main: 167256064 04:34:11 INFO - PROCESS | 891 | 04:34:13 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49719/tests/kraken/driver.html?testName=audio-oscillator) 04:34:14 INFO - PROCESS | 891 | RSS: Main: 168124416 04:34:14 INFO - PROCESS | 891 | 04:34:16 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:16 INFO - PROCESS | 891 | RSS: Main: 168542208 04:34:16 INFO - PROCESS | 891 | 04:34:20 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49719/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:20 INFO - PROCESS | 891 | RSS: Main: 168693760 04:34:20 INFO - PROCESS | 891 | 04:34:24 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49719/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:24 INFO - PROCESS | 891 | RSS: Main: 166334464 04:34:24 INFO - PROCESS | 891 | 04:34:27 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49719/tests/kraken/driver.html?testName=json-parse-financial) 04:34:28 INFO - PROCESS | 891 | RSS: Main: 168443904 04:34:28 INFO - PROCESS | 891 | 04:34:29 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:30 INFO - PROCESS | 891 | RSS: Main: 168566784 04:34:30 INFO - PROCESS | 891 | 04:34:32 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:32 INFO - PROCESS | 891 | RSS: Main: 168538112 04:34:32 INFO - PROCESS | 891 | 04:34:34 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:35 INFO - PROCESS | 891 | RSS: Main: 169316352 04:34:35 INFO - PROCESS | 891 | 04:34:38 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:38 INFO - PROCESS | 891 | RSS: Main: 169472000 04:34:38 INFO - PROCESS | 891 | 04:34:41 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:42 INFO - PROCESS | 891 | RSS: Main: 169291776 04:34:42 INFO - PROCESS | 891 | 04:34:43 INFO - PROCESS | 891 | Cycle 1(1): loaded http://localhost:49719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49719/tests/kraken/driver.html?testName=ai-astar) 04:34:44 INFO - PROCESS | 891 | RSS: Main: 169766912 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | __start_tp_report 04:34:44 INFO - PROCESS | 891 | _x_x_mozilla_page_load 04:34:44 INFO - PROCESS | 891 | _x_x_mozilla_page_load_details 04:34:44 INFO - PROCESS | 891 | |i|pagename|runs| 04:34:44 INFO - PROCESS | 891 | |0;ai-astar;102;112;105;111;111;112;114;111;112;112 04:34:44 INFO - PROCESS | 891 | |1;audio-beat-detection;158;120;146;180;121;153;147;121;174;124 04:34:44 INFO - PROCESS | 891 | |2;audio-dft;162;161;162;161;162;164;175;161;161;165 04:34:44 INFO - PROCESS | 891 | |3;audio-fft;76;75;74;152;77;75;75;75;171;75 04:34:44 INFO - PROCESS | 891 | |4;audio-oscillator;83;82;142;83;83;83;142;83;83;148 04:34:44 INFO - PROCESS | 891 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;117 04:34:44 INFO - PROCESS | 891 | |6;imaging-darkroom;147;146;146;147;148;148;147;145;147;155 04:34:44 INFO - PROCESS | 891 | |7;imaging-desaturate;95;96;95;96;95;95;95;96;96;100 04:34:44 INFO - PROCESS | 891 | |8;json-parse-financial;54;53;52;55;53;54;52;54;52;53 04:34:44 INFO - PROCESS | 891 | |9;json-stringify-tinderbox;63;63;63;63;64;62;62;63;66;63 04:34:44 INFO - PROCESS | 891 | |10;stanford-crypto-aes;76;76;75;85;81;76;76;75;81;76 04:34:44 INFO - PROCESS | 891 | |11;stanford-crypto-ccm;133;119;130;121;124;122;129;128;168;123 04:34:44 INFO - PROCESS | 891 | |12;stanford-crypto-pbkdf2;159;159;159;157;179;158;162;160;157;156 04:34:44 INFO - PROCESS | 891 | |13;stanford-crypto-sha256-iterative;63;64;64;67;64;63;66;70;64;63 04:34:44 INFO - PROCESS | 891 | __end_tp_report 04:34:44 INFO - PROCESS | 891 | __start_cc_report 04:34:44 INFO - PROCESS | 891 | _x_x_mozilla_cycle_collect,926 04:34:44 INFO - PROCESS | 891 | __end_cc_report 04:34:44 INFO - PROCESS | 891 | __startTimestamp1468668884049__endTimestamp 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | ------- Summary: start ------- 04:34:44 INFO - PROCESS | 891 | Number of tests: 14 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.71 (3.3%) stddev-sans-first:2.47 04:34:44 INFO - PROCESS | 891 | Values: 102.0 112.0 105.0 111.0 111.0 112.0 114.0 111.0 112.0 112.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:150.00 stddev:22.41 (14.9%) stddev-sans-first:23.22 04:34:44 INFO - PROCESS | 891 | Values: 158.0 120.0 146.0 180.0 121.0 153.0 147.0 121.0 174.0 124.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.00 stddev:4.30 (2.7%) stddev-sans-first:4.53 04:34:44 INFO - PROCESS | 891 | Values: 162.0 161.0 162.0 161.0 162.0 164.0 175.0 161.0 161.0 165.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:36.65 (48.9%) stddev-sans-first:38.38 04:34:44 INFO - PROCESS | 891 | Values: 76.0 75.0 74.0 152.0 77.0 75.0 75.0 75.0 171.0 75.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.00 stddev:29.58 (35.6%) stddev-sans-first:30.63 04:34:44 INFO - PROCESS | 891 | Values: 83.0 82.0 142.0 83.0 83.0 83.0 142.0 83.0 83.0 148.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:34:44 INFO - PROCESS | 891 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:2.76 (1.9%) stddev-sans-first:2.92 04:34:44 INFO - PROCESS | 891 | Values: 147.0 146.0 146.0 147.0 148.0 148.0 147.0 145.0 147.0 155.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:1.58 04:34:44 INFO - PROCESS | 891 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 100.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.03 (1.9%) stddev-sans-first:1.05 04:34:44 INFO - PROCESS | 891 | Values: 54.0 53.0 52.0 55.0 53.0 54.0 52.0 54.0 52.0 53.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 04:34:44 INFO - PROCESS | 891 | Values: 63.0 63.0 63.0 63.0 64.0 62.0 62.0 63.0 66.0 63.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:76.00 stddev:3.40 (4.5%) stddev-sans-first:3.55 04:34:44 INFO - PROCESS | 891 | Values: 76.0 76.0 75.0 85.0 81.0 76.0 76.0 75.0 81.0 76.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:128.50 stddev:14.17 (11.0%) stddev-sans-first:14.98 04:34:44 INFO - PROCESS | 891 | Values: 133.0 119.0 130.0 121.0 124.0 122.0 129.0 128.0 168.0 123.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:159.00 stddev:6.69 (4.2%) stddev-sans-first:7.07 04:34:44 INFO - PROCESS | 891 | Values: 159.0 159.0 159.0 157.0 179.0 158.0 162.0 160.0 157.0 156.0 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - PROCESS | 891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.00 stddev:2.25 (3.5%) stddev-sans-first:2.29 04:34:44 INFO - PROCESS | 891 | Values: 63.0 64.0 64.0 67.0 64.0 63.0 66.0 70.0 64.0 63.0 04:34:44 INFO - PROCESS | 891 | -------- Summary: end -------- 04:34:44 INFO - PROCESS | 891 | 04:34:44 INFO - TEST-INFO | 891: exit 0 04:34:45 INFO - TEST-OK | kraken | took 61316ms 04:34:45 INFO - SUITE-END | took 1172s 04:34:45 INFO - Completed test suite (00:19:32) 04:34:45 INFO - javascript benchmark 04:34:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7500.007334009499, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.674009229031, 3114.828684422357, 3133.279345750476, 3141.7486601071914, 3154.984225078875, 5433.7283135843245, 5476.069068258395, 5482.287302650655, 5528.364238112618, 5602.719864006794, 5426.430224826396, 5504.559635229182, 5553.444655534445, 5566.805161819337, 5594.636348637346, 4970.6520543561965, 5036.521530454601, 5129.871753206163, 5172.250023746555, 5223.869403264911, 536.5627863478778, 5079.746012699368, 5103.081445339837, 5122.078025955327, 5158.974205128988, 4989.875253118665, 5015.3730783652045, 5029.547340739333, 5032.270320803481, 5062.139436295838, 5002.24966255061, 5024.497550244982, 5035.496450354972, 5035.496450354972, 5045.899082018339, 5025.648204625678, 5081.974590127063, 5085.364329458817, 5101.795928162869, 5105.591552675777, 5525.944740552623, 5579.46995035471, 5585.218069470277, 5600.383957764642, 5619.719014049281, 5689.146628005791, 5814.186013958049, 5855.560832937546, 5975.820725378246, 6023.879522409527, 5930.911036334458, 5956.047032474783, 5959.851003724942, 5964.1650168976375, 5997.190379298782, 5517.668939863621, 5527.640703354309, 5550.91673624896, 5559.138333558305, 5563.471470210324, 5989.760409583655, 6029.276486821609, 6057.909131363033, 6089.908651370233, 6092.268927728701, 5832.591718579659, 5852.122181672698, 5853.94146058534, 5858.2677165354335, 5861.618994765412, 5903.409659034062, 5906.084556893688, 5925.170476133345, 5925.229720136354, 5948.851278718067, 5771.68255745938, 5804.303483581913, 5811.738471768781, 5860.736266868002, 5884.735186916599, 5783.971080144656, 5802.47777700009, 5826.388229235869, 5844.503217226584, 5893.14549390336, 4500.189965806121, 4501.932471012938, 4504.81980720774, 4520.95479045212, 4541.591256786905, 3932.036651020518, 3949.30887094763, 3952.505936757905, 3983.780892050907, 3987.4816273884207, 5590.0, 5644.181593668977, 5662.66024038559, 5662.801801936913, 5710.114932185518, 5799.5650326225705, 5962.1056841473255, 5978.940210597925, 6008.789692360747, 6012.098185272244, 5595.496405323541, 5638.323401191801, 5641.2384328116, 5651.576131790132, 5682.829515114553, 5155.072087024371, 5155.304033955443, 5159.638825282269, 5161.225816127611, 5200.037992971313, 5969.761209551656, 5986.132010858401, 6174.753009879554, 6181.598196117238, 6195.19462469876, 5907.261592300876, 5980.671063091398, 5984.1921340618455, 5985.970070149621, 6032.33644299118, 6090.23872015998, 6126.23422072241, 6131.816045518642, 6132.233470816148, 6138.723757430837, 5621.437856214346, 5819.5053420459735, 5854.0340843760305, 5879.176915231957, 5921.526277897844, 6082.2093127893095, 6085.66528840918, 6086.573939824347, 6088.6042407243385, 6138.386161383826, 5855.414458554111, 5901.498372638202, 5932.228810254639, 5942.494887934574, 5945.672987985529, 5762.855928601651, 5765.423457654369, 5798.768049277982, 5809.419058094157, 5922.052471604523, 5625.0, 5636.0, 5677.744501497526, 5697.401772813961, 5713.143028545752, 5827.096799996008, 5843.065109582446, 5853.385394533512, 5888.087346461305, 5892.086726557391, 5614.550835933034, 5661.122526008476, 5707.514861236841, 5753.338366087786, 5755.36690964002], "value": 5435.476185832232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.0718425663836, 594.6729298885612, 596.2427716799667, 628.1519948070106, 654.8330175805166, 42289.57710422895, 43684.34473482901, 43909.12181756367, 44320.0, 47426.28860567086, 45052.0, 45730.0, 45739.542604573944, 45741.31388029174, 45746.31380529295, 9048.230900373475, 9193.310501712398, 9209.263258939269, 9211.953940230323, 9215.216706579915, 9130.132637399436, 9152.588133533975, 9217.493037882914, 9226.630934762601, 9261.629534818632, 9204.263658907304, 9245.214156796646, 9252.074792520727, 9295.024022477644, 9315.580798864068, 9144.268458523335, 9176.908230917672, 9183.770405739877, 9214.861777073349, 9240.306976976754, 9059.547022648841, 9063.456192628397, 9131.0, 9135.269178465707, 9141.360104792668, 42724.1455170898, 42809.57190428087, 42828.57171428277, 43147.35278970818, 43250.0, 3549.378858699743, 3648.416253399443, 3664.963350366489, 3781.716371272166, 4008.6592639625665, 33029.66970330314, 33749.83125084383, 34164.0, 34956.6504334956, 35657.0, 4369.519352871182, 4372.23485889968, 4464.241079016575, 4490.259107247301, 4559.886002849922, 384153.0, 385221.0738946315, 386021.0, 386685.0, 387702.0614896936, 57964.130538041965, 58609.41390586125, 58620.70689646524, 58636.706816465645, 58941.0, 37392.81303593465, 38421.807890960925, 59341.0, 59952.70023649854, 60217.0, 15739.13434761099, 15802.209889505479, 15850.128242946748, 15934.442294519868, 15963.60090997711, 12963.22220666763, 13074.607761767162, 13092.279924604049, 13118.540851070358, 13123.934380328228, 19646.508837279183, 19719.605607887763, 19913.0, 19925.202991880164, 20011.0, 7322.450816188701, 7395.149557800814, 7486.363659089038, 7540.245975402526, 7662.770116896502, 962.7448726087592, 1058.4654749351528, 1074.363280296203, 1109.4230999880017, 1155.3530023186875, 33290.334193316, 33546.49680254798, 33950.320993580484, 34439.31121377558, 35948.46077308842, 1119.5409881948362, 1124.409684915426, 1127.8363298202107, 1166.8191430328313, 1171.83008463774, 16813.57966050834, 17088.743668844978, 17219.827801722073, 17406.65186696259, 17481.213345399487, 586450.0, 594273.0, 598430.0, 598715.0256994836, 600836.0, 57597.712011439675, 57906.710466447395, 57950.42049579535, 58155.0, 58184.0, 1332.6068809701162, 1366.917984920888, 1392.8258967629047, 1394.1913690059741, 1400.033976556173, 30964.53553196749, 31792.841035794674, 31990.84004579962, 32130.67869321277, 32205.677943220267, 50894.745526272134, 51192.23211651903, 51554.22668659898, 51683.224751628004, 51734.741326294636, 510717.0, 518327.0, 518537.0, 519625.0, 520784.0, 27556.862215688794, 27702.722972770014, 27745.722542775122, 27757.861210693816, 27887.44225115527, 47478.0, 48146.75926620485, 48269.0, 48798.72182210067, 49377.50622493729, 40025.59974400219, 40664.39003414892, 41174.79412602918, 41469.79265103655, 41633.79183104065, 40800.59199408087, 40859.79570102131, 40923.0, 41196.588034120476, 41825.58174418217, 39486.0, 39764.403533947596, 40593.39109913295, 40722.0, 41002.0, 35717.0, 36363.818180909984, 36660.81669591742, 37119.25761484701, 37258.813705931294, 27500.862495687394, 27590.448191036467, 27752.0, 27962.720372796826, 28052.0], "value": 20575.478203657334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.3136676499509, 396.5499158455153, 398.856411691791, 401.4800832921367, 420.6004295918878, 18841.340553080645, 20280.492987675334, 20344.1862325507, 20497.385078447634, 20853.895730521363, 19536.70694939577, 19960.301389451335, 20193.49516262094, 20265.290714824983, 20269.797302026975, 5699.629524080932, 6013.398660133996, 6015.157877897076, 6020.698965051752, 6037.456628903398, 5602.915956260639, 5756.510696590794, 5829.533637309005, 5837.416258374171, 5840.649561026352, 5777.884442311151, 5807.303123625171, 5809.506191973687, 5826.475617194452, 5854.619449735754, 5776.104703770922, 5796.07262837946, 5868.530517558585, 5902.144189092557, 5931.169636250886, 5258.6318957672975, 5258.710770907599, 5276.366835979668, 5303.867403314909, 5304.840854774363, 23258.534829303488, 24226.63660045101, 24554.140605078916, 24650.506989860103, 24960.50078998428, 2547.9490410191693, 2734.740199681027, 3150.070729134911, 3195.344954284366, 3245.837708114585, 14608.342624581814, 14948.40206391743, 14956.24739567828, 15101.47144849936, 15455.613609659737, 1937.2832052140657, 1953.9120739566754, 1978.1889425335544, 2128.5742851429777, 2200.6919031335624, 84213.04918785814, 86966.0, 88794.11205887923, 89830.550847246, 89966.10033899643, 10155.441450720133, 11292.717682058013, 11357.659270221906, 11442.199046066695, 11707.414629268502, 15754.76367854483, 15795.289211985488, 15808.762868556982, 15892.52322430329, 15895.046297221972, 8002.479838810459, 8018.158093400109, 8124.309433698084, 8270.090290068089, 8277.296429803535, 7735.1491335953, 7791.922080779233, 7839.0, 7857.214278572212, 7869.921300787033, 4677.976610116928, 4839.854804355875, 4863.756812159378, 4889.828855990095, 4922.237053256751, 1842.97235541467, 1993.1130646862007, 2003.1486618187212, 2022.737044184276, 2095.5226565271446, 998.2513115163628, 999.8700168977987, 1012.3166862367872, 1052.736815796051, 1063.9838953799103, 20123.59752804965, 20752.896235519027, 20755.481112972295, 20829.1668333268, 20847.47881302949, 1007.4861820471613, 1034.374203606822, 1066.9786604267872, 1070.7804899995483, 1095.2552264460244, 10960.56157753681, 11494.367809770376, 11500.827487587692, 11530.711732206593, 11685.474153663106, 484896.0, 485059.0, 485484.0, 493853.0, 500985.0, 95682.0, 95820.52089739506, 95988.0, 96005.0, 96034.51982740182, 832.1304237072274, 834.678648720235, 844.2359664503634, 852.5012867472598, 939.7979434421495, 17748.3788067417, 17877.553061173574, 18327.17527711283, 18528.629427411644, 18724.81275187285, 36676.0, 40265.79867100763, 43057.354139688556, 43951.78024109859, 44111.55888441203, 56244.43755562392, 57732.0, 58706.706466467396, 65999.67000164969, 66461.33538664551, 8195.95902020486, 8276.220612568086, 8564.229219370287, 8763.167499087576, 8811.0, 9836.06557377048, 13543.661408464866, 13677.521286755315, 13712.451501939811, 13788.655283617989, 12194.51221951112, 12195.841395067455, 12211.328376938998, 12249.0, 12339.69150771238, 12033.398330083286, 12038.157328986887, 12182.573609923611, 12313.322767247888, 12319.076069294659, 11956.163068585116, 12122.09084318662, 12145.817812732992, 12347.938260308641, 12481.375931203585, 8288.917110829056, 8628.568571571523, 8648.82702345937, 8739.0, 8796.164364385373, 8949.552522373726, 11982.64052078439, 12075.0, 12270.447829847857, 12307.015438764698], "value": 9567.772558571323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.3947701181019, 1499.3178103962698, 1673.155056696368, 1780.23449916536, 1809.8280663336986, 8125.91874081259, 8260.793480162984, 8884.911150888489, 9455.621775129004, 9468.479233642156, 8637.265832404237, 8876.068012858654, 8929.464232146076, 8970.102989701027, 8972.955135224314, 2344.296710986706, 2357.4205282460707, 2376.6316220985773, 2378.8691621960784, 2387.880605969703, 2237.5748607764554, 2292.4841910570153, 2400.4238982644215, 2401.5317013182434, 2411.7829395354415, 2402.3633737059695, 2402.5675378431874, 2407.109369533275, 2411.807055435561, 2424.806015518754, 2361.055577768906, 2364.6925899633025, 2376.394019525019, 2380.238323736414, 2382.4401265702545, 2294.8278879084137, 2305.5965206089036, 2311.6763653088583, 2316.5598536278053, 2323.268170526279, 8817.867731984026, 8883.555822208864, 8885.733427997171, 8948.463092214422, 8955.149260820212, 5410.1343784994215, 5477.534409575191, 5503.284573005523, 5540.50135487804, 5551.555875529948, 3572.374834403969, 3669.743117981742, 3719.1817800083936, 3742.8128593570486, 3752.3245815753153, 1201.3572738584903, 1233.9444724987306, 1237.4307818403545, 1251.1804767877054, 1281.9038572107129, 12860.678483037906, 12941.741165176643, 12980.415881285271, 12980.740385192337, 12990.61028169147, 4771.928421073687, 4831.685940413862, 4846.442659094178, 4880.829170978998, 5005.499450055038, 9995.250356223312, 10055.547500362502, 10072.345297555781, 10075.193984481224, 10079.848802267972, 5318.494742999409, 5327.174287985368, 5339.46605339463, 5344.251804747339, 5345.33183352081, 4426.579474949875, 4824.782884770194, 4866.635002374836, 4970.378702662168, 4984.327115839315, 3936.7637941723588, 4008.9799551002056, 4010.8796736097966, 4066.694997875112, 4138.441310423054, 1218.585680868509, 1250.143651598658, 1260.9558665446666, 1264.8166015927823, 1266.6516707905216, 1002.6364144763262, 1036.5698235232444, 1041.7499800047933, 1045.7960697664034, 1058.7035630023606, 6273.937260627426, 6335.11308416822, 6435.839104022437, 6551.541392102602, 6575.375339342755, 437.7001753798658, 451.31400271587006, 460.2980454806447, 463.04612498253704, 466.78994452495834, 4335.479742430928, 4406.581374769392, 4419.624331931757, 4434.911301773946, 4462.196804575207, 11264.774704505864, 11493.42532873353, 11557.422128893522, 11571.884281157249, 11673.0, 10856.891431085745, 11378.772424551462, 11387.772244555063, 11407.25852819564, 11424.657260282205, 8319.292860106958, 8727.345449091217, 8776.122387761172, 8784.165504277084, 8795.252403545643, 6254.687265636791, 6381.8085457436355, 6579.078928949855, 6611.603303801788, 6625.403713665601, 10508.684739457829, 10645.254832161674, 10648.574057037631, 10673.626423075155, 10743.409112498888, 10897.727556811144, 10914.945425272823, 10916.0, 11050.281731687415, 11053.72365690832, 7325.926740732524, 7729.304362607392, 7963.6814527418255, 8206.917930820855, 8314.251717345467, 9071.682491112779, 9095.772605684911, 9102.772430689285, 9154.038825923182, 9163.633454661738, 7831.686732530863, 7990.84018319642, 8090.15053419406, 8135.674573017013, 8145.0, 7862.60686965638, 7882.487638303492, 7894.36845052383, 7990.0, 8150.673973041012, 7024.4029257513685, 7132.215456299907, 7195.532290401107, 7251.673674684546, 7268.164161121539, 5291.947080529146, 5403.270558474713, 5428.891422171456, 5498.257735205856, 5619.690916999441, 5465.72671366438, 5535.225068490495, 5561.6663000220115, 5567.05360088794, 5658.801941932013], "value": 4733.391168160388, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.7813603953371, 333.386568713567, 339.8029143097003, 342.86285485805683, 345.81498898089495, 5441.455854414557, 5541.251930989315, 5585.329760428749, 5669.262995810544, 5760.337561180466, 5598.44015598441, 5599.8600034999145, 5611.3546942101675, 5614.326280846294, 5620.751699320274, 4358.782060896959, 4364.476262848462, 4366.781660916958, 4382.9123417531555, 4383.715058521202, 4148.751074935513, 4366.737995720267, 4366.768591242474, 4383.627391671712, 4393.275109606911, 4316.525182229952, 4317.395564620955, 4324.0, 4334.13317336534, 4334.479862416514, 4344.500382456011, 4350.216960947028, 4365.43249377582, 4389.604935555783, 4396.648268138541, 3791.431285307226, 3840.2703486337505, 3868.825902834379, 3879.0, 3881.86413475527, 5403.729813509348, 5457.263269458652, 5493.835184944458, 5522.834314970557, 5534.0, 4986.127427700174, 4986.775595098229, 4992.350994370745, 5023.422306434771, 5036.11867923112, 5723.885522289531, 5829.650220986712, 5853.151293062482, 5879.176915231871, 5896.734646940855, 4184.351425529047, 4189.120284740208, 4191.601797829201, 4221.2190744712325, 4233.354153653966, 6120.785772497986, 6142.692865356759, 6157.7536898524, 6186.566940314135, 6188.133661287423, 4169.395437661522, 4252.020156841695, 4285.357196420499, 4312.159128969821, 4330.978345108254, 4330.891727706832, 4365.75988320639, 4367.192069467159, 4367.253098760521, 4368.868933931987, 4996.126452580283, 5000.099982003274, 5010.974945125251, 5026.371703537058, 5041.319421878, 5748.885022299614, 5902.58681892272, 5912.290525137011, 5941.910871336933, 5959.433853783884, 1475.7196132734962, 1502.8797696184279, 1506.802092336595, 1513.2887542854842, 1520.5402813299136, 929.7443203119196, 955.991429042353, 959.2421986630624, 970.7865168539325, 971.0095702383529, 4987.800487980513, 5019.723915184627, 5027.4218464877, 5034.471380505068, 5057.367829021372, 5324.866878327995, 5333.866653333697, 5417.753916599126, 5439.918401223985, 5442.755076021588, 4989.825356112518, 5034.597232221414, 5034.89930201394, 5243.973780131075, 5715.971420142872, 3220.2610590281456, 3224.661410551905, 3224.8548815303366, 3255.6256030556315, 3285.91785205367, 6132.294786099566, 6272.776808522385, 6308.653024083627, 6312.495000399957, 6327.114204011442, 6200.3799620037635, 6208.255009398811, 6215.502759779207, 6249.843828866484, 6270.6864656766975, 6273.9372606273355, 6290.276618188876, 6294.433500984934, 6322.146510221061, 6337.873242535124, 5810.477057064884, 5977.864205800884, 6045.758169673164, 6069.180660610761, 6120.234970628671, 5988.341282459013, 5988.640681559121, 6006.489448396936, 6061.696915154136, 6066.605670631395, 6040.244969378828, 6265.404786545271, 6278.277998030285, 6314.400131987454, 6388.169537960035, 4206.284931561703, 4237.703360764717, 4254.0, 4276.358546218092, 4280.422143010654, 6201.689915504297, 6207.906881396873, 6213.751449941951, 6225.501959843292, 6227.221597300338, 5696.515796157373, 5934.970325148347, 5949.286085669747, 5983.401659834156, 6085.148079268817, 5893.2044174035955, 5902.586818922634, 5949.613275137102, 5978.163057172086, 6020.187274717857, 5664.745086471036, 5830.883382332245, 5883.676397798162, 5907.2911250650195, 5976.342602313655, 5964.373740757158, 5968.253968253968, 5991.741734235685, 6009.36901625323, 6020.337762846171, 5861.824145275648, 5880.441358070976, 5898.0, 5919.852003699942, 5981.282246130492], "value": 4459.727985995431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.3952456608412, 810.2221867007672, 827.4869580859867, 840.0759164918586, 850.7515963986831, 15584.220788960549, 16716.91641541792, 16727.080010599413, 17019.659606807858, 17613.11934403278, 15768.44810431635, 15938.043717376966, 15947.122908240042, 15957.680846383066, 15998.520044398687, 670.9261981182066, 815.4536460571402, 840.4369072721291, 841.6338892581716, 844.1136806353335, 795.9283664470197, 820.3888103363003, 822.8107535266893, 823.6952327638782, 828.031203491913, 868.431177578687, 868.7741187291318, 873.3406278259905, 874.5845723281423, 878.9296856251517, 871.2420194430854, 875.5315905990328, 876.0494863073573, 876.6931573949099, 878.2008372381134, 628.7547856336032, 630.8864404407204, 631.9336469670665, 632.9556931014831, 634.2262439823409, 15363.615909602238, 15426.537203883901, 15474.690506189812, 15547.533573992798, 15593.844061559466, 15034.248287585686, 15044.849551504454, 15110.471133510384, 15146.848531514654, 15178.544643660707, 12626.873731262662, 12670.936645316715, 12814.615561533168, 12837.29394883281, 12851.485940562367, 3923.548791888912, 4091.079507110906, 4095.1604920991126, 4124.154548317588, 4125.752454852688, 77310.45379092387, 78280.60859695722, 78437.21562784356, 78462.21537784606, 78601.60699196525, 11716.648500544998, 11780.410979450993, 12014.279143251433, 12017.0, 12114.81827772584, 21223.893880530497, 21281.89359053195, 21298.0, 21341.573168536543, 21472.677909831364, 8853.114688531095, 8934.821303574023, 9058.909410905939, 9108.316876234308, 9320.487373194539, 4744.288356746447, 4774.259989701602, 4928.8767780805765, 4930.580900623487, 4934.679245849008, 3471.253680458663, 3522.9119272018406, 3526.3123690880034, 3532.8233588320995, 3534.0988048047584, 632.5666918161074, 633.6736580660963, 649.4901502320656, 662.1656712542232, 663.5554178700282, 650.0, 724.4892350892608, 730.8574827908614, 743.8252010777463, 757.8332766791297, 9616.0, 9658.951705241428, 9664.323497355117, 10054.64808731691, 10160.441175735257, 622.7851391270004, 677.4580335731494, 682.276786606199, 704.1655638068904, 715.7280233511233, 4986.376702912136, 5002.849914502571, 5044.596432285409, 5067.239914012854, 5075.111855425286, 87772.56113719518, 108202.45898770614, 126004.0, 128776.35611822069, 129797.0, 105849.47075264728, 106002.0, 106194.46902765437, 107175.46412267888, 107369.0, 80031.59984200042, 81308.18691813125, 95572.52213739026, 95626.52186739161, 97431.4897359544, 9932.324840764159, 10455.372677639367, 10646.73383165427, 10804.567817287221, 10817.45912704346, 50773.49226507688, 53230.73384633052, 53817.0, 54566.72716636391, 54823.45176548343, 72950.63524682343, 74528.62735686287, 80672.0, 81156.59421702854, 83291.58354208432, 12679.175853569488, 12878.227306361649, 12959.870401295866, 13008.869911300766, 13285.601431957057, 15290.847091528942, 15319.540413787605, 16299.103549304902, 16497.752533711762, 16598.75101873449, 14552.563423097325, 14766.557003289918, 14908.85091149118, 15085.47200847965, 15543.689126217638, 14197.025651262684, 14892.925535372688, 15019.924900375428, 15367.846321536641, 15536.456224032105, 14622.634434139232, 14678.268834440494, 14739.92630036843, 14890.553283401516, 15180.0, 11326.377064111248, 11469.598564050551, 11574.768504630028, 11791.233569817934, 11909.880901191224, 10905.83641245366, 11277.661670149908, 11406.714832129263, 11687.76624467523, 12044.156909016285], "value": 7878.576850663014, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 105.0, 111.0, 111.0, 112.0, 114.0, 111.0, 112.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 120.0, 146.0, 180.0, 121.0, 153.0, 147.0, 121.0, 174.0, 124.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 164.0, 175.0, 161.0, 161.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 152.0, 77.0, 75.0, 75.0, 75.0, 171.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 142.0, 83.0, 83.0, 83.0, 142.0, 83.0, 83.0, 148.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 148.0, 148.0, 147.0, 145.0, 147.0, 155.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 100.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 55.0, 53.0, 54.0, 52.0, 54.0, 52.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 63.0, 66.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 85.0, 81.0, 76.0, 76.0, 75.0, 81.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 119.0, 130.0, 121.0, 124.0, 122.0, 129.0, 128.0, 168.0, 123.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 159.0, 157.0, 179.0, 158.0, 162.0, 160.0, 157.0, 156.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 67.0, 64.0, 63.0, 66.0, 70.0, 64.0, 63.0], "value": 64.8, "unit": "score"}]}]} 04:34:45 INFO - Return code: 0 04:34:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:45 ERROR - # TBPL SUCCESS # 04:34:45 INFO - Running post-action listener: _resource_record_post_action 04:34:45 INFO - ##### 04:34:45 INFO - ##### Finished run-tests step (success) 04:34:45 INFO - ##### 04:34:45 INFO - Running post-run listener: _resource_record_post_run 04:34:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556326912; Read time: 12; Write time: 527748 04:34:45 INFO - TinderboxPrint: CPU usage
13.3% 04:34:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:34:45 INFO - TinderboxPrint: I/O write bytes / time
556,326,912 / 527,748 04:34:45 INFO - TinderboxPrint: CPU idle
8,228.9 (86.7%) 04:34:45 INFO - TinderboxPrint: CPU user
1,211.6 (12.8%) 04:34:45 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:45 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256843776; Read time: 0; Write time: 285004 04:34:45 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 299483136; Read time: 0; Write time: 242744 04:34:45 INFO - Running post-run listener: _upload_blobber_files 04:34:45 INFO - Blob upload gear active. 04:34:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:45 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 04:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:46 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:50 INFO - (blobuploader) - INFO - Done attempting. 04:34:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:34:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:51 INFO - (blobuploader) - INFO - Done attempting. 04:34:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:34:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:51 INFO - (blobuploader) - INFO - Done attempting. 04:34:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:51 INFO - Return code: 0 04:34:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a41e5b710dedc2776b3af64241bce43247d354776f5809db596054ae371c1218847d149fe40d5a6db3afc36fbf60529c6033ce0456a7c5d59f975d011dd032c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17d8de9e2ac54039bf8ccc3332c83f7f065f622175588a436ea23dd44d07c97b2a925e787717c801624ff9398d8c2ee92d02e71327a5c3702e6af2bba43dacf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ac183e1410a8bf8190cb23ef44b68715968b775230f2b7f51a26553bbcc02367e54a0ca67539b8e7d3bfdf5080a77f430dd656cdc5dccbf034a88bcf60e37be"} 04:34:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:51 INFO - Contents: 04:34:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a41e5b710dedc2776b3af64241bce43247d354776f5809db596054ae371c1218847d149fe40d5a6db3afc36fbf60529c6033ce0456a7c5d59f975d011dd032c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17d8de9e2ac54039bf8ccc3332c83f7f065f622175588a436ea23dd44d07c97b2a925e787717c801624ff9398d8c2ee92d02e71327a5c3702e6af2bba43dacf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ac183e1410a8bf8190cb23ef44b68715968b775230f2b7f51a26553bbcc02367e54a0ca67539b8e7d3bfdf5080a77f430dd656cdc5dccbf034a88bcf60e37be"} 04:34:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:51 INFO - Copying logs to upload dir... 04:34:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.040065 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-16 04:34:51.274611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:34:51.278315) ========= 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=32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a41e5b710dedc2776b3af64241bce43247d354776f5809db596054ae371c1218847d149fe40d5a6db3afc36fbf60529c6033ce0456a7c5d59f975d011dd032c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17d8de9e2ac54039bf8ccc3332c83f7f065f622175588a436ea23dd44d07c97b2a925e787717c801624ff9398d8c2ee92d02e71327a5c3702e6af2bba43dacf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ac183e1410a8bf8190cb23ef44b68715968b775230f2b7f51a26553bbcc02367e54a0ca67539b8e7d3bfdf5080a77f430dd656cdc5dccbf034a88bcf60e37be"} build_url:https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/S8S5EdfJS9CVdie44df4Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a41e5b710dedc2776b3af64241bce43247d354776f5809db596054ae371c1218847d149fe40d5a6db3afc36fbf60529c6033ce0456a7c5d59f975d011dd032c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17d8de9e2ac54039bf8ccc3332c83f7f065f622175588a436ea23dd44d07c97b2a925e787717c801624ff9398d8c2ee92d02e71327a5c3702e6af2bba43dacf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ac183e1410a8bf8190cb23ef44b68715968b775230f2b7f51a26553bbcc02367e54a0ca67539b8e7d3bfdf5080a77f430dd656cdc5dccbf034a88bcf60e37be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:34:51.303945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:34:51.304267) ========= 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=32c5991c409366f7fec8a718000001d2-1468667130.207394-1054635010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:34:51.389232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:34:51.389535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:34:51.389820) ========= ========= Total master_lag: 0.18 =========