builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1471348830.41 results: success (0) buildid: 20160816015422 builduid: 41fd77f97f8f46278de029989f34daca revision: 1a4509a3e2ce583753eda01ba911b34631bf207e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.413343) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.413766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.414037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.518088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.518486) ========= 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=826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 05:00:30-- 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% 43.2M=0s 2016-08-16 05:00:30 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.688833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.689185) ========= 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=826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.107730 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.809948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:30.810303) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1a4509a3e2ce583753eda01ba911b34631bf207e --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 1a4509a3e2ce583753eda01ba911b34631bf207e --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=826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 05:00:31,110 truncating revision to first 12 chars 2016-08-16 05:00:31,110 Setting DEBUG logging. 2016-08-16 05:00:31,110 attempt 1/10 2016-08-16 05:00:31,110 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1a4509a3e2ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 05:00:31,456 unpacking tar archive at: mozilla-inbound-1a4509a3e2ce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:31.510513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:31.510814) ========= script_repo_revision: 1a4509a3e2ce583753eda01ba911b34631bf207e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:31.511286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:31.511546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:00:31.529682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-16 05:00:31.530276) ========= /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=826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:00:31 INFO - MultiFileLogger online at 20160816 05:00:31 in /builds/slave/test 05:00:31 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 05:00:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:00:31 INFO - {'append_to_log': False, 05:00:31 INFO - 'base_work_dir': '/builds/slave/test', 05:00:31 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:00:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:00:31 INFO - 'branch': 'Mozilla-Inbound', 05:00:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:31 INFO - 'config_files': ('talos/linux_config.py',), 05:00:31 INFO - 'default_actions': ('clobber', 05:00:31 INFO - 'read-buildbot-config', 05:00:31 INFO - 'download-and-extract', 05:00:31 INFO - 'populate-webroot', 05:00:31 INFO - 'create-virtualenv', 05:00:31 INFO - 'install', 05:00:31 INFO - 'run-tests'), 05:00:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:31 INFO - 'download_minidump_stackwalk': True, 05:00:31 INFO - 'download_symbols': 'ondemand', 05:00:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:31 INFO - 'installer_path': 'installer.exe', 05:00:31 INFO - 'log_level': 'info', 05:00:31 INFO - 'log_name': 'talos', 05:00:31 INFO - 'log_to_console': True, 05:00:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:00:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:00:31 INFO - 'opt_config_files': (), 05:00:31 INFO - 'pip_index': False, 05:00:31 INFO - 'sps_profile': False, 05:00:31 INFO - 'sps_profile_interval': 0, 05:00:31 INFO - 'suite': 'dromaeojs-e10s', 05:00:31 INFO - 'system_bits': '32', 05:00:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:31 INFO - 'title': 'talos-linux64-ix-052', 05:00:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:31 INFO - 'use_talos_json': True, 05:00:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:00:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:31 INFO - 'work_dir': 'build'} 05:00:31 INFO - [mozharness: 2016-08-16 12:00:31.996903Z] Running clobber step. 05:00:31 INFO - Running pre-action listener: _resource_record_pre_action 05:00:31 INFO - Running main action method: clobber 05:00:31 INFO - rmtree: /builds/slave/test/build 05:00:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:00:34 INFO - Running post-action listener: _resource_record_post_action 05:00:34 INFO - [mozharness: 2016-08-16 12:00:34.011807Z] Finished clobber step (success) 05:00:34 INFO - [mozharness: 2016-08-16 12:00:34.011933Z] Running read-buildbot-config step. 05:00:34 INFO - Running pre-action listener: _resource_record_pre_action 05:00:34 INFO - Running main action method: read_buildbot_config 05:00:34 INFO - Using buildbot properties: 05:00:34 INFO - { 05:00:34 INFO - "project": "", 05:00:34 INFO - "product": "firefox", 05:00:34 INFO - "script_repo_revision": "production", 05:00:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 05:00:34 INFO - "repository": "", 05:00:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 05:00:34 INFO - "buildid": "20160816015422", 05:00:34 INFO - "pgo_build": "True", 05:00:34 INFO - "basedir": "/builds/slave/test", 05:00:34 INFO - "buildnumber": 1204, 05:00:34 INFO - "slavename": "talos-linux64-ix-052", 05:00:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:00:34 INFO - "platform": "ubuntu64_hw", 05:00:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 05:00:34 INFO - "branch": "mozilla-inbound", 05:00:34 INFO - "repo_path": "integration/mozilla-inbound", 05:00:34 INFO - "revision": "1a4509a3e2ce583753eda01ba911b34631bf207e", 05:00:34 INFO - "stage_platform": "linux64-pgo", 05:00:34 INFO - "builduid": "41fd77f97f8f46278de029989f34daca", 05:00:34 INFO - "slavebuilddir": "test" 05:00:34 INFO - } 05:00:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:00:34 INFO - Running post-action listener: _resource_record_post_action 05:00:34 INFO - [mozharness: 2016-08-16 12:00:34.015069Z] Finished read-buildbot-config step (success) 05:00:34 INFO - [mozharness: 2016-08-16 12:00:34.015185Z] Running download-and-extract step. 05:00:34 INFO - Running pre-action listener: _resource_record_pre_action 05:00:34 INFO - Running main action method: download_and_extract 05:00:34 INFO - mkdir: /builds/slave/test/build/tests 05:00:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:34 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:00:34 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:00:34 INFO - Downloaded 1361 bytes. 05:00:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:00:34 INFO - Using the following test package requirements: 05:00:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:00:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:00:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'jsshell-linux-x86_64.zip'], 05:00:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:00:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:00:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:00:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:00:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:00:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:00:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:34 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:00:34 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:00:35 INFO - Downloaded 21833862 bytes. 05:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:00:36 INFO - Return code: 0 05:00:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:36 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:00:36 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:00:37 INFO - Downloaded 21833862 bytes. 05:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:00:38 INFO - Return code: 0 05:00:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:38 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:38 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:00:39 INFO - Downloaded 14413719 bytes. 05:00:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:00:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:00:39 INFO - Return code: 0 05:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:39 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:00:39 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:00:41 INFO - Downloaded 59343017 bytes. 05:00:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:00:41 INFO - mkdir: /builds/slave/test/properties 05:00:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:00:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:00:41 INFO - Contents: 05:00:41 INFO - build_url:https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:00:41 INFO - Running post-action listener: _resource_record_post_action 05:00:41 INFO - Running post-action listener: set_extra_try_arguments 05:00:41 INFO - [mozharness: 2016-08-16 12:00:41.823720Z] Finished download-and-extract step (success) 05:00:41 INFO - [mozharness: 2016-08-16 12:00:41.823952Z] Running populate-webroot step. 05:00:41 INFO - Running pre-action listener: _resource_record_pre_action 05:00:41 INFO - Running main action method: populate_webroot 05:00:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:41 INFO - '--tppagecycles', 05:00:41 INFO - '7'], 05:00:41 INFO - 'tests': ['tsvgm']}}, 05:00:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:00:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:00:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['damp', 'tps']}, 05:00:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'tests': ['damp', 'tps']}, 05:00:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['dromaeo_dom']}, 05:00:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['basic_compositor_video']}, 05:00:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:00:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['a11yr', 05:00:41 INFO - 'ts_paint', 05:00:41 INFO - 'tpaint', 05:00:41 INFO - 'sessionrestore', 05:00:41 INFO - 'sessionrestore_no_auto_restore', 05:00:41 INFO - 'tabpaint']}, 05:00:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:00:41 INFO - 'ts_paint', 05:00:41 INFO - 'tpaint', 05:00:41 INFO - 'sessionrestore', 05:00:41 INFO - 'sessionrestore_no_auto_restore', 05:00:41 INFO - 'tabpaint']}, 05:00:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:00:41 INFO - 'ts_paint', 05:00:41 INFO - 'tpaint', 05:00:41 INFO - 'sessionrestore', 05:00:41 INFO - 'sessionrestore_no_auto_restore', 05:00:41 INFO - 'tabpaint']}, 05:00:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:00:41 INFO - 'ts_paint', 05:00:41 INFO - 'tpaint', 05:00:41 INFO - 'sessionrestore', 05:00:41 INFO - 'sessionrestore_no_auto_restore', 05:00:41 INFO - 'tabpaint']}, 05:00:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['a11yr', 05:00:41 INFO - 'ts_paint', 05:00:41 INFO - 'tpaint', 05:00:41 INFO - 'sessionrestore', 05:00:41 INFO - 'sessionrestore_no_auto_restore', 05:00:41 INFO - 'tabpaint']}, 05:00:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['a11yr', 05:00:41 INFO - 'ts_paint', 05:00:41 INFO - 'tpaint', 05:00:41 INFO - 'sessionrestore', 05:00:41 INFO - 'sessionrestore_no_auto_restore', 05:00:41 INFO - 'tabpaint']}, 05:00:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['tsvgx', 05:00:41 INFO - 'tsvgr_opacity', 05:00:41 INFO - 'tart', 05:00:41 INFO - 'tscrollx', 05:00:41 INFO - 'cart']}, 05:00:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:00:41 INFO - 'tsvgr_opacity', 05:00:41 INFO - 'tart', 05:00:41 INFO - 'tscrollx', 05:00:41 INFO - 'cart']}, 05:00:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'talos_options': ['--disable-e10s'], 05:00:41 INFO - 'tests': ['tp5o']}, 05:00:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'tests': ['tp5o']}, 05:00:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'talos_options': ['--disable-e10s', 05:00:41 INFO - '--xperf_path', 05:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:41 INFO - 'tests': ['tp5n']}, 05:00:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:41 INFO - 'talos_options': ['--xperf_path', 05:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:41 INFO - 'tests': ['tp5n']}}, 05:00:41 INFO - 'talos.zip': {'path': '', 05:00:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:41 INFO - Running post-action listener: _resource_record_post_action 05:00:41 INFO - [mozharness: 2016-08-16 12:00:41.845809Z] Finished populate-webroot step (success) 05:00:41 INFO - [mozharness: 2016-08-16 12:00:41.845897Z] Running create-virtualenv step. 05:00:41 INFO - Running pre-action listener: _resource_record_pre_action 05:00:41 INFO - Running main action method: create_virtualenv 05:00:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:00:41 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 05:00:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:00:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:42 INFO - Using real prefix '/usr' 05:00:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:00:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:45 INFO - Installing pip.................done. 05:00:45 INFO - Return code: 0 05:00:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:00:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:45 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 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:00:45 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 05:00:45 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 05:00:45 INFO - Using env: {'DISPLAY': ':0', 05:00:45 INFO - 'HOME': '/home/cltbld', 05:00:45 INFO - 'LANG': 'en_US.UTF-8', 05:00:45 INFO - 'LANGUAGE': 'en_US:en', 05:00:45 INFO - 'LOGNAME': 'cltbld', 05:00:45 INFO - 'MAIL': '/var/mail/cltbld', 05:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:45 INFO - 'MOZ_NO_REMOTE': '1', 05:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:45 INFO - 'NO_EM_RESTART': '1', 05:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:45 INFO - 'PWD': '/builds/slave/test', 05:00:45 INFO - 'SHELL': '/bin/bash', 05:00:45 INFO - 'SHLVL': '1', 05:00:45 INFO - 'TERM': 'linux', 05:00:45 INFO - 'TMOUT': '86400', 05:00:45 INFO - 'USER': 'cltbld', 05:00:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:45 INFO - '_': '/tools/buildbot/bin/python'} 05:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:47 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 05:00:47 INFO - Cleaning up... 05:00:47 INFO - Return code: 0 05:00:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:00:47 INFO - Using env: {'DISPLAY': ':0', 05:00:47 INFO - 'HOME': '/home/cltbld', 05:00:47 INFO - 'LANG': 'en_US.UTF-8', 05:00:47 INFO - 'LANGUAGE': 'en_US:en', 05:00:47 INFO - 'LOGNAME': 'cltbld', 05:00:47 INFO - 'MAIL': '/var/mail/cltbld', 05:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:47 INFO - 'MOZ_NO_REMOTE': '1', 05:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:47 INFO - 'NO_EM_RESTART': '1', 05:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:47 INFO - 'PWD': '/builds/slave/test', 05:00:47 INFO - 'SHELL': '/bin/bash', 05:00:47 INFO - 'SHLVL': '1', 05:00:47 INFO - 'TERM': 'linux', 05:00:47 INFO - 'TMOUT': '86400', 05:00:47 INFO - 'USER': 'cltbld', 05:00:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:47 INFO - '_': '/tools/buildbot/bin/python'} 05:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:47 INFO - Downloading/unpacking psutil>=3.1.1 05:00:47 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 05:00:47 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 05:00:47 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 05:00:47 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 05:00:47 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 05:00:47 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 05:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:49 INFO - Installing collected packages: psutil 05:00:49 INFO - Running setup.py install for psutil 05:00:49 INFO - building 'psutil._psutil_linux' extension 05:00:49 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 05:00:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:00:51 INFO - building 'psutil._psutil_posix' extension 05:00:51 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 05:00:51 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 05:00:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:51 INFO - Successfully installed psutil 05:00:51 INFO - Cleaning up... 05:00:51 INFO - Return code: 0 05:00:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:00:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:51 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 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:00:51 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 05:00:51 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 05:00:51 INFO - Using env: {'DISPLAY': ':0', 05:00:51 INFO - 'HOME': '/home/cltbld', 05:00:51 INFO - 'LANG': 'en_US.UTF-8', 05:00:51 INFO - 'LANGUAGE': 'en_US:en', 05:00:51 INFO - 'LOGNAME': 'cltbld', 05:00:51 INFO - 'MAIL': '/var/mail/cltbld', 05:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:51 INFO - 'MOZ_NO_REMOTE': '1', 05:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:51 INFO - 'NO_EM_RESTART': '1', 05:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:51 INFO - 'PWD': '/builds/slave/test', 05:00:51 INFO - 'SHELL': '/bin/bash', 05:00:51 INFO - 'SHLVL': '1', 05:00:51 INFO - 'TERM': 'linux', 05:00:51 INFO - 'TMOUT': '86400', 05:00:51 INFO - 'USER': 'cltbld', 05:00:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:51 INFO - '_': '/tools/buildbot/bin/python'} 05:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:00:53 INFO - Installing collected packages: mozsystemmonitor 05:00:53 INFO - Running setup.py install for mozsystemmonitor 05:00:53 INFO - Successfully installed mozsystemmonitor 05:00:53 INFO - Cleaning up... 05:00:53 INFO - Return code: 0 05:00:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:00:53 INFO - Using env: {'DISPLAY': ':0', 05:00:53 INFO - 'HOME': '/home/cltbld', 05:00:53 INFO - 'LANG': 'en_US.UTF-8', 05:00:53 INFO - 'LANGUAGE': 'en_US:en', 05:00:53 INFO - 'LOGNAME': 'cltbld', 05:00:53 INFO - 'MAIL': '/var/mail/cltbld', 05:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:53 INFO - 'MOZ_NO_REMOTE': '1', 05:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:53 INFO - 'NO_EM_RESTART': '1', 05:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:53 INFO - 'PWD': '/builds/slave/test', 05:00:53 INFO - 'SHELL': '/bin/bash', 05:00:53 INFO - 'SHLVL': '1', 05:00:53 INFO - 'TERM': 'linux', 05:00:53 INFO - 'TMOUT': '86400', 05:00:53 INFO - 'USER': 'cltbld', 05:00:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:53 INFO - '_': '/tools/buildbot/bin/python'} 05:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:53 INFO - Downloading/unpacking jsonschema==2.5.1 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:55 INFO - warning: no files found matching '*.txt' 05:00:55 INFO - no previously-included directories found matching 'build' 05:00:55 INFO - no previously-included directories found matching 'dist' 05:00:55 INFO - no previously-included directories found matching '.git*' 05:00:55 INFO - Installing collected packages: jsonschema, functools32 05:00:56 INFO - Running setup.py install for functools32 05:00:56 INFO - warning: no files found matching '*.txt' 05:00:56 INFO - no previously-included directories found matching 'build' 05:00:56 INFO - no previously-included directories found matching 'dist' 05:00:56 INFO - no previously-included directories found matching '.git*' 05:00:56 INFO - Successfully installed jsonschema functools32 05:00:56 INFO - Cleaning up... 05:00:56 INFO - Return code: 0 05:00:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:00:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:00:56 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:00:56 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 functools32==3.2.3-2 05:00:56 INFO - Using env: {'DISPLAY': ':0', 05:00:56 INFO - 'HOME': '/home/cltbld', 05:00:56 INFO - 'LANG': 'en_US.UTF-8', 05:00:56 INFO - 'LANGUAGE': 'en_US:en', 05:00:56 INFO - 'LOGNAME': 'cltbld', 05:00:56 INFO - 'MAIL': '/var/mail/cltbld', 05:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:56 INFO - 'MOZ_NO_REMOTE': '1', 05:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:56 INFO - 'NO_EM_RESTART': '1', 05:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:56 INFO - 'PWD': '/builds/slave/test', 05:00:56 INFO - 'SHELL': '/bin/bash', 05:00:56 INFO - 'SHLVL': '1', 05:00:56 INFO - 'TERM': 'linux', 05:00:56 INFO - 'TMOUT': '86400', 05:00:56 INFO - 'USER': 'cltbld', 05:00:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:56 INFO - '_': '/tools/buildbot/bin/python'} 05:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:00:56 INFO - Cleaning up... 05:00:56 INFO - Return code: 0 05:00:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:00:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 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 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:00:56 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 05:00:56 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 05:00:56 INFO - Using env: {'DISPLAY': ':0', 05:00:56 INFO - 'HOME': '/home/cltbld', 05:00:56 INFO - 'LANG': 'en_US.UTF-8', 05:00:56 INFO - 'LANGUAGE': 'en_US:en', 05:00:56 INFO - 'LOGNAME': 'cltbld', 05:00:56 INFO - 'MAIL': '/var/mail/cltbld', 05:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:56 INFO - 'MOZ_NO_REMOTE': '1', 05:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:56 INFO - 'NO_EM_RESTART': '1', 05:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:56 INFO - 'PWD': '/builds/slave/test', 05:00:56 INFO - 'SHELL': '/bin/bash', 05:00:56 INFO - 'SHLVL': '1', 05:00:56 INFO - 'TERM': 'linux', 05:00:56 INFO - 'TMOUT': '86400', 05:00:56 INFO - 'USER': 'cltbld', 05:00:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:56 INFO - '_': '/tools/buildbot/bin/python'} 05:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:00:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:59 INFO - Downloading docopt-0.6.1.tar.gz 05:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:59 INFO - Running setup.py install for blobuploader 05:00:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:00:59 INFO - Running setup.py install for requests 05:00:59 INFO - Running setup.py install for docopt 05:00:59 INFO - Successfully installed blobuploader requests docopt 05:00:59 INFO - Cleaning up... 05:00:59 INFO - Return code: 0 05:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:59 INFO - Using env: {'DISPLAY': ':0', 05:00:59 INFO - 'HOME': '/home/cltbld', 05:00:59 INFO - 'LANG': 'en_US.UTF-8', 05:00:59 INFO - 'LANGUAGE': 'en_US:en', 05:00:59 INFO - 'LOGNAME': 'cltbld', 05:00:59 INFO - 'MAIL': '/var/mail/cltbld', 05:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:59 INFO - 'MOZ_NO_REMOTE': '1', 05:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:59 INFO - 'NO_EM_RESTART': '1', 05:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:59 INFO - 'PWD': '/builds/slave/test', 05:00:59 INFO - 'SHELL': '/bin/bash', 05:00:59 INFO - 'SHLVL': '1', 05:00:59 INFO - 'TERM': 'linux', 05:00:59 INFO - 'TMOUT': '86400', 05:00:59 INFO - 'USER': 'cltbld', 05:00:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:59 INFO - '_': '/tools/buildbot/bin/python'} 05:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:00 INFO - Running setup.py (path:/tmp/pip-gO8pIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:00 INFO - Running setup.py (path:/tmp/pip-ZhzOBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:00 INFO - Running setup.py (path:/tmp/pip-P4DNSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:00 INFO - Running setup.py (path:/tmp/pip-42N4q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:00 INFO - Running setup.py (path:/tmp/pip-UOp1Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:00 INFO - Running setup.py (path:/tmp/pip-5haxb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:00 INFO - Running setup.py (path:/tmp/pip-guZqsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:00 INFO - Running setup.py (path:/tmp/pip-7H2lvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:00 INFO - Running setup.py (path:/tmp/pip-6ZisTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:00 INFO - Running setup.py (path:/tmp/pip-0Op2qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:00 INFO - Running setup.py (path:/tmp/pip-8yUTLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:00 INFO - Running setup.py (path:/tmp/pip-6Ev3uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:00 INFO - Running setup.py (path:/tmp/pip-zl1cSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:01 INFO - Running setup.py (path:/tmp/pip-Q3EFLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:01 INFO - Running setup.py (path:/tmp/pip-GcPZSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:01 INFO - Running setup.py (path:/tmp/pip-nSQw1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:01 INFO - Running setup.py (path:/tmp/pip-1nDxpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:01 INFO - Running setup.py install for manifestparser 05:01:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:01:01 INFO - Running setup.py install for mozcrash 05:01:01 INFO - Running setup.py install for mozdebug 05:01:01 INFO - Running setup.py install for mozdevice 05:01:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:01:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:01:01 INFO - Running setup.py install for mozfile 05:01:01 INFO - Running setup.py install for mozhttpd 05:01:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:01:01 INFO - Running setup.py install for mozinfo 05:01:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Running setup.py install for mozInstall 05:01:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Running setup.py install for mozleak 05:01:02 INFO - Running setup.py install for mozlog 05:01:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Running setup.py install for moznetwork 05:01:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Running setup.py install for mozprocess 05:01:02 INFO - Running setup.py install for mozprofile 05:01:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Running setup.py install for mozrunner 05:01:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:01:02 INFO - Running setup.py install for mozscreenshot 05:01:02 INFO - Running setup.py install for moztest 05:01:02 INFO - Running setup.py install for mozversion 05:01:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:01:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:03 INFO - Cleaning up... 05:01:03 INFO - Return code: 0 05:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:03 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 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:01:03 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 05:01:03 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 05:01:03 INFO - Using env: {'DISPLAY': ':0', 05:01:03 INFO - 'HOME': '/home/cltbld', 05:01:03 INFO - 'LANG': 'en_US.UTF-8', 05:01:03 INFO - 'LANGUAGE': 'en_US:en', 05:01:03 INFO - 'LOGNAME': 'cltbld', 05:01:03 INFO - 'MAIL': '/var/mail/cltbld', 05:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:03 INFO - 'MOZ_NO_REMOTE': '1', 05:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:03 INFO - 'NO_EM_RESTART': '1', 05:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:03 INFO - 'PWD': '/builds/slave/test', 05:01:03 INFO - 'SHELL': '/bin/bash', 05:01:03 INFO - 'SHLVL': '1', 05:01:03 INFO - 'TERM': 'linux', 05:01:03 INFO - 'TMOUT': '86400', 05:01:03 INFO - 'USER': 'cltbld', 05:01:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:03 INFO - '_': '/tools/buildbot/bin/python'} 05:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:03 INFO - Running setup.py (path:/tmp/pip-sYxf0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:03 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)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:03 INFO - Running setup.py (path:/tmp/pip-1XSfij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:03 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)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:03 INFO - Running setup.py (path:/tmp/pip-n1uKXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:03 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)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:03 INFO - Running setup.py (path:/tmp/pip-Esrvxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:03 INFO - Running setup.py (path:/tmp/pip-hBIf7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:03 INFO - Running setup.py (path:/tmp/pip-n5snFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:03 INFO - Running setup.py (path:/tmp/pip-ElBJ7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:03 INFO - Running setup.py (path:/tmp/pip-d0oUNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:03 INFO - Running setup.py (path:/tmp/pip-WsTT59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:03 INFO - Running setup.py (path:/tmp/pip-nCb49L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:04 INFO - Running setup.py (path:/tmp/pip-Y0PXWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:04 INFO - Running setup.py (path:/tmp/pip-mp7jWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:04 INFO - Running setup.py (path:/tmp/pip-i3cFdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:04 INFO - Running setup.py (path:/tmp/pip-bcX9Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:04 INFO - Running setup.py (path:/tmp/pip-CRNhSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:04 INFO - Running setup.py (path:/tmp/pip-in3vkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:04 INFO - Running setup.py (path:/tmp/pip-nBvsY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:04 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)) 05:01:04 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)) 05:01:04 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)) 05:01:04 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)) 05:01:04 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)) 05:01:04 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)) 05:01:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:04 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 05:01:04 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 05:01:04 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 05:01:04 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 05:01:04 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 05:01:04 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 05:01:06 INFO - Downloading blessings-1.6.tar.gz 05:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:06 INFO - Installing collected packages: blessings 05:01:06 INFO - Running setup.py install for blessings 05:01:06 INFO - Successfully installed blessings 05:01:06 INFO - Cleaning up... 05:01:06 INFO - Return code: 0 05:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:06 INFO - Reading from file tmpfile_stdout 05:01:06 INFO - Current package versions: 05:01:06 INFO - argparse == 1.2.1 05:01:06 INFO - blessings == 1.6 05:01:06 INFO - blobuploader == 1.2.4 05:01:06 INFO - docopt == 0.6.1 05:01:06 INFO - functools32 == 3.2.3-2 05:01:06 INFO - jsonschema == 2.5.1 05:01:06 INFO - manifestparser == 1.1 05:01:06 INFO - mozInstall == 1.12 05:01:06 INFO - mozcrash == 0.17 05:01:06 INFO - mozdebug == 0.1 05:01:06 INFO - mozdevice == 0.48 05:01:06 INFO - mozfile == 1.2 05:01:06 INFO - mozhttpd == 0.7 05:01:06 INFO - mozinfo == 0.9 05:01:06 INFO - mozleak == 0.1 05:01:06 INFO - mozlog == 3.3 05:01:06 INFO - moznetwork == 0.27 05:01:06 INFO - mozprocess == 0.23 05:01:06 INFO - mozprofile == 0.28 05:01:06 INFO - mozrunner == 6.12 05:01:06 INFO - mozscreenshot == 0.1 05:01:06 INFO - mozsystemmonitor == 0.3 05:01:06 INFO - moztest == 0.7 05:01:06 INFO - mozversion == 1.4 05:01:06 INFO - psutil == 3.1.1 05:01:06 INFO - requests == 1.2.3 05:01:06 INFO - wsgiref == 0.1.2 05:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:06 INFO - Using env: {'DISPLAY': ':0', 05:01:06 INFO - 'HOME': '/home/cltbld', 05:01:06 INFO - 'LANG': 'en_US.UTF-8', 05:01:06 INFO - 'LANGUAGE': 'en_US:en', 05:01:06 INFO - 'LOGNAME': 'cltbld', 05:01:06 INFO - 'MAIL': '/var/mail/cltbld', 05:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:06 INFO - 'MOZ_NO_REMOTE': '1', 05:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:06 INFO - 'NO_EM_RESTART': '1', 05:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:06 INFO - 'PWD': '/builds/slave/test', 05:01:06 INFO - 'SHELL': '/bin/bash', 05:01:06 INFO - 'SHLVL': '1', 05:01:06 INFO - 'TERM': 'linux', 05:01:06 INFO - 'TMOUT': '86400', 05:01:06 INFO - 'USER': 'cltbld', 05:01:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:06 INFO - '_': '/tools/buildbot/bin/python'} 05:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 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)) 05:01:07 INFO - Cleaning up... 05:01:07 INFO - Return code: 0 05:01:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:01:07 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:07 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:07 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 0x1a52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, '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': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', '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 05:01:07 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 05:01:07 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 05:01:07 INFO - Using env: {'DISPLAY': ':0', 05:01:07 INFO - 'HOME': '/home/cltbld', 05:01:07 INFO - 'LANG': 'en_US.UTF-8', 05:01:07 INFO - 'LANGUAGE': 'en_US:en', 05:01:07 INFO - 'LOGNAME': 'cltbld', 05:01:07 INFO - 'MAIL': '/var/mail/cltbld', 05:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:07 INFO - 'MOZ_NO_REMOTE': '1', 05:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:07 INFO - 'NO_EM_RESTART': '1', 05:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:07 INFO - 'PWD': '/builds/slave/test', 05:01:07 INFO - 'SHELL': '/bin/bash', 05:01:07 INFO - 'SHLVL': '1', 05:01:07 INFO - 'TERM': 'linux', 05:01:07 INFO - 'TMOUT': '86400', 05:01:07 INFO - 'USER': 'cltbld', 05:01:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:07 INFO - '_': '/tools/buildbot/bin/python'} 05:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:01:07 INFO - Cleaning up... 05:01:07 INFO - Return code: 0 05:01:07 INFO - Running post-action listener: _resource_record_post_action 05:01:07 INFO - Running post-action listener: _start_resource_monitoring 05:01:07 INFO - Starting resource monitoring. 05:01:07 INFO - [mozharness: 2016-08-16 12:01:07.584957Z] Finished create-virtualenv step (success) 05:01:07 INFO - [mozharness: 2016-08-16 12:01:07.585989Z] Running install step. 05:01:07 INFO - Running pre-action listener: _resource_record_pre_action 05:01:07 INFO - Running main action method: install 05:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:07 INFO - Reading from file tmpfile_stdout 05:01:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:01:07 INFO - Reading from file tmpfile_stdout 05:01:07 INFO - Output received: 05:01:07 INFO - Usage: mozinstall [options] installer 05:01:07 INFO - Options: 05:01:07 INFO - -h, --help show this help message and exit 05:01:07 INFO - -d DEST, --destination=DEST 05:01:07 INFO - Directory to install application into. [default: 05:01:07 INFO - "/builds/slave/test"] 05:01:07 INFO - --app=APP Application being installed. [default: firefox] 05:01:07 INFO - mkdir: /builds/slave/test/build/application 05:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:01:24 INFO - Reading from file tmpfile_stdout 05:01:24 INFO - Output received: 05:01:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:01:24 INFO - Running post-action listener: _resource_record_post_action 05:01:24 INFO - [mozharness: 2016-08-16 12:01:24.755893Z] Finished install step (success) 05:01:24 INFO - [mozharness: 2016-08-16 12:01:24.756140Z] Running run-tests step. 05:01:24 INFO - Running pre-action listener: _resource_record_pre_action 05:01:24 INFO - Running main action method: run_tests 05:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:01:24 INFO - Python 2.7.3 05:01:24 INFO - Return code: 0 05:01:24 INFO - grabbing minidump binary from tooltool 05:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d10570>, '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 0x1d11470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d11900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:01:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:01:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:01:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:01:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:24 INFO - Return code: 0 05:01:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:01:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:01:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:01:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:01:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 05:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 05:01:24 INFO - Using env: {'DISPLAY': ':0', 05:01:24 INFO - 'HOME': '/home/cltbld', 05:01:24 INFO - 'LANG': 'en_US.UTF-8', 05:01:24 INFO - 'LANGUAGE': 'en_US:en', 05:01:24 INFO - 'LOGNAME': 'cltbld', 05:01:24 INFO - 'MAIL': '/var/mail/cltbld', 05:01:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:01:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:24 INFO - 'MOZ_NO_REMOTE': '1', 05:01:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:24 INFO - 'NO_EM_RESTART': '1', 05:01:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:24 INFO - 'PWD': '/builds/slave/test', 05:01:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:01:24 INFO - 'SHELL': '/bin/bash', 05:01:24 INFO - 'SHLVL': '1', 05:01:24 INFO - 'TERM': 'linux', 05:01:24 INFO - 'TMOUT': '86400', 05:01:24 INFO - 'USER': 'cltbld', 05:01:24 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999', 05:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:24 INFO - '_': '/tools/buildbot/bin/python'} 05:01:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 05:01:25 INFO - mozversion application_buildid: 20160816015422 05:01:25 INFO - mozversion application_changeset: 1a4509a3e2ce583753eda01ba911b34631bf207e 05:01:25 INFO - mozversion application_display_name: Nightly 05:01:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:25 INFO - mozversion application_name: Firefox 05:01:25 INFO - mozversion application_remotingname: firefox 05:01:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:01:25 INFO - mozversion application_vendor: Mozilla 05:01:25 INFO - mozversion application_version: 51.0a1 05:01:25 INFO - mozversion platform_buildid: 20160816015422 05:01:25 INFO - mozversion platform_changeset: 1a4509a3e2ce583753eda01ba911b34631bf207e 05:01:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:01:25 INFO - mozversion platform_version: 51.0a1 05:01:25 INFO - using testdate: 1471348885 05:01:25 INFO - actual date: 1471348885 05:01:25 INFO - starting webserver on 'localhost:41418' 05:01:25 INFO - SUITE-START | Running 2 tests 05:01:25 INFO - TEST-START | dromaeo_css 05:01:25 INFO - operating with platform_type : linux_ 05:01:25 INFO - Initialising browser for dromaeo_css test... 05:01:25 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpraUQXY/profile http://localhost:41418/getInfo.html) 05:01:31 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 05:01:31 INFO - PROCESS | 3316 | colorDepth:24 05:01:31 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 05:01:31 INFO - PROCESS | 3316 | __metrics 05:01:32 ERROR - PROCESS | 3316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:01:33 INFO - TEST-INFO | 3316: exit 0 05:01:33 INFO - Browser initialized. 05:01:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:33 INFO - TEST-INFO | started process 3437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpraUQXY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:44 INFO - PROCESS | 3437 | RSS: Main: 163053568 05:01:44 INFO - PROCESS | 3437 | 05:02:34 INFO - PROCESS | 3437 | 1471348954477 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] 05:04:43 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:41418/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41418/tests/dromaeo/cssquery-ext.html) 05:04:44 INFO - PROCESS | 3437 | RSS: Main: 166412288 05:04:44 INFO - PROCESS | 3437 | 05:07:47 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:41418/tests/dromaeo/cssquery-ext.html (next: http://localhost:41418/tests/dromaeo/cssquery-jquery.html) 05:07:47 INFO - PROCESS | 3437 | RSS: Main: 164880384 05:07:47 INFO - PROCESS | 3437 | 05:10:49 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:41418/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41418/tests/dromaeo/cssquery-mootools.html) 05:10:50 INFO - PROCESS | 3437 | RSS: Main: 166019072 05:10:50 INFO - PROCESS | 3437 | 05:13:51 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:41418/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41418/tests/dromaeo/cssquery-prototype.html) 05:13:52 INFO - PROCESS | 3437 | RSS: Main: 163336192 05:13:52 INFO - PROCESS | 3437 | 05:16:55 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:41418/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41418/tests/dromaeo/cssquery-yui.html) 05:16:55 INFO - PROCESS | 3437 | RSS: Main: 166035456 05:16:55 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:41418/tests/dromaeo/cssquery-yui.html (next: http://localhost:41418/tests/dromaeo/cssquery-dojo.html) 05:19:58 INFO - PROCESS | 3437 | RSS: Main: 166555648 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | __start_tp_report 05:19:58 INFO - PROCESS | 3437 | _x_x_mozilla_page_load 05:19:58 INFO - PROCESS | 3437 | _x_x_mozilla_page_load_details 05:19:58 INFO - PROCESS | 3437 | |i|pagename|runs| 05:19:58 INFO - PROCESS | 3437 | |0;dojo.html;3069.0485949355702;3079.291762894533;3098.008637236085;3101.302207003424;3104.3015321552652;5140.640155189139;5283.682979021261;5345.224942383352;5349.224362467445;5380.408155102936;5201.713905735183;5258.237555554442;5278.12910869707;5354.973225133878;5399.9730001349935;4793.976030119845;4870.537298956602;4893.094777466163;4902.754862256891;4952.7771250293645;4843.709377437347;4904.803807847682;4937.2840938063955;4968.35411396518;4977.228529577921;4870.464248932614;4930.383702037246;4936.136176169174;4964.826231081913;4983.950160498385;4710.858674239778;4727.338172655831;4746.738929358884;4766.52334766524;4823.324734537167;4708.105459962596;4719.740414277213;4724.4094488188975;4735.337052812609;4799.904001919977;5234.18870075139;5240.554552863011;5277.736113194325;5295.549878260353;5301.946980530184;5574.386817450118;5598.1322894951345;5636.239107720447;5649.802256920988;5677.744501497443;5590.580706447033;5697.800576979786;5709.74306156224;5710.8001219957105;5716.3426205986425;5152.536271735562;5295.894082118336;5308.840734777963;5315;5350.598705097055;5725.141228815711;5743.913841292384;5762.74067666956;5820.301563812285;5854.648721076664;5490.505854473116;5496;5575.749091290902;5579.163125531203;5584.609077364546;5537.252470916455;5611.494965453047;5626.943730562642;5635.971820140955;5660.26416565852;5558.916616250759;5588;5617.775288988477;5618.578606604521;5669.2346533218315;5531.419200983919;5581;5602.215689803431;5633.183188437653;5674.631148975303;4356.716813407118;4374.4531933508315;4375.474943006796;4377.233984052778;4417.845375411845;3825.5218097737784;3857.2478366718783;3866.149447121629;3901.804909754501;3909.179072394829;5373.811916582901;5397.190421436816;5400.891982160413;5416.51251387377;5469.835904922858;5633.718314084279;5684.488396044376;5684.602077854511;5697.544196464273;5699.914501282484;5317.654352467077;5347.732613369394;5369.892602148013;5383.488568585978;5454.972725136349;4826.734529600835;4881.8535443936735;4884.609231261491;4899.1426500363;4912.1158191525865;5903.026000709835;5908.379620139909;5912.615679980788;5930.199423077829;5930.495907847795;5570.359408667893;5634.352049514358;5653.575981801299;5666.065099258576;5705.201271822031;5875.353711091862;5913.083472061838;5920;5929.644221346733;5948.167256583995;5577.944220557904;5602.1036634138345;5616.4383561645145;5618.016847051831;5624.831255062355;5550.722463876871;5632.774689012557;5649.6327738696855;5663.2071509989455;5678.034734095297;5521.171824226398;5560.443955604407;5572.554195664418;5593.07714227148;5607.383187849415;5480.177973304037;5541.445855414427;5544.69504177258;5547.833564993057;5549.278593782782;5407.134858422633;5488.368837583729;5503.394626590992;5523.392426832965;5616.21373007771;5602.971985140048;5627.803026894039;5629.183768353648;5636.351819540641;5638.126090455986;5472.343318801769;5473.370562385377;5490.149026900836;5492.5331346835965;5497.945020549743 05:19:58 INFO - PROCESS | 3437 | |1;ext.html;546.8877204072445;587.2629849538828;592.1887014789738;604.1934018085857;626.764963138823;39410.211795764066;44317.33523997143;44330.55669443305;44389.77805110978;44564.108717825664;44933;45346.546534534646;45489.7725511372;45512;45737.54262457375;8955.37312388133;9039.186473217409;9076.63693452261;9092.22716069135;9116.8632470513;9001.414908030989;9025.548722563879;9031.322650801183;9035.774105647346;9035.909640903605;9066.45601263923;9080.228180604623;9096.135867092615;9102.954485227565;9138.954305228464;8997.595108220114;9018.053104424007;9037.683681071197;9039.954800226022;9041.095890410972;8851.424657397249;8897.466152030898;8920.330975176823;8934.687285944961;8951.060138685474;36093.097672558135;36164.45753313702;36216.81891590525;36429.81785091058;36493.45259821105;3399.337636376301;3566.197605538759;3646.562412510489;3995.14104467538;4291.334843099325;32912.3417531648;33178.50232246518;33205.66794332074;33212;33412.83293583516;4285.040581796527;4306.74159550428;4325.091730736549;4415.66882483815;4541.72749635023;395379;396222;396680.016599918;397003;398170;56498.43501564932;56938.715306424034;56946;57618.135727964116;57714.42285577174;60544.39455605476;60818.69590652107;60997.39002610006;60998.08502872372;61077.694611526655;16541.58646033835;16828.579285517717;16875.24061417239;16926.492205233615;17017.659646806995;12949;13158;13158.802617960739;13159.210447372996;13162.868371316164;14492.202928839015;15671.138087405303;15671.335872901405;15771.132587707556;15866.771961716198;6461.903071453932;6527.184101987252;6615.875301198807;6797.932020679828;6826.795196144024;926.2543652359915;1033.8707661542308;1047.2459828923163;1097.4293367448881;1105.2870898270571;32985.17537061593;33144.50283245753;33591.49612755811;33769.41496408226;34206.48690269648;1019.6176433837311;1110.5356467002605;1119.7368618374676;1139.840422340873;1278.1564167649308;15574.922125389301;16757.916210419113;16815.747763783555;17035.23341449638;17055.317787288368;540917;548401;549211;549363;551240;60690;60852.391476085555;60882.39117608767;60897;60931.69534152301;1298.8831005209577;1330.9267990260435;1348.170874911922;1350.9729805404033;1373.0800363756307;30363.848180758956;32317.192070198435;32553.67446325601;32937.505937411435;33521.83239083789;50253.748731256106;55698.72150639221;57376.13935790883;57551.42448575628;61752.38247617646;502678;504783;505087;507325;509710;27821.582676260277;27891.16326510208;27933.58099628548;28191.71808281973;28324.716752832206;49470;50096.49903500918;50497;50849.23726144185;51869.48130518646;41475.58524414717;41664.3750343739;42288.365674514294;43942.56057439385;44385.33421998608;41360;42501.36247956345;42976.78511607422;44526.3321050191;44550.55449445594;41464;42303;42311.576884230766;43229.783851080545;43340.78329608332;36400.63599364078;37798.81100594479;38200.808995954845;38225.80887095658;38342.80828595839;29126;29212.707872920997;29373.55939660864;29476.925836784427;29709.702902970694 05:19:58 INFO - PROCESS | 3437 | |2;jquery.html;352.46425433341307;370.06927577143483;376.613970680053;378.22841403536785;397.1104725415069;19439.41681749548;19612.607747845035;19620.70568941465;19868.50328741782;19879.900600496978;19511.90244048778;19838;20404.387868363934;20533.178672853068;21020.36938891832;5498.80754173604;5558.86102847428;5666.121751128581;5692.658440493563;5792.131180322943;3919.2749341371796;5837.416258374171;5859.4140585941495;5865.296164460271;5868.354481007107;6378.234611846585;6392.264889537693;6493.642849643268;6522.380373864476;6541.247756507991;5969.403059694039;6009.429104235091;6185.072239164139;6489.25373582037;6496.252930912935;5689.459501347365;5775.711214439303;5779.682117483537;5797;5825.1844741736195;16040.674102255107;23425.648615270784;23745.168919087748;23918.402039948967;24343.756562434326;2214.833887458431;2237.19460994042;2398.0887262840183;2431.63525471179;2618.528664840328;10015.849762253572;10709.892901070967;10760.569577216902;13402.262875541841;14738.115713057143;1877.915493802782;1925.5859990102056;1955.4817973236961;1995.0822621594084;2016.919323227069;78714;83802.16197838004;84394.15605843924;86821;87126;11040.834387484194;11320.433978301053;11370.919762622538;11502.654920352403;11503.137264705181;15724.13517256539;15877.603059923595;16003.919980400256;16015.599610009844;16061.839381606269;8303.418760686814;8376.413651044368;8610.526421046903;8673.52295623734;8806.60370283326;8172.346212303001;8337.624806883705;8373.706920257762;8429.283510901641;8544.2310192083;4898.975505122452;4916;4923.335349727812;4960.851174464699;5016.924746128811;1965.4693232827342;2003.8497112716605;2033.7762846086919;2052.0765655454807;2097.25547430663;862.2929198057658;962.5668449197889;972.5915115651302;1016.872890888639;1020.0921180149672;19429;20078.598428031357;20331.186752529735;20596.116543683896;20648.380548583267;1002.4336250018716;1005.6781829814389;1042.7653777900064;1051.1275641217771;1103.784761971424;9995.506515552333;11678.941605291919;11684.94157529224;11688.123390745728;11722.88277117235;440344;455009;455608;458304;486454;94753.5262323684;96180;97081.514592428;97724.51137744266;98519;950.7813202963218;970.3062310448064;986.5461887531816;987.5778878415059;1000.46475135802;17401.47795566135;18079.548011299823;18695;18755;18898.433047008613;29572.852135740046;30029.249268768457;30662.08013759591;39235.60764392434;43615.34576981284;60368.493136991536;61235.69382153061;62442;63212.68393658186;64693;8508.361872859685;8513.674672042363;8800.207981281716;8832.823343532964;9092.363534552518;9835.754106147404;12654.620361389174;13088.738225235633;13976.301184940916;14439.711205776035;11574.074074073886;11869.821952670889;11882;12144.939275303566;12289.446974885972;11431.771364572829;11630.476628551905;11790.056795456514;11988.381568488143;12092.093093018235;11658.242214256046;11686.590969316034;11831.645050648494;12040.157188996685;12128.575499857463;7701.1143718473095;8736.912630873865;8806.559672016245;9051.366404351633;9105.544722763967;10567.471626418495;11385.886141138482;11639.06887448985;11907.82138267944;11912.225705329125 05:19:58 INFO - PROCESS | 3437 | |3;mootools.html;1478.7560052591323;1497.7229212595666;1659.800823901132;1762.7796525434321;1792.901390423527;7973.92026079739;8613.741587752362;8614.224719775219;9180.449173049621;9282.628694852207;8673.783155421117;8982.505962172077;9018.188363047324;9036.63853445863;9089.318301127425;2266.2634643740766;2310.2029799719153;2310.757370476101;2312.190733243368;2324.976750232501;2273.147569661377;2288.4507718147606;2356.646503024543;2360.209329874494;2362.586547354215;2336.2874323331375;2340.2277248508035;2343.8163727317683;2363.444590521226;2367.739548649647;2269.7389800172946;2278.874661893595;2290.415943934286;2292.4039749665126;2303.57383883982;2270.9545809083893;2282.9429264268524;2288.5651726171973;2289.6222123349626;2292.4612716011725;8991.910080899173;9123.315751318678;9178.908210917938;9186.311026673025;9190.632374705005;5176.508231718019;5279.287296215;5315.362156541201;5325.068113080196;5332.440093790135;3179.8410079495934;3314.6188188358406;3356.8489417976007;3430.073880052397;3446.3451944130534;1031.5718976624692;1084.5499117866077;1103.7406209540752;1109.4286442482048;1111.8888111188896;12426.192297500633;12456.688582785413;12537.373131343396;12567.622971310875;12650.683732906658;4321.2005778931;4406.801693923781;4510.797014134372;4606.032733126014;4609.976950115228;10517.368957862553;10568.89431105679;10569.947150264354;10622.893771062345;10634.840477392845;5148.794048238028;5159.122949098587;5184.507471790174;5227.973860130675;5236.476352364733;4291.249031419489;4574.794134263966;4753.500882407367;4755.690880092783;4757.690750101302;3866.8066596670055;3886.1256217351433;3946.2304850553865;3968.1666849961252;3996.9400458993136;1186.2822992089662;1190.8570971483477;1206.6802297391198;1210.8062709966364;1212.2605210821391;955.9761005974767;973.7078876337071;986.413084214891;988.41189492252;1014.8934361892043;5865.706714664249;5983.640981541122;6026.9095963560585;6043.516518678495;6082.787102451393;426.51164416742654;431.0710419046959;446.0988802618692;449.9325101234841;451.19912155922844;4173.770442625685;4201.642860356843;4207.768572728468;4210.915781684411;4210.978945105255;10911;11112.61105861307;11210.439478026066;11240.437978101063;11266.66200014001;10248.795024099476;11100.390443385664;11127.610533631285;11176.385298808644;11180.888191117985;8111.797205069803;8512.531810750344;8513.574321284035;8524.190201930807;8540.74377768668;5862.94137058624;5905.35041145465;5969.552283578836;6003.0695242237525;6104.328523862283;9367.578458969227;9448.622055117718;9585.616575336908;9647.758806029906;9655.951720241354;9735.610575576897;9796.65711700087;9954.104130628279;9955.800883982425;9992.15066719337;7836.490628109383;8399.496030238206;8556.401051926305;8583.098774628574;8772.342074344322;8716.128387161232;8963.507007114671;8985.595648195716;8991.325650576102;8995.280377569648;7686.9231307686205;7725.99562056929;7905.446618736633;7908.971833661817;7982.8802567960365;7478.663460144197;7606.087269527692;7739.729109481141;7853.410994175346;7971.44199906001;6996.055532503047;7035.22612512613;7046.964765176346;7061.399781018671;7066.646667666699;5036.345275114211;5061.291419201389;5150.4592017837585;5154.123798954111;5342.839714808562;5138.871528211825;5192.3769147702515;5196.454372290855;5238.5023422774775;5434.021876062347 05:19:58 INFO - PROCESS | 3437 | |4;prototype.html;314.65230919833584;326.4874147588286;328.1271816966867;332.5095484160863;333.90650617826986;5443.972780136104;5445.891082178354;5641.815218804051;5671.71641417929;5688.914666280009;5502.312210973629;5549.556035517159;5584.5811564132755;5599.720013999304;5614.522765564931;4417.785109095009;4420.093880754445;4436.378906953013;4445.355423463596;4454.13144436835;4111.48606424197;4304.720193187449;4348.847790327339;4439.800208990603;4456.732596044231;4271.957280427203;4284.785760711968;4286.3784751211215;4296.3577399898995;4311.805968731414;4308.719933204332;4321.373400856874;4328.675349348811;4340.045190058182;4363.454568178978;3734.141147536082;3747.2692824899154;3826.559945606263;3835.673967712748;3835.846566137351;5363.892722145574;5382.138857782775;5405.756740946627;5409.702466364349;5414.40441551429;4874.610031197496;4936.580390666798;4936.851894443136;4940.6788558743565;4952.009598080363;5433.315672141649;5750.367459579443;5763.855903602402;5771.278590176228;5823.5341172706085;4095.3242714952;4103.7948102594755;4119.814608342602;4132.669386449077;4142.834286628531;6052.092186172065;6106.145139680449;6115.327313995457;6118.969405152946;6136.202293701835;4071.4096456013713;4118.546959834416;4133.400656904732;4190.308599081118;4194.098268872207;4217.641500472494;4224.556421575752;4229.471316085489;4232.36514522824;4232.539773778041;4872.051179528217;4894.8497103180725;4897.7795999180125;4902.779374928136;4949.505049495022;5557.472040156179;5806.767729290781;5937.495312898365;5938.910916336258;5943.257092863392;1465.5823090419178;1476.8966172367832;1479.4082367053265;1481.1187343530582;1492.388120870438;885.1281487734576;928.758522784081;945.3760518058186;950.2872845365976;956.1633570625703;4883.658143929962;4883.677945018684;4970.229614409773;4979.502049795064;4993.475685053089;5203.661761985534;5241.633085683966;5266.236395722599;5333.280007198979;5396.731768034509;4693.342931989524;4922.744700101452;5037.82367617139;5040.521150490697;5060.418051924003;2780.569011803174;2784.5659485365054;2800.9299767505568;2803.453326601334;2822.5604941479583;5416.431274716177;5447.863803404867;5461.535769459561;5472.781088756406;5498.048192891546;5178.870528236825;5390.703511306838;5390.865228369322;5399.757010934517;5462;5367.382750983609;5375.75809088592;5459.235707001023;5476.288082549243;5490.752916118784;5245.531251249657;5283.709395983258;5286.2291132471055;5292.894142117213;5343.492368225013;4905.743358055334;5198.584113271005;5210.583153347648;5242.5281724644965;5282.683039017671;5487.314085739283;5489.945100549103;5504.4495550444635;5505.476979686923;5524.751386187711;4007.6994225432627;4120.690948178839;4138.586141385837;4203.663706903501;4220.15596880619;5980.850478738066;5982.4017598239825;5990.790322338871;5997.100434934795;6036.909446358396;5669.716514174357;5823.272090988627;5830.650160990184;5874.441928016831;5927.377625349449;5718.313802343745;5760.164776107525;5766.769329226784;5770.9711451444155;5780.971095144498;5755.683437410982;5765.221695071279;5799.884002320015;5805.419458054161;5874.676892770939;5629.943700563106;5793.030369674331;5844.503217226584;5859.5019423349495;5876.735546900314;5699.458551437607;5719;5721.628094173865;5735.48009777401;5746.856328591819 05:19:58 INFO - PROCESS | 3437 | |5;yui.html;733.431590517349;762.8321769210771;767.501124269225;795.848788730141;833.1959658929133;15732.29204685789;16196.109213993226;16589.668206635874;16612.584685382855;16702.49892503224;13855.445782168727;13907.443702251923;13924.721505569882;13943.09369890959;13948.302584870766;649.2371463530357;778.5873487051844;801.0347531224875;805.8468890910708;815.9714409995652;802.1216767639426;812.7642983534768;812.959352032396;813.7924829168554;813.9837203255931;857.9828403431927;859.3984211052289;862.4695812075591;867.2411639815161;867.5185272173941;852.4927668037508;854.8589482735404;857.9227869491775;858.107568129148;859.3855393393723;623.3174673732256;624.3101372982834;629.2826178156905;630.0737915264554;630.1650313334804;15395.461158859498;15425.15161666108;15448.073115612986;15486.148261845594;15541.611459713598;15682.215889205494;15726.44957426496;15768.842311576967;15867.889247752662;15912.363505459884;12124.878751212464;12434;12445.315507647076;12563.497460101586;12796;3786.318462676717;3793.241351729665;3853.6724378427866;3886.8250928708276;4006.9198616027516;87299;88334.5583272086;88580.55709721474;89008.99999999935;92338;11753.647390578297;11969;12025.579104731292;12047.939760301142;12206.93412233913;23829.285121446384;23981.160659376837;24097.156599518934;24107.397315067265;24134.87932560361;8910.153535414125;8949.865752013726;8958.910410895807;9034.45793252407;9071.366726047732;4730.763461826895;4772.522747725269;4878.829240976549;4983.9252411213865;5045.84862454127;3481.0775144586705;3598.0465176727666;3600.945985810215;3605.0626837022564;3610.1155216971483;596.725506267122;600.3186383454811;601.506764453153;609.3479976425183;610.5329422991415;750.8761054426068;757.6704133701858;772.3782355204114;776.9883451748228;793.412874472886;9832.164266037467;10260.640877569249;10326;10625;10756.515956781963;755.5655498088621;760.3309088002633;764.506893053977;775.5153029356652;784.1844481739041;4807.110684523374;4881.707097574157;5023.397192336943;5102.158143906214;5168.81909133186;96475.51762241144;97423;100275.49862250788;122448;130305;101734;101757.49121254495;102397;103192.48403757933;103522;77325.61337193278;79776.60111699288;88579;90836;91514;9921.45432001218;10269.127124194527;10293.330933489298;10332.690019299433;10605.89394106049;50088.845408988826;51458.48541514687;52221;53135.46864531305;53463.46536534585;70702.64648676723;77037.22962770301;77167.228327716;77452;78413;12615.36923153857;12712.237265764084;13020.5442809505;13356.427637292943;13779.793303100261;14961.700765984837;14976.326065327305;15359.308831102404;15641.843581564039;15915.522534323989;13826.585202443943;14167.929160354131;14491.420343186155;14598.781018284946;14649.560513184622;13500.054996150175;13684.178949263076;14005.019648624499;14266.358013889192;14399.856001439852;13324.866751332362;13547.86452135466;13685.657858553615;13950.581482555539;14343.497977571153;11247.212695111264;11324.716882077684;11333.773324533628;11559.884401155881;12005.75988480243;10753.1935104869;11229.831552526883;11272.436378180893;11352.716182095513;11531.423428828357 05:19:58 INFO - PROCESS | 3437 | __end_tp_report 05:19:58 INFO - PROCESS | 3437 | __start_cc_report 05:19:58 INFO - PROCESS | 3437 | _x_x_mozilla_cycle_collect,331 05:19:58 INFO - PROCESS | 3437 | __end_cc_report 05:19:58 INFO - PROCESS | 3437 | __startTimestamp1471349998832__endTimestamp 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | ------- Summary: start ------- 05:19:58 INFO - PROCESS | 3437 | Number of tests: 6 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | [#0] dojo.html Cycles:165 Average:5272.61 Median:5492.53 stddev:590.41 (10.7%) stddev-sans-first:566.35 05:19:58 INFO - PROCESS | 3437 | Values: 3069.0 3079.3 3098.0 3101.3 3104.3 5140.6 5283.7 5345.2 5349.2 5380.4 5201.7 5258.2 5278.1 5355.0 5400.0 4794.0 4870.5 4893.1 4902.8 4952.8 4843.7 4904.8 4937.3 4968.4 4977.2 4870.5 4930.4 4936.1 4964.8 4984.0 4710.9 4727.3 4746.7 4766.5 4823.3 4708.1 4719.7 4724.4 4735.3 4799.9 5234.2 5240.6 5277.7 5295.5 5301.9 5574.4 5598.1 5636.2 5649.8 5677.7 5590.6 5697.8 5709.7 5710.8 5716.3 5152.5 5295.9 5308.8 5315.0 5350.6 5725.1 5743.9 5762.7 5820.3 5854.6 5490.5 5496.0 5575.7 5579.2 5584.6 5537.3 5611.5 5626.9 5636.0 5660.3 5558.9 5588.0 5617.8 5618.6 5669.2 5531.4 5581.0 5602.2 5633.2 5674.6 4356.7 4374.5 4375.5 4377.2 4417.8 3825.5 3857.2 3866.1 3901.8 3909.2 5373.8 5397.2 5400.9 5416.5 5469.8 5633.7 5684.5 5684.6 5697.5 5699.9 5317.7 5347.7 5369.9 5383.5 5455.0 4826.7 4881.9 4884.6 4899.1 4912.1 5903.0 5908.4 5912.6 5930.2 5930.5 5570.4 5634.4 5653.6 5666.1 5705.2 5875.4 5913.1 5920.0 5929.6 5948.2 5577.9 5602.1 5616.4 5618.0 5624.8 5550.7 5632.8 5649.6 5663.2 5678.0 5521.2 5560.4 5572.6 5593.1 5607.4 5480.2 5541.4 5544.7 5547.8 5549.3 5407.1 5488.4 5503.4 5523.4 5616.2 5603.0 5627.8 5629.2 5636.4 5638.1 5472.3 5473.4 5490.1 5492.5 5497.9 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | [#1] ext.html Cycles:180 Average:64176.08 Median:23768.26 stddev:129481.71 (544.8%) stddev-sans-first:129756.81 05:19:58 INFO - PROCESS | 3437 | Values: 546.9 587.3 592.2 604.2 626.8 39410.2 44317.3 44330.6 44389.8 44564.1 44933.0 45346.5 45489.8 45512.0 45737.5 8955.4 9039.2 9076.6 9092.2 9116.9 9001.4 9025.5 9031.3 9035.8 9035.9 9066.5 9080.2 9096.1 9103.0 9139.0 8997.6 9018.1 9037.7 9040.0 9041.1 8851.4 8897.5 8920.3 8934.7 8951.1 36093.1 36164.5 36216.8 36429.8 36493.5 3399.3 3566.2 3646.6 3995.1 4291.3 32912.3 33178.5 33205.7 33212.0 33412.8 4285.0 4306.7 4325.1 4415.7 4541.7 395379.0 396222.0 396680.0 397003.0 398170.0 56498.4 56938.7 56946.0 57618.1 57714.4 60544.4 60818.7 60997.4 60998.1 61077.7 16541.6 16828.6 16875.2 16926.5 17017.7 12949.0 13158.0 13158.8 13159.2 13162.9 14492.2 15671.1 15671.3 15771.1 15866.8 6461.9 6527.2 6615.9 6797.9 6826.8 926.3 1033.9 1047.2 1097.4 1105.3 32985.2 33144.5 33591.5 33769.4 34206.5 1019.6 1110.5 1119.7 1139.8 1278.2 15574.9 16757.9 16815.7 17035.2 17055.3 540917.0 548401.0 549211.0 549363.0 551240.0 60690.0 60852.4 60882.4 60897.0 60931.7 1298.9 1330.9 1348.2 1351.0 1373.1 30363.8 32317.2 32553.7 32937.5 33521.8 50253.7 55698.7 57376.1 57551.4 61752.4 502678.0 504783.0 505087.0 507325.0 509710.0 27821.6 27891.2 27933.6 28191.7 28324.7 49470.0 50096.5 50497.0 50849.2 51869.5 41475.6 41664.4 42288.4 43942.6 44385.3 41360.0 42501.4 42976.8 44526.3 44550.6 41464.0 42303.0 42311.6 43229.8 43340.8 36400.6 37798.8 38200.8 38225.8 38342.8 29126.0 29212.7 29373.6 29476.9 29709.7 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | [#2] jquery.html Cycles:180 Average:28529.50 Median:16095.69 stddev:76092.34 (472.7%) stddev-sans-first:76276.39 05:19:58 INFO - PROCESS | 3437 | Values: 352.5 370.1 376.6 378.2 397.1 19439.4 19612.6 19620.7 19868.5 19879.9 19511.9 19838.0 20404.4 20533.2 21020.4 5498.8 5558.9 5666.1 5692.7 5792.1 3919.3 5837.4 5859.4 5865.3 5868.4 6378.2 6392.3 6493.6 6522.4 6541.2 5969.4 6009.4 6185.1 6489.3 6496.3 5689.5 5775.7 5779.7 5797.0 5825.2 16040.7 23425.6 23745.2 23918.4 24343.8 2214.8 2237.2 2398.1 2431.6 2618.5 10015.8 10709.9 10760.6 13402.3 14738.1 1877.9 1925.6 1955.5 1995.1 2016.9 78714.0 83802.2 84394.2 86821.0 87126.0 11040.8 11320.4 11370.9 11502.7 11503.1 15724.1 15877.6 16003.9 16015.6 16061.8 8303.4 8376.4 8610.5 8673.5 8806.6 8172.3 8337.6 8373.7 8429.3 8544.2 4899.0 4916.0 4923.3 4960.9 5016.9 1965.5 2003.8 2033.8 2052.1 2097.3 862.3 962.6 972.6 1016.9 1020.1 19429.0 20078.6 20331.2 20596.1 20648.4 1002.4 1005.7 1042.8 1051.1 1103.8 9995.5 11678.9 11684.9 11688.1 11722.9 440344.0 455009.0 455608.0 458304.0 486454.0 94753.5 96180.0 97081.5 97724.5 98519.0 950.8 970.3 986.5 987.6 1000.5 17401.5 18079.5 18695.0 18755.0 18898.4 29572.9 30029.2 30662.1 39235.6 43615.3 60368.5 61235.7 62442.0 63212.7 64693.0 8508.4 8513.7 8800.2 8832.8 9092.4 9835.8 12654.6 13088.7 13976.3 14439.7 11574.1 11869.8 11882.0 12144.9 12289.4 11431.8 11630.5 11790.1 11988.4 12092.1 11658.2 11686.6 11831.6 12040.2 12128.6 7701.1 8736.9 8806.6 9051.4 9105.5 10567.5 11385.9 11639.1 11907.8 11912.2 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | [#3] mootools.html Cycles:180 Average:5839.87 Median:4897.02 stddev:3374.57 (68.9%) stddev-sans-first:3368.12 05:19:58 INFO - PROCESS | 3437 | Values: 1478.8 1497.7 1659.8 1762.8 1792.9 7973.9 8613.7 8614.2 9180.4 9282.6 8673.8 8982.5 9018.2 9036.6 9089.3 2266.3 2310.2 2310.8 2312.2 2325.0 2273.1 2288.5 2356.6 2360.2 2362.6 2336.3 2340.2 2343.8 2363.4 2367.7 2269.7 2278.9 2290.4 2292.4 2303.6 2271.0 2282.9 2288.6 2289.6 2292.5 8991.9 9123.3 9178.9 9186.3 9190.6 5176.5 5279.3 5315.4 5325.1 5332.4 3179.8 3314.6 3356.8 3430.1 3446.3 1031.6 1084.5 1103.7 1109.4 1111.9 12426.2 12456.7 12537.4 12567.6 12650.7 4321.2 4406.8 4510.8 4606.0 4610.0 10517.4 10568.9 10569.9 10622.9 10634.8 5148.8 5159.1 5184.5 5228.0 5236.5 4291.2 4574.8 4753.5 4755.7 4757.7 3866.8 3886.1 3946.2 3968.2 3996.9 1186.3 1190.9 1206.7 1210.8 1212.3 956.0 973.7 986.4 988.4 1014.9 5865.7 5983.6 6026.9 6043.5 6082.8 426.5 431.1 446.1 449.9 451.2 4173.8 4201.6 4207.8 4210.9 4211.0 10911.0 11112.6 11210.4 11240.4 11266.7 10248.8 11100.4 11127.6 11176.4 11180.9 8111.8 8512.5 8513.6 8524.2 8540.7 5862.9 5905.4 5969.6 6003.1 6104.3 9367.6 9448.6 9585.6 9647.8 9656.0 9735.6 9796.7 9954.1 9955.8 9992.2 7836.5 8399.5 8556.4 8583.1 8772.3 8716.1 8963.5 8985.6 8991.3 8995.3 7686.9 7726.0 7905.4 7909.0 7982.9 7478.7 7606.1 7739.7 7853.4 7971.4 6996.1 7035.2 7047.0 7061.4 7066.6 5036.3 5061.3 5150.5 5154.1 5342.8 5138.9 5192.4 5196.5 5238.5 5434.0 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | [#4] prototype.html Cycles:180 Average:4713.42 Median:5284.97 stddev:1369.48 (25.9%) stddev-sans-first:1332.92 05:19:58 INFO - PROCESS | 3437 | Values: 314.7 326.5 328.1 332.5 333.9 5444.0 5445.9 5641.8 5671.7 5688.9 5502.3 5549.6 5584.6 5599.7 5614.5 4417.8 4420.1 4436.4 4445.4 4454.1 4111.5 4304.7 4348.8 4439.8 4456.7 4272.0 4284.8 4286.4 4296.4 4311.8 4308.7 4321.4 4328.7 4340.0 4363.5 3734.1 3747.3 3826.6 3835.7 3835.8 5363.9 5382.1 5405.8 5409.7 5414.4 4874.6 4936.6 4936.9 4940.7 4952.0 5433.3 5750.4 5763.9 5771.3 5823.5 4095.3 4103.8 4119.8 4132.7 4142.8 6052.1 6106.1 6115.3 6119.0 6136.2 4071.4 4118.5 4133.4 4190.3 4194.1 4217.6 4224.6 4229.5 4232.4 4232.5 4872.1 4894.8 4897.8 4902.8 4949.5 5557.5 5806.8 5937.5 5938.9 5943.3 1465.6 1476.9 1479.4 1481.1 1492.4 885.1 928.8 945.4 950.3 956.2 4883.7 4883.7 4970.2 4979.5 4993.5 5203.7 5241.6 5266.2 5333.3 5396.7 4693.3 4922.7 5037.8 5040.5 5060.4 2780.6 2784.6 2800.9 2803.5 2822.6 5416.4 5447.9 5461.5 5472.8 5498.0 5178.9 5390.7 5390.9 5399.8 5462.0 5367.4 5375.8 5459.2 5476.3 5490.8 5245.5 5283.7 5286.2 5292.9 5343.5 4905.7 5198.6 5210.6 5242.5 5282.7 5487.3 5489.9 5504.4 5505.5 5524.8 4007.7 4120.7 4138.6 4203.7 4220.2 5980.9 5982.4 5990.8 5997.1 6036.9 5669.7 5823.3 5830.7 5874.4 5927.4 5718.3 5760.2 5766.8 5771.0 5781.0 5755.7 5765.2 5799.9 5805.4 5874.7 5629.9 5793.0 5844.5 5859.5 5876.7 5699.5 5719.0 5721.6 5735.5 5746.9 05:19:58 INFO - PROCESS | 3437 | 05:19:58 INFO - PROCESS | 3437 | [#5] yui.html Cycles:180 Average:21443.59 Median:3698.22 stddev:30549.14 (826.1%) stddev-sans-first:30595.26 05:19:58 INFO - PROCESS | 3437 | Values: 733.4 762.8 767.5 795.8 833.2 15732.3 16196.1 16589.7 16612.6 16702.5 13855.4 13907.4 13924.7 13943.1 13948.3 649.2 778.6 801.0 805.8 816.0 802.1 812.8 813.0 813.8 814.0 858.0 859.4 862.5 867.2 867.5 852.5 854.9 857.9 858.1 859.4 623.3 624.3 629.3 630.1 630.2 15395.5 15425.2 15448.1 15486.1 15541.6 15682.2 15726.4 15768.8 15867.9 15912.4 12124.9 12434.0 12445.3 12563.5 12796.0 3786.3 3793.2 3853.7 3886.8 4006.9 87299.0 88334.6 88580.6 89009.0 92338.0 11753.6 11969.0 12025.6 12047.9 12206.9 23829.3 23981.2 24097.2 24107.4 24134.9 8910.2 8949.9 8958.9 9034.5 9071.4 4730.8 4772.5 4878.8 4983.9 5045.8 3481.1 3598.0 3600.9 3605.1 3610.1 596.7 600.3 601.5 609.3 610.5 750.9 757.7 772.4 777.0 793.4 9832.2 10260.6 10326.0 10625.0 10756.5 755.6 760.3 764.5 775.5 784.2 4807.1 4881.7 5023.4 5102.2 5168.8 96475.5 97423.0 100275.5 122448.0 130305.0 101734.0 101757.5 102397.0 103192.5 103522.0 77325.6 79776.6 88579.0 90836.0 91514.0 9921.5 10269.1 10293.3 10332.7 10605.9 50088.8 51458.5 52221.0 53135.5 53463.5 70702.6 77037.2 77167.2 77452.0 78413.0 12615.4 12712.2 13020.5 13356.4 13779.8 14961.7 14976.3 15359.3 15641.8 15915.5 13826.6 14167.9 14491.4 14598.8 14649.6 13500.1 13684.2 14005.0 14266.4 14399.9 13324.9 13547.9 13685.7 13950.6 14343.5 11247.2 11324.7 11333.8 11559.9 12005.8 10753.2 11229.8 11272.4 11352.7 11531.4 05:19:58 INFO - PROCESS | 3437 | -------- Summary: end -------- 05:19:58 INFO - PROCESS | 3437 | 05:19:59 INFO - TEST-INFO | 3437: exit 0 05:19:59 INFO - TEST-OK | dromaeo_css | took 1114391ms 05:19:59 INFO - TEST-START | kraken 05:19:59 INFO - operating with platform_type : linux_ 05:19:59 INFO - Initialising browser for kraken test... 05:19:59 INFO - TEST-INFO | started process 3685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_bpSqN/profile http://localhost:41418/getInfo.html) 05:20:04 INFO - PROCESS | 3685 | __metrics Screen width/height:1600/1200 05:20:04 INFO - PROCESS | 3685 | colorDepth:24 05:20:04 INFO - PROCESS | 3685 | Browser inner width/height: 1024/697 05:20:04 INFO - PROCESS | 3685 | __metrics 05:20:04 ERROR - PROCESS | 3685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:20:05 INFO - TEST-INFO | 3685: exit 0 05:20:05 INFO - Browser initialized. 05:20:05 INFO - Running cycle 1/1 for kraken test... 05:20:05 INFO - TEST-INFO | started process 3805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_bpSqN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:17 INFO - PROCESS | 3805 | RSS: Main: 163225600 05:20:17 INFO - PROCESS | 3805 | 05:20:20 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41418/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:21 INFO - PROCESS | 3805 | RSS: Main: 168755200 05:20:21 INFO - PROCESS | 3805 | 05:20:23 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41418/tests/kraken/driver.html?testName=audio-dft) 05:20:24 INFO - PROCESS | 3805 | RSS: Main: 167149568 05:20:24 INFO - PROCESS | 3805 | 05:20:27 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41418/tests/kraken/driver.html?testName=audio-fft) 05:20:27 INFO - PROCESS | 3805 | RSS: Main: 163467264 05:20:27 INFO - PROCESS | 3805 | 05:20:30 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41418/tests/kraken/driver.html?testName=audio-oscillator) 05:20:30 INFO - PROCESS | 3805 | RSS: Main: 164524032 05:20:30 INFO - PROCESS | 3805 | 05:20:32 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41418/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:33 INFO - PROCESS | 3805 | RSS: Main: 164917248 05:20:33 INFO - PROCESS | 3805 | 05:20:36 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41418/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:37 INFO - PROCESS | 3805 | RSS: Main: 165019648 05:20:37 INFO - PROCESS | 3805 | 05:20:40 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41418/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:41 INFO - PROCESS | 3805 | RSS: Main: 162025472 05:20:41 INFO - PROCESS | 3805 | 05:20:44 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41418/tests/kraken/driver.html?testName=json-parse-financial) 05:20:44 INFO - PROCESS | 3805 | RSS: Main: 164200448 05:20:44 INFO - PROCESS | 3805 | 05:20:46 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41418/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:47 INFO - PROCESS | 3805 | RSS: Main: 164282368 05:20:47 INFO - PROCESS | 3805 | 05:20:48 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:49 INFO - PROCESS | 3805 | RSS: Main: 164442112 05:20:49 INFO - PROCESS | 3805 | 05:20:51 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:52 INFO - PROCESS | 3805 | RSS: Main: 164978688 05:20:52 INFO - PROCESS | 3805 | 05:20:55 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:55 INFO - PROCESS | 3805 | RSS: Main: 165605376 05:20:55 INFO - PROCESS | 3805 | 05:20:58 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:59 INFO - PROCESS | 3805 | RSS: Main: 165756928 05:20:59 INFO - PROCESS | 3805 | 05:21:00 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:41418/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41418/tests/kraken/driver.html?testName=ai-astar) 05:21:01 INFO - PROCESS | 3805 | RSS: Main: 165994496 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | __start_tp_report 05:21:01 INFO - PROCESS | 3805 | _x_x_mozilla_page_load 05:21:01 INFO - PROCESS | 3805 | _x_x_mozilla_page_load_details 05:21:01 INFO - PROCESS | 3805 | |i|pagename|runs| 05:21:01 INFO - PROCESS | 3805 | |0;ai-astar;107;112;109;113;115;113;117;113;113;113 05:21:01 INFO - PROCESS | 3805 | |1;audio-beat-detection;146;119;146;184;119;145;148;118;178;122 05:21:01 INFO - PROCESS | 3805 | |2;audio-dft;162;163;162;161;165;171;166;161;161;164 05:21:01 INFO - PROCESS | 3805 | |3;audio-fft;76;75;76;177;82;76;75;76;164;76 05:21:01 INFO - PROCESS | 3805 | |4;audio-oscillator;86;85;147;85;85;86;150;86;85;160 05:21:01 INFO - PROCESS | 3805 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;117;117;117 05:21:01 INFO - PROCESS | 3805 | |6;imaging-darkroom;146;150;147;151;148;148;148;147;147;148 05:21:01 INFO - PROCESS | 3805 | |7;imaging-desaturate;95;96;95;96;96;96;96;95;96;95 05:21:01 INFO - PROCESS | 3805 | |8;json-parse-financial;54;51;61;56;52;57;54;51;51;58 05:21:01 INFO - PROCESS | 3805 | |9;json-stringify-tinderbox;62;62;63;64;63;62;62;63;64;63 05:21:01 INFO - PROCESS | 3805 | |10;stanford-crypto-aes;87;85;84;80;84;78;82;79;79;87 05:21:01 INFO - PROCESS | 3805 | |11;stanford-crypto-ccm;128;129;135;133;130;146;138;128;142;126 05:21:01 INFO - PROCESS | 3805 | |12;stanford-crypto-pbkdf2;165;166;166;163;169;163;163;165;166;165 05:21:01 INFO - PROCESS | 3805 | |13;stanford-crypto-sha256-iterative;67;65;70;65;64;66;65;65;66;68 05:21:01 INFO - PROCESS | 3805 | __end_tp_report 05:21:01 INFO - PROCESS | 3805 | __start_cc_report 05:21:01 INFO - PROCESS | 3805 | _x_x_mozilla_cycle_collect,874 05:21:01 INFO - PROCESS | 3805 | __end_cc_report 05:21:01 INFO - PROCESS | 3805 | __startTimestamp1471350061040__endTimestamp 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | ------- Summary: start ------- 05:21:01 INFO - PROCESS | 3805 | Number of tests: 14 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:2.80 (2.5%) stddev-sans-first:2.15 05:21:01 INFO - PROCESS | 3805 | Values: 107.0 112.0 109.0 113.0 115.0 113.0 117.0 113.0 113.0 113.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:146.00 stddev:23.96 (16.4%) stddev-sans-first:25.38 05:21:01 INFO - PROCESS | 3805 | Values: 146.0 119.0 146.0 184.0 119.0 145.0 148.0 118.0 178.0 122.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.13 (1.9%) stddev-sans-first:3.27 05:21:01 INFO - PROCESS | 3805 | Values: 162.0 163.0 162.0 161.0 165.0 171.0 166.0 161.0 161.0 164.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:39.80 (52.4%) stddev-sans-first:41.60 05:21:01 INFO - PROCESS | 3805 | Values: 76.0 75.0 76.0 177.0 82.0 76.0 75.0 76.0 164.0 76.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:85.00 stddev:32.48 (38.2%) stddev-sans-first:33.67 05:21:01 INFO - PROCESS | 3805 | Values: 86.0 85.0 147.0 85.0 85.0 86.0 150.0 86.0 85.0 160.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:21:01 INFO - PROCESS | 3805 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.49 (1.0%) stddev-sans-first:1.39 05:21:01 INFO - PROCESS | 3805 | Values: 146.0 150.0 147.0 151.0 148.0 148.0 148.0 147.0 147.0 148.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:21:01 INFO - PROCESS | 3805 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:3.44 (6.3%) stddev-sans-first:3.64 05:21:01 INFO - PROCESS | 3805 | Values: 54.0 51.0 61.0 56.0 52.0 57.0 54.0 51.0 51.0 58.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 05:21:01 INFO - PROCESS | 3805 | Values: 62.0 62.0 63.0 64.0 63.0 62.0 62.0 63.0 64.0 63.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:84.00 stddev:3.37 (4.0%) stddev-sans-first:3.16 05:21:01 INFO - PROCESS | 3805 | Values: 87.0 85.0 84.0 80.0 84.0 78.0 82.0 79.0 79.0 87.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:134.00 stddev:6.67 (5.0%) stddev-sans-first:6.77 05:21:01 INFO - PROCESS | 3805 | Values: 128.0 129.0 135.0 133.0 130.0 146.0 138.0 128.0 142.0 126.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.50 stddev:1.85 (1.1%) stddev-sans-first:1.96 05:21:01 INFO - PROCESS | 3805 | Values: 165.0 166.0 166.0 163.0 169.0 163.0 163.0 165.0 166.0 165.0 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - PROCESS | 3805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.79 (2.7%) stddev-sans-first:1.87 05:21:01 INFO - PROCESS | 3805 | Values: 67.0 65.0 70.0 65.0 64.0 66.0 65.0 65.0 66.0 68.0 05:21:01 INFO - PROCESS | 3805 | -------- Summary: end -------- 05:21:01 INFO - PROCESS | 3805 | 05:21:01 INFO - TEST-INFO | 3805: exit 0 05:21:02 INFO - TEST-OK | kraken | took 62487ms 05:21:02 INFO - SUITE-END | took 1176s 05:21:02 INFO - Completed test suite (00:19:37) 05:21:02 INFO - javascript benchmark 05:21:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7312.523100897798, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.0485949355702, 3079.291762894533, 3098.008637236085, 3101.302207003424, 3104.3015321552652, 5140.640155189139, 5283.682979021261, 5345.224942383352, 5349.224362467445, 5380.408155102936, 5201.713905735183, 5258.237555554442, 5278.12910869707, 5354.973225133878, 5399.9730001349935, 4793.976030119845, 4870.537298956602, 4893.094777466163, 4902.754862256891, 4952.7771250293645, 4843.709377437347, 4904.803807847682, 4937.2840938063955, 4968.35411396518, 4977.228529577921, 4870.464248932614, 4930.383702037246, 4936.136176169174, 4964.826231081913, 4983.950160498385, 4710.858674239778, 4727.338172655831, 4746.738929358884, 4766.52334766524, 4823.324734537167, 4708.105459962596, 4719.740414277213, 4724.4094488188975, 4735.337052812609, 4799.904001919977, 5234.18870075139, 5240.554552863011, 5277.736113194325, 5295.549878260353, 5301.946980530184, 5574.386817450118, 5598.1322894951345, 5636.239107720447, 5649.802256920988, 5677.744501497443, 5590.580706447033, 5697.800576979786, 5709.74306156224, 5710.8001219957105, 5716.3426205986425, 5152.536271735562, 5295.894082118336, 5308.840734777963, 5315.0, 5350.598705097055, 5725.141228815711, 5743.913841292384, 5762.74067666956, 5820.301563812285, 5854.648721076664, 5490.505854473116, 5496.0, 5575.749091290902, 5579.163125531203, 5584.609077364546, 5537.252470916455, 5611.494965453047, 5626.943730562642, 5635.971820140955, 5660.26416565852, 5558.916616250759, 5588.0, 5617.775288988477, 5618.578606604521, 5669.2346533218315, 5531.419200983919, 5581.0, 5602.215689803431, 5633.183188437653, 5674.631148975303, 4356.716813407118, 4374.4531933508315, 4375.474943006796, 4377.233984052778, 4417.845375411845, 3825.5218097737784, 3857.2478366718783, 3866.149447121629, 3901.804909754501, 3909.179072394829, 5373.811916582901, 5397.190421436816, 5400.891982160413, 5416.51251387377, 5469.835904922858, 5633.718314084279, 5684.488396044376, 5684.602077854511, 5697.544196464273, 5699.914501282484, 5317.654352467077, 5347.732613369394, 5369.892602148013, 5383.488568585978, 5454.972725136349, 4826.734529600835, 4881.8535443936735, 4884.609231261491, 4899.1426500363, 4912.1158191525865, 5903.026000709835, 5908.379620139909, 5912.615679980788, 5930.199423077829, 5930.495907847795, 5570.359408667893, 5634.352049514358, 5653.575981801299, 5666.065099258576, 5705.201271822031, 5875.353711091862, 5913.083472061838, 5920.0, 5929.644221346733, 5948.167256583995, 5577.944220557904, 5602.1036634138345, 5616.4383561645145, 5618.016847051831, 5624.831255062355, 5550.722463876871, 5632.774689012557, 5649.6327738696855, 5663.2071509989455, 5678.034734095297, 5521.171824226398, 5560.443955604407, 5572.554195664418, 5593.07714227148, 5607.383187849415, 5480.177973304037, 5541.445855414427, 5544.69504177258, 5547.833564993057, 5549.278593782782, 5407.134858422633, 5488.368837583729, 5503.394626590992, 5523.392426832965, 5616.21373007771, 5602.971985140048, 5627.803026894039, 5629.183768353648, 5636.351819540641, 5638.126090455986, 5472.343318801769, 5473.370562385377, 5490.149026900836, 5492.5331346835965, 5497.945020549743], "value": 5233.213847295015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.8877204072445, 587.2629849538828, 592.1887014789738, 604.1934018085857, 626.764963138823, 39410.211795764066, 44317.33523997143, 44330.55669443305, 44389.77805110978, 44564.108717825664, 44933.0, 45346.546534534646, 45489.7725511372, 45512.0, 45737.54262457375, 8955.37312388133, 9039.186473217409, 9076.63693452261, 9092.22716069135, 9116.8632470513, 9001.414908030989, 9025.548722563879, 9031.322650801183, 9035.774105647346, 9035.909640903605, 9066.45601263923, 9080.228180604623, 9096.135867092615, 9102.954485227565, 9138.954305228464, 8997.595108220114, 9018.053104424007, 9037.683681071197, 9039.954800226022, 9041.095890410972, 8851.424657397249, 8897.466152030898, 8920.330975176823, 8934.687285944961, 8951.060138685474, 36093.097672558135, 36164.45753313702, 36216.81891590525, 36429.81785091058, 36493.45259821105, 3399.337636376301, 3566.197605538759, 3646.562412510489, 3995.14104467538, 4291.334843099325, 32912.3417531648, 33178.50232246518, 33205.66794332074, 33212.0, 33412.83293583516, 4285.040581796527, 4306.74159550428, 4325.091730736549, 4415.66882483815, 4541.72749635023, 395379.0, 396222.0, 396680.016599918, 397003.0, 398170.0, 56498.43501564932, 56938.715306424034, 56946.0, 57618.135727964116, 57714.42285577174, 60544.39455605476, 60818.69590652107, 60997.39002610006, 60998.08502872372, 61077.694611526655, 16541.58646033835, 16828.579285517717, 16875.24061417239, 16926.492205233615, 17017.659646806995, 12949.0, 13158.0, 13158.802617960739, 13159.210447372996, 13162.868371316164, 14492.202928839015, 15671.138087405303, 15671.335872901405, 15771.132587707556, 15866.771961716198, 6461.903071453932, 6527.184101987252, 6615.875301198807, 6797.932020679828, 6826.795196144024, 926.2543652359915, 1033.8707661542308, 1047.2459828923163, 1097.4293367448881, 1105.2870898270571, 32985.17537061593, 33144.50283245753, 33591.49612755811, 33769.41496408226, 34206.48690269648, 1019.6176433837311, 1110.5356467002605, 1119.7368618374676, 1139.840422340873, 1278.1564167649308, 15574.922125389301, 16757.916210419113, 16815.747763783555, 17035.23341449638, 17055.317787288368, 540917.0, 548401.0, 549211.0, 549363.0, 551240.0, 60690.0, 60852.391476085555, 60882.39117608767, 60897.0, 60931.69534152301, 1298.8831005209577, 1330.9267990260435, 1348.170874911922, 1350.9729805404033, 1373.0800363756307, 30363.848180758956, 32317.192070198435, 32553.67446325601, 32937.505937411435, 33521.83239083789, 50253.748731256106, 55698.72150639221, 57376.13935790883, 57551.42448575628, 61752.38247617646, 502678.0, 504783.0, 505087.0, 507325.0, 509710.0, 27821.582676260277, 27891.16326510208, 27933.58099628548, 28191.71808281973, 28324.716752832206, 49470.0, 50096.49903500918, 50497.0, 50849.23726144185, 51869.48130518646, 41475.58524414717, 41664.3750343739, 42288.365674514294, 43942.56057439385, 44385.33421998608, 41360.0, 42501.36247956345, 42976.78511607422, 44526.3321050191, 44550.55449445594, 41464.0, 42303.0, 42311.576884230766, 43229.783851080545, 43340.78329608332, 36400.63599364078, 37798.81100594479, 38200.808995954845, 38225.80887095658, 38342.80828595839, 29126.0, 29212.707872920997, 29373.55939660864, 29476.925836784427, 29709.702902970694], "value": 20428.31403488543, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.46425433341307, 370.06927577143483, 376.613970680053, 378.22841403536785, 397.1104725415069, 19439.41681749548, 19612.607747845035, 19620.70568941465, 19868.50328741782, 19879.900600496978, 19511.90244048778, 19838.0, 20404.387868363934, 20533.178672853068, 21020.36938891832, 5498.80754173604, 5558.86102847428, 5666.121751128581, 5692.658440493563, 5792.131180322943, 3919.2749341371796, 5837.416258374171, 5859.4140585941495, 5865.296164460271, 5868.354481007107, 6378.234611846585, 6392.264889537693, 6493.642849643268, 6522.380373864476, 6541.247756507991, 5969.403059694039, 6009.429104235091, 6185.072239164139, 6489.25373582037, 6496.252930912935, 5689.459501347365, 5775.711214439303, 5779.682117483537, 5797.0, 5825.1844741736195, 16040.674102255107, 23425.648615270784, 23745.168919087748, 23918.402039948967, 24343.756562434326, 2214.833887458431, 2237.19460994042, 2398.0887262840183, 2431.63525471179, 2618.528664840328, 10015.849762253572, 10709.892901070967, 10760.569577216902, 13402.262875541841, 14738.115713057143, 1877.915493802782, 1925.5859990102056, 1955.4817973236961, 1995.0822621594084, 2016.919323227069, 78714.0, 83802.16197838004, 84394.15605843924, 86821.0, 87126.0, 11040.834387484194, 11320.433978301053, 11370.919762622538, 11502.654920352403, 11503.137264705181, 15724.13517256539, 15877.603059923595, 16003.919980400256, 16015.599610009844, 16061.839381606269, 8303.418760686814, 8376.413651044368, 8610.526421046903, 8673.52295623734, 8806.60370283326, 8172.346212303001, 8337.624806883705, 8373.706920257762, 8429.283510901641, 8544.2310192083, 4898.975505122452, 4916.0, 4923.335349727812, 4960.851174464699, 5016.924746128811, 1965.4693232827342, 2003.8497112716605, 2033.7762846086919, 2052.0765655454807, 2097.25547430663, 862.2929198057658, 962.5668449197889, 972.5915115651302, 1016.872890888639, 1020.0921180149672, 19429.0, 20078.598428031357, 20331.186752529735, 20596.116543683896, 20648.380548583267, 1002.4336250018716, 1005.6781829814389, 1042.7653777900064, 1051.1275641217771, 1103.784761971424, 9995.506515552333, 11678.941605291919, 11684.94157529224, 11688.123390745728, 11722.88277117235, 440344.0, 455009.0, 455608.0, 458304.0, 486454.0, 94753.5262323684, 96180.0, 97081.514592428, 97724.51137744266, 98519.0, 950.7813202963218, 970.3062310448064, 986.5461887531816, 987.5778878415059, 1000.46475135802, 17401.47795566135, 18079.548011299823, 18695.0, 18755.0, 18898.433047008613, 29572.852135740046, 30029.249268768457, 30662.08013759591, 39235.60764392434, 43615.34576981284, 60368.493136991536, 61235.69382153061, 62442.0, 63212.68393658186, 64693.0, 8508.361872859685, 8513.674672042363, 8800.207981281716, 8832.823343532964, 9092.363534552518, 9835.754106147404, 12654.620361389174, 13088.738225235633, 13976.301184940916, 14439.711205776035, 11574.074074073886, 11869.821952670889, 11882.0, 12144.939275303566, 12289.446974885972, 11431.771364572829, 11630.476628551905, 11790.056795456514, 11988.381568488143, 12092.093093018235, 11658.242214256046, 11686.590969316034, 11831.645050648494, 12040.157188996685, 12128.575499857463, 7701.1143718473095, 8736.912630873865, 8806.559672016245, 9051.366404351633, 9105.544722763967, 10567.471626418495, 11385.886141138482, 11639.06887448985, 11907.82138267944, 11912.225705329125], "value": 9402.376296767256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.7560052591323, 1497.7229212595666, 1659.800823901132, 1762.7796525434321, 1792.901390423527, 7973.92026079739, 8613.741587752362, 8614.224719775219, 9180.449173049621, 9282.628694852207, 8673.783155421117, 8982.505962172077, 9018.188363047324, 9036.63853445863, 9089.318301127425, 2266.2634643740766, 2310.2029799719153, 2310.757370476101, 2312.190733243368, 2324.976750232501, 2273.147569661377, 2288.4507718147606, 2356.646503024543, 2360.209329874494, 2362.586547354215, 2336.2874323331375, 2340.2277248508035, 2343.8163727317683, 2363.444590521226, 2367.739548649647, 2269.7389800172946, 2278.874661893595, 2290.415943934286, 2292.4039749665126, 2303.57383883982, 2270.9545809083893, 2282.9429264268524, 2288.5651726171973, 2289.6222123349626, 2292.4612716011725, 8991.910080899173, 9123.315751318678, 9178.908210917938, 9186.311026673025, 9190.632374705005, 5176.508231718019, 5279.287296215, 5315.362156541201, 5325.068113080196, 5332.440093790135, 3179.8410079495934, 3314.6188188358406, 3356.8489417976007, 3430.073880052397, 3446.3451944130534, 1031.5718976624692, 1084.5499117866077, 1103.7406209540752, 1109.4286442482048, 1111.8888111188896, 12426.192297500633, 12456.688582785413, 12537.373131343396, 12567.622971310875, 12650.683732906658, 4321.2005778931, 4406.801693923781, 4510.797014134372, 4606.032733126014, 4609.976950115228, 10517.368957862553, 10568.89431105679, 10569.947150264354, 10622.893771062345, 10634.840477392845, 5148.794048238028, 5159.122949098587, 5184.507471790174, 5227.973860130675, 5236.476352364733, 4291.249031419489, 4574.794134263966, 4753.500882407367, 4755.690880092783, 4757.690750101302, 3866.8066596670055, 3886.1256217351433, 3946.2304850553865, 3968.1666849961252, 3996.9400458993136, 1186.2822992089662, 1190.8570971483477, 1206.6802297391198, 1210.8062709966364, 1212.2605210821391, 955.9761005974767, 973.7078876337071, 986.413084214891, 988.41189492252, 1014.8934361892043, 5865.706714664249, 5983.640981541122, 6026.9095963560585, 6043.516518678495, 6082.787102451393, 426.51164416742654, 431.0710419046959, 446.0988802618692, 449.9325101234841, 451.19912155922844, 4173.770442625685, 4201.642860356843, 4207.768572728468, 4210.915781684411, 4210.978945105255, 10911.0, 11112.61105861307, 11210.439478026066, 11240.437978101063, 11266.66200014001, 10248.795024099476, 11100.390443385664, 11127.610533631285, 11176.385298808644, 11180.888191117985, 8111.797205069803, 8512.531810750344, 8513.574321284035, 8524.190201930807, 8540.74377768668, 5862.94137058624, 5905.35041145465, 5969.552283578836, 6003.0695242237525, 6104.328523862283, 9367.578458969227, 9448.622055117718, 9585.616575336908, 9647.758806029906, 9655.951720241354, 9735.610575576897, 9796.65711700087, 9954.104130628279, 9955.800883982425, 9992.15066719337, 7836.490628109383, 8399.496030238206, 8556.401051926305, 8583.098774628574, 8772.342074344322, 8716.128387161232, 8963.507007114671, 8985.595648195716, 8991.325650576102, 8995.280377569648, 7686.9231307686205, 7725.99562056929, 7905.446618736633, 7908.971833661817, 7982.8802567960365, 7478.663460144197, 7606.087269527692, 7739.729109481141, 7853.410994175346, 7971.44199906001, 6996.055532503047, 7035.22612512613, 7046.964765176346, 7061.399781018671, 7066.646667666699, 5036.345275114211, 5061.291419201389, 5150.4592017837585, 5154.123798954111, 5342.839714808562, 5138.871528211825, 5192.3769147702515, 5196.454372290855, 5238.5023422774775, 5434.021876062347], "value": 4566.298599980667, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.65230919833584, 326.4874147588286, 328.1271816966867, 332.5095484160863, 333.90650617826986, 5443.972780136104, 5445.891082178354, 5641.815218804051, 5671.71641417929, 5688.914666280009, 5502.312210973629, 5549.556035517159, 5584.5811564132755, 5599.720013999304, 5614.522765564931, 4417.785109095009, 4420.093880754445, 4436.378906953013, 4445.355423463596, 4454.13144436835, 4111.48606424197, 4304.720193187449, 4348.847790327339, 4439.800208990603, 4456.732596044231, 4271.957280427203, 4284.785760711968, 4286.3784751211215, 4296.3577399898995, 4311.805968731414, 4308.719933204332, 4321.373400856874, 4328.675349348811, 4340.045190058182, 4363.454568178978, 3734.141147536082, 3747.2692824899154, 3826.559945606263, 3835.673967712748, 3835.846566137351, 5363.892722145574, 5382.138857782775, 5405.756740946627, 5409.702466364349, 5414.40441551429, 4874.610031197496, 4936.580390666798, 4936.851894443136, 4940.6788558743565, 4952.009598080363, 5433.315672141649, 5750.367459579443, 5763.855903602402, 5771.278590176228, 5823.5341172706085, 4095.3242714952, 4103.7948102594755, 4119.814608342602, 4132.669386449077, 4142.834286628531, 6052.092186172065, 6106.145139680449, 6115.327313995457, 6118.969405152946, 6136.202293701835, 4071.4096456013713, 4118.546959834416, 4133.400656904732, 4190.308599081118, 4194.098268872207, 4217.641500472494, 4224.556421575752, 4229.471316085489, 4232.36514522824, 4232.539773778041, 4872.051179528217, 4894.8497103180725, 4897.7795999180125, 4902.779374928136, 4949.505049495022, 5557.472040156179, 5806.767729290781, 5937.495312898365, 5938.910916336258, 5943.257092863392, 1465.5823090419178, 1476.8966172367832, 1479.4082367053265, 1481.1187343530582, 1492.388120870438, 885.1281487734576, 928.758522784081, 945.3760518058186, 950.2872845365976, 956.1633570625703, 4883.658143929962, 4883.677945018684, 4970.229614409773, 4979.502049795064, 4993.475685053089, 5203.661761985534, 5241.633085683966, 5266.236395722599, 5333.280007198979, 5396.731768034509, 4693.342931989524, 4922.744700101452, 5037.82367617139, 5040.521150490697, 5060.418051924003, 2780.569011803174, 2784.5659485365054, 2800.9299767505568, 2803.453326601334, 2822.5604941479583, 5416.431274716177, 5447.863803404867, 5461.535769459561, 5472.781088756406, 5498.048192891546, 5178.870528236825, 5390.703511306838, 5390.865228369322, 5399.757010934517, 5462.0, 5367.382750983609, 5375.75809088592, 5459.235707001023, 5476.288082549243, 5490.752916118784, 5245.531251249657, 5283.709395983258, 5286.2291132471055, 5292.894142117213, 5343.492368225013, 4905.743358055334, 5198.584113271005, 5210.583153347648, 5242.5281724644965, 5282.683039017671, 5487.314085739283, 5489.945100549103, 5504.4495550444635, 5505.476979686923, 5524.751386187711, 4007.6994225432627, 4120.690948178839, 4138.586141385837, 4203.663706903501, 4220.15596880619, 5980.850478738066, 5982.4017598239825, 5990.790322338871, 5997.100434934795, 6036.909446358396, 5669.716514174357, 5823.272090988627, 5830.650160990184, 5874.441928016831, 5927.377625349449, 5718.313802343745, 5760.164776107525, 5766.769329226784, 5770.9711451444155, 5780.971095144498, 5755.683437410982, 5765.221695071279, 5799.884002320015, 5805.419458054161, 5874.676892770939, 5629.943700563106, 5793.030369674331, 5844.503217226584, 5859.5019423349495, 5876.735546900314, 5699.458551437607, 5719.0, 5721.628094173865, 5735.48009777401, 5746.856328591819], "value": 4272.684942424265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.431590517349, 762.8321769210771, 767.501124269225, 795.848788730141, 833.1959658929133, 15732.29204685789, 16196.109213993226, 16589.668206635874, 16612.584685382855, 16702.49892503224, 13855.445782168727, 13907.443702251923, 13924.721505569882, 13943.09369890959, 13948.302584870766, 649.2371463530357, 778.5873487051844, 801.0347531224875, 805.8468890910708, 815.9714409995652, 802.1216767639426, 812.7642983534768, 812.959352032396, 813.7924829168554, 813.9837203255931, 857.9828403431927, 859.3984211052289, 862.4695812075591, 867.2411639815161, 867.5185272173941, 852.4927668037508, 854.8589482735404, 857.9227869491775, 858.107568129148, 859.3855393393723, 623.3174673732256, 624.3101372982834, 629.2826178156905, 630.0737915264554, 630.1650313334804, 15395.461158859498, 15425.15161666108, 15448.073115612986, 15486.148261845594, 15541.611459713598, 15682.215889205494, 15726.44957426496, 15768.842311576967, 15867.889247752662, 15912.363505459884, 12124.878751212464, 12434.0, 12445.315507647076, 12563.497460101586, 12796.0, 3786.318462676717, 3793.241351729665, 3853.6724378427866, 3886.8250928708276, 4006.9198616027516, 87299.0, 88334.5583272086, 88580.55709721474, 89008.99999999935, 92338.0, 11753.647390578297, 11969.0, 12025.579104731292, 12047.939760301142, 12206.93412233913, 23829.285121446384, 23981.160659376837, 24097.156599518934, 24107.397315067265, 24134.87932560361, 8910.153535414125, 8949.865752013726, 8958.910410895807, 9034.45793252407, 9071.366726047732, 4730.763461826895, 4772.522747725269, 4878.829240976549, 4983.9252411213865, 5045.84862454127, 3481.0775144586705, 3598.0465176727666, 3600.945985810215, 3605.0626837022564, 3610.1155216971483, 596.725506267122, 600.3186383454811, 601.506764453153, 609.3479976425183, 610.5329422991415, 750.8761054426068, 757.6704133701858, 772.3782355204114, 776.9883451748228, 793.412874472886, 9832.164266037467, 10260.640877569249, 10326.0, 10625.0, 10756.515956781963, 755.5655498088621, 760.3309088002633, 764.506893053977, 775.5153029356652, 784.1844481739041, 4807.110684523374, 4881.707097574157, 5023.397192336943, 5102.158143906214, 5168.81909133186, 96475.51762241144, 97423.0, 100275.49862250788, 122448.0, 130305.0, 101734.0, 101757.49121254495, 102397.0, 103192.48403757933, 103522.0, 77325.61337193278, 79776.60111699288, 88579.0, 90836.0, 91514.0, 9921.45432001218, 10269.127124194527, 10293.330933489298, 10332.690019299433, 10605.89394106049, 50088.845408988826, 51458.48541514687, 52221.0, 53135.46864531305, 53463.46536534585, 70702.64648676723, 77037.22962770301, 77167.228327716, 77452.0, 78413.0, 12615.36923153857, 12712.237265764084, 13020.5442809505, 13356.427637292943, 13779.793303100261, 14961.700765984837, 14976.326065327305, 15359.308831102404, 15641.843581564039, 15915.522534323989, 13826.585202443943, 14167.929160354131, 14491.420343186155, 14598.781018284946, 14649.560513184622, 13500.054996150175, 13684.178949263076, 14005.019648624499, 14266.358013889192, 14399.856001439852, 13324.866751332362, 13547.86452135466, 13685.657858553615, 13950.581482555539, 14343.497977571153, 11247.212695111264, 11324.716882077684, 11333.773324533628, 11559.884401155881, 12005.75988480243, 10753.1935104869, 11229.831552526883, 11272.436378180893, 11352.716182095513, 11531.423428828357], "value": 7795.664646478416, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 109.0, 113.0, 115.0, 113.0, 117.0, 113.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 146.0, 184.0, 119.0, 145.0, 148.0, 118.0, 178.0, 122.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 165.0, 171.0, 166.0, 161.0, 161.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 177.0, 82.0, 76.0, 75.0, 76.0, 164.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 147.0, 85.0, 85.0, 86.0, 150.0, 86.0, 85.0, 160.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 147.0, 151.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 61.0, 56.0, 52.0, 57.0, 54.0, 51.0, 51.0, 58.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 64.0, 63.0, 62.0, 62.0, 63.0, 64.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 80.0, 84.0, 78.0, 82.0, 79.0, 79.0, 87.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 135.0, 133.0, 130.0, 146.0, 138.0, 128.0, 142.0, 126.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 163.0, 169.0, 163.0, 163.0, 165.0, 166.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 70.0, 65.0, 64.0, 66.0, 65.0, 65.0, 66.0, 68.0], "value": 66.1, "unit": "score"}]}]} 05:21:02 INFO - Return code: 0 05:21:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:21:02 ERROR - # TBPL SUCCESS # 05:21:02 INFO - Running post-action listener: _resource_record_post_action 05:21:02 INFO - [mozharness: 2016-08-16 12:21:02.334652Z] Finished run-tests step (success) 05:21:02 INFO - Running post-run listener: _resource_record_post_run 05:21:02 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7954432; Write bytes: 404815872; Read time: 2076; Write time: 349000 05:21:02 INFO - TinderboxPrint: CPU usage
13.4% 05:21:02 INFO - TinderboxPrint: I/O read bytes / time
7,954,432 / 2,076 05:21:02 INFO - TinderboxPrint: I/O write bytes / time
404,815,872 / 349,000 05:21:02 INFO - TinderboxPrint: CPU idle
8,247.6 (86.6%) 05:21:02 INFO - TinderboxPrint: CPU user
1,217.7 (12.8%) 05:21:02 INFO - TinderboxPrint: Swap in / out
0 / 0 05:21:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 76873728; Read time: 236; Write time: 62472 05:21:02 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5578752; Write bytes: 327942144; Read time: 1356; Write time: 286528 05:21:02 INFO - Running post-run listener: _upload_blobber_files 05:21:02 INFO - Blob upload gear active. 05:21:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:21:02 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 05:21:02 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'] 05:21:02 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 05:21:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:21:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:04 INFO - (blobuploader) - INFO - Done attempting. 05:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:09 INFO - (blobuploader) - INFO - Done attempting. 05:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:10 INFO - (blobuploader) - INFO - Done attempting. 05:21:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:10 INFO - Return code: 0 05:21:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:21:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/86bc951e1d19e5a46aa4e6a007cb1741cd0ce4cb9042edcdd2c28389e61331f75cefbde22bc3426092d1a8c2d2655d65f3489ee40a500788045b9104f435391f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd6cc3d9949b82beb4011fe89d51a09a13528b7e6b03b172648126bd18ca8ee71c2e6bc73375f192c5dff774d0e459e82474c8e887eecc8048d33441558dca4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0c8612c0eb6913e291558deec94c15febc4eb89c2662406645464a540d057050c15a0db2976f20da6cf433756d959ebb77a6a03e0b74fe76ad256e6d834be70"} 05:21:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:21:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:21:10 INFO - Contents: 05:21:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/86bc951e1d19e5a46aa4e6a007cb1741cd0ce4cb9042edcdd2c28389e61331f75cefbde22bc3426092d1a8c2d2655d65f3489ee40a500788045b9104f435391f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd6cc3d9949b82beb4011fe89d51a09a13528b7e6b03b172648126bd18ca8ee71c2e6bc73375f192c5dff774d0e459e82474c8e887eecc8048d33441558dca4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0c8612c0eb6913e291558deec94c15febc4eb89c2662406645464a540d057050c15a0db2976f20da6cf433756d959ebb77a6a03e0b74fe76ad256e6d834be70"} 05:21:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:21:10 INFO - Copying logs to upload dir... 05:21:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:21:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.485220 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-16 05:21:10.333166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:21:10.336647) ========= 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=826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999 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/86bc951e1d19e5a46aa4e6a007cb1741cd0ce4cb9042edcdd2c28389e61331f75cefbde22bc3426092d1a8c2d2655d65f3489ee40a500788045b9104f435391f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd6cc3d9949b82beb4011fe89d51a09a13528b7e6b03b172648126bd18ca8ee71c2e6bc73375f192c5dff774d0e459e82474c8e887eecc8048d33441558dca4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0c8612c0eb6913e291558deec94c15febc4eb89c2662406645464a540d057050c15a0db2976f20da6cf433756d959ebb77a6a03e0b74fe76ad256e6d834be70"} build_url:https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.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/86bc951e1d19e5a46aa4e6a007cb1741cd0ce4cb9042edcdd2c28389e61331f75cefbde22bc3426092d1a8c2d2655d65f3489ee40a500788045b9104f435391f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd6cc3d9949b82beb4011fe89d51a09a13528b7e6b03b172648126bd18ca8ee71c2e6bc73375f192c5dff774d0e459e82474c8e887eecc8048d33441558dca4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0c8612c0eb6913e291558deec94c15febc4eb89c2662406645464a540d057050c15a0db2976f20da6cf433756d959ebb77a6a03e0b74fe76ad256e6d834be70"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:21:10.361971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:21:10.362329) ========= 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=826874ccc97bd7bf541b4875000001d5-1471348829.41918-892871999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:21:10.445209) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:21:10.445520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:21:10.445803) ========= ========= Total master_lag: 0.46 =========